INFO : AT.py : Setting {'basename': 'x', 'file': 'NGC5194_91112.nf.fits'} for Ingest_AT
INFO : AT.py : Setting 'vlsr' = 463.0 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.6)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     box :  []
INFO :     file :  NGC5194_91112.nf.fits
INFO :     smooth :  []
INFO :     basename :  x
INFO :     mask :  True
INFO :     pb :  
INFO :     edge :  []
INFO :     restfreq :  -1.0
INFO :     vlsr :  463.0
INFO :     usepb :  True
INFO : 
TIMING : Ingest ADMIT [  1.12572400e+00   1.60904059e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  4.64572000e-01   1.44217014e-01   1.11460156e+03   2.15992188e+02]
TIMING : Ingest importfits  [  1.59245000e-01   1.71492815e-01   1.11505078e+03   2.17300781e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  6.53240000e-02   7.34710693e-02   1.11605859e+03   2.18968750e+02]
TIMING : Ingest summary-0  [  1.00440000e-02   1.00429058e-02   1.11605859e+03   2.18968750e+02]
TIMING : Ingest mask  [  4.08710000e-02   4.40859795e-02   1.11636328e+03   2.19382812e+02]
TIMING : Ingest summary-1  [  9.80100000e-03   1.13680363e-02   1.11636328e+03   2.19382812e+02]
TIMING : Ingest statistics  [  2.89287000e-01   4.73580360e-02   1.13264844e+03   2.20773438e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 12.4999992, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 12.4999992, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [145 145 689   1] 8588385 -0.116854 0.630378
INFO : Ingest_AT.py : S/N (all data): 20.448468
INFO : Ingest_AT.py : GOOD PIXELS: 8588385/14486225 (59.286564% good or 40.713436% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.116854 0.630378 0.0308276  145 145 689  40.713436
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: NGC5194
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : VLSR.py : VLSR: /home/teuben/ADMIT/admit/etc/vlsr.tab, found 229 entries
INFO : VLSR.py : VLSR: /home/teuben/ADMIT/admit/etc/z.tab, found 11979 entries
INFO : Ingest_AT.py : VLSR = 463.000000 (from source catalog)
INFO : Ingest_AT.py : VLSRz: 1 values: 0.000000 +/- 0.000000   [ 0.]
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 : Freq Orig Axis 3: 114.959 0.00038942 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.012788 km/s @ fc=115.093415 fw=0.268311 GHz
INFO : Ingest_AT.py : Freq Binn Axis 3: 114.959 0.00038942 0
INFO : Ingest_AT.py : Cube Binn Axis 3: type=Frequency  velocity increment=-1.012788 km/s @ fc=115.093415 fw=0.268311 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= 462.386942  VLSRw= -697.811083  VLSRf= 0.000000 VLSRz= 0.000000 VLSR= 463.000000
TIMING : Ingest done  [  7.52219000e-01   3.77449989e-01   1.13597656e+03   2.24531250e+02]
TIMING : Ingest END [ 1.79881     0.88693094]
INFO : AT.py : BDP_OUT[0] = SpwCube_BDP x.im
INFO : 
INFO : 
INFO :    Executing CubeStats_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     ppp :  True
INFO :     psample :  -1
INFO :     robust :  []
INFO :     maxvrms :  2.0
INFO : 
TIMING : CubeStats ADMIT [  2.96216100e+00   1.60904059e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  3.42230000e-02   3.42309475e-02   1.13650000e+03   2.25562500e+02]
TIMING : CubeStats start  [  8.65600000e-03   8.65411758e-03   1.13650000e+03   2.25562500e+02]
TIMING : CubeStats imstat0  [  1.23541400e+00   3.41845989e-01   1.58327344e+03   3.49710938e+02]
TIMING : CubeStats imstat1  [  8.54430000e-01   1.44805908e-01   1.62973047e+03   3.96109375e+02]
INFO : CubeStats_AT.py : sigma varies from 0.019859 to 0.030113; 689/689 channels ok
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  7.90180000e-01   7.90186167e-01   1.62973047e+03   3.96109375e+02]
INFO : CubeStats_AT.py : CubeMax: 0.630378 @ [ 71  81 398   0]
INFO : CubeStats_AT.py : CubeMin: -0.116854 @ [ 31  59 612   0]
INFO : CubeStats_AT.py : CubeRMS: 0.023744
INFO : CubeStats_AT.py : RMS Sanity check 1.298339
REGRESSION : CST: 0.023744 1.298339
INFO : CubeStats_AT.py : mean,rms,S/N=0.002798 0.023744 26.549045
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.562173 1.545879
TIMING : CubeStats plotting  [  1.52039400e+00   1.61713195e+00   1.63536328e+03   4.03835938e+02]
TIMING : CubeStats done  [  8.52000000e-03   8.51988792e-03   1.63536328e+03   4.03835938e+02]
TIMING : CubeStats summary  [  7.49100000e-03   7.48920441e-03   1.63536328e+03   4.03835938e+02]
TIMING : CubeStats END [ 4.466709    2.96026611]
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.46500900e+00   1.60904059e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.023744
TIMING : CubeSum start  [  3.26380000e-02   3.26688290e-02   1.63536328e+03   4.03835938e+02]
TIMING : CubeSum immoments  [  1.09894000e-01   1.26672029e-01   1.63536328e+03   4.03835938e+02]
TIMING : CubeSum statistics  [  1.66550000e-02   1.32989883e-02   1.63536328e+03   4.04062500e+02]
INFO : CubeSum_AT.py : Total flux: 566082.026103 (sum=14491.701723)
REGRESSION : CSM: [566082.02610288782, 14491.701723171689]
TIMING : CubeSum implot  [  1.54042000e-01   5.65622115e+00   1.63536328e+03   4.04429688e+02]
TIMING : CubeSum getdata  [  1.42020000e-02   1.42009258e-02   1.63536328e+03   4.04429688e+02]
TIMING : CubeSum done  [  1.61090000e-01   1.66217089e-01   1.63536328e+03   4.04554688e+02]
TIMING : CubeSum END [ 0.497608    6.01836586]
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.00120900e+00   1.60904060e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  2.10200000e-02   2.10208893e-02   1.63536328e+03   4.04554688e+02]
TIMING : SFind2D imstat  [  9.55220000e-02   3.38761806e-02   1.63536328e+03   4.05046875e+02]
INFO : AT.py : Setting 'sigma' = 3.72718804094 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 3.72719 -0.118073 36.3882 35 0.409714
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  1.23968000e-01   6.91998005e-02   1.63536328e+03   4.05109375e+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:52.480 +47.11.46.04    72.36    72.55       35.3   1.65e+03  97.129  74.478   14.7    9.5
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  8.58590000e-02   8.79101753e-02   1.63536328e+03   4.05109375e+02]
REGRESSION : CONTFLUX: 1 1651.53
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       12.5 arcsec , Minor axis:       12.5 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  1.82203000e-01   1.86988831e-01   1.63536328e+03   4.05546875e+02]
TIMING : SFind2D END [ 0.517115    0.40753794]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  7.609279    10.62676907]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 7.60928 10.6268 ]
INFO : AT.py : Setting 'csub' = [0, 0] for LineSegment_AT
INFO : AT.py : Setting 'smooth' = ['hanning', 5] for LineSegment_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '' (V1.2.4)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  8.66501700e+00   1.60904060e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[71, 81, 398],0.630378
TIMING : CubeSpectrum CubeStats-pos  [  2.93140000e-02   2.93140411e-02   1.63536328e+03   4.05546875e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[73, 72],36.388172
TIMING : CubeSpectrum Moment-pos  [  2.59490000e-02   2.59480476e-02   1.63536328e+03   4.05546875e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('13h29m52.480s', '+47d11m46.04s'),35.283092
TIMING : CubeSpectrum SourceList-pos  [  2.26500000e-02   2.26578712e-02   1.63536328e+03   4.05546875e+02]
TIMING : CubeSpectrum open  [  7.66000000e-03   7.65895844e-03   1.63536328e+03   4.05546875e+02]
TIMING : CubeSpectrum imval  [  2.89610000e-02   2.89630890e-02   1.63536328e+03   4.06000000e+02]
TIMING : CubeSpectrum imhead  [  2.66400000e-02   2.67570019e-02   1.63536328e+03   4.06000000e+02]
TIMING : CubeSpectrum imval  [  1.64693000e-01   1.69785976e-01   1.63536328e+03   4.06054688e+02]
TIMING : CubeSpectrum imval  [  1.60782000e-01   1.65775061e-01   1.63536328e+03   4.06054688e+02]
REGRESSION : CSP: [0.44185879826545715, 0.35489583015441895, 0.63037776947021484]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.87896000e-01   1.92595005e-01   1.63536328e+03   4.06054688e+02]
TIMING : CubeSpectrum summary  [  8.63200000e-03   8.63289833e-03   1.63536328e+03   4.06054688e+02]
TIMING : CubeSpectrum END [ 0.671438    0.68634796]
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 :     smooth :  ['hanning', 5]
INFO :     recalcnoise :  False
INFO :     maxgap :  3
INFO :     csub :  [0, 0]
INFO :     iterate :  True
INFO :     segment :  ADMIT
INFO : 
TIMING : LineSegment ADMIT [  9.37598400e+00   1.60904060e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  1.52660000e-02   1.52719021e-02   1.63536328e+03   4.06054688e+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  [   15.027085      15.02794003  1635.36328125   406.0625    ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
TIMING : LineSegment segment finder  [    2.627517       2.62800097  1635.36328125   406.0625    ]
INFO : LineSegment_AT.py :  Segment Coverage 180 / 689 = 0.261248
REGRESSION : LINESEG: [[115.05199503788872, 115.12714826176925], [114.96295077483093, 114.96528205391522], [114.97111066530222, 114.97538535595187], [114.9948197748959, 114.99637481224114], [115.00687241446286, 115.00842777779518], [115.0177608413256, 115.01892758077577], [115.02553955146738, 115.02670644873804], [115.04226734165464, 115.04343457834786], [115.04732553839611, 115.05004936703605], [115.12675861378861, 115.13221392554428], [115.14741359192952, 115.15092177720214], [115.17275528963781, 115.17587503874759], [115.20747201994892, 115.20981322674115], [115.21995955583306, 115.22230127019282], [115.05822162687427, 115.12130381898668], [115.05861081106363, 115.12520004824086], [115.09286933295692, 115.12597932573979], [115.15404034357483, 115.15559969010577]]
TIMING : LineSegment done  [  1.50715200e+00   1.53476310e+00   1.64867969e+03   4.19535156e+02]
TIMING : LineSegment END [ 19.18459     19.21354485]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 27.660097    30.74881601]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 27.6601 30.7488 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 27.718815    30.83457899]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 27.7188 30.8346 ]
INFO : AT.py : Setting {'vlsr': 463.0} for LineID_AT
INFO : AT.py : Setting 'smooth' = ['hanning', 5] for LineID_AT
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 :     smooth :  ['hanning', 5]
INFO :     recalcnoise :  False
INFO :     vlsr :  463.0
INFO :     maxgap :  3
INFO :     reject :  []
INFO :     method :  {'PeakFinder': {'thresh': 0.0}}
INFO :     mode :  ONE
INFO : 
TIMING : LineID ADMIT [  2.88019470e+01   1.60904062e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 463
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    8.182641       8.18538499  1648.6796875    419.765625  ]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    6.986029       6.98866487  1648.6796875    419.765625  ]
TIMING : LineID segment finder  [  8.72100000e-03   8.71896744e-03   1.64867969e+03   4.19765625e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
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 : Too many peaks in CubeStats for pattern finding to be useful, turning it off.
INFO : LineID_AT.py :  Found line: CH3C6H 74(6)-73(6) @ 115.14159GHz, channels 9 - 15
REGRESSION : LINEID: CH3C6H 115.14159  9 15
INFO : LineID_AT.py :  Found line: CH2CHCNv=0 23(2,21)-23(1,22) @ 115.15061GHz, channels 30 - 41
REGRESSION : LINEID: CH2CHCNv=0 115.15061  30 41
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 91 - 643
REGRESSION : LINEID: CO 115.27120  91 643
INFO : LineID_AT.py :  Found line: U_115.3997  @ 115.399744256GHz, channels 669 - 675
REGRESSION : LINEID: U_115.3997 115.39974  669 675
INFO : LineID_AT.py :  Line Coverage 579 / 689 = 0.840348
TIMING : LineID done  [   11.631471     11.6557591  1757.1328125   529.125    ]
TIMING : LineID END [ 26.81817     26.84783387]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 54.785564    57.96047592]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 54.7856 57.9605 ]
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.58124970e+01   1.60904065e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  2.55569000e-01   5.17778397e-02   1.71569922e+03   4.79996094e+02]
TIMING : LineCube pad  [  1.02153000e-01   1.22740269e-02   1.71569922e+03   4.79996094e+02]
TIMING : LineCube trans-x.CH3C6H_115.14159  [  4.74080000e-02   6.26959801e-02   1.71569922e+03   4.80003906e+02]
TIMING : LineCube trans-x.CH2CHCN_115.15061  [  4.66860000e-02   6.42020702e-02   1.71569922e+03   4.80003906e+02]
TIMING : LineCube trans-x.CO_115.27120  [  8.13990000e-02   9.85269547e-02   1.71751953e+03   4.81699219e+02]
TIMING : LineCube trans-x.U_115.3997  [  4.62790000e-02   6.55620098e-02   1.71751953e+03   4.81699219e+02]
REGRESSION : LC: [4, 20, 25, 46, 86, 648, 664, 680]
TIMING : LineCube done  [  1.59370000e-02   1.59349442e-02   1.71751953e+03   4.81699219e+02]
TIMING : LineCube END [ 0.603173    0.37871504]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CH3C6H_115.14159/lc.im
INFO : AT.py : BDP_OUT[1] = LineCube_BDP x.CH2CHCN_115.15061/lc.im
INFO : AT.py : BDP_OUT[2] = LineCube_BDP x.CO_115.27120/lc.im
INFO : AT.py : BDP_OUT[3] = LineCube_BDP x.U_115.3997/lc.im
TIMING : ADMITrun END [ 55.550687    58.53653693]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 55.5507 58.5365 ]
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 '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 - '@4' (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.67242690e+01   1.60904065e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  2.99530000e-02   2.99599171e-02   1.71751953e+03   4.81699219e+02]
TIMING : Moment immoments-0  [  1.17634000e-01   1.29927158e-01   1.73781641e+03   5.01996094e+02]
TIMING : Moment mom0clip  [  1.09876000e-01   5.73990345e-02   1.73781641e+03   5.02117188e+02]
TIMING : Moment implot  [  1.27717000e-01   2.29545832e-01   1.73781641e+03   5.02175781e+02]
TIMING : Moment getdata  [  1.41020000e-02   1.41010284e-02   1.73781641e+03   5.02175781e+02]
TIMING : Moment ren+mask_0  [  2.20461000e-01   2.24430084e-01   1.73681641e+03   5.01175781e+02]
TIMING : Moment done  [  1.12130000e-02   1.12199783e-02   1.73681641e+03   5.01175781e+02]
TIMING : Moment END [ 0.648304    0.71399999]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@4.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.74194360e+01   1.60904065e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.27180000e-02   3.27188969e-02   1.73681641e+03   5.01175781e+02]
TIMING : Moment immoments-all  [  5.02150000e-02   8.13941956e-02   1.73681641e+03   5.01175781e+02]
TIMING : Moment mom0clip  [  1.06649000e-01   5.22248745e-02   1.73681641e+03   5.01175781e+02]
TIMING : Moment implot  [  1.25872000e-01   2.27735996e-01   1.73681641e+03   5.01175781e+02]
TIMING : Moment getdata  [  1.38780000e-02   1.38771534e-02   1.73681641e+03   5.01175781e+02]
TIMING : Moment ren+mask_0  [  1.76779000e-01   1.80659771e-01   1.73656641e+03   5.00925781e+02]
TIMING : Moment makemask  [  2.00115000e-01   1.26315117e-01   1.73656641e+03   5.01707031e+02]
TIMING : Moment implot  [  4.84500000e-02   1.90310955e-01   1.73656641e+03   5.01707031e+02]
TIMING : Moment getdata  [  1.33110000e-02   1.33090019e-02   1.73656641e+03   5.01707031e+02]
TIMING : Moment ren+mask_1  [  1.76570000e-01   1.80227041e-01   1.73656641e+03   5.01808594e+02]
TIMING : Moment makemask  [  2.05100000e-01   1.25646114e-01   1.73656641e+03   5.01808594e+02]
TIMING : Moment implot  [  4.78140000e-02   1.91204786e-01   1.73656641e+03   5.01808594e+02]
TIMING : Moment getdata  [  1.31560000e-02   1.31549835e-02   1.73656641e+03   5.01808594e+02]
TIMING : Moment ren+mask_2  [  1.67840000e-01   1.71938181e-01   1.73656641e+03   5.01808594e+02]
REGRESSION : MOM0FLUX: x.CH3C6H_115.14159 -20.6547 7.04666 0.0256 462.946 462.946 3.24591
TIMING : Moment mom0flux  [  3.33170000e-02   3.33158970e-02   1.73656641e+03   5.01808594e+02]
TIMING : Moment flux-spectrum  [  2.74332000e-01   1.77886963e-01   1.80056641e+03   5.02187500e+02]
TIMING : Moment done  [  9.72000000e-03   9.71913338e-03   1.80056641e+03   5.02187500e+02]
TIMING : Moment END [ 1.704072    1.82987404]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH3C6H_115.14159/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH3C6H_115.14159/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH3C6H_115.14159/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.91938740e+01   1.60904065e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.10550000e-02   3.10549736e-02   1.80056641e+03   5.02187500e+02]
TIMING : Moment immoments-all  [  5.56430000e-02   8.56740475e-02   1.80056641e+03   5.02187500e+02]
TIMING : Moment mom0clip  [  1.08350000e-01   5.65149784e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment implot  [  1.27510000e-01   2.39264965e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment getdata  [  1.35540000e-02   1.35540962e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment ren+mask_0  [  1.71346000e-01   1.75132036e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment makemask  [  2.02452000e-01   1.31179810e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment implot  [  4.97710000e-02   1.92669153e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment getdata  [  1.32460000e-02   1.32458210e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment ren+mask_1  [  1.71520000e-01   1.74834013e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment makemask  [  2.04600000e-01   1.34253979e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment implot  [  6.26870000e-02   2.12066174e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment getdata  [  1.35840000e-02   1.35819912e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment ren+mask_2  [  1.68942000e-01   1.72746897e-01   1.80056641e+03   5.02425781e+02]
REGRESSION : MOM0FLUX: x.CH2CHCN_115.15061 -1.28411 13.907 0.0256 460.749 460.749 2.76808
TIMING : Moment mom0flux  [  3.43800000e-02   3.43790054e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment flux-spectrum  [  2.74908000e-01   1.76594019e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment done  [  9.76200000e-03   9.76014137e-03   1.80056641e+03   5.02425781e+02]
TIMING : Moment END [ 1.721382    1.87457705]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH2CHCN_115.15061/lc-@1.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH2CHCN_115.15061/lc-@1.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH2CHCN_115.15061/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 [  6.09866730e+01   1.60904065e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.16970000e-02   3.16967964e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment immoments-all  [  1.19865000e-01   1.50618076e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment mom0clip  [  1.09256000e-01   5.51691055e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment implot  [  1.26788000e-01   2.41339922e-01   1.80056641e+03   5.02425781e+02]
TIMING : Moment getdata  [  1.41050000e-02   1.41038895e-02   1.80056641e+03   5.02425781e+02]
TIMING : Moment ren+mask_0  [  1.68524000e-01   1.72520161e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment makemask  [  2.02596000e-01   1.27251863e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment implot  [  4.83630000e-02   1.93663120e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment getdata  [  1.31230000e-02   1.31230354e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment ren+mask_1  [  1.74818000e-01   1.78335905e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment makemask  [  2.05375000e-01   1.31124973e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment implot  [  5.17780000e-02   1.99224949e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment getdata  [  1.31700000e-02   1.31711960e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment ren+mask_2  [  1.72323000e-01   1.76309824e-01   1.80031641e+03   5.02175781e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 20217.6 11353.5 0.0256 466.131 466.131 42.2927
TIMING : Moment mom0flux  [  3.40830000e-02   3.40821743e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment flux-spectrum  [  8.94550000e-01   2.95496941e-01   1.80031641e+03   5.02175781e+02]
TIMING : Moment done  [  1.04970000e-02   1.05059147e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment END [ 2.399743    2.04656982]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CO_115.27120/lc-@2.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CO_115.27120/lc-@2.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CO_115.27120/lc-@2.mom_2
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@3' (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.34710050e+01   1.60904066e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.45600000e-02   3.45602036e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment immoments-all  [  5.08180000e-02   8.47928524e-02   1.80031641e+03   5.02175781e+02]
TIMING : Moment mom0clip  [  1.08459000e-01   5.56960106e-02   1.80031641e+03   5.02191406e+02]
TIMING : Moment implot  [  1.28094000e-01   2.41528034e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment getdata  [  1.38910000e-02   1.38909817e-02   1.80031641e+03   5.02191406e+02]
TIMING : Moment ren+mask_0  [  1.73498000e-01   1.76931143e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment makemask  [  2.01810000e-01   1.26476765e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment implot  [  4.83680000e-02   1.89740181e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment getdata  [  1.36620000e-02   1.36618614e-02   1.80031641e+03   5.02191406e+02]
TIMING : Moment ren+mask_1  [  1.79045000e-01   1.82780981e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment makemask  [  2.02873000e-01   1.26044035e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment implot  [  4.92780000e-02   1.91816092e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment getdata  [  1.39450000e-02   1.39460564e-02   1.80031641e+03   5.02191406e+02]
TIMING : Moment ren+mask_2  [  1.67736000e-01   1.71466827e-01   1.80031641e+03   5.02191406e+02]
REGRESSION : MOM0FLUX: x.U_115.3997 -22.3847 14.4759 0.0256 463.959 463.959 3.43299
TIMING : Moment mom0flux  [  3.41610000e-02   3.41610909e-02   1.80031641e+03   5.02191406e+02]
TIMING : Moment flux-spectrum  [  2.71958000e-01   1.75460100e-01   1.80031641e+03   5.02191406e+02]
TIMING : Moment done  [  9.81800000e-03   9.81497765e-03   1.80031641e+03   5.02191406e+02]
TIMING : Moment END [ 1.710288    1.85108209]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.U_115.3997/lc-@3.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.U_115.3997/lc-@3.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.U_115.3997/lc-@3.mom_2
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@1' (V1.2.4)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  6.52521870e+01   1.60904066e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[100, 30],0.195546
TIMING : CubeSpectrum Moment-pos  [  3.66790000e-02   3.66790295e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum open  [  8.74100000e-03   8.74114037e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imval  [  2.72790000e-02   2.72808075e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imhead  [  3.16090000e-02   3.16281319e-02   1.80031641e+03   5.02191406e+02]
REGRESSION : CSP: [0.079936675727367401]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.87884000e-01   1.91722870e-01   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum summary  [  8.51700000e-03   8.51607323e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum END [ 0.308977    0.31283498]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH3C6H_115.14159/lc-@1.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@2' (V1.2.4)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  6.56018370e+01   1.60904066e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[119, 65],0.276940
TIMING : CubeSpectrum Moment-pos  [  3.79950000e-02   3.79960537e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum open  [  8.53600000e-03   8.53610039e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imval  [  2.48680000e-02   2.48699188e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imhead  [  2.97670000e-02   2.97679901e-02   1.80031641e+03   5.02191406e+02]
REGRESSION : CSP: [0.065253660082817078]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.75392000e-01   1.79316044e-01   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum summary  [  8.44400000e-03   8.44287872e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum END [ 0.293442  0.297369]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH2CHCN_115.15061/lc-@2.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@3' (V1.2.4)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  6.59356500e+01   1.60904066e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[73, 72],37.316792
TIMING : CubeSpectrum Moment-pos  [  3.71320000e-02   3.71332169e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum open  [  8.47600000e-03   8.48293304e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imval  [  2.90240000e-02   2.90250778e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imhead  [  2.99400000e-02   3.09360027e-02   1.80031641e+03   5.02191406e+02]
REGRESSION : CSP: [0.44185879826545715]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.79011000e-01   1.83400869e-01   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum summary  [  7.94500000e-03   7.94291496e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum END [ 0.299544    0.30494308]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@3.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@4' (V1.2.4)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  6.62757320e+01   1.60904066e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[29, 54],0.230881
TIMING : CubeSpectrum Moment-pos  [  4.72900000e-02   4.73098755e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum open  [  8.99800000e-03   8.99720192e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imval  [  2.63600000e-02   2.63729095e-02   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum imhead  [  3.00560000e-02   3.00550461e-02   1.80031641e+03   5.02191406e+02]
REGRESSION : CSP: [0.072296738624572754]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.71128000e-01   1.78529978e-01   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum summary  [  8.59800000e-03   8.59785080e-03   1.80031641e+03   5.02191406e+02]
TIMING : CubeSpectrum END [ 0.300964    0.30839586]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.U_115.3997/lc-@4.csp