the8x3_filename:    03250002
full_filename:    ramses-2011-337-2-2
  6181  8 03250002.mlg LOG FILE OPENED
Megabytes used      on CF file system = 378.156250
Megabytes available on CF file system = 1622.781250
  6184    init_gps_input()
  6184    behavior surface_5: SUBSTATE 7 ->9 : Waiting for final gps fix
  6185    disabling Iridium console...
  6202 13 sensor: m_gps_status = 2 enum
  6202    sensor: m_gps_invalid_lat = 3108.6116 lat
  6203    sensor: m_gps_invalid_lon = -8017.9 lon
  6203    sensor: m_gps_status = 2 enum
  6203    sensor: m_gps_invalid_lat = 3108.6116 lat
  6203    sensor: m_gps_invalid_lon = -8017.9 lon
  6207 14 sensor: m_gps_status = 2 enum
  6207    sensor: m_gps_invalid_lat = 3108.6116 lat
  6207    sensor: m_gps_invalid_lon = -8017.9 lon
  6212 15 sensor: m_gps_status = 1 enum
  6212    sensor: m_gps_ignored_lat = 3108.7581 lat
  6212    sensor: m_gps_ignored_lon = -8018.3631 lon
  6223 16 sensor: m_gps_status = 1 enum
  6223    sensor: m_gps_ignored_lat = 3108.7581 lat
  6223    sensor: m_gps_ignored_lon = -8018.3632 lon
  6223    sensor: m_gps_status = 1 enum
  6223    sensor: m_gps_ignored_lat = 3108.7585 lat
  6223    sensor: m_gps_ignored_lon = -8018.3642 lon
  6228 17 sensor: m_gps_status = 1 enum
  6228    sensor: m_gps_ignored_lat = 3108.7592 lat
  6228    sensor: m_gps_ignored_lon = -8018.3658 lon
  6232 18 sensor: m_gps_status = 1 enum
  6232    sensor: m_gps_ignored_lat = 3108.7592 lat
  6232    sensor: m_gps_ignored_lon = -8018.3658 lon
  6237 19 sensor: m_gps_lat = 3108.7598 lat
  6237    sensor: m_gps_lon = -8018.3677 lon
  6237    sensor: m_gps_status = 0 enum
  6242 21 end_gps_input()
  6242    behavior surface_5: SUBSTATE 9 ->11 : All done
  6242    behavior surface_5: STATE Active -> UnInited
  6246 22 behavior surface_5: Reading b_args from surfac10.ma
  6247    behavior surface_5: c_use_bpump(enum)=2.000000
  6247    behavior surface_5: c_bpump_value(X)=1000.000000
  6247    behavior surface_5: c_use_pitch(enum)=3.000000
  6247    behavior surface_5: c_pitch_value(X)=0.453800
  6247    behavior surface_5: STATE UnInited -> Waiting for Activation
  6247    behavior surface_5: argument: args_from_file = 10.000000 enum
  6247    behavior surface_5: argument: start_when = 9.000000 enum
  6247    behavior surface_5: argument: when_secs = 3600.000000 sec
  6247    behavior surface_5: argument: when_wpt_dist = 10.000000 m
  6247    behavior surface_5: argument: end_action = 1.000000 enum
  6247    behavior surface_5: argument: report_all = 1.000000 bool
  6247    behavior surface_5: argument: gps_wait_time = 300.000000 sec
  6247    behavior surface_5: argument: keystroke_wait_time = 300.000000 sec
  6247    behavior surface_5: argument: end_wpt_dist = 0.000000 m
  6247    behavior surface_5: argument: c_use_bpump = 2.000000 enum
  6247    behavior surface_5: argument: c_bpump_value = 1000.000000 X
  6247    behavior surface_5: argument: c_use_pitch = 3.000000 enum
  6247    behavior surface_5: argument: c_pitch_value = 0.453800 X
  6247    behavior surface_5: argument: printout_cycle_time = 20.000000 sec
  6247    behavior surface_5: argument: gps_postfix_wait_time = 60.000000 sec
  6247    behavior surface_5: argument: force_iridium_use = 0.000000 nodim
  6247    behavior surface_5: argument: min_time_between_gps_fixes = 300.000000 sec
  6247    behavior surface_5: argument: sensor_input_wait_time = 10.000000 sec
  6247    behavior surface_5: argument: when_utc_min = -1.000000 min
  6247    behavior surface_5: argument: when_utc_hour = -1.000000 hour
  6247    behavior surface_5: argument: when_utc_day = -1.000000 day
  6247    behavior surface_5: argument: when_utc_month = -1.000000 month
  6247    behavior surface_5: argument: when_utc_on_surface = 0.000000 bool
  6247    behavior surface_5: argument: strobe_on = 0.000000 bool
  6251 23 behavior sample_8: SUBSTATE 4 ->1 : Diving
