2015-07-15 18:39:04 INFO hifa_gfluxscale::pipeline.infrastructure.basetask::casa Starting execution for stage 12
2015-07-15 18:39:06 INFO hifa_gfluxscale::pipeline.hifa.heuristics.fluxscale::casa calibrator:Titan size:0.791119338561
2015-07-15 18:39:07 INFO hifa_gfluxscale::pipeline.hifa.heuristics.fluxscale::casa minimum frequency: 335026047263
2015-07-15 18:39:07 INFO hifa_gfluxscale::pipeline.hifa.heuristics.fluxscale::casa maximum baseline: 230.379973634
2015-07-15 18:39:07 INFO hifa_gfluxscale::pipeline.hifa.heuristics.fluxscale::casa antenna selection: DV19,DV18,DA64,DA49,DA62,DA60,DA45,DA44,DA46,DA41,DV14,DV17,DV16,DA63,DV21,DV10,DA52,DA53,DV22,DV12,DA57,DV08,DV09,DV04,DA59,DV02,DV01,DV20,DV05&
2015-07-15 18:39:07 INFO hifa_gfluxscale::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='*FLUX*,*AMPLI*', 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', append=False, gainfield=['nearest', '', '', ''], minblperant=2, antenna='DV19,DV18,DA64,DA49,DA62,DA60,DA45,DA44,DA46,DA41,DV14,DV17,DV16,DA63,DV21,DV10,DA52,DA53,DV22,DV12,DA57,DV08,DV09,DV04,DA59,DV02,DV01,DV20,DV05&', gaintype='G', caltable='uid___A002_Xa0b40d_X3cb8.ms.hifa_gfluxscale.s12_2.spw19_21_17_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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl'], field='Titan', solnorm=False)
2015-07-15 18:39:07 INFO gaincal::::casa
2015-07-15 18:39:07 INFO gaincal::::casa+ ##########################################
2015-07-15 18:39:07 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 18:39: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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl",field="Titan",spw="17,19,21,23",
2015-07-15 18:39:07 INFO gaincal::::casa+ intent="*FLUX*,*AMPLI*",selectdata=True,timerange="",uvrange="",antenna="DV19,DV18,DA64,DA49,DA62,DA60,DA45,DA44,DA46,DA41,DV14,DV17,DV16,DA63,DV21,DV10,DA52,DA53,DV22,DV12,DA57,DV08,DV09,DV04,DA59,DV02,DV01,DV20,DV05&",
2015-07-15 18:39:07 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="int",combine="",
2015-07-15 18:39:07 INFO gaincal::::casa+ preavg=-1.0,refant="DA52",minblperant=2,minsnr=2.0,solnorm=False,
2015-07-15 18:39:07 INFO gaincal::::casa+ gaintype="G",smodel=[],calmode="p",append=False,splinetime=3600.0,
2015-07-15 18:39: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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl'],
2015-07-15 18:39:07 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 18:39: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 18:39:07 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 18:39:08 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 18:39:08 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 18:39:08 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 18:39:08 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 18:39:08 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'Titan'
2015-07-15 18:39:08 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*FLUX*,*AMPLI*'
2015-07-15 18:39:08 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: 'DV19,DV18,DA64,DA49,DA62,DA60,DA45,DA44,DA46,DA41,DV14,DV17,DV16,DA63,DV21,DV10,DA52,DA53,DV22,DV12,DA57,DV08,DV09,DV04,DA59,DV02,DV01,DV20,DV05&'
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 40600
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 18:39:09 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 18:39:09 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:39:09 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:39:10 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 18:39:10 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:39:10 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:39:10 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 18:39:10 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 18:39:10 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 18:39:10 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:39:10 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:39:41 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 18:39:41 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:39:41 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:39:41 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl.tempMemCalTable; ignoring 'perobs' interpolation.
2015-07-15 18:39:41 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:39:41 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 18:39:41 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 18:39:41 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl append=false solint=int refant='DA52' minsnr=2 apmode=P solnorm=false
2015-07-15 18:39:41 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 18:39:42 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 18:39:42 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 18:39:42 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 18:39:42 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:39:42 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 18:39:42 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 18:39:42 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl append=false solint=int refant='DA52' minsnr=2 apmode=P solnorm=false
2015-07-15 18:39:42 INFO gaincal::Calibrater::solve Solving for G Jones
2015-07-15 18:39:42 INFO gaincal:::: For solint = int, found 100 solution intervals.
2015-07-15 18:40:26 INFO gaincal::Calibrater::solve Found good G Jones solutions in 100 slots.
2015-07-15 18:40:26 INFO gaincal:::: Applying refant: DA52
2015-07-15 18:40:26 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 18:40:29 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl
2015-07-15 18:40:30 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 18:40:30 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 18:40:30 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 17: 25/25/25
2015-07-15 18:40:30 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 19: 25/25/25
2015-07-15 18:40:30 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 21: 25/25/25
2015-07-15 18:40:30 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 23: 25/25/25
2015-07-15 18:40:30 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 18:40:30 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 18:40:33 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 18:40:33 INFO gaincal::::casa+ ##########################################
2015-07-15 18:40:34 INFO gaincal::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='*PHASE*,*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', append=True, gainfield=['nearest', '', '', ''], minblperant=4, antenna='0~35', gaintype='G', caltable='uid___A002_Xa0b40d_X3cb8.ms.hifa_gfluxscale.s12_2.spw19_21_17_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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl'], field='J1517-2422,J1625-2527', solnorm=False)
2015-07-15 18:40:34 INFO gaincal::::casa
2015-07-15 18:40:34 INFO gaincal::::casa+ ##########################################
2015-07-15 18:40:34 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 18:40:34 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl",field="J1517-2422,J1625-2527",spw="17,19,21,23",
2015-07-15 18:40:34 INFO gaincal::::casa+ intent="*PHASE*,*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 18:40:34 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="int",combine="",
2015-07-15 18:40:34 INFO gaincal::::casa+ preavg=-1.0,refant="DA52",minblperant=4,minsnr=2.0,solnorm=False,
2015-07-15 18:40:34 INFO gaincal::::casa+ gaintype="G",smodel=[],calmode="p",append=True,splinetime=3600.0,
2015-07-15 18:40:34 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl'],
2015-07-15 18:40:34 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 18:40:34 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 18:40:34 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 18:40:37 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 18:40:37 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 18:40:37 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 18:40:37 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 18:40:37 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'J1517-2422,J1625-2527'
2015-07-15 18:40:37 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*PHASE*,*BANDPASS*'
2015-07-15 18:40:37 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 289800
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 18:40:45 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 18:40:45 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:40:45 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:40:46 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 18:40:46 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:40:46 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:40:46 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 18:40:47 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 18:40:47 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 18:40:47 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:40:47 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:41:17 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 18:41:17 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:41:17 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:41:17 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl.tempMemCalTable; ignoring 'perobs' interpolation.
2015-07-15 18:41:18 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:41:18 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 18:41:18 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 18:41:18 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl append=true solint=int refant='DA52' minsnr=2 apmode=P solnorm=false
2015-07-15 18:41:18 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 18:41:18 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 18:41:18 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 18:41:18 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 18:41:18 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:41:18 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 18:41:18 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 18:41:18 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl append=true solint=int refant='DA52' minsnr=2 apmode=P solnorm=false
2015-07-15 18:41:18 INFO gaincal::Calibrater::solve Solving for G Jones
2015-07-15 18:41:18 INFO gaincal:::: For solint = int, found 460 solution intervals.
2015-07-15 18:46:07 INFO gaincal::Calibrater::solve Found good G Jones solutions in 460 slots.
2015-07-15 18:46:07 INFO gaincal:::: Applying refant: DA52
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=17, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=19, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=21, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:17:00.1 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: At 2015/05/17/06:22:30.0 (Spw=23, Fld=0), using refant DA60 (id=12) (alternate)
2015-07-15 18:46:08 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 18:46:20 INFO gaincal:::: Appending 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl
2015-07-15 18:46:21 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 18:46:21 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 18:46:21 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 17: 115/115/115
2015-07-15 18:46:21 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 19: 115/115/115
2015-07-15 18:46:21 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 21: 115/115/115
2015-07-15 18:46:21 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 23: 115/115/115
2015-07-15 18:46:21 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 18:46:21 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 18:46:25 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 18:46:25 INFO gaincal::::casa+ ##########################################
2015-07-15 18:46:26 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='*PHASE*,*FLUX*,*AMPLI*,*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', append=False, gainfield=['nearest', '', '', '', 'nearest'], minblperant=2, antenna='0~35', gaintype='T', caltable='uid___A002_Xa0b40d_X3cb8.ms.hifa_gfluxscale.s12_4.spw19_21_17_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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl', 'uid___A002_Xa0b40d_X3cb8.ms.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl'], field='J1517-2422,J1625-2527,Titan', solnorm=False)
2015-07-15 18:46:26 INFO gaincal::::casa
2015-07-15 18:46:26 INFO gaincal::::casa+ ##########################################
2015-07-15 18:46:26 INFO gaincal::::casa+ ##### Begin Task: gaincal #####
2015-07-15 18:46:26 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.hifa_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl",field="J1517-2422,J1625-2527,Titan",spw="17,19,21,23",
2015-07-15 18:46:26 INFO gaincal::::casa+ intent="*PHASE*,*FLUX*,*AMPLI*,*BANDPASS*",selectdata=True,timerange="",uvrange="",antenna="0~35",
2015-07-15 18:46:26 INFO gaincal::::casa+ scan="",observation="",msselect="",solint="inf",combine="",
2015-07-15 18:46:26 INFO gaincal::::casa+ preavg=-1.0,refant="DA52",minblperant=2,minsnr=2.0,solnorm=False,
2015-07-15 18:46:26 INFO gaincal::::casa+ gaintype="T",smodel=[],calmode="a",append=False,splinetime=3600.0,
2015-07-15 18:46:26 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl'],
2015-07-15 18:46:26 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 18:46:26 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 18:46:27 INFO gaincal::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 18:46:30 INFO gaincal::calibrater::setdata Beginning selectvis--(MSSelection version)-------
2015-07-15 18:46:30 INFO gaincal::calibrater::reset Reseting solve/apply state
2015-07-15 18:46:30 INFO gaincal::Calibrater::selectvis Performing selection on MeasurementSet
2015-07-15 18:46:30 INFO gaincal::Calibrater::selectvis+ Selecting on spw: '17,19,21,23'
2015-07-15 18:46:30 INFO gaincal::Calibrater::selectvis+ Selecting on field: 'J1517-2422,J1625-2527,Titan'
2015-07-15 18:46:30 INFO gaincal::Calibrater::selectvis+ Selecting on intent: '*PHASE*,*FLUX*,*AMPLI*,*BANDPASS*'
2015-07-15 18:46:30 INFO gaincal::Calibrater::selectvis+ Selecting on antenna/baseline: '0~35'
2015-07-15 18:46:31 INFO gaincal::Calibrater::selectvis By selection 3078324 rows are reduced to 352800
2015-07-15 18:46:32 INFO gaincal::Calibrater::selectvis Frequency selection:
2015-07-15 18:46:32 INFO gaincal::Calibrater::selectvis . Spw 17:0~1919 (1920 channels, step by 1)
2015-07-15 18:46:32 INFO gaincal::Calibrater::selectvis+ . Spw 19:0~1919 (1920 channels, step by 1)
2015-07-15 18:46:32 INFO gaincal::Calibrater::selectvis+ . Spw 21:0~1919 (1920 channels, step by 1)
2015-07-15 18:46:32 INFO gaincal::Calibrater::selectvis+ . Spw 23:0~1919 (1920 channels, step by 1)
2015-07-15 18:46:32 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:46:32 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:46:33 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 18:46:33 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:46:33 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:46:33 INFO gaincal:::: (KAntPos Jones: Overriding with spwmap=[0] since KAntPos Jones is not spw-dependent)
2015-07-15 18:46:34 INFO gaincal:::: (KAntPos Jones: Enforcing calWt()=False for phase/delay-like terms)
2015-07-15 18:46:34 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 18:46:34 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:46:34 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:47:05 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 18:47:05 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:47:05 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:47:05 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl.tempMemCalTable; ignoring 'perobs' interpolation.
2015-07-15 18:47:05 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:47:05 INFO gaincal::calibrater::setapply Beginning setapply--(MSSelection version)-------
2015-07-15 18:47:05 INFO gaincal::Calibrater::setapply(type, applypar) Arranging to APPLY:
2015-07-15 18:47:06 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 18:47:06 INFO gaincal::calibrater::setsolve Beginning setsolve--(MSSelection version)-------
2015-07-15 18:47:06 INFO gaincal::Calibrater::setsolve Arranging to SOLVE:
2015-07-15 18:47:06 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.hifa_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl append=false solint=inf refant='DA52' minsnr=2 apmode=A solnorm=false
2015-07-15 18:47:06 INFO gaincal::calibrater::solve Beginning solve-----------------------------
2015-07-15 18:47:06 INFO gaincal::Calibrater::solve The following calibration terms are arranged for apply:
2015-07-15 18:47:06 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 18:47:06 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 18:47:06 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_bandpass.s10_2.spw17_19_21_23.channel.solintinf.bcal.tbl select= interp=linearperobs, spwmap=[] calWt=true
2015-07-15 18:47:06 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.hifa_gfluxscale.s12_2.spw19_21_17_23.solintint.gpcal.tbl select= interp=linear spwmap=[] calWt=true
2015-07-15 18:47:06 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 18:47:06 INFO gaincal::Calibrater::solve The following calibration term is arranged for solve:
2015-07-15 18:47:06 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_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl append=false solint=inf refant='DA52' minsnr=2 apmode=A solnorm=false
2015-07-15 18:47:06 INFO gaincal::Calibrater::solve Solving for T Jones
2015-07-15 18:47:07 INFO gaincal:::: For solint = inf, found 20 solution intervals.
2015-07-15 18:53:21 INFO gaincal::Calibrater::solve Found good T Jones solutions in 20 slots.
2015-07-15 18:53:21 INFO gaincal:::: Applying refant: DA52
2015-07-15 18:53:22 INFO gaincal:::: Enforcing apmode on solutions.
2015-07-15 18:53:22 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.hifa_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl
2015-07-15 18:53:23 INFO gaincal::calibrater::solve Finished solving.
2015-07-15 18:53:23 INFO gaincal::::casa Calibration solve statistics per spw: (expected/attempted/succeeded):
2015-07-15 18:53:23 INFO gaincal::::casa Spw 0: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 1: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 2: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 3: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 4: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 5: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 6: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 7: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 8: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 9: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 10: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 11: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 12: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 13: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 14: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 15: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 16: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 17: 5/5/5
2015-07-15 18:53:23 INFO gaincal::::casa Spw 18: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 19: 5/5/5
2015-07-15 18:53:23 INFO gaincal::::casa Spw 20: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 21: 5/5/5
2015-07-15 18:53:23 INFO gaincal::::casa Spw 22: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 23: 5/5/5
2015-07-15 18:53:23 INFO gaincal::::casa Spw 24: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 25: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 26: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 27: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 28: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 29: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 30: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 31: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 32: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 33: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 34: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 35: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 36: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 37: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 38: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 39: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 40: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 41: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 42: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 43: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 44: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 45: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 46: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 47: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 48: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 49: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 50: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 51: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 52: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 53: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 54: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 55: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 56: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 57: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 58: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 59: 0/0/0
2015-07-15 18:53:23 INFO gaincal::::casa Spw 60: 0/0/0
2015-07-15 18:53:26 INFO gaincal::::casa ##### End Task: gaincal #####
2015-07-15 18:53:26 INFO gaincal::::casa+ ##########################################
2015-07-15 18:53:27 INFO gaincal::pipeline.infrastructure.jobrequest::casa Executing fluxscale(refspwmap=[-1], vis='uid___A002_Xa0b40d_X3cb8.ms', fluxtable='/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_gfluxscale.s12_5.fcal.tbl', reference='Titan', caltable='uid___A002_Xa0b40d_X3cb8.ms.hifa_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl', transfer='J1517-2422,J1625-2527')
2015-07-15 18:53:27 INFO fluxscale::::casa
2015-07-15 18:53:27 INFO fluxscale::::casa+ ##########################################
2015-07-15 18:53:27 INFO fluxscale::::casa+ ##### Begin Task: fluxscale #####
2015-07-15 18:53:27 INFO fluxscale::::casa fluxscale(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.hifa_gfluxscale.s12_4.spw19_21_17_23.solintinf.gacal.tbl",fluxtable="/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_gfluxscale.s12_5.fcal.tbl",reference="Titan",
2015-07-15 18:53:27 INFO fluxscale::::casa+ transfer="J1517-2422,J1625-2527",listfile="",append=False,refspwmap=[-1],incremental=False,
2015-07-15 18:53:27 INFO fluxscale::::casa+ fitorder=1)
2015-07-15 18:53:27 INFO fluxscale::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 18:53:28 INFO fluxscale::Calibrater:: Initializing nominal selection to the whole MS.
2015-07-15 18:53:32 INFO fluxscale::calibrater::fluxscale Beginning fluxscale--(MSSelection version)-------
2015-07-15 18:53:32 INFO fluxscale:::: Found reference field(s): Titan
2015-07-15 18:53:32 INFO fluxscale:::: Found transfer field(s): J1517-2422 J1625-2527
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=0 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=1 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=2 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=3 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=4 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=5 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=6 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=7 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=8 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=9 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=10 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=11 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=12 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=13 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=14 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=15 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=16 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=17 (freq=3.34792e+11 Hz) is: 1.14195 +/- 0.00396796 (SNR = 287.791, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=18 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=19 (freq=3.35261e+11 Hz) is: 1.14907 +/- 0.00560008 (SNR = 205.188, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=20 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=21 (freq=3.35729e+11 Hz) is: 1.14462 +/- 0.0133502 (SNR = 85.7379, N = 26)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=22 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=23 (freq=3.36198e+11 Hz) is: 1.13629 +/- 0.00457671 (SNR = 248.277, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=24 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=25 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=26 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=27 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=28 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=29 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=30 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=31 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=32 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=33 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=34 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=35 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=36 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=37 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=38 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=39 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=40 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=41 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=42 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=43 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=44 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=45 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=46 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=47 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=48 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=49 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=50 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=51 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=52 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=53 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=54 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=55 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=56 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=57 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=58 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=59 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1517-2422 in SpW=60 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=0 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=1 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=2 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=3 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=4 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=5 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=6 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=7 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=8 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=9 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=10 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=11 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=12 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=13 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=14 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=15 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=16 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=17 (freq=3.34792e+11 Hz) is: 0.686225 +/- 0.00338455 (SNR = 202.752, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=18 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=19 (freq=3.35261e+11 Hz) is: 0.685805 +/- 0.00478361 (SNR = 143.366, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=20 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=21 (freq=3.35729e+11 Hz) is: 0.68434 +/- 0.010235 (SNR = 66.8628, N = 26)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=22 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=23 (freq=3.36198e+11 Hz) is: 0.678322 +/- 0.00309656 (SNR = 219.057, N = 27)
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=24 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=25 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=26 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=27 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=28 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=29 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=30 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=31 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=32 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=33 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=34 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=35 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=36 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=37 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=38 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=39 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=40 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=41 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=42 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=43 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=44 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=45 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=46 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=47 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=48 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=49 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=50 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=51 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=52 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=53 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=54 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=55 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=56 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=57 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=58 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=59 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Flux density for J1625-2527 in SpW=60 is: INSUFFICIENT DATA
2015-07-15 18:53:32 INFO fluxscale:::: Fitted spectrum for J1517-2422 with fitorder=1: Flux density = 1.14126 +/- 0.00271958 (freq=335.495 GHz) spidx=-1.29485 +/- 1.29287
2015-07-15 18:53:32 INFO fluxscale:::: Fitted spectrum for J1625-2527 with fitorder=1: Flux density = 0.682795 +/- 0.000723241 (freq=335.495 GHz) spidx=-2.84618 +/- 0.563288
2015-07-15 18:53:32 INFO fluxscale::Calibrater::fluxscale Storing result 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.hifa_gfluxscale.s12_5.fcal.tbl
2015-07-15 18:53:32 INFO fluxscale:::: 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.hifa_gfluxscale.s12_5.fcal.tbl
2015-07-15 18:53:34 INFO fluxscale::::casa ##### End Task: fluxscale #####
2015-07-15 18:53:34 INFO fluxscale::::casa+ ##########################################
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa Recording flux density measurements for J1517-2422 in uid___A002_Xa0b40d_X3cb8.ms:
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa Recording flux density measurements for J1625-2527 in uid___A002_Xa0b40d_X3cb8.ms:
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:53:35 INFO fluxscale::pipeline.hif.tasks.importdata.importdata::casa Exported 8 flux measurements to /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/fluxscale_s12_4.csv
2015-07-15 18:53:36 INFO fluxscale::pipeline.infrastructure.jobrequest::casa Executing post_to_log(comment='Setjy marker: 2015-07-15 15:53:36.080822', echo_to_screen=False)
2015-07-15 18:53:36 INFO fluxscale::::casa Setjy marker: 2015-07-15 15:53:36.080822
2015-07-15 18:53:36 INFO fluxscale::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[1.14194564165, 0.0, 0.0, 0.0], scalebychan=True, field='J1517-2422', spix=0.0, spw='17', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*BANDPASS*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:53:36 INFO setjy::::casa
2015-07-15 18:53:36 INFO setjy::::casa+ ##########################################
2015-07-15 18:53:36 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:53:36 INFO setjy::::casa setjy(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",field=J1517-2422,spw="17",selectdata=True,
2015-07-15 18:53:36 INFO setjy::::casa+ timerange="",scan="",intent="*BANDPASS*",observation="",scalebychan=True,
2015-07-15 18:53:36 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[1.14194564165, 0.0, 0.0, 0.0],
2015-07-15 18:53:36 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:53:36 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:53:36 INFO setjy::::casa standard=manual
2015-07-15 18:53:37 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:53:37 INFO Clearing all model records in MS header.
2015-07-15 18:53:40 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:53:40 INFO Clearing all model records in MS header.
2015-07-15 18:53:40 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:53:41 INFO Clearing all model records in MS header.
2015-07-15 18:53:41 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:53:41 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:53:41 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1517-2422_334.792GHz57159.3d.cl
2015-07-15 18:53:41 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:54:40 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:54:40 INFO setjy::::casa+ ##########################################
2015-07-15 18:54:40 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[1.14906973696, 0.0, 0.0, 0.0], scalebychan=True, field='J1517-2422', spix=0.0, spw='19', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*BANDPASS*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:54:40 INFO setjy::::casa
2015-07-15 18:54:40 INFO setjy::::casa+ ##########################################
2015-07-15 18:54:40 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:54:40 INFO setjy::::casa setjy(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",field=J1517-2422,spw="19",selectdata=True,
2015-07-15 18:54:40 INFO setjy::::casa+ timerange="",scan="",intent="*BANDPASS*",observation="",scalebychan=True,
2015-07-15 18:54:40 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[1.14906973696, 0.0, 0.0, 0.0],
2015-07-15 18:54:40 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:54:40 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:54:40 INFO setjy::::casa standard=manual
2015-07-15 18:54:41 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:54:41 INFO Clearing all model records in MS header.
2015-07-15 18:54:44 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:54:44 INFO Clearing all model records in MS header.
2015-07-15 18:54:44 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:54:45 INFO Clearing all model records in MS header.
2015-07-15 18:54:45 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:54:45 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:54:45 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1517-2422_335.261GHz57159.3d.cl
2015-07-15 18:54:45 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:55:42 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:55:42 INFO setjy::::casa+ ##########################################
2015-07-15 18:55:42 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[1.14461619935, 0.0, 0.0, 0.0], scalebychan=True, field='J1517-2422', spix=0.0, spw='21', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*BANDPASS*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:55:42 INFO setjy::::casa
2015-07-15 18:55:42 INFO setjy::::casa+ ##########################################
2015-07-15 18:55:42 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:55:42 INFO setjy::::casa setjy(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",field=J1517-2422,spw="21",selectdata=True,
2015-07-15 18:55:42 INFO setjy::::casa+ timerange="",scan="",intent="*BANDPASS*",observation="",scalebychan=True,
2015-07-15 18:55:42 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[1.14461619935, 0.0, 0.0, 0.0],
2015-07-15 18:55:42 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:55:42 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:55:42 INFO setjy::::casa standard=manual
2015-07-15 18:55:43 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:55:43 INFO Clearing all model records in MS header.
2015-07-15 18:55:46 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:55:46 INFO Clearing all model records in MS header.
2015-07-15 18:55:46 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:55:47 INFO Clearing all model records in MS header.
2015-07-15 18:55:47 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:55:47 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:55:47 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1517-2422_335.729GHz57159.3d.cl
2015-07-15 18:55:47 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:56:46 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:56:46 INFO setjy::::casa+ ##########################################
2015-07-15 18:56:46 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[1.13628968235, 0.0, 0.0, 0.0], scalebychan=True, field='J1517-2422', spix=0.0, spw='23', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*BANDPASS*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:56:46 INFO setjy::::casa
2015-07-15 18:56:46 INFO setjy::::casa+ ##########################################
2015-07-15 18:56:46 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:56:46 INFO setjy::::casa setjy(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",field=J1517-2422,spw="23",selectdata=True,
2015-07-15 18:56:46 INFO setjy::::casa+ timerange="",scan="",intent="*BANDPASS*",observation="",scalebychan=True,
2015-07-15 18:56:46 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[1.13628968235, 0.0, 0.0, 0.0],
2015-07-15 18:56:46 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:56:46 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:56:46 INFO setjy::::casa standard=manual
2015-07-15 18:56:47 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:56:47 INFO Clearing all model records in MS header.
2015-07-15 18:56:50 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:56:50 INFO Clearing all model records in MS header.
2015-07-15 18:56:50 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:56:51 INFO Clearing all model records in MS header.
2015-07-15 18:56:51 INFO imager::data selection Selected 66600 out of 3078324 rows.
2015-07-15 18:56:51 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:56:51 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1517-2422_336.198GHz57159.3d.cl
2015-07-15 18:56:51 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:57:48 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:57:48 INFO setjy::::casa+ ##########################################
2015-07-15 18:57:48 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[0.686224525593, 0.0, 0.0, 0.0], scalebychan=True, field='J1625-2527', spix=0.0, spw='17', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*PHASE*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:57:48 INFO setjy::::casa
2015-07-15 18:57:48 INFO setjy::::casa+ ##########################################
2015-07-15 18:57:48 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:57:48 INFO setjy::::casa setjy(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",field=J1625-2527,spw="17",selectdata=True,
2015-07-15 18:57:48 INFO setjy::::casa+ timerange="",scan="",intent="*PHASE*",observation="",scalebychan=True,
2015-07-15 18:57:48 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[0.686224525593, 0.0, 0.0, 0.0],
2015-07-15 18:57:48 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:57:48 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:57:48 INFO setjy::::casa standard=manual
2015-07-15 18:57:48 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:57:48 INFO Clearing all model records in MS header.
2015-07-15 18:57:51 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:57:52 INFO Clearing all model records in MS header.
2015-07-15 18:57:52 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:57:52 INFO Clearing all model records in MS header.
2015-07-15 18:57:52 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:57:52 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:57:52 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1625-2527_334.792GHz57159.3d.cl
2015-07-15 18:57:52 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:58:02 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:58:02 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:02 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[0.685805266566, 0.0, 0.0, 0.0], scalebychan=True, field='J1625-2527', spix=0.0, spw='19', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*PHASE*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:58:02 INFO setjy::::casa
2015-07-15 18:58:02 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:02 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:58:02 INFO setjy::::casa setjy(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",field=J1625-2527,spw="19",selectdata=True,
2015-07-15 18:58:02 INFO setjy::::casa+ timerange="",scan="",intent="*PHASE*",observation="",scalebychan=True,
2015-07-15 18:58:02 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[0.685805266566, 0.0, 0.0, 0.0],
2015-07-15 18:58:02 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:58:02 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:58:02 INFO setjy::::casa standard=manual
2015-07-15 18:58:03 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:58:03 INFO Clearing all model records in MS header.
2015-07-15 18:58:06 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:58:06 INFO Clearing all model records in MS header.
2015-07-15 18:58:06 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:07 INFO Clearing all model records in MS header.
2015-07-15 18:58:07 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:07 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:58:07 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1625-2527_335.261GHz57159.3d.cl
2015-07-15 18:58:07 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:58:16 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:58:16 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:16 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[0.684339614393, 0.0, 0.0, 0.0], scalebychan=True, field='J1625-2527', spix=0.0, spw='21', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*PHASE*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:58:16 INFO setjy::::casa
2015-07-15 18:58:16 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:16 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:58:16 INFO setjy::::casa setjy(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",field=J1625-2527,spw="21",selectdata=True,
2015-07-15 18:58:16 INFO setjy::::casa+ timerange="",scan="",intent="*PHASE*",observation="",scalebychan=True,
2015-07-15 18:58:16 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[0.684339614393, 0.0, 0.0, 0.0],
2015-07-15 18:58:16 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:58:16 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:58:16 INFO setjy::::casa standard=manual
2015-07-15 18:58:17 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:58:17 INFO Clearing all model records in MS header.
2015-07-15 18:58:20 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:58:20 INFO Clearing all model records in MS header.
2015-07-15 18:58:20 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:21 INFO Clearing all model records in MS header.
2015-07-15 18:58:21 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:21 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:58:21 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1625-2527_335.729GHz57159.3d.cl
2015-07-15 18:58:21 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:58:30 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:58:30 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:30 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing setjy(fluxdensity=[0.678322491983, 0.0, 0.0, 0.0], scalebychan=True, field='J1625-2527', spix=0.0, spw='23', vis='uid___A002_Xa0b40d_X3cb8.ms', reffreq='1GHz', intent='*PHASE*', selectdata=True, standard='manual', usescratch=True)
2015-07-15 18:58:30 INFO setjy::::casa
2015-07-15 18:58:30 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:30 INFO setjy::::casa+ ##### Begin Task: setjy #####
2015-07-15 18:58:30 INFO setjy::::casa setjy(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",field=J1625-2527,spw="23",selectdata=True,
2015-07-15 18:58:30 INFO setjy::::casa+ timerange="",scan="",intent="*PHASE*",observation="",scalebychan=True,
2015-07-15 18:58:30 INFO setjy::::casa+ standard="manual",model="",modimage="",listmodels=False,fluxdensity=[0.678322491983, 0.0, 0.0, 0.0],
2015-07-15 18:58:30 INFO setjy::::casa+ spix=0.0,reffreq="1GHz",fluxdict={},useephemdir=False,interpolation="nearest",
2015-07-15 18:58:30 INFO setjy::::casa+ usescratch=True)
2015-07-15 18:58:30 INFO setjy::::casa standard=manual
2015-07-15 18:58:30 INFO Imager::open() Opening MeasurementSet /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
2015-07-15 18:58:30 INFO Clearing all model records in MS header.
2015-07-15 18:58:33 INFO imager::setjy() The applied flux density does not depend on frequency.
2015-07-15 18:58:34 INFO Clearing all model records in MS header.
2015-07-15 18:58:34 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:34 INFO Clearing all model records in MS header.
2015-07-15 18:58:34 INFO imager::data selection Selected 9990 out of 3078324 rows.
2015-07-15 18:58:34 INFO imager::ft() Fourier transforming: replacing MODEL_DATA column
2015-07-15 18:58:34 INFO imager::createSkyEquation() Processing after subtracting componentlist /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_setjy_spw0_J1625-2527_336.198GHz57159.3d.cl
2015-07-15 18:58:34 INFO imager::createFTMachine() Performing interferometric gridding...
2015-07-15 18:58:44 INFO setjy::::casa ##### End Task: setjy #####
2015-07-15 18:58:44 INFO setjy::::casa+ ##########################################
2015-07-15 18:58:44 INFO setjy::pipeline.infrastructure.jobrequest::casa Executing post_to_log(comment='Setjy marker: 2015-07-15 15:58:43.847718', echo_to_screen=False)
2015-07-15 18:58:44 INFO setjy::::casa Setjy marker: 2015-07-15 15:58:43.847718
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa Recording flux density measurements for J1517-2422 in uid___A002_Xa0b40d_X3cb8.ms:
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa Recording flux density measurements for J1625-2527 in uid___A002_Xa0b40d_X3cb8.ms:
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+
2015-07-15 18:58:45 INFO setjy::pipeline.hif.tasks.common.commonfluxresults::casa+