2019-08-26T16:54:34.024Z,1566838474.024 [CommandLine](IMPORTANT): got command restart logs
2019-08-26T16:54:34.716Z,1566838474.716 [NAL9602](DEBUG): Fix Requested
2019-08-26T16:54:35.098Z,1566838475.098 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165434.00,A,3422.33715,N,11947.55248,W,0.758,284.70,260819,,,A*7A
2019-08-26T16:54:35.101Z,1566838475.101 [NAL9602](INFO): GPS fix at 20190826T165434: (34.372286, -119.792541)
2019-08-26T16:54:35.160Z,1566838475.160 [UniversalFixResidualReporter](INFO): Fix residual: 9.8 %DT, over the last 1729.7 m. Residual distance 169.8 m at bearing 58.9 degrees. Fix at (34.3723, -119.7925) with 1811.3 m made good.
2019-08-26T16:54:35.168Z,1566838475.168 [sci2:NeedComms:C] Stopped
2019-08-26T16:54:35.169Z,1566838475.169 [sci2:NeedComms:D] Running Loop=1
2019-08-26T16:54:47.094Z,1566838487.094 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T16:54:47.094Z,1566838487.094 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610053560,35.0, 0.0,1448.9,  0
2019-08-26T16:54:55.239Z,1566838495.239 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:55:06.869Z,1566838506.869 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-26T16:55:07.733Z,1566838507.733 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2019-08-26T16:55:07.733Z,1566838507.733 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-3278,-32768,V
2019-08-26T16:55:30.435Z,1566838530.435 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:56:05.595Z,1566838565.595 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:56:07.094Z,1566838567.094 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T16:56:07.095Z,1566838567.095 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T16:56:40.743Z,1566838600.743 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:56:43.468Z,1566838603.468 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T16:56:43.469Z,1566838603.469 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610073160,35.0, -0.1,   0.0,144

2019-08-26T16:56:45.067Z,1566838605.067 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T16:56:45.067Z,1566838605.067 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610073360,35.0, -0.1,   0.0,144

2019-08-26T16:57:15.903Z,1566838635.903 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:57:27.088Z,1566838647.088 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T16:57:27.088Z,1566838647.088 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610081560,35.0, -0.,1448.9,  0
2019-08-26T16:57:48.114Z,1566838668.114 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2019-08-26T16:57:48.767Z,1566838668.767 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003001
2019-08-26T16:57:56.331Z,1566838676.331 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20190825T172100/Courier0189.lzma
2019-08-26T16:57:57.138Z,1566838677.138 [DataOverHttps](INFO): Moved sent file to Logs/20190825T172100/Courier0189.lzma.bak
2019-08-26T16:57:57.138Z,1566838677.138 [DataOverHttps](INFO): SBD MOMSN=11695766
2019-08-26T16:58:21.017Z,1566838701.017 [DataOverHttps](INFO): Sending 1686 bytes from file Logs/20190825T172100/Express0190.lzma
2019-08-26T16:58:21.821Z,1566838701.821 [DataOverHttps](INFO): Moved sent file to Logs/20190825T172100/Express0190.lzma.bak
2019-08-26T16:58:21.821Z,1566838701.821 [DataOverHttps](INFO): SBD MOMSN=11695769
2019-08-26T16:58:24.348Z,1566838704.348 [sci2:NeedComms:D] Stopped
2019-08-26T16:58:24.348Z,1566838704.348 [sci2:NeedComms:E] Running Loop=1
2019-08-26T16:58:25.927Z,1566838705.927 [NAL9602](DEBUG): Fix Requested
2019-08-26T16:58:26.320Z,1566838706.320 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165826.00,A,3422.34793,N,11947.56484,W,0.311,323.52,260819,,,A*7C
2019-08-26T16:58:26.323Z,1566838706.323 [NAL9602](INFO): GPS fix at 20190826T165826: (34.372465, -119.792747)
2019-08-26T16:58:26.399Z,1566838706.399 [sci2:NeedComms:E] Stopped
2019-08-26T16:58:26.400Z,1566838706.400 [sci2:NeedComms](INFO): Completed sci2:NeedComms
2019-08-26T16:58:26.400Z,1566838706.400 [sci2:NeedComms] Stopped
2019-08-26T16:58:26.400Z,1566838706.400 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms
2019-08-26T16:58:26.400Z,1566838706.400 [sci2:NeedComms:B.GoToSurface] Stopped
2019-08-26T16:58:26.400Z,1566838706.400 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-26T16:58:43.750Z,1566838723.750 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T16:58:43.750Z,1566838723.750 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610093260,35.0, -0.1,   0.0,1448.9,,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T16:58:52.280Z,1566838732.280 [NAL9602](INFO): SBD MO Status=2, MOMSN=8701, MT Status=2, MTMSN=0
2019-08-26T16:58:52.280Z,1566838732.280 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-26T16:58:54.752Z,1566838734.752 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T16:58:54.752Z,1566838734.752 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T16:59:39.307Z,1566838779.307 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T16:59:42.136Z,1566838782.136 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.223537
2019-08-26T16:59:50.363Z,1566838790.363 [Radio_Surface](INFO): Powering down
2019-08-26T16:59:50.771Z,1566838790.771 [Radio_Surface](FAULT): LCB fault:  Invalid Command.
2019-08-26T16:59:50.771Z,1566838790.771 [Radio_Surface] Hardware Fault, FailCount= 1
2019-08-26T16:59:50.772Z,1566838790.772 [Radio_Surface](ERROR): Hardware Fault
2019-08-26T16:59:50.906Z,1566838790.906 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T16:59:50.906Z,1566838790.906 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,

2019-08-26T16:59:51.031Z,1566838791.031 [CBIT](ERROR): Hardware Fault in component: Radio_Surface
2019-08-26T16:59:51.484Z,1566838791.484 [CBIT](INFO): Clearing failed state for component Radio_Surface
2019-08-26T16:59:51.484Z,1566838791.484 [Radio_Surface] No Fault, FailCount= 1
2019-08-26T16:59:51.579Z,1566838791.579 [Radio_Surface](INFO): Powering up
2019-08-26T16:59:57.639Z,1566838797.639 [Radio_Surface](INFO): Powering down
2019-08-26T17:00:14.463Z,1566838814.463 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:00:14.811Z,1566838814.811 [RDI_Pathfinder](ERROR): DVL uart error: serial timeout
2019-08-26T17:00:14.811Z,1566838814.811 [RDI_Pathfinder] Communications Fault, FailCount= 1
2019-08-26T17:00:14.811Z,1566838814.811 [RDI_Pathfinder](ERROR): Communications Fault
2019-08-26T17:00:14.812Z,1566838814.812 [RDI_Pathfinder](ERROR): Failed to parse:
2019-08-26T17:00:14.868Z,1566838814.868 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2019-08-26T17:00:14.904Z,1566838814.904 [CBIT](ERROR): Communications Fault in component: RDI_Pathfinder
2019-08-26T17:00:15.171Z,1566838815.171 [RDI_Pathfinder](INFO): Powering down
2019-08-26T17:00:16.011Z,1566838816.011 [CBIT](INFO): Clearing failed state for component RDI_Pathfinder
2019-08-26T17:00:16.011Z,1566838816.011 [RDI_Pathfinder] No Fault, FailCount= 1
2019-08-26T17:00:29.284Z,1566838829.284 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-08-26T17:00:38.592Z,1566838838.592 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 255 got: 12
2019-08-26T17:00:38.592Z,1566838838.592 [CTD_NeilBrown](ERROR): Bad response:  26.81,13.63

2019-08-26T17:00:39.346Z,1566838839.346 [RDI_Pathfinder](ERROR): Failed to parse:
:B,-32768,-32768,-32768,V
2019-08-26T17:01:59.884Z,1566838919.884 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 17 got: 20
2019-08-26T17:01:59.884Z,1566838919.884 [CTD_NeilBrown](ERROR): Bad response: 44.97361,33.8309
2019-08-26T17:03:29.029Z,1566839009.029 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-26T17:03:58.961Z,1566839038.961 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T17:03:58.961Z,1566839038.961 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T17:03:59.741Z,1566839039.741 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-26T17:04:13.884Z,1566839053.884 [Micromodem](INFO): Nmea in: $

2019-08-26T17:04:13.885Z,1566839053.885 [Micromodem](ERROR): Response from modem failed NMEA checksum: $
 expected 7
2019-08-26T17:05:24.620Z,1566839124.620 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:05:58.962Z,1566839158.962 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:05:58.962Z,1566839158.962 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610164711,35.0, -0.1,   0.,  0
2019-08-26T17:06:02.599Z,1566839162.599 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:06:02.599Z,1566839162.599 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610165111,35.0, -0.1,   09,  0
2019-08-26T17:06:31.604Z,1566839191.604 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 255 got: 0
2019-08-26T17:06:31.604Z,1566839191.604 [CTD_NeilBrown](ERROR): Bad response: *0A