:OOD:digifin_mgr_ctrl:OUT OF DEADBAND: M_FIN:-0.0373 C_FIN:0.0000
  6548 90 behavior dive_to_701: SUBSTATE 4 ->5 : Complete, deduced altitude from water depth
  6548    behavior dive_to_701: STATE Active -> Complete
  6548    behavior climb_to_702: STATE UnInited -> Active
  6549    behavior climb_to_702: argument: target_depth = 5.000000 m
  6549    behavior climb_to_702: argument: target_altitude = -1.000000 m
  6549    behavior climb_to_702: argument: use_bpump = 2.000000 enum
  6549    behavior climb_to_702: argument: bpump_value = 1000.000000 X
  6549    behavior climb_to_702: argument: use_pitch = 3.000000 enum
  6549    behavior climb_to_702: argument: pitch_value = 0.453800 X
  6549    behavior climb_to_702: argument: start_when = 0.000000 enum
  6549    behavior climb_to_702: argument: stop_when_hover_for = 180.000000 sec
  6549    behavior climb_to_702: argument: stop_when_stalled_for = 240.000000 sec
  6549    behavior climb_to_702: argument: initial_inflection = 1.000000 bool
  6549    behavior climb_to_702: argument: use_sc_model = 0.000000 bool
  6549    behavior climb_to_702: argument: speed_min = 100.000000 m/s
  6549    behavior climb_to_702: argument: speed_max = -100.000000 m/s
  6549    behavior climb_to_702: SUBSTATE 0 UnInited->1 : waiting for initial depth reading
  6549    behavior climb_to_702: SUBSTATE 1 ->3 : Starting the climb
  6549    behavior climb_to_702: SUBSTATE 3 ->4 : climbing
  6553 91 behavior sample_8: SUBSTATE 1 ->3 : Climbing
  6829 53 behavior climb_to_702: SUBSTATE 4 ->5 : Complete reached depth
  6829    behavior climb_to_702: STATE Active -> Complete
  6829    behavior dive_to_701: STATE UnInited -> Active
  6829    behavior dive_to_701: argument: target_depth = 180.000000 m
  6829    behavior dive_to_701: argument: target_altitude = 5.000000 m
  6829    behavior dive_to_701: argument: use_bpump = 2.000000 enum
  6829    behavior dive_to_701: argument: bpump_value = -1000.000000 X
  6829    behavior dive_to_701: argument: use_pitch = 3.000000 enum
  6829    behavior dive_to_701: argument: pitch_value = -0.453800 X
  6829    behavior dive_to_701: argument: start_when = 0.000000 enum
  6829    behavior dive_to_701: argument: stop_when_hover_for = 180.000000 sec
  6829    behavior dive_to_701: argument: stop_when_stalled_for = 240.000000 sec
  6829    behavior dive_to_701: argument: initial_inflection = 1.000000 bool
  6829    behavior dive_to_701: argument: use_sc_model = 0.000000 bool
  6829    behavior dive_to_701: argument: speed_min = -100.000000 m/s
  6829    behavior dive_to_701: argument: speed_max = 100.000000 m/s
  6829    behavior dive_to_701: argument: depth_rate_method = 3.000000 enum
  6829    behavior dive_to_701: argument: wait_for_pitch = 1.000000 bool
  6829    behavior dive_to_701: argument: delta_bpump_speed = 85.000000 X
  6829    behavior dive_to_701: argument: delta_bpump_ballast = 25.000000 X
  6829    behavior dive_to_701: argument: time_ratio = 1.100000 X
  6829    behavior dive_to_701: argument: max_thermal_charge_time = 1200.000000 sec
  6829    behavior dive_to_701: argument: max_pumping_charge_time = 300.000000 sec
  6829    behavior dive_to_701: argument: thr_reqd_pres_mul = 1.500000 nodim
  6829    behavior dive_to_701: SUBSTATE 0 UnInited->1 : waiting for initial depth reading
  6829    behavior dive_to_701: SUBSTATE 1 ->3 : Starting the dive
  6829    behavior dive_to_701: SUBSTATE 3 ->4 : diving
  6833 55 behavior sample_8: SUBSTATE 3 ->1 : Diving
  7114 18 behavior dive_to_701: SUBSTATE 4 ->5 : Complete, deduced altitude from water depth
  7114    behavior dive_to_701: STATE Active -> Complete
  7114    behavior climb_to_702: STATE UnInited -> Active
  7114    behavior climb_to_702: argument: target_depth = 5.000000 m
  7114    behavior climb_to_702: argument: target_altitude = -1.000000 m
  7114    behavior climb_to_702: argument: use_bpump = 2.000000 enum
  7114    behavior climb_to_702: argument: bpump_value = 1000.000000 X
  7114    behavior climb_to_702: argument: use_pitch = 3.000000 enum
  7114    behavior climb_to_702: argument: pitch_value = 0.453800 X
  7114    behavior climb_to_702: argument: start_when = 0.000000 enum
  7114    behavior climb_to_702: argument: stop_when_hover_for = 180.000000 sec
  7114    behavior climb_to_702: argument: stop_when_stalled_for = 240.000000 sec
  7114    behavior climb_to_702: argument: initial_inflection = 1.000000 bool
  7114    behavior climb_to_702: argument: use_sc_model = 0.000000 bool
  7114    behavior climb_to_702: argument: speed_min = 100.000000 m/s
  7114    behavior climb_to_702: argument: speed_max = -100.000000 m/s
  7114    behavior climb_to_702: SUBSTATE 0 UnInited->1 : waiting for initial depth reading
  7114    behavior climb_to_702: SUBSTATE 1 ->3 : Starting the climb
  7114    behavior climb_to_702: SUBSTATE 3 ->4 : climbing
  7118 19 behavior sample_8: SUBSTATE 1 ->3 : Climbing
  7342 71 behavior surface_5: STATE Waiting for Activation -> Active
  7342    behavior surface_5: SUBSTATE 0 UnInited->1 : climb_to the surface
  7347    behavior climb_to_501: STATE UnInited -> Active
  7347    behavior climb_to_501: argument: target_depth = 2.000000 m
  7347    behavior climb_to_501: argument: target_altitude = -1.000000 m
  7347    behavior climb_to_501: argument: use_bpump = 2.000000 enum
  7347    behavior climb_to_501: argument: bpump_value = 1000.000000 X
  7347    behavior climb_to_501: argument: use_pitch = 3.000000 enum
  7347    behavior climb_to_501: argument: pitch_value = 0.453800 X
  7347    behavior climb_to_501: argument: start_when = 0.000000 enum
  7347    behavior climb_to_501: argument: stop_when_hover_for = -1.000000 sec
  7347    behavior climb_to_501: argument: stop_when_stalled_for = -1.000000 sec
  7347    behavior climb_to_501: argument: initial_inflection = 1.000000 bool
  7347    behavior climb_to_501: argument: use_sc_model = 0.000000 bool
  7347    behavior climb_to_501: argument: speed_min = 100.000000 m/s
  7347    behavior climb_to_501: argument: speed_max = -100.000000 m/s
  7347    behavior climb_to_501: SUBSTATE 0 UnInited->1 : waiting for initial depth reading
  7347    behavior climb_to_501: SUBSTATE 1 ->3 : Starting the climb
  7347    behavior climb_to_501: SUBSTATE 3 ->4 : climbing
  7394 82 behavior climb_to_702: SUBSTATE 4 ->5 : Complete reached depth
  7394    behavior climb_to_702: STATE Active -> Complete
  7394    behavior dive_to_701: STATE UnInited -> Active
  7394    behavior dive_to_701: argument: target_depth = 180.000000 m
  7394    behavior dive_to_701: argument: target_altitude = 5.000000 m
  7394    behavior dive_to_701: argument: use_bpump = 2.000000 enum
  7394    behavior dive_to_701: argument: bpump_value = -1000.000000 X
  7394    behavior dive_to_701: argument: use_pitch = 3.000000 enum
  7394    behavior dive_to_701: argument: pitch_value = -0.453800 X
  7394    behavior dive_to_701: argument: start_when = 0.000000 enum
  7394    behavior dive_to_701: argument: stop_when_hover_for = 180.000000 sec
  7394    behavior dive_to_701: argument: stop_when_stalled_for = 240.000000 sec
  7394    behavior dive_to_701: argument: initial_inflection = 1.000000 bool
  7394    behavior dive_to_701: argument: use_sc_model = 0.000000 bool
  7394    behavior dive_to_701: argument: speed_min = -100.000000 m/s
  7394    behavior dive_to_701: argument: speed_max = 100.000000 m/s
  7394    behavior dive_to_701: argument: depth_rate_method = 3.000000 enum
  7394    behavior dive_to_701: argument: wait_for_pitch = 1.000000 bool
  7394    behavior dive_to_701: argument: delta_bpump_speed = 85.000000 X
  7394    behavior dive_to_701: argument: delta_bpump_ballast = 25.000000 X
  7394    behavior dive_to_701: argument: time_ratio = 1.100000 X
  7394    behavior dive_to_701: argument: max_thermal_charge_time = 1200.000000 sec
  7394    behavior dive_to_701: argument: max_pumping_charge_time = 300.000000 sec
  7394    behavior dive_to_701: argument: thr_reqd_pres_mul = 1.500000 nodim
  7394    behavior dive_to_701: SUBSTATE 0 UnInited->1 : waiting for initial depth reading
  7394    behavior dive_to_701: SUBSTATE 1 ->3 : Starting the dive
  7394    behavior dive_to_701: SUBSTATE 3 ->4 : diving
  7407 84 behavior climb_to_501: SUBSTATE 4 ->5 : Complete reached depth
  7407    behavior climb_to_501: STATE Active -> Complete
  7407    behavior surface_5: SUBSTATE 1 ->2 : waiting for various sensors
  7407    sensor: m_air_pump = 1 bool
  7408    sensor: m_fin = 0.1024655 rad
  7408    sensor: m_vacuum = 5.64195375457876 inHg
  7408    sensor: m_battery = 13.7998146862311 volts
  7408    sensor: m_pressure = 0.0331125827814596 bar
  7408    sensor: m_depth = 0.331125827814596 m
  7408    sensor: m_battpos = -0.165240537240537 in
  7409    sensor: m_air_pump = 1 bool
  7409    sensor: m_pitch = 0.118682389135614 rad
  7409    sensor: m_roll = 0.0872664625997165 rad
  7409    sensor: m_heading = 1.23569311041198 rad
  7409    sensor: m_leakdetect_voltage = 2.5 volts
  7409    sensor: m_battpos = 0.115479853479853 in
  7409    sensor: m_battpos = 0.248230158730159 in
  7409    sensor: m_battpos = 0.376752747252747 in
  7409    sensor: m_water_pressure = 0.03 bar
  7412 85 behavior sample_8: SUBSTATE 3 ->4 : On Surface
  7413    sensor: m_raw_altitude = 38.998778998779 m
  7416 86 behavior surface_5: SUBSTATE 2 ->3 : waiting for GPS fix
  7416    init_gps_input()
  7423 88 sensor: m_gps_status = 2 enum
  7423    sensor: m_gps_invalid_lat = 3108.7637 lat
  7423    sensor: m_gps_invalid_lon = -8018.3756 lon
  7423    sensor: m_gps_status = 2 enum
  7423    sensor: m_gps_invalid_lat = 3108.7637 lat
  7423    sensor: m_gps_invalid_lon = -8018.3756 lon
  7426 89 sensor: m_gps_status = 2 enum
  7426    sensor: m_gps_invalid_lat = 3108.7637 lat
  7426    sensor: m_gps_invalid_lon = -8018.3756 lon
  7432 90 sensor: m_gps_status = 1 enum
  7432    sensor: m_gps_ignored_lat = 3108.8074 lat
  7432    sensor: m_gps_ignored_lon = -8018.3375 lon
  7436 91 sensor: m_gps_status = 1 enum
  7436    sensor: m_gps_ignored_lat = 3108.8075 lat
  7436    sensor: m_gps_ignored_lon = -8018.3372 lon
  7443 92 sensor: m_gps_status = 1 enum
  7443    sensor: m_gps_ignored_lat = 3108.8084 lat
  7443    sensor: m_gps_ignored_lon = -8018.3378 lon
  7447 93 sensor: m_gps_status = 1 enum
  7447    sensor: m_gps_ignored_lat = 3108.8093 lat
  7447    sensor: m_gps_ignored_lon = -8018.3375 lon
  7451 94 sensor: m_gps_status = 1 enum
  7451    sensor: m_gps_ignored_lat = 3108.8099 lat
  7451    sensor: m_gps_ignored_lon = -8018.3389 lon
  7456 96 sensor: m_gps_lat = 3108.81 lat
  7456    sensor: m_gps_lon = -8018.3392 lon
  7456    sensor: m_gps_status = 0 enum
  7460 97 end_gps_input()
  7460    init_gps_input()
  7460    behavior surface_5: SUBSTATE 3 ->4 : Picking iridium or freewave
  7460    behavior surface_5: SUBSTATE 4 ->5 : Waiting for more gps fixes
  7461    sensor: m_gps_lat = 3108.8108 lat
  7461    sensor: m_gps_lon = -8018.3405 lon
  7462    sensor: m_gps_status = 0 enum
  7466 98 sensor: m_gps_lat = 3108.8118 lat
  7466    sensor: m_gps_lon = -8018.3416 lon
  7466    sensor: m_gps_status = 0 enum
  7471 99 sensor: m_gps_lat = 3108.8128 lat
  7471    sensor: m_gps_lon = -8018.3424 lon
  7471    sensor: m_gps_status = 0 enum
  7476  0 sensor: m_gps_lat = 3108.8131 lat
  7476    sensor: m_gps_lon = -8018.343 lon
  7476    sensor: m_gps_status = 0 enum
  7483  1 sensor: m_gps_lat = 3108.8138 lat
  7483    sensor: m_gps_lon = -8018.3441 lon
  7483    sensor: m_gps_status = 0 enum
  7487  2 sensor: m_gps_lat = 3108.8145 lat
  7487    sensor: m_gps_lon = -8018.3448 lon
  7487    sensor: m_gps_status = 0 enum
  7492  3 sensor: m_gps_lat = 3108.8155 lat
  7492    sensor: m_gps_lon = -8018.3475 lon
  7492    sensor: m_gps_status = 0 enum
  7496  5 sensor: m_gps_lat = 3108.8161 lat
  7496    sensor: m_gps_lon = -8018.3491 lon
  7496    sensor: m_gps_status = 0 enum
  7501  6 sensor: m_gps_lat = 3108.8168 lat
  7501    sensor: m_gps_lon = -8018.3507 lon
  7501    sensor: m_gps_status = 0 enum
  7511  7 sensor: m_gps_lat = 3108.8175 lat
  7511    sensor: m_gps_lon = -8018.3513 lon
  7511    sensor: m_gps_status = 0 enum
  7511    sensor: m_gps_lat = 3108.818 lat
  7511    sensor: m_gps_lon = -8018.3523 lon
  7511    sensor: m_gps_status = 0 enum
  7514  8 end_gps_input()
  7514    behavior surface_5: SUBSTATE 5 ->7 : waiting for control-C to exit/resume
  7524  9 Iridium has been powered on for 4.5 secs
  7524    Waking up Iridium... sending:ATE1
  7524    Iridium, modem making attempt #1 at primary number (881600005143)
  7530 10 Iridium driver received:[ATE1[0D][0D]]
  7530    Iridium modem matched: OK
  7530    Waking up Iridium... sending:AT+cbst=6,0,1
  7535 11 Iridium driver received:[AT+cbst=6,0,1[0D][0D]]
  7535    Iridium modem matched: OK
  7535    Waking up Iridium... sending:AT+CSQ
  7539 13 Iridium driver received:[AT+CSQ[0D][0D][0A]+CSQ:5[0D][0A][0D]]
  7539    Iridium modem matched: OK
  7544 14 Iridium waiting for registration...
  7553 16 Obtaining Iridium RSSI...
  7553    Iridium dialing [ATD00881600005143]...........
  7553    Iridium waiting for connection...
  7558 16 Iridium driver received:[ATD00881600005143[0D]]
  7567 18 Iridium driver received:[[0D]]
  7567    Iridium modem matched: CONNECT 4800
  7567    Iridium connected...
  7567    Iridium console active and ready...
