INFO : AT.py : Setting {'basename': 'x', 'file': 'SEXTANS-A_92178.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 :  SEXTANS-A_92178.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.12890500e+00   1.64394519e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: SEXTANS-A   SHAPE: [ 55  55 689]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  1.69510000e-01   1.75691843e-01   1.41056250e+03   2.17437500e+02]
TIMING : Ingest importfits  [  1.10074000e-01   1.48469210e-01   1.41057812e+03   2.18570312e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  5.60680000e-02   1.44059896e-01   1.41308594e+03   2.22105469e+02]
TIMING : Ingest summary-0  [  1.43520000e-02   1.44109726e-02   1.41308594e+03   2.22105469e+02]
TIMING : Ingest mask  [  2.82610000e-02   7.95869827e-02   1.41308594e+03   2.22105469e+02]
TIMING : Ingest summary-1  [  1.37680000e-02   1.75759792e-02   1.41308594e+03   2.22105469e+02]
TIMING : Ingest statistics  [  4.85900000e-02   4.87260818e-02   1.41113281e+03   2.21308594e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 12.6500004, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 12.6500004, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [ 55  55 689   1] 1933334 -0.054728 0.049264
INFO : Ingest_AT.py : S/N (all data): 6.611284
INFO : Ingest_AT.py : GOOD PIXELS: 1933334/2084225 (92.760331% good or 7.239669% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.0547278 0.049264 0.0074515  55 55 689  7.239669
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: SEXTANS-A
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 152.783800 -5.500001 27.000000
INFO : Ingest_AT.py : DEC  Axis 2: -4.704639 5.500001 27.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: 115.016 0.000390625 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=-1.015921 km/s @ fc=115.149890 fw=0.269141 GHz
INFO : Ingest_AT.py : RESTFREQ: 115.271 115.271 -1
INFO : Ingest_AT.py : VLSRc= 315.507976  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= -699.969569
INFO : Ingest_AT.py : VLSR = 315.507976 errs = 0.000000 0.000000 0.000000 width = -1.015921
TIMING : Ingest done  [  5.66046000e-01   5.70800066e-01   1.41468750e+03   2.25140625e+02]
TIMING : Ingest END [ 1.018814    1.21149993]
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.20864700e+00   1.64394519e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.22320000e-02   5.24690151e-02   1.41393750e+03   2.24472656e+02]
TIMING : CubeStats start  [  1.24980000e-02   1.25370026e-02   1.41393750e+03   2.24472656e+02]
TIMING : CubeStats imstat0  [  1.30524000e-01   1.30988121e-01   1.43180078e+03   2.43136719e+02]
TIMING : CubeStats imstat1  [  1.55977000e-01   1.56486988e-01   1.43452344e+03   2.45703125e+02]
INFO : CubeStats_AT.py : sigma varies from 0.003737 to 0.007778; 689/689 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.00747418 (2.08117 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  7.67773000e-01   7.70521879e-01   1.43452344e+03   2.45804688e+02]
INFO : CubeStats_AT.py : CubeMax: 0.049264 @ [27 13  7  0]
INFO : CubeStats_AT.py : CubeMin: -0.054728 @ [45 36 20  0]
INFO : CubeStats_AT.py : CubeRMS: 0.005816
INFO : CubeStats_AT.py : RMS Sanity check 1.281288
REGRESSION : CST: 0.005816 1.281288
INFO : CubeStats_AT.py : mean,rms,S/N=-0.000073 0.005816 8.470955
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 2.064873 2.113700
TIMING : CubeStats plotting  [    2.467371       2.64024401  1458.421875     267.98046875]
TIMING : CubeStats done  [  1.38230000e-02   1.38590336e-02   1.45842188e+03   2.67980469e+02]
TIMING : CubeStats summary  [  1.22040000e-02   1.22520924e-02   1.45842188e+03   2.67980469e+02]
TIMING : CubeStats END [ 3.624522   3.8015151]
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 [  6.89300200e+00   1.64394519e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.005816
TIMING : CubeSum start  [  5.19970000e-02   5.21459579e-02   1.45842188e+03   2.67984375e+02]
TIMING : CubeSum immoments  [  6.19730000e-02   1.68875933e-01   1.45842188e+03   2.68308594e+02]
TIMING : CubeSum statistics  [  1.99210000e-02   1.99921131e-02   1.45842188e+03   2.68308594e+02]
INFO : CubeSum_AT.py : Total flux: 247.350769 (sum=8.176883)
REGRESSION : CSM: [247.35076858734689, 8.1768825332487722]
TIMING : CubeSum implot  [  1.45572000e-01   6.07488298e+00   1.53042578e+03   2.68335938e+02]
TIMING : CubeSum getdata  [  2.12400000e-02   2.13129520e-02   1.53042578e+03   2.68335938e+02]
TIMING : CubeSum done  [  2.44638000e-01   2.63170004e-01   1.53042578e+03   2.68402344e+02]
TIMING : CubeSum END [ 0.558954    6.61402607]
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 [  7.51247900e+00   1.64394520e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.88300000e-02   3.89420986e-02   1.53042578e+03   2.68402344e+02]
TIMING : SFind2D imstat  [  4.08270000e-02   4.10468578e-02   1.53042578e+03   2.68402344e+02]
INFO : AT.py : Setting 'sigma' = 0.0989128875578 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 0.0989129 -1.32751 1.22581 35 0.322768
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  1.01444000e-01   1.09094143e-01   1.53042578e+03   2.68703125e+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 : 10:11:09.001 -04.41.18.31    24.58    37.62       1.12       3.74  31.315  14.240   86.9   11.3
INFO : SFind2D_AT.py : 10:11:09.025 -04.43.33.63    24.52    13.01       1.11       3.98  35.848  14.314   88.8   11.2
INFO : SFind2D_AT.py : 10:11:09.188 -04.41.18.15    24.08    37.65       1.12       4.54  39.793  14.037   86.5   11.3
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  1.82320000e-01   1.86697006e-01   1.53042578e+03   2.69128906e+02]
REGRESSION : CONTFLUX: 3 12.2657
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       12.7 arcsec , Minor axis:       12.7 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  3.02992000e-01   3.21878910e-01   1.53042578e+03   2.69167969e+02]
TIMING : SFind2D END [ 0.679842    0.71115804]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  6.479832    13.03078914]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 6.47983 13.0308 ]
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 [  8.40765900e+00   1.64394520e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[27, 13, 7],0.049264
TIMING : CubeSpectrum CubeStats-pos  [  4.84350000e-02   4.85570431e-02   1.53042578e+03   2.69167969e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[24, 38],1.225808
TIMING : CubeSpectrum Moment-pos  [  4.19980000e-02   4.21228409e-02   1.53042578e+03   2.69167969e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('10h11m09.001s', '-04d41m18.31s'),1.116341
TIMING : CubeSpectrum SourceList-pos  [  3.62570000e-02   3.63481045e-02   1.53042578e+03   2.69167969e+02]
TIMING : CubeSpectrum open  [  1.22950000e-02   1.23300552e-02   1.53042578e+03   2.69167969e+02]
TIMING : CubeSpectrum imval  [  4.38650000e-02   4.40709591e-02   1.53042578e+03   2.69523438e+02]
TIMING : CubeSpectrum imhead  [  4.18910000e-02   4.20398712e-02   1.53042578e+03   2.69523438e+02]
TIMING : CubeSpectrum imval  [  2.60725000e-01   2.79235125e-01   1.53042578e+03   2.69667969e+02]
TIMING : CubeSpectrum imval  [  2.63243000e-01   2.82296896e-01   1.53042578e+03   2.69667969e+02]
REGRESSION : CSP: [0.047215290367603302, 0.044647514820098877, 0.049263976514339447]
INFO : CubeSpectrum_AT.py : Writing 3 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.93185000e-01   3.12077999e-01   1.53042578e+03   2.69667969e+02]
TIMING : CubeSpectrum summary  [  1.23440000e-02   1.23770237e-02   1.53042578e+03   2.69667969e+02]
TIMING : CubeSpectrum END [ 1.066419    1.12366986]
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 [  9.53448100e+00   1.64394520e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.43430000e-02   2.44069099e-02   1.53042578e+03   2.69667969e+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  [   31.012602      31.08656812  1530.42578125   270.0546875 ]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [0, 36]
WARNING : specutil.py : 1 [104, 109]
WARNING : specutil.py : 2 [210, 219]
WARNING : specutil.py : 3 [230, 234]
WARNING : specutil.py : 4 [243, 246]
WARNING : specutil.py : 0 [0, 35]
WARNING : specutil.py : 1 [102, 109]
WARNING : specutil.py : 2 [210, 219]
WARNING : specutil.py : 3 [243, 246]
WARNING : specutil.py : 4 [382, 385]
WARNING : specutil.py : 0 [0, 40]
WARNING : specutil.py : 1 [124, 127]
WARNING : specutil.py : 2 [179, 183]
WARNING : specutil.py : 3 [209, 212]
WARNING : specutil.py : 4 [225, 228]
WARNING : specutil.py : 5 [479, 483]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [0, 9]
WARNING : specutil.py : 1 [17, 20]
WARNING : specutil.py : 2 [26, 32]
WARNING : specutil.py : 0 [11, 22]
WARNING : specutil.py : 1 [38, 41]
TIMING : LineSegment segment finder  [    4.767643       4.77885389  1530.42578125   270.0546875 ]
INFO : LineSegment_AT.py :  Segment Coverage 91 / 689 = 0.132075
REGRESSION : LINESEG: [[115.01551511760091, 115.01903074283905], [115.02215574305073, 115.02332761813011], [115.02567136828888, 115.02801511844764], [115.01981199289197, 115.02410886818303], [115.0303588686064, 115.03153074368579], [115.01551511760091, 115.02957761855349], [115.05614012035278, 115.0580932454851], [115.0975463731576, 115.10106199839574], [115.1053588736868, 115.10692137379264], [115.1104369990308, 115.11160887411017], [115.01551511760091, 115.02918699352702], [115.05535887029987, 115.0580932454851], [115.0975463731576, 115.10106199839574], [115.1104369990308, 115.11160887411017], [115.16473387770878, 115.16590575278816], [115.01551511760091, 115.03114011865932], [115.06395262088201, 115.06512449596138], [115.08543699733733, 115.08699949744316], [115.09715574813113, 115.09832762321051], [115.10340574855451, 115.10457762363389], [115.20262450527545, 115.20418700538129]]
TIMING : LineSegment done  [    2.453791       2.58543301  1553.18359375   292.81640625]
TIMING : LineSegment END [ 38.27095     38.48787189]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 46.104103  52.98508 ]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 46.1041 52.9851 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 46.202289    53.15806794]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 46.2023 53.1581 ]
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.81556920e+01   1.64394524e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 315.51 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 315.508
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [   21.148432      21.20342207  1553.18359375   292.81640625]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    9.933666       9.95925999  1553.18359375   292.81640625]
TIMING : LineID segment finder  [  1.42660000e-02   1.43048763e-02   1.55318359e+03   2.92816406e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [0, 36]
WARNING : specutil.py : 1 [104, 109]
WARNING : specutil.py : 2 [210, 219]
WARNING : specutil.py : 3 [230, 234]
WARNING : specutil.py : 4 [243, 246]
WARNING : specutil.py : 0 [0, 35]
WARNING : specutil.py : 1 [102, 109]
WARNING : specutil.py : 2 [210, 219]
WARNING : specutil.py : 3 [243, 246]
WARNING : specutil.py : 4 [382, 385]
WARNING : specutil.py : 0 [0, 40]
WARNING : specutil.py : 1 [124, 127]
WARNING : specutil.py : 2 [179, 183]
WARNING : specutil.py : 3 [209, 212]
WARNING : specutil.py : 4 [225, 228]
WARNING : specutil.py : 5 [479, 483]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [0, 9]
WARNING : specutil.py : 1 [17, 20]
WARNING : specutil.py : 2 [26, 32]
WARNING : specutil.py : 0 [11, 22]
WARNING : specutil.py : 1 [38, 41]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py : Found 1 potential pattern(s) with separation(s) of 22.4 km/s
INFO : LineID_AT.py :  Found line: cis-CH2OHCHOv=0 5(3,2)-5(1,5) @ 115.14036GHz, channels 0 - 36
REGRESSION : LINEID: cis-CH2OHCHOv=0 115.14036  0 36
INFO : LineID_AT.py :  Found line: CH2CHCNv=0 23(2,21)-23(1,22) @ 115.15061GHz, channels 38 - 41
REGRESSION : LINEID: CH2CHCNv=0 115.15061  38 41
INFO : LineID_AT.py :  Found line: NS J=5/2-3/2,&Omega=1/2,F=7/2-5/2,l=e @ 115.15394GHz, channels 18 - 40
REGRESSION : LINEID: NS 115.15394  18 40
INFO : LineID_AT.py :  Found line: CO 1-0 @ 115.2712GHz, channels 102 - 483
REGRESSION : LINEID: CO 115.27120  102 483
INFO : LineID_AT.py :  Line Coverage 424 / 689 = 0.615385
TIMING : LineID done  [   20.347734      21.03758311  1667.17578125   408.53125   ]
TIMING : LineID END [ 51.45826     52.22876906]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [  98.0035      105.82415199]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 98.0035 105.824 ]
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 [  9.99097310e+01   1.64394529e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  6.93380000e-02   6.96368217e-02   1.63364062e+03   3.75023438e+02]
TIMING : LineCube pad  [  1.42940000e-02   1.43392086e-02   1.63364062e+03   3.75023438e+02]
WARNING : LineCube_AT.py : pad=5 too large, start=-5 resetting to 0
TIMING : LineCube trans-x.CH2OHCHO_115.14036  [  9.76840000e-02   2.21567869e-01   1.63364062e+03   3.75144531e+02]
TIMING : LineCube trans-x.CH2CHCN_115.15061  [  6.95080000e-02   1.56302929e-01   1.63364062e+03   3.75144531e+02]
TIMING : LineCube trans-x.NS_115.15394  [  6.98150000e-02   1.66117191e-01   1.63364062e+03   3.75144531e+02]
TIMING : LineCube trans-x.CO_115.27120  [  7.44080000e-02   1.57703876e-01   1.63364062e+03   3.75144531e+02]
REGRESSION : LC: [0, 41, 33, 46, 13, 45, 97, 488]
TIMING : LineCube done  [  2.51520000e-02   2.52380371e-02   1.63364062e+03   3.75144531e+02]
TIMING : LineCube END [ 0.432661    0.82340193]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.CH2OHCHO_115.14036/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.NS_115.15394/lc.im
INFO : AT.py : BDP_OUT[3] = LineCube_BDP x.CO_115.27120/lc.im
TIMING : ADMITrun END [  98.686195   106.9559691]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 98.6862 106.956 ]
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 [  1.00831221e+02   1.64394529e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.92490000e-02   4.93650436e-02   1.63364062e+03   3.75144531e+02]
TIMING : Moment immoments-0  [  6.75630000e-02   2.40911961e-01   1.63364062e+03   3.75144531e+02]
TIMING : Moment mom0clip  [  6.86980000e-02   1.42948866e-01   1.63364062e+03   3.75332031e+02]
TIMING : Moment implot  [  1.00279000e-01   3.52212191e-01   1.63364062e+03   3.75390625e+02]
TIMING : Moment getdata  [  2.21450000e-02   2.22280025e-02   1.63364062e+03   3.75390625e+02]
TIMING : Moment ren+mask_0  [  4.64841000e-01   4.69721794e-01   1.63527344e+03   3.77023438e+02]
TIMING : Moment done  [  1.62060000e-02   1.62651539e-02   1.63527344e+03   3.77023438e+02]
TIMING : Moment END [ 0.801339    1.30605698]
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 [  1.01693709e+02   1.64394530e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.88480000e-02   4.89640236e-02   1.63527344e+03   3.77023438e+02]
TIMING : Moment immoments-all  [  6.91900000e-02   1.93747044e-01   1.63527344e+03   3.77023438e+02]
TIMING : Moment mom0clip  [  6.79260000e-02   9.21649933e-02   1.63527344e+03   3.77023438e+02]
TIMING : Moment implot  [  9.31220000e-02   3.38855028e-01   1.63527344e+03   3.77023438e+02]
TIMING : Moment getdata  [  2.18200000e-02   2.18920708e-02   1.63527344e+03   3.77023438e+02]
TIMING : Moment ren+mask_0  [  3.27360000e-01   3.32356930e-01   1.63502344e+03   3.76773438e+02]
TIMING : Moment makemask  [  1.50903000e-01   4.80028868e-01   1.63502344e+03   3.77410156e+02]
TIMING : Moment implot  [  7.99020000e-02   3.12813044e-01   1.63502344e+03   3.77410156e+02]
TIMING : Moment getdata  [  2.13180000e-02   2.13880539e-02   1.63502344e+03   3.77410156e+02]
TIMING : Moment ren+mask_1  [  3.40542000e-01   3.45650911e-01   1.63502344e+03   3.77500000e+02]
TIMING : Moment makemask  [  1.49695000e-01   5.34749985e-01   1.63502344e+03   3.77500000e+02]
TIMING : Moment implot  [  8.10930000e-02   3.10758114e-01   1.63502344e+03   3.77500000e+02]
TIMING : Moment getdata  [  2.17480000e-02   2.18489170e-02   1.63502344e+03   3.77500000e+02]
TIMING : Moment ren+mask_2  [  3.20916000e-01   3.25829983e-01   1.63502344e+03   3.77500000e+02]
REGRESSION : MOM0FLUX: x.CH2OHCHO_115.14036 66.2024 69.9379 0.0330578 306.63 306.63 1.24565
TIMING : Moment mom0flux  [  5.19520000e-02   5.20970821e-02   1.63502344e+03   3.77500000e+02]
TIMING : Moment flux-spectrum  [  3.20356000e-01   3.25254917e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment done  [  1.59740000e-02   1.60191059e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment END [ 2.195066  3.786865]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CH2OHCHO_115.14036/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CH2OHCHO_115.14036/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CH2OHCHO_115.14036/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 [  1.03998335e+02   1.64394530e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.86650000e-02   4.88219261e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment immoments-all  [  6.64670000e-02   2.70387888e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment mom0clip  [  6.73200000e-02   1.33005142e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  9.47890000e-02   3.39326859e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.14700000e-02   2.15420723e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_0  [  3.22784000e-01   3.27632904e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.53794000e-01   6.33489132e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  8.15800000e-02   3.11936855e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.20120000e-02   2.21052170e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_1  [  3.10074000e-01   3.15854788e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.51654000e-01   5.02717018e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  7.97360000e-02   3.08624983e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.16350000e-02   2.17101574e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_2  [  2.97450000e-01   3.02082062e-01   1.63452344e+03   3.77000000e+02]
REGRESSION : MOM0FLUX: x.CH2CHCN_115.15061 0.683786 6.44026 0.0330578 313.725 313.725 1.10261
TIMING : Moment mom0flux  [  5.38780000e-02   5.40878773e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment flux-spectrum  [  3.41523000e-01   3.46425056e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment done  [  1.60240000e-02   1.60698891e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment END [ 2.163286    3.98831296]
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 [  1.06271099e+02   1.64394530e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.85470000e-02   4.86600399e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment immoments-all  [  6.87150000e-02   2.38503933e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment mom0clip  [  6.79900000e-02   1.25780106e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  9.33210000e-02   3.37710857e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.26750000e-02   2.25930214e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_0  [  3.14414000e-01   3.19332123e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.51667000e-01   5.11109829e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  7.91090000e-02   3.07106018e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.21950000e-02   2.29911804e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_1  [  3.24049000e-01   3.29355001e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.51118000e-01   5.47906876e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  7.82770000e-02   3.09437037e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.20880000e-02   2.26409435e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_2  [  3.24545000e-01   3.29895973e-01   1.63452344e+03   3.77000000e+02]
REGRESSION : MOM0FLUX: x.NS_115.15394 14.3132 40.2823 0.0330578 334.536 334.536 1.89991
TIMING : Moment mom0flux  [  5.20150000e-02   5.22551537e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment flux-spectrum  [  3.14454000e-01   3.19584846e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment done  [  1.58540000e-02   1.59070492e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment END [ 2.16346     3.87325001]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.NS_115.15394/lc-@2.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.NS_115.15394/lc-@2.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.NS_115.15394/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 [  1.08544346e+02   1.64394531e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.88420000e-02   4.89559174e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment immoments-all  [  7.82720000e-02   2.32280970e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment mom0clip  [  7.17730000e-02   1.29693031e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  1.09170000e-01   3.52337122e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.58250000e-02   2.59339809e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_0  [  2.98751000e-01   3.03781033e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.50531000e-01   3.84744883e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  7.76830000e-02   3.14395905e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.11830000e-02   2.12531090e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_1  [  2.84510000e-01   2.89463997e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment makemask  [  1.49933000e-01   4.76516008e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment implot  [  7.79270000e-02   3.10532093e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment getdata  [  2.08970000e-02   2.09698677e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment ren+mask_2  [  2.91738000e-01   2.96678066e-01   1.63452344e+03   3.77000000e+02]
REGRESSION : MOM0FLUX: x.CO_115.27120 -122.476 39.1103 0.0330578 353.645 353.645 28.8284
TIMING : Moment mom0flux  [  5.21740000e-02   5.23450375e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment flux-spectrum  [  3.58218000e-01   3.63391876e-01   1.63452344e+03   3.77000000e+02]
TIMING : Moment done  [  1.54030000e-02   1.54421329e-02   1.63452344e+03   3.77000000e+02]
TIMING : Moment END [ 2.145139  3.651088]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.CO_115.27120/lc-@3.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.CO_115.27120/lc-@3.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.CO_115.27120/lc-@3.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 [  1.10798686e+02   1.64394531e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[24, 13],1.358218
TIMING : CubeSpectrum Moment-pos  [  5.44820000e-02   5.46510220e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum open  [  1.24240000e-02   1.24588013e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imval  [  3.69010000e-02   3.70900631e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imhead  [  4.23240000e-02   4.24840450e-02   1.63452344e+03   3.77000000e+02]
REGRESSION : CSP: [0.042162727564573288]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.73071000e-01   2.77909994e-01   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum summary  [  1.25920000e-02   1.26249790e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum END [ 0.444177    0.44968796]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH2OHCHO_115.14036/lc-@1.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@2' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.11303742e+02   1.64394531e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[25, 13],0.273987
TIMING : CubeSpectrum Moment-pos  [  5.45400000e-02   5.47080040e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum open  [  1.23450000e-02   1.23789310e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imval  [  3.63100000e-02   3.64921093e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imhead  [  4.21810000e-02   4.23429012e-02   1.63452344e+03   3.77000000e+02]
REGRESSION : CSP: [0.0429251529276371]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.76997000e-01   2.81893015e-01   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum summary  [  1.26300000e-02   1.26609802e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum END [ 0.44742     0.45293403]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CH2CHCN_115.15061/lc-@2.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@3' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.11812332e+02   1.64394531e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[24, 13],0.927064
TIMING : CubeSpectrum Moment-pos  [  5.47380000e-02   5.48961163e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum open  [  1.24400000e-02   1.24759674e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imval  [  3.68090000e-02   3.69939804e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imhead  [  4.24180000e-02   4.25801277e-02   1.63452344e+03   3.77000000e+02]
REGRESSION : CSP: [0.042162727564573288]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.75985000e-01   2.80920029e-01   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum summary  [  1.25490000e-02   1.25849247e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum END [ 0.447252    0.45280313]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.NS_115.15394/lc-@3.csp
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@4' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  1.12320375e+02   1.64394531e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[46, 38],1.248184
TIMING : CubeSpectrum Moment-pos  [  5.45580000e-02   5.47258854e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum open  [  1.23830000e-02   1.24199390e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imval  [  3.88200000e-02   3.90090942e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum imhead  [  4.21500000e-02   4.23181057e-02   1.63452344e+03   3.77000000e+02]
REGRESSION : CSP: [0.028872648254036903]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.79624000e-01   2.84405947e-01   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum summary  [  1.26260000e-02   1.26569271e-02   1.63452344e+03   3.77000000e+02]
TIMING : CubeSpectrum END [ 0.452574    0.45799303]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.CO_115.27120/lc-@4.csp