2019-08-26T17:06:39.476Z,1566839199.476 [ThrusterServo](FAULT): Invalid EZ Servo response:"/0@5242"
2019-08-26T17:06:39.476Z,1566839199.476 [ThrusterServo] Communications Fault, FailCount= 1
2019-08-26T17:06:39.476Z,1566839199.476 [ThrusterServo](ERROR): Communications Fault
2019-08-26T17:06:39.480Z,1566839199.480 [CBIT](ERROR): Communications Fault in component: ThrusterServo
2019-08-26T17:06:39.791Z,1566839199.791 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-08-26T17:06:39.791Z,1566839199.791 [ThrusterServo](INFO): Powering down
2019-08-26T17:06:40.598Z,1566839200.598 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-08-26T17:06:40.712Z,1566839200.712 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-08-26T17:06:40.716Z,1566839200.716 [CBIT](INFO): Clearing failed state for component ThrusterServo
2019-08-26T17:06:40.717Z,1566839200.717 [ThrusterServo] No Fault, FailCount= 1
2019-08-26T17:07:03.607Z,1566839223.607 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T17:07:03.607Z,1566839223.607 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00, :BI,-32768,-32768,-32768,-32768,V
2019-08-26T17:07:18.943Z,1566839238.943 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:07:50.617Z,1566839270.617 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 10 got: 19
2019-08-26T17:07:50.617Z,1566839270.617 [CTD_NeilBrown](ERROR): Bad response: 41.41268,33.8308
2019-08-26T17:09:37.940Z,1566839377.940 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:11:03.619Z,1566839463.619 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2019-08-26T17:11:18.973Z,1566839478.973 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:11:18.973Z,1566839478.973 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610220711,35.0, -0.1,   0.0,144

2019-08-26T17:11:46.556Z,1566839506.556 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 3 got: 5
2019-08-26T17:11:46.556Z,1566839506.556 [CTD_NeilBrown](ERROR): Bad response: ,33.8618
2019-08-26T17:11:58.942Z,1566839518.942 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:11:58.942Z,1566839518.942 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,190826102.0, -0.1,   0.0,1448.9,  0
2019-08-26T17:12:00.861Z,1566839520.861 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 255 got: 0
2019-08-26T17:12:00.861Z,1566839520.861 [CTD_NeilBrown](ERROR): Bad response: *1F

2019-08-26T17:12:23.598Z,1566839543.598 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:12:23.598Z,1566839543.598 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610231211,35.0, -0.1,   .9,  0
2019-08-26T17:12:28.855Z,1566839548.855 [RDI_Pathfinder](ERROR): Failed to parse:
:B,-32768,-32768,V
2019-08-26T17:12:44.613Z,1566839564.613 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:12:44.613Z,1566839564.613 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,190826135.0, -0.11448.9,  0
2019-08-26T17:13:03.604Z,1566839583.604 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:13:03.605Z,1566839583.605 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610235211,35.0, -0.1,   0.0,1448:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:13:23.409Z,1566839603.409 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2019-08-26T17:13:23.409Z,1566839603.409 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-2768,-32768,V
2019-08-26T17:14:02.592Z,1566839642.592 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:14:02.593Z,1566839642.593 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610240, -0.1,   0.0,1448.9,  0
2019-08-26T17:14:21.614Z,1566839661.614 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2019-08-26T17:14:23.232Z,1566839663.232 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2019-08-26T17:14:42.597Z,1566839682.597 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:14:42.598Z,1566839682.598 [RDI_Pathfinder](ERROR): Failed to parse:
:TS0253111,35.0, -0.1,   0.0,1448.9,  0
2019-08-26T17:16:04.627Z,1566839764.627 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:16:04.627Z,1566839764.627 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610265311,35.0, -0.1,   0.0,10
2019-08-26T17:16:17.965Z,1566839777.965 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:16:17.965Z,1566839777.965 [RDI_Pathfinder](ERROR): Failed to parse:
:TS0270611,35.0, -0.1,   0.0,1448.RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:16:21.578Z,1566839781.578 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:16:21.578Z,1566839781.578 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,1908261027101-0.1,   0.0,1448.9,  0
2019-08-26T17:16:54.450Z,1566839814.450 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 255 got: 0
2019-08-26T17:16:54.451Z,1566839814.451 [CTD_NeilBrown](ERROR): Bad response: *06

