Plots

Flags

Flagcmds
uid___A002_Xa0b40d_X3cb8.ms
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+       ##########################################
Pipeline QA summary for this task.
Score Reason
1.00 0.00% of data in uid___A002_Xa0b40d_X3cb8.ms was newly flagged
niter
1
fnm_lo_limit
0.7
spw
['17,19,21,23']
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']
intent
['BANDPASS']
output_dir
/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
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']
fnm_hi_limit
1.3
flag_nmedian
True
Start time
2015-07-15 17:17:43.693766
End
2015-07-15 17:39:46.915598
Duration
0:22:03.221832
Context size
11.8 MB