INFO : AT.py : Setting {'basename': 'x', 'file': 'R-Cas_94051.nf.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 :  R-Cas_94051.nf.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.24623800e+00   1.64738519e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: R-Cas   SHAPE: [  27   27 2062]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  1.62316000e-01   1.68264866e-01   1.41021875e+03   2.11472656e+02]
TIMING : Ingest importfits  [  1.04494000e-01   2.17819214e-01   1.41085938e+03   2.13171875e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  5.25820000e-02   7.42697716e-02   1.41276953e+03   2.16085938e+02]
TIMING : Ingest summary-0  [  1.37510000e-02   1.38030052e-02   1.41276953e+03   2.16085938e+02]
TIMING : Ingest mask  [  2.42860000e-02   3.34470272e-02   1.41276953e+03   2.16085938e+02]
TIMING : Ingest summary-1  [  1.32810000e-02   1.76520348e-02   1.41276953e+03   2.16085938e+02]
TIMING : Ingest statistics  [  3.83710000e-02   3.84831429e-02   1.41276953e+03   2.17195312e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 17.2500012, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 17.2500012, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [  27   27 2062    1] 1350610 -1.189375 70.345955
INFO : Ingest_AT.py : S/N (all data): 216.475782
INFO : Ingest_AT.py : GOOD PIXELS: 1350610/1503198 (89.849108% good or 10.150892% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -1.18938 70.346 0.32496  27 27 2062  10.150892
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: R-Cas
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 114.561300 -7.499999 13.000000
INFO : Ingest_AT.py : DEC  Axis 2: -10.619000 7.499999 13.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: 86.3372 -9.76562e-05 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=0.339465 km/s @ fc=86.236577 fw=-0.201367 GHz
INFO : Ingest_AT.py : RESTFREQ: 86.2434 86.2434 -1
INFO : Ingest_AT.py : VLSRc= 23.864173  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= 699.976211
INFO : Ingest_AT.py : VLSR = 23.864173 errs = 0.000000 0.000000 0.000000 width = 0.339465
TIMING : Ingest done  [  5.53267000e-01   5.58265924e-01   1.41494141e+03   2.19460938e+02]
TIMING : Ingest END [ 0.974427    1.13411903]
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.28121000e+00   1.64738519e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  6.19830000e-02   6.22398853e-02   1.41449219e+03   2.19500000e+02]
TIMING : CubeStats start  [  1.26670000e-02   1.27079487e-02   1.41449219e+03   2.19500000e+02]
TIMING : CubeStats imstat0  [  1.15827000e-01   1.16250038e-01   1.42851172e+03   2.33867188e+02]
TIMING : CubeStats imstat1  [  1.82845000e-01   1.83391094e-01   1.42851172e+03   2.33867188e+02]
INFO : CubeStats_AT.py : sigma varies from 0.054081 to 0.205935; 2062/2062 channels ok
WARNING : CubeStats_AT.py : sigma varies too much, going to clip to 0.108162 (3.80789 > 2)
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [    2.021434       2.02855301  1428.51171875   234.3046875 ]
INFO : CubeStats_AT.py : CubeMax: 70.345955 @ [  12   14 1035    0]
INFO : CubeStats_AT.py : CubeMin: -1.189375 @ [  26   14 1221    0]
INFO : CubeStats_AT.py : CubeRMS: 0.066359
INFO : CubeStats_AT.py : RMS Sanity check 4.896989
WARNING : CubeStats_AT.py : RMS sanity check = 4.896989.  Either bad sidelobes, lotsa signal, or both
REGRESSION : CST: 0.066359 4.896989
INFO : CubeStats_AT.py : mean,rms,S/N=0.006209 0.066359 1060.079529
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.519665 1.333573
TIMING : CubeStats plotting  [    2.481094       2.65890002  1455.1328125    258.95703125]
TIMING : CubeStats done  [  1.38220000e-02   1.38838291e-02   1.45513281e+03   2.58957031e+02]
TIMING : CubeStats summary  [  1.22000000e-02   1.22711658e-02   1.45513281e+03   2.58957031e+02]
TIMING : CubeStats END [ 4.914013    5.10038996]
INFO : AT.py : BDP_OUT[0] = CubeStats_BDP x.cst
INFO : 
INFO : 
INFO :    Executing CubeSum_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     linesum :  True
INFO :     numsigma :  4.0
INFO :     zoom :  1
INFO :     pad :  5
INFO :     sigma :  99.0
INFO : 
TIMING : CubeSum ADMIT [  8.25484800e+00   1.64738519e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.066359
TIMING : CubeSum start  [  5.18520000e-02   5.20708561e-02   1.45513281e+03   2.58957031e+02]
TIMING : CubeSum immoments  [  5.50900000e-02   8.27541351e-02   1.45513281e+03   2.59132812e+02]
TIMING : CubeSum statistics  [  1.93120000e-02   1.93858147e-02   1.45513281e+03   2.59132812e+02]
INFO : CubeSum_AT.py : Total flux: 146899.810280 (sum=2611.553018)
REGRESSION : CSM: [146899.81027983627, 2611.5530184495437]
TIMING : CubeSum implot  [  1.43994000e-01   6.06721115e+00   1.52713672e+03   2.59214844e+02]
TIMING : CubeSum getdata  [  2.08340000e-02   2.09100246e-02   1.52713672e+03   2.59214844e+02]
TIMING : CubeSum done  [  2.34125000e-01   2.54034996e-01   1.52713672e+03   2.59269531e+02]
TIMING : CubeSum END [ 0.538867    6.51006889]
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.85380000e+00   1.64738520e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.32730000e-02   3.33731174e-02   1.52713672e+03   2.59269531e+02]
TIMING : SFind2D imstat  [  4.09090000e-02   4.11670208e-02   1.52713672e+03   2.59269531e+02]
INFO : AT.py : Setting 'sigma' = 2.18230310021 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 2.1823 -0.488447 201.496 35 0.043322
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  1.02306000e-01   1.34628057e-01   1.52713672e+03   2.60140625e+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 : 07:38:14.981 -10.37.04.35    12.47    13.54        155        336  25.205  18.881   50.0   71.2
INFO : SFind2D_AT.py : 07:38:14.982 -10.37.04.35    12.47    13.54        155        333  25.146  18.621   49.9   71.2
INFO : SFind2D_AT.py : 07:38:14.979 -10.37.04.37    12.48    13.54        155        334  24.922  18.854   49.6   71.2
INFO : SFind2D_AT.py : 07:38:17.209 -10.37.18.17     8.09    11.70       5.18       26.7  37.500  37.500   90.0    2.4
INFO : SFind2D_AT.py : Wrote ds9.reg
TIMING : SFind2D table  [  2.07378000e-01   2.11421013e-01   1.52713672e+03   2.60140625e+02]
REGRESSION : CONTFLUX: 4 1030.36
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:       17.3 arcsec , Minor axis:       17.3 arcsec , PA:   0.0 deg
WARNING : SFind2D_AT.py : LogScaling applied
TIMING : SFind2D done  [  3.06796000e-01   3.26661825e-01   1.52713672e+03   2.60261719e+02]
TIMING : SFind2D END [ 0.704204    0.76083708]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  7.784608    14.21742606]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 7.78461 14.2174 ]
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 [  9.83909300e+00   1.64738520e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[12, 14, 1035],70.345955
TIMING : CubeSpectrum CubeStats-pos  [  4.78490000e-02   4.79760170e-02   1.52713672e+03   2.60261719e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[12, 14],201.496277
TIMING : CubeSpectrum Moment-pos  [  4.12280000e-02   4.13539410e-02   1.52713672e+03   2.60261719e+02]
INFO : CubeSpectrum_AT.py : SourceList::maxpos,val=('07h38m14.981s', '-10d37m04.35s'),155.330002
TIMING : CubeSpectrum SourceList-pos  [  3.57960000e-02   3.58910561e-02   1.52713672e+03   2.60261719e+02]
TIMING : CubeSpectrum open  [  1.21210000e-02   1.21719837e-02   1.52713672e+03   2.60261719e+02]
TIMING : CubeSpectrum imval  [  5.35160000e-02   5.37488461e-02   1.52713672e+03   2.60710938e+02]
TIMING : CubeSpectrum imhead  [  4.17620000e-02   4.19111252e-02   1.52713672e+03   2.60710938e+02]
TIMING : CubeSpectrum imval  [  2.47860000e-01   2.67658949e-01   1.52713672e+03   2.60808594e+02]
REGRESSION : CSP: [70.345954895019531, 70.345954895019531]
INFO : CubeSpectrum_AT.py : Writing 2 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.81637000e-01   3.01321030e-01   1.52713672e+03   2.60808594e+02]
TIMING : CubeSpectrum summary  [  1.23240000e-02   1.23579502e-02   1.52713672e+03   2.60808594e+02]
TIMING : CubeSpectrum END [ 0.786205  0.826545]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.csp
INFO : 
INFO : 
INFO :    Executing LineSegment_AT - '' (V1.2.3)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  5.0
INFO :     minchan :  4
INFO :     edgechannels :  0
INFO :     smooth :  []
INFO :     recalcnoise :  False
INFO :     maxgap :  3
INFO :     csub :  [0, 0]
INFO :     iterate :  True
INFO :     segment :  ADMIT
INFO : 
TIMING : LineSegment ADMIT [  1.06851290e+01   1.64738520e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.43500000e-02   2.44178772e-02   1.52713672e+03   2.60808594e+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  [   16.525735      16.58095121  1527.13671875   261.20703125]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [1021, 1058]
WARNING : specutil.py : 0 [1021, 1058]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [1023, 1057]
TIMING : LineSegment segment finder  [    3.038366       3.04621196  1527.13671875   261.20703125]
INFO : LineSegment_AT.py :  Segment Coverage 38 / 2062 = 0.0184287
REGRESSION : LINESEG: [[86.23398893210269, 86.237309244255542], [86.233891275862902, 86.237504556735104], [86.233891275862902, 86.237504556735104]]
TIMING : LineSegment done  [    2.412863       2.52807498  1557.09765625   291.24609375]
TIMING : LineSegment END [ 22.013888    22.19226003]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 30.909825    37.61870313]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 30.9098 37.6187 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 31.012204    37.78041697]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 31.0122 37.7804 ]
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 [  3.30919050e+01   1.64738522e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 23.86 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 23.8642
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    5.997821       6.01295519  1557.09765625   291.24609375]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [   10.694714      10.72974896  1557.09765625   291.24609375]
TIMING : LineID segment finder  [  1.47580000e-02   1.48270130e-02   1.55709766e+03   2.91246094e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [1021, 1058]
WARNING : specutil.py : 0 [1021, 1058]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [1023, 1057]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: SiO 2-1 @ 86.24337GHz, channels 1021 - 1058
REGRESSION : LINEID: SiO 86.24337  1021 1058
INFO : LineID_AT.py :  Line Coverage 38 / 2062 = 0.0184287
TIMING : LineID done  [   14.727417      14.93656802  1670.07421875   403.9921875 ]
TIMING : LineID END [ 31.448788    31.70822001]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 62.972162    70.06893396]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 62.9722 70.0689 ]
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.50048300e+01   1.64738525e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  5.78470000e-02   5.84201813e-02   1.63210156e+03   3.66328125e+02]
TIMING : LineCube pad  [  1.41000000e-02   1.41580105e-02   1.63210156e+03   3.66328125e+02]
TIMING : LineCube trans-x.SiO_86.24337  [  7.14700000e-02   2.53821850e-01   1.63210156e+03   3.66437500e+02]
REGRESSION : LC: [1016, 1063]
TIMING : LineCube done  [  2.49610000e-02   2.50291824e-02   1.63210156e+03   3.66437500e+02]
TIMING : LineCube END [ 0.180681    0.36376905]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.SiO_86.24337/lc.im
TIMING : ADMITrun END [ 63.327807    70.66851807]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 63.3278 70.6685 ]
INFO : AT.py : Setting 'moments' = [0, 1, 2] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : AT.py : Setting 'numsigma' = [3.0] for Moment_AT
INFO : AT.py : Setting 'mom0clip' = 2.0 for Moment_AT
INFO : Admit.py : ADMIT run() called [flowcount 1]
INFO : 
INFO : 
INFO :    Executing Moment_AT - '@1' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [3.0]
INFO :     moments :  [0]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  6.54579930e+01   1.64738526e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.92260000e-02   4.93550301e-02   1.63210156e+03   3.66437500e+02]
TIMING : Moment immoments-0  [  6.03070000e-02   1.02240086e-01   1.63210156e+03   3.66437500e+02]
TIMING : Moment mom0clip  [  7.04800000e-02   1.03235960e-01   1.63210156e+03   3.66437500e+02]
TIMING : Moment implot  [  1.00776000e-01   3.55222940e-01   1.63533594e+03   3.69796875e+02]
TIMING : Moment getdata  [  2.17490000e-02   2.18150616e-02   1.63533594e+03   3.69796875e+02]
TIMING : Moment ren+mask_0  [  4.20854000e-01   4.25646067e-01   1.63962109e+03   3.74082031e+02]
TIMING : Moment done  [  1.59430000e-02   1.59859657e-02   1.63962109e+03   3.74082031e+02]
TIMING : Moment END [ 0.751627    1.08582616]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x-@1.mom_0
INFO : 
INFO : 
INFO :    Executing Moment_AT - '' (V1.2.2)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     numsigma :  [2.0]
INFO :     moments :  [0, 1, 2]
INFO :     mom0clip :  2.0
INFO :     zoom :  1
INFO :     chans :  
INFO :     sigma :  -1.0
INFO : 
TIMING : Moment ADMIT [  6.62702950e+01   1.64738526e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.82840000e-02   4.83880043e-02   1.63962109e+03   3.74082031e+02]
TIMING : Moment immoments-all  [  6.50200000e-02   3.46566916e-01   1.63962109e+03   3.74082031e+02]
TIMING : Moment mom0clip  [  6.78690000e-02   1.19735003e-01   1.63962109e+03   3.74082031e+02]
TIMING : Moment implot  [  9.50150000e-02   3.41295004e-01   1.63962109e+03   3.74082031e+02]
TIMING : Moment getdata  [  2.15460000e-02   2.16109753e-02   1.63962109e+03   3.74082031e+02]
TIMING : Moment ren+mask_0  [  3.03918000e-01   3.08790207e-01   1.63962109e+03   3.74082031e+02]
TIMING : Moment makemask  [  1.49329000e-01   4.27771807e-01   1.63962109e+03   3.74472656e+02]
TIMING : Moment implot  [  7.99550000e-02   3.11145067e-01   1.63962109e+03   3.74472656e+02]
TIMING : Moment getdata  [  2.13460000e-02   2.14431286e-02   1.63962109e+03   3.74472656e+02]
TIMING : Moment ren+mask_1  [  3.01495000e-01   3.06304932e-01   1.63962109e+03   3.74906250e+02]
TIMING : Moment makemask  [  1.48242000e-01   3.89932871e-01   1.63962109e+03   3.74906250e+02]
TIMING : Moment implot  [  8.08250000e-02   3.08897018e-01   1.63962109e+03   3.74906250e+02]
TIMING : Moment getdata  [  2.13020000e-02   2.13620663e-02   1.63962109e+03   3.74906250e+02]
TIMING : Moment ren+mask_2  [  3.05352000e-01   3.09304953e-01   1.63962109e+03   3.74906250e+02]
REGRESSION : MOM0FLUX: x.SiO_86.24337 2740.89 1610.04 0.0177778 25.2419 25.2419 0.00784652
TIMING : Moment mom0flux  [  5.15350000e-02   5.17261028e-02   1.63962109e+03   3.74906250e+02]
TIMING : Moment flux-spectrum  [  3.04292000e-01   3.08969975e-01   1.63962109e+03   3.74906250e+02]
TIMING : Moment done  [  1.56530000e-02   1.56860352e-02   1.63962109e+03   3.74906250e+02]
TIMING : Moment END [ 2.09329     3.67128396]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.SiO_86.24337/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.SiO_86.24337/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.SiO_86.24337/lc.mom_2
INFO : 
INFO : 
INFO :    Executing CubeSpectrum_AT - '@1' (V1.2.5)
INFO : 
INFO : 
INFO :   Run using the following settings:
INFO :     xaxis :  
INFO :     sources :  [0]
INFO :     pos :  []
INFO : 
TIMING : CubeSpectrum ADMIT [  6.84718160e+01   1.64738526e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[12, 14],202.154480
TIMING : CubeSpectrum Moment-pos  [  5.45620000e-02   5.47089577e-02   1.63962109e+03   3.74906250e+02]
TIMING : CubeSpectrum open  [  1.22650000e-02   1.22931004e-02   1.63962109e+03   3.74906250e+02]
TIMING : CubeSpectrum imval  [  3.67440000e-02   3.69050503e-02   1.63962109e+03   3.74906250e+02]
TIMING : CubeSpectrum imhead  [  4.23810000e-02   4.25050259e-02   1.63962109e+03   3.74906250e+02]
REGRESSION : CSP: [70.345954895019531]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  3.07533000e-01   3.11600924e-01   1.63962109e+03   3.74906250e+02]
TIMING : CubeSpectrum summary  [  1.25070000e-02   1.25498772e-02   1.63962109e+03   3.74906250e+02]
TIMING : CubeSpectrum END [ 0.478208    0.48282814]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.SiO_86.24337/lc-@1.csp