2008-Jul-16 01:50:24 BEGIN executive: CIMA executive starting ... 2008-Jul-16 01:50:24 NOTE executive: STARTING NEW CIMA SESSION 2008-Jul-16 01:50:24 INFO1 executive: Using CIMA version 3.0.00 'next' from 2008-06-12 15:50 2008-Jul-16 01:50:24 INFO4 executive: This is an ON-LINE session 2008-Jul-16 01:50:24 INFO4 executive: This is a REMOTE session 2008-Jul-16 01:50:24 INFO5 executive: All entries in the log-file are timestamped in AST ( = UTC - 4 hours ) 2008-Jul-16 01:50:24 INFO1 executive: CIMA session for project 'a2048' in 'line' mode for 'J. Davies' 2008-Jul-16 01:50:24 INFO2 executive: Logging to '/share/obs4/usr/a2048/a2048.cimalog_20080716' 2008-Jul-16 01:50:24 LOG2 log_preferences: Currently applied preferences: 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(dailylog) = daily 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(offlinelog) = skip 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(datawindow) = ignore 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(limitwarning) = enabled 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(wappfailure) = abort 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(helpstyle) = stay-open 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(logcolours) = full 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(displaylevel) = INFO3 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(loglevel) = LOG5 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(displayformat) = short 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(logformat) = new 2008-Jul-16 01:50:24 LOG2 log_preferences: prefs(fontsize) = 4 2008-Jul-16 01:50:24 LOG3 vw_send: To DATATAKING: source /share/obs4/usr/aoui/psriflo.tcl 2008-Jul-16 01:50:24 LOG3 vw_send: To DATATAKING: cd /share/obs4/usr/a2048 2008-Jul-16 01:50:24 ALERT executive: CIMA executive ready 2008-Jul-16 01:50:27 NOTE frontend: CIMA frontend ready 2008-Jul-16 01:50:28 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:50:28 LOG4 got_cormsg: From DATATAKING: setup 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: mcpSetupCmd: prg tpProg err 0xd 2008-Jul-16 01:50:34 LOG1 got_cormsg: Start-up error message from DATATAKING: 'mcpSetupCmd: prg tpProg err 0xd' 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% io 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: tapeIo Off discIo Off gioIo Off 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% tape stat 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: mcpTapeCmd: err 0xd0003 2008-Jul-16 01:50:34 LOG1 got_cormsg: Start-up error message from DATATAKING: 'mcpTapeCmd: err 0xd0003' 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% connectall 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@cor 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@corp1 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@pnt 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@da 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@dap1 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: connected : prgMgr@dap2 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% online.. exit cmd to quit. 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% source /share/obs4/usr/aoui/psriflo.tcl 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: cd /share/obs4/usr/a2048 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:50:34 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:51:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:51:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.7144 19.6900 RA/Dec = 20:22:17 +36:13:54 2008-Jul-16 01:51:50 COMMAND CIMA-send_to_exec: Sending command to select new receiver 2008-Jul-16 01:51:50 LOG4 exec_msg: From OBSERVER: select_receiver alfa no no yes 2008-Jul-16 01:51:50 LOG1 select_receiver: Calling 'select_receiver alfa no no yes' 2008-Jul-16 01:51:50 BEGIN begin_task: Starting task 'selecting receiver ALFA' 2008-Jul-16 01:51:50 LOG5 begin_task: Level: (1) ID = <10001> Status = 0 0 0 0 ok 2008-Jul-16 01:51:50 NOTE select_receiver: Starting to select receiver ALFA 2008-Jul-16 01:51:50 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Receiver Selection} TOTALLOOPS 1 TASKWAIT BITMAP stat_alfa_rot INFO {Selecting receiver ALFA ...} 2008-Jul-16 01:51:50 LOG3 vw_send: To DATATAKING: setupall alfa 1400.0 2008-Jul-16 01:51:50 LOG3 vw_send: To DATATAKING: acvlbical off 2008-Jul-16 01:51:50 NOTE select_receiver: Don't forget to choose a source after receiver selection! 2008-Jul-16 01:51:50 STOP finish_task: Finishing task 'selecting receiver ALFA' 2008-Jul-16 01:51:50 LOG5 finish_task: Level: (1) ID = <10001> Status = 0 0 0 0 ok 2008-Jul-16 01:51:50 DONE finish_task: DONE finished selecting: receiver ALFA 2008-Jul-16 01:51:50 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 01:51:50 END end_task: Finishing task 'selecting receiver ALFA' with status 'OK' 2008-Jul-16 01:51:50 LOG5 end_task: Level: (1) ID = <10001> Status = 0 0 0 0 ok 2008-Jul-16 01:51:50 LOG4 got_cormsg: From DATATAKING: setupall alfa 1400.0 2008-Jul-16 01:51:50 LOG4 got_cormsg: From DATATAKING: acvlbical off 2008-Jul-16 01:51:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:51:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5154 19.6900 RA/Dec = 20:22:36 +35:57:12 2008-Jul-16 01:51:57 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:51:57 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:52:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:52:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5151 19.6900 RA/Dec = 20:23:07 +35:57:12 2008-Jul-16 01:52:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:52:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5150 19.6900 RA/Dec = 20:23:37 +35:57:11 2008-Jul-16 01:53:10 NOTE CIMA-load_config_file: Loading configuration file 'ages_alfafu.conf' 2008-Jul-16 01:53:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:53:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5150 19.6900 RA/Dec = 20:24:05 +35:57:11 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(fast_config) "yes" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(config_type) "standard" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(receiver) "alfa" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(quick_tsys) "no" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(ifsetup_only) "no" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(retrack_source) "yes" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(path) "ALFA" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(restcent) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest1) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest2) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest3) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest4) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest5) "1420.405751786" 2008-Jul-16 01:53:53 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest6) "1420.405751786" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest7) "1420.405751786" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rest8) "1420.405751786" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(dest1) "250" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(dest2) "250" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(dest3) "250" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(dest4) "250" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq1) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq2) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq3) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq4) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq5) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq6) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq7) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(synfrq8) "0.000000" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(calctype) "SUBBAND" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(backends) "WAPP" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(radarblanker) "off" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(polsel) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(filtersel) "alfafb 1" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(sbshcl) "T" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(shcl) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rfnum) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(zmnormal) "T" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(rfattn) "11 11" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(ifnum) "6" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(up) "1670.405752" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(ifattn) "0 0" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(fiber) "T" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(ac2sw) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(phbsig) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(hybrid) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(phblo) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(xfnormal) "T" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(sigsrc) "gr" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(gain) "8 8" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(inpfrq) "alfa" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(mixer) "750 750 750 750 750 750 750 750" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(vlbainp) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(syndest) "3 3 3 3 3 3 3 3" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(calsrc) "3" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(750nb) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(2to12wb) "F" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(calrcvr) "15" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(2a2b30if) "skip" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(vis30mhz) "gr" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global iflo ; set iflo(430blnk) "F" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw1) "100" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw2) "100" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw3) "100" 2008-Jul-16 01:53:54 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw4) "100" 2008-Jul-16 01:53:55 COMMAND CIMA-send_to_exec: Sending command to apply receiver IF/LO set-up 2008-Jul-16 01:53:55 LOG4 exec_msg: From OBSERVER: config_iflo 2008-Jul-16 01:53:55 BEGIN begin_task: Starting task 'configuring IF/LO path' 2008-Jul-16 01:53:55 LOG5 begin_task: Level: (1) ID = <10002> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 INFO1 config_iflo: Starting to configure IF/LO path for ALFA 2008-Jul-16 01:53:55 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Configuring IF/LO path} TASKWAIT BITMAP stat_iflo INFO {Setting up the IF/LO path ...} 2008-Jul-16 01:53:55 INFO1 config_iflo: Selecting receiver ALFA 2008-Jul-16 01:53:55 LOG4 send_obs_status: To obs_status: <1> INFO {Selecting receiver ALFA} 2008-Jul-16 01:53:55 LOG1 select_receiver: Calling 'select_receiver alfa no no yes' 2008-Jul-16 01:53:55 START begin_task: Starting task 'selecting receiver ALFA' 2008-Jul-16 01:53:55 LOG5 begin_task: Level: (2) ID = <10003> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 NOTE select_receiver: Starting to select receiver ALFA 2008-Jul-16 01:53:55 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Receiver Selection} TOTALLOOPS 1 TASKWAIT BITMAP stat_alfa_rot INFO {Selecting receiver ALFA ...} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: setupall alfa 1400.0 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: acvlbical off 2008-Jul-16 01:53:55 NOTE select_receiver: Don't forget to choose a source after receiver selection! 2008-Jul-16 01:53:55 STOP finish_task: Finishing task 'selecting receiver ALFA' 2008-Jul-16 01:53:55 LOG5 finish_task: Level: (2) ID = <10003> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 INFO2 finish_task: DONE finished selecting: receiver ALFA 2008-Jul-16 01:53:55 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 01:53:55 STOP end_task: Finishing task 'selecting receiver ALFA' with status 'OK' 2008-Jul-16 01:53:55 LOG5 end_task: Level: (2) ID = <10003> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 START begin_task: Starting task 'waiting for receiver ALFA' 2008-Jul-16 01:53:55 LOG5 begin_task: Level: (2) ID = <10004> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 STOP end_task: Finishing task 'waiting for receiver ALFA' with status 'OK' 2008-Jul-16 01:53:55 LOG5 end_task: Level: (2) ID = <10004> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 INFO1 config_iflo: Configuring rest of the IF/LO path 2008-Jul-16 01:53:55 LOG4 send_obs_status: To obs_status: <1> BITMAP stat_iflo INFO {Configuring rest of the IF/LO path} 2008-Jul-16 01:53:55 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 01:53:55 LOG3 socket_wait: To ALFAMON: NOISE ACTIVE 2008-Jul-16 01:53:55 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 01:53:55 LOG5 begin_task: Level: (2) ID = <10005> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 01:53:55 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 01:53:55 LOG5 end_task: Level: (2) ID = <10005> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 01:53:55 LOG3 to_alfamon: To ALFAMON: NOISE ACTIVE 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: alfafb 1 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_sbshcl T} 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_shcl skip' since not applicable 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_rfnum skip' since not applicable 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_zmnormal T} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_rfattn 11 11} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_ifnum 6} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_syn1 1670405752.0} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_ifattn 0 0} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_fiber T} 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_ac2sw skip' since not applicable 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_phbsig skip' since not applicable 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_hybrid skip' since not applicable 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_phblo skip' since not applicable 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if1-command 'if1_750nb skip' since not applicable 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_2to12wb F} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if1 {if1_calrcvr 15} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_xfnormal T} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_sigsrc gr} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_gain 8 8} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_inpfrq alfa} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_mixer 750 750 750 750 750 750 750 750} 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if2-command 'if2_vlbainp skip' since not applicable 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_syndest 3 3 3 3 3 3 3 3} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_calsrc 3} 2008-Jul-16 01:53:55 LOG5 send_ifx: Skipping if2-command 'if2_2a2b30if skip' since not applicable 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_vis30mhz gr} 2008-Jul-16 01:53:55 LOG3 vw_send: To DATATAKING: if2 {if2_430blnk F} 2008-Jul-16 01:53:55 LOG2 socket_wait: Starting sockwait on DATATAKING for 'configuring IF/LO path' using string 'DONE' 2008-Jul-16 01:53:55 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 01:53:55 START begin_task: Starting task 'waiting on configuring IF/LO path' 2008-Jul-16 01:53:55 LOG5 begin_task: Level: (2) ID = <10006> Status = 0 0 0 0 ok 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: setupall alfa 1400.0 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: acvlbical off 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: alfafb 1 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_sbshcl T} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_zmnormal T} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_rfattn 11 11} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_ifnum 6} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_syn1 1670405752.0} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_ifattn 0 0} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_fiber T} 2008-Jul-16 01:53:55 LOG4 got_cormsg: From DATATAKING: if1 {if1_2to12wb F} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if1 {if1_calrcvr 15} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_xfnormal T} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_sigsrc gr} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_gain 8 8} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_inpfrq alfa} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_mixer 750 750 750 750 750 750 750 750} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_syndest 3 3 3 3 3 3 3 3} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_calsrc 3} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_vis30mhz gr} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: if2 {if2_430blnk F} 2008-Jul-16 01:53:56 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 01:53:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:53:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5149 19.6900 RA/Dec = 20:24:37 +35:57:11 2008-Jul-16 01:54:02 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:02 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:03 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:03 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:03 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:04 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:08 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:08 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:09 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:09 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:09 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:09 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:10 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 01:54:11 STOP end_task: Finishing task 'waiting on configuring IF/LO path' with status 'OK' 2008-Jul-16 01:54:11 LOG5 end_task: Level: (2) ID = <10006> Status = 0 0 0 0 ok 2008-Jul-16 01:54:11 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'configuring IF/LO path' 2008-Jul-16 01:54:11 STOP finish_task: Finishing task 'configuring IF/LO path' 2008-Jul-16 01:54:11 LOG5 finish_task: Level: (1) ID = <10002> Status = 0 0 0 0 ok 2008-Jul-16 01:54:11 DONE finish_task: DONE finished configuration: IF/LO path 2008-Jul-16 01:54:11 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 01:54:11 END end_task: Finishing task 'configuring IF/LO path' with status 'OK' 2008-Jul-16 01:54:11 LOG5 end_task: Level: (1) ID = <10002> Status = 0 0 0 0 ok 2008-Jul-16 01:54:11 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:15 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_enabled1) "1" 2008-Jul-16 01:54:15 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_enabled2) "1" 2008-Jul-16 01:54:15 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_enabled3) "1" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_enabled4) "1" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_cfg1) "2 chan, 3-level" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_cfg2) "2 chan, 3-level" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_cfg3) "2 chan, 3-level" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_cfg4) "2 chan, 3-level" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw1) "100" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw2) "100" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw3) "100" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_bw4) "100" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(wapp_dumptime) "1" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(alfa) "1" 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: global wapp ; set wapp(dual) "1" 2008-Jul-16 01:54:16 COMMAND CIMA-send_to_exec: Sending command to configure the WAPPs 2008-Jul-16 01:54:16 LOG4 exec_msg: From OBSERVER: config_wapp_correlator 2008-Jul-16 01:54:16 BEGIN begin_task: Starting task 'configuring WAPPs' 2008-Jul-16 01:54:16 LOG5 begin_task: Level: (1) ID = <10007> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Configuring WAPPs} TASKWAIT BITMAP stat_corr INFO {Configuring the WAPPs ...} 2008-Jul-16 01:54:16 INFO1 config_wapp_correlator: Starting to configure WAPP as correlator 2008-Jul-16 01:54:16 LOG2 set_cal_source: Setting cal signal control to the WAPPs 2008-Jul-16 01:54:16 START begin_task: Starting task 'selecting calibration port' 2008-Jul-16 01:54:16 LOG5 begin_task: Level: (2) ID = <10008> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG3 vw_send: To DATATAKING: calport 3 2008-Jul-16 01:54:16 LOG2 socket_wait: Starting sockwait on DATATAKING for 'calport' using string 'DONE' 2008-Jul-16 01:54:16 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 01:54:16 START begin_task: Starting task 'waiting on calport' 2008-Jul-16 01:54:16 LOG5 begin_task: Level: (3) ID = <10009> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG4 got_cormsg: From DATATAKING: calport 3 2008-Jul-16 01:54:16 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 01:54:16 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:16 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 01:54:16 STOP end_task: Finishing task 'waiting on calport' with status 'OK' 2008-Jul-16 01:54:16 LOG5 end_task: Level: (3) ID = <10009> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'calport' 2008-Jul-16 01:54:16 STOP end_task: Finishing task 'selecting calibration port' with status 'OK' 2008-Jul-16 01:54:16 LOG5 end_task: Level: (2) ID = <10008> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG3 wapp_calcontrol: To CALCONTROL: CALOFF 2008-Jul-16 01:54:16 LOG3 sock_errsend: To CALCONTROL: CALOFF STATUS 2008-Jul-16 01:54:16 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 01:54:16 LOG5 begin_task: Level: (2) ID = <10010> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 01:54:16 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:54:16 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x02 2008-Jul-16 01:54:16 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 01:54:16 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 01:54:16 LOG5 end_task: Level: (2) ID = <10010> Status = 0 0 0 0 ok 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON: VERBOSE 0 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON2: VERBOSE 0 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON3: VERBOSE 0 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON4: VERBOSE 0 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON: TIMEOUT 5 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON2: TIMEOUT 5 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON3: TIMEOUT 5 2008-Jul-16 01:54:16 LOG3 send_to_one_wapp: To WAPPCON4: TIMEOUT 5 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON2: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON3: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON4: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 wapp_calcontrol: To CALCONTROL: TRIGCLOCK 2008-Jul-16 01:54:17 LOG3 sock_errsend: To CALCONTROL: TRIGCLOCK STATUS 2008-Jul-16 01:54:17 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 01:54:17 LOG5 begin_task: Level: (2) ID = <10011> Status = 0 0 0 0 ok 2008-Jul-16 01:54:17 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 01:54:17 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x02 2008-Jul-16 01:54:17 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 01:54:17 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 01:54:17 LOG5 end_task: Level: (2) ID = <10011> Status = 0 0 0 0 ok 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON2: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON3: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 LOG3 send_to_one_wapp: To WAPPCON4: PROJECT a2048 J. Davies 2008-Jul-16 01:54:17 STOP finish_task: Finishing task 'configuring WAPPs' 2008-Jul-16 01:54:17 LOG5 finish_task: Level: (1) ID = <10007> Status = 0 0 0 0 ok 2008-Jul-16 01:54:17 DONE finish_task: DONE finished configuring: the WAPPs in ALFA mode 2008-Jul-16 01:54:17 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 01:54:17 END end_task: Finishing task 'configuring WAPPs' with status 'OK' 2008-Jul-16 01:54:17 LOG5 end_task: Level: (1) ID = <10007> Status = 0 0 0 0 ok 2008-Jul-16 01:54:17 LOG4 WAPP=1+2+3+4-wappcon: Received command 'PROJECT a2048 J. Davies' 2008-Jul-16 01:54:17 LOG4 WAPP=1+2+3+4-wappcon: Received command 'VERBOSE 0' 2008-Jul-16 01:54:17 LOG4 WAPP=1+2+3+4-wappcon: Received command 'TIMEOUT 5' 2008-Jul-16 01:54:17 LOG4 WAPP=1+2+3+4-wappcon: Received command 'PROJECT a2048 J. Davies' 2008-Jul-16 01:54:17 NOTE WAPPDATA-new_file: New FITS file: wapp.20080716.a2048.0000.fits 2008-Jul-16 01:54:18 LOG4 send_obs_status: To obs_status: <1> FILENAME {wapp.20080716.a2048.0000.fits} 2008-Jul-16 01:54:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:54:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5151 19.6900 RA/Dec = 20:25:07 +35:57:10 2008-Jul-16 01:54:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:54:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 155.5151 19.6900 RA/Dec = 20:25:37 +35:57:10 2008-Jul-16 01:55:00 COMMAND CIMA-send_to_exec: Sending command to point to a source 2008-Jul-16 01:55:00 LOG4 exec_msg: From OBSERVER: track_new_source J223226+231111 223536.1 231111 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 18256 Topocentric velocity(optical) 0 0 0 0 0 2008-Jul-16 01:55:00 LOG1 track_new_source: Calling 'track_new_source J223226+231111 223536.1 231111 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 18256 Topocentric velocity(optical) 0 0 0 0 0' 2008-Jul-16 01:55:00 BEGIN begin_task: Starting task 'selecting new source' 2008-Jul-16 01:55:00 LOG5 begin_task: Level: (1) ID = <10012> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Sending Tracking Commands} SOURCE {J223226+231111} INFO {Selecting source 'J223226+231111' ...} 2008-Jul-16 01:55:00 LOG3 track_source: Calling 'track_source J223226+231111 223536.1 231111 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 18256 Topocentric velocity(optical)' 2008-Jul-16 01:55:00 START begin_task: Starting task 'sending tracking commands' 2008-Jul-16 01:55:00 LOG5 begin_task: Level: (2) ID = <10013> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Sending Tracking Commands} SOURCE {J223226+231111} INFO {Slewing to source 'J223226+231111' ...} 2008-Jul-16 01:55:00 INFO1 track_source: Starting to track J223226+231111 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: set ra 223536.1 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: set dec 231111 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: pnt tr send 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: pnt tr 223536.1 231111 -CJ 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: dopsetvel 18256 topo 2008-Jul-16 01:55:00 STOP finish_task: Finishing task 'sending tracking commands' 2008-Jul-16 01:55:00 LOG5 finish_task: Level: (2) ID = <10013> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 INFO2 finish_task: DONE finished sending: tracking commands 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 01:55:00 STOP end_task: Finishing task 'sending tracking commands' with status 'OK' 2008-Jul-16 01:55:00 LOG5 end_task: Level: (2) ID = <10013> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 LOG4 apply_pointing_corr: Calling 'apply_pointing_corr 0 0 0 0 0' 2008-Jul-16 01:55:00 START begin_task: Starting task 'applying pointing corrections' 2008-Jul-16 01:55:00 LOG5 begin_task: Level: (2) ID = <10014> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Applying Pointing Corrections} INFO {Applying pointing corrections ...} 2008-Jul-16 01:55:00 LOG3 vw_send: To DATATAKING: pnt cor setoff 0.0 0.0 2008-Jul-16 01:55:00 STOP finish_task: Finishing task 'applying pointing corrections' 2008-Jul-16 01:55:00 LOG5 finish_task: Level: (2) ID = <10014> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 INFO2 finish_task: DONE finished applying: pointing corrections 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 01:55:00 STOP end_task: Finishing task 'applying pointing corrections' with status 'OK' 2008-Jul-16 01:55:00 LOG5 end_task: Level: (2) ID = <10014> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 STOP finish_task: Finishing task 'selecting new source' 2008-Jul-16 01:55:00 LOG5 finish_task: Level: (1) ID = <10012> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 DONE finish_task: DONE finished selecting: new source 2008-Jul-16 01:55:00 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 01:55:00 END end_task: Finishing task 'selecting new source' with status 'OK' 2008-Jul-16 01:55:00 LOG5 end_task: Level: (1) ID = <10012> Status = 0 0 0 0 ok 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: set ra 223536.1 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: set dec 231111 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% 223536.1 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% 231111 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: pnt tr send 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: pnt tr 223536.1 231111 -CJ 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: dopsetvel 18256 topo 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: pnt cor setoff 0.0 0.0 2008-Jul-16 01:55:00 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 01:55:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:55:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 164.3097 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:55:46 COMMAND CIMA-send_to_exec: Sending command to run standard on/off 2008-Jul-16 01:55:46 LOG4 exec_msg: From OBSERVER: onoff 1 300 60 hcorcal 10 each first 0 2008-Jul-16 01:55:46 LOG1 onoff_wapp: Calling 'onoff_wapp 1 300 60 hcorcal 10 each first 0' 2008-Jul-16 01:55:46 BEGIN begin_task: Starting task 'standard on/off' 2008-Jul-16 01:55:46 LOG5 begin_task: Level: (1) ID = <10015> Status = 0 0 0 0 ok 2008-Jul-16 01:55:46 INFO4 begin_task: MAKING 'standard on/off' using 'alfa' + 'WAPP' on 'J223226+231111' 2008-Jul-16 01:55:46 INFO1 onoff_wapp: Starting pattern: Standard on/off 2008-Jul-16 01:55:46 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Standard on/off} TOTALLOOPS 1 INFO {Starting standard on/off observation ...} 2008-Jul-16 01:55:46 START begin_task: Starting task 'waiting on telescope' 2008-Jul-16 01:55:46 LOG5 begin_task: Level: (2) ID = <10016> Status = 0 0 0 0 ok 2008-Jul-16 01:55:46 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Waiting On Telescope} TASKWAIT BITMAP stat_slew INFO {Waiting for telescope to track source ...} 2008-Jul-16 01:55:46 LOG3 waittrk: Start waittrk 5 2008-Jul-16 01:55:46 START begin_task: Starting task 'waiting on telescope movement' 2008-Jul-16 01:55:46 LOG5 begin_task: Level: (3) ID = <10017> Status = 0 0 0 0 ok 2008-Jul-16 01:55:51 STOP end_task: Finishing task 'waiting on telescope movement' with status 'OK' 2008-Jul-16 01:55:51 LOG5 end_task: Level: (3) ID = <10017> Status = 0 0 0 0 ok 2008-Jul-16 01:55:51 START begin_task: Starting task 'waiting on telescope on source' 2008-Jul-16 01:55:51 LOG5 begin_task: Level: (3) ID = <10018> Status = 0 0 0 0 ok 2008-Jul-16 01:55:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:55:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 176.8097 19.6901 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:56:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:56:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 189.3118 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:56:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:56:57 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 201.8113 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:57:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:57:27 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 214.3109 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:57:57 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:57:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 226.8150 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:58:27 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:58:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 239.3169 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:58:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:58:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.6906 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:59:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:59:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 252.2270 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 01:59:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 01:59:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 252.1712 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:00:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:00:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 252.1151 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:00:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:00:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 252.0573 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:01:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:01:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.9992 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:01:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:01:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.9402 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:02:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:02:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.8801 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:02:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:02:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.8195 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:03:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.69) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:03:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.7571 19.6900 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'waiting on telescope on source' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (3) ID = <10018> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG4 send_obs_status: To obs_status: <0> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:03:43 INFO2 waittrk: Now tracking J223226+231111 2008-Jul-16 02:03:43 LOG4 waittrk: Current telescope position: Az = 251.73 ZA = 19.68 2008-Jul-16 02:03:43 STOP finish_task: Finishing task 'waiting on telescope' 2008-Jul-16 02:03:43 LOG5 finish_task: Level: (2) ID = <10016> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 INFO2 finish_task: DONE finished waiting: telescope on source 2008-Jul-16 02:03:43 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'waiting on telescope' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (2) ID = <10016> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 START begin_task: Starting task 'selecting calibration type' 2008-Jul-16 02:03:43 LOG5 begin_task: Level: (2) ID = <10019> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG3 vw_send: To DATATAKING: setcal hcorcal 2008-Jul-16 02:03:43 LOG2 socket_wait: Starting sockwait on DATATAKING for 'setcal' using string 'DONE' 2008-Jul-16 02:03:43 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:03:43 START begin_task: Starting task 'waiting on setcal' 2008-Jul-16 02:03:43 LOG5 begin_task: Level: (3) ID = <10020> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG4 got_cormsg: From DATATAKING: setcal hcorcal 2008-Jul-16 02:03:43 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:03:43 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:43 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'waiting on setcal' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (3) ID = <10020> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'setcal' 2008-Jul-16 02:03:43 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:03:43 LOG3 socket_wait: To ALFAMON: CAL HI 2008-Jul-16 02:03:43 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:03:43 LOG5 begin_task: Level: (3) ID = <10021> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:43 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (3) ID = <10021> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:03:43 LOG3 to_alfamon: To ALFAMON: CAL HI 2008-Jul-16 02:03:43 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:03:43 LOG3 socket_wait: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:03:43 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:03:43 LOG5 begin_task: Level: (3) ID = <10022> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (3) ID = <10022> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:03:43 LOG3 to_alfamon: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:03:43 STOP end_task: Finishing task 'selecting calibration type' with status 'OK' 2008-Jul-16 02:03:43 LOG5 end_task: Level: (2) ID = <10019> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG3 send_to_one_wapp: To WAPPCON: PROJECT a2048 J. Davies 2008-Jul-16 02:03:43 LOG3 send_to_one_wapp: To WAPPCON2: PROJECT a2048 J. Davies 2008-Jul-16 02:03:43 LOG3 send_to_one_wapp: To WAPPCON3: PROJECT a2048 J. Davies 2008-Jul-16 02:03:43 LOG3 send_to_one_wapp: To WAPPCON4: PROJECT a2048 J. Davies 2008-Jul-16 02:03:43 INFO5 new_file: There is no need to start a new FITS-file since the current one 'wapp.20080716.a2048.0000.fits' is empty! 2008-Jul-16 02:03:43 INFO2 onoff_wapp: Starting standard on/off loop 1 of 1 2008-Jul-16 02:03:43 LOG4 send_obs_status: To obs_status: <1> LOOP 1 TOTALPARTS 2 PART 1 INFO {Making ON observation followed by OFF} 2008-Jul-16 02:03:43 START begin_task: Starting task 'clearing telescope offsets' 2008-Jul-16 02:03:43 LOG5 begin_task: Level: (2) ID = <10023> Status = 0 0 0 0 ok 2008-Jul-16 02:03:43 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Clearing Telescope Offsets} INFO {Removing telescope offsets ...} 2008-Jul-16 02:03:43 INFO3 clear_offsets: Removing telescope offsets 2008-Jul-16 02:03:44 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:03:44 LOG3 vw_send: To DATATAKING: pnt tr 223536.100000 231111.000000 -CJ 2008-Jul-16 02:03:44 STOP finish_task: Finishing task 'clearing telescope offsets' 2008-Jul-16 02:03:44 LOG5 finish_task: Level: (2) ID = <10023> Status = 0 0 0 0 ok 2008-Jul-16 02:03:44 INFO2 finish_task: DONE finished clearing: telescope offsets 2008-Jul-16 02:03:44 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:03:44 STOP end_task: Finishing task 'clearing telescope offsets' with status 'OK' 2008-Jul-16 02:03:44 LOG5 end_task: Level: (2) ID = <10023> Status = 0 0 0 0 ok 2008-Jul-16 02:03:44 START begin_task: Starting task 'waiting on telescope' 2008-Jul-16 02:03:44 LOG5 begin_task: Level: (2) ID = <10024> Status = 0 0 0 0 ok 2008-Jul-16 02:03:44 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Waiting On Telescope} TASKWAIT BITMAP stat_slew INFO {Waiting for telescope to track source ...} 2008-Jul-16 02:03:44 LOG3 waittrk: Start waittrk 5 2008-Jul-16 02:03:44 START begin_task: Starting task 'waiting on telescope movement' 2008-Jul-16 02:03:44 LOG5 begin_task: Level: (3) ID = <10025> Status = 0 0 0 0 ok 2008-Jul-16 02:03:44 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:03:44 LOG4 got_cormsg: From DATATAKING: pnt tr 223536.100000 231111.000000 -CJ 2008-Jul-16 02:03:44 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:03:44 LOG4 WAPP=1+2+3+4-wappcon: Received command 'PROJECT a2048 J. Davies' 2008-Jul-16 02:03:49 STOP end_task: Finishing task 'waiting on telescope movement' with status 'OK' 2008-Jul-16 02:03:49 LOG5 end_task: Level: (3) ID = <10025> Status = 0 0 0 0 ok 2008-Jul-16 02:03:49 START begin_task: Starting task 'waiting on telescope on source' 2008-Jul-16 02:03:49 LOG5 begin_task: Level: (3) ID = <10026> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 STOP end_task: Finishing task 'waiting on telescope on source' with status 'OK' 2008-Jul-16 02:03:51 LOG5 end_task: Level: (3) ID = <10026> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 LOG4 send_obs_status: To obs_status: <0> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:03:51 INFO2 waittrk: Now tracking J223226+231111 2008-Jul-16 02:03:51 LOG4 waittrk: Current telescope position: Az = 251.71 ZA = 19.64 2008-Jul-16 02:03:51 STOP finish_task: Finishing task 'waiting on telescope' 2008-Jul-16 02:03:51 LOG5 finish_task: Level: (2) ID = <10024> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 INFO2 finish_task: DONE finished waiting: telescope on source 2008-Jul-16 02:03:51 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:03:51 STOP end_task: Finishing task 'waiting on telescope' with status 'OK' 2008-Jul-16 02:03:51 LOG5 end_task: Level: (2) ID = <10024> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 LOG5 antvel: Calling 'antvel 223536.100000 231111.000000 J 0' 2008-Jul-16 02:03:51 LOG2 antvel: Precessing RA = 22:35:36.1 Dec = +23:11:11.0 Epoch = 2008.54233 J 2008-Jul-16 02:03:51 LOG2 antvel: Computed apparent RA = 22:36:02.1 Dec = +23:13:50.5 2008-Jul-16 02:03:51 LOG2 antvel: Parameters to Doppler: Topocentric 21831 2008 198 0.0 2008-Jul-16 02:03:51 INFO5 antvel: Computed antenna velocity: +0.00000 km/s 2008-Jul-16 02:03:51 LOG3 dopset_gen: Parameters for 'rest2sky': vel=18256.000000 veltype=velocity(optical) calctype=SUBBAND antvel=0.0 restcent=1420.405751786 rest0=1420.405751786 rest1=1420.405751786 rest2=1420.405751786 rest3=1420.405751786 rest4=1420.405751786 rest5=1420.405751786 rest6=1420.405751786 rest7=1420.405751786 2008-Jul-16 02:03:51 INFO4 dopset_gen: New sky frequencies: 1338.874379 1338.874379 1338.874379 1338.874379 1338.874379 1338.874379 1338.874379 1338.874379 1338.874379 2008-Jul-16 02:03:51 LOG3 dopset_gen: Parameters for 'sky2syn': skycent=1338.874379 sky0=1338.874379 sky1=1338.874379 sky2=1338.874379 sky3=1338.874379 sky4=1338.874379 sky5=1338.874379 sky6=1338.874379 sky7=1338.874379 dest0=250 dest1=250 dest2=250 dest3=250 dest4=250 dest5=250 dest6=250 dest7=250 2008-Jul-16 02:03:51 LOG2 dopset_gen: Result from 'sky2syn': 1588.874379 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 2008-Jul-16 02:03:51 LOG3 vw_send: To DATATAKING: if1 {if1_syn1 1588874379.0} 2008-Jul-16 02:03:51 LOG3 vw_send: To DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 02:03:51 START begin_task: Starting task 'adjusting WAPP power' 2008-Jul-16 02:03:51 LOG5 begin_task: Level: (2) ID = <10027> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Adjusting WAPP power} TASKWAIT BITMAP stat_power INFO {Adjusting WAPP power ...} 2008-Jul-16 02:03:51 INFO2 adjust_power: Starting to adjust WAPP power 2008-Jul-16 02:03:51 LOG3 vw_send: To DATATAKING: adjpwrif2 2008-Jul-16 02:03:51 LOG2 socket_wait: Starting sockwait on DATATAKING for 'adjpwrif2' using string 'DONE' 2008-Jul-16 02:03:51 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:03:51 START begin_task: Starting task 'waiting on adjpwrif2' 2008-Jul-16 02:03:51 LOG5 begin_task: Level: (3) ID = <10028> Status = 0 0 0 0 ok 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: if1 {if1_syn1 1588874379.0} 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: adjpwrif2 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:51 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:54 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:54 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:03:54 STOP end_task: Finishing task 'waiting on adjpwrif2' with status 'OK' 2008-Jul-16 02:03:54 LOG5 end_task: Level: (3) ID = <10028> Status = 0 0 0 0 ok 2008-Jul-16 02:03:54 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'adjpwrif2' 2008-Jul-16 02:03:54 START begin_task: Starting task 'adjusting WAPP power' 2008-Jul-16 02:03:54 LOG5 begin_task: Level: (3) ID = <10029> Status = 0 0 0 0 ok 2008-Jul-16 02:03:54 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Adjusting WAPP Power} TASKWAIT BITMAP stat_power INFO {Adjusting power ...} 2008-Jul-16 02:03:54 LOG3 sock_errsend: To WAPPCON: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:03:54 LOG3 sock_errsend: To WAPPCON2: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:03:54 LOG3 sock_errsend: To WAPPCON3: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:03:54 LOG3 sock_errsend: To WAPPCON4: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:03:54 START begin_task: Starting task 'waiting on adjust WAPP power' 2008-Jul-16 02:03:54 LOG5 begin_task: Level: (4) ID = <10030> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 LOG4 WAPP=1+2+3+4-wappcon: Received command 'ADJUSTPOWER 100 1 2 0 1 1' 2008-Jul-16 02:03:55 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:03:55 INFO2 WAPP=1-auto_atten_dual: Attenuators beam 0: 9 7 dB --- beam 1: 9 7 dB 2008-Jul-16 02:03:55 INFO2 WAPP=3-auto_atten_dual: Attenuators beam 4: 4 4 dB --- beam 5: 8 7 dB 2008-Jul-16 02:03:55 INFO2 WAPP=2-auto_atten_dual: Attenuators beam 2: 7 5 dB --- beam 3: 6 5 dB 2008-Jul-16 02:03:55 INFO2 WAPP=4-auto_atten_dual: Attenuators beam 6: 4 3 dB --- beam 7: 3 4 dB 2008-Jul-16 02:03:55 INFO1 WAPP=1+2+3+4-adjust_power: DONE adjusting power 2008-Jul-16 02:03:55 STOP end_task: Finishing task 'waiting on adjust WAPP power' with status 'OK' 2008-Jul-16 02:03:55 LOG5 end_task: Level: (4) ID = <10030> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 INFO2 wapp_adjpwr: WAPP power: ALFA beam 0: 1.072 1.023 ALFA beam 1: 0.913 0.998 2008-Jul-16 02:03:55 INFO2 wapp_adjpwr: WAPP power: ALFA beam 2: 0.962 1.003 ALFA beam 3: 0.967 0.927 2008-Jul-16 02:03:55 INFO2 wapp_adjpwr: WAPP power: ALFA beam 4: 0.988 0.972 ALFA beam 5: 0.916 0.931 2008-Jul-16 02:03:55 INFO2 wapp_adjpwr: WAPP power: ALFA beam 6: 0.979 0.993 ALFA beam 7: 1.090 0.893 2008-Jul-16 02:03:55 STOP finish_task: Finishing task 'adjusting WAPP power' 2008-Jul-16 02:03:55 LOG5 finish_task: Level: (3) ID = <10029> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 INFO3 finish_task: DONE finished adjusting: WAPP power 2008-Jul-16 02:03:55 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:03:55 STOP end_task: Finishing task 'adjusting WAPP power' with status 'OK' 2008-Jul-16 02:03:55 LOG5 end_task: Level: (3) ID = <10029> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_busy 2008-Jul-16 02:03:55 STOP finish_task: Finishing task 'adjusting WAPP power' 2008-Jul-16 02:03:55 LOG5 finish_task: Level: (2) ID = <10027> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 INFO2 finish_task: DONE finished adjusting: WAPP power levels 2008-Jul-16 02:03:55 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:03:55 STOP end_task: Finishing task 'adjusting WAPP power' with status 'OK' 2008-Jul-16 02:03:55 LOG5 end_task: Level: (2) ID = <10027> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 LOG4 send_obs_status: To obs_status: <1> BITMAP stat_onoff_on MESSAGE {Taking ON scan ...} 2008-Jul-16 02:03:55 LOG4 take_data: Calling 'take_data 300 1 ONOFF ON -' 2008-Jul-16 02:03:55 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:03:55 LOG5 begin_task: Level: (2) ID = <10031> Status = 0 0 0 0 ok 2008-Jul-16 02:03:55 LOG5 log_alfabeam: Parameters: 22.593361111111111 23.186388888888889 21.245028 2008.542330056785 19.881783 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 0 22.593361111111108 23.186388888888892 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 1 22.586089085476100 23.151363590065881 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 2 22.591905781674324 23.095347609120115 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 3 22.599184216287995 23.130022166839861 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 4 22.600633847017416 23.221499200330541 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 5 22.594788513881007 23.277661201558534 2008-Jul-16 02:03:55 LOG4 log_alfabeam: ALFABEAM 6 22.587522314838541 23.242200316337851 2008-Jul-16 02:03:55 INFO2 take_data: Starting WAPP scan: 819800001 2008-Jul-16 02:03:56 LOG4 send_obs_status: To obs_status: <0> TASKTIME 300 2008-Jul-16 02:03:56 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:03:56 LOG5 begin_task: Level: (3) ID = <10032> Status = 0 0 0 0 ok 2008-Jul-16 02:03:56 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:03:56 INFO1 WAPP=1+2+3+4-start_spectra: start sec 21837.00 2008-Jul-16 02:03:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.62) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:03:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.6941 19.6193 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1588.874379 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:03:58 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:04:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.51) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:04:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.6302 19.5058 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:04:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.39) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:04:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.5653 19.3922 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:06:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.05) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:06:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.3639 19.0522 RA/Dec = 22:35:36 +23:11:11 2008-Jul-16 02:08:57 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:08:57 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:08:57 LOG5 end_task: Level: (3) ID = <10032> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:08:57 LOG5 end_task: Level: (2) ID = <10031> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 LOG4 send_obs_status: To obs_status: <1> PART 2 INFO {Waiting for OFF observation followed by CAL} 2008-Jul-16 02:08:57 LOG2 onoff_wapp: Parameters: RA-offset: -90.707099999997851 arcminutes wait: 60 secs 2008-Jul-16 02:08:57 LOG4 track_offsets: Calling 'track_offsets -90.707099999997851 0.0 main small' 2008-Jul-16 02:08:57 START begin_task: Starting task 'sending telescope offsets' 2008-Jul-16 02:08:57 LOG5 begin_task: Level: (2) ID = <10033> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Sending Telescope Offsets} INFO {Changing telescope offsets ...} 2008-Jul-16 02:08:57 INFO2 track_offsets: Starting to send new offsets 2008-Jul-16 02:08:57 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:08:57 LOG3 vw_send: To DATATAKING: pnt tr 223536.100000 231111.000000 -CJ -o -UD -1.51178 0.0 -CH 2008-Jul-16 02:08:57 STOP finish_task: Finishing task 'sending telescope offsets' 2008-Jul-16 02:08:57 LOG5 finish_task: Level: (2) ID = <10033> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 INFO2 finish_task: DONE finished sending: telescope offsets 2008-Jul-16 02:08:57 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:08:57 STOP end_task: Finishing task 'sending telescope offsets' with status 'OK' 2008-Jul-16 02:08:57 LOG5 end_task: Level: (2) ID = <10033> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 INFO2 lstwait: Waiting for 59.8 secs from LST 21:19:45 to LST 21:20:45 ... 2008-Jul-16 02:08:57 LOG4 send_obs_status: To obs_status: <1> TASKTIME 59.836175999996598 BITMAP stat_wait MESSAGE {Waiting ...} 2008-Jul-16 02:08:57 START begin_task: Starting task 'waiting on wait on LST' 2008-Jul-16 02:08:57 LOG5 begin_task: Level: (2) ID = <10034> Status = 0 0 0 0 ok 2008-Jul-16 02:08:57 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:08:57 LOG4 got_cormsg: From DATATAKING: pnt tr 223536.100000 231111.000000 -CJ -o -UD -1.51178 0.0 -CH 2008-Jul-16 02:08:57 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:09:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.57) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:09:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.7617 19.5699 RA/Dec = 22:41:39 +23:11:09 2008-Jul-16 02:09:45 INFO4 wait_and_tell_when_on_source: Telescope is now on source 'J223226+231111' (after 48 seconds) 2008-Jul-16 02:09:57 STOP end_task: Finishing task 'waiting on wait on LST' with status 'OK' 2008-Jul-16 02:09:57 LOG5 end_task: Level: (2) ID = <10034> Status = 0 0 0 0 ok 2008-Jul-16 02:09:57 LOG4 lstwait: Finished waiting 0.16 seconds late 2008-Jul-16 02:09:57 INFO3 lstwait: Finished waiting 2008-Jul-16 02:09:57 LOG4 send_obs_status: To obs_status: <1> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:09:57 LOG4 send_obs_status: To obs_status: <1> BITMAP stat_onoff_off MESSAGE {Taking OFF scan ...} 2008-Jul-16 02:09:57 LOG4 take_data: Calling 'take_data 300 1 ONOFF OFF -' 2008-Jul-16 02:09:57 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:09:57 LOG5 begin_task: Level: (2) ID = <10035> Status = 0 0 0 0 ok 2008-Jul-16 02:09:57 LOG5 log_alfabeam: Parameters: 22.593361111111111 23.186388888888889 21.345859 2008.5423415278728 19.881783 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 0 22.593361111111108 23.186388888888896 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 1 22.586152801515627 23.148946357051155 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 2 22.592065161936894 23.094896395972672 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 3 22.599281330310593 23.131967216441605 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 4 22.600569804613773 23.223929498752092 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 5 22.594626075656048 23.278121029516605 2008-Jul-16 02:09:57 LOG4 log_alfabeam: ALFABEAM 6 22.587425390371244 23.240208995376136 2008-Jul-16 02:09:57 INFO2 take_data: Starting WAPP scan: 819800002 2008-Jul-16 02:09:58 LOG4 send_obs_status: To obs_status: <0> TASKTIME 300 2008-Jul-16 02:09:58 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:09:58 LOG5 begin_task: Level: (3) ID = <10036> Status = 0 0 0 0 ok 2008-Jul-16 02:09:58 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:09:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.63) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:09:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.6978 19.6262 RA/Dec = 22:41:39 +23:11:09 2008-Jul-16 02:09:58 INFO1 WAPP=1+2+3+4-start_spectra: start sec 22199.00 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1588.874379 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:10:00 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:10:12 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:10:14 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:17 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:10:18 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:19 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:10:19 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:10:22 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:10:23 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:10:23 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:10:24 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:26 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.51) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:10:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.6338 19.5127 RA/Dec = 22:41:39 +23:11:09 2008-Jul-16 02:10:29 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:29 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:30 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:10:34 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:34 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:10:35 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:10:38 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:10:44 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:10:44 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:10:47 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:10:48 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:49 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:10:53 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:55 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:56 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:10:56 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:10:57 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:10:58 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.40) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:10:58 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.5694 19.3993 RA/Dec = 22:41:39 +23:11:09 2008-Jul-16 02:10:58 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:10:59 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:11:02 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 10 (99999966 != 99999964)! 2008-Jul-16 02:11:13 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:11:17 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:11:19 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:11:19 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:11:37 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:11:40 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:11:41 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:11:44 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:11:45 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:11:49 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:11:51 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:12:16 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:12:27 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:12:28 WARNING CIMA-warn_on_position: WARNING the telescope is close (ZA = 19.06) to the zenith angle limit 19.69 degrees! 2008-Jul-16 02:12:28 LOG4 CIMA-warn_on_position: Current position: Az/ZA = 251.3681 19.0592 RA/Dec = 22:41:39 +23:11:09 2008-Jul-16 02:12:36 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:12:37 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:12:38 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:12:53 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:13:26 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:13:35 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:13:46 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:14:00 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:14:00 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:14:40 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:14:59 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:14:59 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:14:59 LOG5 end_task: Level: (3) ID = <10036> Status = 0 0 0 0 ok 2008-Jul-16 02:14:59 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:14:59 LOG5 end_task: Level: (2) ID = <10035> Status = 0 0 0 0 ok 2008-Jul-16 02:14:59 LOG2 take_cal: Calling 'take_cal hcorcal 10 0' 2008-Jul-16 02:14:59 START begin_task: Starting task 'WAPP calibration' 2008-Jul-16 02:14:59 LOG5 begin_task: Level: (2) ID = <10037> Status = 0 0 0 0 ok 2008-Jul-16 02:14:59 LOG4 send_obs_status: To obs_status: <0> NEWTASK {WAPP Calibration} INFO {Making WAPP calibration ...} 2008-Jul-16 02:14:59 START begin_task: Starting task 'selecting calibration type' 2008-Jul-16 02:14:59 LOG5 begin_task: Level: (3) ID = <10038> Status = 0 0 0 0 ok 2008-Jul-16 02:14:59 LOG3 vw_send: To DATATAKING: setcal hcorcal 2008-Jul-16 02:14:59 LOG2 socket_wait: Starting sockwait on DATATAKING for 'setcal' using string 'DONE' 2008-Jul-16 02:14:59 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:14:59 START begin_task: Starting task 'waiting on setcal' 2008-Jul-16 02:14:59 LOG5 begin_task: Level: (4) ID = <10039> Status = 0 0 0 0 ok 2008-Jul-16 02:14:59 LOG4 got_cormsg: From DATATAKING: setcal hcorcal 2008-Jul-16 02:14:59 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:15:00 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:15:00 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:15:00 STOP end_task: Finishing task 'waiting on setcal' with status 'OK' 2008-Jul-16 02:15:00 LOG5 end_task: Level: (4) ID = <10039> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'setcal' 2008-Jul-16 02:15:00 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:15:00 LOG3 socket_wait: To ALFAMON: CAL HI 2008-Jul-16 02:15:00 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:15:00 LOG5 begin_task: Level: (4) ID = <10040> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:15:00 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:15:00 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:15:00 LOG5 end_task: Level: (4) ID = <10040> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:15:00 LOG3 to_alfamon: To ALFAMON: CAL HI 2008-Jul-16 02:15:00 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:15:00 LOG3 socket_wait: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:15:00 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:15:00 LOG5 begin_task: Level: (4) ID = <10041> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:15:00 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:15:00 LOG5 end_task: Level: (4) ID = <10041> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:15:00 LOG3 to_alfamon: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:15:00 STOP end_task: Finishing task 'selecting calibration type' with status 'OK' 2008-Jul-16 02:15:00 LOG5 end_task: Level: (3) ID = <10038> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_cal_on MESSAGE {Setting CAL-ON ...} 2008-Jul-16 02:15:00 LOG3 wapp_calcontrol: To CALCONTROL: CALON 2008-Jul-16 02:15:00 LOG3 sock_errsend: To CALCONTROL: CALON STATUS 2008-Jul-16 02:15:00 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 02:15:00 LOG5 begin_task: Level: (3) ID = <10042> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 02:15:00 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x03 2008-Jul-16 02:15:00 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 02:15:00 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 02:15:00 LOG5 end_task: Level: (3) ID = <10042> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG4 send_obs_status: To obs_status: <0> MESSAGE {Taking CAL-ON spectra ...} 2008-Jul-16 02:15:00 LOG4 take_data: Calling 'take_data 10 10 CAL ON -' 2008-Jul-16 02:15:00 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:15:00 LOG5 begin_task: Level: (3) ID = <10043> Status = 0 0 0 0 ok 2008-Jul-16 02:15:00 LOG5 log_alfabeam: Parameters: 22.593361111111111 23.186388888888889 21.429977 2008.5423510976752 19.881783 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 0 22.593361111111111 23.186388888888885 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 1 22.586215867710070 23.146717358148788 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 2 22.592214075476527 23.094524412117185 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 3 22.599368608912624 23.133804990754605 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 4 22.600506382761182 23.226170674691879 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 5 22.594474232964409 23.278499651570641 2008-Jul-16 02:15:00 LOG4 log_alfabeam: ALFABEAM 6 22.587338422107507 23.238327332540557 2008-Jul-16 02:15:00 INFO2 take_data: Starting WAPP scan: 819800003 2008-Jul-16 02:15:01 LOG4 send_obs_status: To obs_status: <0> TASKTIME 10 2008-Jul-16 02:15:01 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:15:01 LOG5 begin_task: Level: (4) ID = <10044> Status = 0 0 0 0 ok 2008-Jul-16 02:15:01 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:15:01 INFO1 WAPP=1+2+3+4-start_spectra: start sec 22502.00 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1588.874379 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:12 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:12 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:15:12 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:15:12 LOG5 end_task: Level: (4) ID = <10044> Status = 0 0 0 0 ok 2008-Jul-16 02:15:12 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:15:12 LOG5 end_task: Level: (3) ID = <10043> Status = 0 0 0 0 ok 2008-Jul-16 02:15:12 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_cal_off MESSAGE {Setting CAL-OFF ...} 2008-Jul-16 02:15:12 LOG3 wapp_calcontrol: To CALCONTROL: CALOFF 2008-Jul-16 02:15:12 LOG3 sock_errsend: To CALCONTROL: CALOFF STATUS 2008-Jul-16 02:15:12 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 02:15:12 LOG5 begin_task: Level: (3) ID = <10045> Status = 0 0 0 0 ok 2008-Jul-16 02:15:12 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 02:15:12 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x02 2008-Jul-16 02:15:12 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 02:15:12 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 02:15:12 LOG5 end_task: Level: (3) ID = <10045> Status = 0 0 0 0 ok 2008-Jul-16 02:15:12 LOG4 send_obs_status: To obs_status: <0> MESSAGE {Taking CAL-OFF spectra ...} 2008-Jul-16 02:15:12 LOG4 take_data: Calling 'take_data 10 10 CAL OFF -' 2008-Jul-16 02:15:12 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:15:12 LOG5 begin_task: Level: (3) ID = <10046> Status = 0 0 0 0 ok 2008-Jul-16 02:15:12 LOG5 log_alfabeam: Parameters: 22.593361111111111 23.186388888888889 21.433598 2008.5423515096204 19.881783 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 0 22.593361111111108 23.186388888888892 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 1 22.586218821216821 23.146616491891901 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 2 22.592220859073155 23.094508597466525 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 3 22.599372505924013 23.133889175710717 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 4 22.600503411894284 23.226272093961615 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 5 22.594467314447893 23.278515734580949 2008-Jul-16 02:15:12 LOG4 log_alfabeam: ALFABEAM 6 22.587334542375970 23.238241136109803 2008-Jul-16 02:15:12 INFO2 take_data: Starting WAPP scan: 819800004 2008-Jul-16 02:15:13 LOG4 send_obs_status: To obs_status: <0> TASKTIME 10 2008-Jul-16 02:15:13 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:15:13 LOG5 begin_task: Level: (4) ID = <10047> Status = 0 0 0 0 ok 2008-Jul-16 02:15:13 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:15:13 INFO1 WAPP=1+2+3+4-start_spectra: start sec 22514.00 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1588.874379 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:24 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1338.874379 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:15:24 INFO1 WAPP=1+2+3+4-start_spectra: Skipping Tsys 2008-Jul-16 02:15:24 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:15:24 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:15:24 LOG5 end_task: Level: (4) ID = <10047> Status = 0 0 0 0 ok 2008-Jul-16 02:15:24 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:15:24 LOG5 end_task: Level: (3) ID = <10046> Status = 0 0 0 0 ok 2008-Jul-16 02:15:24 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_busy 2008-Jul-16 02:15:24 STOP finish_task: Finishing task 'WAPP calibration' 2008-Jul-16 02:15:24 LOG5 finish_task: Level: (2) ID = <10037> Status = 0 0 0 0 ok 2008-Jul-16 02:15:24 INFO2 finish_task: DONE finished calibration: WAPP calibration 2008-Jul-16 02:15:25 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:15:25 STOP end_task: Finishing task 'WAPP calibration' with status 'OK' 2008-Jul-16 02:15:25 LOG5 end_task: Level: (2) ID = <10037> Status = 0 0 0 0 ok 2008-Jul-16 02:15:25 START begin_task: Starting task 'clearing telescope offsets' 2008-Jul-16 02:15:25 LOG5 begin_task: Level: (2) ID = <10048> Status = 0 0 0 0 ok 2008-Jul-16 02:15:25 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Clearing Telescope Offsets} INFO {Removing telescope offsets ...} 2008-Jul-16 02:15:26 INFO3 clear_offsets: Removing telescope offsets 2008-Jul-16 02:15:26 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:15:26 LOG3 vw_send: To DATATAKING: pnt tr 223536.100000 231111.000000 -CJ 2008-Jul-16 02:15:26 STOP finish_task: Finishing task 'clearing telescope offsets' 2008-Jul-16 02:15:26 LOG5 finish_task: Level: (2) ID = <10048> Status = 0 0 0 0 ok 2008-Jul-16 02:15:26 INFO2 finish_task: DONE finished clearing: telescope offsets 2008-Jul-16 02:15:26 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:15:26 STOP end_task: Finishing task 'clearing telescope offsets' with status 'OK' 2008-Jul-16 02:15:26 LOG5 end_task: Level: (2) ID = <10048> Status = 0 0 0 0 ok 2008-Jul-16 02:15:26 STOP finish_task: Finishing task 'standard on/off' 2008-Jul-16 02:15:26 LOG5 finish_task: Level: (1) ID = <10015> Status = 0 0 0 0 ok 2008-Jul-16 02:15:26 DONE finish_task: DONE finished pattern: standard on/off 2008-Jul-16 02:15:26 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 02:15:26 END end_task: Finishing task 'standard on/off' with status 'OK' 2008-Jul-16 02:15:26 LOG5 end_task: Level: (1) ID = <10015> Status = 0 0 0 0 ok 2008-Jul-16 02:15:26 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223226+231111" 2008-Jul-16 02:15:26 LOG4 got_cormsg: From DATATAKING: pnt tr 223536.100000 231111.000000 -CJ 2008-Jul-16 02:15:26 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:15:41 COMMAND CIMA-send_to_exec: Sending command to point to a source 2008-Jul-16 02:15:41 LOG4 exec_msg: From OBSERVER: track_new_source J223502+235235 223502.3 235235 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 9753 Topocentric velocity(optical) 0 0 0 0 0 2008-Jul-16 02:15:41 LOG1 track_new_source: Calling 'track_new_source J223502+235235 223502.3 235235 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 9753 Topocentric velocity(optical) 0 0 0 0 0' 2008-Jul-16 02:15:41 BEGIN begin_task: Starting task 'selecting new source' 2008-Jul-16 02:15:41 LOG5 begin_task: Level: (1) ID = <10049> Status = 0 0 0 0 ok 2008-Jul-16 02:15:41 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Sending Tracking Commands} SOURCE {J223502+235235} INFO {Selecting source 'J223502+235235' ...} 2008-Jul-16 02:15:41 LOG3 track_source: Calling 'track_source J223502+235235 223502.3 235235 J 0 0 main small /share/obs4/usr/a2048/n7332fu.cat 9753 Topocentric velocity(optical)' 2008-Jul-16 02:15:41 START begin_task: Starting task 'sending tracking commands' 2008-Jul-16 02:15:41 LOG5 begin_task: Level: (2) ID = <10050> Status = 0 0 0 0 ok 2008-Jul-16 02:15:41 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Sending Tracking Commands} SOURCE {J223502+235235} INFO {Slewing to source 'J223502+235235' ...} 2008-Jul-16 02:15:41 INFO1 track_source: Starting to track J223502+235235 2008-Jul-16 02:15:41 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:15:41 LOG3 vw_send: To DATATAKING: set ra 223502.3 2008-Jul-16 02:15:41 LOG3 vw_send: To DATATAKING: set dec 235235 2008-Jul-16 02:15:41 LOG3 vw_send: To DATATAKING: pnt tr send 2008-Jul-16 02:15:41 LOG3 vw_send: To DATATAKING: pnt tr 223502.3 235235 -CJ 2008-Jul-16 02:15:42 LOG3 vw_send: To DATATAKING: dopsetvel 9753 topo 2008-Jul-16 02:15:42 STOP finish_task: Finishing task 'sending tracking commands' 2008-Jul-16 02:15:42 LOG5 finish_task: Level: (2) ID = <10050> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 INFO2 finish_task: DONE finished sending: tracking commands 2008-Jul-16 02:15:42 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:15:42 STOP end_task: Finishing task 'sending tracking commands' with status 'OK' 2008-Jul-16 02:15:42 LOG5 end_task: Level: (2) ID = <10050> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 LOG4 apply_pointing_corr: Calling 'apply_pointing_corr 0 0 0 0 0' 2008-Jul-16 02:15:42 START begin_task: Starting task 'applying pointing corrections' 2008-Jul-16 02:15:42 LOG5 begin_task: Level: (2) ID = <10051> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Applying Pointing Corrections} INFO {Applying pointing corrections ...} 2008-Jul-16 02:15:42 LOG3 vw_send: To DATATAKING: pnt cor setoff 0.0 0.0 2008-Jul-16 02:15:42 STOP finish_task: Finishing task 'applying pointing corrections' 2008-Jul-16 02:15:42 LOG5 finish_task: Level: (2) ID = <10051> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 INFO2 finish_task: DONE finished applying: pointing corrections 2008-Jul-16 02:15:42 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:15:42 STOP end_task: Finishing task 'applying pointing corrections' with status 'OK' 2008-Jul-16 02:15:42 LOG5 end_task: Level: (2) ID = <10051> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 STOP finish_task: Finishing task 'selecting new source' 2008-Jul-16 02:15:42 LOG5 finish_task: Level: (1) ID = <10049> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 DONE finish_task: DONE finished selecting: new source 2008-Jul-16 02:15:42 LOG4 send_obs_status: To obs_status: <1> ENDTASK Finished 2008-Jul-16 02:15:42 END end_task: Finishing task 'selecting new source' with status 'OK' 2008-Jul-16 02:15:42 LOG5 end_task: Level: (1) ID = <10049> Status = 0 0 0 0 ok 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: set ra 223502.3 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: set dec 235235 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% 223502.3 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% 235235 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: pnt tr send 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: pnt tr 223502.3 235235 -CJ 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: dopsetvel 9753 topo 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: pnt cor setoff 0.0 0.0 2008-Jul-16 02:15:42 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:07 COMMAND CIMA-send_to_exec: Sending command to run standard on/off 2008-Jul-16 02:16:07 LOG4 exec_msg: From OBSERVER: onoff 1 300 60 hcorcal 10 each first 0 2008-Jul-16 02:16:07 LOG1 onoff_wapp: Calling 'onoff_wapp 1 300 60 hcorcal 10 each first 0' 2008-Jul-16 02:16:07 BEGIN begin_task: Starting task 'standard on/off' 2008-Jul-16 02:16:07 LOG5 begin_task: Level: (1) ID = <10052> Status = 0 0 0 0 ok 2008-Jul-16 02:16:07 INFO4 begin_task: MAKING 'standard on/off' using 'alfa' + 'WAPP' on 'J223502+235235' 2008-Jul-16 02:16:07 INFO1 onoff_wapp: Starting pattern: Standard on/off 2008-Jul-16 02:16:07 LOG4 send_obs_status: To obs_status: <1> NEWTASK {Standard on/off} TOTALLOOPS 1 INFO {Starting standard on/off observation ...} 2008-Jul-16 02:16:07 START begin_task: Starting task 'waiting on telescope' 2008-Jul-16 02:16:07 LOG5 begin_task: Level: (2) ID = <10053> Status = 0 0 0 0 ok 2008-Jul-16 02:16:07 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Waiting On Telescope} TASKWAIT BITMAP stat_slew INFO {Waiting for telescope to track source ...} 2008-Jul-16 02:16:07 LOG3 waittrk: Start waittrk 5 2008-Jul-16 02:16:07 START begin_task: Starting task 'waiting on telescope movement' 2008-Jul-16 02:16:07 LOG5 begin_task: Level: (3) ID = <10054> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 STOP end_task: Finishing task 'waiting on telescope movement' with status 'OK' 2008-Jul-16 02:16:12 LOG5 end_task: Level: (3) ID = <10054> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 START begin_task: Starting task 'waiting on telescope on source' 2008-Jul-16 02:16:12 LOG5 begin_task: Level: (3) ID = <10055> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 STOP end_task: Finishing task 'waiting on telescope on source' with status 'OK' 2008-Jul-16 02:16:12 LOG5 end_task: Level: (3) ID = <10055> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG4 send_obs_status: To obs_status: <0> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:16:12 INFO2 waittrk: Now tracking J223502+235235 2008-Jul-16 02:16:12 LOG4 waittrk: Current telescope position: Az = 247.39 ZA = 16.90 2008-Jul-16 02:16:12 STOP finish_task: Finishing task 'waiting on telescope' 2008-Jul-16 02:16:12 LOG5 finish_task: Level: (2) ID = <10053> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 INFO2 finish_task: DONE finished waiting: telescope on source 2008-Jul-16 02:16:12 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:16:12 STOP end_task: Finishing task 'waiting on telescope' with status 'OK' 2008-Jul-16 02:16:12 LOG5 end_task: Level: (2) ID = <10053> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 START begin_task: Starting task 'selecting calibration type' 2008-Jul-16 02:16:12 LOG5 begin_task: Level: (2) ID = <10056> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG3 vw_send: To DATATAKING: setcal hcorcal 2008-Jul-16 02:16:12 LOG2 socket_wait: Starting sockwait on DATATAKING for 'setcal' using string 'DONE' 2008-Jul-16 02:16:12 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:16:12 START begin_task: Starting task 'waiting on setcal' 2008-Jul-16 02:16:12 LOG5 begin_task: Level: (3) ID = <10057> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG4 got_cormsg: From DATATAKING: setcal hcorcal 2008-Jul-16 02:16:12 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:16:12 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:12 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:16:12 STOP end_task: Finishing task 'waiting on setcal' with status 'OK' 2008-Jul-16 02:16:12 LOG5 end_task: Level: (3) ID = <10057> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'setcal' 2008-Jul-16 02:16:12 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:16:12 LOG3 socket_wait: To ALFAMON: CAL HI 2008-Jul-16 02:16:12 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:16:12 LOG5 begin_task: Level: (3) ID = <10058> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:12 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:16:12 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:16:12 LOG5 end_task: Level: (3) ID = <10058> Status = 0 0 0 0 ok 2008-Jul-16 02:16:12 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:16:12 LOG3 to_alfamon: To ALFAMON: CAL HI 2008-Jul-16 02:16:12 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:16:12 LOG3 socket_wait: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:16:12 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:16:12 LOG5 begin_task: Level: (3) ID = <10059> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:16:13 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:16:13 LOG5 end_task: Level: (3) ID = <10059> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:16:13 LOG3 to_alfamon: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:16:13 STOP end_task: Finishing task 'selecting calibration type' with status 'OK' 2008-Jul-16 02:16:13 LOG5 end_task: Level: (2) ID = <10056> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG3 send_to_one_wapp: To WAPPCON: PROJECT a2048 J. Davies 2008-Jul-16 02:16:13 LOG3 send_to_one_wapp: To WAPPCON2: PROJECT a2048 J. Davies 2008-Jul-16 02:16:13 LOG3 send_to_one_wapp: To WAPPCON3: PROJECT a2048 J. Davies 2008-Jul-16 02:16:13 LOG3 send_to_one_wapp: To WAPPCON4: PROJECT a2048 J. Davies 2008-Jul-16 02:16:13 INFO2 onoff_wapp: Starting standard on/off loop 1 of 1 2008-Jul-16 02:16:13 LOG4 send_obs_status: To obs_status: <1> LOOP 1 TOTALPARTS 2 PART 1 INFO {Making ON observation followed by OFF} 2008-Jul-16 02:16:13 START begin_task: Starting task 'clearing telescope offsets' 2008-Jul-16 02:16:13 LOG5 begin_task: Level: (2) ID = <10060> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Clearing Telescope Offsets} INFO {Removing telescope offsets ...} 2008-Jul-16 02:16:13 INFO3 clear_offsets: Removing telescope offsets 2008-Jul-16 02:16:13 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:16:13 LOG3 vw_send: To DATATAKING: pnt tr 223502.300000 235235.000000 -CJ 2008-Jul-16 02:16:13 STOP finish_task: Finishing task 'clearing telescope offsets' 2008-Jul-16 02:16:13 LOG5 finish_task: Level: (2) ID = <10060> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 INFO2 finish_task: DONE finished clearing: telescope offsets 2008-Jul-16 02:16:13 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:16:13 STOP end_task: Finishing task 'clearing telescope offsets' with status 'OK' 2008-Jul-16 02:16:13 LOG5 end_task: Level: (2) ID = <10060> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 START begin_task: Starting task 'waiting on telescope' 2008-Jul-16 02:16:13 LOG5 begin_task: Level: (2) ID = <10061> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Waiting On Telescope} TASKWAIT BITMAP stat_slew INFO {Waiting for telescope to track source ...} 2008-Jul-16 02:16:13 LOG3 waittrk: Start waittrk 5 2008-Jul-16 02:16:13 START begin_task: Starting task 'waiting on telescope movement' 2008-Jul-16 02:16:13 LOG5 begin_task: Level: (3) ID = <10062> Status = 0 0 0 0 ok 2008-Jul-16 02:16:13 LOG4 WAPP=1+2+3+4-wappcon: Received command 'PROJECT a2048 J. Davies' 2008-Jul-16 02:16:13 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:16:13 LOG4 got_cormsg: From DATATAKING: pnt tr 223502.300000 235235.000000 -CJ 2008-Jul-16 02:16:13 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:16:13 NOTE WAPPDATA-new_file: New FITS file: wapp.20080716.a2048.0001.fits 2008-Jul-16 02:16:13 LOG4 send_obs_status: To obs_status: <0> FILENAME {wapp.20080716.a2048.0001.fits} 2008-Jul-16 02:16:18 STOP end_task: Finishing task 'waiting on telescope movement' with status 'OK' 2008-Jul-16 02:16:18 LOG5 end_task: Level: (3) ID = <10062> Status = 0 0 0 0 ok 2008-Jul-16 02:16:18 START begin_task: Starting task 'waiting on telescope on source' 2008-Jul-16 02:16:18 LOG5 begin_task: Level: (3) ID = <10063> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 STOP end_task: Finishing task 'waiting on telescope on source' with status 'OK' 2008-Jul-16 02:16:20 LOG5 end_task: Level: (3) ID = <10063> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 LOG4 send_obs_status: To obs_status: <0> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:16:20 INFO2 waittrk: Now tracking J223502+235235 2008-Jul-16 02:16:20 LOG4 waittrk: Current telescope position: Az = 247.36 ZA = 16.87 2008-Jul-16 02:16:20 STOP finish_task: Finishing task 'waiting on telescope' 2008-Jul-16 02:16:20 LOG5 finish_task: Level: (2) ID = <10061> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 INFO2 finish_task: DONE finished waiting: telescope on source 2008-Jul-16 02:16:20 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:16:20 STOP end_task: Finishing task 'waiting on telescope' with status 'OK' 2008-Jul-16 02:16:20 LOG5 end_task: Level: (2) ID = <10061> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 LOG5 antvel: Calling 'antvel 223502.300000 235235.000000 J 0' 2008-Jul-16 02:16:20 LOG2 antvel: Precessing RA = 22:35:02.3 Dec = +23:52:35.0 Epoch = 2008.54235 J 2008-Jul-16 02:16:20 LOG2 antvel: Computed apparent RA = 22:35:28.3 Dec = +23:55:14.2 2008-Jul-16 02:16:20 LOG2 antvel: Parameters to Doppler: Topocentric 22580 2008 198 0.0 2008-Jul-16 02:16:20 INFO5 antvel: Computed antenna velocity: +0.00000 km/s 2008-Jul-16 02:16:20 LOG3 dopset_gen: Parameters for 'rest2sky': vel=9753.000000 veltype=velocity(optical) calctype=SUBBAND antvel=0.0 restcent=1420.405751786 rest0=1420.405751786 rest1=1420.405751786 rest2=1420.405751786 rest3=1420.405751786 rest4=1420.405751786 rest5=1420.405751786 rest6=1420.405751786 rest7=1420.405751786 2008-Jul-16 02:16:20 INFO4 dopset_gen: New sky frequencies: 1375.652334 1375.652334 1375.652334 1375.652334 1375.652334 1375.652334 1375.652334 1375.652334 1375.652334 2008-Jul-16 02:16:20 LOG3 dopset_gen: Parameters for 'sky2syn': skycent=1375.652334 sky0=1375.652334 sky1=1375.652334 sky2=1375.652334 sky3=1375.652334 sky4=1375.652334 sky5=1375.652334 sky6=1375.652334 sky7=1375.652334 dest0=250 dest1=250 dest2=250 dest3=250 dest4=250 dest5=250 dest6=250 dest7=250 2008-Jul-16 02:16:20 LOG2 dopset_gen: Result from 'sky2syn': 1625.652334 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 2008-Jul-16 02:16:20 LOG3 vw_send: To DATATAKING: if1 {if1_syn1 1625652334.0} 2008-Jul-16 02:16:20 LOG3 vw_send: To DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 02:16:20 START begin_task: Starting task 'adjusting WAPP power' 2008-Jul-16 02:16:20 LOG5 begin_task: Level: (2) ID = <10064> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Adjusting WAPP power} TASKWAIT BITMAP stat_power INFO {Adjusting WAPP power ...} 2008-Jul-16 02:16:20 INFO2 adjust_power: Starting to adjust WAPP power 2008-Jul-16 02:16:20 LOG3 vw_send: To DATATAKING: adjpwrif2 2008-Jul-16 02:16:20 LOG2 socket_wait: Starting sockwait on DATATAKING for 'adjpwrif2' using string 'DONE' 2008-Jul-16 02:16:20 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:16:20 START begin_task: Starting task 'waiting on adjpwrif2' 2008-Jul-16 02:16:20 LOG5 begin_task: Level: (3) ID = <10065> Status = 0 0 0 0 ok 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: if1 {if1_syn1 1625652334.0} 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: if2 {if2_synfrq 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0} 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: adjpwrif2 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:20 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:23 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:23 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:16:23 STOP end_task: Finishing task 'waiting on adjpwrif2' with status 'OK' 2008-Jul-16 02:16:23 LOG5 end_task: Level: (3) ID = <10065> Status = 0 0 0 0 ok 2008-Jul-16 02:16:23 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'adjpwrif2' 2008-Jul-16 02:16:23 START begin_task: Starting task 'adjusting WAPP power' 2008-Jul-16 02:16:23 LOG5 begin_task: Level: (3) ID = <10066> Status = 0 0 0 0 ok 2008-Jul-16 02:16:23 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Adjusting WAPP Power} TASKWAIT BITMAP stat_power INFO {Adjusting power ...} 2008-Jul-16 02:16:23 LOG3 sock_errsend: To WAPPCON: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:16:23 LOG3 sock_errsend: To WAPPCON2: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:16:23 LOG3 sock_errsend: To WAPPCON3: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:16:23 LOG3 sock_errsend: To WAPPCON4: ADJUSTPOWER 100 1 2 0 1 1 2008-Jul-16 02:16:23 START begin_task: Starting task 'waiting on adjust WAPP power' 2008-Jul-16 02:16:23 LOG5 begin_task: Level: (4) ID = <10067> Status = 0 0 0 0 ok 2008-Jul-16 02:16:23 LOG4 WAPP=1+2+3+4-wappcon: Received command 'ADJUSTPOWER 100 1 2 0 1 1' 2008-Jul-16 02:16:23 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:16:24 INFO2 WAPP=1-auto_atten_dual: Attenuators beam 0: 8 6 dB --- beam 1: 8 7 dB 2008-Jul-16 02:16:24 INFO2 WAPP=3-auto_atten_dual: Attenuators beam 4: 3 3 dB --- beam 5: 6 5 dB 2008-Jul-16 02:16:24 INFO2 WAPP=2-auto_atten_dual: Attenuators beam 2: 6 4 dB --- beam 3: 4 4 dB 2008-Jul-16 02:16:24 INFO2 WAPP=4-auto_atten_dual: Attenuators beam 6: 3 2 dB --- beam 7: 2 3 dB 2008-Jul-16 02:16:24 INFO1 WAPP=1+2+3+4-adjust_power: DONE adjusting power 2008-Jul-16 02:16:24 STOP end_task: Finishing task 'waiting on adjust WAPP power' with status 'OK' 2008-Jul-16 02:16:25 LOG5 end_task: Level: (4) ID = <10067> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 INFO2 wapp_adjpwr: WAPP power: ALFA beam 0: 1.015 1.050 ALFA beam 1: 0.899 0.953 2008-Jul-16 02:16:25 INFO2 wapp_adjpwr: WAPP power: ALFA beam 2: 0.988 1.018 ALFA beam 3: 1.058 0.922 2008-Jul-16 02:16:25 INFO2 wapp_adjpwr: WAPP power: ALFA beam 4: 0.896 0.923 ALFA beam 5: 1.015 1.087 2008-Jul-16 02:16:25 INFO2 wapp_adjpwr: WAPP power: ALFA beam 6: 0.988 1.049 ALFA beam 7: 1.098 0.910 2008-Jul-16 02:16:25 STOP finish_task: Finishing task 'adjusting WAPP power' 2008-Jul-16 02:16:25 LOG5 finish_task: Level: (3) ID = <10066> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 INFO3 finish_task: DONE finished adjusting: WAPP power 2008-Jul-16 02:16:25 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:16:25 STOP end_task: Finishing task 'adjusting WAPP power' with status 'OK' 2008-Jul-16 02:16:25 LOG5 end_task: Level: (3) ID = <10066> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_busy 2008-Jul-16 02:16:25 STOP finish_task: Finishing task 'adjusting WAPP power' 2008-Jul-16 02:16:25 LOG5 finish_task: Level: (2) ID = <10064> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 INFO2 finish_task: DONE finished adjusting: WAPP power levels 2008-Jul-16 02:16:25 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:16:25 STOP end_task: Finishing task 'adjusting WAPP power' with status 'OK' 2008-Jul-16 02:16:25 LOG5 end_task: Level: (2) ID = <10064> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 LOG4 send_obs_status: To obs_status: <1> BITMAP stat_onoff_on MESSAGE {Taking ON scan ...} 2008-Jul-16 02:16:25 LOG4 take_data: Calling 'take_data 300 1 ONOFF ON -' 2008-Jul-16 02:16:25 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:16:25 LOG5 begin_task: Level: (2) ID = <10068> Status = 0 0 0 0 ok 2008-Jul-16 02:16:25 LOG5 log_alfabeam: Parameters: 22.583972222222219 23.87638888888889 21.453653 2008.5423537911627 19.881783 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 0 22.583972222222215 23.876388888888897 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 1 22.576937292982322 23.832014740832207 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 2 22.583142832212065 23.783870623418924 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 3 22.590188962318351 23.827853092868331 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 4 22.591007023813535 23.920873916225165 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 5 22.584765678233989 23.969134187608372 2008-Jul-16 02:16:25 LOG4 log_alfabeam: ALFABEAM 6 22.577742259225680 23.924258034314672 2008-Jul-16 02:16:25 INFO2 take_data: Starting WAPP scan: 819800005 2008-Jul-16 02:16:26 LOG4 send_obs_status: To obs_status: <0> TASKTIME 300 2008-Jul-16 02:16:26 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:16:26 LOG5 begin_task: Level: (3) ID = <10069> Status = 0 0 0 0 ok 2008-Jul-16 02:16:26 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:16:26 INFO1 WAPP=1+2+3+4-start_spectra: start sec 22587.00 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1625.652334 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:16:28 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:16:37 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:16:44 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:16:50 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:17:04 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:17:05 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 15 (99999966 != 99999964)! 2008-Jul-16 02:17:20 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 13 (99999966 != 99999964)! 2008-Jul-16 02:17:27 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 8 (99999966 != 99999964)! 2008-Jul-16 02:17:27 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:17:35 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:18:19 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 14 (99999966 != 99999964)! 2008-Jul-16 02:18:26 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:20:06 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:20:55 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 11 (99999966 != 99999964)! 2008-Jul-16 02:20:59 WARNING WAPP=4-chip_count: WARNING counts don't match between chip 0 and chip 12 (99999966 != 99999964)! 2008-Jul-16 02:21:27 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:21:27 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:21:27 LOG5 end_task: Level: (3) ID = <10069> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:21:27 LOG5 end_task: Level: (2) ID = <10068> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 LOG4 send_obs_status: To obs_status: <1> PART 2 INFO {Waiting for OFF observation followed by CAL} 2008-Jul-16 02:21:27 LOG2 onoff_wapp: Parameters: RA-offset: -90.95729999999925 arcminutes wait: 60 secs 2008-Jul-16 02:21:27 LOG4 track_offsets: Calling 'track_offsets -90.95729999999925 0.0 main small' 2008-Jul-16 02:21:27 START begin_task: Starting task 'sending telescope offsets' 2008-Jul-16 02:21:27 LOG5 begin_task: Level: (2) ID = <10070> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 LOG4 send_obs_status: To obs_status: <0> NEWTASK {Sending Telescope Offsets} INFO {Changing telescope offsets ...} 2008-Jul-16 02:21:27 INFO2 track_offsets: Starting to send new offsets 2008-Jul-16 02:21:27 LOG3 vw_send: To DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:21:27 LOG3 vw_send: To DATATAKING: pnt tr 223502.300000 235235.000000 -CJ -o -UD -1.51595 0.0 -CH 2008-Jul-16 02:21:27 STOP finish_task: Finishing task 'sending telescope offsets' 2008-Jul-16 02:21:27 LOG5 finish_task: Level: (2) ID = <10070> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 INFO2 finish_task: DONE finished sending: telescope offsets 2008-Jul-16 02:21:27 LOG4 send_obs_status: To obs_status: <0> ENDTASK Finished 2008-Jul-16 02:21:27 STOP end_task: Finishing task 'sending telescope offsets' with status 'OK' 2008-Jul-16 02:21:27 LOG5 end_task: Level: (2) ID = <10070> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 INFO2 lstwait: Waiting for 59.8 secs from LST 21:32:17 to LST 21:33:17 ... 2008-Jul-16 02:21:27 LOG4 send_obs_status: To obs_status: <1> TASKTIME 59.836175999996598 BITMAP stat_wait MESSAGE {Waiting ...} 2008-Jul-16 02:21:27 START begin_task: Starting task 'waiting on wait on LST' 2008-Jul-16 02:21:27 LOG5 begin_task: Level: (2) ID = <10071> Status = 0 0 0 0 ok 2008-Jul-16 02:21:27 LOG4 got_cormsg: From DATATAKING: hdrldsrcnm "J223502+235235" 2008-Jul-16 02:21:27 LOG4 got_cormsg: From DATATAKING: pnt tr 223502.300000 235235.000000 -CJ -o -UD -1.51595 0.0 -CH 2008-Jul-16 02:21:27 LOG4 got_cormsg: From DATATAKING: vw% vw% 2008-Jul-16 02:22:07 INFO4 wait_and_tell_when_on_source: Telescope is now on source 'J223502+235235' (after 40 seconds) 2008-Jul-16 02:22:27 STOP end_task: Finishing task 'waiting on wait on LST' with status 'OK' 2008-Jul-16 02:22:27 LOG5 end_task: Level: (2) ID = <10071> Status = 0 0 0 0 ok 2008-Jul-16 02:22:27 LOG4 lstwait: Finished waiting 0.17 seconds late 2008-Jul-16 02:22:27 INFO3 lstwait: Finished waiting 2008-Jul-16 02:22:27 LOG4 send_obs_status: To obs_status: <1> CLEARTIME BITMAP stat_busy 2008-Jul-16 02:22:27 LOG4 send_obs_status: To obs_status: <1> BITMAP stat_onoff_off MESSAGE {Taking OFF scan ...} 2008-Jul-16 02:22:27 LOG4 take_data: Calling 'take_data 300 1 ONOFF OFF -' 2008-Jul-16 02:22:27 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:22:27 LOG5 begin_task: Level: (2) ID = <10072> Status = 0 0 0 0 ok 2008-Jul-16 02:22:27 LOG5 log_alfabeam: Parameters: 22.583972222222219 23.87638888888889 21.554763 2008.5423652939387 19.881783 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 0 22.583972222222211 23.876388888888897 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 1 22.577055314984161 23.828654332825362 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 2 22.583378874344564 23.783537091487641 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 3 22.590309352351873 23.830856510678583 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 4 22.590888324508459 23.924250510661022 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 5 22.584525333370152 23.969469120424765 2008-Jul-16 02:22:27 LOG4 log_alfabeam: ALFABEAM 6 22.577623014756931 23.921193167737393 2008-Jul-16 02:22:27 INFO2 take_data: Starting WAPP scan: 819800006 2008-Jul-16 02:22:28 LOG4 send_obs_status: To obs_status: <0> TASKTIME 300 2008-Jul-16 02:22:28 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:22:28 LOG5 begin_task: Level: (3) ID = <10073> Status = 0 0 0 0 ok 2008-Jul-16 02:22:28 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:22:28 INFO1 WAPP=1+2+3+4-start_spectra: start sec 22949.00 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1625.652334 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:22:30 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:27:29 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:27:29 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:27:29 LOG5 end_task: Level: (3) ID = <10073> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:27:29 LOG5 end_task: Level: (2) ID = <10072> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG2 take_cal: Calling 'take_cal hcorcal 10 0' 2008-Jul-16 02:27:29 START begin_task: Starting task 'WAPP calibration' 2008-Jul-16 02:27:29 LOG5 begin_task: Level: (2) ID = <10074> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG4 send_obs_status: To obs_status: <0> NEWTASK {WAPP Calibration} INFO {Making WAPP calibration ...} 2008-Jul-16 02:27:29 START begin_task: Starting task 'selecting calibration type' 2008-Jul-16 02:27:29 LOG5 begin_task: Level: (3) ID = <10075> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG3 vw_send: To DATATAKING: setcal hcorcal 2008-Jul-16 02:27:29 LOG2 socket_wait: Starting sockwait on DATATAKING for 'setcal' using string 'DONE' 2008-Jul-16 02:27:29 LOG3 socket_wait: To DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:27:29 START begin_task: Starting task 'waiting on setcal' 2008-Jul-16 02:27:29 LOG5 begin_task: Level: (4) ID = <10076> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG4 got_cormsg: From DATATAKING: setcal hcorcal 2008-Jul-16 02:27:29 LOG4 got_cormsg: From DATATAKING: puts {DONE}; flush stdout 2008-Jul-16 02:27:29 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:27:29 LOG4 got_cormsg: From DATATAKING: DONE 2008-Jul-16 02:27:29 STOP end_task: Finishing task 'waiting on setcal' with status 'OK' 2008-Jul-16 02:27:29 LOG5 end_task: Level: (4) ID = <10076> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG3 socket_wait: DONE with sockwait on DATATAKING for 'setcal' 2008-Jul-16 02:27:29 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:27:29 LOG3 socket_wait: To ALFAMON: CAL HI 2008-Jul-16 02:27:29 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:27:29 LOG5 begin_task: Level: (4) ID = <10077> Status = 0 0 0 0 ok 2008-Jul-16 02:27:29 LOG4 got_cormsg: From DATATAKING: vw% 2008-Jul-16 02:27:30 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:27:30 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:27:30 LOG5 end_task: Level: (4) ID = <10077> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:27:30 LOG3 to_alfamon: To ALFAMON: CAL HI 2008-Jul-16 02:27:30 LOG2 socket_wait: Starting sockwait on ALFAMON for 'command to ALFA' using string 'ACK' 2008-Jul-16 02:27:30 LOG3 socket_wait: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:27:30 START begin_task: Starting task 'waiting on command to ALFA' 2008-Jul-16 02:27:30 LOG5 begin_task: Level: (4) ID = <10078> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG4 got_alfamon: From ALFAMON: ACK 2008-Jul-16 02:27:30 STOP end_task: Finishing task 'waiting on command to ALFA' with status 'OK' 2008-Jul-16 02:27:30 LOG5 end_task: Level: (4) ID = <10078> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG3 socket_wait: DONE with sockwait on ALFAMON for 'command to ALFA' 2008-Jul-16 02:27:30 LOG3 to_alfamon: To ALFAMON: NOISE ACTIVE 2008-Jul-16 02:27:30 STOP end_task: Finishing task 'selecting calibration type' with status 'OK' 2008-Jul-16 02:27:30 LOG5 end_task: Level: (3) ID = <10075> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_cal_on MESSAGE {Setting CAL-ON ...} 2008-Jul-16 02:27:30 LOG3 wapp_calcontrol: To CALCONTROL: CALON 2008-Jul-16 02:27:30 LOG3 sock_errsend: To CALCONTROL: CALON STATUS 2008-Jul-16 02:27:30 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 02:27:30 LOG5 begin_task: Level: (3) ID = <10079> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 02:27:30 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x03 2008-Jul-16 02:27:30 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 02:27:30 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 02:27:30 LOG5 end_task: Level: (3) ID = <10079> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG4 send_obs_status: To obs_status: <0> MESSAGE {Taking CAL-ON spectra ...} 2008-Jul-16 02:27:30 LOG4 take_data: Calling 'take_data 10 10 CAL ON -' 2008-Jul-16 02:27:30 START begin_task: Starting task 'WAPP spectral observation' 2008-Jul-16 02:27:30 LOG5 begin_task: Level: (3) ID = <10080> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG5 log_alfabeam: Parameters: 22.583972222222219 23.87638888888889 21.638881 2008.5423748637411 19.881783 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 0 22.583972222222219 23.876388888888897 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 1 22.577175446957984 23.825513517393482 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 2 22.583603959984316 23.783325107537518 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 3 22.590416689295420 23.833764452131039 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 4 22.590767451088968 23.927406268516215 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 5 22.584296088677096 23.969679077281409 2008-Jul-16 02:27:30 LOG4 log_alfabeam: ALFABEAM 6 22.577517057504593 23.918226760455475 2008-Jul-16 02:27:30 INFO2 take_data: Starting WAPP scan: 819800007 2008-Jul-16 02:27:30 LOG4 send_obs_status: To obs_status: <0> TASKTIME 10 2008-Jul-16 02:27:30 START begin_task: Starting task 'waiting on WAPP spectra' 2008-Jul-16 02:27:30 LOG5 begin_task: Level: (4) ID = <10081> Status = 0 0 0 0 ok 2008-Jul-16 02:27:30 LOG4 WAPP=1+2+3+4-wappcon: Received a FITS-header block 2008-Jul-16 02:27:30 INFO1 WAPP=1+2+3+4-start_spectra: start sec 23251.00 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Up: 1625.652334 MHz --- rfnum = 17 ifnum = 6 inpfrq = 4 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 1: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 2: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 3: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 290.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 4: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1010.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 5: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 6: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 7: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:27:41 LOG3 WAPP=1+2+3+4-save_rfcalc: Channel 8: Sky freq = 1375.652334 MHz Flip = 1 Band = 0 Mixer = 1025.000000 MHz 2008-Jul-16 02:27:41 INFO1 WAPP=1+2+3+4-start_spectra: DONE with spectral line observation 2008-Jul-16 02:27:41 STOP end_task: Finishing task 'waiting on WAPP spectra' with status 'OK' 2008-Jul-16 02:27:41 LOG5 end_task: Level: (4) ID = <10081> Status = 0 0 0 0 ok 2008-Jul-16 02:27:41 STOP end_task: Finishing task 'WAPP spectral observation' with status 'OK' 2008-Jul-16 02:27:41 LOG5 end_task: Level: (3) ID = <10080> Status = 0 0 0 0 ok 2008-Jul-16 02:27:41 LOG4 send_obs_status: To obs_status: <0> BITMAP stat_cal_off MESSAGE {Setting CAL-OFF ...} 2008-Jul-16 02:27:41 LOG3 wapp_calcontrol: To CALCONTROL: CALOFF 2008-Jul-16 02:27:41 LOG3 sock_errsend: To CALCONTROL: CALOFF STATUS 2008-Jul-16 02:27:41 START begin_task: Starting task 'waiting on CALCONTROL command' 2008-Jul-16 02:27:41 LOG5 begin_task: Level: (3) ID = <10082> Status = 0 0 0 0 ok 2008-Jul-16 02:27:42 LOG3 CALCONTROL-caltrig: Software trigger 2008-Jul-16 02:27:42 LOG1 CALCONTROL-caltrig: Cal/trigger control status 0x02 2008-Jul-16 02:27:42 LOG3 got_calcontrol: Received status OK from CALCONTROL 2008-Jul-16 02:27:42 STOP end_task: Finishing task 'waiting on CALCONTROL command' with status 'OK' 2008-Jul-16 02:27:42 LOG5 end_task: Level: (3) ID = <10082> Status = 0 0 0 0 ok 2008-Jul-16 02:27:42 LOG4 send_obs_status: To obs_status: <0> MESSAGE {Taking CAL-OFF spectra ...} 2008-Jul-16 02:27:42 LOG4 take_data: Calling 'take_data 10 10 CAL OFF -' 2008-Jul-16 02:27:42 START begin_task: Starting task 'WAPP spectral