INFO : AT.py : Setting {'basename': 'x', 'file': 'SEXTANS-A_92787.nfs.fits'} for Ingest_AT
INFO : AT.py : Setting 'ppp' = True for CubeStats_AT
INFO : AT.py : Setting 'numsigma' = 4.0 for CubeSum_AT
INFO : AT.py : Setting 'sigma' = 99.0 for CubeSum_AT
INFO : AT.py : Setting 'numsigma' = 4.0 for SFind2D_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing Ingest_AT - '' (V1.2.13)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     box :  []
INFO :     file :  SEXTANS-A_92787.nfs.fits
INFO :     smooth :  []
INFO :     basename :  x
INFO :     mask :  True
INFO :     pb :  
INFO :     edge :  []
INFO :     restfreq :  -1.0
INFO :     vlsr :  -999999.9
INFO :     usepb :  True
INFO : 
TIMING : Ingest ADMIT [  2.15376700e+00   1.64394545e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: SEXTANS-A   SHAPE: [ 45  45 689]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  1.59127000e-01   1.65473223e-01   1.41036719e+03   2.16972656e+02]
TIMING : Ingest importfits  [  1.04577000e-01   1.55523777e-01   1.41064062e+03   2.18386719e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  5.40570000e-02   1.10128164e-01   1.41278906e+03   2.21242188e+02]
TIMING : Ingest summary-0  [  1.38160000e-02   1.38759613e-02   1.41278906e+03   2.21242188e+02]
TIMING : Ingest mask  [  2.45810000e-02   3.45470905e-02   1.41278906e+03   2.21503906e+02]
TIMING : Ingest summary-1  [  1.35480000e-02   1.78608894e-02   1.41278906e+03   2.21503906e+02]
TIMING : Ingest statistics  [  3.81620000e-02   3.82649899e-02   1.41172656e+03   2.21628906e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 12.6500004, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 12.6500004, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [ 45  45 689   1] 1365598 -0.055589 0.053985
INFO : Ingest_AT.py : S/N (all data): 5.407897
INFO : Ingest_AT.py : GOOD PIXELS: 1365598/1395225 (97.876543% good or 2.123457% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.0555891 0.0539849 0.00998261  45 45 689  2.123457
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: SEXTANS-A
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 152.783800 -5.500001 22.000000
INFO : Ingest_AT.py : DEC  Axis 2: -4.704639 5.500001 22.000000
INFO : Ingest_AT.py : VLSRv = 0.000000 (from source catalog)
INFO : Ingest_AT.py : VLSRz = 0.000000 +/- 0.000000   1 values: [ 0.]
INFO : Ingest_AT.py : Freq Orig Axis 3: 115.016 0.000390625 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.015921 km/s @ fc=115.149890 fw=0.269141 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= 315.507976  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= -699.969569
INFO : Ingest_AT.py : VLSR = 315.507976 errs = 0.000000 0.000000 0.000000 width = -1.015921
TIMING : Ingest done  [  5.57235000e-01   5.62262058e-01   1.41507031e+03   2.25113281e+02]
TIMING : Ingest END [ 0.977271    1.11013913]
INFO : AT.py : BDP_OUT[0] = SpwCube_BDP x.im
INFO : 
INFO : 
INFO :    Executing CubeStats_AT - '' (V1.2.3)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     ppp :  True
INFO :     psample :  -1
INFO :     robust :  []
INFO :     maxvrms :  2.0
INFO : 
TIMING : CubeStats ADMIT [  3.19230100e+00   1.64394546e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.25980000e-02   5.28187752e-02   1.41432031e+03   2.24894531e+02]
TIMING : CubeStats start  [  1.25310000e-02   1.25691891e-02   1.41432031e+03   2.24894531e+02]
TIMING : CubeStats imstat0  [  1.12490000e-01   1.12864017e-01   1.42721094e+03   2.38183594e+02]
TIMING : CubeStats imstat1  [  1.24341000e-01   1.24749899e-01   1.42798047e+03   2.38945312e+02]
INFO : CubeStats_AT.py : sigma varies from 0.004559 to 0.011984; 689/689 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.00911886 (2.62843 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  7.58150000e-01   7.60711908e-01   1.42798047e+03   2.39015625e+02]
INFO : CubeStats_AT.py : CubeMax: 0.053985 @ [ 12  15 382   0]
INFO : CubeStats_AT.py : CubeMin: -0.055589 @ [ 20  17 252   0]
INFO : CubeStats_AT.py : CubeRMS: 0.008187
INFO : CubeStats_AT.py : RMS Sanity check 1.219270
REGRESSION : CST: 0.008187 1.219270
INFO : CubeStats_AT.py : mean,rms,S/N=-0.000212 0.008187 6.593686
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.777582 1.682050
TIMING : CubeStats plotting  [    2.45142        2.63046813  1455.0703125    264.09375   ]
TIMING : CubeStats done  [  1.40450000e-02   1.40979290e-02   1.45507031e+03   2.64093750e+02]
TIMING : CubeStats summary  [  1.22690000e-02   1.23379230e-02   1.45507031e+03   2.64093750e+02]
TIMING : CubeStats END [ 3.549987    3.73281598]
INFO : AT.py : BDP_OUT[0] = CubeStats_BDP x.cst
INFO : 
INFO : 
INFO :    Executing CubeSum_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     linesum :  True
INFO :     numsigma :  4.0
INFO :     zoom :  1
INFO :     pad :  5
INFO :     sigma :  99.0
INFO : 
TIMING : CubeSum ADMIT [  6.80246300e+00   1.64394546e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.008187
TIMING : CubeSum start  [  5.25290000e-02   5.27918339e-02   1.45507031e+03   2.64093750e+02]
TIMING : CubeSum immoments  [  5.73070000e-02   1.28164053e-01   1.45507031e+03   2.64601562e+02]
TIMING : CubeSum statistics  [  2.00890000e-02   2.01621056e-02   1.45507031e+03   2.64601562e+02]
INFO : CubeSum_AT.py : Total flux: -495.650191 (sum=-16.385126)
REGRESSION : CSM: [-495.65019117994723, -16.385125520358088]
TIMING : CubeSum implot  [  1.47352000e-01   6.08455491e+00   1.52707422e+03   2.64683594e+02]
TIMING : CubeSum getdata  [  2.18440000e-02   2.19149590e-02   1.52707422e+03   2.64683594e+02]
TIMING : CubeSum done  [  2.54815000e-01   2.74285078e-01   1.52707422e+03   2.64812500e+02]
TIMING : CubeSum END [ 0.567863    6.59584284]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.csm
INFO : 
INFO : 
INFO :    Executing SFind2D_AT - 'csm' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     nmax :  30
INFO :     numsigma :  4.0
INFO :     snmax :  35.0
INFO :     region :  
INFO :     zoom :  1
INFO :     robust :  ['hin', 1.5]
INFO :     sigma :  -1.0
INFO : 
TIMING : SFind2D ADMIT [  7.43105100e+00   1.64394547e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.37250000e-02   3.38270664e-02   1.52707422e+03   2.64812500e+02]
TIMING : SFind2D imstat  [  4.07830000e-02   4.10130024e-02   1.52707422e+03   2.64812500e+02]
INFO : AT.py : Setting 'sigma' = 0.110119420455 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 0.110119 -0.43674 0.390226 35 1.12878
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  9.03740000e-02   9.74819660e-02   1.52707422e+03   2.64812500e+02]
REGRESSION : CONTFLUX: 0 0
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       12.7 arcsec , Minor axis:       12.7 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  3.19643000e-01   3.42889071e-01   1.52707422e+03   2.65210938e+02]
TIMING : SFind2D END [ 0.498502    0.52922106]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  6.180763    12.61431789]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 6.18076 12.6143 ]
INFO : AT.py : Setting 'csub' = [0, 0] for LineSegment_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  8.14433800e+00   1.64394547e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[12, 15, 382],0.053985
TIMING : CubeSpectrum CubeStats-pos  [  4.83230000e-02   4.84409332e-02   1.52707422e+03   2.65210938e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[9, 12],0.390226
TIMING : CubeSpectrum Moment-pos  [  4.17850000e-02   4.19108868e-02   1.52707422e+03   2.65210938e+02]
TIMING : CubeSpectrum open  [  1.22010000e-02   1.22380257e-02   1.52707422e+03   2.65210938e+02]
TIMING : CubeSpectrum imval  [  4.40280000e-02   4.42330837e-02   1.52707422e+03   2.65867188e+02]
TIMING : CubeSpectrum imhead  [  4.17860000e-02   4.19590473e-02   1.52707422e+03   2.65867188e+02]
TIMING : CubeSpectrum imval  [  2.53459000e-01   2.73404837e-01   1.52707422e+03   2.66003906e+02]
REGRESSION : CSP: [0.053984943777322769, 0.042571719735860825]
INFO : CubeSpectrum_AT.py : Writing 2 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.92545000e-01   3.12324047e-01   1.52707422e+03   2.66003906e+02]
TIMING : CubeSpectrum summary  [  1.24550000e-02   1.24859810e-02   1.52707422e+03   2.66003906e+02]
TIMING : CubeSpectrum END [ 0.758814    0.79926682]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.csp
INFO : 
INFO : 
INFO :    Executing LineSegment_AT - '' (V1.2.3)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  5.0
INFO :     minchan :  4
INFO :     edgechannels :  0
INFO :     smooth :  []
INFO :     recalcnoise :  False
INFO :     maxgap :  3
INFO :     csub :  [0, 0]
INFO :     iterate :  True
INFO :     segment :  ADMIT
INFO : 
TIMING : LineSegment ADMIT [  8.96351300e+00   1.64394547e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.44560000e-02   2.45339870e-02   1.52707422e+03   2.66003906e+02]
INFO : LineSegment_AT.py : Attempting Continuum Subtraction for Input Spectra
INFO : LineSegment_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineSegment getspectrum  [   29.526555      29.60480905  1527.07421875   266.34375   ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [35, 39]
WARNING : specutil.py : 1 [91, 97]
WARNING : specutil.py : 2 [165, 169]
WARNING : specutil.py : 3 [379, 383]
WARNING : specutil.py : 4 [589, 593]
WARNING : specutil.py : 5 [643, 646]
WARNING : specutil.py : 0 [4, 7]
WARNING : specutil.py : 1 [182, 185]
WARNING : specutil.py : 2 [197, 201]
WARNING : specutil.py : 3 [283, 286]
WARNING : specutil.py : 4 [402, 406]
WARNING : specutil.py : 5 [437, 440]
WARNING : specutil.py : 6 [475, 480]
WARNING : specutil.py : 7 [538, 541]
WARNING : specutil.py : 8 [597, 604]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [671, 674]
TIMING : LineSegment segment finder  [    3.712302       3.72207308  1527.07421875   266.34765625]
INFO : LineSegment_AT.py :  Segment Coverage 75 / 689 = 0.108853
REGRESSION : LINESEG: [[115.27762451035585, 115.27879638543523], [115.02918699352702, 115.03074949363285], [115.05106199500881, 115.05340574516757], [115.07996824696687, 115.08153074707272], [115.1635620026294, 115.16512450273524], [115.24559325818609, 115.24715575829192], [115.26668700961496, 115.26785888469433], [115.01707761770675, 115.01824949278614], [115.0866088724167, 115.08778074749608], [115.09246824781361, 115.09403074791945], [115.12606200008921, 115.12723387516859], [115.172546378238, 115.17410887834384], [115.1862182541641, 115.18739012924348], [115.2010620051696, 115.20301513030191], [115.22567138183661, 115.226843256916], [115.24871825839779, 115.25145263358299]]
TIMING : LineSegment done  [    2.085193       2.19406796  1557.33984375   296.44140625]
TIMING : LineSegment END [ 35.360875    35.55788922]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 42.576893    49.29799008]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 42.5769 49.298 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 42.678572    49.45317507]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 42.6786 49.4532 ]
INFO : AT.py : Setting 'csub' = [0, 0] for LineID_AT
INFO : AT.py : Setting 'references' = etc/tier1_lines.list for LineID_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing LineID_AT - '' (V1.2.7)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  5.0
INFO :     force :  []
INFO :     tier1width :  0.0
INFO :     online :  False
INFO :     recomblevel :  shallow
INFO :     references :  etc/tier1_lines.list
INFO :     csub :  [0, 0]
INFO :     identifylines :  True
INFO :     iterate :  True
INFO :     segment :  ADMIT
INFO :     allowexotics :  False
INFO :     minchan :  4
INFO :     pattern :  AUTO
INFO :     edgechannels :  0
INFO :     smooth :  []
INFO :     recalcnoise :  False
INFO :     vlsr :  -999999.99
INFO :     maxgap :  3
INFO :     reject :  []
INFO :     method :  {'PeakFinder': {'thresh': 0.0}}
INFO :     mode :  ONE
INFO : 
TIMING : LineID ADMIT [  4.46687970e+01   1.64394550e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 315.51 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 315.508
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [   15.994662      16.03669     1557.33984375   296.62109375]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [   13.759818      13.79312301  1557.33984375   296.62109375]
TIMING : LineID segment finder  [  1.39010000e-02   1.39400959e-02   1.55733984e+03   2.96621094e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [35, 39]
WARNING : specutil.py : 1 [91, 97]
WARNING : specutil.py : 2 [165, 169]
WARNING : specutil.py : 3 [379, 383]
WARNING : specutil.py : 4 [589, 593]
WARNING : specutil.py : 5 [643, 646]
WARNING : specutil.py : 0 [4, 7]
WARNING : specutil.py : 1 [182, 185]
WARNING : specutil.py : 2 [197, 201]
WARNING : specutil.py : 3 [283, 286]
WARNING : specutil.py : 4 [402, 406]
WARNING : specutil.py : 5 [437, 440]
WARNING : specutil.py : 6 [475, 480]
WARNING : specutil.py : 7 [538, 541]
WARNING : specutil.py : 8 [597, 604]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [671, 674]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py : Found 1 potential pattern(s) with separation(s) of 109.8 km/s
INFO : LineID_AT.py :  Found line: CH3CH2CNv=0 61(9,52)-60(10,51) @ 115.12896GHz, channels 4 - 7
REGRESSION : LINEID: CH3CH2CNv=0 115.12896  4 7
INFO : LineID_AT.py :  Found line: NS J=5/2-3/2,&Omega=1/2,F=7/2-5/2,l=e @ 115.15394GHz, channels 35 - 97
REGRESSION : LINEID: NS 115.15394  35 97
INFO : LineID_AT.py :  Found line: NS J=5/2-3/2,&Omega=1/2,F=5/2-3/2,l=e @ 115.15681GHz, channels 35 - 97
REGRESSION : LINEID: NS 115.15681  35 97
INFO : LineID_AT.py :  Found line: NS J=5/2-3/2,&Omega=1/2,F=3/2-1/2,l=e @ 115.16298GHz, channels 35 - 97
REGRESSION : LINEID: NS 115.16298  35 97
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 165 - 646
REGRESSION : LINEID: CO 115.27120  165 646
INFO : LineID_AT.py :  Found line: c-H13CCCH 5(3,3)-5(1,4) @ 115.38865GHz, channels 671 - 674
REGRESSION : LINEID: c-H13CCCH 115.38865  671 674
INFO : LineID_AT.py :  Line Coverage 553 / 689 = 0.802612
TIMING : LineID done  [   17.183557      17.98141098  1666.2578125    406.89453125]
TIMING : LineID END [ 46.967163    47.84042406]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 89.971741    97.70273709]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 89.9717 97.7027 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing LineCube_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     equalize :  False
INFO :     pad :  5
INFO :     fpad :  -1.0
INFO : 
TIMING : LineCube ADMIT [  9.19145010e+01   1.64394555e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  6.03500000e-02   6.05859756e-02   1.62746094e+03   3.68296875e+02]
TIMING : LineCube pad  [  1.51760000e-02   1.52218342e-02   1.62746094e+03   3.68296875e+02]
WARNING : LineCube_AT.py : pad=5 too large, start=-1 resetting to 0
TIMING : LineCube trans-x.CH3CH2CN_115.12896  [  9.54010000e-02   2.47630119e-01   1.62746094e+03   3.68359375e+02]
TIMING : LineCube trans-x.NS_115.15394  [  6.91210000e-02   1.19338989e-01   1.62746094e+03   3.68359375e+02]
TIMING : LineCube trans-x.CO_115.27120  [  7.44360000e-02   1.73356056e-01   1.62746094e+03   3.68359375e+02]
TIMING : LineCube trans-x.H13CCCH_115.38865  [  6.84010000e-02   2.29405880e-01   1.62746094e+03   3.68359375e+02]
REGRESSION : LC: [0, 12, 30, 102, 160, 651, 666, 679]
TIMING : LineCube done  [  2.49610000e-02   2.50411034e-02   1.62746094e+03   3.68359375e+02]
TIMING : LineCube END [ 0.420239    0.88300896]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CH3CH2CN_115.12896/lc.im
INFO : AT.py : BDP_OUT[1] = LineCube_BDP x.NS_115.15394/lc.im
INFO : AT.py : BDP_OUT[2] = LineCube_BDP x.CO_115.27120/lc.im
INFO : AT.py : BDP_OUT[3] = LineCube_BDP x.H13CCCH_115.38865/lc.im
TIMING : ADMITrun END [ 90.64789     98.91895795]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 90.6479 98.919 ]
INFO : AT.py : Setting 'moments' = [0, 1, 2] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : AT.py : Setting 'moments' = [0, 1, 2] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : AT.py : Setting 'moments' = [0, 1, 2] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : AT.py : Setting 'moments' = [0, 1, 2] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : AT.py : Setting 'numsigma' = [3.0] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@4' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [3.0]
INFO :     moments :  [0]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  9.28324480e+01   1.64394555e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.93430000e-02   4.94689941e-02   1.62746094e+03   3.68359375e+02]
TIMING : Moment immoments-0  [  6.15930000e-02   1.50492907e-01   1.62746094e+03   3.68359375e+02]
TIMING : Moment mom0clip  [  6.83090000e-02   1.35162115e-01   1.62746094e+03   3.68359375e+02]
TIMING : Moment implot  [  9.94400000e-02   3.44090939e-01   1.63151953e+03   3.72523438e+02]
TIMING : Moment getdata  [  2.11710000e-02   2.12490559e-02   1.63151953e+03   3.72574219e+02]
TIMING : Moment ren+mask_0  [  4.54736000e-01   4.60103989e-01   1.63539844e+03   3.76453125e+02]
TIMING : Moment done  [  1.54540000e-02   1.54948235e-02   1.63539844e+03   3.76453125e+02]
TIMING : Moment END [ 0.782467    1.18854094]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@4.mom_0
INFO : 
INFO : 
INFO :    Executing Moment_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  9.36758860e+01   1.64394555e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.87930000e-02   4.89180088e-02   1.63539844e+03   3.76453125e+02]
TIMING : Moment immoments-all  [  6.47040000e-02   1.52856112e-01   1.63539844e+03   3.76453125e+02]
TIMING : Moment mom0clip  [  6.77230000e-02   1.33271933e-01   1.63539844e+03   3.76453125e+02]
TIMING : Moment implot  [  9.49570000e-02   3.37687016e-01   1.63539844e+03   3.76453125e+02]
TIMING : Moment getdata  [  2.10800000e-02   2.11710930e-02   1.63539844e+03   3.76453125e+02]
TIMING : Moment ren+mask_0  [  3.08257000e-01   3.12986851e-01   1.63539844e+03   3.76453125e+02]
TIMING : Moment makemask  [  1.49961000e-01   4.18449163e-01   1.63539844e+03   3.77199219e+02]
TIMING : Moment implot  [  7.75620000e-02   3.04857016e-01   1.63539844e+03   3.77289062e+02]
TIMING : Moment getdata  [  2.09320000e-02   2.10030079e-02   1.63539844e+03   3.77289062e+02]
TIMING : Moment ren+mask_1  [  2.98016000e-01   3.03682804e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.49638000e-01   6.42045975e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.73930000e-02   3.06777000e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.08920000e-02   2.09701061e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_2  [  2.99611000e-01   3.04301023e-01   1.63514844e+03   3.77039062e+02]
REGRESSION : MOM0FLUX: x.CH3CH2CN_115.12896 26.9246 4.9274 0.0330578 289.815 289.815 2.09713
TIMING : Moment mom0flux  [  5.12320000e-02   5.13720512e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment flux-spectrum  [  2.89125000e-01   2.94323921e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment done  [  1.51890000e-02   1.52349472e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment END [ 2.067396    3.70228815]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH3CH2CN_115.12896/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH3CH2CN_115.12896/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH3CH2CN_115.12896/lc.mom_2
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@1' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  9.58518670e+01   1.64394556e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.86930000e-02   4.88080978e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment immoments-all  [  6.53950000e-02   3.26160908e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment mom0clip  [  6.70440000e-02   1.29902124e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  9.39180000e-02   3.35659027e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.09720000e-02   2.10437775e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_0  [  3.01084000e-01   3.05432081e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.49504000e-01   4.46521997e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.72090000e-02   3.12259912e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.07360000e-02   2.08082199e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_1  [  2.90407000e-01   2.94818878e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.48887000e-01   4.35878038e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.72980000e-02   3.11589003e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.05910000e-02   2.06608772e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_2  [  2.93142000e-01   2.97799110e-01   1.63514844e+03   3.77039062e+02]
REGRESSION : MOM0FLUX: x.NS_115.15394 17.6178 20.175 0.0330578 285.888 285.888 4.63165
TIMING : Moment mom0flux  [  5.09640000e-02   5.11519909e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment flux-spectrum  [  3.00573000e-01   3.16140890e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment done  [  1.50060000e-02   1.50480270e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment END [ 2.053839    3.70214915]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.NS_115.15394/lc-@1.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.NS_115.15394/lc-@1.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.NS_115.15394/lc-@1.mom_2
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@2' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  9.80147330e+01   1.64394556e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.85790000e-02   4.98580933e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment immoments-all  [  7.41370000e-02   2.61518955e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment mom0clip  [  6.99980000e-02   1.44822121e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  9.50180000e-02   3.40300798e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.07140000e-02   2.07831860e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_0  [  2.94817000e-01   2.99533844e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.49682000e-01   6.67541981e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.87720000e-02   3.08016062e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.07620000e-02   2.08239555e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_1  [  2.95001000e-01   2.99855947e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.49687000e-01   5.85875034e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.81760000e-02   3.07716131e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.06900000e-02   2.07600594e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_2  [  2.90225000e-01   2.94290781e-01   1.63514844e+03   3.77039062e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 -262.524 0.806949 0.0330578 270.564 270.564 0
TIMING : Moment mom0flux  [  5.11210000e-02   5.12599945e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment flux-spectrum  [  3.68460000e-01   3.72482061e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment done  [  1.49860000e-02   1.50239468e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment END [ 2.133101    4.07278013]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CO_115.27120/lc-@2.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CO_115.27120/lc-@2.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CO_115.27120/lc-@2.mom_2
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@3' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  1.00256560e+02   1.64394557e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.86030000e-02   4.87120152e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment immoments-all  [  6.40970000e-02   3.87523174e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment mom0clip  [  6.68650000e-02   1.38182878e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  9.28390000e-02   3.30472946e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.07600000e-02   2.08270550e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_0  [  2.92775000e-01   2.97951937e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.48585000e-01   5.98880053e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.77510000e-02   3.08120012e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.04800000e-02   2.05459595e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_1  [  2.81142000e-01   2.85182953e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment makemask  [  1.52112000e-01   6.82867050e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment implot  [  7.92270000e-02   3.04703951e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment getdata  [  2.04500000e-02   2.05221176e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment ren+mask_2  [  3.13390000e-01   3.17615986e-01   1.63514844e+03   3.77039062e+02]
REGRESSION : MOM0FLUX: x.H13CCCH_115.38865 -4.82025 3.54693 0.0330578 288.432 288.432 1.48409
TIMING : Moment mom0flux  [  5.13330000e-02   5.15019894e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment flux-spectrum  [  2.92222000e-01   2.96890020e-01   1.63514844e+03   3.77039062e+02]
TIMING : Moment done  [  1.59460000e-02   1.59878731e-02   1.63514844e+03   3.77039062e+02]
TIMING : Moment END [ 2.050931    4.13889217]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.H13CCCH_115.38865/lc-@3.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.H13CCCH_115.38865/lc-@3.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.H13CCCH_115.38865/lc-@3.mom_2
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@1' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.02415621e+02   1.64394557e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[33, 27],0.209501
TIMING : CubeSpectrum Moment-pos  [  5.43210000e-02   5.44779301e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum open  [  1.23050000e-02   1.23379230e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imval  [  3.59310000e-02   3.61042023e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imhead  [  4.21530000e-02   4.23119068e-02   1.63514844e+03   3.77039062e+02]
REGRESSION : CSP: [0.044361211359500885]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.91609000e-01   2.96540022e-01   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum summary  [  1.26500000e-02   1.26869678e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum END [ 0.461301    0.46682501]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH3CH2CN_115.12896/lc-@1.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@2' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.02937659e+02   1.64394557e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[30, 35],0.668907
TIMING : CubeSpectrum Moment-pos  [  5.42580000e-02   5.44040203e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum open  [  1.23020000e-02   1.23348236e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imval  [  3.61610000e-02   3.63261700e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imhead  [  4.21300000e-02   4.22868729e-02   1.63514844e+03   3.77039062e+02]
REGRESSION : CSP: [0.03566935658454895]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.91112000e-01   2.95281172e-01   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum summary  [  1.24620000e-02   1.26719475e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum END [ 0.460707    0.46562099]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.NS_115.15394/lc-@2.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@3' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.03459055e+02   1.64394557e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[17, 36],0.806949
TIMING : CubeSpectrum Moment-pos  [  5.42190000e-02   5.43761253e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum open  [  1.23460000e-02   1.23779774e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imval  [  3.94460000e-02   3.96330357e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imhead  [  4.22600000e-02   4.24189568e-02   1.63514844e+03   3.77039062e+02]
REGRESSION : CSP: [0.035971075296401978]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.88941000e-01   2.93535948e-01   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum summary  [  1.24720000e-02   1.25110149e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum END [ 0.461973    0.46717811]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@3.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@4' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.03981672e+02   1.64394557e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[33, 30],0.284193
TIMING : CubeSpectrum Moment-pos  [  5.40800000e-02   5.42287827e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum open  [  1.23470000e-02   1.23791695e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imval  [  3.56040000e-02   3.57739925e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum imhead  [  4.19140000e-02   4.20739651e-02   1.63514844e+03   3.77039062e+02]
REGRESSION : CSP: [0.042588561773300171]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  3.01237000e-01   3.06690931e-01   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum summary  [  1.25520000e-02   1.25861168e-02   1.63514844e+03   3.77039062e+02]
TIMING : CubeSpectrum END [ 0.469993    0.47602797]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.H13CCCH_115.38865/lc-@4.csp