INFO : AT.py : Setting {'basename': 'x', 'file': 'L1157-B1_84475.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 :  L1157-B1_84475.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.13595300e+00   1.64394224e+09]
TIMING : Ingest BEGIN [ 0.  0.]
INFO : Ingest_AT.py : OBJECT: L1157-B1   SHAPE: [ 57  57 573]
INFO : Ingest_AT.py : basename=x
INFO : utils.py : OSTYPE: linux
TIMING : Ingest start  [  1.64405000e-01   1.70804977e-01   1.41021484e+03   2.16835938e+02]
TIMING : Ingest importfits  [  1.05793000e-01   1.58424854e-01   1.41073438e+03   2.18714844e+02]
WARNING : Ingest_AT.py : Adding dummy STOKES-I axis
TIMING : Ingest adddegaxes  [  5.43940000e-02   7.53161907e-02   1.41231250e+03   2.20816406e+02]
TIMING : Ingest summary-0  [  1.37920000e-02   1.38449669e-02   1.41231250e+03   2.20816406e+02]
TIMING : Ingest mask  [  2.57600000e-02   3.49409580e-02   1.41257422e+03   2.21562500e+02]
TIMING : Ingest summary-1  [  1.32740000e-02   1.69439316e-02   1.41257422e+03   2.21562500e+02]
TIMING : Ingest statistics  [  3.93260000e-02   3.94239426e-02   1.41231250e+03   2.22140625e+02]
INFO : Ingest_AT.py : COMMONBEAM[3] {'major': {'value': 14.950000800000002, 'unit': 'arcsec'}, 'pa': {'value': 0.0, 'unit': 'deg'}, 'minor': {'value': 14.950000800000002, 'unit': 'arcsec'}}
INFO : Ingest_AT.py : BASICS: [shape] npts min max: [ 57  57 573   1] 1015929 -0.124287 0.214598
INFO : Ingest_AT.py : S/N (all data): 9.715972
INFO : Ingest_AT.py : GOOD PIXELS: 1015929/1861677 (54.570637% good or 45.429363% bad)
WARNING : Ingest_AT.py : MASKS: ['mask0']
REGRESSION : CUBE: -0.124287 0.214598 0.0220872  57 57 573  45.429363
INFO : Ingest_AT.py : TELESCOPE: LMT
INFO : Ingest_AT.py : OBJECT: L1157-B1
INFO : Ingest_AT.py : REFFREQTYPE: LSRK
INFO : Ingest_AT.py : RA   Axis 1: 309.792500 -6.500002 28.000000
INFO : Ingest_AT.py : DEC  Axis 2: 68.019580 6.500002 28.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: 96.0661 -0.000390625 0
INFO : Ingest_AT.py : Cube Orig Axis 3: type=Frequency  velocity increment=1.220431 km/s @ fc=95.954363 fw=-0.223828 GHz
INFO : Ingest_AT.py : RESTFREQ: 95.955 95.955 -1
INFO : Ingest_AT.py : VLSRc= 1.989866  VLSRf= 0.000000  VLSRv= 0.000000 VLSRz= 0.000000 WIDTH= 699.306963
INFO : Ingest_AT.py : VLSR = 1.989866 errs = 0.000000 0.000000 0.000000 width = 1.220431
TIMING : Ingest done  [  5.56078000e-01   5.61200142e-01   1.41469141e+03   2.24746094e+02]
TIMING : Ingest END [ 0.984836    1.08294201]
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.18129800e+00   1.64394224e+09]
TIMING : CubeStats BEGIN [ 0.  0.]
TIMING : CubeStats imval  [  5.14960000e-02   5.16960621e-02   1.41444141e+03   2.24625000e+02]
TIMING : CubeStats start  [  1.25210000e-02   1.25608444e-02   1.41444141e+03   2.24625000e+02]
TIMING : CubeStats imstat0  [  1.04678000e-01   1.05020046e-01   1.41391797e+03   2.24816406e+02]
TIMING : CubeStats imstat1  [  1.16149000e-01   1.16500139e-01   1.43257031e+03   2.43171875e+02]
INFO : CubeStats_AT.py : sigma varies from 0.019792 to 0.024421; 573/573 channels ok
INFO : CubeStats_AT.py : Computing MaxPos for PeakPointPlot
TIMING : CubeStats ppp  [  6.32318000e-01   6.34382010e-01   1.43257031e+03   2.43484375e+02]
INFO : CubeStats_AT.py : CubeMax: 0.214598 @ [ 29  32 388   0]
INFO : CubeStats_AT.py : CubeMin: -0.124287 @ [ 20   9 566   0]
INFO : CubeStats_AT.py : CubeRMS: 0.021931
INFO : CubeStats_AT.py : RMS Sanity check 1.007124
REGRESSION : CST: 0.021931 1.007124
INFO : CubeStats_AT.py : mean,rms,S/N=0.000006 0.021931 9.785185
INFO : CubeStats_AT.py : RMS BAD VARIATION RATIO: 1.033374 1.001671
TIMING : CubeStats plotting  [    2.310068       2.48363686  1436.6484375    245.84765625]
TIMING : CubeStats done  [  1.36280000e-02   1.36580467e-02   1.43664844e+03   2.45847656e+02]
TIMING : CubeStats summary  [  1.22370000e-02   1.22759342e-02   1.43664844e+03   2.45847656e+02]
TIMING : CubeStats END [ 3.265314    3.44198489]
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.50694000e+00   1.64394225e+09]
TIMING : CubeSum BEGIN [ 0.  0.]
INFO : CubeSum_AT.py : Using constant sigma = 0.021931
TIMING : CubeSum start  [  5.22630000e-02   5.23879528e-02   1.43664844e+03   2.45847656e+02]
TIMING : CubeSum immoments  [  5.80220000e-02   1.07713938e-01   1.44354688e+03   2.53179688e+02]
TIMING : CubeSum statistics  [  1.98580000e-02   1.99320316e-02   1.44354688e+03   2.53179688e+02]
INFO : CubeSum_AT.py : Total flux: 825.700986 (sum=19.543209)
REGRESSION : CSM: [825.70098585959374, 19.543208978953771]
TIMING : CubeSum implot  [  1.41914000e-01   5.82104993e+00   1.52315234e+03   2.60812500e+02]
TIMING : CubeSum getdata  [  2.05410000e-02   2.05950737e-02   1.52315234e+03   2.60812500e+02]
TIMING : CubeSum done  [  2.36851000e-01   2.58347988e-01   1.50844922e+03   2.46363281e+02]
TIMING : CubeSum END [ 0.542825    6.29343891]
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.11010000e+00   1.64394225e+09]
TIMING : SFind2D BEGIN [ 0.  0.]
TIMING : SFind2D start  [  3.34540000e-02   3.35400105e-02   1.50844922e+03   2.46363281e+02]
TIMING : SFind2D imstat  [  4.03830000e-02   4.06060219e-02   1.50844922e+03   2.46363281e+02]
INFO : AT.py : Setting 'sigma' = 0.254013227536 for SFind2D_AT
INFO : SFind2D_AT.py : sigma, dmin, dmax, snmax, cutoff 0.254013 -0.234076 1.01589 35 1.00016
WARNING : SFind2D_AT.py : Temporarely patching your K.km/s units to Jy/beam for ia.findsources()
TIMING : SFind2D findsources  [  9.00490000e-02   9.79678631e-02   1.50844922e+03   2.46363281e+02]
REGRESSION : CONTFLUX: 0 0
INFO : SFind2D_AT.py :  Fitted Gaussian size; NOT deconvolved source size.
INFO : SFind2D_AT.py :  Restoring Beam: Major axis:         15 arcsec , Minor axis:         15 arcsec , PA:   0.0 deg
TIMING : SFind2D done  [  2.76598000e-01   2.99215078e-01   1.50933203e+03   2.47644531e+02]
TIMING : SFind2D END [ 0.454317    0.48520708]
INFO : AT.py : BDP_OUT[0] = SourceList_BDP x-csm.sl
TIMING : ADMITrun END [  5.822579    11.93966603]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 5.82258 11.9397 ]
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 [  7.77134200e+00   1.64394226e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeStats::maxpos,val=[29, 32, 388],0.214598
TIMING : CubeSpectrum CubeStats-pos  [  4.84890000e-02   4.85870838e-02   1.50933203e+03   2.47644531e+02]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[29, 28],1.015891
TIMING : CubeSpectrum Moment-pos  [  4.17970000e-02   4.19058800e-02   1.50933203e+03   2.47644531e+02]
TIMING : CubeSpectrum open  [  1.22350000e-02   1.22680664e-02   1.50933203e+03   2.47644531e+02]
TIMING : CubeSpectrum imval  [  4.31380000e-02   4.33199406e-02   1.50933203e+03   2.48300781e+02]
TIMING : CubeSpectrum imhead  [  4.16890000e-02   4.18279171e-02   1.50933203e+03   2.48300781e+02]
TIMING : CubeSpectrum imval  [  2.48786000e-01   2.67582178e-01   1.50958984e+03   2.48695312e+02]
REGRESSION : CSP: [0.19159087538719177, 0.21459846198558807]
INFO : CubeSpectrum_AT.py : Writing 2 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.81687000e-01   3.00434828e-01   1.50978906e+03   2.48894531e+02]
TIMING : CubeSpectrum summary  [  1.24090000e-02   1.24351978e-02   1.50978906e+03   2.48894531e+02]
TIMING : CubeSpectrum END [ 0.742493  0.780653]
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 [  8.57437900e+00   1.64394226e+09]
TIMING : LineSegment BEGIN [ 0.  0.]
TIMING : LineSegment start  [  2.44880000e-02   2.45521069e-02   1.50978906e+03   2.48894531e+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  [   12.579461     12.604496   1509.7890625   249.3828125]
INFO : LineSegment_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [387, 390]
WARNING : specutil.py : 0 [388, 390]
INFO : LineSegment_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [387, 391]
TIMING : LineSegment segment finder  [    2.911729       2.91754699  1509.7890625    249.3828125 ]
INFO : LineSegment_AT.py :  Segment Coverage 4 / 573 = 0.0069808
REGRESSION : LINESEG: [[95.913347466047469, 95.914909966417056], [95.913738091139862, 95.914909966417056], [95.913738091139862, 95.914519341324663]]
TIMING : LineSegment done  [    1.913532       2.01955581  1556.6328125    296.10546875]
TIMING : LineSegment END [ 17.441577    17.57855296]
INFO : AT.py : BDP_OUT[0] = LineSegment_BDP x.lseg
TIMING : ADMITrun END [ 24.272834    30.61632609]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 24.2728 30.6163 ]
INFO : Admit.py : ADMIT run() called [flowcount 1]
TIMING : ADMITrun END [ 24.370407    30.78822112]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 24.3704 30.7882 ]
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 [  2.63448780e+01   1.64394227e+09]
TIMING : LineID BEGIN [ 0.  0.]
INFO : LineID_AT.py : Set vlsr = 1.99 for line identification.
INFO : LineID_AT.py : Identifylines = True
INFO : LineID_AT.py : Using vlsr = 1.98987
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input Spectra
TIMING : LineID getspectrum-cubespecs  [    5.503922       5.51533794  1556.6328125    296.10546875]
INFO : LineID_AT.py : Attempting Continuum Subtraction for Input CubeStats Spectra
TIMING : LineID getspectrum-cubestats  [    7.202596       7.22434211  1556.6328125    296.10546875]
TIMING : LineID segment finder  [  1.38370000e-02   1.38878822e-02   1.55663281e+03   2.96105469e+02]
INFO : LineID_AT.py : Detecting segments in CubeSpectrum based data
WARNING : specutil.py : 0 [387, 390]
WARNING : specutil.py : 0 [388, 390]
INFO : LineID_AT.py : Detecting segments in CubeStats based data
WARNING : specutil.py : 0 [387, 391]
INFO : LineID_AT.py : Searching for spectral peaks with method: PeakFinder
INFO : LineID_AT.py :  Found line: U_95.9152  @ 95.9151559761GHz, channels 387 - 391
REGRESSION : LINEID: U_95.9152 95.91516  387 391
INFO : LineID_AT.py :  Line Coverage 5 / 573 = 0.008726
TIMING : LineID done  [   13.543221      13.72340393  1655.83203125   396.390625  ]
TIMING : LineID END [ 26.278111    26.49153805]
INFO : AT.py : BDP_OUT[0] = LineList_BDP x.ll
TIMING : ADMITrun END [ 50.948896    57.65897608]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 50.9489 57.659 ]
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.28776070e+01   1.64394230e+09]
TIMING : LineCube BEGIN [ 0.  0.]
TIMING : LineCube start  [  6.23680000e-02   6.26149178e-02   1.62059766e+03   3.61335938e+02]
TIMING : LineCube pad  [  1.46040000e-02   1.46410465e-02   1.62059766e+03   3.61335938e+02]
TIMING : LineCube trans-x.U_95.9152  [  7.16120000e-02   2.02667952e-01   1.62059766e+03   3.61457031e+02]
REGRESSION : LC: [382, 396]
TIMING : LineCube done  [  2.50950000e-02   2.51519680e-02   1.62059766e+03   3.61457031e+02]
TIMING : LineCube END [ 0.186027    0.31745386]
INFO : AT.py : BDP_OUT[0] = LineCube_BDP x.U_95.9152/lc.im
TIMING : ADMITrun END [ 51.307187    58.22749901]
INFO : Admit.py : ADMIT run() finished [flowcount 1] [cpu 51.3072 58.2275 ]
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 [  5.33308530e+01   1.64394230e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.94430000e-02   5.01570702e-02   1.62059766e+03   3.61457031e+02]
TIMING : Moment immoments-0  [  6.33490000e-02   1.34521008e-01   1.62059766e+03   3.61457031e+02]
TIMING : Moment mom0clip  [  6.86320000e-02   1.17208004e-01   1.62059766e+03   3.61550781e+02]
TIMING : Moment implot  [  9.46530000e-02   3.40736866e-01   1.62109375e+03   3.62109375e+02]
TIMING : Moment getdata  [  2.06200000e-02   2.15661526e-02   1.62109375e+03   3.62109375e+02]
TIMING : Moment ren+mask_0  [  3.51714000e-01   3.57885838e-01   1.62683984e+03   3.67855469e+02]
TIMING : Moment done  [  1.51170000e-02   1.51541233e-02   1.62683984e+03   3.67855469e+02]
TIMING : Moment END [ 0.675866    1.04962206]
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 [  5.40746600e+01   1.64394230e+09]
TIMING : Moment BEGIN [ 0.  0.]
TIMING : Moment open  [  4.92820000e-02   4.93969917e-02   1.62683984e+03   3.67855469e+02]
TIMING : Moment immoments-all  [  6.81120000e-02   2.97070026e-01   1.62683984e+03   3.67855469e+02]
TIMING : Moment mom0clip  [  6.71510000e-02   1.23840809e-01   1.62683984e+03   3.67855469e+02]
TIMING : Moment implot  [  9.68810000e-02   3.56188059e-01   1.62683984e+03   3.67855469e+02]
TIMING : Moment getdata  [  2.04820000e-02   2.05481052e-02   1.62683984e+03   3.67855469e+02]
TIMING : Moment ren+mask_0  [  2.82084000e-01   2.87521839e-01   1.62633984e+03   3.67355469e+02]
TIMING : Moment makemask  [  1.48155000e-01   4.70966101e-01   1.62633984e+03   3.67476562e+02]
TIMING : Moment implot  [  7.68120000e-02   3.08845043e-01   1.62633984e+03   3.68250000e+02]
TIMING : Moment getdata  [  2.02070000e-02   2.02748775e-02   1.62633984e+03   3.68250000e+02]
TIMING : Moment ren+mask_1  [  2.59806000e-01   2.64937162e-01   1.62633984e+03   3.68250000e+02]
TIMING : Moment makemask  [  1.49086000e-01   3.54847908e-01   1.62633984e+03   3.68250000e+02]
TIMING : Moment implot  [  7.71140000e-02   2.98989058e-01   1.62633984e+03   3.68250000e+02]
TIMING : Moment getdata  [  2.01400000e-02   2.02090740e-02   1.62633984e+03   3.68250000e+02]
TIMING : Moment ren+mask_2  [  2.62357000e-01   2.67241001e-01   1.62633984e+03   3.68250000e+02]
REGRESSION : MOM0FLUX: x.U_95.9152 32.773 23.0985 0.0236686 3.3605 3.3605 1.18793
TIMING : Moment mom0flux  [  5.11700000e-02   5.13448715e-02   1.62633984e+03   3.68250000e+02]
TIMING : Moment flux-spectrum  [  2.57916000e-01   2.62123108e-01   1.62633984e+03   3.68250000e+02]
TIMING : Moment done  [  1.48930000e-02   1.49259567e-02   1.62633984e+03   3.68250000e+02]
TIMING : Moment END [ 1.933948    3.48161888]
INFO : AT.py : BDP_OUT[0] = Moment_BDP x.U_95.9152/lc.mom_0
INFO : AT.py : BDP_OUT[1] = Moment_BDP x.U_95.9152/lc.mom_1
INFO : AT.py : BDP_OUT[2] = Moment_BDP x.U_95.9152/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 [  5.61172060e+01   1.64394231e+09]
TIMING : CubeSpectrum BEGIN [ 0.  0.]
INFO : CubeSpectrum_AT.py : CubeSum::maxpos,val=[29, 29],0.966338
TIMING : CubeSpectrum Moment-pos  [  5.37870000e-02   5.39109707e-02   1.62633984e+03   3.68250000e+02]
TIMING : CubeSpectrum open  [  1.22850000e-02   1.23169422e-02   1.62633984e+03   3.68250000e+02]
TIMING : CubeSpectrum imval  [  3.56810000e-02   3.58281136e-02   1.62633984e+03   3.68250000e+02]
TIMING : CubeSpectrum imhead  [  4.17830000e-02   4.19168472e-02   1.62633984e+03   3.68250000e+02]
REGRESSION : CSP: [0.16197723150253296]
INFO : CubeSpectrum_AT.py : Writing 1 testCubeSpectrum tables
TIMING : CubeSpectrum done  [  2.59898000e-01   2.64444113e-01   1.62633984e+03   3.68250000e+02]
TIMING : CubeSpectrum summary  [  1.26500000e-02   1.26979351e-02   1.62633984e+03   3.68250000e+02]
TIMING : CubeSpectrum END [ 0.428498    0.43357086]
INFO : AT.py : BDP_OUT[0] = CubeSpectrum_BDP x.U_95.9152/lc-@1.csp