Version 66.12/CLOWNFISH Built: Feb 10 2017 08:46:29 Seaglider operating software developed by Applied Physics Laboratory, University of Washington(APL) Maintained by Kongsberg Maritime in conjunction with APL Copyright 2003-2016, University of Washington with serial and logger device sensor integration facilities developed by Integrative Observational Platforms Group, APL-UW _mtop = 0x2fefff, _mbot = 0x29c110, _mcur = 0x29d000 glmalloc_init: glmalloc_data_init = 0x0 glmalloc_init: avail_bytes = 364543, requested_bytes = 348160 glmalloc_init: Allocated 348160 bytes. 2.336,SSENSOR,N,reading cnf aa4831.cnf 2.444,SSENSOR,N,INFO: CNF doesn't specify cycles, assuming non-frequency device. 3.245,SSENSOR,N,reading cnf wlbbfl2.cnf 3.355,SSENSOR,N,INFO: CNF doesn't specify cycles, assuming non-frequency device. 3.696,SSENSOR,N,assigned SBE_CT to sensor slot 1 (p = 2 [index 0; port 2]) 3.884,SSENSOR,N,assigned WL_BBFL2 to sensor slot 2 (p = 51 [index 3; port 3]) 4.079,SSENSOR,N,assigned AA4831 to sensor slot 3 (p = 37 [index 2; port 5]) 4.496,SSENSOR,N,loading logger parms from loggers.cmd 4.608,SSENSOR,N,done loading logger parms 5.164,SPOWER,N,Iridium_during_init saved current=0.02984 5.333,SPOWER,N,Iridium_during_connect saved current=0.16000 5.506,SPOWER,N,Iridium_during_xfer saved current=0.22300 5.674,SPOWER,N,GPS saved current=0.01198 5.818,SPOWER,N,TT8 saved current=0.00972 5.963,SPOWER,N,TT8_Active saved current=0.00972 6.121,SPOWER,N,TT8_Sampling saved current=0.02994 6.280,SPOWER,N,TT8_CF8 saved current=0.03518 6.434,SPOWER,N,TT8_Kalman saved current=0.04717 6.593,SPOWER,N,Analog_circuits saved current=0.01500 6.760,SPOWER,N,Compass saved current=0.01723 6.916,SPOWER,N,SBE_CT saved current=0.02472 7.071,SPOWER,N,WL_BBFL2 saved current=0.05917 7.228,SPOWER,N,AA4831 saved current=0.02097 7.427,HCOMPASS,N,Active compass is SP3003 7.623,SSYS,N,Changing capture file 12.086,SUSR,N,Glider 604, mission 2, dive 13, boot #363, booted Thu Jan 1 00:00:12 1970 12.242,SUSR,N,Launched as: MAIN 13.359,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 15.471,HPRES,N,20 samples mean depth = -0.65m noise = 0.0275m (0.0700m threshold) 15.614,HPRES,N,enabled. 15.691,SSURF,N,Hit CR within 1 minute to start, otherwise will go to recovery ... Set current date and time for default [02/10/2017 08:46:29] 11/01/2017 16:35:00 Are you running on external (bench) power? [N] ------ Main Menu ------ 1 [param ] Parameters and configuration 2 [hw ] Hardware tests and monitoring 3 [modes ] Operation modes and files 4 [pdos ] PicoDOS commands (and exit) 5 [launch ] Pre-launch Enter selection (1-5,CR): 5 ------ Launch Menu ------ 1 [scene ] Set scenario mode 2 [selftest] Interactive self test 3 [autotest] Autonomous self test 4 [uploadst] Upload self-test results 5 [quick ] Quick test (nose-off) 6 [nosed ] Quick test (nose-on) 7 [test ] Test Launch! 8 [sea ] Sea Launch! CR) Return to previous Enter selection (1-8,CR): 7 Quick launch (skips some tests and calls)? [N] 17.462,SPOWER,N,All devices are off. Remove all old TT8 eng data and log files? [Y] n 20.616,SUSR,N,This is an AUTONOMOUS run. 20.713,SUSR,N,Please verify the phone numbers are correct. 20.830,SUSR,N,Current telnum is 88160000558 New telnum (15 char max length, CR to leave unchanged): 23.454,SUSR,N,Current altnum is 441631559013 New altnum (15 char max length, CR to leave unchanged): 25.215,HGPS,N,Obtaining GPS fix 25.337,HGPS,N,Acquiring GPS fix (0,0,20) 27.396,HGPS,N,VGPS: no data received 29.050,HGPS,N,VVVVVA -25.001,HGPS,N,sync sentence $GPRMC,163437,A,5627.1278,N,00526.4514,W,000.0,000.0,011117,004.1,W*7F (k=37945)set 2017/11/01 16:34:38 -25.492,SPOWER,N,Bogus seconds (-50.119373) for TT8_Sampling; ignored! -25.607,HGPS,N,011117 163436 5627.1284 -526.4522 hdop=1.3 cog=0.0 sog=0.0 hpe=162.5 n=5 8/8 seconds -20.017,HCF8,N,file 'sg0013dz.x00' opened... -20.175,HCF8,N,file 'sg0013dz.x00' has 241 bytes, closed... -20.878,HCF8,N,file 'sg0013lz.x00' opened... -19.058,HCF8,N,file 'sg0013lz.x00' has 1609 bytes, closed... -19.848,HCF8,N,file 'sg0012kz.x00' opened... -18.015,HCF8,N,file 'sg0012kz.x00' has 2184 bytes, closed... -18.849,HCF8,N,file 'sg0012lz.x00' opened... -18.972,HCF8,N,file 'sg0012lz.x00' has 1478 bytes, closed... -17.470,SSURF,N,Collecting glider state -17.765,HBATT,N,24V batt pack voltage = 15.16V -17.902,HBATT,N,10V batt pack voltage = 14.98V -16.162,SDIVE,N,Measuring depth & angle for 1 sec....compass filter disabled ok #-14.590,SDIVE,N, done. -14.721,SDIVE,N,Measured depth: -0.67m angle: -7.38deg -13.048,SUSR,N,Normal Heap: 0+20479 bytes -13.108,SGLMALLOC,N,glheap_walk: 344668 bytes free, 8 blocks free, 2700 bytes alloc, 25 blocks alloc -13.235,SSURF,N,Trying call 0... -13.279,SSURF,N,Calling phone number: 88160000558 -11.398,HPHONE,N,initializing RUDICS connection 14.814,HPHONE,N,Phone registered 16.431,HPHONE,N,Iridium signal strength: 5 after 5 queries 16.507,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 16.689,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.394188 Wed Nov 1 16:35:11 2017 27.205,HPHONE,N,Dialing succeeded 50.360,SSURF,N,Got another login: prompt [], restarting login sequence 64.196,SSURF,N,Logged in... 66.358,SSURF,N,Sending cmd lsx -k -t150 cmdfile 70.514,SSURF,N,Receiving cmdfile... 72.196,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 74.625,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 76.966,SSURF,N,EOT: 0x4 received (1), secSize= 128... 77.336,SSURF,N,Received cmdfile 217 bytes 79.118,SSURF,N,Transmission succeeded... 79.198,HTT8,N,Updating parameter $MISSION to 2 79.270,HTT8,N,Updating parameter $SIM_W to 0.1 79.341,HTT8,N,Updating parameter $SIM_PITCH to -20 79.411,HTT8,N,Updating parameter $D_TGT to 30 79.798,HTT8,N,Updating parameter $T_DIVE to 10 79.864,HTT8,N,Updating parameter $T_MISSION to 15 79.934,HTT8,N,Updating parameter $KALMAN_USE to 2 80.005,HTT8,N,Updating parameter $SM_CC to 150 80.071,HTT8,N,Updating parameter $MAX_BUOY to 5 80.135,HTT8,N,Updating parameter $USE_BATHY to 0 80.208,HTT8,N,Updating parameter $C_VBD to 3332 80.279,HTT8,N,Updating parameter $C_PITCH to 2700 80.351,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 80.427,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 80.503,HTT8,N,Updating parameter $T_RSLEEP to 1 80.565,SDIVE,N,Parsed command: $GO 80.704,HTT8,N,Writing NVRAM...done. 88.858,SUSR,N,$ID,604 88.892,SUSR,N,$MISSION,2 88.926,SUSR,N,$DIVE,0 88.963,SUSR,N,$N_DIVES,14 88.998,SUSR,N,$STOP_T,0 89.035,SUSR,N,$D_SURF,2 89.071,SUSR,N,$D_FLARE,3 89.108,SUSR,N,$D_TGT,30 89.147,SUSR,N,$D_ABORT,135 89.187,SUSR,N,$D_NO_BLEED,25 89.229,SUSR,N,$D_BOOST,3 89.264,SUSR,N,$T_BOOST,0 89.298,SUSR,N,$D_FINISH,0 89.334,SUSR,N,$D_PITCH,0 89.371,SUSR,N,$D_SAFE,100 89.407,SUSR,N,$D_CALL,0 89.440,SUSR,N,$SURFACE_URGENCY,0 89.484,SUSR,N,$SURFACE_URGENCY_TRY,0 89.532,SUSR,N,$SURFACE_URGENCY_FORCE,0 89.587,SUSR,N,$T_DIVE,10 89.625,SUSR,N,$T_MISSION,15 89.668,SUSR,N,$T_ABORT,720 89.708,SUSR,N,$T_TURN,500 89.747,SUSR,N,$T_TURN_SAMPINT,-5 89.796,SUSR,N,$T_NO_W,120 89.832,SUSR,N,$T_LOITER,0 89.868,SUSR,N,$T_EPIRB,0 89.902,SUSR,N,$USE_BATHY,0 89.941,SUSR,N,$USE_ICE,-1 89.982,SUSR,N,$ICE_FREEZE_MARGIN,0.30000001 90.042,SUSR,N,$D_OFFGRID,100 90.085,SUSR,N,$T_WATCHDOG,10 90.124,SUSR,N,$RELAUNCH,0 90.163,SUSR,N,$APOGEE_PITCH,-7 90.207,SUSR,N,$MAX_BUOY,5 90.243,SUSR,N,$COURSE_BIAS,0 90.285,SUSR,N,$GLIDE_SLOPE,30 90.328,SUSR,N,$SPEED_FACTOR,1 90.373,SUSR,N,$RHO,1.0276999 90.418,SUSR,N,$MASS,53665.398 90.459,SUSR,N,$MASS_COMP,0 90.495,SUSR,N,$NAV_MODE,0 90.535,SUSR,N,$FERRY_MAX,45 90.576,SUSR,N,$KALMAN_USE,2 90.619,SUSR,N,$HD_A,0.0038360001 90.668,SUSR,N,$HD_B,0.010078 90.713,SUSR,N,$HD_C,9.8500004e-06 90.761,SUSR,N,$HEADING,-1 90.800,SUSR,N,$ESCAPE_HEADING,60 90.847,SUSR,N,$ESCAPE_HEADING_DELTA,10 90.898,SUSR,N,$FIX_MISSING_TIMEOUT,0 91.267,SUSR,N,$TGT_DEFAULT_LAT,5627.5 91.323,SUSR,N,$TGT_DEFAULT_LON,-528 91.370,SUSR,N,$TGT_AUTO_DEFAULT,0 91.419,SUSR,N,$SM_CC,150 91.456,SUSR,N,$N_FILEKB,4 91.492,SUSR,N,$FILEMGR,0 91.529,SUSR,N,$CALL_NDIVES,1 91.568,SUSR,N,$COMM_SEQ,0 91.603,SUSR,N,$PROTOCOL,0 91.642,SUSR,N,$N_NOCOMM,1 91.677,SUSR,N,$NOCOMM_ACTION,0 91.719,SUSR,N,$N_NOSURFACE,0 91.760,SUSR,N,$UPLOAD_DIVES_MAX,-1 91.810,SUSR,N,$CALL_TRIES,5 91.851,SUSR,N,$CALL_WAIT,60 91.889,SUSR,N,$CAPUPLOAD,0 91.929,SUSR,N,$CAPMAXSIZE,100000 91.973,SUSR,N,$HEAPDBG,0 92.011,SUSR,N,$T_GPS,15 92.047,SUSR,N,$N_GPS,20 92.083,SUSR,N,$T_RSLEEP,1 92.119,SUSR,N,$STROBE,0 92.155,SUSR,N,$RAFOS_PEAK_OFFSET,1.5 92.207,SUSR,N,$RAFOS_CORR_THRESH,60 92.260,SUSR,N,$RAFOS_HIT_WINDOW,3600 92.314,SUSR,N,$PITCH_MIN,222 92.357,SUSR,N,$PITCH_MAX,3875 92.402,SUSR,N,$C_PITCH,2700 92.446,SUSR,N,$PITCH_DBAND,0.1 92.493,SUSR,N,$PITCH_CNV,0.003125763 92.547,SUSR,N,$P_OVSHOOT,0.039999999 92.602,SUSR,N,$P_OVSHOOT_WITHG,0.079999998 92.663,SUSR,N,$PITCH_GAIN,23 92.706,SUSR,N,$PITCH_TIMEOUT,18 92.752,SUSR,N,$PITCH_AD_RATE,145 92.799,SUSR,N,$PITCH_MAXERRORS,1 92.842,SUSR,N,$PITCH_ADJ_GAIN,0 92.885,SUSR,N,$PITCH_ADJ_DBAND,0 92.935,SUSR,N,$ROLL_MIN,257 92.977,SUSR,N,$ROLL_MAX,3875 93.019,SUSR,N,$ROLL_DEG,40 93.059,SUSR,N,$C_ROLL_DIVE,2000 93.105,SUSR,N,$C_ROLL_CLIMB,2000 93.153,SUSR,N,$HEAD_ERRBAND,15 93.200,SUSR,N,$ROLL_CNV,0.028270001 93.251,SUSR,N,$ROLL_TIMEOUT,15 93.298,SUSR,N,$R_PORT_OVSHOOT,34 93.348,SUSR,N,$R_STBD_OVSHOOT,38 93.395,SUSR,N,$ROLL_AD_RATE,350 93.441,SUSR,N,$ROLL_MAXERRORS,1 93.483,SUSR,N,$ROLL_ADJ_GAIN,0 93.525,SUSR,N,$ROLL_ADJ_DBAND,0 93.571,SUSR,N,$VBD_MIN,500 93.614,SUSR,N,$VBD_MAX,3957 93.657,SUSR,N,$C_VBD,3332 93.696,SUSR,N,$VBD_DBAND,2 93.738,SUSR,N,$VBD_CNV,-0.245296 93.782,SUSR,N,$VBD_LP_IGNORE,0 93.829,SUSR,N,$VBD_TIMEOUT,720 93.876,SUSR,N,$PITCH_VBD_SHIFT,0.0012300001 93.935,SUSR,N,$VBD_PUMP_AD_RATE_SURFACE,5 93.993,SUSR,N,$VBD_PUMP_AD_RATE_APOGEE,4 94.049,SUSR,N,$VBD_BLEED_AD_RATE,8 94.098,SUSR,N,$UNCOM_BLEED,60 94.141,SUSR,N,$VBD_MAXERRORS,1 94.183,SUSR,N,$W_ADJ_DBAND,0 94.543,SUSR,N,$DBDW,0 94.573,SUSR,N,$PITCH_W_GAIN,0 94.614,SUSR,N,$PITCH_W_DBAND,0 94.659,SUSR,N,$CF8_MAXERRORS,20 94.707,SUSR,N,$AH0_24V,310 94.743,SUSR,N,$AH0_10V,0 94.784,SUSR,N,$MINV_24V,11.5 94.828,SUSR,N,$MINV_10V,11.5 94.873,SUSR,N,$MAXI_24V,0.80000001 94.924,SUSR,N,$MAXI_10V,0.60000002 94.971,SUSR,N,$FG_AHR_10V,0 95.008,SUSR,N,$FG_AHR_24V,0 95.049,SUSR,N,$PHONE_SUPPLY,2 95.095,SUSR,N,$PRESSURE_YINT,-29.700203 95.153,SUSR,N,$PRESSURE_SLOPE,0.000116345 95.213,SUSR,N,$AD7714Ch0Gain,128 95.257,SUSR,N,$TCM_PITCH_OFFSET,0 95.302,SUSR,N,$TCM_ROLL_OFFSET,0 95.345,SUSR,N,$COMPASS_USE,0 95.385,SUSR,N,$ALTIM_BOTTOM_PING_RANGE,0 95.438,SUSR,N,$ALTIM_TOP_PING_RANGE,0 95.491,SUSR,N,$ALTIM_BOTTOM_TURN_MARGIN,10 95.546,SUSR,N,$ALTIM_TOP_TURN_MARGIN,0 95.600,SUSR,N,$ALTIM_TOP_MIN_OBSTACLE,1 95.657,SUSR,N,$ALTIM_PING_DEPTH,22 95.706,SUSR,N,$ALTIM_PING_DELTA,2 95.757,SUSR,N,$ALTIM_FREQUENCY,13 95.805,SUSR,N,$ALTIM_PULSE,7 95.847,SUSR,N,$ALTIM_SENSITIVITY,2 95.896,SUSR,N,$XPDR_VALID,3 95.937,SUSR,N,$XPDR_INHIBIT,90 95.984,SUSR,N,$INT_PRESSURE_SLOPE,0.0097660003 96.049,SUSR,N,$INT_PRESSURE_YINT,1.26 96.099,SUSR,N,$DEEPGLIDER,0 96.140,SUSR,N,$MOTHERBOARD,4 96.182,SUSR,N,$DEVICE1,2 96.222,SUSR,N,$DEVICE2,51 96.263,SUSR,N,$DEVICE3,37 96.301,SUSR,N,$DEVICE4,-1 96.340,SUSR,N,$DEVICE5,-1 96.378,SUSR,N,$DEVICE6,-1 96.416,SUSR,N,$LOGGERS,1 96.453,SUSR,N,$LOGGERDEVICE1,-1 96.499,SUSR,N,$LOGGERDEVICE2,-1 96.544,SUSR,N,$LOGGERDEVICE3,-1 96.589,SUSR,N,$LOGGERDEVICE4,-1 96.636,SUSR,N,$COMPASS_DEVICE,17 96.682,SUSR,N,$COMPASS2_DEVICE,-1 96.732,SUSR,N,$PHONE_DEVICE,48 96.779,SUSR,N,$GPS_DEVICE,32 96.821,SUSR,N,$RAFOS_DEVICE,-1 96.868,SUSR,N,$XPDR_DEVICE,24 96.913,SUSR,N,$SIM_W,0.1 96.951,SUSR,N,$SIM_PITCH,-20 96.996,SUSR,N,$SEABIRD_T_G,0.0044098105 97.054,SUSR,N,$SEABIRD_T_H,0.00064510072 97.113,SUSR,N,$SEABIRD_T_I,2.6190437e-05 97.172,SUSR,N,$SEABIRD_T_J,3.2100886e-06 97.230,SUSR,N,$SEABIRD_C_G,-9.7047873 97.285,SUSR,N,$SEABIRD_C_H,1.1225765 97.339,SUSR,N,$SEABIRD_C_I,-0.00085018261 97.399,SUSR,N,$SEABIRD_C_J,0.00014670726 100.286,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 10.0 meters. 100.717,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 10.0 meters. 100.828,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 100.941,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 101.085,SSURF,N,Sending cmd lrx -y -c -t150 sg0013lz.x00 103.345,SSURF,N,Sending sg0013lz.x00... 103.436,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 107.919,SSURF,N,block: 2, size: 585, blkSize: 1024, attempt: 1... 112.326,SSURF,N,EOT sent ... 114.920,SSURF,N,received ACK (attempt 0) 117.444,SSURF,N,Transmission succeeded... 117.543,SSURF,N,Sending cmd lrx -y -c -t150 sg0012lz.x00 119.716,SSURF,N,Sending sg0012lz.x00... 119.804,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 124.280,SSURF,N,block: 2, size: 454, blkSize: 1024, attempt: 1... 133.099,SSURF,N,EOT sent ... 135.709,SSURF,N,received ACK (attempt 0) 143.524,HPHONE,N,No prompt after send complete echo [] 143.594,SSURF,N,Transmission succeeded... 143.692,SSURF,N,Sending cmd lrx -y -c -t150 sg0013dz.x00 158.784,HPHONE,N,basestation not ready to receive [] 158.860,SSURF,N,Problems transferring files (send=1/rcv=0)... 168.972,SSURF,N,logout... 182.040,SSURF,N,Total NAK's: 0, timeouts: 0 182.096,SSURF,N,going to sleep.. Type tt8: 201.281,SGLMALLOC,N,glheap_walk: 344252 bytes free, 8 blocks free, 2876 bytes alloc, 35 blocks alloc 201.408,SSURF,N,Trying call 1... 201.452,SSURF,N,Calling phone number: 88160000558 203.571,HPHONE,N,initializing RUDICS connection 228.999,HPHONE,N,Phone registered 233.060,HPHONE,N,Iridium signal strength: 5 after 5 queries 233.136,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 233.320,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 16:38:46 2017 252.269,HPHONE,N,Dialing succeeded 285.077,SSURF,N,No shell prompt after password [] 285.148,SSURF,N,Unable to login (-5)... 285.201,SSURF,N,Missing '= ' as basestation prompt! 289.414,SSURF,N,Total NAK's: 0, timeouts: 0 289.470,SSURF,N,going to sleep.. Type tt8: 296.942,SGLMALLOC,N,glheap_walk: 344228 bytes free, 9 blocks free, 2876 bytes alloc, 35 blocks alloc 297.368,SSURF,N,Trying call 2... 297.412,SSURF,N,Calling phone number: 88160000558 299.529,HPHONE,N,initializing RUDICS connection 330.522,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 330.632,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 330.816,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 16:39:12 2017 331.052,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 336.159,SSURF,N,Unable to login (-2)... 338.218,SSURF,N,Total NAK's: 0, timeouts: 0 338.274,SSURF,N,going to sleep.. Type tt8: 341.417,SGLMALLOC,N,glheap_walk: 344228 bytes free, 9 blocks free, 2876 bytes alloc, 35 blocks alloc 341.543,SSURF,N,Trying call 3... 341.587,SSURF,N,Calling phone number: 88160000558 343.704,HPHONE,N,initializing RUDICS connection 374.111,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 374.222,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 374.406,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 16:39:12 2017 402.054,HPHONE,N,Dialing succeeded 432.328,SSURF,N,Logged in... 434.625,SSURF,N,Sending cmd lsx -k -t150 cmdfile 438.776,SSURF,N,Receiving cmdfile... 444.404,SSURF,N,SOH/STX: 0x1 received (68), secSize= 128... 446.504,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 449.023,SSURF,N,EOT: 0x4 received (1), secSize= 128... 449.381,SSURF,N,Received cmdfile 217 bytes 459.466,SSURF,N,Transmission succeeded... 459.548,HTT8,N,Updating parameter $MISSION to 2 459.621,HTT8,N,Updating parameter $SIM_W to 0.1 459.693,HTT8,N,Updating parameter $SIM_PITCH to -20 459.764,HTT8,N,Updating parameter $D_TGT to 30 459.830,HTT8,N,Updating parameter $T_DIVE to 10 459.898,HTT8,N,Updating parameter $T_MISSION to 15 459.969,HTT8,N,Updating parameter $KALMAN_USE to 2 460.040,HTT8,N,Updating parameter $SM_CC to 150 460.107,HTT8,N,Updating parameter $MAX_BUOY to 5 460.173,HTT8,N,Updating parameter $USE_BATHY to 0 460.247,HTT8,N,Updating parameter $C_VBD to 3332 460.639,HTT8,N,Updating parameter $C_PITCH to 2700 460.713,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 460.790,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 460.868,HTT8,N,Updating parameter $T_RSLEEP to 1 460.930,SDIVE,N,Parsed command: $GO 461.071,HTT8,N,Writing NVRAM...done. 469.227,SUSR,N,$ID,604 469.262,SUSR,N,$MISSION,2 469.298,SUSR,N,$DIVE,0 469.336,SUSR,N,$N_DIVES,14 469.373,SUSR,N,$STOP_T,0 469.410,SUSR,N,$D_SURF,2 469.447,SUSR,N,$D_FLARE,3 469.486,SUSR,N,$D_TGT,30 469.526,SUSR,N,$D_ABORT,135 469.567,SUSR,N,$D_NO_BLEED,25 469.610,SUSR,N,$D_BOOST,3 469.646,SUSR,N,$T_BOOST,0 469.681,SUSR,N,$D_FINISH,0 469.718,SUSR,N,$D_PITCH,0 469.757,SUSR,N,$D_SAFE,100 469.794,SUSR,N,$D_CALL,0 469.828,SUSR,N,$SURFACE_URGENCY,0 469.873,SUSR,N,$SURFACE_URGENCY_TRY,0 469.923,SUSR,N,$SURFACE_URGENCY_FORCE,0 469.978,SUSR,N,$T_DIVE,10 470.018,SUSR,N,$T_MISSION,15 470.062,SUSR,N,$T_ABORT,720 470.104,SUSR,N,$T_TURN,500 470.143,SUSR,N,$T_TURN_SAMPINT,-5 470.194,SUSR,N,$T_NO_W,120 470.231,SUSR,N,$T_LOITER,0 470.268,SUSR,N,$T_EPIRB,0 470.303,SUSR,N,$USE_BATHY,0 470.344,SUSR,N,$USE_ICE,-1 470.386,SUSR,N,$ICE_FREEZE_MARGIN,0.30000001 470.447,SUSR,N,$D_OFFGRID,100 470.491,SUSR,N,$T_WATCHDOG,10 470.531,SUSR,N,$RELAUNCH,0 470.571,SUSR,N,$APOGEE_PITCH,-7 470.617,SUSR,N,$MAX_BUOY,5 470.654,SUSR,N,$COURSE_BIAS,0 470.697,SUSR,N,$GLIDE_SLOPE,30 470.741,SUSR,N,$SPEED_FACTOR,1 470.788,SUSR,N,$RHO,1.0276999 470.834,SUSR,N,$MASS,53665.398 470.875,SUSR,N,$MASS_COMP,0 470.913,SUSR,N,$NAV_MODE,0 470.954,SUSR,N,$FERRY_MAX,45 470.996,SUSR,N,$KALMAN_USE,2 471.040,SUSR,N,$HD_A,0.0038360001 471.091,SUSR,N,$HD_B,0.010078 471.137,SUSR,N,$HD_C,9.8500004e-06 471.186,SUSR,N,$HEADING,-1 471.226,SUSR,N,$ESCAPE_HEADING,60 471.274,SUSR,N,$ESCAPE_HEADING_DELTA,10 471.326,SUSR,N,$FIX_MISSING_TIMEOUT,0 471.382,SUSR,N,$TGT_DEFAULT_LAT,5627.5 471.438,SUSR,N,$TGT_DEFAULT_LON,-528 471.487,SUSR,N,$TGT_AUTO_DEFAULT,0 471.536,SUSR,N,$SM_CC,150 471.575,SUSR,N,$N_FILEKB,4 471.612,SUSR,N,$FILEMGR,0 471.650,SUSR,N,$CALL_NDIVES,1 471.690,SUSR,N,$COMM_SEQ,0 471.727,SUSR,N,$PROTOCOL,0 472.148,SUSR,N,$N_NOCOMM,1 472.185,SUSR,N,$NOCOMM_ACTION,0 472.227,SUSR,N,$N_NOSURFACE,0 472.270,SUSR,N,$UPLOAD_DIVES_MAX,-1 472.321,SUSR,N,$CALL_TRIES,5 472.363,SUSR,N,$CALL_WAIT,60 472.402,SUSR,N,$CAPUPLOAD,0 472.444,SUSR,N,$CAPMAXSIZE,100000 472.489,SUSR,N,$HEAPDBG,0 472.528,SUSR,N,$T_GPS,15 472.566,SUSR,N,$N_GPS,20 472.603,SUSR,N,$T_RSLEEP,1 472.640,SUSR,N,$STROBE,0 472.677,SUSR,N,$RAFOS_PEAK_OFFSET,1.5 472.730,SUSR,N,$RAFOS_CORR_THRESH,60 472.784,SUSR,N,$RAFOS_HIT_WINDOW,3600 472.839,SUSR,N,$PITCH_MIN,222 472.883,SUSR,N,$PITCH_MAX,3875 472.930,SUSR,N,$C_PITCH,2700 472.975,SUSR,N,$PITCH_DBAND,0.1 473.023,SUSR,N,$PITCH_CNV,0.003125763 473.079,SUSR,N,$P_OVSHOOT,0.039999999 473.134,SUSR,N,$P_OVSHOOT_WITHG,0.079999998 473.197,SUSR,N,$PITCH_GAIN,23 473.241,SUSR,N,$PITCH_TIMEOUT,18 473.288,SUSR,N,$PITCH_AD_RATE,145 473.336,SUSR,N,$PITCH_MAXERRORS,1 473.381,SUSR,N,$PITCH_ADJ_GAIN,0 473.425,SUSR,N,$PITCH_ADJ_DBAND,0 473.476,SUSR,N,$ROLL_MIN,257 473.519,SUSR,N,$ROLL_MAX,3875 473.563,SUSR,N,$ROLL_DEG,40 473.604,SUSR,N,$C_ROLL_DIVE,2000 473.651,SUSR,N,$C_ROLL_CLIMB,2000 473.700,SUSR,N,$HEAD_ERRBAND,15 473.748,SUSR,N,$ROLL_CNV,0.028270001 473.800,SUSR,N,$ROLL_TIMEOUT,15 473.848,SUSR,N,$R_PORT_OVSHOOT,34 473.899,SUSR,N,$R_STBD_OVSHOOT,38 473.948,SUSR,N,$ROLL_AD_RATE,350 473.994,SUSR,N,$ROLL_MAXERRORS,1 474.038,SUSR,N,$ROLL_ADJ_GAIN,0 474.081,SUSR,N,$ROLL_ADJ_DBAND,0 474.128,SUSR,N,$VBD_MIN,500 474.172,SUSR,N,$VBD_MAX,3957 474.217,SUSR,N,$C_VBD,3332 474.256,SUSR,N,$VBD_DBAND,2 474.300,SUSR,N,$VBD_CNV,-0.245296 474.345,SUSR,N,$VBD_LP_IGNORE,0 474.393,SUSR,N,$VBD_TIMEOUT,720 474.441,SUSR,N,$PITCH_VBD_SHIFT,0.0012300001 474.502,SUSR,N,$VBD_PUMP_AD_RATE_SURFACE,5 474.560,SUSR,N,$VBD_PUMP_AD_RATE_APOGEE,4 474.618,SUSR,N,$VBD_BLEED_AD_RATE,8 474.668,SUSR,N,$UNCOM_BLEED,60 474.713,SUSR,N,$VBD_MAXERRORS,1 474.755,SUSR,N,$W_ADJ_DBAND,0 474.795,SUSR,N,$DBDW,0 474.828,SUSR,N,$PITCH_W_GAIN,0 474.869,SUSR,N,$PITCH_W_DBAND,0 474.915,SUSR,N,$CF8_MAXERRORS,20 474.964,SUSR,N,$AH0_24V,310 475.002,SUSR,N,$AH0_10V,0 475.044,SUSR,N,$MINV_24V,11.5 475.388,SUSR,N,$MINV_10V,11.5 475.433,SUSR,N,$MAXI_24V,0.80000001 475.486,SUSR,N,$MAXI_10V,0.60000002 475.533,SUSR,N,$FG_AHR_10V,0 475.572,SUSR,N,$FG_AHR_24V,0 475.615,SUSR,N,$PHONE_SUPPLY,2 475.661,SUSR,N,$PRESSURE_YINT,-29.700203 475.720,SUSR,N,$PRESSURE_SLOPE,0.000116345 475.781,SUSR,N,$AD7714Ch0Gain,128 475.826,SUSR,N,$TCM_PITCH_OFFSET,0 475.873,SUSR,N,$TCM_ROLL_OFFSET,0 475.918,SUSR,N,$COMPASS_USE,0 475.958,SUSR,N,$ALTIM_BOTTOM_PING_RANGE,0 476.013,SUSR,N,$ALTIM_TOP_PING_RANGE,0 476.067,SUSR,N,$ALTIM_BOTTOM_TURN_MARGIN,10 476.124,SUSR,N,$ALTIM_TOP_TURN_MARGIN,0 476.178,SUSR,N,$ALTIM_TOP_MIN_OBSTACLE,1 476.237,SUSR,N,$ALTIM_PING_DEPTH,22 476.287,SUSR,N,$ALTIM_PING_DELTA,2 476.339,SUSR,N,$ALTIM_FREQUENCY,13 476.388,SUSR,N,$ALTIM_PULSE,7 476.431,SUSR,N,$ALTIM_SENSITIVITY,2 476.481,SUSR,N,$XPDR_VALID,3 476.524,SUSR,N,$XPDR_INHIBIT,90 476.572,SUSR,N,$INT_PRESSURE_SLOPE,0.0097660003 476.639,SUSR,N,$INT_PRESSURE_YINT,1.26 476.689,SUSR,N,$DEEPGLIDER,0 476.731,SUSR,N,$MOTHERBOARD,4 476.775,SUSR,N,$DEVICE1,2 476.816,SUSR,N,$DEVICE2,51 476.858,SUSR,N,$DEVICE3,37 476.898,SUSR,N,$DEVICE4,-1 476.937,SUSR,N,$DEVICE5,-1 476.976,SUSR,N,$DEVICE6,-1 477.016,SUSR,N,$LOGGERS,1 477.054,SUSR,N,$LOGGERDEVICE1,-1 477.101,SUSR,N,$LOGGERDEVICE2,-1 477.147,SUSR,N,$LOGGERDEVICE3,-1 477.194,SUSR,N,$LOGGERDEVICE4,-1 477.241,SUSR,N,$COMPASS_DEVICE,17 477.289,SUSR,N,$COMPASS2_DEVICE,-1 477.340,SUSR,N,$PHONE_DEVICE,48 477.388,SUSR,N,$GPS_DEVICE,32 477.431,SUSR,N,$RAFOS_DEVICE,-1 477.479,SUSR,N,$XPDR_DEVICE,24 477.526,SUSR,N,$SIM_W,0.1 477.565,SUSR,N,$SIM_PITCH,-20 477.611,SUSR,N,$SEABIRD_T_G,0.0044098105 477.670,SUSR,N,$SEABIRD_T_H,0.00064510072 477.730,SUSR,N,$SEABIRD_T_I,2.6190437e-05 477.790,SUSR,N,$SEABIRD_T_J,3.2100886e-06 477.850,SUSR,N,$SEABIRD_C_G,-9.7047873 477.906,SUSR,N,$SEABIRD_C_H,1.1225765 477.961,SUSR,N,$SEABIRD_C_I,-0.00085018261 478.022,SUSR,N,$SEABIRD_C_J,0.00014670726 480.912,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 10.0 meters. 481.022,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 10.0 meters. 481.455,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 481.568,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 481.710,SSURF,N,Sending cmd lrx -y -c -t150 sg0013dz.x00 484.043,SSURF,N,Sending sg0013dz.x00... 484.125,SSURF,N,block: 1, size: 241, blkSize: 1024, attempt: 1... 488.695,SSURF,N,EOT sent ... 491.486,SSURF,N,received ACK (attempt 0) 494.100,SSURF,N,Transmission succeeded... 494.200,SSURF,N,Sending cmd lrx -y -c -t150 sg0012kz.x00 496.552,SSURF,N,Sending sg0012kz.x00... 496.646,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 501.297,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 505.887,SSURF,N,block: 3, size: 136, blkSize: 1024, attempt: 1... 510.566,SSURF,N,EOT sent ... 515.786,SSURF,N,received ACK (attempt 0) 518.400,SSURF,N,Transmission succeeded... Compressing THISDIVE.KAP to sg0000kl.x... 521.123,SSURF,N,Sending cmd lrx -y -c -t150 sg0000kl.x 535.602,SSURF,N,Sending sg0000kl.x... 535.724,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 539.447,SSURF,N,block: 1, size: 128, blkSize: 128, attempt: 2... 544.307,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 550.698,SSURF,N,block: 3, size: 1024, blkSize: 1024, attempt: 1... 555.288,SSURF,N,block: 4, size: 1024, blkSize: 1024, attempt: 1... 564.737,SSURF,N,block: 5, size: 1024, blkSize: 1024, attempt: 1... 565.817,SSURF,N,block: 5, size: 128, blkSize: 128, attempt: 2... 569.327,SSURF,N,block: 6, size: 1024, blkSize: 1024, attempt: 1... 570.767,SSURF,N,block: 6, size: 128, blkSize: 128, attempt: 2... 575.357,SSURF,N,block: 7, size: 1024, blkSize: 1024, attempt: 1... 582.205,SSURF,N,block: 8, size: 1024, blkSize: 1024, attempt: 1... 588.685,SSURF,N,block: 9, size: 1024, blkSize: 1024, attempt: 1... 593.096,SSURF,N,block: 10, size: 1024, blkSize: 1024, attempt: 1... 597.506,SSURF,N,block: 11, size: 497, blkSize: 1024, attempt: 1... 603.084,SSURF,N,EOT sent ... 605.694,SSURF,N,received ACK (attempt 0) 608.129,SSURF,N,Transmission succeeded... 610.831,SSURF,N,logout... 623.895,SSURF,N,Total NAK's: 3, timeouts: 0 624.036,SGLMALLOC,N,glheap_walk: 344260 bytes free, 13 blocks free, 2796 bytes alloc, 33 blocks alloc 627.659,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 10.0 meters. 627.849,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 10.0 meters. 628.060,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 628.255,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 629.769,SUSR,N, Setting glider to pre-launch state ... 629.988,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 630.982,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=14.9 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 631.605,SMOTOR,N,GC TICKS/TIME: 31/33249 631.692,HROLL,N,done. 631.759,HROLL,N,Roll: No motion occurred. 632.012,HPITCH,N,Pitch commanded from -7.79 cm (209) to -7.75 cm (222)... 632.894,HPITCH,N,-7.8 cm (ad: 209) mA=0 minV=14.9 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 14.9V 633.500,SMOTOR,N,GC TICKS/TIME: 30/32687 633.587,HPITCH,N,done. 633.656,HPITCH,N,Pitch: No motion occurred. 633.902,HVBD,N,Bleed commanded from 152.57 cc (2710) to 150.12 cc (2720)... 634.809,HVBD,N,150.1 cc (ad: 2720 [2781,2659]) mA=197 minV=14.8 (0,0)MOTOR_DONE: ticks: 15 max 24v: 2038.7mA avg 24v: 140.0mA minV 24v: 14.8V 635.569,SMOTOR,N,GC TICKS/TIME: 35/38347 635.656,HVBD,N,done. 635.815,HVBD,N,Bleed completed from 152.57 cc (2710) to 150.12 cc (2720 [2782, 2659]) took 0.4 sec 0 mA (1906 mA peak) 14.8 Vmin 23.53 AD/sec 17 ticks 636.255,HVBD,N,TRACK: b: 2782/2658 a: 2783/2658 d: -63 o: -63 636.382,SUSR,N,query timeout lengthened, you have one hour to respond Has the pilot given the OK to launch (no cancels launch, yes proceeds)? [N] y 640.779,SUSR,N,For a fresh start, reset the dive number to 1 Reset dive/run number to: [0] 1 643.549,HTT8,N,Updating parameter $DIVE to 1 643.868,HTT8,N,Writing NVRAM...done. 652.676,SSURF,N,Initializing data file 652.860,SSURF,N,Initializing log file 654.629,SUSR,N, Now wait for the phone call and confirm that QUIT is parsed and RECOVERY is entered before disconnecting comms cable and placing the glider in the water. If possible, confirm positive buoyancy and surface position before releasing. 0.632,SSYS,N,Dive started Wed Nov 1 16:45:59 2017 (1509554759) 0.875,SSYS,N,GPCTD attached: No 0.953,SSURF,N,Entering surface state 1.042,SSURF,N,Starting surface maneuver... 1.360,SSURF,N,disabling surface maneuver aborts 2.584,SSURF,N,d= -0.62m 2.759,HROLL,N,Roll commanded from -0.65 deg (1977) to 0.00 deg (2000)... 3.631,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=14.9 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 4.240,SMOTOR,N,GC TICKS/TIME: 30/32643 4.324,HROLL,N,done. 4.388,HROLL,N,Roll: No motion occurred. 4.639,HPITCH,N,Pitch commanded from -7.79 cm (209) to -7.75 cm (222)... 5.515,HPITCH,N,-7.8 cm (ad: 209) mA=0 minV=14.9 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 14.9V 6.123,SMOTOR,N,GC TICKS/TIME: 30/32733 6.208,HPITCH,N,done. 6.273,HPITCH,N,Pitch: No motion occurred. 6.373,SSURF,N,Waiting 60 seconds for oscillations to dampen... 67.673,SSURF,N,Depth at end of surface maneuver = -0.520975 69.137,SSURF,N,Finished surface maneuver... 70.001,HGPS,N,Acquiring GPS fix (0,0,20) 72.059,HGPS,N,VGPS: no data received 73.711,HGPS,N,VVVVVVVVVVVVVVA 89.002,HGPS,N,sync sentence $GPRMC,164727,A,5627.1010,N,00526.4009,W,000.0,000.0,011117,004.1,W*7F (k=8539)set 2017/11/01 16:47:28 89.192,HGPS,N,011117 164726 5627.0972 -526.3969 hdop=1.5 cog=0.0 sog=0.0 hpe=86.2 n=4 17/17 seconds 92.964,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0000kz.a... 94.252,SSYS,N,Capture file opened Compressing THISDIVE.LOG to sg0000lz.x... 96.907,HCF8,N,file 'sg0000lz.x00' opened... 97.057,HCF8,N,file 'sg0000lz.x00' has 1478 bytes, closed... 97.544,SSURF,N,Collecting glider state 97.842,HBATT,N,24V batt pack voltage = 14.90V 97.976,HBATT,N,10V batt pack voltage = 14.73V 98.233,SDIVE,N,Measuring depth & angle for 1 sec....# done. 100.545,SDIVE,N,Measured depth: -0.63m angle: -7.29deg 100.880,SGLMALLOC,N,glheap_walk: 344132 bytes free, 10 blocks free, 2948 bytes alloc, 35 blocks alloc 101.007,SSURF,N,Trying call 0... 101.051,SSURF,N,Calling phone number: 88160000558 103.170,HPHONE,N,initializing RUDICS connection 133.571,HPHONE,N,Phone registered 137.007,HPHONE,N,Iridium signal strength: 0 after 6 queries 137.084,HPHONE,N,cnt_NoComm:0 callCycle:1 smsLastCallCycle:-1 137.267,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.452622 Wed Nov 1 16:48:05 2017 160.742,HPHONE,N,Dialing succeeded 186.530,SSURF,N,Sent login id, no password: prompt detected [^@] 186.619,SSURF,N,Unable to login (-4)... 188.677,SSURF,N,Total NAK's: 0, timeouts: 0 188.734,SSURF,N,going to sleep.. Type tt8: 192.466,SGLMALLOC,N,glheap_walk: 344108 bytes free, 11 blocks free, 2948 bytes alloc, 35 blocks alloc 192.593,SSURF,N,Trying call 1... 192.637,SSURF,N,Calling phone number: 88160000558 194.754,HPHONE,N,initializing RUDICS connection 225.172,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 225.282,HPHONE,N,cnt_NoComm:0 callCycle:1 smsLastCallCycle:-1 225.466,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.452622 Wed Nov 1 16:48:27 2017 244.490,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 249.598,SSURF,N,Unable to login (-2)... 251.656,SSURF,N,Total NAK's: 0, timeouts: 0 251.713,SSURF,N,going to sleep.. Type tt8: 254.910,SGLMALLOC,N,glheap_walk: 344108 bytes free, 11 blocks free, 2948 bytes alloc, 35 blocks alloc 255.038,SSURF,N,Trying call 2... 255.082,SSURF,N,Calling phone number: 88160000558 257.397,HPHONE,N,initializing RUDICS connection 287.801,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 287.912,HPHONE,N,cnt_NoComm:0 callCycle:1 smsLastCallCycle:-1 288.096,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.458788 Wed Nov 1 16:50:36 2017 325.801,HPHONE,N,Dialing succeeded 349.048,SSURF,N,Got another login: prompt [], restarting login sequence 369.147,SSURF,N,Sent login id, no password: prompt detected [] 369.234,SSURF,N,Unable to login (-4)... 369.286,SSURF,N,Missing '= ' as basestation prompt! 373.491,SSURF,N,Total NAK's: 0, timeouts: 0 373.547,SSURF,N,going to sleep.. 433.370,SGLMALLOC,N,glheap_walk: 344108 bytes free, 11 blocks free, 2948 bytes alloc, 35 blocks alloc 433.498,SSURF,N,Trying call 3... 433.542,SSURF,N,Calling phone number: 88160000558 435.658,HPHONE,N,initializing RUDICS connection 461.017,HPHONE,N,Phone registered 464.065,HPHONE,N,Iridium signal strength: 4 after 5 queries 464.142,HPHONE,N,cnt_NoComm:0 callCycle:1 smsLastCallCycle:-1 464.325,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.329574 Wed Nov 1 16:53:32 2017 472.818,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 477.925,SSURF,N,Unable to login (-2)... 479.984,SSURF,N,Total NAK's: 0, timeouts: 0 480.040,SSURF,N,going to sleep.. 540.371,SGLMALLOC,N,glheap_walk: 344108 bytes free, 11 blocks free, 2948 bytes alloc, 35 blocks alloc 540.499,SSURF,N,Trying call 4... 540.543,SSURF,N,Calling phone number: 88160000558 542.659,HPHONE,N,initializing RUDICS connection 573.083,HPHONE,N,Phone registered 574.044,HPHONE,N,Iridium signal strength: 0 after 6 queries 574.120,HPHONE,N,cnt_NoComm:0 callCycle:1 smsLastCallCycle:-1 574.304,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 16:55:20 2017 593.146,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 598.254,SSURF,N,Unable to login (-2)... 600.312,SSURF,N,Total NAK's: 0, timeouts: 0 600.376,HTT8,N,Updating parameter $SM_CC to 694.67828 600.661,HTT8,N,Writing NVRAM...done. 608.818,SSURF,N,N_NOCOMM reached; will pump to 694.68 CC... 608.978,SGLMALLOC,N,glheap_walk: 344236 bytes free, 13 blocks free, 2820 bytes alloc, 33 blocks alloc 609.284,HTT8,N,Updating parameter $MISSION to 2 609.483,HTT8,N,Updating parameter $SIM_W to 0.1 609.668,HTT8,N,Updating parameter $SIM_PITCH to -20 609.818,HTT8,N,Updating parameter $D_TGT to 30 609.966,HTT8,N,Updating parameter $T_DIVE to 10 610.118,HTT8,N,Updating parameter $T_MISSION to 15 610.274,HTT8,N,Updating parameter $KALMAN_USE to 2 610.436,HTT8,N,Updating parameter $SM_CC to 150 610.584,HTT8,N,Updating parameter $MAX_BUOY to 5 610.707,HTT8,N,Updating parameter $USE_BATHY to 0 610.898,HTT8,N,Updating parameter $C_VBD to 3332 611.081,HTT8,N,Updating parameter $C_PITCH to 2700 611.254,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 611.431,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 611.598,HTT8,N,Updating parameter $T_RSLEEP to 1 611.702,SDIVE,N,Parsed command: $GO 611.791,SDIVE,N,No recovery errors reported. Going to Dive. 612.313,HTT8,N,Writing NVRAM...done. 621.136,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 638.337,SDIVE,N,Measured depth: -0.62m angle: -7.37deg 638.489,HGPS,N,Acquiring GPS fix (0,0,20) 640.549,HGPS,N,VGPS: no data received 642.211,HGPS,N,VVVVVA 647.001,HGPS,N,sync sentence $GPRMC,165645,A,5627.1368,N,00526.4404,W,000.0,000.0,011117,004.1,W*7E (k=44858)set 2017/11/01 16:56:46 647.196,HGPS,N,011117 165644 5627.1406 -526.4435 hdop=1.3 cog=0.0 sog=0.0 hpe=137.1 n=5 8/8 seconds 651.038,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571708.00 meters 651.234,SDIVE,N,Grid depth = 30.0, target depth = 30.0 651.389,SDIVE,N,wDesired = -0.100 652.046,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 681.185,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 681.431,SDIVE,N,speed limits = 0.17, 0.18 681.718,SDIVE,N,DesiredHead = 291.61, range = 571708.0, glide angle -28.63 682.606,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 683.694,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 684.317,SMOTOR,N,GC TICKS/TIME: 31/33247 684.404,HROLL,N,done. 684.471,HROLL,N,Roll: No motion occurred. 684.679,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.854,SSURF,N,Dive 0 started Wed Nov 1 16:57:23 2017 (1509555443) 1.076,SUSR,N,Normal Heap: 0+20479 bytes 1.227,SGLMALLOC,N,glheap_walk: 344236 bytes free, 13 blocks free, 2820 bytes alloc, 33 blocks alloc 1.524,HTT8,N,Updating parameter $DIVE to 1 1.841,HTT8,N,Writing NVRAM...done. 10.618,SSURF,N,Initializing data file 10.823,SSURF,N,Initializing log file 13.845,SSURF,N,Starting dive at 13s 13.929,SSURF,N,Leaving surface state 14.032,SDIVE,N,Entering dive state 15.580,SDIVE,N,start $GC,15,-1.15,-4.9,209,1977,2782,2659,0.0,0.0,0, ... 39.517,SSENSOR,N,A 37273ms 3.69m 289.0 #1 42.549,SMOTOR,N,MOTOR_DONE: ticks: 143 max 24v: 2028.8mA avg 24v: 16.8mA minV 24v: 14.9V 42.708,SMOTOR,N,GC TICKS/TIME: 1058/1062901 42.905,HVBD,N,Bleed completed from 150.12 cc (2720) to -5.40 cc (3354 [3441, 3267]) took 22.8 sec 0 mA (1911 mA peak) 14.9 Vmin 27.81 AD/sec 912 ticks 43.352,HVBD,N,TRACK: b: 3435/3267 a: 3434/3270 d: -83 o: -80 43.695,SDIVE,N,end $GC ,43,0.00,0.00,-22.80,0.000,16390,0.000,0.000,209,1977,3354,3441,3267,0,0,0,0,0,0,15.00,13.79,14.93 44.045,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 45.154,SDIVE,N,start $GC,45,-1.15,-4.9,209,1977,3441,3267,3.7,0.0,1, ... 51.890,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 52.383,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 14.9V 52.533,SMOTOR,N,GC TICKS/TIME: 270/273780 52.714,HPITCH,N,Pitch completed from -7.79 cm (209) to -1.17 cm (2326) took 6.4 sec 125 mA (360 mA peak) 14.6 Vmin 328.22 AD/sec 258 ticks 53.156,HPITCH,N,TRACK: b: 2314/0 a: 2317/0 d: 0 o: 9 53.513,SDIVE,N,end $GC ,53,6.45,0.00,0.00,0.000,2054,0.125,0.000,2326,1977,3354,3442,3267,0,0,0,0,0,0,14.62,14.79,14.76 53.855,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 65.181,SSENSOR,N,P 63461ms 6.39m 288.4 #2 90.178,SSENSOR,N,P 88461ms 8.81m 287.8 #3 115.187,SSENSOR,N,P 113461ms 11.39m 289.1 #4 140.189,SSENSOR,N,P 138461ms 13.88m 288.3 #5 165.187,SSENSOR,N,P 163461ms 16.41m 288.0 #6 166.989,SDIVE,N,turn rate during steady passive flight = 0.003 deg/s 167.125,SDIVE,N,Exiting passive after 5 samples, ret=CONTROL_FINISHED_OK 167.327,HVBD,N,wObserved = -0.101 (6) pitchObserved = -20.000 168.484,SDIVE,N,start $GC,168,-1.15,-4.9,2326,1977,3445,3267,16.4,-10.1,6, ... 168.779,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 169.214,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.1V 169.366,SMOTOR,N,GC TICKS/TIME: 12/14176 169.665,SDIVE,N,end $GC ,169,0.00,0.00,0.00,0.000,6,0.000,0.000,2327,1977,3355,3445,3266,0,0,0,0,0,0,15.06,15.06,15.06 170.005,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 190.186,SSENSOR,N,P 188461ms 18.69m 288.4 #7 215.418,SSENSOR,N,P 213461ms 21.28m 288.0 #8 240.187,SSENSOR,N,P 238461ms 23.68m 288.4 #9 241.117,HXPDR,N,ranging to bottom at 23.678892 meters 241.607,HXPDR,N,ping response: R013.622ms 243.438,HXPDR,N,ping response: R--------- 265.187,SSENSOR,N,P 263461ms 26.07m 288.6 #10 266.101,HXPDR,N,ranging to bottom at 26.070900 meters 266.592,HXPDR,N,ping response: R--------- 290.418,SSENSOR,N,P 288461ms 28.48m 288.1 #11 291.336,HXPDR,N,ranging to bottom at 28.479160 meters 291.828,HXPDR,N,ping response: R--------- 315.184,SSENSOR,N,P 313461ms 30.99m 288.2 #12 316.105,HXPDR,N,ranging to bottom at 30.989754 meters 316.596,HXPDR,N,ping response: R--------- 317.649,SDIVE,N,Exiting passive after 6 samples, ret=TARGET_DEPTH_EXCEEDED 317.789,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 317.929,SDIVE,N,Entering apogee state 318.073,SDIVE,N,Going neutral at apogee at 30.99 meters 318.286,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 319.255,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.1 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.1V 319.862,SMOTOR,N,GC TICKS/TIME: 30/32688 319.949,HROLL,N,done. 320.016,HROLL,N,Roll: No motion occurred. 320.111,SDIVE,N,entering active for apogee pump 321.162,SDIVE,N,start $GC,321,-0.30,0.0,2327,1977,3446,3267,31.0,-9.7,12, ... 325.456,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 325.984,SMOTOR,N,MOTOR_DONE: ticks: 10 max 24v: 4.6mA avg 24v: 3.8mA minV 24v: 14.9V 326.137,SMOTOR,N,GC TICKS/TIME: 172/176370 326.319,HPITCH,N,Pitch completed from -1.17 cm (2327) to -0.30 cm (2603) took 0.8 sec 137 mA (396 mA peak) 14.7 Vmin 334.55 AD/sec 33 ticks 326.763,HPITCH,N,TRACK: b: 2590/0 a: 2594/0 d: -5 o: 9 326.946,HVBD,N,Pump completed from -5.89 cc (3356) to 0.74 cc (3329 [3419, 3240]) took 3.2 sec 731 mA (2743 mA peak) 14.0 Vmin 8.57 AD/sec 126 ticks 327.410,HVBD,N,TRACK: b: 3422/3243 a: 3422/3243 d: -90 o: -93 327.837,SDIVE,N,end $GC ,327,0.82,0.00,3.15,0.731,10246,0.137,0.000,2603,1977,3329,3419,3240,0,0,0,0,0,0,14.69,14.78,14.03 328.214,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 328.380,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 328.520,SDIVE,N,Entering climb state 328.682,SDIVE,N,Going up from 30.99 meters ... VBDctl=5 329.800,SDIVE,N,start $GC,329,1.15,4.9,2603,1977,3419,3239,31.0,0.0,12, ... 333.615,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 334.151,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 5.4mA avg 24v: 3.8mA minV 24v: 14.9V 334.302,SMOTOR,N,GC TICKS/TIME: 153/157626 334.484,HPITCH,N,Pitch completed from -0.30 cm (2603) to 1.11 cm (3054) took 1.4 sec 137 mA (396 mA peak) 14.7 Vmin 334.07 AD/sec 54 ticks 334.924,HPITCH,N,TRACK: b: 3042/0 a: 3046/0 d: -3 o: 8 335.107,HVBD,N,Pump completed from 0.74 cc (3329) to 5.40 cc (3310 [3400, 3220]) took 2.2 sec 399 mA (2585 mA peak) 14.0 Vmin 8.74 AD/sec 87 ticks 335.566,HVBD,N,TRACK: b: 3402/3223 a: 3402/3222 d: -90 o: -92 335.992,SDIVE,N,end $GC ,335,1.35,0.00,2.17,0.399,10246,0.137,0.000,3054,1977,3310,3400,3220,0,0,0,0,0,0,14.72,14.76,13.95 336.340,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 340.188,SSENSOR,N,P 338461ms 28.50m 288.4 #13 365.187,SSENSOR,N,P 363461ms 25.85m 288.4 #14 390.185,SSENSOR,N,P 388461ms 23.40m 288.4 #15 415.187,SSENSOR,N,P 413461ms 20.98m 288.2 #16 440.185,SSENSOR,N,P 438461ms 18.50m 288.3 #17 465.189,SSENSOR,N,P 463461ms 15.88m 288.4 #18 490.187,SSENSOR,N,P 488461ms 13.41m 288.3 #19 515.187,SSENSOR,N,P 513461ms 11.00m 287.6 #20 540.181,SSENSOR,N,P 538461ms 8.74m 287.8 #21 565.180,SSENSOR,N,P 563461ms 6.22m 288.2 #22 590.181,SSENSOR,N,P 588461ms 3.66m 287.7 #23 615.179,SSENSOR,N,P 613461ms 1.16m 287.9 #24 616.968,SDIVE,N,turn rate during steady passive flight = -0.002 deg/s 617.105,SDIVE,N,Exiting passive after 12 samples, ret=SURFACE_DEPTH_REACHED 617.246,SDIVE,N,Leaving climb state due to SURFACE_DEPTH_REACHED 617.390,SDIVE,N,Entering surface coast state 617.552,SDIVE,N,Reached SD, Wo = 0.099052, 0 more points 640.156,SSENSOR,N,P 638461ms 0.00m 288.5 #25 641.657,SDIVE,N,Exiting passive after 1 samples, ret=CONTROL_FINISHED_OK 642.502,SSURF,N,D_SURF: T = 12.0428, S = 0, rho = 999.495 642.675,SDIVE,N,Leaving coast to surface state 642.795,SSURF,N,Entering surface state 642.905,SSURF,N,Starting surface maneuver... 643.340,SSURF,N,disabling surface maneuver aborts 644.565,SSURF,N,d= -0.66m 644.743,HROLL,N,Roll commanded from -0.65 deg (1977) to 0.00 deg (2000)... 645.655,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.1 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.1V 646.264,SMOTOR,N,GC TICKS/TIME: 30/32727 646.351,HROLL,N,done. 646.418,HROLL,N,Roll: No motion occurred. 646.671,HPITCH,N,Pitch commanded from 1.10 cm (3053) to -7.75 cm (222)... 647.578,HPITCH,N,0.7 cm (ad: 2914) mA=67 minV=15.1 (0,0)......... 653.253,HPITCH,N,-5.8 cm (ad: 847) mA=50 minV=15.1 (0,0)...MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 655.586,SMOTOR,N,GC TICKS/TIME: 324/328108 655.676,HPITCH,N,done. 655.814,HPITCH,N,Pitch completed from 1.11 cm (3054) to -7.81 cm (200) took 7.8 sec 50 mA (350 mA peak) 14.8 Vmin 365.90 AD/sec 312 ticks 656.253,HPITCH,N,TRACK: b: 236/0 a: 232/0 d: 2 o: -32 656.510,HVBD,N,Pump commanded from 5.89 cc (3308) to 150.12 cc (2720)... 657.444,HVBD,N,6.1 cc (ad: 3307 [3395,3218]) mA=386 minV=15.1 (0,0)......... 663.144,HVBD,N,18.2 cc (ad: 3258 [3346,3167]) mA=190 minV=15.1 (0,0)......... 668.844,HVBD,N,30.7 cc (ad: 3207 [3294,3117]) mA=179 minV=15.1 (0,0)......... 674.569,HVBD,N,43.4 cc (ad: 3155 [3242,3066]) mA=175 minV=15.1 (0,0)......... 680.294,HVBD,N,55.9 cc (ad: 3104 [3188,3018]) mA=173 minV=15.1 (0,0)......... 685.994,HVBD,N,68.2 cc (ad: 3054 [3138,2965]) mA=171 minV=15.1 (0,0)......... 691.719,HVBD,N,81.2 cc (ad: 3001 [3085,2915]) mA=171 minV=15.1 (0,0)......... 697.444,HVBD,N,93.5 cc (ad: 2951 [3032,2868]) mA=170 minV=15.1 (0,0)......... 703.169,HVBD,N,106.2 cc (ad: 2899 [2979,2819]) mA=169 minV=15.1 (0,0)......... 708.894,HVBD,N,118.5 cc (ad: 2849 [2926,2772]) mA=168 minV=15.1 (0,0)......... 714.619,HVBD,N,131.0 cc (ad: 2798 [2867,2729]) mA=168 minV=15.1 (0,0)......... 720.344,HVBD,N,143.3 cc (ad: 2748 [2813,2681]) mA=168 minV=15.1 (0,0)......MOTOR_DONE: ticks: 14 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 724.282,SMOTOR,N,GC TICKS/TIME: 2679/2682178 724.375,HVBD,N,done. 724.523,HVBD,N,Pump completed from 5.89 cc (3308) to 151.10 cc (2716 [2783, 2650]) took 66.6 sec 168 mA (1665 mA peak) 14.6 Vmin 8.90 AD/sec 2662 ticks 724.997,HVBD,N,TRACK: b: 2787/2653 a: 2787/2654 d: -67 o: -71 726.327,SSURF,N,Depth at end of surface maneuver = -0.575169 727.768,SSURF,N,Finished surface maneuver... 728.773,HTT8,N,TT8 state: Normal (2MHz); analog off; TPU TCR1 480000Hz, tick rate 40000Hz 728.941,SPOWER,N,All devices are off. 730.107,HBATT,N,24V batt pack voltage = 14.97V 730.244,HBATT,N,10V batt pack voltage = 14.79V 745.524,HGPS,N,Acquiring GPS fix (0,0,20) 747.584,HGPS,N,VGPS: no data received 749.246,HGPS,N,VVVVVVVVVVVVVVVVVVVVVVA 772.001,HGPS,N,sync sentence $GPRMC,171014,A,5627.1052,N,00526.3986,W,000.0,000.0,011117,004.1,W*73 (k=34633)set 2017/11/01 17:10:15 772.194,HGPS,N,011117 171013 5627.1050 -526.3983 hdop=1.5 cog=0.0 sog=0.0 hpe=35.7 n=4 25/25 seconds 776.473,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0001kz.a... 778.824,SSYS,N,Capture file opened Compressing THISDIVE.DAT to sg0001dz.x... Compressing THISDIVE.LOG to sg0001lz.x... 782.256,HCF8,N,file 'sg0001dz.x00' opened... 782.421,HCF8,N,file 'sg0001dz.x00' has 546 bytes, closed... 783.173,HCF8,N,file 'sg0001lz.x00' opened... 783.348,HCF8,N,file 'sg0001lz.x00' has 2858 bytes, closed... 784.054,SSURF,N,Collecting glider state 784.353,HBATT,N,24V batt pack voltage = 14.97V 784.490,HBATT,N,10V batt pack voltage = 14.81V 784.749,SDIVE,N,Measuring depth & angle for 1 sec....# done. 787.061,SDIVE,N,Measured depth: -0.59m angle: -7.23deg 787.399,SGLMALLOC,N,glheap_walk: 344076 bytes free, 13 blocks free, 2932 bytes alloc, 35 blocks alloc 787.526,SSURF,N,Trying call 0... 787.570,SSURF,N,Calling phone number: 441631559013 789.691,HPHONE,N,initializing PSTN connection 815.031,HPHONE,N,Phone registered 817.308,HPHONE,N,Iridium signal strength: 4 after 5 queries 817.384,HPHONE,N,cnt_NoComm:1 callCycle:0 smsLastCallCycle:-1 817.568,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.388094 Wed Nov 1 17:10:49 2017 838.702,HPHONE,N,Dialing succeeded 868.752,SSURF,N,No login: prompt detected [] 868.815,SSURF,N,Unable to login (-3)... 870.874,SSURF,N,Total NAK's: 0, timeouts: 0 870.930,SSURF,N,going to sleep.. 930.371,SGLMALLOC,N,glheap_walk: 344100 bytes free, 12 blocks free, 2932 bytes alloc, 35 blocks alloc 930.499,SSURF,N,Trying call 1... 930.543,SSURF,N,Calling phone number: 441631559013 932.660,HPHONE,N,initializing PSTN connection 963.090,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 963.200,HPHONE,N,cnt_NoComm:1 callCycle:0 smsLastCallCycle:-1 963.384,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.388094 Wed Nov 1 17:11:08 2017 988.307,HPHONE,N,Dialing failed: ret 1, response ATDT00441631559013 NO CARRIER 993.416,SSURF,N,Unable to login (-2)... 995.474,SSURF,N,Total NAK's: 0, timeouts: 0 995.531,SSURF,N,going to sleep.. 1055.371,SGLMALLOC,N,glheap_walk: 344100 bytes free, 12 blocks free, 2932 bytes alloc, 35 blocks alloc 1055.752,SSURF,N,Trying call 2... 1055.797,SSURF,N,Calling phone number: 441631559013 1057.916,HPHONE,N,initializing PSTN connection 1083.297,HPHONE,N,Phone registered 1084.964,HPHONE,N,Iridium signal strength: 0 after 5 queries 1085.042,HPHONE,N,cnt_NoComm:1 callCycle:0 smsLastCallCycle:-1 1085.227,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.394188 Wed Nov 1 17:15:19 2017 1116.166,HPHONE,N,Dialing succeeded 1146.218,SSURF,N,No login: prompt detected [ NO CARRIER ] 1146.301,SSURF,N,Unable to login (-3)... 1148.361,SSURF,N,Total NAK's: 0, timeouts: 0 1148.419,SSURF,N,going to sleep.. 1208.371,SGLMALLOC,N,glheap_walk: 344100 bytes free, 12 blocks free, 2932 bytes alloc, 35 blocks alloc 1208.500,SSURF,N,Trying call 3... 1208.545,SSURF,N,Calling phone number: 441631559013 1210.664,HPHONE,N,initializing PSTN connection 1236.046,HPHONE,N,Phone registered 1239.131,HPHONE,N,Iridium signal strength: 5 after 5 queries 1239.209,HPHONE,N,cnt_NoComm:1 callCycle:0 smsLastCallCycle:-1 1239.394,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.458788 Wed Nov 1 17:17:50 2017 1257.978,HPHONE,N,Dialing succeeded 1288.029,SSURF,N,No login: prompt detected [Fedora release 14 (Laughlin) Kernel 2.6.35.11-83.fc14.i686 on an i686 (ttyS0) speed.sa] 1288.208,SSURF,N,Unable to login (-3)... 1290.266,SSURF,N,Total NAK's: 0, timeouts: 0 1290.324,SSURF,N,going to sleep.. 1350.371,SGLMALLOC,N,glheap_walk: 344100 bytes free, 12 blocks free, 2932 bytes alloc, 35 blocks alloc 1350.500,SSURF,N,Trying call 4... 1350.545,SSURF,N,Calling phone number: 441631559013 1352.664,HPHONE,N,initializing PSTN connection 1383.110,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1383.222,HPHONE,N,cnt_NoComm:1 callCycle:0 smsLastCallCycle:-1 1383.406,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 17:20:24 2017 1409.098,HPHONE,N,Dialing succeeded 1439.149,SSURF,N,No login: prompt detected [] 1439.214,SSURF,N,Unable to login (-3)... 1441.534,SSURF,N,Total NAK's: 0, timeouts: 0 1441.599,HTT8,N,Updating parameter $SM_CC to 694.67828 1441.695,HTT8,N,Writing NVRAM...done. 1449.852,SSURF,N,N_NOCOMM reached; will pump to 694.68 CC... 1450.015,SGLMALLOC,N,glheap_walk: 344212 bytes free, 14 blocks free, 2820 bytes alloc, 33 blocks alloc 1450.200,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 1467.364,SDIVE,N,Measured depth: -0.64m angle: -7.26deg 1467.518,HGPS,N,Acquiring GPS fix (0,0,20) 1469.579,HGPS,N,VGPS: no data received 1471.268,HGPS,N,VVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVA 1504.001,HGPS,N,sync sentence $GPRMC,172226,A,5627.1016,N,00526.3914,W,000.0,000.0,011117,004.1,W*78 (k=39279)set 2017/11/01 17:22:27 1504.196,HGPS,N,011117 172225 5627.1016 -526.3911 hdop=1.4 cog=0.0 sog=0.0 hpe=33.9 n=4 35/35 seconds 1508.271,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571778.50 meters 1508.468,SDIVE,N,Grid depth = 30.0, target depth = 30.0 1508.625,SDIVE,N,wDesired = -0.100 1509.284,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 1538.423,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 1538.671,SDIVE,N,speed limits = 0.17, 0.18 1538.963,SDIVE,N,DesiredHead = 291.61, range = 571778.5, glide angle -28.63 1539.853,HROLL,N,Roll commanded from -0.65 deg (1977) to 0.00 deg (2000)... 1540.822,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 1541.446,SMOTOR,N,GC TICKS/TIME: 31/33335 1541.534,HROLL,N,done. 1541.603,HROLL,N,Roll: No motion occurred. 1541.812,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.989,SSURF,N,Dive 1 started Wed Nov 1 17:23:04 2017 (1509556984) 1.204,SUSR,N,Normal Heap: 0+20479 bytes 1.355,SGLMALLOC,N,glheap_walk: 344212 bytes free, 14 blocks free, 2820 bytes alloc, 33 blocks alloc 1.655,HTT8,N,Updating parameter $DIVE to 2 1.972,HTT8,N,Writing NVRAM...done. 10.765,SSURF,N,Initializing data file 10.971,SSURF,N,Initializing log file 13.995,SSURF,N,Starting dive at 13s 14.079,SSURF,N,Leaving surface state 14.182,SDIVE,N,Entering dive state 15.755,SDIVE,N,start $GC,15,-1.15,-4.9,200,1977,2773,2647,0.0,0.0,0, ... 39.517,SSENSOR,N,A 37133ms 3.70m 288.7 #1 42.535,SMOTOR,N,MOTOR_DONE: ticks: 112 max 24v: 2042.5mA avg 24v: 21.4mA minV 24v: 14.9V 42.693,SMOTOR,N,GC TICKS/TIME: 1050/1055224 42.891,HVBD,N,Bleed completed from 152.57 cc (2710) to -4.42 cc (3350 [3436, 3265]) took 23.4 sec 0 mA (1918 mA peak) 14.9 Vmin 27.38 AD/sec 935 ticks 43.339,HVBD,N,TRACK: b: 3433/3269 a: 3430/3265 d: -79 o: -80 43.689,SDIVE,N,end $GC ,43,0.00,0.00,-23.38,0.000,16390,0.000,0.000,200,1977,3350,3436,3265,0,0,0,0,0,0,15.00,13.84,14.94 44.039,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 45.144,SDIVE,N,start $GC,45,-1.15,-4.9,200,1977,3439,3265,3.7,0.0,1, ... 51.906,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 52.403,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 14.9V 52.553,SMOTOR,N,GC TICKS/TIME: 271/274959 52.734,HPITCH,N,Pitch completed from -7.81 cm (200) to -1.16 cm (2330) took 6.5 sec 123 mA (358 mA peak) 14.6 Vmin 328.96 AD/sec 259 ticks 53.177,HPITCH,N,TRACK: b: 2317/0 a: 2321/0 d: -4 o: 9 53.538,SDIVE,N,end $GC ,53,6.47,0.00,0.00,0.000,2054,0.123,0.000,2330,1977,3352,3440,3265,0,0,0,0,0,0,14.64,14.81,14.78 53.879,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 65.183,SSENSOR,N,P 63327ms 6.32m 288.4 #2 90.183,SSENSOR,N,P 88326ms 8.79m 288.4 #3 115.188,SSENSOR,N,P 113327ms 11.18m 288.3 #4 140.186,SSENSOR,N,P 138327ms 13.72m 288.5 #5 165.185,SSENSOR,N,P 163327ms 16.21m 288.5 #6 166.989,SDIVE,N,turn rate during steady passive flight = 0.002 deg/s 167.125,SDIVE,N,Exiting passive after 5 samples, ret=CONTROL_FINISHED_OK 167.324,HVBD,N,wObserved = -0.099 (6) pitchObserved = -20.000 167.539,SDIVE,N,wObs=-0.099, wDes_adj=-0.100, changing VBD -4.9 -> -6.2, actual=-4.9 (MAX_BUOY) 168.857,SDIVE,N,start $GC,168,-1.15,-4.9,2330,1977,3443,3265,16.2,-9.9,6, ... 169.150,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 169.586,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.1V 169.737,SMOTOR,N,GC TICKS/TIME: 12/14179 170.035,SDIVE,N,end $GC ,169,0.00,0.00,0.00,0.000,6,0.000,0.000,2330,1977,3354,3443,3265,0,0,0,0,0,0,15.06,15.07,15.07 170.376,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 190.186,SSENSOR,N,P 188326ms 18.61m 288.6 #7 215.187,SSENSOR,N,P 213326ms 21.05m 288.1 #8 240.186,SSENSOR,N,P 238327ms 23.58m 288.6 #9 241.113,HXPDR,N,ranging to bottom at 23.577997 meters 241.604,HXPDR,N,ping response: R--------- 265.188,SSENSOR,N,P 263326ms 26.63m 288.3 #10 266.108,HXPDR,N,ranging to bottom at 26.634989 meters 266.599,HXPDR,N,ping response: R--------- 290.188,SSENSOR,N,P 288326ms 29.08m 288.4 #11 291.113,HXPDR,N,ranging to bottom at 29.077045 meters 291.604,HXPDR,N,ping response: R--------- 315.185,SSENSOR,N,P 313326ms 31.39m 288.1 #12 316.114,HXPDR,N,ranging to bottom at 31.385847 meters 316.605,HXPDR,N,ping response: R--------- 317.667,SDIVE,N,Exiting passive after 6 samples, ret=TARGET_DEPTH_EXCEEDED 317.807,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 317.948,SDIVE,N,Entering apogee state 318.092,SDIVE,N,Going neutral at apogee at 31.39 meters 318.305,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 319.314,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.1 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.1V 319.932,SMOTOR,N,GC TICKS/TIME: 31/33159 320.019,HROLL,N,done. 320.086,HROLL,N,Roll: No motion occurred. 320.181,SDIVE,N,entering active for apogee pump 321.264,SDIVE,N,start $GC,321,-0.30,0.0,2330,1977,3444,3265,31.4,-10.5,12, ... 325.259,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 325.788,SMOTOR,N,MOTOR_DONE: ticks: 10 max 24v: 5.4mA avg 24v: 3.8mA minV 24v: 14.9V 325.941,SMOTOR,N,GC TICKS/TIME: 160/164371 326.124,HPITCH,N,Pitch completed from -1.16 cm (2330) to -0.31 cm (2600) took 0.8 sec 135 mA (404 mA peak) 14.7 Vmin 337.50 AD/sec 32 ticks 326.565,HPITCH,N,TRACK: b: 2586/0 a: 2590/0 d: -1 o: 10 326.750,HVBD,N,Pump completed from -5.40 cc (3354) to 0.74 cc (3329 [3419, 3240]) took 2.9 sec 670 mA (2733 mA peak) 14.0 Vmin 8.70 AD/sec 115 ticks 327.213,HVBD,N,TRACK: b: 3422/3243 a: 3422/3243 d: -90 o: -93 327.645,SDIVE,N,end $GC ,327,0.80,0.00,2.88,0.670,10246,0.135,0.000,2600,1977,3329,3419,3240,0,0,0,0,0,0,14.71,14.78,14.04 327.996,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 328.162,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 328.302,SDIVE,N,Entering climb state 328.465,SDIVE,N,Going up from 31.39 meters ... VBDctl=5 329.627,SDIVE,N,start $GC,329,1.15,4.9,2599,1977,3419,3240,31.4,0.0,12, ... 333.418,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 333.958,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 5.4mA avg 24v: 3.8mA minV 24v: 14.9V 334.110,SMOTOR,N,GC TICKS/TIME: 152/156716 334.293,HPITCH,N,Pitch completed from -0.31 cm (2600) to 1.12 cm (3059) took 1.4 sec 135 mA (398 mA peak) 14.7 Vmin 333.82 AD/sec 55 ticks 334.732,HPITCH,N,TRACK: b: 3047/0 a: 3051/0 d: -8 o: 8 334.915,HVBD,N,Pump completed from 0.74 cc (3329) to 5.40 cc (3310 [3400, 3220]) took 2.1 sec 374 mA (2807 mA peak) 13.9 Vmin 8.94 AD/sec 85 ticks 335.376,HVBD,N,TRACK: b: 3402/3223 a: 3403/3222 d: -91 o: -93 335.812,SDIVE,N,end $GC ,335,1.38,0.00,2.12,0.374,10246,0.135,0.000,3059,1977,3310,3400,3220,0,0,0,0,0,0,14.73,14.76,13.85 336.185,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 340.187,SSENSOR,N,P 338327ms 28.54m 287.9 #13 365.188,SSENSOR,N,P 363326ms 25.99m 287.9 #14 390.187,SSENSOR,N,P 388326ms 23.52m 288.5 #15 415.188,SSENSOR,N,P 413326ms 20.93m 288.3 #16 440.187,SSENSOR,N,P 438326ms 18.43m 287.8 #17 465.186,SSENSOR,N,P 463326ms 15.94m 288.9 #18 490.189,SSENSOR,N,P 488327ms 13.40m 287.7 #19 515.188,SSENSOR,N,P 513327ms 10.89m 288.1 #20 540.182,SSENSOR,N,P 538326ms 8.41m 288.4 #21 565.181,SSENSOR,N,P 563327ms 5.91m 287.9 #22 590.179,SSENSOR,N,P 588326ms 3.40m 288.3 #23 615.180,SSENSOR,N,P 613326ms 0.88m 288.3 #24 616.984,SDIVE,N,turn rate during steady passive flight = 0.003 deg/s 617.120,SDIVE,N,Exiting passive after 12 samples, ret=SURFACE_DEPTH_REACHED 617.262,SDIVE,N,Leaving climb state due to SURFACE_DEPTH_REACHED 617.405,SDIVE,N,Entering surface coast state 617.568,SDIVE,N,Reached SD, Wo = 0.100120, 0 more points 640.155,SSENSOR,N,P 638327ms 0.00m 288.0 #25 641.653,SDIVE,N,Exiting passive after 1 samples, ret=CONTROL_FINISHED_OK 642.497,SSURF,N,D_SURF: T = 11.846, S = 0, rho = 999.517 642.670,SDIVE,N,Leaving coast to surface state 642.789,SSURF,N,Entering surface state 642.900,SSURF,N,Starting surface maneuver... 643.400,SSURF,N,disabling surface maneuver aborts 644.626,SSURF,N,d= -0.60m 644.803,HROLL,N,Roll commanded from -0.65 deg (1977) to 0.00 deg (2000)... 645.734,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.1 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.8mA avg 24v: 2.3mA minV 24v: 15.1V 646.358,SMOTOR,N,GC TICKS/TIME: 31/33289 646.445,HROLL,N,done. 646.513,HROLL,N,Roll: No motion occurred. 646.764,HPITCH,N,Pitch commanded from 1.12 cm (3058) to -7.75 cm (222)... 647.697,HPITCH,N,0.7 cm (ad: 2919) mA=66 minV=15.1 (0,0)......... 653.372,HPITCH,N,-5.8 cm (ad: 849) mA=50 minV=15.1 (0,0)...MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 655.707,SMOTOR,N,GC TICKS/TIME: 324/328181 655.797,HPITCH,N,done. 655.936,HPITCH,N,Pitch completed from 1.12 cm (3059) to -7.81 cm (200) took 7.8 sec 50 mA (349 mA peak) 14.8 Vmin 366.54 AD/sec 312 ticks 656.375,HPITCH,N,TRACK: b: 237/0 a: 233/0 d: 1 o: -33 656.631,HVBD,N,Pump commanded from 5.89 cc (3308) to 694.68 cc (500)... 657.565,HVBD,N,6.1 cc (ad: 3307 [3395,3218]) mA=384 minV=15.1 (0,0)......... 663.265,HVBD,N,18.2 cc (ad: 3258 [3346,3167]) mA=189 minV=15.1 (0,0)......... 668.990,HVBD,N,30.9 cc (ad: 3206 [3294,3117]) mA=179 minV=15.1 (0,0)......... 674.715,HVBD,N,43.4 cc (ad: 3155 [3242,3066]) mA=175 minV=15.1 (0,0)......... 680.440,HVBD,N,56.2 cc (ad: 3103 [3188,3017]) mA=173 minV=15.1 (0,0)......... 686.140,HVBD,N,68.4 cc (ad: 3053 [3137,2966]) mA=172 minV=15.1 (0,0)......... 691.840,HVBD,N,81.2 cc (ad: 3001 [3085,2915]) mA=171 minV=15.1 (0,0)......... 697.565,HVBD,N,93.5 cc (ad: 2951 [3033,2868]) mA=170 minV=15.1 (0,0)......... 703.290,HVBD,N,106.0 cc (ad: 2900 [2979,2819]) mA=169 minV=15.1 (0,0)......... 709.040,HVBD,N,118.2 cc (ad: 2850 [2926,2772]) mA=169 minV=15.1 (0,0)......... 714.765,HVBD,N,130.7 cc (ad: 2799 [2868,2729]) mA=168 minV=15.1 (0,0)......... 720.490,HVBD,N,143.3 cc (ad: 2748 [2813,2681]) mA=168 minV=15.1 (0,0)......... 726.190,HVBD,N,155.3 cc (ad: 2699 [2766,2630]) mA=168 minV=15.1 (0,0)......... 731.915,HVBD,N,167.3 cc (ad: 2650 [2718,2579]) mA=168 minV=15.1 (0,0)......... 737.615,HVBD,N,179.3 cc (ad: 2601 [2671,2529]) mA=168 minV=15.1 (0,0)......... 743.290,HVBD,N,191.6 cc (ad: 2551 [2620,2479]) mA=168 minV=15.1 (0,0)......... 749.015,HVBD,N,203.8 cc (ad: 2501 [2570,2430]) mA=168 minV=15.1 (0,0)......... 754.740,HVBD,N,215.9 cc (ad: 2452 [2522,2379]) mA=168 minV=15.1 (0,0)......... 760.440,HVBD,N,228.1 cc (ad: 2402 [2472,2331]) mA=168 minV=15.1 (0,0)......... 766.165,HVBD,N,240.1 cc (ad: 2353 [2422,2281]) mA=168 minV=15.1 (0,0)......... 771.865,HVBD,N,251.9 cc (ad: 2305 [2374,2234]) mA=168 minV=15.1 (0,0)......... 777.565,HVBD,N,264.2 cc (ad: 2255 [2322,2186]) mA=168 minV=15.1 (0,0)......... 783.265,HVBD,N,276.2 cc (ad: 2206 [2271,2139]) mA=168 minV=15.1 (0,0)......... 788.965,HVBD,N,288.2 cc (ad: 2157 [2220,2093]) mA=168 minV=15.1 (0,0)......... 794.690,HVBD,N,300.2 cc (ad: 2108 [2167,2045]) mA=168 minV=15.1 (0,0)......... 800.415,HVBD,N,312.3 cc (ad: 2059 [2120,1996]) mA=168 minV=15.1 (0,0)......... 806.140,HVBD,N,324.3 cc (ad: 2010 [2072,1946]) mA=168 minV=15.1 (0,0)......... 811.865,HVBD,N,336.3 cc (ad: 1961 [2024,1894]) mA=168 minV=15.1 (0,0)......... 817.590,HVBD,N,348.6 cc (ad: 1911 [1976,1844]) mA=168 minV=15.1 (0,0)......... 823.315,HVBD,N,360.8 cc (ad: 1861 [1928,1791]) mA=168 minV=15.1 (0,0)......... 829.415,HVBD,N,373.6 cc (ad: 1809 [1876,1738]) mA=168 minV=15.1 (0,0)......... 835.140,HVBD,N,386.1 cc (ad: 1758 [1827,1689]) mA=168 minV=15.1 (0,0)......... 840.865,HVBD,N,398.1 cc (ad: 1709 [1777,1638]) mA=168 minV=15.1 (0,0)......... 846.590,HVBD,N,410.4 cc (ad: 1659 [1728,1588]) mA=169 minV=15.1 (0,0)......... 852.265,HVBD,N,422.4 cc (ad: 1610 [1680,1539]) mA=169 minV=15.1 (0,0)......... 858.015,HVBD,N,434.4 cc (ad: 1561 [1631,1488]) mA=169 minV=15.1 (0,0)......... 863.740,HVBD,N,446.4 cc (ad: 1512 [1582,1439]) mA=169 minV=15.1 (0,0)......... 869.490,HVBD,N,458.5 cc (ad: 1463 [1536,1389]) mA=169 minV=15.1 (0,0)......... 875.215,HVBD,N,470.5 cc (ad: 1414 [1488,1338]) mA=169 minV=15.1 (0,0)......... 880.990,HVBD,N,482.5 cc (ad: 1365 [1441,1286]) mA=170 minV=15.1 (0,0)......... 886.715,HVBD,N,494.8 cc (ad: 1315 [1394,1236]) mA=170 minV=15.1 (0,0)......... 892.440,HVBD,N,506.5 cc (ad: 1267 [1346,1187]) mA=170 minV=15.1 (0,0)......... 898.140,HVBD,N,518.6 cc (ad: 1218 [1297,1138]) mA=170 minV=15.1 (0,0)......... 903.840,HVBD,N,530.3 cc (ad: 1170 [1249,1090]) mA=170 minV=15.1 (0,0)......... 909.590,HVBD,N,542.3 cc (ad: 1121 [1200,1040]) mA=170 minV=15.1 (0,0)......... 915.315,HVBD,N,553.9 cc (ad: 1074 [1154,993]) mA=170 minV=15.1 (0,0)......... 921.040,HVBD,N,565.4 cc (ad: 1027 [1106,945]) mA=171 minV=15.1 (0,0)......... 926.765,HVBD,N,576.9 cc (ad: 980 [1059,899]) mA=171 minV=15.1 (0,0)......... 932.490,HVBD,N,588.7 cc (ad: 932 [1011,852]) mA=171 minV=15.1 (0,0)......... 938.215,HVBD,N,600.2 cc (ad: 885 [962,805]) mA=171 minV=15.1 (0,0)......... 943.940,HVBD,N,612.0 cc (ad: 837 [913,760]) mA=171 minV=15.1 (0,0)......... 949.665,HVBD,N,623.5 cc (ad: 790 [864,714]) mA=171 minV=15.1 (0,0)......... 955.390,HVBD,N,635.1 cc (ad: 743 [814,670]) mA=171 minV=15.1 (0,0)......... 961.090,HVBD,N,646.6 cc (ad: 696 [764,626]) mA=171 minV=15.1 (0,0)......... 966.815,HVBD,N,658.1 cc (ad: 649 [715,583]) mA=171 minV=15.1 (0,0)......... 972.540,HVBD,N,669.4 cc (ad: 603 [664,540]) mA=171 minV=15.1 (0,0)......... 978.265,HVBD,N,680.9 cc (ad: 556 [615,495]) mA=171 minV=15.1 (0,0)......... 983.990,HVBD,N,692.2 cc (ad: 510 [566,451]) mA=171 minV=15.1 (0,0)..MOTOR_DONE: ticks: 13 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.8V 985.888,SMOTOR,N,GC TICKS/TIME: 13134/13141528 985.983,HVBD,N,done. 986.532,HVBD,N,Pump completed from 5.64 cc (3309) to 695.41 cc (497 [554, 441]) took 328.0 sec 171 mA (1628 mA peak) 14.5 Vmin 8.57 AD/sec 13118 ticks 987.007,HVBD,N,TRACK: b: 557/444 a: 558/443 d: -58 o: -61 988.337,SSURF,N,Depth at end of surface maneuver = -0.518983 989.772,SSURF,N,Finished surface maneuver... 990.743,HTT8,N,TT8 state: Normal (2MHz); analog off; TPU TCR1 480000Hz, tick rate 40000Hz 990.911,SPOWER,N,All devices are off. 992.080,HBATT,N,24V batt pack voltage = 14.82V 992.217,HBATT,N,10V batt pack voltage = 14.65V 1007.522,HGPS,N,Acquiring GPS fix (0,0,20) 1009.583,HGPS,N,VGPS: no data received 1011.273,HGPS,N,VVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVA 1051.001,HGPS,N,sync sentence $GPRMC,174034,A,5627.1063,N,00526.3998,W,000.0,000.0,011117,004.1,W*79 (k=32540)set 2017/11/01 17:40:35 1051.196,HGPS,N,011117 174032 5627.1069 -526.3998 hdop=2.0 cog=0.0 sog=0.0 hpe=75.2 n=5 41/41 seconds 1055.432,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0002kz.a... 1058.014,SSYS,N,Capture file opened Compressing THISDIVE.DAT to sg0002dz.x... Compressing THISDIVE.LOG to sg0002lz.x... 1061.519,HCF8,N,file 'sg0002dz.x00' opened... 1061.666,HCF8,N,file 'sg0002dz.x00' has 596 bytes, closed... 1062.405,HCF8,N,file 'sg0002lz.x00' opened... 1062.647,HCF8,N,file 'sg0002lz.x00' has 2863 bytes, closed... 1063.546,SSURF,N,Collecting glider state 1063.846,HBATT,N,24V batt pack voltage = 14.85V 1063.984,HBATT,N,10V batt pack voltage = 14.69V 1064.245,SDIVE,N,Measuring depth & angle for 1 sec....# done. 1066.562,SDIVE,N,Measured depth: -0.60m angle: -7.16deg 1066.899,SGLMALLOC,N,glheap_walk: 344036 bytes free, 13 blocks free, 2972 bytes alloc, 35 blocks alloc 1067.028,SSURF,N,Trying call 0... 1067.073,SSURF,N,Calling phone number: 88160000558 1069.193,HPHONE,N,initializing RUDICS connection 1099.597,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1099.708,HPHONE,N,cnt_NoComm:2 callCycle:0 smsLastCallCycle:-1 1099.893,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.258997 Wed Nov 1 17:20:40 2017 1127.909,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 1133.019,SSURF,N,Unable to login (-2)... 1135.079,SSURF,N,Total NAK's: 0, timeouts: 0 1135.137,SSURF,N,going to sleep.. 1195.371,SGLMALLOC,N,glheap_walk: 344060 bytes free, 12 blocks free, 2972 bytes alloc, 35 blocks alloc 1195.500,SSURF,N,Trying call 1... 1195.545,SSURF,N,Calling phone number: 88160000558 1197.662,HPHONE,N,initializing RUDICS connection 1228.262,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1228.373,HPHONE,N,cnt_NoComm:2 callCycle:0 smsLastCallCycle:-1 1229.165,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.226551 -9.655780 Wed Nov 1 17:41:28 2017 1283.286,HPHONE,N,Dialing succeeded 1306.260,SSURF,N,Got another login: prompt [], restarting login sequence 1321.087,SSURF,N,Logged in... 1323.147,SSURF,N,Sending cmd lsx -k -t150 cmdfile 1327.298,SSURF,N,Receiving cmdfile... 1328.998,SSURF,N,SOH/STX: 0x1 received (68), secSize= 128... 1331.337,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 1333.586,SSURF,N,EOT: 0x4 received (1), secSize= 128... 1333.969,SSURF,N,Received cmdfile 217 bytes 1335.569,SSURF,N,Transmission succeeded... 1335.652,HTT8,N,Updating parameter $MISSION to 2 1335.726,HTT8,N,Updating parameter $SIM_W to 0.1 1335.799,HTT8,N,Updating parameter $SIM_PITCH to -20 1335.872,HTT8,N,Updating parameter $D_TGT to 30 1335.940,HTT8,N,Updating parameter $T_DIVE to 10 1336.009,HTT8,N,Updating parameter $T_MISSION to 15 1336.081,HTT8,N,Updating parameter $KALMAN_USE to 2 1336.154,HTT8,N,Updating parameter $SM_CC to 150 1336.222,HTT8,N,Updating parameter $MAX_BUOY to 5 1336.288,HTT8,N,Updating parameter $USE_BATHY to 0 1336.364,HTT8,N,Updating parameter $C_VBD to 3332 1336.437,HTT8,N,Updating parameter $C_PITCH to 2700 1336.511,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 1336.590,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 1336.669,HTT8,N,Updating parameter $T_RSLEEP to 1 1336.733,SDIVE,N,Parsed command: $GO 1336.782,SDIVE,N,No recovery errors reported. Going to Dive. 1336.951,HTT8,N,Writing NVRAM...done. 1349.877,SSURF,N,Sending cmd lsx -k -t150 science 1354.035,SSURF,N,Receiving science... 1355.629,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 1360.312,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 1362.108,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 1364.360,SSURF,N,EOT: 0x4 received (1), secSize= 128... 1364.751,SSURF,N,Received science 273 bytes 1366.342,SSURF,N,Transmission succeeded... 1366.493,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 1366.607,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 1366.731,SSURF,N,Sending cmd lrx -y -c -t150 sg0002lz.x00 1368.799,SSURF,N,Sending sg0002lz.x00... 1368.898,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 1373.180,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 1377.499,SSURF,N,block: 3, size: 815, blkSize: 1024, attempt: 1... 1381.999,SSURF,N,EOT sent ... 1384.521,SSURF,N,received ACK (attempt 0) 1386.864,SSURF,N,Transmission succeeded... 1386.970,SSURF,N,Sending cmd lrx -y -c -t150 sg0002dz.x00 1389.139,SSURF,N,Sending sg0002dz.x00... 1389.226,SSURF,N,block: 1, size: 596, blkSize: 1024, attempt: 1... 1393.608,SSURF,N,EOT sent ... 1396.128,SSURF,N,received ACK (attempt 0) 1398.483,SSURF,N,Transmission succeeded... 1398.646,SSURF,N,Sending cmd lrx -y -c -t150 sg0001lz.x00 1400.752,SSURF,N,Sending sg0001lz.x00... 1400.851,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 1405.309,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 1419.182,SSURF,N,block: 3, size: 810, blkSize: 1024, attempt: 1... 1432.861,SSURF,N,EOT sent ... 1436.371,SSURF,N,received NCK (attempt 0) - resending EOT 1440.222,SSURF,N,received ACK (attempt 1) 1443.280,HPHONE,N,No prompt after send complete [] 1445.356,SSURF,N,Transmission succeeded... 1445.461,SSURF,N,Sending cmd lrx -y -c -t150 sg0000lz.x00 1447.538,SSURF,N,Sending sg0000lz.x00... 1447.628,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 1452.013,SSURF,N,block: 2, size: 454, blkSize: 1024, attempt: 1... 1461.470,SSURF,N,EOT sent ... 1466.421,SSURF,N,received ACK (attempt 0) 1468.766,SSURF,N,Transmission succeeded... 1468.866,SSURF,N,Sending cmd lrx -y -c -t150 sg0001dz.x00 1473.381,SSURF,N,Sending sg0001dz.x00... 1473.468,SSURF,N,block: 1, size: 546, blkSize: 1024, attempt: 1... 1477.951,SSURF,N,EOT sent ... 1480.471,SSURF,N,received ACK (attempt 0) 1482.816,SSURF,N,Transmission succeeded... 1484.978,SSURF,N,logout... 1498.051,SSURF,N,Total NAK's: 0, timeouts: 0 1498.197,SGLMALLOC,N,glheap_walk: 344152 bytes free, 17 blocks free, 2808 bytes alloc, 33 blocks alloc 1498.381,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 1515.587,SDIVE,N,Measured depth: -0.66m angle: -7.28deg 1515.740,HGPS,N,Acquiring GPS fix (0,0,20) 1517.802,HGPS,N,VGPS: no data received 1519.514,HGPS,N,VVVVVVVVVVVA 1532.001,HGPS,N,sync sentence $GPRMC,174835,A,5627.1093,N,00526.3959,W,000.0,000.0,011117,004.1,W*72 (k=33712)set 2017/11/01 17:48:36 1532.440,SPOWER,N,Bogus seconds (-1.171525) for TT8_Sampling; ignored! 1532.551,HGPS,N,011117 174833 5627.1084 -526.3947 hdop=2.0 cog=0.0 sog=0.0 hpe=94.3 n=5 14/14 seconds 1536.394,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571771.50 meters 1536.591,SDIVE,N,Grid depth = 30.0, target depth = 30.0 1536.747,SDIVE,N,wDesired = -0.100 1537.406,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 1566.545,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 1566.793,SDIVE,N,speed limits = 0.17, 0.18 1567.084,SDIVE,N,DesiredHead = 291.61, range = 571771.5, glide angle -28.63 1567.973,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 1568.888,HROLL,N,-0.7 deg (ad: 1976) mA=0 minV=14.9 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 14.9V 1569.510,SMOTOR,N,GC TICKS/TIME: 31/33245 1569.599,HROLL,N,done. 1569.667,HROLL,N,Roll: No motion occurred. 1569.877,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.053,SSURF,N,Dive 2 started Wed Nov 1 17:49:14 2017 (1509558554) 0.268,SUSR,N,Normal Heap: 0+20479 bytes 0.423,SGLMALLOC,N,glheap_walk: 344152 bytes free, 17 blocks free, 2808 bytes alloc, 33 blocks alloc 0.720,HTT8,N,Updating parameter $DIVE to 3 1.037,HTT8,N,Writing NVRAM...done. 9.831,SSURF,N,Initializing data file 10.014,SSURF,N,Initializing log file 13.008,SSURF,N,Starting dive at 12s 13.092,SSURF,N,Leaving surface state 13.195,SDIVE,N,Entering dive state 14.745,SDIVE,N,start $GC,14,-1.15,-4.9,200,1976,547,441,0.0,0.0,0, ... 24.428,SSENSOR,N,A 22086ms 2.30m 288.4 #1 34.378,SSENSOR,N,A 32086ms 3.30m 288.5 #2 38.442,SMOTOR,N,MOTOR_DONE: no ticks 38.530,SMOTOR,N,GC TICKS/TIME: 908/914370 38.732,HVBD,N,Bleed completed from 696.15 cc (494) to 508.01 cc (1261 [1317, 1206]) took 22.6 sec 0 mA (1906 mA peak) 14.9 Vmin 33.86 AD/sec 906 ticks 39.182,HVBD,N,TRACK: b: 1260/0 a: 1260/0 d: 2091 o: 1 39.514,SDIVE,N,end $GC ,39,0.00,0.00,-22.65,0.000,16386,0.000,0.000,200,1976,1261,1317,1206,0,0,0,0,0,0,14.91,28.83,14.92 39.862,SDIVE,N,Exiting active in GCPHASE_VBD (2) after 2 samples, ret=FLARE_DEPTH_REACHED 41.024,SDIVE,N,start $GC,40,-1.15,-4.9,200,1976,1317,1206,3.3,-10.0,2, ... 44.714,SSENSOR,N,A 42090ms 4.32m 288.6 #3 54.364,SSENSOR,N,A 52107ms 5.33m 287.6 #4 64.264,SSENSOR,N,A 62066ms 6.41m 287.5 #5 74.214,SSENSOR,N,A 72072ms 7.41m 287.7 #6 84.164,SSENSOR,N,A 82078ms 8.54m 287.7 #7 93.989,SSENSOR,N,A 92085ms 9.55m 288.4 #8 104.039,SSENSOR,N,A 102073ms 10.55m 287.4 #9 114.239,SSENSOR,N,A 112080ms 11.53m 287.5 #10 117.839,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 118.843,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 2041.0mA avg 24v: 234.9mA minV 24v: 14.8V 119.002,SMOTOR,N,GC TICKS/TIME: 3073/3096071 119.189,HPITCH,N,Pitch completed from -7.81 cm (200) to -1.16 cm (2328) took 6.5 sec 123 mA (352 mA peak) 14.6 Vmin 328.65 AD/sec 259 ticks 119.632,HPITCH,N,TRACK: b: 2315/0 a: 2319/0 d: -2 o: 9 119.826,HVBD,N,Bleed completed from 507.52 cc (1263) to -5.15 cc (3353 [3440, 3266]) took 70.1 sec 0 mA (1895 mA peak) 14.7 Vmin 29.84 AD/sec 2802 ticks 120.275,HVBD,N,TRACK: b: 3438/3265 a: 3438/3265 d: -87 o: -85 120.677,SDIVE,N,end $GC ,120,6.47,0.00,-70.05,0.000,18438,0.123,0.000,2328,1977,3353,3440,3266,0,0,0,0,0,0,14.57,13.42,14.71 121.048,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 9 samples, ret=CONTROL_FINISHED_OK 124.938,SSENSOR,N,P 123267ms 12.65m 288.1 #11 134.940,SSENSOR,N,P 133266ms 13.61m 288.6 #12 144.940,SSENSOR,N,P 143266ms 14.55m 288.1 #13 155.171,SSENSOR,N,P 153266ms 15.56m 288.3 #14 164.940,SSENSOR,N,P 163266ms 16.54m 288.7 #15 174.939,SSENSOR,N,P 173266ms 17.54m 289.0 #16 176.786,SDIVE,N,turn rate during steady passive flight = 0.013 deg/s 176.921,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 177.122,HVBD,N,wObserved = -0.098 (16) pitchObserved = -20.000 177.340,SDIVE,N,wObs=-0.098, wDes_adj=-0.100, changing VBD -4.9 -> -6.4, actual=-4.9 (MAX_BUOY) 178.577,SDIVE,N,start $GC,178,-1.15,-4.9,2328,1977,3446,3266,17.5,-9.8,16, ... 178.872,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 179.310,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 179.461,SMOTOR,N,GC TICKS/TIME: 12/14173 179.764,SDIVE,N,end $GC ,179,0.00,0.00,0.00,0.000,6,0.000,0.000,2328,1977,3355,3446,3265,0,0,0,0,0,0,14.96,14.97,14.97 180.092,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 184.938,SSENSOR,N,P 183266ms 18.51m 288.8 #17 194.938,SSENSOR,N,P 193267ms 19.51m 288.2 #18 204.940,SSENSOR,N,P 203266ms 20.49m 288.3 #19 214.938,SSENSOR,N,P 213266ms 21.48m 288.1 #20 225.262,SSENSOR,N,P 223266ms 22.49m 288.0 #21 226.213,HXPDR,N,ranging to bottom at 22.492615 meters 226.703,HXPDR,N,ping response: R014.922ms 228.532,HXPDR,N,ping response: R--------- 234.939,SSENSOR,N,P 233266ms 23.50m 288.4 #22 236.773,SDIVE,N,turn rate during steady passive flight = 0.009 deg/s 236.909,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 237.110,HVBD,N,wObserved = -0.100 (22) pitchObserved = -20.000 237.329,SDIVE,N,wObs=-0.100, wDes_adj=-0.100, changing VBD -4.9 -> -5.0, actual=-4.9 (MAX_BUOY) 238.654,SDIVE,N,start $GC,238,-1.15,-4.9,2328,1977,3446,3266,23.5,-10.0,22, ... 238.950,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 239.385,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 239.537,SMOTOR,N,GC TICKS/TIME: 12/14134 239.840,SDIVE,N,end $GC ,239,0.00,0.00,0.00,0.000,6,0.000,0.000,2328,1977,3355,3445,3266,0,0,0,0,0,0,14.97,14.97,14.97 240.152,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 245.199,SSENSOR,N,P 243266ms 24.54m 288.4 #23 246.149,HXPDR,N,ranging to bottom at 24.542166 meters 246.639,HXPDR,N,ping response: R--------- 254.939,SSENSOR,N,P 253266ms 25.64m 288.5 #24 264.940,SSENSOR,N,P 263267ms 26.65m 288.1 #25 265.893,HXPDR,N,ranging to bottom at 26.648058 meters 266.386,HXPDR,N,ping response: R--------- 274.940,SSENSOR,N,P 273267ms 27.63m 288.1 #26 284.941,SSENSOR,N,P 283266ms 28.65m 288.5 #27 285.893,HXPDR,N,ranging to bottom at 28.650749 meters 286.384,HXPDR,N,ping response: R--------- 294.937,SSENSOR,N,P 293267ms 29.73m 287.9 #28 296.786,SDIVE,N,turn rate during steady passive flight = -0.022 deg/s 296.923,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 297.125,HVBD,N,wObserved = -0.102 (28) pitchObserved = -20.000 298.289,SDIVE,N,start $GC,298,-1.15,-4.9,2328,1977,3446,3266,29.7,-10.2,28, ... 298.585,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 299.021,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 299.172,SMOTOR,N,GC TICKS/TIME: 12/14175 299.473,SDIVE,N,end $GC ,299,0.00,0.00,0.00,0.000,6,0.000,0.000,2328,1977,3356,3446,3266,0,0,0,0,0,0,14.99,15.00,14.99 299.789,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 304.939,SSENSOR,N,P 303267ms 30.71m 288.0 #29 305.891,HXPDR,N,ranging to bottom at 30.712095 meters 306.380,HXPDR,N,ping response: R--------- 307.432,SDIVE,N,Exiting passive after 1 samples, ret=TARGET_DEPTH_EXCEEDED 307.572,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 307.712,SDIVE,N,Entering apogee state 307.857,SDIVE,N,Going neutral at apogee at 30.71 meters 308.070,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 308.955,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 309.564,SMOTOR,N,GC TICKS/TIME: 30/32688 309.651,HROLL,N,done. 309.718,HROLL,N,Roll: No motion occurred. 309.813,SDIVE,N,entering active for apogee pump 310.851,SDIVE,N,start $GC,310,-0.30,0.0,2328,1977,3446,3266,30.7,-10.2,29, ... 314.421,SSENSOR,N,A 312112ms 29.80m 288.6 #30 317.721,SMOTOR,N,MOTOR_DONE: ticks: 94 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 317.874,SMOTOR,N,GC TICKS/TIME: 252/258327 318.059,HPITCH,N,Pitch completed from -1.16 cm (2328) to -0.30 cm (2604) took 0.8 sec 135 mA (396 mA peak) 14.6 Vmin 334.55 AD/sec 33 ticks 318.503,HPITCH,N,TRACK: b: 2591/0 a: 2594/0 d: -5 o: 10 318.688,HVBD,N,Pump completed from -5.64 cc (3355) to 0.74 cc (3329 [3420, 3239]) took 3.0 sec 707 mA (2560 mA peak) 14.0 Vmin 8.52 AD/sec 122 ticks 319.151,HVBD,N,TRACK: b: 3423/3242 a: 3422/3242 d: -90 o: -93 319.575,SDIVE,N,end $GC ,319,0.82,0.00,3.05,0.707,10246,0.135,0.000,2604,1977,3329,3420,3239,0,0,0,0,0,0,14.64,14.70,13.97 319.909,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 320.075,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 320.215,SDIVE,N,Entering climb state 320.379,SDIVE,N,Going up from 29.80 meters ... VBDctl=5 321.505,SDIVE,N,start $GC,321,1.15,4.9,2604,1977,3419,3239,29.8,0.0,30, ... 324.396,SSENSOR,N,A 322079ms 28.81m 288.1 #31 327.620,SMOTOR,N,MOTOR_DONE: ticks: 83 max 24v: 4.6mA avg 24v: 3.1mA minV 24v: 14.9V 327.773,SMOTOR,N,GC TICKS/TIME: 222/228270 327.956,HPITCH,N,Pitch completed from -0.30 cm (2604) to 1.07 cm (3043) took 1.3 sec 134 mA (400 mA peak) 14.6 Vmin 337.69 AD/sec 52 ticks 328.393,HPITCH,N,TRACK: b: 3040/0 a: 3033/0 d: 10 o: 10 328.580,HVBD,N,Pump completed from 0.49 cc (3330) to 5.64 cc (3309 [3399, 3219]) took 2.1 sec 318 mA (2681 mA peak) 13.7 Vmin 10.00 AD/sec 84 ticks 329.038,HVBD,N,TRACK: b: 3403/3222 a: 3403/3222 d: -91 o: -94 329.459,SDIVE,N,end $GC ,329,1.30,0.00,2.10,0.318,10246,0.134,0.000,3043,1977,3309,3399,3219,0,0,0,0,0,0,14.57,14.66,13.70 329.796,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 334.939,SSENSOR,N,P 333266ms 27.60m 287.9 #32 344.939,SSENSOR,N,P 343267ms 26.63m 288.2 #33 354.939,SSENSOR,N,P 353267ms 25.60m 287.9 #34 365.171,SSENSOR,N,P 363266ms 24.64m 287.9 #35 374.938,SSENSOR,N,P 373266ms 23.71m 288.0 #36 384.937,SSENSOR,N,P 383267ms 22.71m 287.6 #37 386.772,SDIVE,N,turn rate during steady passive flight = -0.022 deg/s 386.910,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 387.110,HVBD,N,wObserved = 0.097 (7) pitchObserved = 20.000 387.322,SDIVE,N,wObs=0.097, wDes_adj=0.100, changing VBD 4.9 -> 7.7 388.476,SDIVE,N,start $GC,388,1.16,7.7,3042,1977,3400,3219,22.7,9.7,37, ... 390.017,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 390.488,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 390.640,SMOTOR,N,GC TICKS/TIME: 62/64797 390.825,HVBD,N,Pump completed from 5.64 cc (3309) to 8.34 cc (3298 [3389, 3207]) took 1.2 sec 271 mA (1663 mA peak) 14.6 Vmin 8.80 AD/sec 50 ticks 391.288,HVBD,N,TRACK: b: 3391/3210 a: 3391/3210 d: -91 o: -93 391.652,SDIVE,N,end $GC ,391,0.00,0.00,1.25,0.271,8198,0.000,0.000,3043,1977,3298,3389,3207,0,0,0,0,0,0,14.99,14.76,14.60 391.984,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 394.450,SSENSOR,N,P 392779ms 21.81m 287.8 #38 405.071,SSENSOR,N,P 403401ms 20.78m 288.7 #39 415.073,SSENSOR,N,P 413401ms 19.77m 287.9 #40 425.306,SSENSOR,N,P 423400ms 18.82m 288.6 #41 435.071,SSENSOR,N,P 433401ms 17.80m 288.1 #42 445.074,SSENSOR,N,P 443400ms 16.81m 288.0 #43 446.903,SDIVE,N,turn rate during steady passive flight = -0.023 deg/s 447.040,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 447.241,HVBD,N,wObserved = 0.099 (13) pitchObserved = 20.000 447.456,SDIVE,N,wObs=0.099, wDes_adj=0.100, changing VBD 7.7 -> 8.7 448.606,SDIVE,N,start $GC,448,1.16,8.7,3043,1977,3388,3207,16.8,9.9,43, ... 448.897,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 449.332,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 449.484,SMOTOR,N,GC TICKS/TIME: 12/14132 449.781,SDIVE,N,end $GC ,449,0.00,0.00,0.00,0.000,6,0.000,0.000,3043,1977,3297,3388,3207,0,0,0,0,0,0,15.00,15.01,15.01 450.107,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 455.073,SSENSOR,N,P 453401ms 15.84m 288.4 #44 465.073,SSENSOR,N,P 463401ms 14.83m 288.1 #45 475.074,SSENSOR,N,P 473400ms 13.77m 287.9 #46 485.071,SSENSOR,N,P 483401ms 12.78m 288.1 #47 495.355,SSENSOR,N,P 493401ms 11.77m 288.4 #48 505.073,SSENSOR,N,P 503400ms 10.76m 287.8 #49 506.905,SDIVE,N,turn rate during steady passive flight = -0.011 deg/s 507.042,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 507.245,HVBD,N,wObserved = 0.101 (19) pitchObserved = 20.000 508.355,SDIVE,N,start $GC,508,1.16,8.7,3043,1977,3388,3207,10.8,10.1,49, ... 508.647,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 509.084,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 509.236,SMOTOR,N,GC TICKS/TIME: 12/14178 509.535,SDIVE,N,end $GC ,509,0.00,0.00,0.00,0.000,6,0.000,0.000,3043,1977,3297,3388,3207,0,0,0,0,0,0,15.02,15.02,15.02 509.847,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 515.067,SSENSOR,N,P 513401ms 9.76m 288.5 #50 525.065,SSENSOR,N,P 523401ms 8.77m 288.4 #51 535.066,SSENSOR,N,P 533400ms 7.78m 287.9 #52 545.067,SSENSOR,N,P 543400ms 6.80m 288.4 #53 555.065,SSENSOR,N,P 553401ms 5.81m 288.2 #54 565.348,SSENSOR,N,P 563401ms 4.81m 288.4 #55 567.176,SDIVE,N,turn rate during steady passive flight = 0.000 deg/s 567.311,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 567.510,HVBD,N,wObserved = 0.099 (25) pitchObserved = 20.000 567.724,SDIVE,N,wObs=0.099, wDes_adj=0.100, changing VBD 8.7 -> 9.9 568.919,SDIVE,N,start $GC,568,1.16,9.9,3042,1977,3388,3207,4.8,9.9,55, ... 569.208,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 569.643,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 569.795,SMOTOR,N,GC TICKS/TIME: 12/14135 570.095,SDIVE,N,end $GC ,569,0.00,0.00,0.00,0.000,6,0.000,0.000,3043,1976,3297,3388,3207,0,0,0,0,0,0,15.02,15.03,15.03 570.411,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 575.066,SSENSOR,N,P 573401ms 3.81m 288.6 #56 585.067,SSENSOR,N,P 583402ms 2.83m 288.1 #57 595.062,SSENSOR,N,P 593401ms 1.85m 288.3 #58 596.859,SDIVE,N,Exiting passive after 3 samples, ret=SURFACE_DEPTH_REACHED 597.003,SDIVE,N,Leaving climb state due to SURFACE_DEPTH_REACHED 597.144,SDIVE,N,Entering surface coast state 597.307,SDIVE,N,Reached SD, Wo = 0.099000, 2 more points 605.066,SSENSOR,N,P 603400ms 0.79m 287.6 #59 615.043,SSENSOR,N,P 613401ms 0.00m 288.1 #60 616.614,SDIVE,N,turn rate during steady passive flight = 0.050 deg/s 616.750,SDIVE,N,Exiting passive after 2 samples, ret=CONTROL_FINISHED_OK 617.596,SSURF,N,D_SURF: T = 11.738, S = 0, rho = 999.529 617.769,SDIVE,N,Leaving coast to surface state 617.888,SSURF,N,Entering surface state 618.002,SSURF,N,Starting surface maneuver... 618.326,SSURF,N,disabling surface maneuver aborts 619.553,SSURF,N,d= -0.71m 619.729,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 620.611,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 27 max 24v: 4.6mA avg 24v: 2.3mA minV 24v: 15.0V 621.221,SMOTOR,N,GC TICKS/TIME: 30/32735 621.308,HROLL,N,done. 621.375,HROLL,N,Roll: No motion occurred. 621.626,HPITCH,N,Pitch commanded from 1.07 cm (3042) to -7.75 cm (222)... 622.512,HPITCH,N,0.6 cm (ad: 2903) mA=65 minV=15.0 (0,0)......... 628.162,HPITCH,N,-5.8 cm (ad: 858) mA=50 minV=15.0 (0,0)...MOTOR_DONE: ticks: 7 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 630.496,SMOTOR,N,GC TICKS/TIME: 323/327095 630.586,HPITCH,N,done. 630.725,HPITCH,N,Pitch completed from 1.07 cm (3043) to -7.82 cm (198) took 7.8 sec 50 mA (341 mA peak) 14.8 Vmin 363.58 AD/sec 313 ticks 631.163,HPITCH,N,TRACK: b: 232/0 a: 228/0 d: 6 o: -30 631.421,HVBD,N,Pump commanded from 8.83 cc (3296) to 150.12 cc (2720)... 632.330,HVBD,N,8.8 cc (ad: 3296 [3383,3206]) mA=386 minV=15.0 (0,0)......... 638.030,HVBD,N,21.1 cc (ad: 3246 [3335,3155]) mA=189 minV=15.0 (0,0)......... 643.730,HVBD,N,33.4 cc (ad: 3196 [3285,3105]) mA=179 minV=15.0 (0,0)......... 649.455,HVBD,N,45.9 cc (ad: 3145 [3232,3057]) mA=175 minV=15.0 (0,0)......... 655.180,HVBD,N,58.1 cc (ad: 3095 [3179,3007]) mA=173 minV=15.0 (0,0)......... 660.905,HVBD,N,70.6 cc (ad: 3044 [3128,2956]) mA=171 minV=15.0 (0,0)......... 666.630,HVBD,N,83.4 cc (ad: 2992 [3075,2908]) mA=171 minV=15.0 (0,0)......... 672.355,HVBD,N,95.4 cc (ad: 2943 [3022,2861]) mA=170 minV=15.0 (0,0)......... 678.080,HVBD,N,107.7 cc (ad: 2893 [2970,2814]) mA=169 minV=15.0 (0,0)......... 683.805,HVBD,N,119.9 cc (ad: 2843 [2917,2768]) mA=168 minV=15.0 (0,0)......... 689.530,HVBD,N,132.2 cc (ad: 2793 [2858,2725]) mA=168 minV=15.0 (0,0)......... 695.280,HVBD,N,144.7 cc (ad: 2742 [2808,2675]) mA=168 minV=15.0 (0,0)....MOTOR_DONE: ticks: 1 max 24v: 4.6mA avg 24v: 4.6mA minV 24v: 14.8V 698.165,SMOTOR,N,GC TICKS/TIME: 2639/2642184 698.258,HVBD,N,done. 698.404,HVBD,N,Pump completed from 8.59 cc (3297) to 150.37 cc (2719 [2785, 2654]) took 65.9 sec 168 mA (1665 mA peak) 14.6 Vmin 8.77 AD/sec 2635 ticks 698.877,HVBD,N,TRACK: b: 2786/2655 a: 2786/2655 d: -66 o: -67 700.220,SSURF,N,Depth at end of surface maneuver = -0.635898 701.659,SSURF,N,Finished surface maneuver... 702.616,HTT8,N,TT8 state: Normal (2MHz); analog off; TPU TCR1 480000Hz, tick rate 40000Hz 702.785,SPOWER,N,All devices are off. 703.958,HBATT,N,24V batt pack voltage = 14.90V 704.093,HBATT,N,10V batt pack voltage = 14.73V 719.647,HGPS,N,Acquiring GPS fix (0,0,20) 721.707,HGPS,N,VGPS: no data received 723.437,HGPS,N,VVVVVVVVVVVVVA 738.001,HGPS,N,sync sentence $GPRMC,180131,A,5627.0927,N,00526.4053,W,000.0,000.0,011117,004.1,W*77 (k=32802)set 2017/11/01 18:01:32 738.196,HGPS,N,011117 180129 5627.0938 -526.4036 hdop=1.8 cog=0.0 sog=0.0 hpe=163.8 n=5 16/16 seconds 742.075,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0003kz.a... 744.985,SSYS,N,Capture file opened Compressing THISDIVE.DAT to sg0003dz.x... Compressing THISDIVE.LOG to sg0003lz.x... 748.910,HCF8,N,file 'sg0003dz.x00' opened... 749.062,HCF8,N,file 'sg0003dz.x00' has 1420 bytes, closed... 749.793,HCF8,N,file 'sg0003lz.x00' opened... 749.981,HCF8,N,file 'sg0003lz.x00' has 3099 bytes, closed... 750.513,SSURF,N,Collecting glider state 750.812,HBATT,N,24V batt pack voltage = 14.91V 750.949,HBATT,N,10V batt pack voltage = 14.75V 751.208,SDIVE,N,Measuring depth & angle for 1 sec....# done. 753.524,SDIVE,N,Measured depth: -0.59m angle: -7.32deg 753.864,SGLMALLOC,N,glheap_walk: 344088 bytes free, 13 blocks free, 2920 bytes alloc, 35 blocks alloc 753.991,SSURF,N,Trying call 0... 754.035,SSURF,N,Calling phone number: 88160000558 756.154,HPHONE,N,initializing RUDICS connection 781.554,HPHONE,N,Phone registered 783.507,HPHONE,N,Iridium signal strength: 5 after 5 queries 783.583,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 783.767,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.394188 Wed Nov 1 18:02:08 2017 791.308,HPHONE,N,Dialing succeeded 804.630,SSURF,N,Logged in... 806.599,SSURF,N,Sending cmd lsx -k -t150 cmdfile 810.756,SSURF,N,Receiving cmdfile... 812.269,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 814.610,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 816.679,SSURF,N,EOT: 0x4 received (1), secSize= 128... 817.082,SSURF,N,Received cmdfile 217 bytes 818.571,SSURF,N,Transmission succeeded... 818.653,HTT8,N,Updating parameter $MISSION to 2 818.726,HTT8,N,Updating parameter $SIM_W to 0.1 818.797,HTT8,N,Updating parameter $SIM_PITCH to -20 818.869,HTT8,N,Updating parameter $D_TGT to 30 818.936,HTT8,N,Updating parameter $T_DIVE to 10 819.004,HTT8,N,Updating parameter $T_MISSION to 15 819.075,HTT8,N,Updating parameter $KALMAN_USE to 2 819.147,HTT8,N,Updating parameter $SM_CC to 150 819.214,HTT8,N,Updating parameter $MAX_BUOY to 5 819.279,HTT8,N,Updating parameter $USE_BATHY to 0 819.353,HTT8,N,Updating parameter $C_VBD to 3332 819.701,HTT8,N,Updating parameter $C_PITCH to 2700 819.774,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 819.852,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 819.929,HTT8,N,Updating parameter $T_RSLEEP to 1 819.992,SDIVE,N,Parsed command: $GO 820.040,SDIVE,N,No recovery errors reported. Going to Dive. 820.208,HTT8,N,Writing NVRAM...done. 832.969,SSURF,N,Sending cmd lsx -k -t150 science 837.118,SSURF,N,Receiving science... 838.704,SSURF,N,SOH/STX: 0x1 received (67), secSize= 128... 840.954,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 843.203,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 845.454,SSURF,N,EOT: 0x4 received (1), secSize= 128... 845.893,SSURF,N,Received science 273 bytes 847.436,SSURF,N,Transmission succeeded... 847.586,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 847.699,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 847.822,SSURF,N,Sending cmd lrx -y -c -t150 sg0003lz.x00 849.894,SSURF,N,Sending sg0003lz.x00... 849.993,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 854.364,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 858.685,SSURF,N,block: 3, size: 1024, blkSize: 1024, attempt: 1... 863.004,SSURF,N,block: 4, size: 27, blkSize: 128, attempt: 1... 864.624,SSURF,N,EOT sent ... 867.143,SSURF,N,received ACK (attempt 0) 871.918,SSURF,N,Transmission succeeded... 872.020,SSURF,N,Sending cmd lrx -y -c -t150 sg0003dz.x00 874.105,SSURF,N,Sending sg0003dz.x00... 874.193,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 878.664,SSURF,N,block: 2, size: 396, blkSize: 1024, attempt: 1... 882.983,SSURF,N,EOT sent ... 885.503,SSURF,N,received ACK (attempt 0) 890.278,SSURF,N,Transmission succeeded... 892.440,SSURF,N,logout... 905.513,SSURF,N,Total NAK's: 0, timeouts: 0 905.658,SGLMALLOC,N,glheap_walk: 344196 bytes free, 17 blocks free, 2764 bytes alloc, 33 blocks alloc 905.841,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 923.026,SDIVE,N,Measured depth: -0.67m angle: -7.30deg 923.178,HGPS,N,Acquiring GPS fix (0,0,20) 925.543,HGPS,N,VGPS: no data received 926.965,HGPS,N,VVVVVVVVA 935.001,HGPS,N,sync sentence $GPRMC,180448,A,5627.1138,N,00526.4215,W,000.0,000.0,011117,004.1,W*7B (k=2491)set 2017/11/01 18:04:49 935.194,HGPS,N,011117 180447 5627.1128 -526.4212 hdop=1.8 cog=0.0 sog=0.0 hpe=167.7 n=5 11/11 seconds 939.040,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571744.00 meters 939.236,SDIVE,N,Grid depth = 30.0, target depth = 30.0 939.391,SDIVE,N,wDesired = -0.100 940.049,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 969.187,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 969.434,SDIVE,N,speed limits = 0.17, 0.18 969.722,SDIVE,N,DesiredHead = 291.61, range = 571744.0, glide angle -28.63 970.610,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 971.528,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 972.145,SMOTOR,N,GC TICKS/TIME: 31/33213 972.232,HROLL,N,done. 972.299,HROLL,N,Roll: No motion occurred. 972.507,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.683,SSURF,N,Dive 3 started Wed Nov 1 18:05:26 2017 (1509559526) 0.904,SUSR,N,Normal Heap: 0+20479 bytes 1.058,SGLMALLOC,N,glheap_walk: 344196 bytes free, 17 blocks free, 2764 bytes alloc, 33 blocks alloc 1.358,HTT8,N,Updating parameter $DIVE to 4 1.675,HTT8,N,Writing NVRAM...done. 10.469,SSURF,N,Initializing data file 10.677,SSURF,N,Initializing log file 13.678,SSURF,N,Starting dive at 13s 13.762,SSURF,N,Leaving surface state 13.865,SDIVE,N,Entering dive state 15.436,SDIVE,N,start $GC,15,-1.15,-4.9,198,1976,2773,2649,0.0,0.0,0, ... 25.423,SSENSOR,N,A 22453ms 2.32m 288.5 #1 35.348,SSENSOR,N,A 32436ms 3.32m 288.5 #2 39.418,SMOTOR,N,MOTOR_DONE: no ticks 39.506,SMOTOR,N,GC TICKS/TIME: 919/925653 39.697,HVBD,N,Bleed completed from 152.33 cc (2711) to -1.72 cc (3339 [3424, 3255]) took 22.9 sec 0 mA (1919 mA peak) 15.0 Vmin 27.39 AD/sec 917 ticks 40.145,HVBD,N,TRACK: b: 3338/0 a: 3338/0 d: 13 o: 1 40.477,SDIVE,N,end $GC ,40,0.00,0.00,-22.92,0.000,16386,0.000,0.000,199,1977,3339,3424,3255,0,0,0,0,0,0,14.96,28.83,14.97 40.828,SDIVE,N,Exiting active in GCPHASE_VBD (2) after 2 samples, ret=FLARE_DEPTH_REACHED 41.967,SDIVE,N,start $GC,41,-1.15,-4.9,198,1976,3426,3255,3.3,-10.0,2, ... 45.706,SSENSOR,N,A 42460ms 4.32m 287.8 #3 49.588,SMOTOR,N,MOTOR_DONE: ticks: 3 max 24v: 2053.3mA avg 24v: 703.8mA minV 24v: 14.6V 49.745,SMOTOR,N,GC TICKS/TIME: 282/288143 49.929,HPITCH,N,Pitch completed from -7.82 cm (198) to -1.15 cm (2332) took 6.5 sec 122 mA (356 mA peak) 14.6 Vmin 329.58 AD/sec 259 ticks 50.371,HPITCH,N,TRACK: b: 2319/0 a: 2323/0 d: -6 o: 9 50.553,HVBD,N,Bleed completed from -2.21 cc (3341) to -4.91 cc (3352 [3439, 3266]) took 0.4 sec 0 mA (1903 mA peak) 14.8 Vmin 25.88 AD/sec 17 ticks 50.993,HVBD,N,TRACK: b: 3437/3266 a: 3438/3266 d: -87 o: -86 51.384,SDIVE,N,end $GC ,51,6.47,0.00,-0.43,0.000,18438,0.122,0.000,2332,1977,3352,3439,3266,0,0,0,0,0,0,14.61,13.49,14.76 51.729,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 55.933,SSENSOR,N,P 53638ms 5.45m 288.3 #4 65.933,SSENSOR,N,P 63638ms 6.50m 288.3 #5 75.932,SSENSOR,N,P 73638ms 7.49m 288.5 #6 86.217,SSENSOR,N,P 83638ms 8.49m 288.8 #7 95.932,SSENSOR,N,P 93638ms 9.52m 287.8 #8 105.938,SSENSOR,N,P 103638ms 10.55m 288.0 #9 107.771,SDIVE,N,turn rate during steady passive flight = -0.008 deg/s 107.908,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 108.111,HVBD,N,wObserved = -0.101 (9) pitchObserved = -20.000 109.318,SDIVE,N,start $GC,109,-1.15,-4.9,2332,1977,3444,3267,10.6,-10.1,9, ... 109.613,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 110.051,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 110.203,SMOTOR,N,GC TICKS/TIME: 12/14181 110.503,SDIVE,N,end $GC ,110,0.00,0.00,0.00,0.000,6,0.000,0.000,2332,1977,3355,3444,3267,0,0,0,0,0,0,14.98,15.00,14.99 110.844,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 115.940,SSENSOR,N,P 113638ms 11.47m 288.1 #10 125.939,SSENSOR,N,P 123638ms 12.48m 288.3 #11 135.939,SSENSOR,N,P 133638ms 13.47m 288.6 #12 145.938,SSENSOR,N,P 143638ms 14.52m 288.7 #13 156.222,SSENSOR,N,P 153638ms 15.52m 288.5 #14 165.937,SSENSOR,N,P 163638ms 16.57m 288.2 #15 167.776,SDIVE,N,turn rate during steady passive flight = -0.005 deg/s 167.913,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 168.116,HVBD,N,wObserved = -0.102 (15) pitchObserved = -20.000 169.252,SDIVE,N,start $GC,169,-1.15,-4.9,2332,1977,3444,3266,16.6,-10.2,15, ... 169.548,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 169.984,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 170.136,SMOTOR,N,GC TICKS/TIME: 12/14175 170.434,SDIVE,N,end $GC ,170,0.00,0.00,0.00,0.000,6,0.000,0.000,2333,1977,3355,3444,3266,0,0,0,0,0,0,15.00,15.01,15.00 170.775,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 175.937,SSENSOR,N,P 173638ms 17.57m 287.7 #16 185.938,SSENSOR,N,P 183639ms 18.56m 288.4 #17 195.938,SSENSOR,N,P 193638ms 19.55m 288.2 #18 205.940,SSENSOR,N,P 203638ms 20.60m 288.1 #19 215.939,SSENSOR,N,P 213638ms 21.60m 288.0 #20 226.200,SSENSOR,N,P 223638ms 22.62m 288.6 #21 227.151,HXPDR,N,ranging to bottom at 22.616222 meters 227.644,HXPDR,N,ping response: R--------- 228.739,SDIVE,N,turn rate during steady passive flight = 0.007 deg/s 228.875,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 229.076,HVBD,N,wObserved = -0.102 (21) pitchObserved = -20.000 230.260,SDIVE,N,start $GC,230,-1.15,-4.9,2332,1977,3444,3266,22.6,-10.2,21, ... 230.556,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 230.992,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 231.144,SMOTOR,N,GC TICKS/TIME: 12/14177 231.445,SDIVE,N,end $GC ,231,0.00,0.00,0.00,0.000,6,0.000,0.000,2332,1977,3355,3444,3267,0,0,0,0,0,0,14.98,14.99,14.99 231.789,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 235.937,SSENSOR,N,P 233638ms 23.64m 288.1 #22 245.940,SSENSOR,N,P 243638ms 24.65m 288.4 #23 246.891,HXPDR,N,ranging to bottom at 24.647364 meters 247.385,HXPDR,N,ping response: R--------- 255.940,SSENSOR,N,P 253638ms 25.75m 288.1 #24 265.940,SSENSOR,N,P 263638ms 26.76m 288.6 #25 266.889,HXPDR,N,ranging to bottom at 26.760828 meters 267.379,HXPDR,N,ping response: R--------- 276.222,SSENSOR,N,P 273638ms 27.85m 288.4 #26 285.937,SSENSOR,N,P 283638ms 28.87m 288.4 #27 286.883,HXPDR,N,ranging to bottom at 28.867760 meters 287.373,HXPDR,N,ping response: R--------- 288.465,SDIVE,N,turn rate during steady passive flight = -0.002 deg/s 288.602,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 288.805,HVBD,N,wObserved = -0.105 (27) pitchObserved = -20.000 289.968,SDIVE,N,start $GC,289,-1.15,-4.9,2332,1977,3444,3267,28.9,-10.5,27, ... 290.264,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 290.700,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 290.851,SMOTOR,N,GC TICKS/TIME: 12/14177 291.151,SDIVE,N,end $GC ,290,0.00,0.00,0.00,0.000,6,0.000,0.000,2332,1977,3355,3444,3267,0,0,0,0,0,0,14.99,15.00,15.00 291.492,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 295.938,SSENSOR,N,P 293638ms 29.83m 288.4 #28 306.237,SSENSOR,N,P 303638ms 30.68m 288.2 #29 307.186,HXPDR,N,ranging to bottom at 30.684521 meters 307.676,HXPDR,N,ping response: R--------- 308.728,SDIVE,N,Exiting passive after 2 samples, ret=TARGET_DEPTH_EXCEEDED 308.868,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 309.008,SDIVE,N,Entering apogee state 309.153,SDIVE,N,Going neutral at apogee at 30.68 meters 309.366,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 310.307,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 310.931,SMOTOR,N,GC TICKS/TIME: 31/33291 311.018,HROLL,N,done. 311.086,HROLL,N,Roll: No motion occurred. 311.180,SDIVE,N,entering active for apogee pump 312.261,SDIVE,N,start $GC,312,-0.30,0.0,2332,1977,3444,3266,30.7,-9.8,29, ... 315.404,SSENSOR,N,A 312451ms 29.80m 288.3 #30 318.724,SMOTOR,N,MOTOR_DONE: ticks: 80 max 24v: 4.6mA avg 24v: 3.1mA minV 24v: 14.9V 318.877,SMOTOR,N,GC TICKS/TIME: 236/242098 319.061,HPITCH,N,Pitch completed from -1.15 cm (2332) to -0.30 cm (2603) took 0.8 sec 135 mA (397 mA peak) 14.6 Vmin 338.75 AD/sec 32 ticks 319.506,HPITCH,N,TRACK: b: 2593/0 a: 2594/0 d: -5 o: 9 319.689,HVBD,N,Pump completed from -5.89 cc (3356) to 0.74 cc (3329 [3418, 3240]) took 3.0 sec 655 mA (2388 mA peak) 14.0 Vmin 8.93 AD/sec 121 ticks 320.152,HVBD,N,TRACK: b: 3422/3242 a: 3422/3243 d: -90 o: -93 320.574,SDIVE,N,end $GC ,320,0.80,0.00,3.03,0.655,10246,0.135,0.000,2603,1977,3329,3418,3240,0,0,0,0,0,0,14.57,14.73,14.00 320.944,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 321.110,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 321.250,SDIVE,N,Entering climb state 321.414,SDIVE,N,Going up from 29.80 meters ... VBDctl=5 322.577,SDIVE,N,start $GC,322,1.15,4.9,2603,1977,3419,3240,29.8,0.0,30, ... 325.393,SSENSOR,N,A 322448ms 28.79m 289.0 #31 328.633,SMOTOR,N,MOTOR_DONE: ticks: 79 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 328.786,SMOTOR,N,GC TICKS/TIME: 220/225851 328.970,HPITCH,N,Pitch completed from -0.30 cm (2603) to 1.11 cm (3056) took 1.4 sec 134 mA (395 mA peak) 14.6 Vmin 335.56 AD/sec 54 ticks 329.407,HPITCH,N,TRACK: b: 3048/0 a: 3049/0 d: -6 o: 7 329.591,HVBD,N,Pump completed from 0.74 cc (3329) to 5.64 cc (3309 [3399, 3219]) took 2.1 sec 317 mA (2570 mA peak) 13.7 Vmin 9.52 AD/sec 84 ticks 330.052,HVBD,N,TRACK: b: 3403/3222 a: 3403/3222 d: -91 o: -94 330.474,SDIVE,N,end $GC ,330,1.35,0.00,2.10,0.317,10246,0.134,0.000,3056,1977,3309,3399,3219,0,0,0,0,0,0,14.59,14.69,13.71 330.826,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 335.941,SSENSOR,N,P 333638ms 27.71m 288.1 #32 345.939,SSENSOR,N,P 343638ms 26.72m 287.9 #33 355.938,SSENSOR,N,P 353638ms 25.72m 288.0 #34 366.220,SSENSOR,N,P 363638ms 24.67m 288.0 #35 375.940,SSENSOR,N,P 373638ms 23.73m 288.8 #36 385.938,SSENSOR,N,P 383638ms 22.76m 288.3 #37 387.775,SDIVE,N,turn rate during steady passive flight = 0.012 deg/s 387.910,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 388.109,HVBD,N,wObserved = 0.099 (7) pitchObserved = 20.000 388.321,SDIVE,N,wObs=0.099, wDes_adj=0.100, changing VBD 4.9 -> 6.0 389.528,SDIVE,N,start $GC,389,1.15,6.0,3057,1977,3399,3219,22.8,9.9,37, ... 389.819,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 390.254,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 390.406,SMOTOR,N,GC TICKS/TIME: 12/14131 390.704,SDIVE,N,end $GC ,390,0.00,0.00,0.00,0.000,6,0.000,0.000,3057,1977,3308,3398,3219,0,0,0,0,0,0,15.02,15.02,15.02 391.045,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 395.937,SSENSOR,N,P 393638ms 21.76m 288.1 #38 405.938,SSENSOR,N,P 403638ms 20.75m 288.3 #39 415.939,SSENSOR,N,P 413638ms 19.74m 288.0 #40 425.938,SSENSOR,N,P 423638ms 18.75m 288.3 #41 436.246,SSENSOR,N,P 433638ms 17.76m 288.3 #42 445.939,SSENSOR,N,P 443638ms 16.67m 288.4 #43 447.766,SDIVE,N,turn rate during steady passive flight = 0.005 deg/s 447.901,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 448.104,HVBD,N,wObserved = 0.101 (13) pitchObserved = 20.000 449.237,SDIVE,N,start $GC,449,1.15,6.0,3057,1977,3398,3219,16.7,10.1,43, ... 449.529,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 449.966,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 450.117,SMOTOR,N,GC TICKS/TIME: 12/14137 450.418,SDIVE,N,end $GC ,450,0.00,0.00,0.00,0.000,6,0.000,0.000,3057,1977,3309,3399,3219,0,0,0,0,0,0,15.02,15.03,15.03 450.759,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 455.939,SSENSOR,N,P 453639ms 15.65m 287.7 #44 465.940,SSENSOR,N,P 463638ms 14.68m 287.9 #45 475.939,SSENSOR,N,P 473639ms 13.68m 288.5 #46 485.939,SSENSOR,N,P 483638ms 12.69m 288.4 #47 495.939,SSENSOR,N,P 493638ms 11.67m 287.9 #48 506.221,SSENSOR,N,P 503638ms 10.64m 288.2 #49 508.061,SDIVE,N,turn rate during steady passive flight = 0.011 deg/s 508.197,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 508.398,HVBD,N,wObserved = 0.101 (19) pitchObserved = 20.000 509.529,SDIVE,N,start $GC,509,1.15,6.0,3057,1977,3399,3219,10.6,10.1,49, ... 509.821,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 510.257,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 510.409,SMOTOR,N,GC TICKS/TIME: 12/14174 510.708,SDIVE,N,end $GC ,510,0.00,0.00,0.00,0.000,6,0.000,0.000,3057,1977,3308,3398,3219,0,0,0,0,0,0,15.04,15.04,15.04 511.051,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 515.932,SSENSOR,N,P 513638ms 9.63m 288.5 #50 525.932,SSENSOR,N,P 523638ms 8.71m 288.6 #51 535.930,SSENSOR,N,P 533638ms 7.68m 288.6 #52 545.932,SSENSOR,N,P 543638ms 6.67m 288.2 #53 555.933,SSENSOR,N,P 553638ms 5.67m 287.9 #54 565.930,SSENSOR,N,P 563638ms 4.69m 288.1 #55 567.766,SDIVE,N,turn rate during steady passive flight = -0.017 deg/s 567.905,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 568.107,HVBD,N,wObserved = 0.100 (25) pitchObserved = 20.000 569.232,SDIVE,N,start $GC,569,1.15,6.0,3057,1977,3399,3219,4.7,10.0,55, ... 569.523,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 569.957,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.1V 570.109,SMOTOR,N,GC TICKS/TIME: 12/14133 570.409,SDIVE,N,end $GC ,570,0.00,0.00,0.00,0.000,6,0.000,0.000,3057,1977,3309,3399,3219,0,0,0,0,0,0,15.04,15.05,15.05 570.749,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 575.932,SSENSOR,N,P 573638ms 3.61m 288.2 #56 585.932,SSENSOR,N,P 583638ms 2.61m 288.1 #57 595.928,SSENSOR,N,P 593638ms 1.57m 288.3 #58 597.708,SDIVE,N,Exiting passive after 3 samples, ret=SURFACE_DEPTH_REACHED 597.848,SDIVE,N,Leaving climb state due to SURFACE_DEPTH_REACHED 597.991,SDIVE,N,Entering surface coast state 598.157,SDIVE,N,Reached SD, Wo = 0.102798, 1 more points 606.241,SSENSOR,N,P 603638ms 0.57m 288.2 #59 608.035,SDIVE,N,Exiting passive after 1 samples, ret=CONTROL_FINISHED_OK 609.012,SSURF,N,D_SURF: T = 11.3249, S = 0, rho = 999.574 609.206,SDIVE,N,Leaving coast to surface state 609.326,SSURF,N,Entering surface state 609.436,SSURF,N,Starting surface maneuver... 609.882,SSURF,N,disabling surface maneuver aborts 611.108,SSURF,N,d= -0.66m 611.284,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 612.194,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.1 (0,0)MOTOR_DONE: ticks: 27 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 612.802,SMOTOR,N,GC TICKS/TIME: 30/32688 612.889,HROLL,N,done. 612.956,HROLL,N,Roll: No motion occurred. 613.209,HPITCH,N,Pitch commanded from 1.11 cm (3056) to -7.75 cm (222)... 614.121,HPITCH,N,0.7 cm (ad: 2917) mA=64 minV=15.0 (0,0)......... 619.821,HPITCH,N,-5.8 cm (ad: 852) mA=50 minV=15.0 (0,0)...MOTOR_DONE: ticks: 8 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 14.9V 622.156,SMOTOR,N,GC TICKS/TIME: 325/329118 622.246,HPITCH,N,done. 622.384,HPITCH,N,Pitch completed from 1.12 cm (3057) to -7.82 cm (197) took 7.8 sec 50 mA (343 mA peak) 14.8 Vmin 364.33 AD/sec 314 ticks 622.822,HPITCH,N,TRACK: b: 234/0 a: 229/0 d: 5 o: -32 623.079,HVBD,N,Pump commanded from 5.89 cc (3308) to 150.12 cc (2720)... 624.016,HVBD,N,6.1 cc (ad: 3307 [3395,3218]) mA=386 minV=15.0 (0,0)......... 629.741,HVBD,N,18.2 cc (ad: 3258 [3347,3167]) mA=189 minV=15.0 (0,0)......... 635.466,HVBD,N,30.7 cc (ad: 3207 [3295,3117]) mA=179 minV=15.0 (0,0)......... 641.166,HVBD,N,42.9 cc (ad: 3157 [3244,3068]) mA=174 minV=15.0 (0,0)......... 646.866,HVBD,N,55.4 cc (ad: 3106 [3190,3021]) mA=173 minV=15.0 (0,0)......... 652.566,HVBD,N,67.7 cc (ad: 3056 [3142,2968]) mA=171 minV=15.0 (0,0)......... 658.291,HVBD,N,80.7 cc (ad: 3003 [3088,2919]) mA=170 minV=15.0 (0,0)......... 664.016,HVBD,N,92.5 cc (ad: 2955 [3035,2872]) mA=169 minV=15.0 (0,0)......... 669.741,HVBD,N,105.0 cc (ad: 2904 [2983,2824]) mA=169 minV=15.0 (0,0)......... 675.466,HVBD,N,117.3 cc (ad: 2854 [2930,2777]) mA=168 minV=15.0 (0,0)......... 681.191,HVBD,N,129.5 cc (ad: 2804 [2872,2735]) mA=168 minV=15.0 (0,0)......... 686.916,HVBD,N,141.8 cc (ad: 2754 [2818,2687]) mA=168 minV=15.0 (0,0).......MOTOR_DONE: ticks: 9 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.8V 691.375,SMOTOR,N,GC TICKS/TIME: 2700/2703016 691.467,HVBD,N,done. 691.614,HVBD,N,Pump completed from 5.89 cc (3308) to 150.86 cc (2717 [2782, 2652]) took 67.2 sec 168 mA (1656 mA peak) 14.6 Vmin 8.79 AD/sec 2688 ticks 692.088,HVBD,N,TRACK: b: 2785/2656 a: 2786/2655 d: -66 o: -69 693.415,SSURF,N,Depth at end of surface maneuver = -0.679412 694.884,SSURF,N,Finished surface maneuver... 695.911,HTT8,N,TT8 state: Normal (2MHz); analog off; TPU TCR1 480000Hz, tick rate 40000Hz 696.079,SPOWER,N,All devices are off. 697.253,HBATT,N,24V batt pack voltage = 14.90V 697.390,HBATT,N,10V batt pack voltage = 14.73V 712.946,HGPS,N,Acquiring GPS fix (0,0,20) 715.007,HGPS,N,VGPS: no data received 716.736,HGPS,N,VVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVVA 752.001,HGPS,N,sync sentence $GPRMC,181757,A,5627.0945,N,00526.3995,W,000.0,000.0,011117,004.1,W*70 (k=33537)set 2017/11/01 18:17:58 752.195,HGPS,N,011117 181755 5627.0942 -526.3997 hdop=1.9 cog=0.0 sog=0.0 hpe=49.6 n=4 37/37 seconds 756.356,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0004kz.a... 759.106,SSYS,N,Capture file opened Compressing THISDIVE.DAT to sg0004dz.x... Compressing THISDIVE.LOG to sg0004lz.x... 763.102,HCF8,N,file 'sg0004dz.x00' opened... 763.254,HCF8,N,file 'sg0004dz.x00' has 1351 bytes, closed... 764.046,HCF8,N,file 'sg0004lz.x00' opened... 764.228,HCF8,N,file 'sg0004lz.x00' has 3096 bytes, closed... 764.792,SSURF,N,Collecting glider state 765.090,HBATT,N,24V batt pack voltage = 14.92V 765.227,HBATT,N,10V batt pack voltage = 14.76V 765.486,SDIVE,N,Measuring depth & angle for 1 sec....# done. 767.800,SDIVE,N,Measured depth: -0.67m angle: -7.34deg 768.137,SGLMALLOC,N,glheap_walk: 344104 bytes free, 14 blocks free, 2880 bytes alloc, 35 blocks alloc 768.265,SSURF,N,Trying call 0... 768.309,SSURF,N,Calling phone number: 88160000558 770.427,HPHONE,N,initializing RUDICS connection 800.883,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 800.994,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 801.178,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.329574 Wed Nov 1 18:02:21 2017 801.415,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 806.523,SSURF,N,Unable to login (-2)... 808.581,SSURF,N,Total NAK's: 0, timeouts: 0 808.637,SSURF,N,going to sleep.. 868.371,SGLMALLOC,N,glheap_walk: 344104 bytes free, 14 blocks free, 2880 bytes alloc, 35 blocks alloc 868.498,SSURF,N,Trying call 1... 868.542,SSURF,N,Calling phone number: 88160000558 870.662,HPHONE,N,initializing RUDICS connection 901.119,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 901.229,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 901.413,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.329574 Wed Nov 1 18:02:21 2017 932.157,HPHONE,N,Dialing succeeded 947.902,SSURF,N,Logged in... 950.249,SSURF,N,Sending cmd lsx -k -t150 cmdfile 954.406,SSURF,N,Receiving cmdfile... 956.270,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 958.878,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 961.488,SSURF,N,EOT: 0x4 received (1), secSize= 128... 961.894,SSURF,N,Received cmdfile 217 bytes 963.741,SSURF,N,Transmission succeeded... 963.822,HTT8,N,Updating parameter $MISSION to 2 963.895,HTT8,N,Updating parameter $SIM_W to 0.1 963.967,HTT8,N,Updating parameter $SIM_PITCH to -20 964.038,HTT8,N,Updating parameter $D_TGT to 30 964.104,HTT8,N,Updating parameter $T_DIVE to 10 964.172,HTT8,N,Updating parameter $T_MISSION to 15 964.243,HTT8,N,Updating parameter $KALMAN_USE to 2 964.315,HTT8,N,Updating parameter $SM_CC to 150 964.382,HTT8,N,Updating parameter $MAX_BUOY to 5 964.447,HTT8,N,Updating parameter $USE_BATHY to 0 964.521,HTT8,N,Updating parameter $C_VBD to 3332 964.594,HTT8,N,Updating parameter $C_PITCH to 2700 964.667,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 964.744,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 964.822,HTT8,N,Updating parameter $T_RSLEEP to 1 964.885,SDIVE,N,Parsed command: $GO 964.932,SDIVE,N,No recovery errors reported. Going to Dive. 965.101,HTT8,N,Writing NVRAM...done. 978.235,SSURF,N,Sending cmd lsx -k -t150 science 982.390,SSURF,N,Receiving science... 984.258,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 986.869,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 989.389,SSURF,N,SOH/STX: 0x1 received (1), secSize= 128... 991.908,SSURF,N,EOT: 0x4 received (1), secSize= 128... 992.343,SSURF,N,Received science 273 bytes 994.161,SSURF,N,Transmission succeeded... 994.318,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 994.431,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 994.554,SSURF,N,Sending cmd lrx -y -c -t150 sg0004lz.x00 996.889,SSURF,N,Sending sg0004lz.x00... 996.988,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 1001.604,SSURF,N,block: 2, size: 1024, blkSize: 1024, attempt: 1... 1006.284,SSURF,N,block: 3, size: 1024, blkSize: 1024, attempt: 1... 1011.144,SSURF,N,block: 4, size: 24, blkSize: 128, attempt: 1... 1013.033,SSURF,N,EOT sent ... 1015.823,SSURF,N,received ACK (attempt 0) 1018.438,SSURF,N,Transmission succeeded... 1018.541,SSURF,N,Sending cmd lrx -y -c -t150 sg0004dz.x00 1020.894,SSURF,N,Sending sg0004dz.x00... 1021.252,SSURF,N,block: 1, size: 1024, blkSize: 1024, attempt: 1... 1025.903,SSURF,N,block: 2, size: 327, blkSize: 1024, attempt: 1... 1030.493,SSURF,N,EOT sent ... 1033.282,SSURF,N,received ACK (attempt 0) 1041.097,HPHONE,N,No prompt after send complete echo [e] 1041.169,SSURF,N,Transmission succeeded... 1045.544,SSURF,N,logout... 1062.912,SSURF,N,Total NAK's: 0, timeouts: 0 1063.059,SGLMALLOC,N,glheap_walk: 344128 bytes free, 18 blocks free, 2808 bytes alloc, 33 blocks alloc 1063.243,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 1080.408,SDIVE,N,Measured depth: -0.69m angle: -7.24deg 1080.561,HGPS,N,Acquiring GPS fix (0,0,20) 1082.622,HGPS,N,VGPS: no data received 1084.358,HGPS,N,VVVVVVVVVVVVVVVVVVVA 1104.001,HGPS,N,sync sentence $GPRMC,182349,A,5627.0975,N,00526.3899,W,000.0,000.0,011117,004.1,W*76 (k=32693)set 2017/11/01 18:23:50 1104.196,HGPS,N,011117 182348 5627.0986 -526.3880 hdop=1.8 cog=0.0 sog=0.0 hpe=137.2 n=4 22/22 seconds 1108.273,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571783.00 meters 1108.470,SDIVE,N,Grid depth = 30.0, target depth = 30.0 1108.626,SDIVE,N,wDesired = -0.100 1109.285,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 1138.425,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 1138.673,SDIVE,N,speed limits = 0.17, 0.18 1138.964,SDIVE,N,DesiredHead = 291.61, range = 571783.0, glide angle -28.63 1139.852,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 1140.831,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 15.0V 1141.454,SMOTOR,N,GC TICKS/TIME: 31/33205 1141.542,HROLL,N,done. 1141.611,HROLL,N,Roll: No motion occurred. 1141.820,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.997,SSURF,N,Dive 4 started Wed Nov 1 18:24:27 2017 (1509560667) 1.229,SUSR,N,Normal Heap: 0+20479 bytes 1.384,SGLMALLOC,N,glheap_walk: 344128 bytes free, 18 blocks free, 2808 bytes alloc, 33 blocks alloc 1.683,HTT8,N,Updating parameter $DIVE to 5 2.004,HTT8,N,Writing NVRAM...done. 10.795,SSURF,N,Initializing data file 10.950,SSURF,N,Initializing log file 13.881,SSURF,N,Starting dive at 13s 13.964,SSURF,N,Leaving surface state 14.068,SDIVE,N,Entering dive state 15.632,SDIVE,N,start $GC,15,-1.15,-4.9,199,1977,2773,2649,0.0,0.0,0, ... 25.744,SSENSOR,N,A 22133ms 2.18m 288.3 #1 35.369,SSENSOR,N,A 32137ms 3.17m 288.6 #2 39.433,SMOTOR,N,MOTOR_DONE: no ticks 39.521,SMOTOR,N,GC TICKS/TIME: 912/918429 39.716,HVBD,N,Bleed completed from 152.33 cc (2711) to -2.45 cc (3342 [3427, 3258]) took 22.8 sec 0 mA (1919 mA peak) 15.0 Vmin 27.74 AD/sec 910 ticks 40.171,HVBD,N,TRACK: b: 3341/0 a: 3341/0 d: 10 o: 1 40.502,SDIVE,N,end $GC ,40,0.00,0.00,-22.75,0.000,16386,0.000,0.000,199,1977,3342,3427,3258,0,0,0,0,0,0,14.96,28.83,14.97 40.836,SDIVE,N,Exiting active in GCPHASE_VBD (2) after 2 samples, ret=FLARE_DEPTH_REACHED 41.965,SDIVE,N,start $GC,41,-1.15,-4.9,199,1977,3428,3258,3.2,-9.9,2, ... 45.403,SSENSOR,N,A 42139ms 4.21m 288.9 #3 49.153,SMOTOR,N,MOTOR_DONE: ticks: 5 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 14.8V 49.303,SMOTOR,N,GC TICKS/TIME: 266/272012 49.485,HPITCH,N,Pitch completed from -7.82 cm (199) to -1.16 cm (2328) took 6.4 sec 122 mA (353 mA peak) 14.6 Vmin 330.08 AD/sec 258 ticks 49.928,HPITCH,N,TRACK: b: 2316/0 a: 2320/0 d: -3 o: 8 50.285,SDIVE,N,end $GC ,50,6.45,0.00,0.00,0.000,2054,0.122,0.000,2328,1977,3343,3429,3258,0,0,0,0,0,0,14.62,14.78,14.74 50.636,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 55.934,SSENSOR,N,P 53324ms 5.25m 288.4 #4 65.933,SSENSOR,N,P 63324ms 6.24m 288.2 #5 75.933,SSENSOR,N,P 73324ms 7.22m 288.7 #6 86.166,SSENSOR,N,P 83324ms 8.16m 288.4 #7 95.933,SSENSOR,N,P 93324ms 9.16m 288.1 #8 105.939,SSENSOR,N,P 103324ms 10.13m 288.6 #9 107.777,SDIVE,N,turn rate during steady passive flight = 0.012 deg/s 107.913,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 108.114,HVBD,N,wObserved = -0.097 (9) pitchObserved = -20.000 108.330,SDIVE,N,wObs=-0.097, wDes_adj=-0.100, changing VBD -4.9 -> -7.7, actual=-4.9 (MAX_BUOY) 109.668,SDIVE,N,start $GC,109,-1.15,-4.9,2328,1977,3432,3258,10.1,-9.7,9, ... 109.961,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 110.396,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 110.548,SMOTOR,N,GC TICKS/TIME: 12/14132 110.848,SDIVE,N,end $GC ,110,0.00,0.00,0.00,0.000,6,0.000,0.000,2327,1977,3345,3432,3258,0,0,0,0,0,0,14.99,14.99,14.99 111.189,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 115.939,SSENSOR,N,P 113324ms 11.09m 288.5 #10 125.940,SSENSOR,N,P 123324ms 12.00m 288.2 #11 135.938,SSENSOR,N,P 133324ms 13.00m 288.0 #12 145.938,SSENSOR,N,P 143324ms 13.92m 288.0 #13 156.170,SSENSOR,N,P 153324ms 14.88m 288.2 #14 165.939,SSENSOR,N,P 163324ms 15.87m 288.2 #15 167.776,SDIVE,N,turn rate during steady passive flight = 0.001 deg/s 167.912,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 168.112,HVBD,N,wObserved = -0.096 (15) pitchObserved = -20.000 168.330,SDIVE,N,wObs=-0.096, wDes_adj=-0.100, changing VBD -4.9 -> -8.8, actual=-4.9 (MAX_BUOY) 169.644,SDIVE,N,start $GC,169,-1.15,-4.9,2328,1977,3433,3258,15.9,-9.6,15, ... 169.938,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 170.375,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 170.526,SMOTOR,N,GC TICKS/TIME: 12/14131 170.825,SDIVE,N,end $GC ,170,0.00,0.00,0.00,0.000,6,0.000,0.000,2328,1976,3345,3433,3258,0,0,0,0,0,0,15.00,15.01,15.00 171.166,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 175.939,SSENSOR,N,P 173324ms 16.88m 288.2 #16 185.937,SSENSOR,N,P 183324ms 18.02m 288.4 #17 195.937,SSENSOR,N,P 193324ms 19.00m 288.1 #18 205.939,SSENSOR,N,P 203324ms 20.00m 288.5 #19 215.938,SSENSOR,N,P 213324ms 20.98m 288.5 #20 226.174,SSENSOR,N,P 223324ms 22.02m 288.0 #21 227.121,HXPDR,N,ranging to bottom at 22.023840 meters 227.611,HXPDR,N,ping response: R--------- 228.709,SDIVE,N,turn rate during steady passive flight = -0.012 deg/s 228.846,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 229.047,HVBD,N,wObserved = -0.100 (21) pitchObserved = -20.000 229.266,SDIVE,N,wObs=-0.100, wDes_adj=-0.100, changing VBD -4.9 -> -4.9, actual=-4.9 (MAX_BUOY) 230.627,SDIVE,N,start $GC,230,-1.15,-4.9,2328,1977,3434,3258,22.0,-10.0,21, ... 230.924,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 231.358,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 231.510,SMOTOR,N,GC TICKS/TIME: 12/14129 231.810,SDIVE,N,end $GC ,231,0.00,0.00,0.00,0.000,6,0.000,0.000,2329,1977,3345,3433,3258,0,0,0,0,0,0,14.99,15.00,15.00 232.154,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 235.940,SSENSOR,N,P 233324ms 22.98m 287.7 #22 245.938,SSENSOR,N,P 243324ms 24.00m 288.3 #23 246.889,HXPDR,N,ranging to bottom at 24.004534 meters 247.379,HXPDR,N,ping response: R--------- 255.937,SSENSOR,N,P 253324ms 25.00m 287.9 #24 265.938,SSENSOR,N,P 263324ms 25.97m 287.9 #25 275.939,SSENSOR,N,P 273324ms 26.94m 287.9 #26 276.892,HXPDR,N,ranging to bottom at 26.941982 meters 277.385,HXPDR,N,ping response: R--------- 285.940,SSENSOR,N,P 283324ms 27.93m 288.3 #27 287.775,SDIVE,N,turn rate during steady passive flight = -0.001 deg/s 287.912,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 288.111,HVBD,N,wObserved = -0.098 (27) pitchObserved = -20.000 288.328,SDIVE,N,wObs=-0.098, wDes_adj=-0.100, changing VBD -4.9 -> -7.0, actual=-4.9 (MAX_BUOY) 289.641,SDIVE,N,start $GC,289,-1.15,-4.9,2328,1977,3434,3258,27.9,-9.8,27, ... 289.936,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 290.373,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 290.524,SMOTOR,N,GC TICKS/TIME: 12/14177 290.824,SDIVE,N,end $GC ,290,0.00,0.00,0.00,0.000,6,0.000,0.000,2328,1977,3346,3434,3258,0,0,0,0,0,0,15.02,15.02,15.02 291.165,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 295.937,SSENSOR,N,P 293324ms 28.95m 288.0 #28 296.885,HXPDR,N,ranging to bottom at 28.952717 meters 297.377,HXPDR,N,ping response: R--------- 306.172,SSENSOR,N,P 303324ms 29.94m 287.9 #29 315.938,SSENSOR,N,P 313324ms 30.86m 288.4 #30 316.888,HXPDR,N,ranging to bottom at 30.861605 meters 317.378,HXPDR,N,ping response: R--------- 318.432,SDIVE,N,Exiting passive after 3 samples, ret=TARGET_DEPTH_EXCEEDED 318.572,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 318.713,SDIVE,N,Entering apogee state 318.858,SDIVE,N,Going neutral at apogee at 30.86 meters 319.071,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 320.090,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 320.710,SMOTOR,N,GC TICKS/TIME: 31/33157 320.797,HROLL,N,done. 320.864,HROLL,N,Roll: No motion occurred. 320.959,SDIVE,N,entering active for apogee pump 322.024,SDIVE,N,start $GC,321,-0.30,0.0,2328,1977,3434,3258,30.9,-9.9,30, ... 325.393,SSENSOR,N,A 322134ms 29.90m 288.2 #31 328.546,SMOTOR,N,MOTOR_DONE: ticks: 129 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 328.700,SMOTOR,N,GC TICKS/TIME: 239/244353 328.883,HPITCH,N,Pitch completed from -1.16 cm (2329) to -0.30 cm (2603) took 0.8 sec 135 mA (392 mA peak) 14.6 Vmin 342.50 AD/sec 32 ticks 329.328,HPITCH,N,TRACK: b: 2593/0 a: 2593/0 d: -4 o: 10 329.513,HVBD,N,Pump completed from -3.68 cc (3347) to 0.74 cc (3329 [3414, 3244]) took 1.9 sec 200 mA (1885 mA peak) 14.6 Vmin 9.60 AD/sec 75 ticks 329.970,HVBD,N,TRACK: b: 3415/3246 a: 3415/3246 d: -83 o: -86 330.396,SDIVE,N,end $GC ,330,0.80,0.00,1.88,0.200,10246,0.135,0.000,2603,1977,3329,3414,3244,0,0,0,0,0,0,14.60,14.66,14.55 330.745,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 330.910,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 331.050,SDIVE,N,Entering climb state 331.215,SDIVE,N,Going up from 29.90 meters ... VBDctl=5 332.343,SDIVE,N,start $GC,332,1.15,4.9,2603,1977,3414,3244,29.9,0.0,31, ... 335.408,SSENSOR,N,A 332142ms 28.97m 289.0 #32 338.598,SMOTOR,N,MOTOR_DONE: ticks: 86 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 338.751,SMOTOR,N,GC TICKS/TIME: 228/233740 338.933,HPITCH,N,Pitch completed from -0.30 cm (2603) to 1.10 cm (3053) took 1.4 sec 132 mA (395 mA peak) 14.6 Vmin 333.33 AD/sec 54 ticks 339.372,HPITCH,N,TRACK: b: 3046/0 a: 3047/0 d: -4 o: 6 339.557,HVBD,N,Pump completed from 0.49 cc (3330) to 5.64 cc (3309 [3395, 3223]) took 2.1 sec 336 mA (2635 mA peak) 13.8 Vmin 9.88 AD/sec 85 ticks 340.018,HVBD,N,TRACK: b: 3398/3226 a: 3398/3227 d: -86 o: -89 340.449,SDIVE,N,end $GC ,340,1.35,0.00,2.12,0.336,10246,0.132,0.000,3053,1977,3309,3395,3223,0,0,0,0,0,0,14.56,14.70,13.78 340.822,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 345.938,SSENSOR,N,P 343324ms 27.85m 288.8 #33 355.939,SSENSOR,N,P 353324ms 26.82m 288.3 #34 365.937,SSENSOR,N,P 363324ms 25.80m 288.5 #35 376.169,SSENSOR,N,P 373324ms 24.89m 288.3 #36 385.940,SSENSOR,N,P 383323ms 23.84m 288.6 #37 395.939,SSENSOR,N,P 393324ms 22.84m 288.2 #38 397.773,SDIVE,N,turn rate during steady passive flight = -0.004 deg/s 397.910,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 398.110,HVBD,N,wObserved = 0.099 (7) pitchObserved = 20.000 398.323,SDIVE,N,wObs=0.099, wDes_adj=0.100, changing VBD 4.9 -> 5.6 399.586,SDIVE,N,start $GC,399,1.15,5.6,3054,1977,3396,3223,22.8,9.9,38, ... 399.877,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 400.312,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 400.464,SMOTOR,N,GC TICKS/TIME: 12/14131 400.765,SDIVE,N,end $GC ,400,0.00,0.00,0.00,0.000,6,0.000,0.000,3054,1977,3309,3396,3223,0,0,0,0,0,0,15.02,15.03,15.03 401.105,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 405.939,SSENSOR,N,P 403324ms 21.85m 288.5 #39 415.937,SSENSOR,N,P 413324ms 20.85m 287.9 #40 425.940,SSENSOR,N,P 423324ms 19.85m 288.0 #41 435.936,SSENSOR,N,P 433324ms 18.88m 288.1 #42 446.170,SSENSOR,N,P 443324ms 17.88m 288.2 #43 455.938,SSENSOR,N,P 453324ms 17.00m 288.5 #44 457.767,SDIVE,N,turn rate during steady passive flight = 0.020 deg/s 457.902,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 458.101,HVBD,N,wObserved = 0.097 (13) pitchObserved = 20.000 458.315,SDIVE,N,wObs=0.097, wDes_adj=0.100, changing VBD 5.6 -> 9.0 459.589,SDIVE,N,start $GC,459,1.16,9.0,3054,1977,3396,3223,17.0,9.7,44, ... 461.655,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 462.131,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 462.283,SMOTOR,N,GC TICKS/TIME: 83/86014 462.465,HVBD,N,Pump completed from 5.40 cc (3310) to 9.57 cc (3293 [3380, 3207]) took 1.8 sec 241 mA (1654 mA peak) 14.6 Vmin 9.58 AD/sec 71 ticks 462.920,HVBD,N,TRACK: b: 3382/3209 a: 3382/3209 d: -87 o: -89 463.286,SDIVE,N,end $GC ,463,0.00,0.00,1.77,0.241,8198,0.000,0.000,3054,1977,3293,3380,3207,0,0,0,0,0,0,15.04,14.79,14.62 463.631,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 466.332,SSENSOR,N,P 463484ms 15.99m 288.5 #45 476.718,SSENSOR,N,P 474104ms 14.83m 288.6 #46 486.719,SSENSOR,N,P 484104ms 13.80m 288.0 #47 496.718,SSENSOR,N,P 494104ms 12.78m 288.2 #48 506.720,SSENSOR,N,P 504105ms 11.77m 287.8 #49 516.718,SSENSOR,N,P 514104ms 10.77m 288.0 #50 518.561,SDIVE,N,turn rate during steady passive flight = -0.020 deg/s 518.698,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 518.900,HVBD,N,wObserved = 0.101 (19) pitchObserved = 20.000 520.132,SDIVE,N,start $GC,519,1.16,9.0,3054,1977,3379,3206,10.8,10.1,50, ... 520.424,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 520.859,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 521.011,SMOTOR,N,GC TICKS/TIME: 12/14132 521.310,SDIVE,N,end $GC ,521,0.00,0.00,0.00,0.000,6,0.000,0.000,3054,1977,3292,3379,3206,0,0,0,0,0,0,15.04,15.04,15.04 521.654,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 526.713,SSENSOR,N,P 524104ms 9.75m 288.2 #51 536.945,SSENSOR,N,P 534104ms 8.71m 288.0 #52 546.712,SSENSOR,N,P 544104ms 7.67m 288.4 #53 556.712,SSENSOR,N,P 554105ms 6.86m 288.2 #54 566.715,SSENSOR,N,P 564105ms 5.85m 288.5 #55 576.714,SSENSOR,N,P 574105ms 4.87m 288.2 #56 578.552,SDIVE,N,turn rate during steady passive flight = 0.008 deg/s 578.687,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 578.886,HVBD,N,wObserved = 0.095 (25) pitchObserved = 20.000 579.099,SDIVE,N,wObs=0.095, wDes_adj=0.100, changing VBD 9.0 -> 14.4 580.327,SDIVE,N,start $GC,580,1.17,14.4,3054,1977,3379,3206,4.9,9.5,56, ... 585.642,SSENSOR,N,A 582399ms 4.08m 287.9 #57 588.759,SMOTOR,N,MOTOR_DONE: ticks: 208 max 24v: 13.8mA avg 24v: 3.1mA minV 24v: 15.0V 588.914,SMOTOR,N,GC TICKS/TIME: 316/321354 589.110,HVBD,N,Pump completed from 9.81 cc (3292) to 15.45 cc (3269 [3356, 3183]) took 2.6 sec 589 mA (2681 mA peak) 14.0 Vmin 8.76 AD/sec 105 ticks 589.576,HVBD,N,TRACK: b: 3360/3186 a: 3361/3186 d: -88 o: -92 589.949,SDIVE,N,end $GC ,589,0.00,0.00,2.62,0.589,8198,0.000,0.000,3055,1977,3269,3356,3183,0,0,0,0,0,0,15.04,14.74,14.02 590.338,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 596.714,SSENSOR,N,P 594104ms 2.85m 288.3 #58 606.710,SSENSOR,N,P 604104ms 1.81m 288.2 #59 608.508,SDIVE,N,Exiting passive after 2 samples, ret=SURFACE_DEPTH_REACHED 608.648,SDIVE,N,Leaving climb state due to SURFACE_DEPTH_REACHED 608.791,SDIVE,N,Entering surface coast state 608.957,SDIVE,N,Reached SD, Wo = 0.100992, 1 more points 616.714,SSENSOR,N,P 614104ms 0.78m 288.5 #60 618.499,SDIVE,N,Exiting passive after 1 samples, ret=CONTROL_FINISHED_OK 619.471,SSURF,N,D_SURF: T = 10.471, S = 0, rho = 999.659 619.665,SDIVE,N,Leaving coast to surface state 619.785,SSURF,N,Entering surface state 619.895,SSURF,N,Starting surface maneuver... 620.230,SSURF,N,disabling surface maneuver aborts 621.454,SSURF,N,d= -0.67m 621.631,HROLL,N,Roll commanded from -0.65 deg (1977) to 0.00 deg (2000)... 622.522,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 623.142,SMOTOR,N,GC TICKS/TIME: 31/33161 623.229,HROLL,N,done. 623.296,HROLL,N,Roll: No motion occurred. 623.547,HPITCH,N,Pitch commanded from 1.11 cm (3054) to -7.75 cm (222)... 624.439,HPITCH,N,0.7 cm (ad: 2914) mA=64 minV=15.0 (0,0)......... 630.114,HPITCH,N,-5.8 cm (ad: 857) mA=50 minV=15.0 (0,0)...MOTOR_DONE: ticks: 7 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 14.9V 632.447,SMOTOR,N,GC TICKS/TIME: 324/328019 632.537,HPITCH,N,done. 632.676,HPITCH,N,Pitch completed from 1.10 cm (3053) to -7.83 cm (195) took 7.8 sec 49 mA (346 mA peak) 14.8 Vmin 364.08 AD/sec 314 ticks 633.112,HPITCH,N,TRACK: b: 231/0 a: 227/0 d: 7 o: -32 633.374,HVBD,N,Pump commanded from 15.70 cc (3268) to 150.12 cc (2720)... 634.293,HVBD,N,15.9 cc (ad: 3267 [3351,3181]) mA=380 minV=15.0 (0,0)......... 639.993,HVBD,N,28.0 cc (ad: 3218 [3304,3130]) mA=190 minV=15.0 (0,0)......... 645.718,HVBD,N,40.5 cc (ad: 3167 [3253,3080]) mA=179 minV=15.0 (0,0)......... 651.443,HVBD,N,52.7 cc (ad: 3117 [3201,3030]) mA=175 minV=15.0 (0,0)......... 657.143,HVBD,N,65.2 cc (ad: 3066 [3149,2982]) mA=173 minV=15.0 (0,0)......... 662.843,HVBD,N,77.5 cc (ad: 3016 [3099,2930]) mA=172 minV=15.0 (0,0)......... 668.568,HVBD,N,90.0 cc (ad: 2965 [3047,2881]) mA=171 minV=15.0 (0,0)......... 674.318,HVBD,N,102.0 cc (ad: 2916 [2995,2835]) mA=170 minV=15.0 (0,0)......... 680.043,HVBD,N,114.6 cc (ad: 2865 [2941,2788]) mA=169 minV=15.0 (0,0)......... 685.768,HVBD,N,126.8 cc (ad: 2815 [2885,2744]) mA=169 minV=15.0 (0,0)......... 691.493,HVBD,N,139.1 cc (ad: 2765 [2829,2700]) mA=168 minV=15.0 (0,0)......... 697.193,HVBD,N,151.1 cc (ad: 2716 [2782,2651]) mA=168 minV=14.6 (0,0)MOTOR_DONE: ticks: 36 max 24v: 4.6mA avg 24v: 3.1mA minV 24v: 14.9V 697.923,SMOTOR,N,GC TICKS/TIME: 2551/2553945 698.016,HVBD,N,done. 698.172,HVBD,N,Pump completed from 15.45 cc (3269) to 151.10 cc (2716 [2781, 2651]) took 62.8 sec 168 mA (1692 mA peak) 14.6 Vmin 8.81 AD/sec 2512 ticks 698.645,HVBD,N,TRACK: b: 2786/2655 a: 2786/2655 d: -66 o: -70 699.976,SSURF,N,Depth at end of surface maneuver = -0.575886 701.499,SSURF,N,Finished surface maneuver... 702.534,HTT8,N,TT8 state: Normal (2MHz); analog off; TPU TCR1 480000Hz, tick rate 40000Hz 702.702,SPOWER,N,All devices are off. 703.878,HBATT,N,24V batt pack voltage = 14.90V 704.014,HBATT,N,10V batt pack voltage = 14.74V 719.570,HGPS,N,Acquiring GPS fix (0,0,20) 721.630,HGPS,N,VGPS: no data received 723.384,HGPS,N,VVVVVVVVVVVVVVVVVVVVA 743.001,HGPS,N,sync sentence $GPRMC,183649,A,5627.0919,N,00526.4193,W,000.0,000.0,011117,004.1,W*7C (k=36215)set 2017/11/01 18:36:50 743.195,HGPS,N,011117 183648 5627.0923 -526.4182 hdop=1.7 cog=0.0 sog=0.0 hpe=54.8 n=4 23/23 seconds 747.308,SSYS,N,Capture file closed Compressing THISDIVE.KAP to sg0005kz.a... 750.207,SSYS,N,Capture file opened Compressing THISDIVE.DAT to sg0005dz.x... Compressing THISDIVE.LOG to sg0005lz.x... 754.300,HCF8,N,file 'sg0005dz.x00' opened... 754.452,HCF8,N,file 'sg0005dz.x00' has 1378 bytes, closed... 755.303,HCF8,N,file 'sg0005lz.x00' opened... 755.529,HCF8,N,file 'sg0005lz.x00' has 3147 bytes, closed... 756.097,SSURF,N,Collecting glider state 756.395,HBATT,N,24V batt pack voltage = 14.92V 756.532,HBATT,N,10V batt pack voltage = 14.76V 756.791,SDIVE,N,Measuring depth & angle for 1 sec....# done. 759.107,SDIVE,N,Measured depth: -0.64m angle: -7.29deg 759.443,SGLMALLOC,N,glheap_walk: 344088 bytes free, 12 blocks free, 2944 bytes alloc, 35 blocks alloc 759.570,SSURF,N,Trying call 0... 759.614,SSURF,N,Calling phone number: 88160000558 761.731,HPHONE,N,initializing RUDICS connection 792.201,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 792.312,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 792.495,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.033066 -5.394188 Wed Nov 1 18:20:51 2017 861.880,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 866.988,SSURF,N,Unable to login (-2)... 869.046,SSURF,N,Total NAK's: 0, timeouts: 0 869.103,SSURF,N,going to sleep.. 929.371,SGLMALLOC,N,glheap_walk: 344088 bytes free, 12 blocks free, 2944 bytes alloc, 35 blocks alloc 929.499,SSURF,N,Trying call 1... 929.543,SSURF,N,Calling phone number: 88160000558 931.659,HPHONE,N,initializing RUDICS connection 957.080,HPHONE,N,Phone registered 959.374,HPHONE,N,Iridium signal strength: 3 after 5 queries 959.451,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 959.634,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.335609 Wed Nov 1 18:40:17 2017 988.136,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 993.243,SSURF,N,Unable to login (-2)... 995.301,SSURF,N,Total NAK's: 0, timeouts: 0 995.358,SSURF,N,going to sleep.. 1055.371,SGLMALLOC,N,glheap_walk: 344088 bytes free, 12 blocks free, 2944 bytes alloc, 35 blocks alloc 1055.825,SSURF,N,Trying call 2... 1055.870,SSURF,N,Calling phone number: 88160000558 1057.988,HPHONE,N,initializing RUDICS connection 1088.466,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1088.578,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 1088.763,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.400295 Wed Nov 1 18:40:35 2017 1131.041,HPHONE,N,Dialing succeeded 1255.373,SSURF,N,Logged in... 1260.435,SSURF,N,No prompt before lsx cmdfile [] (call dropped?), skipping xfer 1260.561,HTT8,N,Updating parameter $MISSION to 2 1260.636,HTT8,N,Updating parameter $SIM_W to 0.1 1260.708,HTT8,N,Updating parameter $SIM_PITCH to -20 1260.781,HTT8,N,Updating parameter $D_TGT to 30 1260.848,HTT8,N,Updating parameter $T_DIVE to 10 1260.917,HTT8,N,Updating parameter $T_MISSION to 15 1260.989,HTT8,N,Updating parameter $KALMAN_USE to 2 1261.062,HTT8,N,Updating parameter $SM_CC to 150 1261.130,HTT8,N,Updating parameter $MAX_BUOY to 5 1261.196,HTT8,N,Updating parameter $USE_BATHY to 0 1261.272,HTT8,N,Updating parameter $C_VBD to 3332 1261.345,HTT8,N,Updating parameter $C_PITCH to 2700 1261.420,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 1261.498,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 1261.577,HTT8,N,Updating parameter $T_RSLEEP to 1 1261.641,SDIVE,N,Parsed command: $GO 1261.690,SDIVE,N,No recovery errors reported. Going to Dive. 1261.859,HTT8,N,Writing NVRAM...done. 1277.785,SSURF,N,No prompt before lsx science [] (call dropped?), skipping xfer 1277.987,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 1278.102,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 1278.226,SSURF,N,Sending cmd lrx -y -c -t150 sg0005lz.x00 1293.321,HPHONE,N,basestation not ready to receive [] 1293.397,SSURF,N,Problems transferring files (send=1/rcv=2)... 1303.510,SSURF,N,logout... 1316.572,SSURF,N,Total NAK's: 0, timeouts: 0 1316.630,SSURF,N,going to sleep.. 1376.371,SGLMALLOC,N,glheap_walk: 344052 bytes free, 15 blocks free, 2908 bytes alloc, 35 blocks alloc 1376.855,SSURF,N,Trying call 3... 1376.900,SSURF,N,Calling phone number: 88160000558 1379.018,HPHONE,N,initializing RUDICS connection 1409.506,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1409.617,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 1409.802,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.458788 Wed Nov 1 18:43:14 2017 1410.047,HPHONE,N,Dialing failed: ret 1, response ATDT0088160000558 NO CARRIER 1415.156,SSURF,N,Unable to login (-2)... 1417.216,SSURF,N,Total NAK's: 0, timeouts: 0 1417.274,SSURF,N,going to sleep.. 1477.372,SGLMALLOC,N,glheap_walk: 344028 bytes free, 16 blocks free, 2908 bytes alloc, 35 blocks alloc 1477.501,SSURF,N,Trying call 4... 1477.546,SSURF,N,Calling phone number: 88160000558 1479.663,HPHONE,N,initializing RUDICS connection 1510.153,HPHONE,N,Registration check failed after 7 queries - signal strength not checked 1510.264,HPHONE,N,cnt_NoComm:0 callCycle:0 smsLastCallCycle:-1 1510.449,HPHONE,N,Iridium geolocation (Warning: Potentially low accuracy): 56.097450 -5.400295 Wed Nov 1 18:49:33 2017 1537.146,HPHONE,N,Dialing succeeded 1560.120,SSURF,N,Got another login: prompt [], restarting login sequence 1617.219,SSURF,N,Logged in... 1617.582,SSURF,N,Sending cmd lsx -k -t150 cmdfile 1621.733,SSURF,N,Receiving cmdfile... 1629.786,SSURF,N,Transmission failed... 1629.865,HTT8,N,Updating parameter $MISSION to 2 1629.939,HTT8,N,Updating parameter $SIM_W to 0.1 1630.012,HTT8,N,Updating parameter $SIM_PITCH to -20 1630.084,HTT8,N,Updating parameter $D_TGT to 30 1630.152,HTT8,N,Updating parameter $T_DIVE to 10 1630.220,HTT8,N,Updating parameter $T_MISSION to 15 1630.293,HTT8,N,Updating parameter $KALMAN_USE to 2 1630.366,HTT8,N,Updating parameter $SM_CC to 150 1630.434,HTT8,N,Updating parameter $MAX_BUOY to 5 1630.500,HTT8,N,Updating parameter $USE_BATHY to 0 1630.575,HTT8,N,Updating parameter $C_VBD to 3332 1630.649,HTT8,N,Updating parameter $C_PITCH to 2700 1630.723,HTT8,N,Updating parameter $C_ROLL_DIVE to 2000 1630.802,HTT8,N,Updating parameter $C_ROLL_CLIMB to 2000 1631.192,HTT8,N,Updating parameter $T_RSLEEP to 1 1631.256,SDIVE,N,Parsed command: $GO 1631.305,SDIVE,N,No recovery errors reported. Going to Dive. 1631.475,HTT8,N,Writing NVRAM...done. 1647.402,SSURF,N,No prompt before lsx science [ NO CARRIER ] (call dropped?), skipping xfer 1647.623,SSENSOR,N,NOTE: Device in slot 2 (WL_BBFL2) not sampled at depth 1000.0 meters. 1647.738,SSENSOR,N,NOTE: Device in slot 3 (AA4831) not sampled at depth 1000.0 meters. 1647.861,SSURF,N,Sending cmd lrx -y -c -t150 sg0005lz.x00 1662.958,HPHONE,N,basestation not ready to receive [] 1663.034,SSURF,N,Problems transferring files (send=1/rcv=2)... 1673.147,SSURF,N,logout... 1686.218,SSURF,N,Total NAK's: 0, timeouts: 0 1686.283,HTT8,N,Updating parameter $SM_CC to 694.67828 1686.379,HTT8,N,Writing NVRAM...done. 1694.536,SSURF,N,N_NOCOMM reached; will pump to 694.68 CC... 1694.702,SGLMALLOC,N,glheap_walk: 344164 bytes free, 18 blocks free, 2772 bytes alloc, 33 blocks alloc 1694.887,SDIVE,N,Measuring depth & angle for 10 sec....#.#.#.#.#.#.#.#.#.# done. 1712.102,SDIVE,N,Measured depth: -0.68m angle: -7.25deg 1712.255,HGPS,N,Acquiring GPS fix (0,0,20) 1714.315,HGPS,N,VGPS: no data received 1716.085,HGPS,N,VVVVVVVVVVVA 1730.001,HGPS,N,sync sentence $GPRMC,185316,A,5627.0986,N,00526.4312,W,000.0,000.0,011117,004.1,W*78 (k=33384)set 2017/11/01 18:53:17 1730.195,HGPS,N,011117 185314 5627.0977 -526.4302 hdop=1.6 cog=0.0 sog=0.0 hpe=52.3 n=4 15/15 seconds 1734.040,SDIVE,N,Target [EAST] bearing 287.51 degT, range 571744.00 meters 1734.237,SDIVE,N,Grid depth = 30.0, target depth = 30.0 1734.393,SDIVE,N,wDesired = -0.100 1735.053,HXPDR,N,max range = 16.500000 m, timeout = 22 ms 1764.193,SDIVE,N,WARNING - Maximum speed limit less than expected minimum speed limit; check flight parameters! 1764.441,SDIVE,N,speed limits = 0.17, 0.18 1764.730,SDIVE,N,DesiredHead = 291.61, range = 571744.0, glide angle -28.63 1765.619,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 1766.647,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 1767.270,SMOTOR,N,GC TICKS/TIME: 31/33290 1767.359,HROLL,N,done. 1767.427,HROLL,N,Roll: No motion occurred. 1767.637,SDIVE,N,pitch angle=-26.4deg (pitch -1.1cm), force=-5.0gm (VBD -4.9cc) 0.813,SSURF,N,Dive 5 started Wed Nov 1 18:53:54 2017 (1509562434) 1.034,SUSR,N,Normal Heap: 0+20479 bytes 1.190,SGLMALLOC,N,glheap_walk: 344164 bytes free, 18 blocks free, 2772 bytes alloc, 33 blocks alloc 1.487,HTT8,N,Updating parameter $DIVE to 6 1.803,HTT8,N,Writing NVRAM...done. 10.598,SSURF,N,Initializing data file 10.804,SSURF,N,Initializing log file 13.684,SSURF,N,Starting dive at 13s 13.768,SSURF,N,Leaving surface state 13.871,SDIVE,N,Entering dive state 15.450,SDIVE,N,start $GC,15,-1.15,-4.9,195,1977,2771,2649,0.0,0.0,0, ... 25.412,SSENSOR,N,A 22309ms 2.16m 288.6 #1 35.362,SSENSOR,N,A 32314ms 3.15m 288.1 #2 39.428,SMOTOR,N,MOTOR_DONE: no ticks 39.516,SMOTOR,N,GC TICKS/TIME: 919/925523 39.712,HVBD,N,Bleed completed from 152.57 cc (2710) to -2.94 cc (3344 [3429, 3260]) took 22.9 sec 0 mA (1918 mA peak) 15.0 Vmin 27.66 AD/sec 917 ticks 40.160,HVBD,N,TRACK: b: 3343/0 a: 3343/0 d: 8 o: 1 40.490,SDIVE,N,end $GC ,40,0.00,0.00,-22.92,0.000,16386,0.000,0.000,195,1977,3344,3429,3260,0,0,0,0,0,0,14.96,28.83,14.97 40.810,SDIVE,N,Exiting active in GCPHASE_VBD (2) after 2 samples, ret=FLARE_DEPTH_REACHED 41.962,SDIVE,N,start $GC,41,-1.15,-4.9,195,1977,3430,3260,3.2,-9.9,2, ... 45.700,SSENSOR,N,A 42325ms 4.10m 288.7 #3 49.458,SMOTOR,N,MOTOR_DONE: ticks: 16 max 24v: 3.8mA avg 24v: 3.1mA minV 24v: 14.9V 49.610,SMOTOR,N,GC TICKS/TIME: 278/284365 49.792,HPITCH,N,Pitch completed from -7.83 cm (195) to -1.15 cm (2333) took 6.5 sec 122 mA (357 mA peak) 14.6 Vmin 330.19 AD/sec 259 ticks 50.235,HPITCH,N,TRACK: b: 2320/0 a: 2324/0 d: -7 o: 9 50.592,SDIVE,N,end $GC ,50,6.47,0.00,0.00,0.000,2054,0.122,0.000,2333,1977,3346,3432,3260,0,0,0,0,0,0,14.61,14.77,14.74 50.957,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 55.931,SSENSOR,N,P 53507ms 5.18m 288.7 #4 65.933,SSENSOR,N,P 63507ms 6.18m 288.3 #5 75.932,SSENSOR,N,P 73507ms 7.20m 288.8 #6 86.165,SSENSOR,N,P 83507ms 8.16m 288.4 #7 95.932,SSENSOR,N,P 93507ms 9.09m 288.1 #8 105.936,SSENSOR,N,P 103507ms 10.07m 288.2 #9 107.767,SDIVE,N,turn rate during steady passive flight = -0.003 deg/s 107.904,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 108.104,HVBD,N,wObserved = -0.097 (9) pitchObserved = -20.000 108.319,SDIVE,N,wObs=-0.097, wDes_adj=-0.100, changing VBD -4.9 -> -8.4, actual=-4.9 (MAX_BUOY) 109.652,SDIVE,N,start $GC,109,-1.15,-4.9,2332,1977,3435,3261,10.1,-9.7,9, ... 109.945,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 110.382,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 3.1mA minV 24v: 15.0V 110.533,SMOTOR,N,GC TICKS/TIME: 12/14174 110.834,SDIVE,N,end $GC ,110,0.00,0.00,0.00,0.000,6,0.000,0.000,2333,1977,3347,3435,3260,0,0,0,0,0,0,14.98,14.99,14.99 111.175,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 115.939,SSENSOR,N,P 113507ms 11.05m 288.6 #10 125.939,SSENSOR,N,P 123507ms 12.06m 288.6 #11 135.939,SSENSOR,N,P 133507ms 13.05m 288.5 #12 145.938,SSENSOR,N,P 143507ms 14.05m 288.6 #13 156.170,SSENSOR,N,P 153507ms 15.01m 287.9 #14 165.940,SSENSOR,N,P 163507ms 15.92m 288.2 #15 167.776,SDIVE,N,turn rate during steady passive flight = -0.014 deg/s 167.913,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 168.112,HVBD,N,wObserved = -0.097 (15) pitchObserved = -20.000 168.329,SDIVE,N,wObs=-0.097, wDes_adj=-0.100, changing VBD -4.9 -> -8.3, actual=-4.9 (MAX_BUOY) 169.663,SDIVE,N,start $GC,169,-1.15,-4.9,2332,1977,3436,3260,15.9,-9.7,15, ... 169.958,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 170.395,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 170.547,SMOTOR,N,GC TICKS/TIME: 12/14177 170.845,SDIVE,N,end $GC ,170,0.00,0.00,0.00,0.000,6,0.000,0.000,2333,1977,3348,3436,3260,0,0,0,0,0,0,15.00,15.01,15.00 171.208,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 175.940,SSENSOR,N,P 173507ms 16.86m 288.6 #16 185.939,SSENSOR,N,P 183507ms 17.79m 288.6 #17 195.939,SSENSOR,N,P 193507ms 18.84m 288.3 #18 205.940,SSENSOR,N,P 203507ms 19.85m 288.3 #19 215.939,SSENSOR,N,P 213507ms 20.85m 288.2 #20 226.174,SSENSOR,N,P 223507ms 21.85m 288.6 #21 228.004,SDIVE,N,turn rate during steady passive flight = -0.001 deg/s 228.139,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 228.342,HVBD,N,wObserved = -0.101 (21) pitchObserved = -20.000 229.485,SDIVE,N,start $GC,229,-1.15,-4.9,2332,1977,3435,3260,21.9,-10.1,21, ... 229.783,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 230.219,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 230.371,SMOTOR,N,GC TICKS/TIME: 12/14176 230.667,SDIVE,N,end $GC ,230,0.00,0.00,0.00,0.000,6,0.000,0.000,2333,1977,3348,3436,3260,0,0,0,0,0,0,15.01,15.02,15.02 231.009,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 235.939,SSENSOR,N,P 233507ms 22.88m 288.6 #22 236.895,HXPDR,N,ranging to bottom at 22.882486 meters 237.386,HXPDR,N,ping response: R--------- 245.940,SSENSOR,N,P 243507ms 23.85m 288.7 #23 256.171,SSENSOR,N,P 253507ms 24.86m 288.8 #24 257.120,HXPDR,N,ranging to bottom at 24.855928 meters 257.613,HXPDR,N,ping response: R--------- 265.939,SSENSOR,N,P 263507ms 25.85m 289.4 #25 275.939,SSENSOR,N,P 273507ms 26.86m 288.8 #26 276.891,HXPDR,N,ranging to bottom at 26.864038 meters 277.380,HXPDR,N,ping response: R--------- 285.939,SSENSOR,N,P 283507ms 27.77m 288.4 #27 287.773,SDIVE,N,turn rate during steady passive flight = -0.010 deg/s 287.910,SDIVE,N,Exiting passive after 6 samples, ret=CONTROL_FINISHED_OK 288.111,HVBD,N,wObserved = -0.098 (27) pitchObserved = -20.000 288.329,SDIVE,N,wObs=-0.098, wDes_adj=-0.100, changing VBD -4.9 -> -6.5, actual=-4.9 (MAX_BUOY) 289.667,SDIVE,N,start $GC,289,-1.15,-4.9,2332,1977,3437,3260,27.8,-9.8,27, ... 289.962,SDIVE,N,exiting active w/o sampling due to early MOTOR_DONE 290.399,SMOTOR,N,MOTOR_DONE: ticks: 9 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 290.551,SMOTOR,N,GC TICKS/TIME: 12/14176 290.849,SDIVE,N,end $GC ,290,0.00,0.00,0.00,0.000,6,0.000,0.000,2333,1977,3348,3437,3260,0,0,0,0,0,0,15.02,15.02,15.02 291.189,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 295.937,SSENSOR,N,P 293507ms 28.77m 288.9 #28 296.890,HXPDR,N,ranging to bottom at 28.769180 meters 297.381,HXPDR,N,ping response: R--------- 305.940,SSENSOR,N,P 303507ms 29.77m 288.7 #29 315.936,SSENSOR,N,P 313507ms 30.77m 288.5 #30 316.882,HXPDR,N,ranging to bottom at 30.765730 meters 317.374,HXPDR,N,ping response: R--------- 318.424,SDIVE,N,Exiting passive after 3 samples, ret=TARGET_DEPTH_EXCEEDED 318.564,SDIVE,N,Leaving dive state due to TARGET_DEPTH_EXCEEDED 318.704,SDIVE,N,Entering apogee state 318.848,SDIVE,N,Going neutral at apogee at 30.77 meters 319.061,HROLL,N,Roll commanded from -0.68 deg (1976) to 0.00 deg (2000)... 320.080,HROLL,N,-0.7 deg (ad: 1977) mA=0 minV=15.0 (0,0)MOTOR_DONE: ticks: 28 max 24v: 3.1mA avg 24v: 2.3mA minV 24v: 15.0V 320.701,SMOTOR,N,GC TICKS/TIME: 31/33246 320.788,HROLL,N,done. 320.855,HROLL,N,Roll: No motion occurred. 320.949,SDIVE,N,entering active for apogee pump 322.037,SDIVE,N,start $GC,321,-0.30,0.0,2333,1977,3437,3260,30.8,-9.8,30, ... 325.406,SSENSOR,N,A 322308ms 29.91m 288.8 #31 328.586,SMOTOR,N,MOTOR_DONE: ticks: 115 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 328.741,SMOTOR,N,GC TICKS/TIME: 239/245445 328.923,HPITCH,N,Pitch completed from -1.15 cm (2333) to -0.31 cm (2600) took 0.8 sec 135 mA (396 mA peak) 14.6 Vmin 344.52 AD/sec 31 ticks 329.366,HPITCH,N,TRACK: b: 2590/0 a: 2595/0 d: -6 o: 5 329.550,HVBD,N,Pump completed from -3.92 cc (3348) to 0.74 cc (3329 [3414, 3244]) took 2.2 sec 411 mA (2702 mA peak) 13.9 Vmin 8.44 AD/sec 90 ticks 330.016,HVBD,N,TRACK: b: 3418/3246 a: 3418/3246 d: -86 o: -89 330.440,SDIVE,N,end $GC ,330,0.77,0.00,2.25,0.411,10246,0.135,0.000,2600,1977,3329,3414,3244,0,0,0,0,0,0,14.60,14.73,13.94 330.811,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 330.976,SDIVE,N,Leaving Apogee state due to CONTROL_FINISHED_OK 331.116,SDIVE,N,Entering climb state 331.280,SDIVE,N,Going up from 29.91 meters ... VBDctl=5 332.429,SDIVE,N,start $GC,332,1.15,4.9,2600,1977,3414,3244,29.9,0.0,31, ... 335.395,SSENSOR,N,A 332319ms 28.91m 287.9 #32 338.615,SMOTOR,N,MOTOR_DONE: ticks: 85 max 24v: 5.4mA avg 24v: 3.1mA minV 24v: 14.9V 338.768,SMOTOR,N,GC TICKS/TIME: 225/231071 338.950,HPITCH,N,Pitch completed from -0.31 cm (2600) to 1.11 cm (3055) took 1.4 sec 131 mA (395 mA peak) 14.6 Vmin 337.04 AD/sec 54 ticks 339.386,HPITCH,N,TRACK: b: 3046/0 a: 3047/0 d: -4 o: 8 339.569,HVBD,N,Pump completed from 0.74 cc (3329) to 5.40 cc (3310 [3397, 3224]) took 2.1 sec 303 mA (2644 mA peak) 13.4 Vmin 9.16 AD/sec 83 ticks 340.026,HVBD,N,TRACK: b: 3398/3227 a: 3398/3227 d: -86 o: -88 340.448,SDIVE,N,end $GC ,340,1.35,0.00,2.08,0.303,10246,0.131,0.000,3055,1977,3310,3397,3224,0,0,0,0,0,0,14.59,14.69,13.42 340.799,SDIVE,N,Exiting active in GCPHASE_DONE (6) after 1 samples, ret=CONTROL_FINISHED_OK 345.937,SSENSOR,N,P 343507ms 27.81m 290.6 #33 355.940,SSENSOR,N,P 353507ms 26.85m 291.3 #34 365.938,SSENSOR,N,P 363507ms 25.80m 291.6 #35 376.172,SSENSOR,N,P 373507ms 24.81m 291.1 #36