Vehicle Name: ramses
Curr Time: Sun Dec  4 05:06:49 2011 MT:    7566
DR  Location:  3108.819 N -8018.352 E measured     50.532 secs ago
GPS TooFar:   69696969.000 N 69696969.000 E measured     1e+308 secs ago
GPS Invalid :  3108.764 N -8018.376 E measured    141.019 secs ago
GPS Location:  3108.819 N -8018.353 E measured     51.074 secs ago
   sensor:m_battery(volts)=13.7959562694736        32.886 secs ago
   sensor:m_gps_lat(lat)=3108.8186                 51.354 secs ago
   sensor:m_gps_lon(lon)=-8018.3525                51.426 secs ago
   sensor:m_iridium_signal_strength(nodim)=5       14.505 secs ago
   sensor:m_lat(lat)=3108.81860003266              51.044 secs ago
   sensor:m_leakdetect_voltage(volts)=2.5          33.113 secs ago
   sensor:m_lon(lon)=-8018.35249999976             51.173 secs ago
   sensor:m_present_time(timestamp)=1322975208.75366      1.822 secs ago
   sensor:m_vacuum(inHg)=7.56443006715507          38.159 secs ago
   sensor:m_water_vx(m/s)=-0.202914064627264       56.244 secs ago
   sensor:m_water_vy(m/s)=0.0785719609543184       56.296 secs ago
ABORT HISTORY: total since reset: 1
ABORT HISTORY: last abort cause: MS_ABORT_BEH_ERROR
ABORT HISTORY: last abort details: layered_control(): The surface behavior entered B_ERROR state.
ABORT HISTORY: last abort time: 2011-12-04T02:53:50
ABORT HISTORY: last abort segment: ramses-2011-337-1-0 (0324.0000)
ABORT HISTORY: last abort mission: initial.mi
  7568    No login script found for processing.
  7607 26 03250002.mlg LOG FILE CLOSED
