INFO : AT.py : Setting {'basename': 'x', 'file': 'NGC5194_90911.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 :  NGC5194_90911.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.22930300e+00   1.64394393e+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.70348000e-01   2.77225018e-01   1.41106641e+03   2.18085938e+02]
TIMING : Ingest importfits  [  1.80751000e-01   3.46338987e-01   1.41125391e+03   2.19265625e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  7.64480000e-02   2.20573902e-01   1.41177734e+03   2.20929688e+02]
TIMING : Ingest summary-0  [  1.42580000e-02   1.43811703e-02   1.41177734e+03   2.20929688e+02]
TIMING : Ingest mask  [  6.82820000e-02   1.11690998e-01   1.41177734e+03   2.20929688e+02]
TIMING : Ingest summary-1  [  1.40300000e-02   1.83429718e-02   1.41177734e+03   2.20929688e+02]
TIMING : Ingest statistics  [  1.07357000e-01   1.07614994e-01   1.41177734e+03   2.21644531e+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] 8803980 -0.075473 0.515486
INFO : Ingest_AT.py : S/N (all data): 26.282239
INFO : Ingest_AT.py : GOOD PIXELS: 8803980/12404750 (70.972652% good or 29.027348% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.075473 0.515486 0.0196135  145 145 590  29.027348
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.16721000e-01   6.40721083e-01   1.41482031e+03   2.25281250e+02]
TIMING : Ingest END [ 1.360167    1.74889612]
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.64977600e+00   1.64394393e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.24540000e-02   5.33530712e-02   1.41572656e+03   2.26500000e+02]
TIMING : CubeStats start  [  1.24610000e-02   1.25100613e-02   1.41572656e+03   2.26500000e+02]
TIMING : CubeStats imstat0  [  4.67738000e-01   4.69627857e-01   1.41454297e+03   2.26042969e+02]
TIMING : CubeStats imstat1  [  5.55793000e-01   5.57277203e-01   1.41407031e+03   2.25753906e+02]
INFO : CubeStats_AT.py : sigma varies from 0.005508 to 0.017503; 590/590 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.0110157 (3.17789 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  8.91183000e-01   8.94399881e-01   1.42085547e+03   2.32417969e+02]
INFO : CubeStats_AT.py : CubeMax: 0.515486 @ [ 73  67 262   0]
INFO : CubeStats_AT.py : CubeMin: -0.075473 @ [22 74 24  0]
INFO : CubeStats_AT.py : CubeRMS: 0.011058
INFO : CubeStats_AT.py : RMS Sanity check 1.773730
WARNING : CubeStats_AT.py : RMS sanity check = 1.773730.  Either bad sidelobes, lotsa signal, or both
REGRESSION : CST: 0.011058 1.773730
INFO : CubeStats_AT.py : mean,rms,S/N=0.000660 0.011058 46.617601
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 3.112381 3.695236
TIMING : CubeStats plotting  [    2.284084       2.47552609  1455.0234375    264.91015625]
TIMING : CubeStats done  [  1.36090000e-02   1.36539936e-02   1.45502344e+03   2.64910156e+02]
TIMING : CubeStats summary  [  1.21440000e-02   1.21970177e-02   1.45502344e+03   2.64910156e+02]
TIMING : CubeStats END [ 4.301584    4.50070715]
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.01076600e+00   1.64394394e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.011058
TIMING : CubeSum start  [  5.22860000e-02   5.24411201e-02   1.45502344e+03   2.64914062e+02]
TIMING : CubeSum immoments  [  1.50369000e-01   2.13248968e-01   1.46258594e+03   2.72925781e+02]
TIMING : CubeSum statistics  [  2.02790000e-02   2.03609467e-02   1.46258594e+03   2.72925781e+02]
INFO : CubeSum_AT.py : Total flux: 471818.169703 (sum=12078.546690)
REGRESSION : CSM: [471818.16970338766, 12078.546690460651]
TIMING : CubeSum implot  [  1.44118000e-01   6.10233712e+00   1.53458984e+03   2.72953125e+02]
TIMING : CubeSum getdata  [  2.16430000e-02   2.17628479e-02   1.53458984e+03   2.72953125e+02]
TIMING : CubeSum done  [  2.33118000e-01   2.52663136e-01   1.53458984e+03   2.73015625e+02]
TIMING : CubeSum END [ 0.635119    6.67617416]
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.70555800e+00   1.64394395e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.37520000e-02   3.39019299e-02   1.53458984e+03   2.73015625e+02]
TIMING : SFind2D imstat  [  4.20930000e-02   4.23920155e-02   1.53458984e+03   2.73015625e+02]
INFO : AT.py : Setting 'sigma' = 1.54276131191 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 1.54276 -0.808097 29.9848 35 0.205806
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  6.93601000e-01   7.04015017e-01   1.53458984e+03   2.73015625e+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:51.552 +47.11.34.26    73.88    70.66       24.9        763  91.906  58.215    4.1   16.2
INFO : SFind2D_AT.py : 13:30:00.263 +47.13.02.45    59.68    84.78        9.5        228 110.492  45.434  148.1    6.2
INFO : SFind2D_AT.py : 13:29:45.294 +47.10.16.46    84.09    58.22       8.42        236  97.725  57.178  154.4    5.5
INFO : SFind2D_AT.py : 13:29:45.791 +47.11.59.84    83.27    74.76       9.03       41.9  31.250  31.250  180.0    5.9
INFO : SFind2D_AT.py : 13:29:44.921 +47.10.09.07    84.70    57.04       8.32        324 170.389  47.513  126.2    5.4
INFO : SFind2D_AT.py : 13:30:02.072 +47.12.29.29    56.72    79.47       7.61       36.1  31.250  31.250   90.0    4.9
INFO : SFind2D_AT.py : 13:30:01.128 +47.11.54.48    58.26    73.90        7.6       33.9  31.250  31.250   90.0    4.9
INFO : SFind2D_AT.py : 13:29:56.600 +47.13.51.64    65.65    92.65       6.41       30.6  31.250  31.250    0.0    4.2
INFO : SFind2D_AT.py : 13:29:51.980 +47.09.31.69    73.18    51.05       5.88        106  96.496  36.820  102.2    3.8
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  3.32218000e-01   3.38086843e-01   1.53458984e+03   2.73562500e+02]
REGRESSION : CONTFLUX: 9 1798.53
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.73727000e-01   2.92479992e-01   1.53458984e+03   2.73601562e+02]
TIMING : SFind2D END [ 1.388791    1.42431998]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  8.259781    14.97979498]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 8.25978 14.9798 ]
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.03027090e+01   1.64394395e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[73, 67, 262],0.515486
TIMING : CubeSpectrum CubeStats-pos  [  4.77150000e-02   4.78491783e-02   1.53458984e+03   2.73601562e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[75, 70],29.984840
TIMING : CubeSpectrum Moment-pos  [  4.24080000e-02   4.25348282e-02   1.53458984e+03   2.73601562e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('13h29m51.552s', '+47d11m34.26s'),24.932289
TIMING : CubeSpectrum SourceList-pos  [  3.58710000e-02   3.59599590e-02   1.53458984e+03   2.73601562e+02]
TIMING : CubeSpectrum open  [  1.21800000e-02   1.22151375e-02   1.53458984e+03   2.73601562e+02]
TIMING : CubeSpectrum imval  [  4.70530000e-02   4.72900867e-02   1.53458984e+03   2.73957031e+02]
TIMING : CubeSpectrum imhead  [  4.44700000e-02   4.46279049e-02   1.53458984e+03   2.73957031e+02]
TIMING : CubeSpectrum imval  [  2.35584000e-01   2.54175901e-01   1.53458984e+03   2.73957031e+02]
TIMING : CubeSpectrum imval  [  2.56398000e-01   2.75398016e-01   1.53458984e+03   2.74019531e+02]
REGRESSION : CSP: [0.33226931095123291, 0.51548552513122559, 0.46312695741653442]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.72022000e-01   2.91336060e-01   1.53458984e+03   2.74019531e+02]
TIMING : CubeSpectrum summary  [  1.26670000e-02   1.27060413e-02   1.53458984e+03   2.74019531e+02]
TIMING : CubeSpectrum END [ 1.01877     1.07653308]
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.13825340e+01   1.64394395e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.46870000e-02   2.47550011e-02   1.53458984e+03   2.74019531e+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  [   26.875842      26.95541978  1534.58984375   274.58203125]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [37, 40]
WARNING : specutil.py : 1 [235, 400]
WARNING : specutil.py : 0 [224, 320]
WARNING : specutil.py : 1 [328, 334]
WARNING : specutil.py : 2 [339, 347]
WARNING : specutil.py : 3 [387, 390]
WARNING : specutil.py : 0 [241, 376]
WARNING : specutil.py : 1 [387, 390]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [224, 417]
WARNING : specutil.py : 1 [427, 429]
WARNING : specutil.py : 0 [36, 39]
WARNING : specutil.py : 1 [65, 68]
WARNING : specutil.py : 2 [100, 103]
WARNING : specutil.py : 3 [136, 140]
WARNING : specutil.py : 4 [218, 222]
WARNING : specutil.py : 5 [551, 554]
TIMING : LineSegment segment finder  [    4.501586       4.51259804  1534.58984375   274.58203125]
INFO : LineSegment_AT.py :  Segment Coverage 181 / 590 = 0.30678
REGRESSION : LINESEG: [[115.05118676365392, 115.12657739376077], [115.13048364402538, 115.1312648940783], [114.97774925867935, 114.97892113375873], [114.9890773844467, 114.99024925952608], [115.00274926037282, 115.00392113545219], [115.0168117613254, 115.01837426143123], [115.04884301349514, 115.05040551360098], [115.17892114730647, 115.18009302238585], [114.97813988370581, 114.97931175878519], [115.05548363894498, 115.11993676831095], [115.05118676365392, 115.0886867661941], [115.0918117664058, 115.09415551656456], [115.09610864169686, 115.09923364190854], [115.11485864296696, 115.11603051804634], [115.05782738910375, 115.11056176767589], [115.11485864296696, 115.11603051804634]]
TIMING : LineSegment done  [    2.188597       2.320961    1558.78125      298.64453125]
TIMING : LineSegment END [ 33.603042    33.82610583]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 43.157797   50.2135272]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 43.1578 50.2135 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 43.255398    50.37002015]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 43.2554 50.37 ]
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.53235270e+01   1.64394398e+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  [   16.973565      17.01939106  1558.78125      298.6484375 ]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [   10.073011      10.09831095  1558.78125      298.6484375 ]
TIMING : LineID segment finder  [  1.43290000e-02   1.43709183e-02   1.55878125e+03   2.98648438e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [37, 40]
WARNING : specutil.py : 1 [235, 400]
WARNING : specutil.py : 0 [224, 320]
WARNING : specutil.py : 1 [328, 334]
WARNING : specutil.py : 2 [339, 347]
WARNING : specutil.py : 3 [387, 390]
WARNING : specutil.py : 0 [241, 376]
WARNING : specutil.py : 1 [387, 390]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [224, 417]
WARNING : specutil.py : 1 [427, 429]
WARNING : specutil.py : 0 [36, 39]
WARNING : specutil.py : 1 [65, 68]
WARNING : specutil.py : 2 [100, 103]
WARNING : specutil.py : 3 [136, 140]
WARNING : specutil.py : 4 [218, 222]
WARNING : specutil.py : 5 [551, 554]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : utils.py : Gaussian fit attempted with only three points, look at the covariance for goodness of fit.
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 36 - 554
REGRESSION : LINEID: CO 115.27120  36 554
INFO : LineID_AT.py :  Line Coverage 519 / 590 = 0.879661
TIMING : LineID done  [   16.714832      16.90557003  1656.3359375    396.28515625]
TIMING : LineID END [ 43.789727    44.05167007]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 87.371767    94.81573105]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 87.3718 94.8157 ]
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 [  8.93927100e+01   1.64394403e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  1.24271000e-01   1.24914885e-01   1.60689844e+03   3.47007812e+02]
TIMING : LineCube pad  [  1.30110000e-02   1.30479336e-02   1.60689844e+03   3.47007812e+02]
TIMING : LineCube trans-x.CO_115.27120  [  1.10872000e-01   1.68368101e-01   1.60689844e+03   3.47250000e+02]
REGRESSION : LC: [31, 559]
TIMING : LineCube done  [  2.49800000e-02   2.50449181e-02   1.60689844e+03   3.47250000e+02]
TIMING : LineCube END [ 0.285481    0.34375978]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CO_115.27120/lc.im
TIMING : ADMITrun END [ 87.828439    95.38981819]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 87.8284 95.3898 ]
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 [  8.99455310e+01   1.64394403e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.86820000e-02   4.88040447e-02   1.60689844e+03   3.47250000e+02]
TIMING : Moment immoments-0  [  1.59030000e-01   2.21357822e-01   1.62566406e+03   3.65890625e+02]
TIMING : Moment mom0clip  [  7.11260000e-02   2.39927053e-01   1.62566406e+03   3.66078125e+02]
TIMING : Moment implot  [  1.08109000e-01   3.76441002e-01   1.62566406e+03   3.66136719e+02]
TIMING : Moment getdata  [  2.10640000e-02   2.11310387e-02   1.62566406e+03   3.66136719e+02]
TIMING : Moment ren+mask_0  [  3.36067000e-01   3.41219902e-01   1.63082422e+03   3.71296875e+02]
TIMING : Moment done  [  1.51680000e-02   1.52301788e-02   1.63082422e+03   3.71296875e+02]
TIMING : Moment END [ 0.771678    1.27660894]
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 [  9.07783130e+01   1.64394403e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.85710000e-02   4.87489700e-02   1.63082422e+03   3.71296875e+02]
TIMING : Moment immoments-all  [  1.71932000e-01   3.75452042e-01   1.63082422e+03   3.71296875e+02]
TIMING : Moment mom0clip  [  7.04690000e-02   2.37957954e-01   1.63082422e+03   3.71296875e+02]
TIMING : Moment implot  [  9.41600000e-02   3.77850056e-01   1.63082422e+03   3.71296875e+02]
TIMING : Moment getdata  [  2.14150000e-02   2.14960575e-02   1.63082422e+03   3.71296875e+02]
TIMING : Moment ren+mask_0  [  2.62769000e-01   2.67509937e-01   1.63057422e+03   3.71046875e+02]
TIMING : Moment makemask  [  1.55752000e-01   8.56826067e-01   1.63057422e+03   3.71492188e+02]
TIMING : Moment implot  [  7.79430000e-02   3.15141916e-01   1.63057422e+03   3.71492188e+02]
TIMING : Moment getdata  [  2.11170000e-02   2.11970806e-02   1.63057422e+03   3.71492188e+02]
TIMING : Moment ren+mask_1  [  2.64981000e-01   2.69732952e-01   1.63057422e+03   3.71949219e+02]
TIMING : Moment makemask  [  1.53732000e-01   3.78539085e-01   1.63057422e+03   3.71949219e+02]
TIMING : Moment implot  [  7.65720000e-02   3.06303978e-01   1.63057422e+03   3.71949219e+02]
TIMING : Moment getdata  [  2.06470000e-02   2.07219124e-02   1.63057422e+03   3.71949219e+02]
TIMING : Moment ren+mask_2  [  2.55059000e-01   2.59809017e-01   1.63057422e+03   3.71949219e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 10426.5 7370.82 0.0256 465.294 465.294 42.4682
TIMING : Moment mom0flux  [  5.18560000e-02   5.20060062e-02   1.63057422e+03   3.71949219e+02]
TIMING : Moment flux-spectrum  [  7.27551000e-01   7.33294010e-01   1.63032422e+03   3.71710938e+02]
TIMING : Moment done  [  1.48070000e-02   1.48549080e-02   1.63032422e+03   3.71710938e+02]
TIMING : Moment END [ 2.501621    4.56978011]
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 [  9.33875660e+01   1.64394403e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[75, 70],30.523739
TIMING : CubeSpectrum Moment-pos  [  5.45350000e-02   5.46960831e-02   1.63032422e+03   3.71710938e+02]
TIMING : CubeSpectrum open  [  1.23740000e-02   1.24108791e-02   1.63032422e+03   3.71710938e+02]
TIMING : CubeSpectrum imval  [  4.05120000e-02   4.07021046e-02   1.63032422e+03   3.71710938e+02]
TIMING : CubeSpectrum imhead  [  4.25940000e-02   4.27529812e-02   1.63032422e+03   3.71710938e+02]
REGRESSION : CSP: [0.46312695741653442]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.58015000e-01   2.61708021e-01   1.63007422e+03   3.71460938e+02]
TIMING : CubeSpectrum summary  [  1.25830000e-02   1.26168728e-02   1.63007422e+03   3.71460938e+02]
TIMING : CubeSpectrum END [ 0.432938    0.43725014]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@1.csp