INFO : AT.py : Setting {'basename': 'x', 'file': 'R-Cas_94050.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 :  R-Cas_94050.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.17585500e+00   1.64738832e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: R-Cas   SHAPE: [  27   27 2062]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  1.61202000e-01   1.66775942e-01   1.41021875e+03   2.10855469e+02]
TIMING : Ingest importfits  [  1.05110000e-01   2.94998884e-01   1.41079688e+03   2.12457031e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  5.30570000e-02   1.23106003e-01   1.41270312e+03   2.14671875e+02]
TIMING : Ingest summary-0  [  1.38720000e-02   1.39272213e-02   1.41270312e+03   2.14671875e+02]
TIMING : Ingest mask  [  2.44970000e-02   3.46927643e-02   1.41298047e+03   2.15699219e+02]
TIMING : Ingest summary-1  [  1.34280000e-02   1.85332298e-02   1.41298047e+03   2.15699219e+02]
TIMING : Ingest statistics  [  3.78130000e-02   3.79109383e-02   1.41266016e+03   2.16046875e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 17.2500012, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 17.2500012, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [  27   27 2062    1] 1503198 -2.602660 59.724079
INFO : Ingest_AT.py : S/N (all data): 231.895306
INFO : Ingest_AT.py : GOOD PIXELS: 1503198/1503198 (100.000000% good or 0.000000% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -2.60266 59.7241 0.257548  27 27 2062  0.000000
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: R-Cas
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 0.000000 -7.499999 13.000000
INFO : Ingest_AT.py : DEC  Axis 2: 0.000000 7.499999 13.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: 86.3372 -9.76562e-05 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=0.339465 km/s @ fc=86.236577 fw=-0.201367 GHz
INFO : Ingest_AT.py : RESTFREQ: 86.2434 86.2434 -1
INFO : Ingest_AT.py : VLSRc= 23.864173  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= 699.976211
INFO : Ingest_AT.py : VLSR = 23.864173 errs = 0.000000 0.000000 0.000000 width = 0.339465
TIMING : Ingest done  [  5.53327000e-01   5.65011024e-01   1.41494531e+03   2.18429688e+02]
TIMING : Ingest END [ 0.974582    1.26728797]
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.21104100e+00   1.64738833e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  6.32150000e-02   6.34729862e-02   1.41462891e+03   2.18367188e+02]
TIMING : CubeStats start  [  1.28090000e-02   1.28519535e-02   1.41462891e+03   2.18367188e+02]
TIMING : CubeStats imstat0  [  1.17699000e-01   1.18082047e-01   1.42710547e+03   2.31359375e+02]
TIMING : CubeStats imstat1  [  1.88078000e-01   1.88619137e-01   1.42710547e+03   2.31359375e+02]
INFO : CubeStats_AT.py : sigma varies from 0.087859 to 0.322530; 2062/2062 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.175719 (3.67098 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [    2.027667       2.03457999  1427.10546875   231.796875  ]
INFO : CubeStats_AT.py : CubeMax: 59.724079 @ [  12   14 1035    0]
INFO : CubeStats_AT.py : CubeMin: -2.602660 @ [  6  20 929   0]
INFO : CubeStats_AT.py : CubeRMS: 0.111712
INFO : CubeStats_AT.py : RMS Sanity check 2.305461
WARNING : CubeStats_AT.py : RMS sanity check = 2.305461.  Either bad sidelobes, lotsa signal, or both
REGRESSION : CST: 0.111712 2.305461
INFO : CubeStats_AT.py : mean,rms,S/N=0.006867 0.111712 534.625470
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.447957 1.337738
TIMING : CubeStats plotting  [    2.342778       2.51767683  1455.20703125   258.14453125]
TIMING : CubeStats done  [  1.38300000e-02   1.38761997e-02   1.45520703e+03   2.58144531e+02]
TIMING : CubeStats summary  [  1.24830000e-02   1.25448704e-02   1.45520703e+03   2.58144531e+02]
TIMING : CubeStats END [ 4.790894    4.97408295]
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 [  8.06192900e+00   1.64738833e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.111712
TIMING : CubeSum start  [  5.29140000e-02   5.31091690e-02   1.45520703e+03   2.58144531e+02]
TIMING : CubeSum immoments  [  5.60860000e-02   1.21482849e-01   1.45520703e+03   2.58402344e+02]
TIMING : CubeSum statistics  [  1.97680000e-02   1.98671818e-02   1.45520703e+03   2.58402344e+02]
INFO : CubeSum_AT.py : Total flux: 111419.689925 (sum=1980.795121)
REGRESSION : CSM: [111419.68992491084, 1980.7951214083587]
TIMING : CubeSum implot  [  1.43405000e-01   6.08922482e+00   1.52721094e+03   2.58460938e+02]
TIMING : CubeSum getdata  [  2.13320000e-02   2.13961601e-02   1.52721094e+03   2.58460938e+02]
TIMING : CubeSum done  [  2.31525000e-01   2.50419855e-01   1.52922266e+03   2.60472656e+02]
TIMING : CubeSum END [ 0.53869     6.56919098]
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.66101700e+00   1.64738834e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.36770000e-02   3.37641239e-02   1.52922266e+03   2.60472656e+02]
TIMING : SFind2D imstat  [  4.06880000e-02   4.08978462e-02   1.52922266e+03   2.60472656e+02]
INFO : AT.py : Setting 'sigma' = 1.11713927992 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 1.11714 -16.7553 175.274 35 0.0285714
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  1.00862000e-01   1.09423161e-01   1.52922266e+03   2.60472656e+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 : 00:00:00.376 +00.00.04.80    12.25    13.64        134        241  22.688  17.744   61.6  119.6
INFO : SFind2D_AT.py : 00:00:00.380 +00.00.04.81    12.24    13.64        134        238  22.419  17.574   60.5  119.6
INFO : SFind2D_AT.py : 00:00:00.374 +00.00.04.78    12.25    13.64        134        239  22.403  17.722   61.7  119.6
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  1.82809000e-01   1.87708855e-01   1.52922266e+03   2.60472656e+02]
REGRESSION : CONTFLUX: 3 718.086
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       17.3 arcsec , Minor axis:       17.3 arcsec , PA:   0.0 deg
WARNING : SFind2D_AT.py : LogScaling applied
TIMING : SFind2D done  [  3.16462000e-01   3.37015152e-01   1.52922266e+03   2.61082031e+02]
TIMING : SFind2D END [ 0.688315    0.72266316]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  7.638962    14.23898816]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 7.63896 14.239 ]
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.62929700e+00   1.64738834e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[12, 14, 1035],59.724079
TIMING : CubeSpectrum CubeStats-pos  [  4.84240000e-02   4.85289097e-02   1.52922266e+03   2.61082031e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[12, 14],175.274216
TIMING : CubeSpectrum Moment-pos  [  4.22150000e-02   4.23169136e-02   1.52922266e+03   2.61082031e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('00h00m00.376s', '+00d00m04.80s'),133.585098
TIMING : CubeSpectrum SourceList-pos  [  3.61340000e-02   3.62110138e-02   1.52922266e+03   2.61082031e+02]
TIMING : CubeSpectrum open  [  1.22900000e-02   1.23231411e-02   1.52922266e+03   2.61082031e+02]
TIMING : CubeSpectrum imval  [  5.49930000e-02   5.51970005e-02   1.52922266e+03   2.61500000e+02]
TIMING : CubeSpectrum imhead  [  4.21140000e-02   4.22439575e-02   1.52922266e+03   2.61500000e+02]
TIMING : CubeSpectrum imval  [  2.53938000e-01   2.72949934e-01   1.52922266e+03   2.61585938e+02]
REGRESSION : CSP: [59.724079132080078, 59.724079132080078]
INFO : CubeSpectrum_AT.py : Writing 2 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.70963000e-01   2.89605141e-01   1.52922266e+03   2.61585938e+02]
TIMING : CubeSpectrum summary  [  1.25530000e-02   1.25858784e-02   1.52922266e+03   2.61585938e+02]
TIMING : CubeSpectrum END [ 0.786004    0.82437181]
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.04807490e+01   1.64738834e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.49270000e-02   2.49819756e-02   1.52922266e+03   2.61585938e+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  [   13.501437      13.52966309  1529.22265625   261.90625   ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [819, 830]
WARNING : specutil.py : 1 [1022, 1057]
WARNING : specutil.py : 0 [819, 830]
WARNING : specutil.py : 1 [1022, 1057]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [820, 830]
WARNING : specutil.py : 1 [1022, 1057]
TIMING : LineSegment segment finder  [    3.318022       3.32783914  1529.22265625   261.90625   ]
INFO : LineSegment_AT.py :  Segment Coverage 48 / 2062 = 0.0232784
REGRESSION : LINESEG: [[86.256156898534883, 86.257133460932792], [86.23398893210269, 86.237406900495316], [86.256156898534883, 86.257231117172566], [86.23398893210269, 86.237406900495316], [86.256156898534883, 86.257231117172566], [86.23398893210269, 86.237406900495316]]
TIMING : LineSegment done  [    2.163742       2.26819086  1557.5859375    290.26953125]
TIMING : LineSegment END [ 19.020413    19.16298914]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 27.771002    34.60929418]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 27.771 34.6093 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 27.870944    34.86120296]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 27.8709 34.8612 ]
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.98850030e+01   1.64738836e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 23.86 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 23.8642
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    6.141559       6.15372491  1557.5859375    290.26953125]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    7.512703       7.52762794  1557.5859375    290.26953125]
TIMING : LineID segment finder  [  1.46490000e-02   1.46820545e-02   1.55758594e+03   2.90269531e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [819, 830]
WARNING : specutil.py : 1 [1022, 1057]
WARNING : specutil.py : 0 [819, 830]
WARNING : specutil.py : 1 [1022, 1057]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [820, 830]
WARNING : specutil.py : 1 [1022, 1057]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: SiO 2-1 @ 86.24337GHz, channels 1022 - 1057
REGRESSION : LINEID: SiO 86.24337  1022 1057
INFO : LineID_AT.py :  Found line: (CH3)2COv=0 19(9,10)-19(8,11)EA @ 86.26354GHz, channels 819 - 830
REGRESSION : LINEID: (CH3)2COv=0 86.26354  819 830
INFO : LineID_AT.py :  Line Coverage 48 / 2062 = 0.0232784
TIMING : LineID done  [   15.827179      16.05280209  1667.08984375   401.30859375]
TIMING : LineID END [ 29.510516    29.76329684]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 57.895813    65.20645618]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 57.8958 65.2065 ]
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.98634050e+01   1.64738839e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  5.79600000e-02   5.83999157e-02   1.62911719e+03   3.63457031e+02]
TIMING : LineCube pad  [  1.42230000e-02   1.42610073e-02   1.62911719e+03   3.63457031e+02]
TIMING : LineCube trans-x.SiO_86.24337  [  6.91380000e-02   1.38566017e-01   1.62911719e+03   3.63457031e+02]
TIMING : LineCube trans-x.(CH3)2CO_86.26354  [  6.88770000e-02   1.07040167e-01   1.62911719e+03   3.63457031e+02]
REGRESSION : LC: [1017, 1062, 814, 835]
TIMING : LineCube done  [  2.48880000e-02   2.49478817e-02   1.62911719e+03   3.63457031e+02]
TIMING : LineCube END [ 0.247391   0.3555541]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.SiO_86.24337/lc.im
INFO : AT.py : BDP_OUT[1] = LineCube_BDP x.(CH3)2CO_86.26354/lc.im
TIMING : ADMITrun END [ 58.345229    65.82456112]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 58.3452 65.8246 ]
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 - '@2' (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 [  6.04555510e+01   1.64738839e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  5.40310000e-02   5.41429520e-02   1.62911719e+03   3.63457031e+02]
TIMING : Moment immoments-0  [  6.36170000e-02   1.51073933e-01   1.62911719e+03   3.63457031e+02]
TIMING : Moment mom0clip  [  6.86660000e-02   1.15728140e-01   1.62911719e+03   3.63558594e+02]
TIMING : Moment implot  [  9.80000000e-02   3.47070932e-01   1.63235156e+03   3.66792969e+02]
TIMING : Moment getdata  [  2.05460000e-02   2.06389427e-02   1.63235156e+03   3.66792969e+02]
TIMING : Moment ren+mask_0  [  3.49622000e-01   3.54228973e-01   1.63984766e+03   3.74289062e+02]
TIMING : Moment done  [  1.53940000e-02   1.54411793e-02   1.63984766e+03   3.74289062e+02]
TIMING : Moment END [ 0.682206    1.07070994]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@2.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 [  6.11988690e+01   1.64738839e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.84590000e-02   4.85560894e-02   1.63984766e+03   3.74289062e+02]
TIMING : Moment immoments-all  [  6.25630000e-02   2.87525892e-01   1.63984766e+03   3.74289062e+02]
TIMING : Moment mom0clip  [  6.66700000e-02   1.21720076e-01   1.63984766e+03   3.74289062e+02]
TIMING : Moment implot  [  9.20230000e-02   3.36893082e-01   1.63984766e+03   3.74289062e+02]
TIMING : Moment getdata  [  2.07050000e-02   2.07688808e-02   1.63984766e+03   3.74289062e+02]
TIMING : Moment ren+mask_0  [  2.56278000e-01   2.60584116e-01   1.63984766e+03   3.74289062e+02]
TIMING : Moment makemask  [  1.46452000e-01   4.15877819e-01   1.63984766e+03   3.74421875e+02]
TIMING : Moment implot  [  7.81790000e-02   3.09903145e-01   1.63984766e+03   3.74980469e+02]
TIMING : Moment getdata  [  2.02970000e-02   2.03599930e-02   1.63984766e+03   3.74980469e+02]
TIMING : Moment ren+mask_1  [  2.53752000e-01   2.58209944e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment makemask  [  1.46487000e-01   3.55853081e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment implot  [  7.64890000e-02   3.13638926e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment getdata  [  2.03460000e-02   2.04329491e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment ren+mask_2  [  2.53349000e-01   2.57694960e-01   1.63959766e+03   3.74730469e+02]
REGRESSION : MOM0FLUX: x.SiO_86.24337 2210.15 1246.34 0.0177778 25.221 25.221 0.0197064
TIMING : Moment mom0flux  [  5.10820000e-02   5.12161255e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment flux-spectrum  [  2.52226000e-01   2.57066011e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment done  [  1.49760000e-02   1.50258541e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment END [ 1.872634    3.36368608]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.SiO_86.24337/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.SiO_86.24337/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.SiO_86.24337/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 [  6.31802200e+01   1.64738840e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.84100000e-02   4.85458374e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment immoments-all  [  6.16430000e-02   1.96354151e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment mom0clip  [  6.83550000e-02   1.27469063e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment implot  [  9.34040000e-02   3.33107948e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment getdata  [  2.06070000e-02   2.06859112e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment ren+mask_0  [  2.56560000e-01   2.60973930e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment makemask  [  1.47288000e-01   5.45342207e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment implot  [  7.58220000e-02   2.97143936e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment getdata  [  2.03400000e-02   2.04029083e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment ren+mask_1  [  2.53175000e-01   2.57828951e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment makemask  [  1.47472000e-01   7.02280045e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment implot  [  7.68110000e-02   3.01039934e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment getdata  [  2.03880000e-02   2.04541683e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment ren+mask_2  [  2.54069000e-01   2.58682966e-01   1.63959766e+03   3.74730469e+02]
REGRESSION : MOM0FLUX: x.(CH3)2CO_86.26354 65.0581 42.7873 0.0177778 23.6482 23.6482 0.064557
TIMING : Moment mom0flux  [  5.08510000e-02   5.10079861e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment flux-spectrum  [  2.49997000e-01   2.54353046e-01   1.63959766e+03   3.74730469e+02]
TIMING : Moment done  [  1.49480000e-02   1.50029659e-02   1.63959766e+03   3.74730469e+02]
TIMING : Moment END [ 1.872545    3.72314191]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.(CH3)2CO_86.26354/lc-@1.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.(CH3)2CO_86.26354/lc-@1.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.(CH3)2CO_86.26354/lc-@1.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.51661010e+01   1.64738840e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[12, 14],169.722366
TIMING : CubeSpectrum Moment-pos  [  5.50660000e-02   5.52659035e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum open  [  1.22850000e-02   1.23240948e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum imval  [  3.35800000e-02   3.37550640e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum imhead  [  4.11620000e-02   4.13079262e-02   1.63959766e+03   3.74730469e+02]
REGRESSION : CSP: [59.724079132080078]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.73070000e-01   2.77914047e-01   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum summary  [  1.25260000e-02   1.25539303e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum END [ 0.440015    0.44547987]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.SiO_86.24337/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.56667140e+01   1.64738840e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[13, 13],8.754821
TIMING : CubeSpectrum Moment-pos  [  5.43670000e-02   5.45229912e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum open  [  1.23670000e-02   1.24020576e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum imval  [  3.28200000e-02   3.29608917e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum imhead  [  4.09590000e-02   4.11031246e-02   1.63959766e+03   3.74730469e+02]
REGRESSION : CSP: [3.4454498291015625]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.62667000e-01   2.67166853e-01   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum summary  [  1.24760000e-02   1.25181675e-02   1.63959766e+03   3.74730469e+02]
TIMING : CubeSpectrum END [ 0.427893    0.43295193]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.(CH3)2CO_86.26354/lc-@2.csp