2015-07-15 17:17:44 INFO hif_lowgainflag::pipeline.infrastructure.basetask::casa Starting execution for stage 8
2015-07-15 17:17:45 INFO hif_lowgainflag::pipeline.infrastructure.jobrequest::casa Executing flagdata(vis='uid___A002_Xa0b40d_X3cb8.ms', mode='summary')
2015-07-15 17:17:45 INFO flagdata::::casa
2015-07-15 17:17:45 INFO flagdata::::casa+ ##########################################
2015-07-15 17:17:45 INFO flagdata::::casa+ ##### Begin Task: flagdata #####
2015-07-15 17:17:45 INFO flagdata::::casa flagdata(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",mode="summary",autocorr=False,inpfile="",
2015-07-15 17:17:45 INFO flagdata::::casa+ reason="any",tbuff=0.0,spw="",field="",antenna="",
2015-07-15 17:17:45 INFO flagdata::::casa+ uvrange="",timerange="",correlation="",scan="",intent="",
2015-07-15 17:17:45 INFO flagdata::::casa+ array="",observation="",feed="",clipminmax=[],datacolumn="DATA",
2015-07-15 17:17:45 INFO flagdata::::casa+ clipoutside=True,channelavg=False,clipzeros=False,quackinterval=1.0,quackmode="beg",
2015-07-15 17:17:45 INFO flagdata::::casa+ quackincrement=False,tolerance=0.0,addantenna="",lowerlimit=0.0,upperlimit=90.0,
2015-07-15 17:17:45 INFO flagdata::::casa+ ntime="scan",combinescans=False,timecutoff=4.0,freqcutoff=3.0,timefit="line",
2015-07-15 17:17:45 INFO flagdata::::casa+ freqfit="poly",maxnpieces=7,flagdimension="freqtime",usewindowstats="none",halfwin=1,
2015-07-15 17:17:45 INFO flagdata::::casa+ extendflags=True,winsize=3,timedev="",freqdev="",timedevscale=5.0,
2015-07-15 17:17:45 INFO flagdata::::casa+ freqdevscale=5.0,spectralmax=1000000.0,spectralmin=0.0,extendpols=True,growtime=50.0,
2015-07-15 17:17:45 INFO flagdata::::casa+ growfreq=50.0,growaround=False,flagneartime=False,flagnearfreq=False,minrel=0.0,
2015-07-15 17:17:45 INFO flagdata::::casa+ maxrel=1.0,minabs=0,maxabs=-1,spwchan=False,spwcorr=False,
2015-07-15 17:17:45 INFO flagdata::::casa+ basecnt=False,name="Summary",action="apply",display="",flagbackup=True,
2015-07-15 17:17:45 INFO flagdata::::casa+ savepars=False,cmdreason="",outfile="")
2015-07-15 17:17:45 INFO AgentFlagger::open Table type is Measurement Set
2015-07-15 17:17:45 INFO flagdata::::casa Summary mode is active
2015-07-15 17:17:46 INFO flagdata::::casa Initializing the agents
2015-07-15 17:17:46 INFO Summary::setAgentParameters Spw-Channel count deactivated
2015-07-15 17:17:46 INFO Summary::setAgentParameters Spw-Correlation count deactivated
2015-07-15 17:17:46 INFO Summary::setAgentParameters Baseline count deactivated
2015-07-15 17:17:46 INFO AgentFlagger::initAgents There are 1 valid agents in list
2015-07-15 17:17:46 INFO flagdata::::casa Running the agentflagger tool
2015-07-15 17:17:49 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:17:49 INFO FlagMSHandler:: Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (J1517-2422), Spw = 0, Channels = 4, Corrs = [ XX ], Total Rows = 3132
2015-07-15 17:17:54 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:17:54 INFO FlagMSHandler:: Chunk = 9 [progress: 13%], Observation = 0, Array = 0, Scan = 1, Field = 0 (J1517-2422), Spw = 8, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:17:58 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:17:58 INFO FlagMSHandler:: Chunk = 14 [progress: 24%], Observation = 0, Array = 0, Scan = 2, Field = 0 (J1517-2422), Spw = 12, Channels = 1, Corrs = [ XX YY ], Total Rows = 83916
2015-07-15 17:18:03 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:18:03 INFO FlagMSHandler:: Chunk = 18 [progress: 34%], Observation = 0, Array = 0, Scan = 2, Field = 0 (J1517-2422), Spw = 16, Channels = 1, Corrs = [ XX YY ], Total Rows = 83916
2015-07-15 17:18:13 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:18:13 INFO FlagMSHandler:: Chunk = 30 [progress: 44%], Observation = 0, Array = 0, Scan = 4, Field = 0 (J1517-2422), Spw = 18, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:18:28 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:18:28 INFO FlagMSHandler:: Chunk = 34 [progress: 52%], Observation = 0, Array = 0, Scan = 4, Field = 0 (J1517-2422), Spw = 22, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:18:37 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:18:37 INFO FlagMSHandler:: Chunk = 44 [progress: 60%], Observation = 0, Array = 0, Scan = 5, Field = 1 (Titan), Spw = 15, Channels = 128, Corrs = [ XX YY ], Total Rows = 15984
2015-07-15 17:18:48 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:18:48 INFO FlagMSHandler:: Chunk = 72 [progress: 70%], Observation = 0, Array = 0, Scan = 8, Field = 3 (IRAS16293-2422), Spw = 16, Channels = 1, Corrs = [ XX YY ], Total Rows = 15984
2015-07-15 17:19:08 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:19:08 INFO FlagMSHandler:: Chunk = 81 [progress: 82%], Observation = 0, Array = 0, Scan = 9, Field = 3 (IRAS16293-2422), Spw = 24, Channels = 1, Corrs = [ XX YY ], Total Rows = 43290
2015-07-15 17:19:17 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:19:17 INFO FlagMSHandler:: Chunk = 103 [progress: 92%], Observation = 0, Array = 0, Scan = 12, Field = 3 (IRAS16293-2422), Spw = 19, Channels = 1920, Corrs = [ XX YY ], Total Rows = 43290
2015-07-15 17:19:33 INFO FlagMSHandler::nextChunk ====================================================================================
2015-07-15 17:19:33 INFO Summary::getResult antenna DA41 flagged: 2.61629e+07 total: 1.59503e+08 (16.4%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA42 flagged: 2.41206e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA43 flagged: 3.55174e+07 total: 1.59503e+08 (22.3%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA44 flagged: 2.31524e+07 total: 1.59503e+08 (14.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA45 flagged: 1.59498e+08 total: 1.59503e+08 (100%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA46 flagged: 2.50504e+07 total: 1.59503e+08 (15.7%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA49 flagged: 2.40822e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA51 flagged: 2.60647e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA52 flagged: 2.46086e+07 total: 1.59503e+08 (15.4%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA53 flagged: 2.41513e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA57 flagged: 2.41398e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA59 flagged: 2.46355e+07 total: 1.59503e+08 (15.4%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA60 flagged: 2.36134e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA61 flagged: 2.36442e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA62 flagged: 2.36365e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA63 flagged: 2.40669e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DA64 flagged: 2.40899e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV01 flagged: 2.67602e+07 total: 1.59503e+08 (16.8%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV02 flagged: 2.72174e+07 total: 1.59503e+08 (17.1%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV04 flagged: 2.63106e+07 total: 1.59503e+08 (16.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV05 flagged: 2.59918e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV08 flagged: 2.6522e+07 total: 1.59503e+08 (16.6%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV09 flagged: 3.50617e+07 total: 1.59503e+08 (22%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV10 flagged: 2.79051e+07 total: 1.59503e+08 (17.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV11 flagged: 2.82663e+07 total: 1.59503e+08 (17.7%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV12 flagged: 2.76324e+07 total: 1.59503e+08 (17.3%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV14 flagged: 5.9781e+07 total: 1.59503e+08 (37.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV15 flagged: 2.9538e+07 total: 1.59503e+08 (18.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV16 flagged: 2.70291e+07 total: 1.59503e+08 (16.9%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV17 flagged: 2.58035e+07 total: 1.59503e+08 (16.2%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV18 flagged: 2.75363e+07 total: 1.59503e+08 (17.3%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV19 flagged: 2.68947e+07 total: 1.59503e+08 (16.9%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV20 flagged: 2.74979e+07 total: 1.59503e+08 (17.2%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV21 flagged: 2.78897e+07 total: 1.59503e+08 (17.5%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV22 flagged: 2.68447e+07 total: 1.59503e+08 (16.8%)
2015-07-15 17:19:33 INFO Summary::getResult antenna DV23 flagged: 2.60532e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:19:33 INFO Summary::getResult array 0 flagged: 6.38162e+08 total: 2.95092e+09 (21.6%)
2015-07-15 17:19:33 INFO Summary::getResult correlation XX flagged: 3.1911e+08 total: 1.47557e+09 (21.6%)
2015-07-15 17:19:33 INFO Summary::getResult correlation YY flagged: 3.19053e+08 total: 1.47534e+09 (21.6%)
2015-07-15 17:19:33 INFO Summary::getResult field IRAS16293-2422 flagged: 2.26814e+08 total: 1.36365e+09 (16.6%)
2015-07-15 17:19:33 INFO Summary::getResult field J1517-2422 flagged: 3.24864e+08 total: 1.16133e+09 (28%)
2015-07-15 17:19:33 INFO Summary::getResult field J1625-2527 flagged: 1.83253e+07 total: 1.53538e+08 (11.9%)
2015-07-15 17:19:33 INFO Summary::getResult field Titan flagged: 6.81587e+07 total: 2.72393e+08 (25%)
2015-07-15 17:19:33 INFO Summary::getResult observation 0 flagged: 6.38162e+08 total: 2.95092e+09 (21.6%)
2015-07-15 17:19:33 INFO Summary::getResult scan 1 flagged: 3.46445e+07 total: 3.46445e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 10 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:19:33 INFO Summary::getResult scan 11 flagged: 1.64968e+07 total: 1.64968e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 12 flagged: 9.88545e+07 total: 6.6533e+08 (14.9%)
2015-07-15 17:19:33 INFO Summary::getResult scan 13 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:19:33 INFO Summary::getResult scan 2 flagged: 8.66087e+07 total: 8.66087e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 3 flagged: 1.64969e+07 total: 1.64969e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 4 flagged: 1.87114e+08 total: 1.02358e+09 (18.3%)
2015-07-15 17:19:33 INFO Summary::getResult scan 5 flagged: 1.64969e+07 total: 1.64969e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 6 flagged: 5.16618e+07 total: 2.55896e+08 (20.2%)
2015-07-15 17:19:33 INFO Summary::getResult scan 7 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:19:33 INFO Summary::getResult scan 8 flagged: 1.64968e+07 total: 1.64968e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult scan 9 flagged: 9.49662e+07 total: 6.6533e+08 (14.3%)
2015-07-15 17:19:33 INFO Summary::getResult spw 0 flagged: 57188 total: 229392 (24.9%)
2015-07-15 17:19:33 INFO Summary::getResult spw 1 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 10 flagged: 295704 total: 295704 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 11 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 12 flagged: 295704 total: 295704 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 13 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 14 flagged: 295704 total: 295704 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 15 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 16 flagged: 295704 total: 295704 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 17 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:19:33 INFO Summary::getResult spw 18 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:19:33 INFO Summary::getResult spw 19 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:19:33 INFO Summary::getResult spw 2 flagged: 133200 total: 133200 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 20 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:19:33 INFO Summary::getResult spw 21 flagged: 1.46799e+08 total: 6.90509e+08 (21.3%)
2015-07-15 17:19:33 INFO Summary::getResult spw 22 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:19:33 INFO Summary::getResult spw 23 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:19:33 INFO Summary::getResult spw 24 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:19:33 INFO Summary::getResult spw 3 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 4 flagged: 133200 total: 133200 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 5 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 6 flagged: 133200 total: 133200 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 7 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 8 flagged: 133200 total: 133200 (100%)
2015-07-15 17:19:33 INFO Summary::getResult spw 9 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:19:33 INFO Summary::getResult Total Flagged: 6.38162e+08 Total Counts: 2.95092e+09 (21.6%)
2015-07-15 17:19:33 INFO flagdata::::casa Flags are not written to the MS. (action='calculate')
2015-07-15 17:19:33 INFO flagdata::::casa ##### End Task: flagdata #####
2015-07-15 17:19:33 INFO flagdata::::casa+ ##########################################
2015-07-15 17:19:34 INFO flagdata::pipeline.hif.tasks.common.viewflaggers::casa flagcmds will be extended by removing selection in following fields: ['field', 'timerange']
2015-07-15 17:19:36 INFO flagdata::pipeline.infrastructure.jobrequest::casa Executing gaincal(solint='int', interp=['linear,linear', '', 'nearest'], spw='17,19,21,23', vis='uid___A002_Xa0b40d_X3cb8.ms', calmode='p', intent='*BANDPASS*', spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], []], refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45', gainfield=['nearest', '', ''], minblperant=4, antenna='0~35', gaintype='G', caltable='uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl', minsnr=3.0, gaintable=['uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.antpos', 'uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl'], field='J1517-2422', solnorm=False)
2015-07-15 17:19:36 INFO gaincal::::casa
2015-07-15 17:19:36 INFO gaincal::::casa+ ##########################################
2015-07-15 17:19:36 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 17:19:36 INFO gaincal::::casa gaincal(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",caltable="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl",field="J1517-2422",spw="17,19,21,23",
2015-07-15 17:19:36 INFO gaincal::::casa+ intent="*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 17:19:36 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="int",combine="",
2015-07-15 17:19:36 INFO gaincal::::casa+ preavg=-1.0,refant="DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45",minblperant=4,minsnr=3.0,solnorm=False,
2015-07-15 17:19:36 INFO gaincal::::casa+ gaintype="G",smodel=[],calmode="p",append=False,splinetime=3600.0,
2015-07-15 17:19:36 INFO gaincal::::casa+ npointaver=3,phasewrap=180.0,docallib=False,callib="",gaintable=['/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl'],
2015-07-15 17:19:36 INFO gaincal::::casa+ gainfield=['nearest', '', ''],interp=['linear,linear', '', 'nearest'],spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], []],parang=False)
2015-07-15 17:19:36 INFO gaincal::calibrater::open Opening MS: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms for calibration.
2015-07-15 17:19:36 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 17:19:37 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 17:19:37 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 17:19:37 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 17:19:37 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 17:19:37 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'J1517-2422'
2015-07-15 17:19:37 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*BANDPASS*'
2015-07-15 17:19:37 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 252000
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 17:19:38 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 17:19:38 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:19:38 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:19:40 INFO gaincal::Calibrater::setapply(type, applypar) . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:19:40 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:19:40 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:19:40 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 17:19:41 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 17:19:41 INFO gaincal::Calibrater::setapply(type, applypar) . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:19:41 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:19:41 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:20:11 INFO gaincal::Calibrater::setapply(type, applypar) . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:20:11 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 17:20:11 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 17:20:11 INFO gaincal::Calibrater::setsolve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl append=false solint=int refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=3 apmode=P solnorm=false
2015-07-15 17:20:11 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl append=false solint=int refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=3 apmode=P solnorm=false
2015-07-15 17:20:11 INFO gaincal::Calibrater::solve Solving for G Jones
2015-07-15 17:20:12 INFO gaincal:::: For solint = int, found 400 solution intervals.
2015-07-15 17:23:44 INFO gaincal::Calibrater::solve Found good G Jones solutions in 400 slots.
2015-07-15 17:23:44 INFO gaincal:::: Applying refant: DA52 (DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45)
2015-07-15 17:23:44 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:44 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:44 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:23:45 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 17:23:55 INFO gaincal:::: Writing solutions to table: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl
2015-07-15 17:23:56 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 17:23:56 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 17:23:56 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 17: 100/100/100
2015-07-15 17:23:56 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 19: 100/100/100
2015-07-15 17:23:56 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 21: 100/100/100
2015-07-15 17:23:56 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 23: 100/100/100
2015-07-15 17:23:56 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 17:23:56 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 17:24:00 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 17:24:00 INFO gaincal::::casa+ ##########################################
2015-07-15 17:24:01 INFO gaincal::pipeline.infrastructure.jobrequest::casa Executing bandpass(bandtype='B', solint='inf,7.8125MHz', interp=['linear,linear', '', 'nearest', 'linear,linear'], spw='17,19,21,23', vis='uid___A002_Xa0b40d_X3cb8.ms', intent='*BANDPASS*', spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], []], refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45', minblperant=4, gainfield=['nearest', '', '', 'nearest'], antenna='0~35', caltable='uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl', minsnr=3.0, gaintable=['uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.antpos', 'uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl'], field='J1517-2422', combine='scan', solnorm=True)
2015-07-15 17:24:01 INFO bandpass::::casa
2015-07-15 17:24:01 INFO bandpass::::casa+ ##########################################
2015-07-15 17:24:01 INFO bandpass::::casa+ ##### Begin Task: bandpass #####
2015-07-15 17:24:01 INFO bandpass::::casa bandpass(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",caltable="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl",field="J1517-2422",spw="17,19,21,23",
2015-07-15 17:24:01 INFO bandpass::::casa+ intent="*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 17:24:01 INFO bandpass::::casa+ scan="",observation="",msselect="",solint="inf,7.8125MHz",combine="scan",
2015-07-15 17:24:01 INFO bandpass::::casa+ refant="DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45",minblperant=4,minsnr=3.0,solnorm=True,bandtype="B",
2015-07-15 17:24:01 INFO bandpass::::casa+ smodel=[],append=False,fillgaps=0,degamp=3,degphase=3,
2015-07-15 17:24:01 INFO bandpass::::casa+ visnorm=False,maskcenter=0,maskedge=5,docallib=False,callib="",
2015-07-15 17:24:01 INFO bandpass::::casa+ gaintable=['/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl'],gainfield=['nearest', '', '', 'nearest'],interp=['linear,linear', '', 'nearest', 'linear,linear'],spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], []],parang=False)
2015-07-15 17:24:01 INFO bandpass::calibrater::open Opening MS: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms for calibration.
2015-07-15 17:24:01 INFO bandpass::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 17:24:05 INFO bandpass::calibrater::reset Reseting solve/apply state
2015-07-15 17:24:05 INFO bandpass::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 17:24:05 INFO bandpass::calibrater::reset Reseting solve/apply state
2015-07-15 17:24:05 INFO bandpass::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 17:24:05 INFO bandpass::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 17:24:05 INFO bandpass::Calibrater::selectvis+ Selecting on field: 'J1517-2422'
2015-07-15 17:24:05 INFO bandpass::Calibrater::selectvis+ Selecting on intent: '*BANDPASS*'
2015-07-15 17:24:05 INFO bandpass::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis By selection 3078324 rows are reduced to 252000
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis Frequency selection:
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 17:24:06 INFO bandpass::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 17:24:07 INFO bandpass::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:24:07 INFO bandpass::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:24:07 INFO bandpass::Calibrater::setapply(type, applypar) . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:24:07 INFO bandpass::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:24:07 INFO bandpass::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:24:07 INFO bandpass:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 17:24:08 INFO bandpass:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 17:24:08 INFO bandpass::Calibrater::setapply(type, applypar) . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:24:08 INFO bandpass::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:24:08 INFO bandpass::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:24:38 INFO bandpass::Calibrater::setapply(type, applypar) . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:24:38 INFO bandpass::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:24:38 INFO bandpass::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:24:39 INFO bandpass::Calibrater::setapply(type, applypar) . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 17:24:39 INFO bandpass::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 17:24:39 INFO bandpass::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 17:24:39 INFO bandpass::Calibrater::setsolve . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl append=false solint=inf,7.8125MHz refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=3 apmode=AP solnorm=true
2015-07-15 17:24:39 INFO bandpass::calibrater::solve Beginning solve-----------------------------
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl append=false solint=inf,7.8125MHz refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=3 apmode=AP solnorm=true
2015-07-15 17:24:39 INFO bandpass::Calibrater::solve Solving for B Jones
2015-07-15 17:24:39 INFO bandpass:::: Combining scans.
2015-07-15 17:24:39 INFO bandpass:::: For solint = inf, found 4 solution intervals.
2015-07-15 17:24:40 INFO bandpass::Calibrater::solve Reducing nchan in spw 17 from 1920 to 60
2015-07-15 17:25:29 INFO bandpass::Calibrater::solve Reducing nchan in spw 19 from 1920 to 60
2015-07-15 17:26:17 INFO bandpass::Calibrater::solve Reducing nchan in spw 21 from 1920 to 60
2015-07-15 17:27:03 INFO bandpass::Calibrater::solve Reducing nchan in spw 23 from 1920 to 60
2015-07-15 17:27:50 INFO bandpass::Calibrater::solve Found good B Jones solutions in 4 slots.
2015-07-15 17:27:50 INFO bandpass:::: Applying refant: DA52 (DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45)
2015-07-15 17:27:51 INFO bandpass:::: Normalizing solutions per spw, pol, ant, time.
2015-07-15 17:27:51 INFO bandpass:::: Writing solutions to table: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl
2015-07-15 17:27:52 INFO bandpass::calibrater::solve Finished solving.
2015-07-15 17:27:56 INFO bandpass::::casa ##### End Task: bandpass #####
2015-07-15 17:27:56 INFO bandpass::::casa+ ##########################################
2015-07-15 17:27:57 INFO bandpass::pipeline.infrastructure.jobrequest::casa Executing gaincal(solint='int', interp=['linear,linear', '', 'nearest', 'linearperobs,linearflag'], spw='17,19,21,23', vis='uid___A002_Xa0b40d_X3cb8.ms', calmode='p', intent='*BANDPASS*', spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], []], refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45', gainfield=['nearest', '', '', ''], minblperant=4, antenna='0~35', gaintype='G', caltable='uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl', minsnr=2.0, gaintable=['uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.antpos', 'uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl'], field='J1517-2422', solnorm=False)
2015-07-15 17:27:57 INFO gaincal::::casa
2015-07-15 17:27:57 INFO gaincal::::casa+ ##########################################
2015-07-15 17:27:57 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 17:27:57 INFO gaincal::::casa gaincal(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",caltable="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl",field="J1517-2422",spw="17,19,21,23",
2015-07-15 17:27:57 INFO gaincal::::casa+ intent="*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 17:27:57 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="int",combine="",
2015-07-15 17:27:57 INFO gaincal::::casa+ preavg=-1.0,refant="DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45",minblperant=4,minsnr=2.0,solnorm=False,
2015-07-15 17:27:57 INFO gaincal::::casa+ gaintype="G",smodel=[],calmode="p",append=False,splinetime=3600.0,
2015-07-15 17:27:57 INFO gaincal::::casa+ npointaver=3,phasewrap=180.0,docallib=False,callib="",gaintable=['/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl'],
2015-07-15 17:27:57 INFO gaincal::::casa+ gainfield=['nearest', '', '', ''],interp=['linear,linear', '', 'nearest', 'linearperobs,linearflag'],spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], []],parang=False)
2015-07-15 17:27:57 INFO gaincal::calibrater::open Opening MS: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms for calibration.
2015-07-15 17:27:57 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 17:28:00 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 17:28:00 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 17:28:00 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 17:28:00 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 17:28:00 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'J1517-2422'
2015-07-15 17:28:00 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*BANDPASS*'
2015-07-15 17:28:00 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 17:28:01 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 252000
2015-07-15 17:28:02 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 17:28:02 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 17:28:02 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 17:28:02 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 17:28:02 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 17:28:02 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:28:02 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:28:03 INFO gaincal::Calibrater::setapply(type, applypar) . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:28:03 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:28:03 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:28:03 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 17:28:03 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 17:28:03 INFO gaincal::Calibrater::setapply(type, applypar) . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:28:03 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:28:03 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:28:34 INFO gaincal::Calibrater::setapply(type, applypar) . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:28:34 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:28:34 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:28:34 WARN gaincal:::: Only one ObsId found in /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl.tempMemCalTable; ignoring 'perobs' interpolation.
2015-07-15 17:28:34 INFO gaincal::Calibrater::setapply(type, applypar) . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 17:28:34 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 17:28:34 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 17:28:34 INFO gaincal::Calibrater::setsolve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl append=false solint=int refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=2 apmode=P solnorm=false
2015-07-15 17:28:34 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl append=false solint=int refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=2 apmode=P solnorm=false
2015-07-15 17:28:34 INFO gaincal::Calibrater::solve Solving for G Jones
2015-07-15 17:28:34 INFO gaincal:::: For solint = int, found 400 solution intervals.
2015-07-15 17:32:51 INFO gaincal::Calibrater::solve Found good G Jones solutions in 400 slots.
2015-07-15 17:32:51 INFO gaincal:::: Applying refant: DA52 (DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:51 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 17:32:52 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 17:33:02 INFO gaincal:::: Writing solutions to table: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl
2015-07-15 17:33:03 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 17:33:03 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 17:33:03 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 17: 100/100/100
2015-07-15 17:33:03 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 19: 100/100/100
2015-07-15 17:33:03 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 21: 100/100/100
2015-07-15 17:33:03 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 23: 100/100/100
2015-07-15 17:33:03 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 17:33:03 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 17:33:06 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 17:33:06 INFO gaincal::::casa+ ##########################################
2015-07-15 17:33:07 INFO gaincal::pipeline.infrastructure.jobrequest::casa Executing gaincal(solint='inf', interp=['linear,linear', '', 'nearest', 'linearperobs,linearflag', 'linear,linear'], spw='17,19,21,23', vis='uid___A002_Xa0b40d_X3cb8.ms', calmode='a', intent='*BANDPASS*', spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], [], []], refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45', gainfield=['nearest', '', '', '', 'nearest'], minblperant=4, antenna='0~35', gaintype='T', caltable='uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl', minsnr=2.0, gaintable=['uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.antpos', 'uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl'], field='J1517-2422', solnorm=False)
2015-07-15 17:33:07 INFO gaincal::::casa
2015-07-15 17:33:07 INFO gaincal::::casa+ ##########################################
2015-07-15 17:33:07 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 17:33:07 INFO gaincal::::casa gaincal(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",caltable="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl",field="J1517-2422",spw="17,19,21,23",
2015-07-15 17:33:07 INFO gaincal::::casa+ intent="*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 17:33:07 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="inf",combine="",
2015-07-15 17:33:07 INFO gaincal::::casa+ preavg=-1.0,refant="DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45",minblperant=4,minsnr=2.0,solnorm=False,
2015-07-15 17:33:07 INFO gaincal::::casa+ gaintype="T",smodel=[],calmode="a",append=False,splinetime=3600.0,
2015-07-15 17:33:07 INFO gaincal::::casa+ npointaver=3,phasewrap=180.0,docallib=False,callib="",gaintable=['/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl', '/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl'],
2015-07-15 17:33:07 INFO gaincal::::casa+ gainfield=['nearest', '', '', '', 'nearest'],interp=['linear,linear', '', 'nearest', 'linearperobs,linearflag', 'linear,linear'],spwmap=[[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15], [], [], [], []],parang=False)
2015-07-15 17:33:07 INFO gaincal::calibrater::open Opening MS: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms for calibration.
2015-07-15 17:33:07 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 17:33:11 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 17:33:11 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 17:33:11 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 17:33:11 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 17:33:11 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'J1517-2422'
2015-07-15 17:33:11 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*BANDPASS*'
2015-07-15 17:33:11 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 252000
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 17:33:12 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 17:33:12 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:33:12 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:33:13 INFO gaincal::Calibrater::setapply(type, applypar) . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:33:13 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:33:13 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:33:13 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 17:33:14 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 17:33:14 INFO gaincal::Calibrater::setapply(type, applypar) . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:33:14 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:33:14 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:33:45 INFO gaincal::Calibrater::setapply(type, applypar) . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:33:45 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:33:45 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:33:45 WARN gaincal:::: Only one ObsId found in /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl.tempMemCalTable; ignoring 'perobs' interpolation.
2015-07-15 17:33:46 INFO gaincal::Calibrater::setapply(type, applypar) . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 17:33:46 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 17:33:46 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 17:33:46 INFO gaincal::Calibrater::setapply(type, applypar) . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 17:33:46 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 17:33:46 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 17:33:46 INFO gaincal::Calibrater::setsolve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl append=false solint=inf refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=2 apmode=A solnorm=false
2015-07-15 17:33:46 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . KAntPos Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.antpos select= interp=linear spwmap=[0] calWt=false
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . B TSYS: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_tsyscal.s5_1.tsyscal.tbl select= interp=linear, spwmap=[0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 9, 11, 11, 13, 13, 15, 15, 9, 9, 11, 11, 13, 13, 15, 15] calWt=true
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . B Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.channel.solintinf_7_812MHz.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . G Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_5.spw17_19_21_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hifa_wvrgcalflag.s7_4.sm6_048s.wvrcal.tbl select= interp=nearest spwmap=[] calWt=true
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve . T Jones: table=/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl append=false solint=inf refant='DA52,DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45' minsnr=2 apmode=A solnorm=false
2015-07-15 17:33:46 INFO gaincal::Calibrater::solve Solving for T Jones
2015-07-15 17:33:46 INFO gaincal:::: For solint = inf, found 4 solution intervals.
2015-07-15 17:37:49 INFO gaincal::Calibrater::solve Found good T Jones solutions in 4 slots.
2015-07-15 17:37:49 INFO gaincal:::: Applying refant: DA52 (DA60,DA59,DV12,DA62,DA57,DV20,DV17,DV22,DV08,DA49,DV02,DV04,DV19,DV18,DA64,DV05,DA44,DA46,DV21,DA53,DA63,DA41,DV01,DV10,DA61,DV16,DV15,DA42,DA43,DV09,DV14,DV23,DA51,DV11,DA45)
2015-07-15 17:37:49 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 17:37:49 INFO gaincal:::: Writing solutions to table: /mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl
2015-07-15 17:37:50 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 17:37:50 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 17:37:50 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 17: 1/1/1
2015-07-15 17:37:50 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 19: 1/1/1
2015-07-15 17:37:50 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 21: 1/1/1
2015-07-15 17:37:50 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 23: 1/1/1
2015-07-15 17:37:50 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 17:37:50 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 17:37:54 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 17:37:54 INFO gaincal::::casa+ ##########################################
2015-07-15 17:37:55 INFO gaincal::pipeline.hif.tasks.lowgainflag.lowgainflag::casa Computing flagging metrics for caltable uid___A002_Xa0b40d_X3cb8.ms.hif_lowgainflag.s8_6.spw17_19_21_23.solintinf.gacal.tbl
2015-07-15 17:37:55 INFO gaincal::pipeline.hif.tasks.common.viewflaggers::casa uid___A002_Xa0b40d_X3cb8.ms iteration 1 raised 0 flagging commands
2015-07-15 17:37:55 INFO gaincal::pipeline.infrastructure.jobrequest::casa Executing flagdata(vis='uid___A002_Xa0b40d_X3cb8.ms', mode='summary')
2015-07-15 17:37:56 INFO flagdata::::casa
2015-07-15 17:37:56 INFO flagdata::::casa+ ##########################################
2015-07-15 17:37:56 INFO flagdata::::casa+ ##### Begin Task: flagdata #####
2015-07-15 17:37:56 INFO flagdata::::casa flagdata(vis="/mnt/jaosco/pipeline/data/2013.1.00278.S_2015_07_15T16_13_56.693/SOUS_uid___A001_X120_X100/GOUS_uid___A001_X120_X101/MOUS_uid___A001_X120_X102/working/uid___A002_Xa0b40d_X3cb8.ms",mode="summary",autocorr=False,inpfile="",
2015-07-15 17:37:56 INFO flagdata::::casa+ reason="any",tbuff=0.0,spw="",field="",antenna="",
2015-07-15 17:37:56 INFO flagdata::::casa+ uvrange="",timerange="",correlation="",scan="",intent="",
2015-07-15 17:37:56 INFO flagdata::::casa+ array="",observation="",feed="",clipminmax=[],datacolumn="DATA",
2015-07-15 17:37:56 INFO flagdata::::casa+ clipoutside=True,channelavg=False,clipzeros=False,quackinterval=1.0,quackmode="beg",
2015-07-15 17:37:56 INFO flagdata::::casa+ quackincrement=False,tolerance=0.0,addantenna="",lowerlimit=0.0,upperlimit=90.0,
2015-07-15 17:37:56 INFO flagdata::::casa+ ntime="scan",combinescans=False,timecutoff=4.0,freqcutoff=3.0,timefit="line",
2015-07-15 17:37:56 INFO flagdata::::casa+ freqfit="poly",maxnpieces=7,flagdimension="freqtime",usewindowstats="none",halfwin=1,
2015-07-15 17:37:56 INFO flagdata::::casa+ extendflags=True,winsize=3,timedev="",freqdev="",timedevscale=5.0,
2015-07-15 17:37:56 INFO flagdata::::casa+ freqdevscale=5.0,spectralmax=1000000.0,spectralmin=0.0,extendpols=True,growtime=50.0,
2015-07-15 17:37:56 INFO flagdata::::casa+ growfreq=50.0,growaround=False,flagneartime=False,flagnearfreq=False,minrel=0.0,
2015-07-15 17:37:56 INFO flagdata::::casa+ maxrel=1.0,minabs=0,maxabs=-1,spwchan=False,spwcorr=False,
2015-07-15 17:37:56 INFO flagdata::::casa+ basecnt=False,name="Summary",action="apply",display="",flagbackup=True,
2015-07-15 17:37:56 INFO flagdata::::casa+ savepars=False,cmdreason="",outfile="")
2015-07-15 17:37:56 INFO AgentFlagger::open Table type is Measurement Set
2015-07-15 17:37:56 INFO flagdata::::casa Summary mode is active
2015-07-15 17:37:56 INFO flagdata::::casa Initializing the agents
2015-07-15 17:37:56 INFO Summary::setAgentParameters Spw-Channel count deactivated
2015-07-15 17:37:56 INFO Summary::setAgentParameters Spw-Correlation count deactivated
2015-07-15 17:37:56 INFO Summary::setAgentParameters Baseline count deactivated
2015-07-15 17:37:56 INFO AgentFlagger::initAgents There are 1 valid agents in list
2015-07-15 17:37:56 INFO flagdata::::casa Running the agentflagger tool
2015-07-15 17:37:59 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:37:59 INFO FlagMSHandler:: Chunk = 1 [progress: 0%], Observation = 0, Array = 0, Scan = 1, Field = 0 (J1517-2422), Spw = 0, Channels = 4, Corrs = [ XX ], Total Rows = 3132
2015-07-15 17:38:04 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:04 INFO FlagMSHandler:: Chunk = 9 [progress: 13%], Observation = 0, Array = 0, Scan = 1, Field = 0 (J1517-2422), Spw = 8, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:38:09 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:09 INFO FlagMSHandler:: Chunk = 14 [progress: 24%], Observation = 0, Array = 0, Scan = 2, Field = 0 (J1517-2422), Spw = 12, Channels = 1, Corrs = [ XX YY ], Total Rows = 83916
2015-07-15 17:38:14 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:14 INFO FlagMSHandler:: Chunk = 18 [progress: 34%], Observation = 0, Array = 0, Scan = 2, Field = 0 (J1517-2422), Spw = 16, Channels = 1, Corrs = [ XX YY ], Total Rows = 83916
2015-07-15 17:38:24 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:24 INFO FlagMSHandler:: Chunk = 30 [progress: 44%], Observation = 0, Array = 0, Scan = 4, Field = 0 (J1517-2422), Spw = 18, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:38:39 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:39 INFO FlagMSHandler:: Chunk = 34 [progress: 52%], Observation = 0, Array = 0, Scan = 4, Field = 0 (J1517-2422), Spw = 22, Channels = 1, Corrs = [ XX YY ], Total Rows = 66600
2015-07-15 17:38:49 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:38:49 INFO FlagMSHandler:: Chunk = 44 [progress: 60%], Observation = 0, Array = 0, Scan = 5, Field = 1 (Titan), Spw = 15, Channels = 128, Corrs = [ XX YY ], Total Rows = 15984
2015-07-15 17:39:00 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:39:00 INFO FlagMSHandler:: Chunk = 72 [progress: 70%], Observation = 0, Array = 0, Scan = 8, Field = 3 (IRAS16293-2422), Spw = 16, Channels = 1, Corrs = [ XX YY ], Total Rows = 15984
2015-07-15 17:39:20 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:39:20 INFO FlagMSHandler:: Chunk = 81 [progress: 82%], Observation = 0, Array = 0, Scan = 9, Field = 3 (IRAS16293-2422), Spw = 24, Channels = 1, Corrs = [ XX YY ], Total Rows = 43290
2015-07-15 17:39:30 INFO FlagMSHandler:: ------------------------------------------------------------------------------------
2015-07-15 17:39:30 INFO FlagMSHandler:: Chunk = 103 [progress: 92%], Observation = 0, Array = 0, Scan = 12, Field = 3 (IRAS16293-2422), Spw = 19, Channels = 1920, Corrs = [ XX YY ], Total Rows = 43290
2015-07-15 17:39:46 INFO FlagMSHandler::nextChunk ====================================================================================
2015-07-15 17:39:46 INFO Summary::getResult antenna DA41 flagged: 2.61629e+07 total: 1.59503e+08 (16.4%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA42 flagged: 2.41206e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA43 flagged: 3.55174e+07 total: 1.59503e+08 (22.3%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA44 flagged: 2.31524e+07 total: 1.59503e+08 (14.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA45 flagged: 1.59498e+08 total: 1.59503e+08 (100%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA46 flagged: 2.50504e+07 total: 1.59503e+08 (15.7%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA49 flagged: 2.40822e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA51 flagged: 2.60647e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA52 flagged: 2.46086e+07 total: 1.59503e+08 (15.4%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA53 flagged: 2.41513e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA57 flagged: 2.41398e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA59 flagged: 2.46355e+07 total: 1.59503e+08 (15.4%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA60 flagged: 2.36134e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA61 flagged: 2.36442e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA62 flagged: 2.36365e+07 total: 1.59503e+08 (14.8%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA63 flagged: 2.40669e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DA64 flagged: 2.40899e+07 total: 1.59503e+08 (15.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV01 flagged: 2.67602e+07 total: 1.59503e+08 (16.8%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV02 flagged: 2.72174e+07 total: 1.59503e+08 (17.1%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV04 flagged: 2.63106e+07 total: 1.59503e+08 (16.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV05 flagged: 2.59918e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV08 flagged: 2.6522e+07 total: 1.59503e+08 (16.6%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV09 flagged: 3.50617e+07 total: 1.59503e+08 (22%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV10 flagged: 2.79051e+07 total: 1.59503e+08 (17.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV11 flagged: 2.82663e+07 total: 1.59503e+08 (17.7%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV12 flagged: 2.76324e+07 total: 1.59503e+08 (17.3%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV14 flagged: 5.9781e+07 total: 1.59503e+08 (37.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV15 flagged: 2.9538e+07 total: 1.59503e+08 (18.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV16 flagged: 2.70291e+07 total: 1.59503e+08 (16.9%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV17 flagged: 2.58035e+07 total: 1.59503e+08 (16.2%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV18 flagged: 2.75363e+07 total: 1.59503e+08 (17.3%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV19 flagged: 2.68947e+07 total: 1.59503e+08 (16.9%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV20 flagged: 2.74979e+07 total: 1.59503e+08 (17.2%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV21 flagged: 2.78897e+07 total: 1.59503e+08 (17.5%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV22 flagged: 2.68447e+07 total: 1.59503e+08 (16.8%)
2015-07-15 17:39:46 INFO Summary::getResult antenna DV23 flagged: 2.60532e+07 total: 1.59503e+08 (16.3%)
2015-07-15 17:39:46 INFO Summary::getResult array 0 flagged: 6.38162e+08 total: 2.95092e+09 (21.6%)
2015-07-15 17:39:46 INFO Summary::getResult correlation XX flagged: 3.1911e+08 total: 1.47557e+09 (21.6%)
2015-07-15 17:39:46 INFO Summary::getResult correlation YY flagged: 3.19053e+08 total: 1.47534e+09 (21.6%)
2015-07-15 17:39:46 INFO Summary::getResult field IRAS16293-2422 flagged: 2.26814e+08 total: 1.36365e+09 (16.6%)
2015-07-15 17:39:46 INFO Summary::getResult field J1517-2422 flagged: 3.24864e+08 total: 1.16133e+09 (28%)
2015-07-15 17:39:46 INFO Summary::getResult field J1625-2527 flagged: 1.83253e+07 total: 1.53538e+08 (11.9%)
2015-07-15 17:39:46 INFO Summary::getResult field Titan flagged: 6.81587e+07 total: 2.72393e+08 (25%)
2015-07-15 17:39:46 INFO Summary::getResult observation 0 flagged: 6.38162e+08 total: 2.95092e+09 (21.6%)
2015-07-15 17:39:46 INFO Summary::getResult scan 1 flagged: 3.46445e+07 total: 3.46445e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 10 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:39:46 INFO Summary::getResult scan 11 flagged: 1.64968e+07 total: 1.64968e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 12 flagged: 9.88545e+07 total: 6.6533e+08 (14.9%)
2015-07-15 17:39:46 INFO Summary::getResult scan 13 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:39:46 INFO Summary::getResult scan 2 flagged: 8.66087e+07 total: 8.66087e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 3 flagged: 1.64969e+07 total: 1.64969e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 4 flagged: 1.87114e+08 total: 1.02358e+09 (18.3%)
2015-07-15 17:39:46 INFO Summary::getResult scan 5 flagged: 1.64969e+07 total: 1.64969e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 6 flagged: 5.16618e+07 total: 2.55896e+08 (20.2%)
2015-07-15 17:39:46 INFO Summary::getResult scan 7 flagged: 6.10844e+06 total: 5.11792e+07 (11.9%)
2015-07-15 17:39:46 INFO Summary::getResult scan 8 flagged: 1.64968e+07 total: 1.64968e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult scan 9 flagged: 9.49662e+07 total: 6.6533e+08 (14.3%)
2015-07-15 17:39:46 INFO Summary::getResult spw 0 flagged: 57188 total: 229392 (24.9%)
2015-07-15 17:39:46 INFO Summary::getResult spw 1 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 10 flagged: 295704 total: 295704 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 11 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 12 flagged: 295704 total: 295704 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 13 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 14 flagged: 295704 total: 295704 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 15 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 16 flagged: 295704 total: 295704 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 17 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:39:46 INFO Summary::getResult spw 18 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:39:46 INFO Summary::getResult spw 19 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:39:46 INFO Summary::getResult spw 2 flagged: 133200 total: 133200 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 20 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:39:46 INFO Summary::getResult spw 21 flagged: 1.46799e+08 total: 6.90509e+08 (21.3%)
2015-07-15 17:39:46 INFO Summary::getResult spw 22 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:39:46 INFO Summary::getResult spw 23 flagged: 1.01295e+08 total: 6.90509e+08 (14.7%)
2015-07-15 17:39:46 INFO Summary::getResult spw 24 flagged: 51092 total: 359640 (14.2%)
2015-07-15 17:39:46 INFO Summary::getResult spw 3 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 4 flagged: 133200 total: 133200 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 5 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 6 flagged: 133200 total: 133200 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 7 flagged: 8.5248e+06 total: 8.5248e+06 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 8 flagged: 133200 total: 133200 (100%)
2015-07-15 17:39:46 INFO Summary::getResult spw 9 flagged: 3.78501e+07 total: 3.78501e+07 (100%)
2015-07-15 17:39:46 INFO Summary::getResult Total Flagged: 6.38162e+08 Total Counts: 2.95092e+09 (21.6%)
2015-07-15 17:39:46 INFO flagdata::::casa Flags are not written to the MS. (action='calculate')
2015-07-15 17:39:46 INFO flagdata::::casa ##### End Task: flagdata #####
2015-07-15 17:39:46 INFO flagdata::::casa+ ##########################################