2019-08-26T17:17:18.588Z,1566839838.588 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2019-08-26T17:17:18.589Z,1566839838.589 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,     ,        +0.00,        +0.00,   0.00,1008.96
2019-08-26T17:17:58.972Z,1566839878.972 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T17:17:58.972Z,1566839878.972 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T17:18:23.592Z,1566839903.592 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T17:18:23.592Z,1566839903.592 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T17:18:42.578Z,1566839922.578 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:23:48.123Z,1566840228.123 [CBIT](IMPORTANT): Beginning ground fault scan
2019-08-26T17:23:48.317Z,1566840228.317 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:48.321Z,1566840228.321 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:48.524Z,1566840228.524 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:48.528Z,1566840228.528 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:48.725Z,1566840228.725 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:48.728Z,1566840228.728 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:48.929Z,1566840228.929 [CTD_NeilBrown](ERROR): Salinity reading out of range: 62.321800 psu
2019-08-26T17:23:48.929Z,1566840228.929 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:48.933Z,1566840228.933 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:49.133Z,1566840229.133 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:49.137Z,1566840229.137 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:49.348Z,1566840229.348 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:49.375Z,1566840229.375 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:49.556Z,1566840229.556 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:49.560Z,1566840229.560 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:49.768Z,1566840229.768 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:49.771Z,1566840229.771 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:49.984Z,1566840229.984 [CTD_NeilBrown](ERROR): Salinity reading out of range: 69.760002 psu
2019-08-26T17:23:49.984Z,1566840229.984 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:49.988Z,1566840229.988 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:50.189Z,1566840230.189 [CTD_NeilBrown](ERROR): Salinity reading out of range: 41.373001 psu
2019-08-26T17:23:50.190Z,1566840230.190 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:50.227Z,1566840230.227 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:50.428Z,1566840230.428 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:50.444Z,1566840230.444 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:50.608Z,1566840230.608 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:50.611Z,1566840230.611 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:50.824Z,1566840230.824 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:50.828Z,1566840230.828 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:51.032Z,1566840231.032 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:51.036Z,1566840231.036 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:51.236Z,1566840231.236 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:51.240Z,1566840231.240 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:51.605Z,1566840231.605 [CTD_NeilBrown](ERROR): Salinity reading out of range: 50.055000 psu
2019-08-26T17:23:51.606Z,1566840231.606 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:51.609Z,1566840231.609 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:51.809Z,1566840231.809 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:51.812Z,1566840231.812 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:52.013Z,1566840232.013 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:52.016Z,1566840232.016 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:52.220Z,1566840232.220 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:52.224Z,1566840232.224 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:52.421Z,1566840232.421 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:52.425Z,1566840232.425 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:52.625Z,1566840232.625 [CTD_NeilBrown](ERROR): Salinity reading out of range: 0.038000 psu
2019-08-26T17:23:52.625Z,1566840232.625 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:52.629Z,1566840232.629 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:52.845Z,1566840232.845 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:52.849Z,1566840232.849 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:53.052Z,1566840233.052 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:53.056Z,1566840233.056 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:53.255Z,1566840233.255 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:53.259Z,1566840233.259 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:53.457Z,1566840233.457 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:53.461Z,1566840233.461 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:53.661Z,1566840233.661 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:53.665Z,1566840233.665 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:53.866Z,1566840233.866 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:53.871Z,1566840233.871 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:54.069Z,1566840234.069 [CTD_NeilBrown](ERROR): Salinity reading out of range: 38.930199 psu
2019-08-26T17:23:54.070Z,1566840234.070 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:54.073Z,1566840234.073 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:54.273Z,1566840234.273 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:54.276Z,1566840234.276 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:54.477Z,1566840234.477 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:54.480Z,1566840234.480 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:54.681Z,1566840234.681 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:54.685Z,1566840234.685 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:54.888Z,1566840234.888 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:54.899Z,1566840234.899 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:55.089Z,1566840235.089 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:55.092Z,1566840235.092 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:55.293Z,1566840235.293 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:55.296Z,1566840235.296 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:55.497Z,1566840235.497 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:55.500Z,1566840235.500 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:55.701Z,1566840235.701 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:55.705Z,1566840235.705 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:55.905Z,1566840235.905 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:55.908Z,1566840235.908 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:56.109Z,1566840236.109 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:56.112Z,1566840236.112 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:56.313Z,1566840236.313 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:56.316Z,1566840236.316 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:56.517Z,1566840236.517 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:56.521Z,1566840236.521 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:56.721Z,1566840236.721 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:56.724Z,1566840236.724 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:56.925Z,1566840236.925 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:56.929Z,1566840236.929 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:57.129Z,1566840237.129 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:57.133Z,1566840237.133 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:57.344Z,1566840237.344 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:57.347Z,1566840237.347 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:57.554Z,1566840237.554 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:57.566Z,1566840237.566 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:57.764Z,1566840237.764 [CTD_NeilBrown](ERROR): Salinity reading out of range: 49.812599 psu
2019-08-26T17:23:57.765Z,1566840237.765 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:57.770Z,1566840237.770 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:57.968Z,1566840237.968 [CTD_NeilBrown](ERROR): Salinity reading out of range: 40.011501 psu
2019-08-26T17:23:57.968Z,1566840237.968 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:57.972Z,1566840237.972 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:58.184Z,1566840238.184 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:58.187Z,1566840238.187 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:58.390Z,1566840238.390 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:58.394Z,1566840238.394 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:58.761Z,1566840238.761 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:58.764Z,1566840238.764 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:58.965Z,1566840238.965 [CTD_NeilBrown](INFO): Ground Fault scan is active; will mark data as invalid.
2019-08-26T17:23:58.968Z,1566840238.968 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:23:59.054Z,1566840239.054 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.017520
CHAN A1 (24V): -0.024544
CHAN A2 (12V): -0.011670
CHAN A3 (5V): -0.002555
CHAN B0 (3.3V): -0.000172
CHAN B1 (3.15aV): -0.000488
CHAN B2 (3.15bV): -0.000338
CHAN B3 (GND): 0.000494
OPEN: 0.009628
Full Scale Calc: 4.765 mA, -1.589 mA
2019-08-26T17:26:23.581Z,1566840383.581 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2019-08-26T17:26:23.581Z,1566840383.581 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,19082610371211,35,   0.0,1448.9,  0
2019-08-26T17:28:26.446Z,1566840506.446 [sci2:NeedComms] Running Loop=1
2019-08-26T17:28:26.446Z,1566840506.446 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms
2019-08-26T17:28:26.446Z,1566840506.446 [sci2:NeedComms:B.GoToSurface] Running Loop=1
2019-08-26T17:28:26.446Z,1566840506.446 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-26T17:28:26.447Z,1566840506.447 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2019-08-26T17:28:26.447Z,1566840506.447 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2019-08-26T17:28:26.448Z,1566840506.448 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2019-08-26T17:28:26.448Z,1566840506.448 [sci2:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-26T17:28:26.448Z,1566840506.448 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-26T17:28:26.449Z,1566840506.449 [sci2:NeedComms:A] Running Loop=1
2019-08-26T17:28:26.450Z,1566840506.450 [sci2:NeedComms:A](INFO): last time_fix was: 1566838706.000000 second since 1970/01/01T00:00:00Z 
2019-08-26T17:28:26.450Z,1566840506.450 [sci2:NeedComms:A] Stopped
2019-08-26T17:29:16.660Z,1566840556.660 [sci2:NeedComms:C] Running Loop=1
2019-08-26T17:29:17.231Z,1566840557.231 [Radio_Surface](INFO): Powering up
2019-08-26T17:29:17.757Z,1566840557.757 [CTD_NeilBrown](ERROR): Salinity reading out of range: 21.912701 psu
2019-08-26T17:29:17.761Z,1566840557.761 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:29:17.961Z,1566840557.961 [CTD_NeilBrown](ERROR): Salinity reading out of range: 3.081300 psu
2019-08-26T17:29:17.965Z,1566840557.965 [CTD_NeilBrown](INFO): some bad data, not updating bins
2019-08-26T17:29:18.211Z,1566840558.211 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:29:22.871Z,1566840562.871 [DataOverHttps](INFO): Radio surface powered ON.
2019-08-26T17:29:49.561Z,1566840589.561 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2019-08-26T17:29:49.639Z,1566840589.639 [NAL9602](FAULT): received: 
+CSQ:0

OK01, 2, 0, 0, 0

OK
2019-08-26T17:29:49.639Z,1566840589.639 [NAL9602] Data Fault, FailCount= 1
2019-08-26T17:29:49.639Z,1566840589.639 [NAL9602](ERROR): Data Fault
2019-08-26T17:29:49.839Z,1566840589.839 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-26T17:29:49.965Z,1566840589.965 [NAL9602](INFO): Powering down
2019-08-26T17:29:50.369Z,1566840590.369 [NAL9602](FAULT): LCB fault:  Software Overcurrent.
2019-08-26T17:29:50.369Z,1566840590.369 [NAL9602] Hardware Fault, FailCount= 1
2019-08-26T17:29:50.369Z,1566840590.369 [NAL9602](ERROR): Hardware Fault
2019-08-26T17:29:50.899Z,1566840590.899 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-26T17:29:50.899Z,1566840590.899 [NAL9602] No Fault, FailCount= 1
2019-08-26T17:29:53.184Z,1566840593.184 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:29:55.650Z,1566840595.650 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:30:20.270Z,1566840620.270 [NAL9602](INFO): Powering up NAL9602
2019-08-26T17:30:22.389Z,1566840622.389 [CTD_NeilBrown](ERROR): Failed to match checksum. Expected: 255 got: 87
2019-08-26T17:30:22.389Z,1566840622.389 [CTD_NeilBrown](ERROR): Bad response:  1A

2019-08-26T17:30:28.331Z,1566840628.331 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:30:31.179Z,1566840631.179 [NAL9602](INFO): NAL9602 initialized
2019-08-26T17:30:31.596Z,1566840631.596 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2019-08-26T17:30:31.596Z,1566840631.596 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2019-08-26T17:30:31.999Z,1566840631.999 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:30:50.574Z,1566840650.574 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=8701, MT Status=1, MTMSN=358
2019-08-26T17:30:50.574Z,1566840650.574 [NAL9602](INFO): Data available in MT queue
2019-08-26T17:30:51.075Z,1566840651.075 [NAL9602](INFO): Received command:stop
2019-08-26T17:30:51.092Z,1566840651.092 [CommandLine](IMPORTANT): got command stop
2019-08-26T17:30:51.092Z,1566840651.092 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-08-26T17:30:51.117Z,1566840651.117 [MissionManager](INFO): MissionManager is completed.
2019-08-26T17:30:51.117Z,1566840651.117 [MissionManager](INFO): Uninitializing Mission sci2
2019-08-26T17:30:51.117Z,1566840651.117 [sci2] Stopped
2019-08-26T17:30:51.117Z,1566840651.117 [sci2](DEBUG): Aggregate::uninitialize sci2
2019-08-26T17:30:51.117Z,1566840651.117 [sci2:Science] Stopped
2019-08-26T17:30:51.117Z,1566840651.117 [sci2:Science](DEBUG): Aggregate::uninitialize sci2:Science
2019-08-26T17:30:51.117Z,1566840651.117 [sci2:Science:A] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:C] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:G] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:Read_Oil] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:PeakDetectChl] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectChl
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:NeedComms] Stopped
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms
2019-08-26T17:30:51.118Z,1566840651.118 [sci2:NeedComms:B.GoToSurface] Stopped
2019-08-26T17:30:51.119Z,1566840651.119 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-26T17:30:51.119Z,1566840651.119 [sci2:NeedComms:C] Stopped
2019-08-26T17:30:51.119Z,1566840651.119 [sci2:StandardEnvelopes] Stopped
2019-08-26T17:30:51.119Z,1566840651.119 [sci2:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2:StandardEnvelopes
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:B.DepthEnvelope] Stopped
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2019-08-26T17:30:51.147Z,1566840651.147 [sci2:I.Pitch] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:J.Buoyancy] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:K.SetSpeed] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:K.SetSpeed](DEBUG): Uninitialize.
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:L.DepthEnvelope] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:L.DepthEnvelope](DEBUG): Uninitialize.
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:M.AltitudeEnvelope] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:N.YoYo] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:N.YoYo](DEBUG): Uninitialize YoYoComponent.
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:Lap] Stopped
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:Lap](DEBUG): Aggregate::uninitialize sci2:Lap
2019-08-26T17:30:51.148Z,1566840651.148 [sci2:Lap:Wpt1] Stopped
2019-08-26T17:30:51.149Z,1566840651.149 [sci2:Lap:Wpt1](DEBUG): Aggregate::uninitialize sci2:Lap:Wpt1
2019-08-26T17:30:51.149Z,1566840651.149 [sci2:Lap:Wpt1:A.Waypoint] Stopped
2019-08-26T17:30:51.149Z,1566840651.149 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2019-08-26T17:30:51.320Z,1566840651.320 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-08-26T17:30:51.490Z,1566840651.490 [MissionManager](IMPORTANT): Started mission Default
2019-08-26T17:30:51.490Z,1566840651.490 [Default] Running Loop=1
2019-08-26T17:30:51.490Z,1566840651.490 [Default](DEBUG): Aggregate::initialize Default
2019-08-26T17:30:51.490Z,1566840651.490 [Default:B.GoToSurface] Running Loop=1
2019-08-26T17:30:51.490Z,1566840651.490 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-26T17:30:51.491Z,1566840651.491 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-08-26T17:30:51.496Z,1566840651.496 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-08-26T17:30:51.496Z,1566840651.496 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-08-26T17:30:51.496Z,1566840651.496 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-26T17:30:51.497Z,1566840651.497 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-26T17:30:51.497Z,1566840651.497 [Default:A.Wait] Running Loop=1
2019-08-26T17:30:51.497Z,1566840651.497 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-08-26T17:30:51.939Z,1566840651.939 [Aanderaa_O2](INFO): Powering down
2019-08-26T17:31:03.480Z,1566840663.480 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:31:04.746Z,1566840664.746 [Default:A.Wait](INFO): Done Waiting.
2019-08-26T17:31:04.746Z,1566840664.746 [Default:A.Wait] Stopped
2019-08-26T17:31:04.746Z,1566840664.746 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-08-26T17:31:05.146Z,1566840665.146 [Default:CheckIn] Running Loop=1
2019-08-26T17:31:05.146Z,1566840665.146 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-26T17:31:05.147Z,1566840665.147 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-26T17:31:06.755Z,1566840666.755 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:10.015Z,1566840670.015 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:10.404Z,1566840670.404 [RDI_Pathfinder](ERROR): Failed to parse:
:BI,-32768,-32768,-32768,-32768,V
2019-08-26T17:31:12.810Z,1566840672.810 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:16.047Z,1566840676.047 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:18.871Z,1566840678.871 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:22.103Z,1566840682.103 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:24.935Z,1566840684.935 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:28.167Z,1566840688.167 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:30.995Z,1566840690.995 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:33.823Z,1566840693.823 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:37.055Z,1566840697.055 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:37.078Z,1566840697.078 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-08-26T17:31:37.080Z,1566840697.080 [BPC1](INFO): Received data from all battery sticks.
2019-08-26T17:31:38.627Z,1566840698.627 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:31:39.879Z,1566840699.879 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:43.135Z,1566840703.135 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:45.943Z,1566840705.943 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:49.167Z,1566840709.167 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:52.003Z,1566840712.003 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:54.831Z,1566840714.831 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:31:58.067Z,1566840718.067 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:00.904Z,1566840720.904 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:04.123Z,1566840724.123 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:06.951Z,1566840726.951 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:10.179Z,1566840730.179 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:13.011Z,1566840733.011 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:13.775Z,1566840733.775 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2019-08-26T17:32:15.835Z,1566840735.835 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:19.075Z,1566840739.075 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:21.895Z,1566840741.895 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:25.131Z,1566840745.131 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:27.955Z,1566840747.955 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:31.188Z,1566840751.188 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:32:31.583Z,1566840751.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173230.00,A,3422.65935,N,11948.67644,W,0.467,179.25,260819,,,A*78
2019-08-26T17:32:31.585Z,1566840751.585 [NAL9602](INFO): GPS fix at 20190826T173230: (34.377656, -119.811274)
2019-08-26T17:32:31.611Z,1566840751.611 [UniversalFixResidualReporter](INFO): Fix residual: 8.5 %DT, over the last 1753.3 m. Residual distance 148.2 m at bearing 57.4 degrees. Fix at (34.3777, -119.8113) with 1795.6 m made good.
2019-08-26T17:32:31.612Z,1566840751.612 [Default:CheckIn:Read_GPS] Stopped
2019-08-26T17:32:31.612Z,1566840751.612 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-26T17:33:03.629Z,1566840783.629 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-26T17:33:11.499Z,1566840791.499 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002980
2019-08-26T17:33:15.572Z,1566840795.572 [CommandLine](IMPORTANT): got command show variable micromodem
2019-08-26T17:33:15.769Z,1566840795.769 [CommandLine](IMPORTANT): Micromodem.loadAtStartup (bool)
2019-08-26T17:33:15.770Z,1566840795.770 [CommandLine](IMPORTANT): Micromodem.simulateHardware (bool)
2019-08-26T17:33:15.770Z,1566840795.770 [CommandLine](IMPORTANT): Micromodem.localAddress (enum)
2019-08-26T17:33:15.770Z,1566840795.770 [CommandLine](IMPORTANT): Micromodem.destinationAddress (enum)
2019-08-26T17:33:15.819Z,1566840795.819 [CommandLine](IMPORTANT): Micromodem.dataRate (enum)
2019-08-26T17:33:15.820Z,1566840795.820 [CommandLine](IMPORTANT): Micromodem.sendExpress (bool)
2019-08-26T17:33:15.820Z,1566840795.820 [CommandLine](IMPORTANT): Micromodem.surfaceThreshold (meter)
2019-08-26T17:33:15.820Z,1566840795.820 [CommandLine](IMPORTANT): Micromodem.pwrampTXLevel (enum)
2019-08-26T17:33:15.821Z,1566840795.821 [CommandLine](IMPORTANT): Micromodem.dusblPingCode (none)
2019-08-26T17:33:15.922Z,1566840795.922 [CommandLine](IMPORTANT): Micromodem.loadControl (none)
2019-08-26T17:33:15.922Z,1566840795.922 [CommandLine](IMPORTANT): Micromodem.loadControl2 (none)
2019-08-26T17:33:15.939Z,1566840795.939 [CommandLine](IMPORTANT): Micromodem.uart (none)
2019-08-26T17:33:15.940Z,1566840795.940 [CommandLine](IMPORTANT): Micromodem.baud (bit_per_second)
2019-08-26T17:33:15.961Z,1566840795.961 [CommandLine](IMPORTANT): Micromodem.acoustic_wakeup (count)
2019-08-26T17:33:15.961Z,1566840795.961 [CommandLine](IMPORTANT): Micromodem.acoustic_receive_time (epoch_second)
2019-08-26T17:33:15.962Z,1566840795.962 [CommandLine](IMPORTANT): Micromodem.acoustic_transmit_time (epoch_second)
2019-08-26T17:33:15.962Z,1566840795.962 [CommandLine](IMPORTANT): Micromodem.range_request (count)
2019-08-26T17:33:15.962Z,1566840795.962 [CommandLine](IMPORTANT): Micromodem.remote_address (count)
2019-08-26T17:33:15.963Z,1566840795.963 [CommandLine](IMPORTANT): Micromodem.local_address (count)
2019-08-26T17:33:15.987Z,1566840795.987 [CommandLine](IMPORTANT): Micromodem.range (meter)
2019-08-26T17:33:15.988Z,1566840795.988 [CommandLine](IMPORTANT): Micromodem.platform_communications (bool)
2019-08-26T17:33:16.165Z,1566840796.165 [CommandLine](IMPORTANT): Micromodem.component_voltage (volt)
2019-08-26T17:33:16.165Z,1566840796.165 [CommandLine](IMPORTANT): Micromodem.component_avgVoltage (volt)
2019-08-26T17:33:16.166Z,1566840796.166 [CommandLine](IMPORTANT): Micromodem.component_current (milliampere)
2019-08-26T17:33:16.166Z,1566840796.166 [CommandLine](IMPORTANT): Micromodem.component_avgCurrent (milliampere)
2019-08-26T17:33:23.954Z,1566840803.954 [CommandLine](IMPORTANT): got command get Micromodem.loadAtStartup
2019-08-26T17:33:23.955Z,1566840803.955 [CommandLine](IMPORTANT): Micromodem.loadAtStartup 1 bool
2019-08-26T17:33:24.247Z,1566840804.247 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2019-08-26T17:33:24.247Z,1566840804.247 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.00,        +0.00,     ,   0.00,1974.84
2019-08-26T17:33:26.164Z,1566840806.164 [DataOverHttps](INFO): Sending 356 bytes from file Logs/20190826T165434/Courier0003.lzma
2019-08-26T17:33:26.969Z,1566840806.969 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Courier0003.lzma.bak
2019-08-26T17:33:26.970Z,1566840806.970 [DataOverHttps](INFO): SBD MOMSN=11695954
2019-08-26T17:33:48.926Z,1566840828.926 [DataOverHttps](INFO): Sending 2465 bytes from file Logs/20190826T165434/Express0004.lzma
2019-08-26T17:33:49.729Z,1566840829.729 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Express0004.lzma.bak
2019-08-26T17:33:49.729Z,1566840829.729 [DataOverHttps](INFO): SBD MOMSN=11695958
2019-08-26T17:33:51.710Z,1566840831.710 [Default:CheckIn:Read_Iridium] Stopped
2019-08-26T17:33:51.711Z,1566840831.711 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-26T17:33:51.711Z,1566840831.711 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-26T17:34:06.112Z,1566840846.112 [DataOverHttps](IMPORTANT): SBD MTMSN=20190826T173405
2019-08-26T17:34:13.735Z,1566840853.735 [DataOverHttps](INFO): Received command:configSet Courier linearApproximation WetLabsSeaOWL_UV_A.OutputFDOM 50 count persist
2019-08-26T17:34:16.184Z,1566840856.184 [CommandLine](IMPORTANT): got command configSet Courier linearApproximation WetLabsSeaOWL_UV_A.OutputFDOM 50.000000 count persist
2019-08-26T17:35:57.645Z,1566840957.645 [DataOverHttps](IMPORTANT): SBD MTMSN=20190826T173557
2019-08-26T17:36:04.291Z,1566840964.291 [DataOverHttps](INFO): Received command:sched asap "load Science/sci2.xml;set sci2.NeedCommsTime 15 minute;set sci2.Lat1 34.39665 degree;set sci2.Lon1 -119.875317 degree;set sci2.Lat2 34.4047 degree;set sci2.Lon2 -119.933 degree;set sci2.Lat3 34.384231 degree" 1sbjj 1 3
2019-08-26T17:36:04.325Z,1566840964.325 [CommandLine](IMPORTANT): got command schedule asap "load Science/sci2.xml;set sci2.NeedCommsTime 15 minute;set sci2.Lat1 34.39665 degree;set sci2.Lon1 -119.875317 degree;set sci2.Lat2 34.4047 degree;set sci2.Lon2 -119.933 degree;set sci2.Lat3 34.384231 degree" 1sbjj 1 3.000000
2019-08-26T17:36:04.325Z,1566840964.325 [CommandLine](IMPORTANT): Scheduling command #1 of 3 with id=1sbjj
2019-08-26T17:36:04.326Z,1566840964.326 [CommandLine](IMPORTANT): Scheduled #42 (#1 of 3 with id='1sbjj'): "load Science/sci2.xml;set sci2.NeedCommsTime 15 minute;set sci2.Lat1 34.39665 degree;set sci2.Lon1 -119.875317 degree;set sci2.Lat2 34.4047 degree;set sci2.Lon2 -119.933 degree;set sci2.Lat3 34.384231 degree" ASAP
2019-08-26T17:36:05.097Z,1566840965.097 [DataOverHttps](IMPORTANT): SBD MTMSN=20190826T173604
2019-08-26T17:36:19.912Z,1566840979.912 [DataOverHttps](INFO): Received command:sched asap "set sci2.Lon3 -119.94913 degree;set sci2.Lat4 34.370162 degree;set sci2.Lon4 -119.895112 degree;set sci2.Lat5 34.384383 degree;set sci2.Lon5 -119.890467 degree;set sci2.YoYoMaxDepth 30 meter;set sci2.MaxDepth 80 meter" 1sbjj 2 3
2019-08-26T17:36:19.952Z,1566840979.952 [CommandLine](IMPORTANT): got command schedule asap "set sci2.Lon3 -119.94913 degree;set sci2.Lat4 34.370162 degree;set sci2.Lon4 -119.895112 degree;set sci2.Lat5 34.384383 degree;set sci2.Lon5 -119.890467 degree;set sci2.YoYoMaxDepth 30 meter;set sci2.MaxDepth 80 meter" 1sbjj 2 3.000000
2019-08-26T17:36:19.952Z,1566840979.952 [CommandLine](IMPORTANT): Scheduling command #2 of 3 with id=1sbjj
2019-08-26T17:36:19.953Z,1566840979.953 [CommandLine](IMPORTANT): Scheduled #43 (#2 of 3 with id='1sbjj'): "set sci2.Lon3 -119.94913 degree;set sci2.Lat4 34.370162 degree;set sci2.Lon4 -119.895112 degree;set sci2.Lat5 34.384383 degree;set sci2.Lon5 -119.890467 degree;set sci2.YoYoMaxDepth 30 meter;set sci2.MaxDepth 80 meter" ASAP
2019-08-26T17:36:20.716Z,1566840980.716 [DataOverHttps](IMPORTANT): SBD MTMSN=20190826T173620
2019-08-26T17:36:26.259Z,1566840986.259 [DataOverHttps](INFO): Received command:sched asap "set sci2.MinOffshore 1 kilometer;run " 1sbjj 3 3
2019-08-26T17:36:26.263Z,1566840986.263 [CommandLine](IMPORTANT): got command schedule asap "set sci2.MinOffshore 1 kilometer;run " 1sbjj 3 3.000000
2019-08-26T17:36:26.264Z,1566840986.264 [CommandLine](IMPORTANT): Scheduling command #3 of 3 with id=1sbjj
2019-08-26T17:36:26.264Z,1566840986.264 [CommandLine](IMPORTANT): Scheduled #44 (#3 of 3 with id='1sbjj'): "set sci2.MinOffshore 1 kilometer;run " ASAP
2019-08-26T17:36:26.393Z,1566840986.393 [CommandLine](IMPORTANT): got command load ./Missions/Science/sci2.xml
2019-08-26T17:36:26.394Z,1566840986.394 [MissionManager](INFO): Loading Mission: ./Missions/Science/sci2.xml
2019-08-26T17:36:26.488Z,1566840986.488 [MissionManager](INFO): DefineArg sci2.MissionTimeout = 2.000000 h
2019-08-26T17:36:26.490Z,1566840986.490 [MissionManager](INFO): DefineArg sci2.NeedCommsTime = 60.000000 min
2019-08-26T17:36:26.533Z,1566840986.533 [MissionManager](INFO): DefineArg sci2.Repeat = 1.000000 count
2019-08-26T17:36:26.535Z,1566840986.535 [MissionManager](INFO): DefineArg sci2.Lat1 = nan arcdeg
2019-08-26T17:36:26.537Z,1566840986.537 [MissionManager](INFO): DefineArg sci2.Lon1 = nan arcdeg
2019-08-26T17:36:26.541Z,1566840986.541 [MissionManager](INFO): DefineArg sci2.Lat2 = nan arcdeg
2019-08-26T17:36:26.571Z,1566840986.571 [MissionManager](INFO): DefineArg sci2.Lon2 = nan arcdeg
2019-08-26T17:36:26.573Z,1566840986.573 [MissionManager](INFO): DefineArg sci2.Lat3 = nan arcdeg
2019-08-26T17:36:26.580Z,1566840986.580 [MissionManager](INFO): DefineArg sci2.Lon3 = nan arcdeg
2019-08-26T17:36:26.582Z,1566840986.582 [MissionManager](INFO): DefineArg sci2.Lat4 = nan arcdeg
2019-08-26T17:36:26.590Z,1566840986.590 [MissionManager](INFO): DefineArg sci2.Lon4 = nan arcdeg
2019-08-26T17:36:26.617Z,1566840986.617 [MissionManager](INFO): DefineArg sci2.Lat5 = nan arcdeg
2019-08-26T17:36:26.619Z,1566840986.619 [MissionManager](INFO): DefineArg sci2.Lon5 = nan arcdeg
2019-08-26T17:36:26.633Z,1566840986.633 [MissionManager](INFO): DefineArg sci2.Lat6 = nan arcdeg
2019-08-26T17:36:26.640Z,1566840986.640 [MissionManager](INFO): DefineArg sci2.Lon6 = nan arcdeg
2019-08-26T17:36:26.642Z,1566840986.642 [MissionManager](INFO): DefineArg sci2.Lat7 = nan arcdeg
2019-08-26T17:36:26.644Z,1566840986.644 [MissionManager](INFO): DefineArg sci2.Lon7 = nan arcdeg
2019-08-26T17:36:26.646Z,1566840986.646 [MissionManager](INFO): DefineArg sci2.Speed = 1.000000 m/s
2019-08-26T17:36:26.657Z,1566840986.657 [MissionManager](INFO): DefineArg sci2.CaptureRadius = nan m
2019-08-26T17:36:26.659Z,1566840986.659 [MissionManager](INFO): DefineArg sci2.YoYoMinDepth = 2.000000 m
2019-08-26T17:36:26.665Z,1566840986.665 [MissionManager](INFO): DefineArg sci2.YoYoMaxDepth = 200.000000 m
2019-08-26T17:36:26.672Z,1566840986.672 [MissionManager](INFO): DefineArg sci2.YoYoMinAltitude = 9.000000 m
2019-08-26T17:36:26.674Z,1566840986.674 [MissionManager](INFO): DefineArg sci2.YoYoUpPitch = 20.000000 arcdeg
2019-08-26T17:36:26.681Z,1566840986.681 [MissionManager](INFO): DefineArg sci2.YoYoDownPitch = -20.000000 arcdeg
2019-08-26T17:36:26.691Z,1566840986.691 [MissionManager](INFO): DefineArg sci2.BuoyancyNeutral = 277.999992 cc
2019-08-26T17:36:26.694Z,1566840986.694 [MissionManager](INFO): DefineArg sci2.MassDefault = 2.500000 cm
2019-08-26T17:36:26.699Z,1566840986.699 [MissionManager](INFO): DefineArg sci2.MinAltitude = 5.000000 m
2019-08-26T17:36:26.709Z,1566840986.709 [MissionManager](INFO): DefineArg sci2.MaxDepth = 205.000000 m
2019-08-26T17:36:26.715Z,1566840986.715 [MissionManager](INFO): DefineArg sci2.MinOffshore = 2.000000 km
2019-08-26T17:36:26.716Z,1566840986.716 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2019-08-26T17:36:27.068Z,1566840987.068 [MissionManager](INFO): DefineArg sci2:Science.SampleISUS = 0 bool
2019-08-26T17:36:27.070Z,1566840987.070 [MissionManager](INFO): DefineArg sci2:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2019-08-26T17:36:27.073Z,1566840987.073 [MissionManager](INFO): DefineArg sci2:Science.SampleISUSminPitch = -60.000000 arcdeg
2019-08-26T17:36:27.075Z,1566840987.075 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectChlActive = 0 bool
2019-08-26T17:36:27.077Z,1566840987.077 [MissionManager](INFO): DefineArg sci2:Science.TimeWindowPeakReport = nan min
2019-08-26T17:36:27.080Z,1566840987.080 [MissionManager](INFO): DefineArg sci2:Science.HighestChlPeakReportActive = 0 bool
2019-08-26T17:36:27.082Z,1566840987.082 [MissionManager](INFO): DefineArg sci2:Science.PatchTracking = 0 bool
2019-08-26T17:36:27.084Z,1566840987.084 [MissionManager](INFO): DefineArg sci2:Science.FilterWidthHorizontal = 3.000000 count
2019-08-26T17:36:27.086Z,1566840987.086 [MissionManager](INFO): DefineArg sci2:Science.NumProfilesSlidingwindow = 100.000000 count
2019-08-26T17:36:27.088Z,1566840987.088 [MissionManager](INFO): DefineArg sci2:Science.OffPeakFractionHorizontal = 80.000000 %
2019-08-26T17:36:27.090Z,1566840987.090 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectNO3Active = 0 bool
2019-08-26T17:36:27.092Z,1566840987.092 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectOilActive = 0 bool
2019-08-26T17:36:27.094Z,1566840987.094 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectFDOMActive = 0 bool
2019-08-26T17:36:27.096Z,1566840987.096 [MissionManager](INFO): DefineArg sci2:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2019-08-26T17:36:27.099Z,1566840987.099 [MissionManager](INFO): DefineArg sci2:Science.EnabledAanderaaO2 = 1.000000 bool
2019-08-26T17:36:27.101Z,1566840987.101 [MissionManager](INFO): DefineArg sci2:Science.EnabledNeilBrown = 1.000000 bool
2019-08-26T17:36:27.104Z,1566840987.104 [MissionManager](INFO): DefineArg sci2:Science.EnabledSeabird = 0.000000 bool
2019-08-26T17:36:27.106Z,1566840987.106 [MissionManager](INFO): DefineArg sci2:Science.EnabledTurbulence_NPS = 0.000000 bool
2019-08-26T17:36:27.109Z,1566840987.109 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsBB2FL = 0.000000 bool
2019-08-26T17:36:27.112Z,1566840987.112 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool
2019-08-26T17:36:27.114Z,1566840987.114 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsUBAT = 0.000000 bool
2019-08-26T17:36:27.117Z,1566840987.117 [MissionManager](INFO): DefineArg sci2:Science.EnabledISUS = 0.000000 bool
2019-08-26T17:36:27.119Z,1566840987.119 [MissionManager](INFO): DefineArg sci2:Science.LowPassWindowLength = 20.000000 count
2019-08-26T17:36:27.121Z,1566840987.121 [MissionManager](INFO): DefineArg sci2:Science.MedianFilterLen = 5.000000 count
2019-08-26T17:36:27.123Z,1566840987.123 [MissionManager](INFO): DefineArg sci2:Science.PeakChlShallowBound = nan m
2019-08-26T17:36:27.126Z,1566840987.126 [MissionManager](INFO): DefineArg sci2:Science.PeakChlDeepBound = nan m
2019-08-26T17:36:27.128Z,1566840987.128 [MissionManager](INFO): DefineArg sci2:Science.PeakShallowBound = nan m
2019-08-26T17:36:27.130Z,1566840987.130 [MissionManager](INFO): DefineArg sci2:Science.PeakDeepBound = nan m
2019-08-26T17:36:27.132Z,1566840987.132 [MissionManager](INFO): DefineOutput sci2:Science.PeakChl = 0.000000 ug/l
2019-08-26T17:36:27.135Z,1566840987.135 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlDepth = 0.000000 m
2019-08-26T17:36:27.161Z,1566840987.161 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlTemperature = 0.000000 degC
2019-08-26T17:36:27.168Z,1566840987.168 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLatitude = nan arcdeg
2019-08-26T17:36:27.170Z,1566840987.170 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLongitude = nan arcdeg
2019-08-26T17:36:27.177Z,1566840987.177 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3 = 0.000000 umol/l
2019-08-26T17:36:27.183Z,1566840987.183 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Depth = 0.000000 m
2019-08-26T17:36:27.186Z,1566840987.186 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Latitude = nan arcdeg
2019-08-26T17:36:27.192Z,1566840987.192 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Longitude = nan arcdeg
2019-08-26T17:36:27.194Z,1566840987.194 [MissionManager](INFO): DefineOutput sci2:Science.PatchChl = 0.000000 m
2019-08-26T17:36:27.201Z,1566840987.201 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDepth = 0.000000 m
2019-08-26T17:36:27.208Z,1566840987.208 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLatitude = nan arcdeg
2019-08-26T17:36:27.210Z,1566840987.210 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLongitude = nan arcdeg
2019-08-26T17:36:27.213Z,1566840987.213 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDistance = nan m
2019-08-26T17:36:27.215Z,1566840987.215 [MissionManager](INFO): DefineOutput sci2:Science.PeakOil = 0.000000 kg/m3
2019-08-26T17:36:27.229Z,1566840987.229 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilDepth = 0.000000 m
2019-08-26T17:36:27.235Z,1566840987.235 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLatitude = nan arcdeg
2019-08-26T17:36:27.245Z,1566840987.245 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLongitude = nan arcdeg
2019-08-26T17:36:27.256Z,1566840987.256 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOM = 0.000000 ppb
2019-08-26T17:36:27.258Z,1566840987.258 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMDepth = 0.000000 m
2019-08-26T17:36:27.265Z,1566840987.265 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLatitude = nan arcdeg
2019-08-26T17:36:27.279Z,1566840987.279 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLongitude = nan arcdeg
2019-08-26T17:36:27.281Z,1566840987.281 [MissionManager](INFO): DefineOutput sci2:Science.PatchFDOMDistance = nan m
2019-08-26T17:36:27.367Z,1566840987.367 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-26T17:36:27.409Z,1566840987.409 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2019-08-26T17:36:27.456Z,1566840987.456 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-26T17:36:27.477Z,1566840987.477 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-26T17:36:27.500Z,1566840987.500 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-08-26T17:36:27.509Z,1566840987.509 [MissionManager](INFO): RedefineArg sci2:Science.SampleISUS = value:1 bool
2019-08-26T17:36:27.511Z,1566840987.511 [MissionManager](INFO): RedefineArg sci2:Science.PeakDetectChlActive = value:1 bool
2019-08-26T17:36:27.525Z,1566840987.525 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml
2019-08-26T17:36:27.625Z,1566840987.625 [MissionManager](INFO): DefineArg sci2:NeedComms.DiveInterval = 3.000000 h
2019-08-26T17:36:27.636Z,1566840987.636 [MissionManager](INFO): DefineArg sci2:NeedComms.WaitForPitchUp = 10.000000 min
2019-08-26T17:36:27.644Z,1566840987.644 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfacePitch = 20.000000 arcdeg
2019-08-26T17:36:27.646Z,1566840987.646 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceDepthRate = nan m/s
2019-08-26T17:36:27.648Z,1566840987.648 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceSpeed = 1.000000 m/s
2019-08-26T17:36:27.650Z,1566840987.650 [MissionManager](INFO): DefineArg sci2:NeedComms.GPSTimeout = 7.000000 min
2019-08-26T17:36:27.673Z,1566840987.673 [MissionManager](INFO): DefineArg sci2:NeedComms.CommsTimeout = 30.000000 min
2019-08-26T17:36:27.678Z,1566840987.678 [sci2:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-08-26T17:36:27.705Z,1566840987.705 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml
2019-08-26T17:36:27.805Z,1566840987.805 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinAltitude = 5.000000 m
2019-08-26T17:36:27.820Z,1566840987.820 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MaxDepth = 200.000000 m
2019-08-26T17:36:27.822Z,1566840987.822 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinOffshore = 2000.000000 m
2019-08-26T17:36:27.827Z,1566840987.827 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2019-08-26T17:36:27.833Z,1566840987.833 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2019-08-26T17:36:27.851Z,1566840987.851 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2019-08-26T17:36:27.869Z,1566840987.869 [sci2:I.Pitch](DEBUG): Construct.
2019-08-26T17:36:27.889Z,1566840987.889 [sci2:J.Buoyancy](DEBUG): Construct Buoyancy.
2019-08-26T17:36:27.896Z,1566840987.896 [sci2:K.SetSpeed](DEBUG): Construct.
2019-08-26T17:36:27.898Z,1566840987.898 [sci2:L.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2019-08-26T17:36:27.918Z,1566840987.918 [sci2:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2019-08-26T17:36:27.936Z,1566840987.936 [sci2:N.YoYo](DEBUG): Construct YoYo.
2019-08-26T17:36:27.947Z,1566840987.947 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:27.960Z,1566840987.960 [sci2:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:27.973Z,1566840987.973 [sci2:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:27.978Z,1566840987.978 [sci2:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:27.995Z,1566840987.995 [sci2:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:28.005Z,1566840988.005 [sci2:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:28.010Z,1566840988.010 [sci2:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint.
2019-08-26T17:36:28.082Z,1566840988.082 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Control="Tethys/Control"
         xmlns:Guidance="Tethys/Guidance"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd"
       Id="sci2">

    <Description>
        Vehicle yo-yo's to the specified waypoints, with science turned on.
    </Description>
    <DefineArg Name="MissionTimeout"><Description>
        Maximum duration of mission
    </Description><Units:hour/><Value>2</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        How often to surface for commumications
    </Description><Units:minute/><Value>60</Value></DefineArg>

    <DefineArg Name="Repeat"><Description>
        Number of times the vehicle should try to cycle through waypoints..
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="Lat1"><Description>
        Latitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon1"><Description>
        Longitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat2"><Description>
        Latitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon2"><Description>
        Longitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat3"><Description>
        Latitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon3"><Description>
        Longitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat4"><Description>
        Latitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon4"><Description>
        Longitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat5"><Description>
        Latitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon5"><Description>
        Longitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat6"><Description>
        Latitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon6"><Description>
        Longitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat7"><Description>
        Latitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon7"><Description>
        Longitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Speed while performing the YoYo behavior.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

    <DefineArg Name="CaptureRadius"><Description>
        Speed while performing the YoYo behavior.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    
    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>200</Value></DefineArg>

    <DefineArg Name="YoYoMinAltitude"><Description>
        Minimum altitude while performing the YoYo behavior (for
        bottom-terminated YoYos).
    </Description><Units:meter/><Value>9</Value></DefineArg>

    <DefineArg Name="YoYoUpPitch"><Description>
        Vehicle up pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="YoYoDownPitch"><Description>
        Vehicle down pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>-20</Value></DefineArg>

    <DefineArg Name="BuoyancyNeutral"><Description>
        Buoyancy bladder position while performing the YoYo behavior. Defaults
        to buoyancyNeutral setting in the Config/Control.cfg file. Set to NaN cc
        for active buoyancy
    </Description><Control:VerticalControl.buoyancyNeutral/></DefineArg>

    <DefineArg Name="MassDefault"><Description>
        Static setting for mass during the mission. Set to NaN mm for active
        mass position
    </Description><Control:VerticalControl.massDefault/></DefineArg>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>5</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>205</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>
    <Timeout Duration="MissionTimeout"/>

    <Insert Filename="Insert/Science.xml">
        <Description>
            Most missions will run the science sensors. If you don't place this
            aggregate above NeedComms, science instruments get turned off on the
            last upcast and while floating on the surface.
        </Description>
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="NeedCommsTime"/></Assign>

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

    <Call Id="StartingMission" RefId="NeedComms"/>

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Arg Name="MassDefault"/></Setting>
    </Guidance:Pitch>

    <Guidance:Buoyancy>
        <Parallel/>
        <Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope>
        <Description>
            Another depth envelope for the YoYo behavior. This envelope should
            fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for depth-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
        <Setting><Guidance:DepthEnvelope.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:AltitudeEnvelope>
        <Description>
            Another altitude envelope for the YoYo behavior. This envelope
            should fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for bottom-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="YoYoMinAltitude"/></Setting>
        <Setting><Guidance:AltitudeEnvelope.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:YoYo>
        <Parallel/>
        <Setting><Guidance:YoYo.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
        <Setting><Guidance:YoYo.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:YoYo>

    <Aggregate Id="Lap">
        <Sequence Repeat="Repeat"/>

        <Aggregate Id="Wpt1">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat1"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon1"/></Setting>
                <Setting><Guidance:Waypoint.captureRadius/><Arg Name="CaptureRadius"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt2">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat2"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon2"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt3">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat3"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon3"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt4">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat4"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon4"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt5">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat5"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon5"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt6">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat6"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon6"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>

        <Aggregate Id="Wpt7">
            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat7"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon7"/></Setting>
            </Guidance:Waypoint>
        </Aggregate>
    </Aggregate>
</Mission>


2019-08-26T17:36:28.082Z,1566840988.082 [CommandLine](IMPORTANT): Loaded ./Missions/Science/sci2.xml
2019-08-26T17:36:35.528Z,1566840995.528 [CommandLine](IMPORTANT): got command set sci2.NeedCommsTime 15.000000 minute
2019-08-26T17:36:35.528Z,1566840995.528 [CommandLine](IMPORTANT): got command set sci2.Lat1 34.396648 degree
2019-08-26T17:36:35.529Z,1566840995.529 [CommandLine](IMPORTANT): got command set sci2.Lon1 -119.875320 degree
2019-08-26T17:36:35.530Z,1566840995.530 [CommandLine](IMPORTANT): got command set sci2.Lat2 34.404701 degree
2019-08-26T17:36:35.531Z,1566840995.531 [CommandLine](IMPORTANT): got command set sci2.Lon2 -119.932999 degree
2019-08-26T17:36:35.532Z,1566840995.532 [CommandLine](IMPORTANT): got command set sci2.Lat3 34.384232 degree
2019-08-26T17:36:44.746Z,1566841004.746 [CommandLine](IMPORTANT): got command set sci2.Lon3 -119.949127 degree
2019-08-26T17:36:44.752Z,1566841004.752 [CommandLine](IMPORTANT): got command set sci2.Lat4 34.370163 degree
2019-08-26T17:36:44.752Z,1566841004.752 [CommandLine](IMPORTANT): got command set sci2.Lon4 -119.895111 degree
2019-08-26T17:36:44.753Z,1566841004.753 [CommandLine](IMPORTANT): got command set sci2.Lat5 34.384384 degree
2019-08-26T17:36:44.754Z,1566841004.754 [CommandLine](IMPORTANT): got command set sci2.Lon5 -119.890465 degree
2019-08-26T17:36:44.755Z,1566841004.755 [CommandLine](IMPORTANT): got command set sci2.YoYoMaxDepth 30.000000 meter
2019-08-26T17:36:44.760Z,1566841004.760 [CommandLine](IMPORTANT): got command set sci2.MaxDepth 80.000000 meter
2019-08-26T17:36:46.650Z,1566841006.650 [CommandLine](IMPORTANT): got command set sci2.MinOffshore 1.000000 kilometer
2019-08-26T17:36:46.650Z,1566841006.650 [CommandLine](IMPORTANT): got command run 
2019-08-26T17:36:46.652Z,1566841006.652 [CommandLine](IMPORTANT): Running 
2019-08-26T17:36:46.762Z,1566841006.762 [Default] Stopped
2019-08-26T17:36:46.762Z,1566841006.762 [Default](DEBUG): Aggregate::uninitialize Default
2019-08-26T17:36:46.762Z,1566841006.762 [Default:B.GoToSurface] Stopped
2019-08-26T17:36:46.762Z,1566841006.762 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-26T17:36:46.762Z,1566841006.762 [Default:CheckIn] Stopped
2019-08-26T17:36:46.762Z,1566841006.762 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-26T17:36:46.762Z,1566841006.762 [Default:CheckIn:C.Wait] Stopped
2019-08-26T17:36:46.762Z,1566841006.762 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-26T17:36:46.763Z,1566841006.763 [MissionManager](IMPORTANT): Started mission sci2
2019-08-26T17:36:46.763Z,1566841006.763 [sci2] Running Loop=1
2019-08-26T17:36:46.763Z,1566841006.763 [sci2](DEBUG): Aggregate::initialize sci2
2019-08-26T17:36:46.763Z,1566841006.763 [sci2:Science] Running Loop=1
2019-08-26T17:36:46.763Z,1566841006.763 [sci2:Science](DEBUG): Aggregate::initialize sci2:Science
2019-08-26T17:36:46.763Z,1566841006.763 [sci2:Science:A] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:B] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:C] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:D] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:E] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:F] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:G] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:H] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:Read_Oil] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:PeakDetectChl] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2:Science:PeakDetectChl
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2019-08-26T17:36:46.764Z,1566841006.764 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-26T17:36:46.766Z,1566841006.766 [sci2:Science:HighestChlPeakReport] Running Loop=1
2019-08-26T17:36:46.766Z,1566841006.766 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestChlPeakReport
2019-08-26T17:36:46.766Z,1566841006.766 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2019-08-26T17:36:46.766Z,1566841006.766 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2019-08-26T17:36:46.766Z,1566841006.766 [sci2:Science:PeakDetectNO3] Running Loop=1
2019-08-26T17:36:46.767Z,1566841006.767 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2:Science:PeakDetectNO3
2019-08-26T17:36:46.767Z,1566841006.767 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2019-08-26T17:36:46.767Z,1566841006.767 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-26T17:36:46.768Z,1566841006.768 [sci2:Science:PeakDetectOil] Running Loop=1
2019-08-26T17:36:46.768Z,1566841006.768 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2:Science:PeakDetectOil
2019-08-26T17:36:46.768Z,1566841006.768 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2019-08-26T17:36:46.768Z,1566841006.768 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-26T17:36:46.769Z,1566841006.769 [sci2:Science:PeakDetectFDOM] Running Loop=1
2019-08-26T17:36:46.770Z,1566841006.770 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2:Science:PeakDetectFDOM
2019-08-26T17:36:46.770Z,1566841006.770 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2019-08-26T17:36:46.770Z,1566841006.770 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-08-26T17:36:46.771Z,1566841006.771 [sci2:StandardEnvelopes] Running Loop=1
2019-08-26T17:36:46.771Z,1566841006.771 [sci2:StandardEnvelopes](DEBUG): Aggregate::initialize sci2:StandardEnvelopes
2019-08-26T17:36:46.771Z,1566841006.771 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2019-08-26T17:36:46.771Z,1566841006.771 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2019-08-26T17:36:46.771Z,1566841006.771 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:I.Pitch] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:I.Pitch](DEBUG): Initialize.
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:J.Buoyancy] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:J.Buoyancy](DEBUG): Initialize Buoyancy Component.
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:K.SetSpeed] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:K.SetSpeed](DEBUG): Initialize.
2019-08-26T17:36:46.772Z,1566841006.772 [sci2:L.DepthEnvelope] Running Loop=1
2019-08-26T17:36:46.772Z,1566841006.773 [sci2:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2019-08-26T17:36:46.773Z,1566841006.773 [sci2:M.AltitudeEnvelope] Running Loop=1
2019-08-26T17:36:46.773Z,1566841006.773 [sci2:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2019-08-26T17:36:46.773Z,1566841006.773 [sci2:N.YoYo] Running Loop=1
2019-08-26T17:36:46.773Z,1566841006.773 [sci2:N.YoYo](DEBUG): Initialize YoYoComponent.
2019-08-26T17:36:46.773Z,1566841006.773 [sci2:C] Running Loop=1
2019-08-26T17:36:46.774Z,1566841006.774 [sci2:N.YoYo] Running Loop=1
2019-08-26T17:36:46.774Z,1566841006.774 [sci2:M.AltitudeEnvelope] Running Loop=1
2019-08-26T17:36:46.775Z,1566841006.775 [sci2:L.DepthEnvelope] Running Loop=1
2019-08-26T17:36:46.776Z,1566841006.776 [sci2:K.SetSpeed] Running Loop=1
2019-08-26T17:36:46.776Z,1566841006.776 [sci2:J.Buoyancy] Running Loop=1
2019-08-26T17:36:46.776Z,1566841006.776 [sci2:I.Pitch] Running Loop=1
2019-08-26T17:36:46.776Z,1566841006.776 [sci2:StandardEnvelopes] Running Loop=1
2019-08-26T17:36:46.776Z,1566841006.776 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2019-08-26T17:36:46.777Z,1566841006.777 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2019-08-26T17:36:46.777Z,1566841006.777 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2019-08-26T17:36:46.777Z,1566841006.777 [sci2:C] Stopped
2019-08-26T17:36:46.777Z,1566841006.777 [sci2:E] Running Loop=1
2019-08-26T17:36:46.778Z,1566841006.778 [sci2:Science] Running Loop=1
2019-08-26T17:36:46.779Z,1566841006.779 [sci2:Science:PeakDetectFDOM] Stopped
2019-08-26T17:36:46.779Z,1566841006.779 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectFDOM
2019-08-26T17:36:46.779Z,1566841006.779 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2019-08-26T17:36:46.779Z,1566841006.779 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-26T17:36:46.779Z,1566841006.779 [sci2:Science:PeakDetectOil] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectOil
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectNO3] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectNO3
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:HighestChlPeakReport] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestChlPeakReport
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2019-08-26T17:36:46.780Z,1566841006.780 [sci2:Science:PeakDetectChl] Running Loop=1
2019-08-26T17:36:46.781Z,1566841006.781 [sci2:Science:Read_Oil] Running Loop=1
2019-08-26T17:36:46.781Z,1566841006.781 [sci2:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-08-26T17:36:46.781Z,1566841006.781 [sci2:Science:H] Stopped
2019-08-26T17:36:46.781Z,1566841006.781 [sci2:Science:G] Running Loop=1
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:F] Stopped
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:E] Stopped
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:D] Stopped
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:C] Running Loop=1
2019-08-26T17:36:46.782Z,1566841006.782 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2019-08-26T17:36:46.783Z,1566841006.783 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2019-08-26T17:36:46.783Z,1566841006.783 [sci2:Science:B] Stopped
2019-08-26T17:36:46.783Z,1566841006.783 [sci2:Science:A] Running Loop=1
2019-08-26T17:36:46.784Z,1566841006.784 [sci2:Science:A](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_oxygen_in_sea_water
2019-08-26T17:36:46.868Z,1566841006.868 [CTD_NeilBrown](INFO): Opening uart, block timeout 10ths=4
2019-08-26T17:36:47.048Z,1566841007.048 [WetLabsSeaOWL_UV_A](INFO): Opening uart, block timeout 10ths=4
2019-08-26T17:36:47.048Z,1566841007.048 [WetLabsSeaOWL_UV_A](INFO): Powering up
2019-08-26T17:36:47.162Z,1566841007.162 [sci2:E] Stopped
2019-08-26T17:36:47.163Z,1566841007.163 [sci2:F] Running Loop=1
2019-08-26T17:36:47.594Z,1566841007.594 [sci2:F] Stopped
2019-08-26T17:36:47.594Z,1566841007.594 [sci2:G] Running Loop=1
2019-08-26T17:36:47.989Z,1566841007.989 [sci2:G] Stopped
2019-08-26T17:36:47.989Z,1566841007.989 [sci2:StartingMission] Running Loop=1
2019-08-26T17:36:47.989Z,1566841007.989 [sci2:StartingMission](DEBUG): Aggregate::initialize sci2:StartingMission
2019-08-26T17:36:48.387Z,1566841008.387 [sci2:NeedComms] Running Loop=1
2019-08-26T17:36:48.387Z,1566841008.387 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms
2019-08-26T17:36:48.387Z,1566841008.387 [sci2:NeedComms:B.GoToSurface] Running Loop=1
2019-08-26T17:36:48.387Z,1566841008.387 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-26T17:36:48.388Z,1566841008.388 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2019-08-26T17:36:48.388Z,1566841008.388 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2019-08-26T17:36:48.389Z,1566841008.389 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2019-08-26T17:36:48.389Z,1566841008.389 [sci2:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-26T17:36:48.389Z,1566841008.389 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-26T17:36:48.390Z,1566841008.390 [sci2:NeedComms:A] Running Loop=1
2019-08-26T17:36:48.391Z,1566841008.391 [sci2:NeedComms:A](INFO): last time_fix was: 1566840750.000000 second since 1970/01/01T00:00:00Z 
2019-08-26T17:36:48.391Z,1566841008.391 [sci2:NeedComms:A] Stopped
2019-08-26T17:36:48.833Z,1566841008.833 [sci2:NeedComms:C] Running Loop=1
2019-08-26T17:36:49.236Z,1566841009.236 [sci2:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-08-26T17:36:49.582Z,1566841009.582 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2019-08-26T17:36:50.383Z,1566841010.383 [NAL9602](DEBUG): Fix Requested
2019-08-26T17:36:50.781Z,1566841010.781 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,173650.00,A,3422.67324,N,11948.67799,W,0.467,341.08,260819,,,A*75
2019-08-26T17:36:50.784Z,1566841010.784 [NAL9602](INFO): GPS fix at 20190826T173650: (34.377887, -119.811300)
2019-08-26T17:36:50.826Z,1566841010.826 [sci2:NeedComms:C] Stopped
2019-08-26T17:36:50.826Z,1566841010.826 [sci2:NeedComms:D] Running Loop=1
2019-08-26T17:36:51.311Z,1566841011.311 [sci2:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-08-26T17:36:59.335Z,1566841019.335 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20190826T165434/Courier0006.lzma
2019-08-26T17:37:00.140Z,1566841020.140 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Courier0006.lzma.bak
2019-08-26T17:37:00.141Z,1566841020.141 [DataOverHttps](INFO): SBD MOMSN=11695993
2019-08-26T17:37:14.774Z,1566841034.774 [DataOverHttps](INFO): Sending 40 bytes from file Logs/20190826T165434/Courier0009.lzma
2019-08-26T17:37:15.581Z,1566841035.581 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Courier0009.lzma.bak
2019-08-26T17:37:15.581Z,1566841035.581 [DataOverHttps](INFO): SBD MOMSN=11695996
2019-08-26T17:37:16.771Z,1566841036.771 [RDI_Pathfinder](ERROR): Failed to parse:
68,-32768,-32768,V
2019-08-26T17:37:20.797Z,1566841040.797 [NAL9602](INFO): SBD MO Status=2, MOMSN=8702, MT Status=2, MTMSN=0
2019-08-26T17:37:20.797Z,1566841040.797 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-26T17:37:25.320Z,1566841045.320 [RDI_Pathfinder](ERROR): Failed to parse:768,-32768,-32768,V
2019-08-26T17:37:31.341Z,1566841051.341 [DataOverHttps](INFO): Sending 1229 bytes from file Logs/20190826T165434/Express0007.lzma
2019-08-26T17:37:32.145Z,1566841052.145 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Express0007.lzma.bak
2019-08-26T17:37:32.145Z,1566841052.145 [DataOverHttps](INFO): SBD MOMSN=11695998
2019-08-26T17:37:38.966Z,1566841058.966 [NAL9602](INFO): SBD MO Status=2, MOMSN=8702, MT Status=2, MTMSN=0
2019-08-26T17:37:38.967Z,1566841058.967 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-26T17:37:47.326Z,1566841067.326 [DataOverHttps](INFO): Sending 53 bytes from file Logs/20190826T165434/Express0008.lzma
2019-08-26T17:37:48.133Z,1566841068.133 [DataOverHttps](INFO): Moved sent file to Logs/20190826T165434/Express0008.lzma.bak
2019-08-26T17:37:48.133Z,1566841068.133 [DataOverHttps](IMPORTANT): SBD MOMSN=11696062, MTMSN=20190826T173747
2019-08-26T17:37:50.739Z,1566841070.739 [sci2:NeedComms:D] Stopped
2019-08-26T17:37:50.743Z,1566841070.743 [sci2:NeedComms:E] Running Loop=1
2019-08-26T17:37:51.142Z,1566841071.142 [sci2:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-08-26T17:37:56.751Z,1566841076.751 [NAL9602](INFO): SBD MO Status=2, MOMSN=8702, MT Status=2, MTMSN=0
2019-08-26T17:37:56.751Z,1566841076.751 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2