INFO : AT.py : Setting {'basename': 'x', 'file': 'NGC5194_91112.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_91112.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.20526300e+00   1.64394441e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: NGC5194   SHAPE: [177 177 590]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  3.42985000e-01   3.50193024e-01   1.41062109e+03   2.17808594e+02]
TIMING : Ingest importfits  [  2.35615000e-01   2.97588825e-01   1.41095703e+03   2.19296875e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  1.17447000e-01   2.11469173e-01   1.41200000e+03   2.21179688e+02]
TIMING : Ingest summary-0  [  1.47790000e-02   1.48978233e-02   1.41200000e+03   2.21179688e+02]
TIMING : Ingest mask  [  1.22940000e-01   1.33556128e-01   1.41200000e+03   2.21179688e+02]
TIMING : Ingest summary-1  [  1.42500000e-02   1.77919865e-02   1.41200000e+03   2.21179688e+02]
TIMING : Ingest statistics  [  1.74650000e-01   1.75142050e-01   1.41228516e+03   2.22542969e+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: [177 177 590   1] 8791000 -0.073970 0.650974
INFO : Ingest_AT.py : S/N (all data): 27.626901
INFO : Ingest_AT.py : GOOD PIXELS: 8791000/18484110 (47.559769% good or 52.440231% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.0739696 0.650974 0.0235631  177 177 590  52.440231
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 88.000000
INFO : Ingest_AT.py : DEC  Axis 2: 47.195170 6.250000 88.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.82910000e-01   6.88549995e-01   1.41542188e+03   2.26050781e+02]
TIMING : Ingest END [ 1.717605    1.90124893]
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.98352900e+00   1.64394442e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.18340000e-02   5.27560711e-02   1.41467188e+03   2.25906250e+02]
TIMING : CubeStats start  [  1.26680000e-02   1.27148628e-02   1.41467188e+03   2.25906250e+02]
TIMING : CubeStats imstat0  [  6.60376000e-01   6.62665129e-01   1.44604297e+03   2.57578125e+02]
TIMING : CubeStats imstat1  [  6.78071000e-01   6.80229902e-01   1.41392188e+03   2.25703125e+02]
INFO : CubeStats_AT.py : sigma varies from 0.006333 to 0.014208; 590/590 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.0126655 (2.24363 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  9.88402000e-01   9.93093967e-01   1.42460938e+03   2.36269531e+02]
INFO : CubeStats_AT.py : CubeMax: 0.650974 @ [ 89  83 261   0]
INFO : CubeStats_AT.py : CubeMin: -0.073970 @ [ 73 114  71   0]
INFO : CubeStats_AT.py : CubeRMS: 0.011576
INFO : CubeStats_AT.py : RMS Sanity check 2.035463
WARNING : CubeStats_AT.py : RMS sanity check = 2.035463.  Either bad sidelobes, lotsa signal, or both
REGRESSION : CST: 0.011576 2.035463
INFO : CubeStats_AT.py : mean,rms,S/N=0.002594 0.011576 56.233522
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 3.027358 3.517729
TIMING : CubeStats plotting  [    2.272729       2.46010113  1455.45703125   265.59765625]
TIMING : CubeStats done  [  1.34630000e-02   1.34987831e-02   1.45545703e+03   2.65597656e+02]
TIMING : CubeStats summary  [  1.21590000e-02   1.22041702e-02   1.45545703e+03   2.65597656e+02]
TIMING : CubeStats END [ 4.70187     4.89946985]
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.74498800e+00   1.64394442e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.011576
TIMING : CubeSum start  [  5.16150000e-02   5.17737865e-02   1.45545703e+03   2.65597656e+02]
TIMING : CubeSum immoments  [  2.03315000e-01   2.43410110e-01   1.46116797e+03   2.71632812e+02]
TIMING : CubeSum statistics  [  1.98910000e-02   1.99830532e-02   1.46116797e+03   2.71632812e+02]
INFO : CubeSum_AT.py : Total flux: 666275.628000 (sum=17056.658260)
REGRESSION : CSM: [666275.62800009386, 17056.658260054588]
TIMING : CubeSum implot  [  1.63683000e-01   6.12680101e+00   1.53317188e+03   2.71660156e+02]
TIMING : CubeSum getdata  [  2.54340000e-02   2.55370140e-02   1.53317188e+03   2.71660156e+02]
TIMING : CubeSum done  [  2.89912000e-01   3.10060978e-01   1.53317188e+03   2.71726562e+02]
TIMING : CubeSum END [ 0.767987    6.79176784]
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 [  9.57373200e+00   1.64394443e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.44490000e-02   3.45518589e-02   1.53317188e+03   2.71726562e+02]
TIMING : SFind2D imstat  [  4.28070000e-02   4.30469513e-02   1.53317188e+03   2.71726562e+02]
INFO : AT.py : Setting 'sigma' = 2.14303613138 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 2.14304 -0.510292 39.3836 35 0.217658
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  2.63924000e-01   2.72024155e-01   1.53317188e+03   2.71910156e+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.584 +47.11.39.64    89.83    87.53       33.7   1.12e+03  97.242  61.480    4.2   15.7
INFO : SFind2D_AT.py : 13:30:00.476 +47.12.57.41    75.33    99.97         13        401 124.653  51.786  150.3    6.1
INFO : SFind2D_AT.py : 13:29:45.143 +47.10.16.76   100.34    74.27       10.1        289 100.313  55.321  147.2    4.7
INFO : SFind2D_AT.py : 13:29:46.977 +47.09.54.68    97.34    70.73       10.3        288 126.189  47.821  120.1    4.8
INFO : SFind2D_AT.py : 13:30:00.849 +47.11.52.67    74.72    89.61       9.58       46.1  31.250  31.250   90.0    4.5
INFO : SFind2D_AT.py : 13:30:27.913 +47.09.49.59    30.55    69.97          0   4.87e+03 735.934  69.271  126.3    0.0
INFO : SFind2D_AT.py : 13:29:52.293 +47.09.32.34    88.67    67.16       8.89        136  91.801  35.078  101.0    4.1
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  2.81891000e-01   2.87755013e-01   1.53317188e+03   2.71910156e+02]
REGRESSION : CONTFLUX: 7 7149.71
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.90770000e-01   3.09159040e-01   1.53292188e+03   2.72066406e+02]
TIMING : SFind2D END [ 0.92791     0.96064687]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  8.710288    15.21009994]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 8.71029 15.2101 ]
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.07163860e+01   1.64394443e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[89, 83, 261],0.650974
TIMING : CubeSpectrum CubeStats-pos  [  4.93120000e-02   4.94339466e-02   1.53292188e+03   2.72070312e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[91, 87],39.383556
TIMING : CubeSpectrum Moment-pos  [  4.31870000e-02   4.33120728e-02   1.53292188e+03   2.72070312e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('13h29m51.584s', '+47d11m39.64s'),33.731522
TIMING : CubeSpectrum SourceList-pos  [  3.59200000e-02   3.60250473e-02   1.53292188e+03   2.72070312e+02]
TIMING : CubeSpectrum open  [  1.22200000e-02   1.22539997e-02   1.53292188e+03   2.72070312e+02]
TIMING : CubeSpectrum imval  [  4.27300000e-02   4.29239273e-02   1.53292188e+03   2.72421875e+02]
TIMING : CubeSpectrum imhead  [  4.14710000e-02   4.16231155e-02   1.53292188e+03   2.72421875e+02]
TIMING : CubeSpectrum imval  [  2.42960000e-01   2.61832952e-01   1.53292188e+03   2.72484375e+02]
TIMING : CubeSpectrum imval  [  2.62743000e-01   2.81955957e-01   1.53267188e+03   2.72234375e+02]
REGRESSION : CSP: [0.54922127723693848, 0.65097445249557495, 0.38500279188156128]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  3.08212000e-01   3.26941967e-01   1.53267188e+03   2.72234375e+02]
TIMING : CubeSpectrum summary  [  1.25350000e-02   1.25739574e-02   1.53267188e+03   2.72234375e+02]
TIMING : CubeSpectrum END [ 1.06345     1.12107396]
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.18400800e+01   1.64394443e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.44400000e-02   2.45089531e-02   1.53267188e+03   2.72234375e+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  [   21.728344      21.78712702  1532.671875     272.7421875 ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [246, 396]
WARNING : specutil.py : 1 [473, 476]
WARNING : specutil.py : 0 [72, 77]
WARNING : specutil.py : 1 [232, 324]
WARNING : specutil.py : 2 [329, 336]
WARNING : specutil.py : 3 [345, 350]
WARNING : specutil.py : 0 [248, 401]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [224, 416]
TIMING : LineSegment segment finder  [    4.128823       4.14430213  1532.671875     272.74609375]
INFO : LineSegment_AT.py :  Segment Coverage 180 / 590 = 0.305085
REGRESSION : LINESEG: [[115.05118676365392, 115.12618676873431], [115.05978051423604, 115.1183742682051], [115.14845239524256, 115.14962427032194], [114.99181175963193, 114.99376488476422], [115.0543117638656, 115.09024926629996], [115.09220239143225, 115.09493676661748], [115.09845239185562, 115.10040551698793], [115.06056176428896, 115.1203273933374]]
TIMING : LineSegment done  [    2.271028       2.40155602  1554.390625     294.328125  ]
TIMING : LineSegment END [ 28.164995    28.36988807]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 38.222854    45.10917187]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 38.2229 45.1092 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 38.319604    45.30226398]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 38.3196 45.3023 ]
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.03506140e+01   1.64394446e+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  [   15.206757      15.25535703  1554.390625     294.46875   ]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    6.702785       6.72602391  1554.390625     294.46875   ]
TIMING : LineID segment finder  [  1.41370000e-02   1.41999722e-02   1.55439062e+03   2.94468750e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [246, 396]
WARNING : specutil.py : 1 [473, 476]
WARNING : specutil.py : 0 [72, 77]
WARNING : specutil.py : 1 [232, 324]
WARNING : specutil.py : 2 [329, 336]
WARNING : specutil.py : 3 [345, 350]
WARNING : specutil.py : 0 [248, 401]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [224, 416]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 72 - 476
REGRESSION : LINEID: CO 115.27120  72 476
INFO : LineID_AT.py :  Line Coverage 405 / 590 = 0.686441
TIMING : LineID done  [   16.495241      16.69734502  1656.4609375    396.6328125 ]
TIMING : LineID END [ 38.433127    38.70717001]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 77.07797     84.40197682]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 77.078 84.402 ]
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 [  7.90588200e+01   1.64394450e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  1.90187000e-01   1.91024065e-01   1.60702344e+03   3.47417969e+02]
TIMING : LineCube pad  [  1.34580000e-02   1.34968758e-02   1.60702344e+03   3.47417969e+02]
TIMING : LineCube trans-x.CO_115.27120  [  1.68352000e-01   3.98470163e-01   1.60702344e+03   3.47656250e+02]
REGRESSION : LC: [67, 481]
TIMING : LineCube done  [  2.49860000e-02   2.50549316e-02   1.60702344e+03   3.47656250e+02]
TIMING : LineCube END [ 0.409264    0.64036298]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CO_115.27120/lc.im
TIMING : ADMITrun END [ 77.656899   85.2712369]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 77.6569 85.2712 ]
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 [  7.97335540e+01   1.64394450e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.87460000e-02   4.88829613e-02   1.60702344e+03   3.47656250e+02]
TIMING : Moment immoments-0  [  2.10593000e-01   2.39753962e-01   1.62594531e+03   3.66453125e+02]
TIMING : Moment mom0clip  [  7.00340000e-02   1.45489931e-01   1.62594531e+03   3.66640625e+02]
TIMING : Moment implot  [  9.86280000e-02   3.66223097e-01   1.62594531e+03   3.66699219e+02]
TIMING : Moment getdata  [  2.31590000e-02   2.32319832e-02   1.62594531e+03   3.66699219e+02]
TIMING : Moment ren+mask_0  [  4.32087000e-01   4.37463999e-01   1.63069922e+03   3.71453125e+02]
TIMING : Moment done  [  1.62100000e-02   1.62770748e-02   1.63069922e+03   3.71453125e+02]
TIMING : Moment END [ 0.911812    1.28973389]
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 [  8.07063760e+01   1.64394450e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.83930000e-02   4.85160351e-02   1.63069922e+03   3.71453125e+02]
TIMING : Moment immoments-all  [  2.22953000e-01   4.14787054e-01   1.63069922e+03   3.71453125e+02]
TIMING : Moment mom0clip  [  7.25020000e-02   3.09483051e-01   1.63069922e+03   3.71453125e+02]
TIMING : Moment implot  [  9.81390000e-02   3.90707016e-01   1.63069922e+03   3.71453125e+02]
TIMING : Moment getdata  [  2.31860000e-02   2.32658386e-02   1.63069922e+03   3.71453125e+02]
TIMING : Moment ren+mask_0  [  3.19852000e-01   3.24542999e-01   1.63069922e+03   3.71453125e+02]
TIMING : Moment makemask  [  1.55872000e-01   4.81508017e-01   1.63069922e+03   3.71902344e+02]
TIMING : Moment implot  [  7.92050000e-02   3.26109171e-01   1.63069922e+03   3.71902344e+02]
TIMING : Moment getdata  [  2.21210000e-02   2.21920013e-02   1.63069922e+03   3.71902344e+02]
TIMING : Moment ren+mask_1  [  2.94164000e-01   3.00114870e-01   1.63069922e+03   3.72484375e+02]
TIMING : Moment makemask  [  1.53847000e-01   5.24007082e-01   1.63069922e+03   3.72484375e+02]
TIMING : Moment implot  [  7.81530000e-02   3.10196877e-01   1.63069922e+03   3.72484375e+02]
TIMING : Moment getdata  [  2.21670000e-02   2.22370625e-02   1.63069922e+03   3.72484375e+02]
TIMING : Moment ren+mask_2  [  2.88674000e-01   2.93285131e-01   1.63069922e+03   3.72484375e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 20843.4 11134.9 0.0256 470.304 470.304 41.9175
TIMING : Moment mom0flux  [  5.36900000e-02   5.38477898e-02   1.63069922e+03   3.72484375e+02]
TIMING : Moment flux-spectrum  [  7.43080000e-01   7.48621225e-01   1.63069922e+03   3.72484375e+02]
TIMING : Moment done  [  1.57490000e-02   1.57868862e-02   1.63069922e+03   3.72484375e+02]
TIMING : Moment END [ 2.704164    4.62167907]
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 [  8.35198810e+01   1.64394451e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[91, 87],39.952038
TIMING : CubeSpectrum Moment-pos  [  5.52410000e-02   5.53860664e-02   1.63069922e+03   3.72484375e+02]
TIMING : CubeSpectrum open  [  1.23420000e-02   1.23789310e-02   1.63069922e+03   3.72484375e+02]
TIMING : CubeSpectrum imval  [  3.94270000e-02   3.96020412e-02   1.63069922e+03   3.72484375e+02]
TIMING : CubeSpectrum imhead  [  4.25930000e-02   4.27520275e-02   1.63069922e+03   3.72484375e+02]
REGRESSION : CSP: [0.54922127723693848]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.88623000e-01   2.92703867e-01   1.63044922e+03   3.72234375e+02]
TIMING : CubeSpectrum summary  [  1.28170000e-02   1.28531456e-02   1.63044922e+03   3.72234375e+02]
TIMING : CubeSpectrum END [ 0.463483    0.46815085]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@1.csp