INFO : AT.py : Setting {'basename': 'x', 'file': 'IRC+10216_79448.nf.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 :  IRC+10216_79448.nf.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.19008500e+00   1.64843554e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: IRC+10216   SHAPE: [ 97  97 689]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  2.07672000e-01   2.13883162e-01   1.41021484e+03   2.10863281e+02]
TIMING : Ingest importfits  [  1.45053000e-01   2.73586988e-01   1.41111719e+03   2.12496094e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  8.21260000e-02   1.03342056e-01   1.41568750e+03   2.17808594e+02]
TIMING : Ingest summary-0  [  1.43400000e-02   1.44319534e-02   1.41568750e+03   2.17808594e+02]
TIMING : Ingest mask  [  6.01840000e-02   7.00118542e-02   1.41642578e+03   2.19109375e+02]
TIMING : Ingest summary-1  [  1.42590000e-02   1.77750587e-02   1.41642578e+03   2.19109375e+02]
TIMING : Ingest statistics  [  9.19650000e-02   9.21730995e-02   1.41704297e+03   2.20230469e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 14.375001600000001, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 14.375001600000001, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [ 97  97 689   1] 4667975 -2.402700 8.956923
INFO : Ingest_AT.py : S/N (all data): 52.381909
INFO : Ingest_AT.py : GOOD PIXELS: 4667975/6482801 (72.005527% good or 27.994473% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -2.4027 8.95692 0.170993  97 97 689  27.994473
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: IRC+10216
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 146.989200 -6.250000 48.000000
INFO : Ingest_AT.py : DEC  Axis 2: 13.278770 6.250000 48.000000
INFO : Ingest_AT.py : VLSRv = -26.000000 (from source catalog)
INFO : Ingest_AT.py : VLSRz = -25.833333 +/- 0.623610   3 values: [-25.  -26.  -26.5]
INFO : Ingest_AT.py : Freq Orig Axis 3: 115.144 0.000390625 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.015921 km/s @ fc=115.278699 fw=0.269141 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= -19.492024  VLSRf= 0.000000  VLSRv= -26.000000 VLSRz= -25.833333 WIDTH= -699.969569
INFO : Ingest_AT.py : VLSR = -26.000000 errs = 0.623610 0.000000 0.000000 width = -1.015921
TIMING : Ingest done  [  6.00653000e-01   6.23625040e-01   1.42004297e+03   2.23589844e+02]
TIMING : Ingest END [ 1.228302    1.42091417]
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.47901400e+00   1.64843555e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.25930000e-02   5.28328419e-02   1.41904297e+03   2.23058594e+02]
TIMING : CubeStats start  [  1.23920000e-02   1.24361515e-02   1.41904297e+03   2.23058594e+02]
TIMING : CubeStats imstat0  [  3.48652000e-01   3.49470854e-01   1.44694531e+03   2.51285156e+02]
TIMING : CubeStats imstat1  [  3.39921000e-01   3.40698004e-01   1.48229297e+03   2.86859375e+02]
INFO : CubeStats_AT.py : sigma varies from 0.109420 to 0.239885; 689/689 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.218839 (2.19234 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  8.49283000e-01   8.52467060e-01   1.48229297e+03   2.86878906e+02]
INFO : CubeStats_AT.py : CubeMax: 8.956923 @ [ 48  48 334   0]
INFO : CubeStats_AT.py : CubeMin: -2.402700 @ [  9  82 442   0]
INFO : CubeStats_AT.py : CubeRMS: 0.119425
INFO : CubeStats_AT.py : RMS Sanity check 1.431798
REGRESSION : CST: 0.119425 1.431798
INFO : CubeStats_AT.py : mean,rms,S/N=0.009554 0.119425 75.000307
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 5.947488 1.889372
TIMING : CubeStats plotting  [    2.484951      33.65693808  1491.546875     294.52734375]
TIMING : CubeStats done  [  1.34180000e-02   1.34508610e-02   1.49154688e+03   2.94527344e+02]
TIMING : CubeStats summary  [  1.21480000e-02   1.22020245e-02   1.49154688e+03   2.94527344e+02]
TIMING : CubeStats END [  4.125462    35.30263591]
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 [  7.66423100e+00   1.64843558e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.119425
TIMING : CubeSum start  [  5.20360000e-02   5.21609783e-02   1.49154688e+03   2.94527344e+02]
TIMING : CubeSum immoments  [  1.02629000e-01   1.97132111e-01   1.49154688e+03   2.94785156e+02]
TIMING : CubeSum statistics  [  2.01590000e-02   2.02279091e-02   1.49154688e+03   2.94785156e+02]
INFO : CubeSum_AT.py : Total flux: 1470608.003112 (sum=37647.569699)
REGRESSION : CSM: [1470608.0031117823, 37647.569698550389]
TIMING : CubeSum implot  [  1.45866000e-01   6.11030102e+00   1.56355078e+03   2.94843750e+02]
TIMING : CubeSum getdata  [  2.22960000e-02   2.23670006e-02   1.56355078e+03   2.94843750e+02]
TIMING : CubeSum done  [  2.63641000e-01   3.78632402e+00   1.56355078e+03   2.94847656e+02]
TIMING : CubeSum END [  0.620375   10.2023201]
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 [  8.34425500e+00   1.64843559e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.37550000e-02   3.38580608e-02   1.56355078e+03   2.94847656e+02]
TIMING : SFind2D imstat  [  4.14880000e-02   4.17208672e-02   1.56355078e+03   2.94847656e+02]
INFO : AT.py : Setting 'sigma' = 12.48131043 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 12.4813 -6.3787 233.815 35 0.213525
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  9.40420000e-02   1.09030008e-01   1.56355078e+03   2.94847656e+02]
INFO : SFind2D_AT.py : Right Ascen.  Declination   X(pix)   Y(pix)      Peak       Flux    Major   Minor    PA    SNR
INFO : SFind2D_AT.py :                                                K.km/s       Jy    arcsec   arcsec   deg
INFO : SFind2D_AT.py : 09:47:57.264 +13.16.42.81    48.33    47.88        215   2.16e+03  49.615  47.942   12.1   17.3
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  1.32695000e-01   1.40010118e-01   1.56355078e+03   2.95562500e+02]
REGRESSION : CONTFLUX: 1 2163.42
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       14.4 arcsec , Minor axis:       14.4 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  2.87763000e-01   3.85083604e+00   1.56355078e+03   2.95562500e+02]
TIMING : SFind2D END [ 0.603572    4.18931913]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  7.166831    51.76616716]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 7.16683 51.7662 ]
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 [  9.16352900e+00   1.64843560e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[48, 48, 334],8.956923
TIMING : CubeSpectrum CubeStats-pos  [  5.37650000e-02   5.38780689e-02   1.56355078e+03   2.95562500e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[48, 48],233.814926
TIMING : CubeSpectrum Moment-pos  [  4.31130000e-02   4.32379246e-02   1.56355078e+03   2.95562500e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('09h47m57.264s', '+13d16m42.81s'),215.358017
TIMING : CubeSpectrum SourceList-pos  [  3.58790000e-02   3.59590054e-02   1.56355078e+03   2.95562500e+02]
TIMING : CubeSpectrum open  [  1.22070000e-02   1.22480392e-02   1.56355078e+03   2.95562500e+02]
TIMING : CubeSpectrum imval  [  4.42400000e-02   4.44638729e-02   1.56355078e+03   2.95949219e+02]
TIMING : CubeSpectrum imhead  [  4.16450000e-02   4.21931744e-02   1.56355078e+03   2.95949219e+02]
TIMING : CubeSpectrum imval  [  2.55323000e-01   3.60957885e+00   1.56355078e+03   2.95972656e+02]
REGRESSION : CSP: [8.9569225311279297, 8.9569225311279297]
INFO : CubeSpectrum_AT.py : Writing 2 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.93583000e-01   3.64289904e+00   1.56355078e+03   2.95988281e+02]
TIMING : CubeSpectrum summary  [  1.23250000e-02   1.23510361e-02   1.56355078e+03   2.95988281e+02]
TIMING : CubeSpectrum END [ 0.80408     7.50884509]
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 [  1.00273920e+01   1.64843560e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.42250000e-02   2.42841244e-02   1.56355078e+03   2.95988281e+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  [   11.623331      11.64865184  1563.55078125   296.3203125 ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [329, 359]
WARNING : specutil.py : 1 [615, 619]
WARNING : specutil.py : 2 [638, 642]
WARNING : specutil.py : 0 [329, 359]
WARNING : specutil.py : 1 [615, 619]
WARNING : specutil.py : 2 [638, 642]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [330, 357]
TIMING : LineSegment segment finder  [    3.28348        3.29043412  1563.55078125   296.3203125 ]
INFO : LineSegment_AT.py :  Segment Coverage 41 / 689 = 0.0595065
REGRESSION : LINESEG: [[115.27322999812944, 115.28377687384388], [115.27283937310298, 115.28455812389679], [115.38455813067067, 115.3861206307765], [115.39354250627925, 115.39510500638509], [115.27283937310298, 115.28455812389679], [115.38455813067067, 115.3861206307765], [115.39354250627925, 115.39510500638509]]
TIMING : LineSegment done  [    1.967878      18.67104506  1579.25390625   311.95703125]
TIMING : LineSegment END [ 16.911227    33.64675713]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 25.154565    93.25233722]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 25.1546 93.2523 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 25.251383    93.41310501]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 25.2514 93.4131 ]
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 [  2.72691680e+01   1.64843564e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = -26.00 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = -26
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    6.407605       6.42150593  1579.25390625   312.0234375 ]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    5.371972       5.38359809  1579.25390625   312.0234375 ]
TIMING : LineID segment finder  [  1.37250000e-02   1.37648582e-02   1.57925391e+03   3.12023438e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [329, 359]
WARNING : specutil.py : 1 [615, 619]
WARNING : specutil.py : 2 [638, 642]
WARNING : specutil.py : 0 [329, 359]
WARNING : specutil.py : 1 [615, 619]
WARNING : specutil.py : 2 [638, 642]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [330, 357]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 329 - 359
REGRESSION : LINEID: CO 115.27120  329 359
INFO : LineID_AT.py :  Found line: g-CH3CH2OH 18(2,16)-18(1,17),vt=1-1 @ 115.37595GHz, channels 615 - 619
REGRESSION : LINEID: g-CH3CH2OH 115.37595  615 619
INFO : LineID_AT.py :  Found line: U_115.3851  @ 115.385098042GHz, channels 638 - 642
REGRESSION : LINEID: U_115.3851 115.38510  638 642
INFO : LineID_AT.py :  Line Coverage 41 / 689 = 0.0595065
TIMING : LineID done  [   14.656678      16.44048905  1664.49609375   398.73828125]
TIMING : LineID END [ 26.464014    28.27344584]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [  52.026176    122.06491208]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 52.0262 122.065 ]
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 [  5.39999180e+01   1.64843567e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  1.10444000e-01   1.11375809e-01   1.61505859e+03   3.49523438e+02]
TIMING : LineCube pad  [  1.37030000e-02   1.37441158e-02   1.61505859e+03   3.49523438e+02]
TIMING : LineCube trans-x.CO_115.27120  [  8.13090000e-02   1.77612066e-01   1.61505859e+03   3.49523438e+02]
TIMING : LineCube trans-x.CH3CH2OH_115.37595  [  7.05940000e-02   1.90207005e-01   1.61505859e+03   3.49523438e+02]
TIMING : LineCube trans-x.U_115.3851  [  7.12820000e-02   1.45764828e-01   1.61505859e+03   3.49523438e+02]
REGRESSION : LC: [324, 364, 610, 624, 633, 647]
TIMING : LineCube done  [  2.51490000e-02   2.52430439e-02   1.61505859e+03   3.49523438e+02]
TIMING : LineCube END [ 0.384751    0.67625499]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CO_115.27120/lc.im
INFO : AT.py : BDP_OUT[1] = LineCube_BDP x.CH3CH2OH_115.37595/lc.im
INFO : AT.py : BDP_OUT[2] = LineCube_BDP x.U_115.3851/lc.im
TIMING : ADMITrun END [  52.632563    123.02434611]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 52.6326 123.024 ]
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 - '@3' (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 [  5.47963840e+01   1.64843567e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.88210000e-02   4.89330292e-02   1.61505859e+03   3.49523438e+02]
TIMING : Moment immoments-0  [  1.12402000e-01   1.82934999e-01   1.63385938e+03   3.68199219e+02]
TIMING : Moment mom0clip  [  6.87360000e-02   1.06930971e-01   1.63385938e+03   3.68300781e+02]
TIMING : Moment implot  [  9.80370000e-02   3.54928970e-01   1.63385938e+03   3.68300781e+02]
TIMING : Moment getdata  [  2.09660000e-02   2.10380554e-02   1.63385938e+03   3.68300781e+02]
TIMING : Moment ren+mask_0  [  3.26842000e-01   6.16199017e-01   1.63688281e+03   3.71324219e+02]
TIMING : Moment done  [  1.50410000e-02   1.50890350e-02   1.63688281e+03   3.71324219e+02]
TIMING : Moment END [ 0.703116    1.35838509]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@3.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 [  5.55598750e+01   1.64843567e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.83270000e-02   4.84249592e-02   1.63688281e+03   3.71324219e+02]
TIMING : Moment immoments-all  [  7.17980000e-02   5.41754007e-01   1.63688281e+03   3.71324219e+02]
TIMING : Moment mom0clip  [  6.76880000e-02   1.61511898e-01   1.63688281e+03   3.71324219e+02]
TIMING : Moment implot  [  9.32970000e-02   3.53306055e-01   1.63688281e+03   3.71324219e+02]
TIMING : Moment getdata  [  2.05310000e-02   2.06019878e-02   1.63688281e+03   3.71324219e+02]
TIMING : Moment ren+mask_0  [  2.57462000e-01   5.73878050e-01   1.63688281e+03   3.71324219e+02]
TIMING : Moment makemask  [  1.49891000e-01   6.75956964e-01   1.63688281e+03   3.71996094e+02]
TIMING : Moment implot  [  7.76280000e-02   3.27448130e-01   1.63688281e+03   3.72140625e+02]
TIMING : Moment getdata  [  2.03830000e-02   2.04498768e-02   1.63688281e+03   3.72140625e+02]
TIMING : Moment ren+mask_1  [  2.57853000e-01   5.62901974e-01   1.63688281e+03   3.72140625e+02]
TIMING : Moment makemask  [  1.55398000e-01   5.35257101e-01   1.63688281e+03   3.72140625e+02]
TIMING : Moment implot  [  7.76600000e-02   3.18652868e-01   1.63688281e+03   3.72140625e+02]
TIMING : Moment getdata  [  2.02800000e-02   2.03480721e-02   1.63688281e+03   3.72140625e+02]
TIMING : Moment ren+mask_2  [  2.69382000e-01   5.38607121e-01   1.63663281e+03   3.71890625e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 42939.5 18404.3 0.0256 -19.6379 -19.6379 0.358775
TIMING : Moment mom0flux  [  5.11370000e-02   5.12897968e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment flux-spectrum  [  2.75997000e-01   5.37301064e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment done  [  1.47260000e-02   1.47590637e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment END [ 1.9417      5.31476998]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CO_115.27120/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CO_115.27120/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CO_115.27120/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 [  5.76094640e+01   1.64843567e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.81810000e-02   4.82909679e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment immoments-all  [  7.01910000e-02   2.60876894e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment mom0clip  [  6.70450000e-02   1.27398968e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  9.72450000e-02   3.53925943e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.04610000e-02   2.05311775e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_0  [  2.66048000e-01   5.54105043e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment makemask  [  1.50806000e-01   4.90825891e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  7.67530000e-02   3.16070080e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.04240000e-02   2.04989910e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_1  [  2.62619000e-01   5.41122913e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment makemask  [  1.50401000e-01   4.35878992e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  7.80400000e-02   3.16982985e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.04800000e-02   2.05569267e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_2  [  2.61039000e-01   5.50577164e-01   1.63663281e+03   3.71890625e+02]
REGRESSION : MOM0FLUX: x.CH3CH2OH_115.37595 195.667 142.957 0.0256 -27.0315 -27.0315 1.67791
TIMING : Moment mom0flux  [  5.13290000e-02   5.14738560e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment flux-spectrum  [  2.65457000e-01   5.37362099e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment done  [  1.47490000e-02   1.47869587e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment END [ 1.93359     4.67364192]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH3CH2OH_115.37595/lc-@1.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH3CH2OH_115.37595/lc-@1.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH3CH2OH_115.37595/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 [  5.96510230e+01   1.64843568e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.82410000e-02   4.83500957e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment immoments-all  [  6.84600000e-02   2.06079960e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment mom0clip  [  6.73690000e-02   1.14124060e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  9.33220000e-02   3.60804081e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.03980000e-02   2.04768181e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_0  [  2.56969000e-01   5.25531054e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment makemask  [  1.48223000e-01   3.94604921e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  7.70520000e-02   3.46812010e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.02220000e-02   2.02920437e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_1  [  2.58435000e-01   5.77183962e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment makemask  [  1.47230000e-01   3.86282206e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment implot  [  7.66910000e-02   3.26575994e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment getdata  [  2.01380000e-02   2.01959610e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment ren+mask_2  [  2.52704000e-01   5.49365997e-01   1.63663281e+03   3.71890625e+02]
REGRESSION : MOM0FLUX: x.U_115.3851 148.104 139.312 0.0256 -21.9177 -21.9177 1.56842
TIMING : Moment mom0flux  [  5.10000000e-02   5.11448383e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment flux-spectrum  [  2.57946000e-01   5.15580177e-01   1.63663281e+03   3.71890625e+02]
TIMING : Moment done  [  1.47680000e-02   1.48029327e-02   1.63663281e+03   3.71890625e+02]
TIMING : Moment END [ 1.891449    4.49053621]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.U_115.3851/lc-@2.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.U_115.3851/lc-@2.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.U_115.3851/lc-@2.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 [  6.16503200e+01   1.64843568e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[48, 48],223.278961
TIMING : CubeSpectrum Moment-pos  [  5.43520000e-02   5.44788837e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum open  [  1.22780000e-02   1.23081207e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imval  [  3.60630000e-02   3.62298489e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imhead  [  4.20310000e-02   4.21800613e-02   1.63663281e+03   3.71890625e+02]
REGRESSION : CSP: [8.9569225311279297]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.55373000e-01   5.31706095e-01   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum summary  [  1.24250000e-02   1.24599934e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum END [ 0.424726    0.70159698]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/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 [  6.21352650e+01   1.64843568e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[48, 48],6.444395
TIMING : CubeSpectrum Moment-pos  [  5.42070000e-02   5.43680191e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum open  [  1.21810000e-02   1.22089386e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imval  [  3.57170000e-02   3.58779430e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imhead  [  4.21170000e-02   4.22470570e-02   1.63663281e+03   3.71890625e+02]
REGRESSION : CSP: [1.1512991189956665]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.57467000e-01   5.47986984e-01   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum summary  [  1.24120000e-02   1.24371052e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum END [ 0.426281    0.71735001]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH3CH2OH_115.37595/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 [  6.26218310e+01   1.64843568e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[49, 48],6.988549
TIMING : CubeSpectrum Moment-pos  [  5.44010000e-02   5.45358658e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum open  [  1.23850000e-02   1.24101639e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imval  [  3.61620000e-02   3.63268852e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum imhead  [  4.23160000e-02   4.24511433e-02   1.63663281e+03   3.71890625e+02]
REGRESSION : CSP: [0.9208601713180542]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.55442000e-01   5.36371946e-01   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum summary  [  1.24440000e-02   1.24709606e-02   1.63663281e+03   3.71890625e+02]
TIMING : CubeSpectrum END [ 0.425396    0.70683885]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.U_115.3851/lc-@3.csp