INFO : AT.py : Setting {'basename': 'x', 'file': 'NGC5194_90911.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 :  NGC5194_90911.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.23517600e+00   1.64394404e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: NGC5194   SHAPE: [145 145 590]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  2.69364000e-01   2.74970055e-01   1.41106250e+03   2.17113281e+02]
TIMING : Ingest importfits  [  1.81850000e-01   3.62035036e-01   1.41131641e+03   2.18816406e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  7.61970000e-02   1.23628855e-01   1.41173047e+03   2.20140625e+02]
TIMING : Ingest summary-0  [  1.42210000e-02   1.43060684e-02   1.41173047e+03   2.20140625e+02]
TIMING : Ingest mask  [  6.82310000e-02   9.95218754e-02   1.41188672e+03   2.20140625e+02]
TIMING : Ingest summary-1  [  1.36370000e-02   1.72080994e-02   1.41188672e+03   2.20140625e+02]
TIMING : Ingest statistics  [  9.66860000e-02   9.69409943e-02   1.41188672e+03   2.21132812e+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: [145 145 590   1] 7352580 -3.584407 4.010004
INFO : Ingest_AT.py : S/N (all data): 37.858777
INFO : Ingest_AT.py : GOOD PIXELS: 7352580/12404750 (59.272295% good or 40.727705% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -3.58441 4.01 0.10592  145 145 590  40.727705
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: NGC5194
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 202.469600 -6.250000 72.000000
INFO : Ingest_AT.py : DEC  Axis 2: 47.195170 6.250000 72.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: 114.964 0.000390625 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.015921 km/s @ fc=115.078726 fw=0.230469 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= 500.589066  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= -599.393390
INFO : Ingest_AT.py : VLSR = 500.589066 errs = 0.000000 0.000000 0.000000 width = -1.015921
TIMING : Ingest done  [  6.07131000e-01   6.12358093e-01   1.41476562e+03   2.24457031e+02]
TIMING : Ingest END [ 1.339365    1.61304903]
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.63506100e+00   1.64394404e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.24570000e-02   5.26809692e-02   1.41576562e+03   2.26136719e+02]
TIMING : CubeStats start  [  1.25500000e-02   1.25880241e-02   1.41576562e+03   2.26136719e+02]
TIMING : CubeStats imstat0  [  4.16992000e-01   4.18070078e-01   1.41453906e+03   2.25343750e+02]
TIMING : CubeStats imstat1  [  5.47280000e-01   5.48542023e-01   1.45803906e+03   2.69058594e+02]
INFO : CubeStats_AT.py : sigma varies from 0.097617 to 0.109592; 590/590 channels ok
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  8.48469000e-01   8.51280928e-01   1.45803906e+03   2.69062500e+02]
INFO : CubeStats_AT.py : CubeMax: 4.010004 @ [ 22  74 289   0]
INFO : CubeStats_AT.py : CubeMin: -3.584407 @ [ 22  74 559   0]
INFO : CubeStats_AT.py : CubeRMS: 0.103391
INFO : CubeStats_AT.py : RMS Sanity check 1.024456
REGRESSION : CST: 0.103391 1.024456
INFO : CubeStats_AT.py : mean,rms,S/N=0.000788 0.103391 38.784656
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 2.229175 2.289259
TIMING : CubeStats plotting  [    2.262594       2.43770695  1467.04296875   276.40625   ]
TIMING : CubeStats done  [  1.36540000e-02   1.36899948e-02   1.46704297e+03   2.76406250e+02]
TIMING : CubeStats summary  [  1.21670000e-02   1.22151375e-02   1.46704297e+03   2.76406250e+02]
TIMING : CubeStats END [ 4.1783      4.35895109]
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.87297200e+00   1.64394405e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.103391
TIMING : CubeSum start  [  5.22930000e-02   5.24461269e-02   1.46704297e+03   2.76406250e+02]
TIMING : CubeSum immoments  [  1.50595000e-01   1.86500788e-01   1.46704297e+03   2.76808594e+02]
TIMING : CubeSum statistics  [  2.02550000e-02   2.03452110e-02   1.46704297e+03   2.76851562e+02]
INFO : CubeSum_AT.py : Total flux: 91243.460171 (sum=2335.832879)
REGRESSION : CSM: [91243.460170520266, 2335.8328793519177]
TIMING : CubeSum implot  [  1.41629000e-01   6.05882883e+00   1.53904688e+03   2.76890625e+02]
TIMING : CubeSum getdata  [  2.18650000e-02   2.19399929e-02   1.53904688e+03   2.76890625e+02]
TIMING : CubeSum done  [  2.44407000e-01   2.64342070e-01   1.53904688e+03   2.76953125e+02]
TIMING : CubeSum END [ 0.644949    6.61835408]
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.57828400e+00   1.64394405e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.41030000e-02   3.42280865e-02   1.53904688e+03   2.76953125e+02]
TIMING : SFind2D imstat  [  4.19050000e-02   4.21459675e-02   1.53904688e+03   2.76953125e+02]
INFO : AT.py : Setting 'sigma' = 1.05790707555 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 1.05791 -30.3162 40.7147 35 0.103934
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  6.97942000e-01   7.21409082e-01   1.53904688e+03   2.76953125e+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 : 13:29:50.871 +47.11.17.27    74.99    67.95       18.4        172  62.183  18.486  155.2   17.4
INFO : SFind2D_AT.py : 13:29:49.972 +47.11.28.92    76.46    69.81       38.1        249 100.031  15.449  147.5   36.0
INFO : SFind2D_AT.py : 13:29:51.583 +47.11.58.15    73.83    74.49       16.6       92.6  31.250  31.250   90.0   15.7
INFO : SFind2D_AT.py : 13:29:53.774 +47.11.26.61    70.25    69.44         16       76.7  31.250  31.250   90.0   15.1
INFO : SFind2D_AT.py : 13:29:55.341 +47.12.05.79    67.70    75.71       10.3       60.1  31.250  31.250   90.0    9.7
INFO : SFind2D_AT.py : 13:29:52.500 +47.11.23.88    72.33    69.00       16.6        548 146.699  57.041    7.9   15.6
INFO : SFind2D_AT.py : 13:29:49.547 +47.12.38.64    77.15    80.97       4.23       40.7  31.250  31.250   90.0    4.0
INFO : SFind2D_AT.py : 13:29:59.893 +47.13.17.41    60.28    87.17        7.5       36.2  88.947  11.312  152.0    7.1
INFO : SFind2D_AT.py : 13:29:43.958 +47.10.27.46    86.27    59.98       3.51       8.35  18.138  13.966   87.3    3.3
INFO : SFind2D_AT.py : 13:29:48.127 +47.09.42.64    79.47    52.81       7.34       9.19  31.988   9.405  135.9    6.9
INFO : SFind2D_AT.py : 13:29:46.589 +47.12.16.53    81.97    77.43       2.08       24.4  31.250  31.250  180.0    2.0
INFO : SFind2D_AT.py : 13:30:00.462 +47.13.07.61    59.35    85.60       5.53       27.5  68.299  11.999  153.9    5.2
INFO : SFind2D_AT.py : 13:29:56.318 +47.13.48.93    66.11    92.21       4.87       21.6  31.250  31.250    0.0    4.6
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  4.31997000e-01   4.36908960e-01   1.53904688e+03   2.77714844e+02]
REGRESSION : CONTFLUX: 13 1366.51
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
WARNING : SFind2D_AT.py : LogScaling applied
TIMING : SFind2D done  [  2.99401000e-01   3.18737030e-01   1.53904688e+03   2.77718750e+02]
TIMING : SFind2D END [ 1.519045    1.56716418]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  8.255295    14.79924583]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 8.2553 14.7992 ]
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 [  1.03076670e+01   1.64394405e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[22, 74, 289],4.010004
TIMING : CubeSpectrum CubeStats-pos  [  4.82880000e-02   4.84299660e-02   1.53904688e+03   2.77718750e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[76, 70],40.714703
TIMING : CubeSpectrum Moment-pos  [  4.28810000e-02   4.30161953e-02   1.53904688e+03   2.77718750e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('13h29m50.871s', '+47d11m17.27s'),18.387573
TIMING : CubeSpectrum SourceList-pos  [  3.59020000e-02   3.59919071e-02   1.53904688e+03   2.77718750e+02]
TIMING : CubeSpectrum open  [  1.22300000e-02   1.22649670e-02   1.53904688e+03   2.77718750e+02]
TIMING : CubeSpectrum imval  [  4.94120000e-02   4.96380329e-02   1.53904688e+03   2.78191406e+02]
TIMING : CubeSpectrum imhead  [  4.18990000e-02   4.20479774e-02   1.53904688e+03   2.78191406e+02]
TIMING : CubeSpectrum imval  [  2.50066000e-01   2.68901110e-01   1.53904688e+03   2.78230469e+02]
TIMING : CubeSpectrum imval  [  2.79093000e-01   2.97951937e-01   1.53904688e+03   2.78292969e+02]
REGRESSION : CSP: [0.84380042552947998, 4.0100035667419434, 1.1241528987884521]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.86455000e-01   3.05396080e-01   1.53904688e+03   2.78292969e+02]
TIMING : CubeSpectrum summary  [  1.22980000e-02   1.23269558e-02   1.53904688e+03   2.78292969e+02]
TIMING : CubeSpectrum END [ 1.070614    1.12809014]
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.14381220e+01   1.64394406e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.42070000e-02   2.42829323e-02   1.53904688e+03   2.78292969e+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  [   12.986646      13.01753807  1539.046875     278.703125  ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [264, 302]
WARNING : specutil.py : 0 [282, 321]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
TIMING : LineSegment segment finder  [    3.554895       3.56338596  1539.046875     278.703125  ]
INFO : LineSegment_AT.py :  Segment Coverage 58 / 590 = 0.0983051
REGRESSION : LINESEG: [[115.06681176471233, 115.08165551571781], [115.07384301518861, 115.08907739122057]]
TIMING : LineSegment done  [    2.282429       2.41247892  1555.80859375   295.30078125]
TIMING : LineSegment END [ 18.86053     19.03006887]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 28.461891    35.33977699]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 28.4619 35.3398 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 28.558751    35.49661398]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 28.5588 35.4966 ]
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 [  3.06345020e+01   1.64394407e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 500.59 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 500.589
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    7.968051       7.98719382  1555.80859375   295.359375  ]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    5.14515        5.15729117  1555.80859375   295.359375  ]
TIMING : LineID segment finder  [  1.44230000e-02   1.44679546e-02   1.55580859e+03   2.95359375e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [264, 302]
WARNING : specutil.py : 0 [282, 321]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 264 - 321
REGRESSION : LINEID: CO 115.27120  264 321
INFO : LineID_AT.py :  Line Coverage 58 / 590 = 0.0983051
TIMING : LineID done  [   15.76993       15.98250699  1656.34375      395.94921875]
TIMING : LineID END [ 28.911524    29.15546584]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 57.786506    65.05607581]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 57.7865 65.0561 ]
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.98149450e+01   1.64394410e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  1.13818000e-01   1.14444971e-01   1.60690234e+03   3.46671875e+02]
TIMING : LineCube pad  [  1.31270000e-02   1.31671429e-02   1.60690234e+03   3.46671875e+02]
TIMING : LineCube trans-x.CO_115.27120  [  7.80920000e-02   1.59436941e-01   1.60690234e+03   3.46792969e+02]
REGRESSION : LC: [259, 326]
TIMING : LineCube done  [  2.49090000e-02   2.49810219e-02   1.60690234e+03   3.46792969e+02]
TIMING : LineCube END [ 0.242369    0.32449198]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CO_115.27120/lc.im
TIMING : ADMITrun END [ 58.196319    65.60564089]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 58.1963 65.6056 ]
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 - '@1' (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.03229190e+01   1.64394410e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.87810000e-02   4.89189625e-02   1.60690234e+03   3.46792969e+02]
TIMING : Moment immoments-0  [  1.55633000e-01   2.08220005e-01   1.62661328e+03   3.66378906e+02]
TIMING : Moment mom0clip  [  7.05060000e-02   1.23656034e-01   1.62661328e+03   3.66531250e+02]
TIMING : Moment implot  [  9.50650000e-02   3.55758905e-01   1.62661328e+03   3.66531250e+02]
TIMING : Moment getdata  [  2.06060000e-02   2.06861496e-02   1.62661328e+03   3.66531250e+02]
TIMING : Moment ren+mask_0  [  3.05218000e-01   3.09908867e-01   1.63207812e+03   3.71996094e+02]
TIMING : Moment done  [  1.47810000e-02   1.48260593e-02   1.63207812e+03   3.71996094e+02]
TIMING : Moment END [ 0.722871    1.09431887]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@1.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.11061660e+01   1.64394411e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.83430000e-02   4.84590530e-02   1.63182812e+03   3.71746094e+02]
TIMING : Moment immoments-all  [  8.54630000e-02   2.28818893e-01   1.63182812e+03   3.71746094e+02]
TIMING : Moment mom0clip  [  6.93930000e-02   1.37376070e-01   1.63182812e+03   3.71746094e+02]
TIMING : Moment implot  [  9.35160000e-02   3.86755943e-01   1.63182812e+03   3.71746094e+02]
TIMING : Moment getdata  [  2.04830000e-02   2.05621719e-02   1.63182812e+03   3.71746094e+02]
TIMING : Moment ren+mask_0  [  2.53142000e-01   2.57553816e-01   1.63182812e+03   3.71746094e+02]
TIMING : Moment makemask  [  1.52385000e-01   4.57588196e-01   1.63182812e+03   3.72019531e+02]
TIMING : Moment implot  [  7.71320000e-02   3.22341919e-01   1.63182812e+03   3.72019531e+02]
TIMING : Moment getdata  [  2.02650000e-02   2.03390121e-02   1.63182812e+03   3.72019531e+02]
TIMING : Moment ren+mask_1  [  2.48992000e-01   2.53502846e-01   1.63157812e+03   3.72343750e+02]
TIMING : Moment makemask  [  1.55162000e-01   4.29092169e-01   1.63157812e+03   3.72343750e+02]
TIMING : Moment implot  [  7.66920000e-02   3.04535866e-01   1.63157812e+03   3.72343750e+02]
TIMING : Moment getdata  [  2.03520000e-02   2.04260349e-02   1.63157812e+03   3.72343750e+02]
TIMING : Moment ren+mask_2  [  2.45967000e-01   2.50333071e-01   1.63157812e+03   3.72343750e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 4578.49 2381.39 0.0256 508.147 508.147 13.2975
TIMING : Moment mom0flux  [  5.19320000e-02   5.23779392e-02   1.63157812e+03   3.72343750e+02]
TIMING : Moment flux-spectrum  [  3.08385000e-01   3.13251972e-01   1.63132812e+03   3.72093750e+02]
TIMING : Moment done  [  1.46770000e-02   1.47290230e-02   1.63132812e+03   3.72093750e+02]
TIMING : Moment END [ 1.954617    3.53044105]
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 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.31689710e+01   1.64394411e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[76, 69],43.224056
TIMING : CubeSpectrum Moment-pos  [  5.46110000e-02   5.47618866e-02   1.63132812e+03   3.72093750e+02]
TIMING : CubeSpectrum open  [  1.23160000e-02   1.23531818e-02   1.63132812e+03   3.72093750e+02]
TIMING : CubeSpectrum imval  [  3.65410000e-02   3.67269516e-02   1.63132812e+03   3.72093750e+02]
TIMING : CubeSpectrum imhead  [  4.19440000e-02   4.21078205e-02   1.63132812e+03   3.72093750e+02]
REGRESSION : CSP: [1.1849629878997803]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.94012000e-01   2.98829079e-01   1.63132812e+03   3.72093750e+02]
TIMING : CubeSpectrum summary  [  1.24940000e-02   1.25291348e-02   1.63132812e+03   3.72093750e+02]
TIMING : CubeSpectrum END [ 0.464208    0.46963286]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@1.csp