INFO : AT.py : Setting {'basename': 'x', 'file': 'M31_85778.fits'} for Ingest_AT
INFO : AT.py : Setting 'vlsr' = -296.0 for Ingest_AT
INFO : AT.py : Setting 'box' = [20, 20, 70, 70] 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 :  [20, 20, 70, 70]
INFO :     file :  M31_85778.fits
INFO :     smooth :  []
INFO :     basename :  x
INFO :     mask :  True
INFO :     pb :  
INFO :     edge :  []
INFO :     restfreq :  -1.0
INFO :     vlsr :  -296.0
INFO :     usepb :  True
INFO : 
TIMING : Ingest ADMIT [  1.27356000e+00   1.60824708e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  2.73742000e-01   1.66448116e-01   1.09024219e+03   2.15503906e+02]
TIMING : Ingest importfits  [  1.23002000e-01   1.32749081e-01   1.09076562e+03   2.16785156e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  6.27210000e-02   7.33838081e-02   1.09841406e+03   2.25007812e+02]
TIMING : Ingest summary-0  [  1.24490000e-02   1.24490261e-02   1.09841406e+03   2.25007812e+02]
WARNING : Ingest_AT.py : no extra mask created because input image already had one
INFO : Ingest_AT.py : box=[20, 20, 70, 70] edge=[] processing with SHAPE: [ 91  91 689   1]
INFO : Ingest_AT.py : SUBIMAGE
TIMING : Ingest subimage-1  [  1.04966000e-01   1.14729166e-01   1.09841406e+03   2.25363281e+02]
TIMING : Ingest summary-1  [  1.10220000e-02   1.10199451e-02   1.09841406e+03   2.25363281e+02]
TIMING : Ingest statistics  [  2.02790000e-02   2.03008652e-02   1.14547656e+03   2.33281250e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 11.000001600000001, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 11.000001600000001, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [ 51  51 689   1] 1792089 -0.840157 1.664312
INFO : Ingest_AT.py : S/N (all data): 12.341230
INFO : Ingest_AT.py : GOOD PIXELS: 1792089/1792089 (100.000000% good or 0.000000% bad)
REGRESSION : CUBE: -0.840157 1.66431 0.134858  51 51 689  0.000000
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: Region_J-K
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 = -296.000000 (from source catalog)
INFO : Ingest_AT.py : VLSRz: 1 values: 0.000000 +/- 0.000000   [ 0.]
INFO : Ingest_AT.py : RA   Axis 1: 10.648750 -5.500001 25.000000
INFO : Ingest_AT.py : DEC  Axis 2: 41.513700 5.500001 25.000000
INFO : Ingest_AT.py : Freq Orig Axis 3: 115.24 0.000391328 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.017749 km/s @ fc=115.374915 fw=0.269625 GHz
INFO : Ingest_AT.py : Freq Binn Axis 3: 115.24 0.000391328 0
INFO : Ingest_AT.py : Cube Binn Axis 3: type=Frequency  velocity increment=-1.017749 km/s @ fc=115.374915 fw=0.269625 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= -269.728346  VLSRw= -701.228730  VLSRf= 0.000000 VLSRz= 0.000000 VLSR= -296.000000
TIMING : Ingest done  [  5.94433000e-01   3.96920204e-01   1.14847656e+03   2.36718750e+02]
TIMING : Ingest END [ 1.21398    0.9393661]
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.53924500e+00   1.60824708e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.80760000e-02   5.80768585e-02   1.14722656e+03   2.35710938e+02]
TIMING : CubeStats start  [  1.39940000e-02   1.40011311e-02   1.14722656e+03   2.35710938e+02]
TIMING : CubeStats imstat0  [  4.82760000e-01   1.11412048e-01   1.62016016e+03   2.86628906e+02]
TIMING : CubeStats imstat1  [  2.39067000e-01   6.31909370e-02   1.62016016e+03   2.86628906e+02]
INFO : CubeStats_AT.py : sigma varies from 0.113176 to 0.153578; 689/689 channels ok
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  6.59113000e-01   6.59134865e-01   1.62016016e+03   2.86628906e+02]
INFO : CubeStats_AT.py : CubeMax: 1.664312 @ [ 10  38 336   0]
INFO : CubeStats_AT.py : CubeMin: -0.840157 @ [ 0  1 12  0]
INFO : CubeStats_AT.py : CubeRMS: 0.129541
INFO : CubeStats_AT.py : RMS Sanity check 1.041045
REGRESSION : CST: 0.129541 1.041045
INFO : CubeStats_AT.py : mean,rms,S/N=0.003310 0.129541 12.847777
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.818926 1.559878
TIMING : CubeStats plotting  [    1.658176       1.76227808  1626.04296875   294.55859375]
TIMING : CubeStats done  [  9.49400000e-03   9.49192047e-03   1.62604297e+03   2.94558594e+02]
TIMING : CubeStats summary  [  8.09800000e-03   8.09717178e-03   1.62604297e+03   2.94558594e+02]
TIMING : CubeStats END [ 3.136875    2.69378686]
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 [  5.71554300e+00   1.60824708e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.129541
TIMING : CubeSum start  [  3.48670000e-02   3.48689556e-02   1.62604297e+03   2.94558594e+02]
TIMING : CubeSum immoments  [  3.75300000e-02   5.15611172e-02   1.62604297e+03   2.94558594e+02]
TIMING : CubeSum statistics  [  1.38320000e-02   1.38330460e-02   1.62604297e+03   2.94558594e+02]
INFO : CubeSum_AT.py : Total flux: 54249.309605 (sum=1793.365085)
REGRESSION : CSM: [54249.309604601716, 1793.3650850574486]
TIMING : CubeSum implot  [  1.02253000e-01   5.65699697e+00   1.69804688e+03   2.94839844e+02]
TIMING : CubeSum getdata  [  1.43520000e-02   1.43508911e-02   1.69804688e+03   2.94839844e+02]
TIMING : CubeSum done  [  1.58899000e-01   1.62814140e-01   1.69804688e+03   2.94957031e+02]
TIMING : CubeSum END [ 0.370654    5.94334507]
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 [  6.12390700e+00   1.60824709e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  2.04360000e-02   2.04370022e-02   1.69804688e+03   2.94957031e+02]
TIMING : SFind2D imstat  [  3.00870000e-02   3.00869942e-02   1.69804688e+03   2.94957031e+02]
INFO : AT.py : Setting 'sigma' = 2.58525338841 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 2.58525 -2.85213 20.2945 35 0.509548
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  6.56200000e-02   6.92481995e-02   1.69804688e+03   2.95539062e+02]
INFO : SFind2D_AT.py : Right Ascen.  Declination   X(pix)   Y(pix)      Peak       Flux    Major   Minor    PA    SNR
INFO : SFind2D_AT.py :                                                K.km/s       Jy    arcsec   arcsec   deg
INFO : SFind2D_AT.py : 00:42:39.474 +41.32.07.16    17.29    39.16       18.7       99.8  42.836  14.475   57.6    7.2
INFO : SFind2D_AT.py : 00:42:29.691 +41.28.55.20    37.28     4.25       13.1       85.7  27.500  27.500  180.0    5.1
INFO : SFind2D_AT.py : 00:42:29.685 +41.29.00.04    37.29     5.13       12.7        103  43.559  20.876   27.9    4.9
INFO : SFind2D_AT.py : 00:42:39.402 +41.32.07.03    17.44    39.13       18.7       87.7  37.564  13.356   52.3    7.2
INFO : SFind2D_AT.py : 00:42:41.974 +41.32.10.00    12.19    39.67        5.6       82.5  45.619  25.546  120.5    2.2
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  1.62169000e-01   1.63784027e-01   1.69804688e+03   2.95539062e+02]
REGRESSION : CONTFLUX: 5 458.749
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:         11 arcsec , Minor axis:         11 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  1.80781000e-01   1.87025785e-01   1.69804688e+03   2.95632812e+02]
TIMING : SFind2D END [ 0.468028    0.47951603]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  5.60798     10.50017309]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 5.60798 10.5002 ]
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 [  6.74590800e+00   1.60824709e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[10, 38, 336],1.664312
TIMING : CubeSpectrum CubeStats-pos  [  3.07460000e-02   3.07471752e-02   1.69804688e+03   2.95632812e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[17, 40],20.294487
TIMING : CubeSpectrum Moment-pos  [  2.74530000e-02   2.74629593e-02   1.69804688e+03   2.95632812e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('00h42m39.474s', '+41d32m07.16s'),18.743057
TIMING : CubeSpectrum SourceList-pos  [  2.30450000e-02   2.30438709e-02   1.69804688e+03   2.95632812e+02]
TIMING : CubeSpectrum open  [  7.88300000e-03   7.88307190e-03   1.69804688e+03   2.95632812e+02]
TIMING : CubeSpectrum imval  [  3.02490000e-02   3.02500725e-02   1.69804688e+03   2.96003906e+02]
TIMING : CubeSpectrum imhead  [  2.74430000e-02   2.74438858e-02   1.69804688e+03   2.96003906e+02]
TIMING : CubeSpectrum imval  [  1.58322000e-01   1.63074970e-01   1.69804688e+03   2.96003906e+02]
TIMING : CubeSpectrum imval  [  1.82132000e-01   1.86585188e-01   1.69804688e+03   2.96066406e+02]
REGRESSION : CSP: [1.4463015794754028, 1.4617654085159302, 1.6643116474151611]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.91365000e-01   1.96309805e-01   1.69804688e+03   2.96066406e+02]
TIMING : CubeSpectrum summary  [  8.93400000e-03   8.93402100e-03   1.69804688e+03   2.96066406e+02]
TIMING : CubeSpectrum END [ 0.696809    0.71097302]
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 [  7.48226900e+00   1.60824709e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  1.54740000e-02   1.54750347e-02   1.69804688e+03   2.96066406e+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  [   19.687285      19.71860504  1698.046875     296.12890625]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
TIMING : LineSegment segment finder  [    3.083957       3.08491087  1698.046875     296.12890625]
INFO : LineSegment_AT.py :  Segment Coverage 38 / 689 = 0.0551524
REGRESSION : LINESEG: [[115.28755837881249, 115.29107510896795], [115.36380226419207, 115.3861079893781], [115.3978513096984, 115.39902577320002], [115.30436247045759, 115.30514417533745], [115.24381256632485, 115.2453743451025], [115.24693616621106, 115.25084090419136], [115.31374362861006, 115.31491638071235], [115.34619857197193, 115.34776312706191], [115.44563211493208, 115.44719936863491], [115.46522584519839, 115.46718558403605], [115.47384919370873, 115.47502520466702], [115.36693237202013, 115.38023722545576], [115.36693237202013, 115.37906314435865], [115.3657585616799, 115.37397573570451]]
TIMING : LineSegment done  [    1.810284       1.83854103  1724.14453125   322.484375  ]
TIMING : LineSegment END [ 24.606716    24.66724896]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 31.12881     36.12994313]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 31.1288 36.1299 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 31.207992    36.24169397]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 31.208 36.2417 ]
INFO : AT.py : Setting {'vlsr': -296.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 :  -296.0
INFO :     maxgap :  3
INFO :     reject :  []
INFO :     method :  {'PeakFinder': {'thresh': 0.0}}
INFO :     mode :  ONE
INFO : 
TIMING : LineID ADMIT [  3.23941690e+01   1.60824711e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = -296
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [   11.182537      11.18299317  1724.14453125   322.72265625]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [   10.921868      10.92247796  1724.14453125   322.72265625]
TIMING : LineID segment finder  [  1.02010000e-02   1.02000237e-02   1.72414453e+03   3.22722656e+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 : utils.py : Gaussian fit attempted with only three points, look at the covariance for goodness of fit.
INFO : LineID_AT.py :  Found line: H2CCCHCN 22(1,21)-21(1,20) @ 115.13031GHz, channels 9 - 13
REGRESSION : LINEID: H2CCCHCN 115.13031  9 13
INFO : LineID_AT.py :  Found line: CH3C5N 74(0)-73(0),F=75-74 @ 115.13571GHz, channels 17 - 27
REGRESSION : LINEID: CH3C5N 115.13571  17 27
INFO : LineID_AT.py :  Found line: CH3C5N 74(0)-73(0),F=73-72 @ 115.13571GHz, channels 17 - 27
WARNING : LineID_AT.py :  Skipping duplicate UID: CH3C5N_115.13571
INFO : LineID_AT.py :  Found line: CH3C5N 74(0)-73(0),F=74-73 @ 115.13571GHz, channels 17 - 27
WARNING : LineID_AT.py :  Skipping duplicate UID: CH3C5N_115.13571
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 121 - 600
REGRESSION : LINEID: CO 115.27120  121 600
INFO : LineID_AT.py :  Line Coverage 496 / 689 = 0.719884
TIMING : LineID done  [   12.702536      12.72565603  1830.41015625   430.0703125 ]
TIMING : LineID END [ 34.829976    34.85416007]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 66.31765     71.40746498]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 66.3177 71.4075 ]
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 [  6.74292780e+01   1.60824715e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  3.35460000e-02   3.12900543e-02   1.79464453e+03   3.94488281e+02]
TIMING : LineCube pad  [  1.08976000e-01   1.29380226e-02   1.79464453e+03   3.94488281e+02]
TIMING : LineCube trans-x.H2CCCHCN_115.13031  [  5.20380000e-02   6.77490234e-02   1.79464453e+03   3.94488281e+02]
TIMING : LineCube trans-x.CH3C5N_115.13571  [  5.35720000e-02   6.70690536e-02   1.79464453e+03   3.94488281e+02]
TIMING : LineCube trans-x.CO_115.27120  [  5.30860000e-02   6.65209293e-02   1.79464453e+03   3.94488281e+02]
REGRESSION : LC: [4, 18, 12, 32, 116, 605]
TIMING : LineCube done  [  1.76680000e-02   1.76661015e-02   1.79464453e+03   3.94488281e+02]
TIMING : LineCube END [ 0.327389    0.27173615]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.H2CCCHCN_115.13031/lc.im
INFO : AT.py : BDP_OUT[1] = LineCube_BDP x.CH3C5N_115.13571/lc.im
INFO : AT.py : BDP_OUT[2] = LineCube_BDP x.CO_115.27120/lc.im
TIMING : ADMITrun END [ 66.792963    71.86469793]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 66.793 71.8647 ]
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 - '@3' (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.80368360e+01   1.60824715e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.66740000e-02   3.66749763e-02   1.79464453e+03   3.94488281e+02]
TIMING : Moment immoments-0  [  5.19520000e-02   6.44910336e-02   1.79464453e+03   3.94488281e+02]
TIMING : Moment mom0clip  [  5.08190000e-02   5.95850945e-02   1.79464453e+03   3.94957031e+02]
TIMING : Moment implot  [  7.22060000e-02   2.53085852e-01   1.79464453e+03   3.95082031e+02]
TIMING : Moment getdata  [  1.37050000e-02   1.37059689e-02   1.79464453e+03   3.95082031e+02]
TIMING : Moment ren+mask_0  [  2.28057000e-01   2.31280088e-01   1.79840625e+03   3.98843750e+02]
TIMING : Moment done  [  1.26140000e-02   1.26180649e-02   1.79840625e+03   3.98843750e+02]
TIMING : Moment END [ 0.477449   0.6829381]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@3.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.85561890e+01   1.60824715e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.24740000e-02   3.24850082e-02   1.79840625e+03   3.98843750e+02]
TIMING : Moment immoments-all  [  4.05870000e-02   7.15889931e-02   1.79840625e+03   3.98843750e+02]
TIMING : Moment mom0clip  [  4.63720000e-02   5.59821129e-02   1.79840625e+03   3.98843750e+02]
TIMING : Moment implot  [  6.61620000e-02   2.28802919e-01   1.79840625e+03   3.98843750e+02]
TIMING : Moment getdata  [  1.39170000e-02   1.39160156e-02   1.79840625e+03   3.98843750e+02]
TIMING : Moment ren+mask_0  [  1.78372000e-01   1.81913853e-01   1.79790625e+03   3.98343750e+02]
TIMING : Moment makemask  [  7.79850000e-02   1.28512144e-01   1.79790625e+03   3.98343750e+02]
TIMING : Moment implot  [  5.48830000e-02   2.07738876e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.32660000e-02   1.32670403e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_1  [  1.64465000e-01   1.67983055e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment makemask  [  8.02900000e-02   1.26841068e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  5.15970000e-02   2.01511860e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.33570000e-02   1.33559704e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_2  [  1.81289000e-01   1.84514999e-01   1.79790625e+03   3.99140625e+02]
REGRESSION : MOM0FLUX: x.H2CCCHCN_115.13031 -196.361 4.59451 0.0330578 -297.43 -297.43 3.12604
TIMING : Moment mom0flux  [  3.47220000e-02   3.47220898e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment flux-spectrum  [  2.94492000e-01   1.94221973e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment done  [  1.06390000e-02   1.06379986e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment END [ 1.363549    1.87667489]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.H2CCCHCN_115.13031/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.H2CCCHCN_115.13031/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.H2CCCHCN_115.13031/lc.mom_2
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@1' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  6.99947110e+01   1.60824715e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.29310000e-02   3.29301357e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment immoments-all  [  4.15970000e-02   7.15010166e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment mom0clip  [  5.04110000e-02   6.23488426e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  6.81860000e-02   2.41008997e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.36010000e-02   1.36010647e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_0  [  1.78112000e-01   1.81123018e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment makemask  [  8.41390000e-02   1.32220030e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  5.22610000e-02   2.17470884e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.38970000e-02   1.39400959e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_1  [  1.88049000e-01   1.91452026e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment makemask  [  9.04990000e-02   1.37965918e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  5.33920000e-02   2.11614132e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.33510000e-02   1.33519173e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_2  [  1.67057000e-01   1.69932127e-01   1.79790625e+03   3.99140625e+02]
REGRESSION : MOM0FLUX: x.CH3C5N_115.13571 -372.31 9.94685 0.0330578 -294.873 -294.873 4.53233
TIMING : Moment mom0flux  [  3.36620000e-02   3.36608887e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment flux-spectrum  [  2.91190000e-01   1.88299894e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment done  [  1.14160000e-02   1.14150047e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment END [ 1.397847    1.93793201]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH3C5N_115.13571/lc-@1.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH3C5N_115.13571/lc-@1.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH3C5N_115.13571/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 [  7.14730770e+01   1.60824715e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  3.51520000e-02   3.51529121e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment immoments-all  [  4.79410000e-02   7.61110783e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment mom0clip  [  4.89580000e-02   5.95428944e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  6.85510000e-02   2.46721029e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.40570000e-02   1.40581131e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_0  [  1.83403000e-01   1.86371803e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment makemask  [  8.70210000e-02   1.33261204e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  5.48270000e-02   2.14702845e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.45290000e-02   1.45289898e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_1  [  1.68990000e-01   1.72620058e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment makemask  [  8.94720000e-02   1.37701988e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment implot  [  5.30690000e-02   2.30329990e-01   1.79790625e+03   3.99140625e+02]
TIMING : Moment getdata  [  1.40430000e-02   1.40430927e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment ren+mask_2  [  1.77078000e-01   1.82890892e-01   1.79790625e+03   3.99140625e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 4086.54 2195.11 0.0330578 -258.582 -258.582 26.5006
TIMING : Moment mom0flux  [  3.53830000e-02   3.54349613e-02   1.79790625e+03   3.99140625e+02]
TIMING : Moment flux-spectrum  [  3.69725000e-01   2.31691122e-01   1.79790625e+03   3.99144531e+02]
TIMING : Moment done  [  1.01560000e-02   1.01890564e-02   1.79790625e+03   3.99144531e+02]
TIMING : Moment END [ 1.481004    2.00400186]
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 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 [  7.30349430e+01   1.60824715e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[0, 21],1.133288
TIMING : CubeSpectrum Moment-pos  [  3.98910000e-02   3.98879051e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum open  [  8.79300000e-03   8.79406929e-03   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imval  [  2.91460000e-02   2.92458534e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imhead  [  3.83770000e-02   3.85391712e-02   1.79790625e+03   3.99144531e+02]
REGRESSION : CSP: [0.43062615394592285]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.88623000e-01   1.91974878e-01   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum summary  [  8.46700000e-03   8.46815109e-03   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum END [ 0.321814    0.32542586]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.H2CCCHCN_115.13031/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 [  7.33979760e+01   1.60824715e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[6, 0],1.482431
TIMING : CubeSpectrum Moment-pos  [  3.77690000e-02   3.77678871e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum open  [  1.25400000e-02   1.25410557e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imval  [  2.77110000e-02   2.78220177e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imhead  [  3.31670000e-02   3.32269669e-02   1.79790625e+03   3.99144531e+02]
REGRESSION : CSP: [0.50631368160247803]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.84506000e-01   1.87998056e-01   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum summary  [  1.05040000e-02   1.05848312e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum END [ 0.315083    0.31882691]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH3C5N_115.13571/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 [  7.37607870e+01   1.60824716e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[17, 40],24.087542
TIMING : CubeSpectrum Moment-pos  [  4.10270000e-02   4.10859585e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum open  [  9.88300000e-03   9.99689102e-03   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imval  [  3.01980000e-02   3.02710533e-02   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum imhead  [  3.14010000e-02   3.14011574e-02   1.79790625e+03   3.99144531e+02]
REGRESSION : CSP: [1.4617654085159302]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  1.91944000e-01   1.97985888e-01   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum summary  [  8.77400000e-03   8.78596306e-03   1.79790625e+03   3.99144531e+02]
TIMING : CubeSpectrum END [ 0.321627    0.32792592]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@3.csp