MORE-Web

Test Date: 2016-01-20 11:57
Analysis date: 2016-05-26 08:47
Logfile
LogfileView
[11:02:41.060] <TB2>     INFO: *** Welcome to pxar ***

[11:02:41.060] <TB2>     INFO: *** Today: 2016/01/20

[11:02:41.132] <TB2>     INFO: *** Version: 3197-dirty

[11:02:41.132] <TB2>     INFO: readRocDacs: /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C15.dat

[11:02:41.133] <TB2>     INFO: readTbmDacs: /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//tbmParameters_C0b.dat

[11:02:41.133] <TB2>     INFO: readMaskFile: /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//defaultMaskFile.dat

[11:02:41.133] <TB2>     INFO: readTrimFile: /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters_C15.dat

[11:02:41.211] <TB2>     INFO:         clk: 4

[11:02:41.211] <TB2>     INFO:         ctr: 4

[11:02:41.211] <TB2>     INFO:         sda: 19

[11:02:41.211] <TB2>     INFO:         tin: 9

[11:02:41.211] <TB2>     INFO:         level: 15

[11:02:41.211] <TB2>     INFO:         triggerdelay: 0

[11:02:41.211] <TB2>    QUIET: Instanciating API for pxar prod-12

[11:02:41.211] <TB2>     INFO: Log level: INFO

[11:02:41.217] <TB2>     INFO: Found DTB DTB_WXC55Z

[11:02:41.225] <TB2>    QUIET: Connection to board DTB_WXC55Z opened.

[11:02:41.228] <TB2>     INFO: DTB startup information

--- DTB info------------------------------------------

Board id:    156

HW version:  DTB1.2

FW version:  4.2

SW version:  4.5

USB id:      DTB_WXC55Z

MAC address: 40D85511809C

Hostname:    pixelDTB156

Comment:     

------------------------------------------------------

[11:02:41.230] <TB2>     INFO: RPC call hashes of host and DTB match: 398089610

[11:02:42.794] <TB2>     INFO: DUT info: 

[11:02:42.794] <TB2>     INFO: The DUT currently contains the following objects:

[11:02:42.794] <TB2>     INFO:  2 TBM Cores tbm09c (2 ON)

[11:02:42.794] <TB2>     INFO: 	TBM Core alpha (0): 7 registers set

[11:02:42.794] <TB2>     INFO: 	TBM Core beta  (1): 7 registers set

[11:02:42.794] <TB2>     INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs

[11:02:42.794] <TB2>     INFO: 	ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:42.794] <TB2>     INFO: 	ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.

[11:02:43.195] <TB2>     INFO: enter 'restricted' command line mode

[11:02:43.195] <TB2>     INFO: enter test to run

[11:02:43.195] <TB2>     INFO:   test: pretest no parameter change

[11:02:43.195] <TB2>     INFO:   running: pretest

[11:02:43.199] <TB2>     INFO:    ----------------------------------------------------------------------

[11:02:43.199] <TB2>     INFO:    PixTestPretest::programROC() 

[11:02:43.199] <TB2>     INFO:    ----------------------------------------------------------------------

[11:03:01.216] <TB2>     INFO: PixTestPretest::programROC() done: ROCs are all programmable

[11:03:01.216] <TB2>     INFO: IA differences per ROC:  19.3 16.9 17.7 16.9 18.5 18.5 16.9 16.9 18.5 18.5 16.1 17.7 20.9 17.7 19.3 18.5

[11:03:01.312] <TB2>     INFO: enter test to run

[11:03:01.312] <TB2>     INFO:   test: pretest no parameter change

[11:03:01.312] <TB2>     INFO:   running: pretest

[11:03:01.314] <TB2>     INFO:    ----------------------------------------------------------------------

[11:03:01.314] <TB2>     INFO:    PixTestPretest::setVana() target Ia = 24 mA/ROC

[11:03:01.314] <TB2>     INFO:    ----------------------------------------------------------------------

[11:03:22.609] <TB2>     INFO: PixTestPretest::setVana() done, Module Ia 397.1 mA = 24.8188 mA/ROC

[11:03:22.609] <TB2>     INFO: i(loss) [mA/ROC]:     20.1  19.3  20.9  20.1  20.1  20.1  20.1  19.3  19.3  20.9  19.3  20.1  19.3  20.1  20.9  17.7

[11:03:22.640] <TB2>     INFO: enter test to run

[11:03:22.641] <TB2>     INFO:   test: pretest no parameter change

[11:03:22.641] <TB2>     INFO:   running: pretest

[11:03:22.641] <TB2>     INFO:    ----------------------------------------------------------------------

[11:03:22.641] <TB2>     INFO:    PixTestPretest::findTiming() 

[11:03:22.641] <TB2>     INFO:    ----------------------------------------------------------------------

[11:03:22.641] <TB2>     INFO: PixTestCmd::init()

[11:03:23.239] <TB2>  WARNING: Not unmasking DUT, not setting Calibrate bits!

[11:05:02.694] <TB2>     INFO: TBM phases:  160MHz: 0, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1

[11:05:02.694] <TB2>     INFO: (success/tries = 100/100), width = 4

[11:05:02.694] <TB2>     INFO: enter test to run

[11:05:02.694] <TB2>     INFO:   test: pretest no parameter change

[11:05:02.694] <TB2>     INFO:   running: pretest

[11:05:02.696] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:02.696] <TB2>     INFO:    PixTestPretest::findWorkingPixel()

[11:05:02.696] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:02.835] <TB2>     INFO: Expecting 231680 events.

[11:05:11.477] <TB2>     INFO: 231680 events read in total (7926ms).

[11:05:11.481] <TB2>     INFO: Test took 8783ms.

[11:05:11.784] <TB2>     INFO: Found working pixel in all ROCs: col/row = 12/22

[11:05:11.844] <TB2>     INFO: enter test to run

[11:05:11.844] <TB2>     INFO:   test: pretest no parameter change

[11:05:11.844] <TB2>     INFO:   running: pretest

[11:05:11.845] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:11.845] <TB2>     INFO:    PixTestPretest::setVthrCompCalDel()

[11:05:11.845] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:11.980] <TB2>     INFO: Expecting 231680 events.

[11:05:20.555] <TB2>     INFO: 231680 events read in total (7859ms).

[11:05:20.559] <TB2>     INFO: Test took 8710ms.

[11:05:20.891] <TB2>     INFO: PixTestPretest::setVthrCompCalDel() done

[11:05:20.891] <TB2>     INFO: CalDel:      142   144   157   130   139   142   133   125   132   130   128   146   154   128   146   129

[11:05:20.891] <TB2>     INFO: VthrComp:     51    51    51    51    51    51    51    51    51    51    51    51    54    51    51    51

[11:05:20.937] <TB2>     INFO: enter test to run

[11:05:20.937] <TB2>     INFO:   test: pretest no parameter change

[11:05:20.937] <TB2>     INFO:   running: pretest

[11:05:20.937] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C0.dat

[11:05:20.938] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C1.dat

[11:05:20.938] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C2.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C3.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C4.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C5.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C6.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C7.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C8.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C9.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C10.dat

[11:05:20.939] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C11.dat

[11:05:20.940] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C12.dat

[11:05:20.940] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C13.dat

[11:05:20.940] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C14.dat

[11:05:20.940] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters_C15.dat

[11:05:20.940] <TB2>     INFO: enter test to run

[11:05:20.940] <TB2>     INFO:   test: fulltest no parameter change

[11:05:20.940] <TB2>     INFO:   running: fulltest

[11:05:20.940] <TB2>     INFO: ######################################################################

[11:05:20.940] <TB2>     INFO: PixTestFullTest::doTest()

[11:05:20.940] <TB2>     INFO: ######################################################################

[11:05:20.942] <TB2>     INFO: ######################################################################

[11:05:20.942] <TB2>     INFO: PixTestAlive::doTest()

[11:05:20.942] <TB2>     INFO: ######################################################################

[11:05:20.943] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:20.943] <TB2>     INFO:    PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[11:05:20.943] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:21.292] <TB2>     INFO: Expecting 41600 events.

[11:05:25.519] <TB2>     INFO: 41600 events read in total (3511ms).

[11:05:25.519] <TB2>     INFO: Test took 4574ms.

[11:05:25.525] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:05:25.814] <TB2>     INFO: PixTestAlive::aliveTest() done

[11:05:25.814] <TB2>     INFO: number of dead pixels (per ROC):     0    0    1    1    0    0    0    0    0    2    0    0    0    0    0    0

[11:05:25.816] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:25.816] <TB2>     INFO:    PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[11:05:25.816] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:26.131] <TB2>     INFO: Expecting 41600 events.

[11:05:29.254] <TB2>     INFO: 41600 events read in total (2408ms).

[11:05:29.254] <TB2>     INFO: Test took 3436ms.

[11:05:29.255] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:05:29.255] <TB2>     INFO: mask vs. old pixelAlive PixelAlive_C0_V0 ..  PixelAlive_C15_V0

[11:05:29.569] <TB2>     INFO: PixTestAlive::maskTest() done

[11:05:29.569] <TB2>     INFO: number of mask-defect pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[11:05:29.571] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:29.571] <TB2>     INFO:    PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[11:05:29.571] <TB2>     INFO:    ----------------------------------------------------------------------

[11:05:29.884] <TB2>     INFO: Expecting 41600 events.

[11:05:34.208] <TB2>     INFO: 41600 events read in total (3608ms).

[11:05:34.209] <TB2>     INFO: Test took 4636ms.

[11:05:34.215] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:05:34.500] <TB2>     INFO: PixTestAlive::addressDecodingTest() done

[11:05:34.500] <TB2>     INFO: number of address-decoding pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[11:05:34.501] <TB2>     INFO: PixTestAlive::doTest() done, duration: 13 seconds

[11:05:34.501] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:05:34.501] <TB2>     INFO: Decoding statistics:

[11:05:34.501] <TB2>     INFO:   General information:

[11:05:34.501] <TB2>     INFO: 	 16bit words read:         0

[11:05:34.501] <TB2>     INFO: 	 valid events total:       0

[11:05:34.501] <TB2>     INFO: 	 empty events:             0

[11:05:34.501] <TB2>     INFO: 	 valid events with pixels: 0

[11:05:34.501] <TB2>     INFO: 	 valid pixel hits:         0

[11:05:34.501] <TB2>     INFO:   Event errors: 	           0

[11:05:34.501] <TB2>     INFO: 	 start marker:             0

[11:05:34.501] <TB2>     INFO: 	 stop marker:              0

[11:05:34.501] <TB2>     INFO: 	 overflow:                 0

[11:05:34.501] <TB2>     INFO: 	 invalid 5bit words:       0

[11:05:34.501] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[11:05:34.501] <TB2>     INFO:   TBM errors: 		           0

[11:05:34.501] <TB2>     INFO: 	 flawed TBM headers:       0

[11:05:34.501] <TB2>     INFO: 	 flawed TBM trailers:      0

[11:05:34.501] <TB2>     INFO: 	 event ID mismatches:      0

[11:05:34.501] <TB2>     INFO:   ROC errors: 		           0

[11:05:34.501] <TB2>     INFO: 	 missing ROC header(s):    0

[11:05:34.501] <TB2>     INFO: 	 misplaced readback start: 0

[11:05:34.501] <TB2>     INFO:   Pixel decoding errors:	   0

[11:05:34.501] <TB2>     INFO: 	 pixel data incomplete:    0

[11:05:34.501] <TB2>     INFO: 	 pixel address:            0

[11:05:34.501] <TB2>     INFO: 	 pulse height fill bit:    0

[11:05:34.501] <TB2>     INFO: 	 buffer corruption:        0

[11:05:34.513] <TB2>     INFO: ######################################################################

[11:05:34.513] <TB2>     INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)

[11:05:34.513] <TB2>     INFO: ######################################################################

[11:05:34.515] <TB2>     INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)

[11:05:34.526] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[11:05:34.526] <TB2>     INFO:     run 1 of 1

[11:05:34.834] <TB2>     INFO: Expecting 3120000 events.

[11:06:17.106] <TB2>     INFO: 926760 events read in total (41557ms).

[11:06:58.535] <TB2>     INFO: 1842360 events read in total (82986ms).

[11:07:39.886] <TB2>     INFO: 2762190 events read in total (124337ms).

[11:07:55.258] <TB2>     INFO: 3120000 events read in total (139709ms).

[11:07:55.299] <TB2>     INFO: Test took 140774ms.

[11:07:55.387] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:08:18.188] <TB2>     INFO: PixTestBBMap::doTest() done, duration: 163 seconds

[11:08:18.188] <TB2>     INFO: number of dead bumps (per ROC):     8    7    2    0    0    0    1    2    2    7    3    1    8    9   18   21

[11:08:18.189] <TB2>     INFO: separation cut       (per ROC):   110  109  103  107  103  123  121  103  125  126   94  104  125  102  116   97

[11:08:18.189] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:08:18.189] <TB2>     INFO: Decoding statistics:

[11:08:18.189] <TB2>     INFO:   General information:

[11:08:18.189] <TB2>     INFO: 	 16bit words read:         0

[11:08:18.189] <TB2>     INFO: 	 valid events total:       0

[11:08:18.189] <TB2>     INFO: 	 empty events:             0

[11:08:18.189] <TB2>     INFO: 	 valid events with pixels: 0

[11:08:18.189] <TB2>     INFO: 	 valid pixel hits:         0

[11:08:18.189] <TB2>     INFO:   Event errors: 	           0

[11:08:18.189] <TB2>     INFO: 	 start marker:             0

[11:08:18.189] <TB2>     INFO: 	 stop marker:              0

[11:08:18.189] <TB2>     INFO: 	 overflow:                 0

[11:08:18.189] <TB2>     INFO: 	 invalid 5bit words:       0

[11:08:18.189] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[11:08:18.189] <TB2>     INFO:   TBM errors: 		           0

[11:08:18.189] <TB2>     INFO: 	 flawed TBM headers:       0

[11:08:18.189] <TB2>     INFO: 	 flawed TBM trailers:      0

[11:08:18.189] <TB2>     INFO: 	 event ID mismatches:      0

[11:08:18.189] <TB2>     INFO:   ROC errors: 		           0

[11:08:18.189] <TB2>     INFO: 	 missing ROC header(s):    0

[11:08:18.189] <TB2>     INFO: 	 misplaced readback start: 0

[11:08:18.189] <TB2>     INFO:   Pixel decoding errors:	   0

[11:08:18.189] <TB2>     INFO: 	 pixel data incomplete:    0

[11:08:18.189] <TB2>     INFO: 	 pixel address:            0

[11:08:18.189] <TB2>     INFO: 	 pulse height fill bit:    0

[11:08:18.189] <TB2>     INFO: 	 buffer corruption:        0

[11:08:18.258] <TB2>     INFO: ######################################################################

[11:08:18.258] <TB2>     INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1

[11:08:18.258] <TB2>     INFO: ######################################################################

[11:08:18.258] <TB2>     INFO:    ----------------------------------------------------------------------

[11:08:18.259] <TB2>     INFO:    PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1

[11:08:18.259] <TB2>     INFO:    ----------------------------------------------------------------------

[11:08:18.259] <TB2>     INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)

[11:08:18.266] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 50

[11:08:18.266] <TB2>     INFO:     run 1 of 1

[11:08:18.569] <TB2>     INFO: Expecting 26208000 events.

[11:08:48.210] <TB2>     INFO: 908300 events read in total (28924ms).

[11:09:18.188] <TB2>     INFO: 1801250 events read in total (58902ms).

[11:09:50.094] <TB2>     INFO: 2693050 events read in total (90808ms).

[11:10:20.366] <TB2>     INFO: 3583850 events read in total (121080ms).

[11:10:50.873] <TB2>     INFO: 4471750 events read in total (151587ms).

[11:11:20.444] <TB2>     INFO: 5359250 events read in total (181158ms).

[11:11:49.488] <TB2>     INFO: 6246950 events read in total (210202ms).

[11:12:20.339] <TB2>     INFO: 7132750 events read in total (241053ms).

[11:12:50.075] <TB2>     INFO: 8017900 events read in total (270789ms).

[11:13:16.989] <TB2>     INFO: 8903500 events read in total (297703ms).

[11:13:46.813] <TB2>     INFO: 9789400 events read in total (327527ms).

[11:14:17.315] <TB2>     INFO: 10674200 events read in total (358029ms).

[11:14:47.679] <TB2>     INFO: 11555250 events read in total (388393ms).

[11:15:17.538] <TB2>     INFO: 12439300 events read in total (418252ms).

[11:15:47.504] <TB2>     INFO: 13317350 events read in total (448218ms).

[11:16:17.473] <TB2>     INFO: 14191600 events read in total (478187ms).

[11:16:48.194] <TB2>     INFO: 15061750 events read in total (508908ms).

[11:17:18.572] <TB2>     INFO: 15933800 events read in total (539286ms).

[11:17:49.020] <TB2>     INFO: 16805450 events read in total (569734ms).

[11:18:19.808] <TB2>     INFO: 17675550 events read in total (600522ms).

[11:18:51.358] <TB2>     INFO: 18545250 events read in total (632072ms).

[11:19:22.384] <TB2>     INFO: 19414300 events read in total (663098ms).

[11:19:53.976] <TB2>     INFO: 20284000 events read in total (694690ms).

[11:20:24.390] <TB2>     INFO: 21152000 events read in total (725104ms).

[11:20:55.063] <TB2>     INFO: 22021000 events read in total (755777ms).

[11:21:25.647] <TB2>     INFO: 22890800 events read in total (786361ms).

[11:21:56.791] <TB2>     INFO: 23762250 events read in total (817505ms).

[11:22:27.116] <TB2>     INFO: 24633400 events read in total (847830ms).

[11:22:58.161] <TB2>     INFO: 25505750 events read in total (878875ms).

[11:23:22.600] <TB2>     INFO: 26208000 events read in total (903314ms).

[11:23:22.630] <TB2>     INFO: Test took 904364ms.

[11:23:22.708] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:23:22.864] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:24.293] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:25.713] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:27.129] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:28.514] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:29.886] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:31.263] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:32.632] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:33.989] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:35.306] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:36.644] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:38.104] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:39.547] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:40.914] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:42.410] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:43.769] <TB2>     INFO: dumping ASCII scurve output file: SCurveData

[11:23:45.218] <TB2>     INFO: PixTestScurves::scurves() done 

[11:23:45.218] <TB2>     INFO: Vcal mean:  93.75  84.94  85.04  90.17  86.55  86.12  85.73  90.54 109.75 107.72  72.83  81.48 106.30  88.65 105.80  91.26 

[11:23:45.218] <TB2>     INFO: Vcal RMS:    5.17   5.21   4.83   5.86   4.66   5.22   5.34   5.12   5.41   5.66   4.07   4.56   7.22   5.00   5.28   5.49 

[11:23:45.218] <TB2>     INFO: PixTestScurves::fullTest() done, duration: 926 seconds

[11:23:45.218] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:23:45.218] <TB2>     INFO: Decoding statistics:

[11:23:45.218] <TB2>     INFO:   General information:

[11:23:45.218] <TB2>     INFO: 	 16bit words read:         0

[11:23:45.218] <TB2>     INFO: 	 valid events total:       0

[11:23:45.218] <TB2>     INFO: 	 empty events:             0

[11:23:45.218] <TB2>     INFO: 	 valid events with pixels: 0

[11:23:45.218] <TB2>     INFO: 	 valid pixel hits:         0

[11:23:45.218] <TB2>     INFO:   Event errors: 	           0

[11:23:45.218] <TB2>     INFO: 	 start marker:             0

[11:23:45.218] <TB2>     INFO: 	 stop marker:              0

[11:23:45.218] <TB2>     INFO: 	 overflow:                 0

[11:23:45.218] <TB2>     INFO: 	 invalid 5bit words:       0

[11:23:45.218] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[11:23:45.218] <TB2>     INFO:   TBM errors: 		           0

[11:23:45.218] <TB2>     INFO: 	 flawed TBM headers:       0

[11:23:45.218] <TB2>     INFO: 	 flawed TBM trailers:      0

[11:23:45.218] <TB2>     INFO: 	 event ID mismatches:      0

[11:23:45.218] <TB2>     INFO:   ROC errors: 		           0

[11:23:45.218] <TB2>     INFO: 	 missing ROC header(s):    0

[11:23:45.218] <TB2>     INFO: 	 misplaced readback start: 0

[11:23:45.218] <TB2>     INFO:   Pixel decoding errors:	   0

[11:23:45.218] <TB2>     INFO: 	 pixel data incomplete:    0

[11:23:45.218] <TB2>     INFO: 	 pixel address:            0

[11:23:45.218] <TB2>     INFO: 	 pulse height fill bit:    0

[11:23:45.218] <TB2>     INFO: 	 buffer corruption:        0

[11:23:45.290] <TB2>     INFO: ######################################################################

[11:23:45.290] <TB2>     INFO: PixTestTrim::doTest()

[11:23:45.290] <TB2>     INFO: ######################################################################

[11:23:45.291] <TB2>     INFO:    ----------------------------------------------------------------------

[11:23:45.291] <TB2>     INFO:    PixTestTrim::trimTest() ntrig = 10, vcal = 35

[11:23:45.291] <TB2>     INFO:    ----------------------------------------------------------------------

[11:23:45.375] <TB2>     INFO: ---> VthrComp thr map (minimal VthrComp)

[11:23:45.375] <TB2>     INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)

[11:23:45.383] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:23:45.383] <TB2>     INFO:     run 1 of 1

[11:23:45.723] <TB2>     INFO: Expecting 6281600 events.

[11:24:25.060] <TB2>     INFO: 1074700 events read in total (38619ms).

[11:25:04.122] <TB2>     INFO: 2144600 events read in total (77681ms).

[11:25:42.610] <TB2>     INFO: 3209830 events read in total (116170ms).

[11:26:20.394] <TB2>     INFO: 4274810 events read in total (153953ms).

[11:26:59.715] <TB2>     INFO: 5342060 events read in total (193274ms).

[11:27:33.271] <TB2>     INFO: 6281600 events read in total (226830ms).

[11:27:33.302] <TB2>     INFO: Test took 227919ms.

[11:27:33.353] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:27:54.453] <TB2>     INFO: ROC 0 VthrComp = 102

[11:27:54.453] <TB2>     INFO: ROC 1 VthrComp = 91

[11:27:54.454] <TB2>     INFO: ROC 2 VthrComp = 90

[11:27:54.454] <TB2>     INFO: ROC 3 VthrComp = 93

[11:27:54.454] <TB2>     INFO: ROC 4 VthrComp = 94

[11:27:54.454] <TB2>     INFO: ROC 5 VthrComp = 91

[11:27:54.454] <TB2>     INFO: ROC 6 VthrComp = 91

[11:27:54.454] <TB2>     INFO: ROC 7 VthrComp = 96

[11:27:54.454] <TB2>     INFO: ROC 8 VthrComp = 108

[11:27:54.454] <TB2>     INFO: ROC 9 VthrComp = 108

[11:27:54.454] <TB2>     INFO: ROC 10 VthrComp = 81

[11:27:54.454] <TB2>     INFO: ROC 11 VthrComp = 90

[11:27:54.455] <TB2>     INFO: ROC 12 VthrComp = 101

[11:27:54.455] <TB2>     INFO: ROC 13 VthrComp = 93

[11:27:54.455] <TB2>     INFO: ROC 14 VthrComp = 108

[11:27:54.455] <TB2>     INFO: ROC 15 VthrComp = 96

[11:27:54.455] <TB2>     INFO: ---> Vcal thr map (pixel with maximum Vcal thr)

[11:27:54.455] <TB2>     INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)

[11:27:54.463] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:27:54.463] <TB2>     INFO:     run 1 of 1

[11:27:54.765] <TB2>     INFO: Expecting 6281600 events.

[11:28:30.234] <TB2>     INFO: 756070 events read in total (34753ms).

[11:29:04.183] <TB2>     INFO: 1509710 events read in total (68702ms).

[11:29:37.527] <TB2>     INFO: 2263360 events read in total (102046ms).

[11:30:11.038] <TB2>     INFO: 3017320 events read in total (135557ms).

[11:30:44.657] <TB2>     INFO: 3766010 events read in total (169176ms).

[11:31:17.818] <TB2>     INFO: 4511510 events read in total (202337ms).

[11:31:50.502] <TB2>     INFO: 5255160 events read in total (235021ms).

[11:32:23.344] <TB2>     INFO: 5999000 events read in total (267863ms).

[11:32:36.402] <TB2>     INFO: 6281600 events read in total (280921ms).

[11:32:36.453] <TB2>     INFO: Test took 281990ms.

[11:32:36.618] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:33:00.897] <TB2>     INFO:    roc 0 with ID = 0  has maximal Vcal 57.27 for pixel 32/9 mean/min/max = 44.5897/31.8867/57.2927

[11:33:00.898] <TB2>     INFO:    roc 1 with ID = 1  has maximal Vcal 57.4036 for pixel 20/67 mean/min/max = 44.9851/32.1089/57.8613

[11:33:00.898] <TB2>     INFO:    roc 2 with ID = 2  has maximal Vcal 58.0518 for pixel 0/0 mean/min/max = 45.1689/32.2369/58.1009

[11:33:00.898] <TB2>     INFO:    roc 3 with ID = 3  has maximal Vcal 61.3039 for pixel 0/4 mean/min/max = 46.6282/31.9052/61.3511

[11:33:00.898] <TB2>     INFO:    roc 4 with ID = 4  has maximal Vcal 55.7844 for pixel 13/2 mean/min/max = 44.0607/32.2926/55.8288

[11:33:00.899] <TB2>     INFO:    roc 5 with ID = 5  has maximal Vcal 58.1525 for pixel 6/37 mean/min/max = 45.122/32.0058/58.2382

[11:33:00.899] <TB2>     INFO:    roc 6 with ID = 6  has maximal Vcal 59.4362 for pixel 2/75 mean/min/max = 45.8589/32.1021/59.6158

[11:33:00.899] <TB2>     INFO:    roc 7 with ID = 7  has maximal Vcal 57.934 for pixel 13/6 mean/min/max = 44.8025/31.6014/58.0037

[11:33:00.899] <TB2>     INFO:    roc 8 with ID = 8  has maximal Vcal 65.5446 for pixel 23/71 mean/min/max = 50.1003/34.6352/65.5653

[11:33:00.900] <TB2>     INFO:    roc 9 with ID = 9  has maximal Vcal 61.495 for pixel 0/65 mean/min/max = 47.6866/33.8487/61.5246

[11:33:00.900] <TB2>     INFO:    roc 10 with ID = 10  has maximal Vcal 53.8955 for pixel 26/79 mean/min/max = 43.0479/31.9376/54.1582

[11:33:00.900] <TB2>     INFO:    roc 11 with ID = 11  has maximal Vcal 56.9959 for pixel 1/12 mean/min/max = 44.8389/32.283/57.3948

[11:33:00.900] <TB2>     INFO:    roc 12 with ID = 12  has maximal Vcal 68.118 for pixel 0/37 mean/min/max = 49.6484/30.8828/68.4141

[11:33:00.900] <TB2>     INFO:    roc 13 with ID = 13  has maximal Vcal 57.7208 for pixel 22/10 mean/min/max = 45.0352/32.3479/57.7225

[11:33:00.901] <TB2>     INFO:    roc 14 with ID = 14  has maximal Vcal 61.0031 for pixel 23/79 mean/min/max = 47.5298/33.7659/61.2937

[11:33:00.901] <TB2>     INFO:    roc 15 with ID = 15  has maximal Vcal 57.9995 for pixel 32/6 mean/min/max = 44.9319/31.7323/58.1315

[11:33:00.901] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[11:33:01.032] <TB2>     INFO: Expecting 514560 events.

[11:33:12.517] <TB2>     INFO: 514560 events read in total (10769ms).

[11:33:12.523] <TB2>     INFO: Expecting 514560 events.

[11:33:24.966] <TB2>     INFO: 514560 events read in total (11868ms).

[11:33:24.975] <TB2>     INFO: Expecting 514560 events.

[11:33:37.250] <TB2>     INFO: 514560 events read in total (11703ms).

[11:33:37.259] <TB2>     INFO: Expecting 514560 events.

[11:33:48.999] <TB2>     INFO: 514560 events read in total (11167ms).

[11:33:49.014] <TB2>     INFO: Expecting 514560 events.

[11:34:01.684] <TB2>     INFO: 514560 events read in total (12111ms).

[11:34:01.698] <TB2>     INFO: Expecting 514560 events.

[11:34:13.514] <TB2>     INFO: 514560 events read in total (11246ms).

[11:34:13.530] <TB2>     INFO: Expecting 514560 events.

[11:34:25.971] <TB2>     INFO: 514560 events read in total (11878ms).

[11:34:25.989] <TB2>     INFO: Expecting 514560 events.

[11:34:38.295] <TB2>     INFO: 514560 events read in total (11743ms).

[11:34:38.314] <TB2>     INFO: Expecting 514560 events.

[11:34:50.089] <TB2>     INFO: 514560 events read in total (11210ms).

[11:34:50.111] <TB2>     INFO: Expecting 514560 events.

[11:35:03.112] <TB2>     INFO: 514560 events read in total (12443ms).

[11:35:03.136] <TB2>     INFO: Expecting 514560 events.

[11:35:14.922] <TB2>     INFO: 514560 events read in total (11234ms).

[11:35:14.948] <TB2>     INFO: Expecting 514560 events.

[11:35:27.188] <TB2>     INFO: 514560 events read in total (11684ms).

[11:35:27.215] <TB2>     INFO: Expecting 514560 events.

[11:35:39.223] <TB2>     INFO: 514560 events read in total (11449ms).

[11:35:39.251] <TB2>     INFO: Expecting 514560 events.

[11:35:49.997] <TB2>     INFO: 514560 events read in total (10185ms).

[11:35:50.033] <TB2>     INFO: Expecting 514560 events.

[11:36:02.438] <TB2>     INFO: 514560 events read in total (11856ms).

[11:36:02.477] <TB2>     INFO: Expecting 514560 events.

[11:36:14.843] <TB2>     INFO: 514560 events read in total (11828ms).

[11:36:14.889] <TB2>     INFO: Test took 193988ms.

[11:36:16.194] <TB2>     INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)

[11:36:16.202] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:36:16.203] <TB2>     INFO:     run 1 of 1

[11:36:16.539] <TB2>     INFO: Expecting 6281600 events.

[11:36:50.214] <TB2>     INFO: 741760 events read in total (32959ms).

[11:37:22.964] <TB2>     INFO: 1482050 events read in total (65709ms).

[11:37:55.678] <TB2>     INFO: 2223160 events read in total (98423ms).

[11:38:28.777] <TB2>     INFO: 2964540 events read in total (131522ms).

[11:39:01.805] <TB2>     INFO: 3700300 events read in total (164550ms).

[11:39:35.356] <TB2>     INFO: 4432640 events read in total (198101ms).

[11:40:10.242] <TB2>     INFO: 5162980 events read in total (232987ms).

[11:40:43.945] <TB2>     INFO: 5892970 events read in total (266690ms).

[11:41:02.343] <TB2>     INFO: 6281600 events read in total (285088ms).

[11:41:02.385] <TB2>     INFO: Test took 286182ms.

[11:41:02.525] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:41:25.214] <TB2>     INFO: ---> TrimStepCorr4 extremal thresholds: 0.130052 .. 255.000000

[11:41:25.289] <TB2>     INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)

[11:41:25.297] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:41:25.297] <TB2>     INFO:     run 1 of 1

[11:41:25.601] <TB2>     INFO: Expecting 10649600 events.

[11:42:00.291] <TB2>     INFO: 712350 events read in total (33975ms).

[11:42:33.336] <TB2>     INFO: 1424410 events read in total (67020ms).

[11:43:07.701] <TB2>     INFO: 2136730 events read in total (101385ms).

[11:43:40.890] <TB2>     INFO: 2849010 events read in total (134574ms).

[11:44:14.084] <TB2>     INFO: 3561690 events read in total (167768ms).

[11:44:47.776] <TB2>     INFO: 4274260 events read in total (201460ms).

[11:45:20.204] <TB2>     INFO: 4986630 events read in total (233888ms).

[11:45:53.803] <TB2>     INFO: 5699190 events read in total (267487ms).

[11:46:27.811] <TB2>     INFO: 6411400 events read in total (301495ms).

[11:47:02.145] <TB2>     INFO: 7123010 events read in total (335829ms).

[11:47:35.368] <TB2>     INFO: 7834450 events read in total (369052ms).

[11:48:08.865] <TB2>     INFO: 8545170 events read in total (402549ms).

[11:48:42.367] <TB2>     INFO: 9255880 events read in total (436051ms).

[11:49:16.443] <TB2>     INFO: 9966870 events read in total (470127ms).

[11:49:49.550] <TB2>     INFO: 10649600 events read in total (503234ms).

[11:49:49.636] <TB2>     INFO: Test took 504340ms.

[11:49:49.901] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:50:18.339] <TB2>     INFO: ---> TrimStepCorr2 extremal thresholds: 14.362276 .. 84.462766

[11:50:18.414] <TB2>     INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 4 .. 94 (-1/-1) hits flags = 528 (plus default)

[11:50:18.421] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:50:18.421] <TB2>     INFO:     run 1 of 1

[11:50:18.723] <TB2>     INFO: Expecting 3785600 events.

[11:50:53.507] <TB2>     INFO: 798650 events read in total (34068ms).

[11:51:28.534] <TB2>     INFO: 1597660 events read in total (69095ms).

[11:52:03.745] <TB2>     INFO: 2396000 events read in total (104306ms).

[11:52:39.129] <TB2>     INFO: 3193890 events read in total (139690ms).

[11:53:04.093] <TB2>     INFO: 3785600 events read in total (164654ms).

[11:53:04.116] <TB2>     INFO: Test took 165695ms.

[11:53:04.187] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:53:22.545] <TB2>     INFO: ---> TrimStepCorr1a extremal thresholds: 21.110861 .. 73.371352

[11:53:22.620] <TB2>     INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 11 .. 83 (-1/-1) hits flags = 528 (plus default)

[11:53:22.629] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:53:22.629] <TB2>     INFO:     run 1 of 1

[11:53:22.954] <TB2>     INFO: Expecting 3036800 events.

[11:53:58.095] <TB2>     INFO: 794080 events read in total (34425ms).

[11:54:32.032] <TB2>     INFO: 1588360 events read in total (68363ms).

[11:55:07.367] <TB2>     INFO: 2381960 events read in total (103697ms).

[11:55:37.817] <TB2>     INFO: 3036800 events read in total (134147ms).

[11:55:37.839] <TB2>     INFO: Test took 135210ms.

[11:55:37.901] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:55:54.956] <TB2>     INFO: ---> TrimStepCorr1b extremal thresholds: 17.886566 .. 52.405932

[11:55:55.031] <TB2>     INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 7 .. 62 (-1/-1) hits flags = 528 (plus default)

[11:55:55.039] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:55:55.039] <TB2>     INFO:     run 1 of 1

[11:55:55.341] <TB2>     INFO: Expecting 2329600 events.

[11:56:32.836] <TB2>     INFO: 884670 events read in total (36779ms).

[11:57:09.332] <TB2>     INFO: 1769470 events read in total (73275ms).

[11:57:33.042] <TB2>     INFO: 2329600 events read in total (96985ms).

[11:57:33.059] <TB2>     INFO: Test took 98020ms.

[11:57:33.096] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:57:48.549] <TB2>     INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55

[11:57:48.549] <TB2>     INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)

[11:57:48.556] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 10

[11:57:48.557] <TB2>     INFO:     run 1 of 1

[11:57:48.863] <TB2>     INFO: Expecting 1705600 events.

[11:58:25.871] <TB2>     INFO: 878440 events read in total (36292ms).

[11:58:59.437] <TB2>     INFO: 1705600 events read in total (69858ms).

[11:58:59.451] <TB2>     INFO: Test took 70894ms.

[11:58:59.481] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[11:59:13.183] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C0.dat

[11:59:13.183] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C1.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C2.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C3.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C4.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C5.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C6.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C7.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C8.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C9.dat

[11:59:13.184] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C10.dat

[11:59:13.185] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C11.dat

[11:59:13.185] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C12.dat

[11:59:13.185] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C13.dat

[11:59:13.185] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C14.dat

[11:59:13.185] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C15.dat

[11:59:13.185] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C0.dat

[11:59:13.193] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C1.dat

[11:59:13.199] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C2.dat

[11:59:13.205] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C3.dat

[11:59:13.211] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C4.dat

[11:59:13.217] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C5.dat

[11:59:13.223] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C6.dat

[11:59:13.229] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C7.dat

[11:59:13.235] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C8.dat

[11:59:13.241] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C9.dat

[11:59:13.247] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C10.dat

[11:59:13.253] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C11.dat

[11:59:13.259] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C12.dat

[11:59:13.265] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C13.dat

[11:59:13.271] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C14.dat

[11:59:13.277] <TB2>     INFO: write trim parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//trimParameters35_C15.dat

[11:59:13.283] <TB2>     INFO: PixTestTrim::trimTest() done

[11:59:13.283] <TB2>     INFO: vtrim:     104 104 118 107  94 104 109 106 130 134  91  99 114  97 111 101 

[11:59:13.283] <TB2>     INFO: vthrcomp:  102  91  90  93  94  91  91  96 108 108  81  90 101  93 108  96 

[11:59:13.283] <TB2>     INFO: vcal mean:  35.01  35.00  34.97  34.95  34.95  34.95  34.94  34.97  34.97  35.02  34.99  34.97  34.93  35.01  35.00  34.99 

[11:59:13.283] <TB2>     INFO: vcal RMS:    0.83   0.83   0.94   1.03   0.80   0.85   0.83   0.88   0.93   0.98   0.74   0.85   1.27   0.85   0.87   0.91 

[11:59:13.284] <TB2>     INFO: bits mean:   9.57   9.64   9.30   9.13   9.83   9.45   9.37   9.93   8.49   8.68   9.95   9.72   9.16   9.32   8.68   9.87 

[11:59:13.284] <TB2>     INFO: bits RMS:    2.74   2.65   2.68   2.83   2.57   2.79   2.70   2.60   2.43   2.59   2.61   2.62   2.64   2.77   2.66   2.63 

[11:59:13.291] <TB2>     INFO:    ----------------------------------------------------------------------

[11:59:13.291] <TB2>     INFO:    PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32

[11:59:13.291] <TB2>     INFO:    ----------------------------------------------------------------------

[11:59:13.293] <TB2>     INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)

[11:59:13.301] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[11:59:13.301] <TB2>     INFO:     run 1 of 1

[11:59:13.603] <TB2>     INFO: Expecting 4160000 events.

[11:59:57.988] <TB2>     INFO: 931365 events read in total (43669ms).

[12:00:41.456] <TB2>     INFO: 1855915 events read in total (87137ms).

[12:01:23.532] <TB2>     INFO: 2772660 events read in total (129213ms).

[12:02:06.422] <TB2>     INFO: 3687395 events read in total (172103ms).

[12:02:29.027] <TB2>     INFO: 4160000 events read in total (194708ms).

[12:02:29.080] <TB2>     INFO: Test took 195780ms.

[12:02:29.179] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:02:56.693] <TB2>     INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)

[12:02:56.701] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[12:02:56.701] <TB2>     INFO:     run 1 of 1

[12:02:57.003] <TB2>     INFO: Expecting 3868800 events.

[12:03:41.338] <TB2>     INFO: 929325 events read in total (43620ms).

[12:04:23.522] <TB2>     INFO: 1851770 events read in total (85804ms).

[12:05:06.339] <TB2>     INFO: 2764205 events read in total (128621ms).

[12:05:48.729] <TB2>     INFO: 3675640 events read in total (171011ms).

[12:05:58.475] <TB2>     INFO: 3868800 events read in total (180757ms).

[12:05:58.511] <TB2>     INFO: Test took 181810ms.

[12:05:58.605] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:06:25.390] <TB2>     INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 176 (-1/-1) hits flags = 528 (plus default)

[12:06:25.398] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[12:06:25.398] <TB2>     INFO:     run 1 of 1

[12:06:25.705] <TB2>     INFO: Expecting 3681600 events.

[12:07:09.014] <TB2>     INFO: 948535 events read in total (42593ms).

[12:07:52.501] <TB2>     INFO: 1888415 events read in total (86080ms).

[12:08:34.702] <TB2>     INFO: 2817525 events read in total (128281ms).

[12:09:13.989] <TB2>     INFO: 3681600 events read in total (167568ms).

[12:09:14.031] <TB2>     INFO: Test took 168633ms.

[12:09:14.120] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:09:43.964] <TB2>     INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 175 (-1/-1) hits flags = 528 (plus default)

[12:09:43.973] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[12:09:43.973] <TB2>     INFO:     run 1 of 1

[12:09:44.314] <TB2>     INFO: Expecting 3660800 events.

[12:10:27.996] <TB2>     INFO: 950355 events read in total (42967ms).

[12:11:10.921] <TB2>     INFO: 1891970 events read in total (85892ms).

[12:11:53.149] <TB2>     INFO: 2822950 events read in total (128120ms).

[12:12:31.280] <TB2>     INFO: 3660800 events read in total (166251ms).

[12:12:31.323] <TB2>     INFO: Test took 167350ms.

[12:12:31.420] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:12:57.272] <TB2>     INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 171 (-1/-1) hits flags = 528 (plus default)

[12:12:57.280] <TB2>     INFO:   dacScan split into 1 runs with ntrig = 5

[12:12:57.280] <TB2>     INFO:     run 1 of 1

[12:12:57.585] <TB2>     INFO: Expecting 3577600 events.

[12:13:42.670] <TB2>     INFO: 959545 events read in total (44369ms).

[12:14:26.164] <TB2>     INFO: 1909225 events read in total (87863ms).

[12:15:10.093] <TB2>     INFO: 2848310 events read in total (131792ms).

[12:15:43.153] <TB2>     INFO: 3577600 events read in total (164852ms).

[12:15:43.191] <TB2>     INFO: Test took 165911ms.

[12:15:43.270] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:10.911] <TB2>     INFO: PixTestTrim::trimBitTest() done 

[12:16:10.913] <TB2>     INFO: PixTestTrim::doTest() done, duration: 3145 seconds

[12:16:10.913] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:10.913] <TB2>     INFO: Decoding statistics:

[12:16:10.913] <TB2>     INFO:   General information:

[12:16:10.913] <TB2>     INFO: 	 16bit words read:         0

[12:16:10.913] <TB2>     INFO: 	 valid events total:       0

[12:16:10.913] <TB2>     INFO: 	 empty events:             0

[12:16:10.913] <TB2>     INFO: 	 valid events with pixels: 0

[12:16:10.913] <TB2>     INFO: 	 valid pixel hits:         0

[12:16:10.913] <TB2>     INFO:   Event errors: 	           0

[12:16:10.913] <TB2>     INFO: 	 start marker:             0

[12:16:10.913] <TB2>     INFO: 	 stop marker:              0

[12:16:10.913] <TB2>     INFO: 	 overflow:                 0

[12:16:10.913] <TB2>     INFO: 	 invalid 5bit words:       0

[12:16:10.913] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[12:16:10.913] <TB2>     INFO:   TBM errors: 		           0

[12:16:10.913] <TB2>     INFO: 	 flawed TBM headers:       0

[12:16:10.913] <TB2>     INFO: 	 flawed TBM trailers:      0

[12:16:10.913] <TB2>     INFO: 	 event ID mismatches:      0

[12:16:10.913] <TB2>     INFO:   ROC errors: 		           0

[12:16:10.913] <TB2>     INFO: 	 missing ROC header(s):    0

[12:16:10.913] <TB2>     INFO: 	 misplaced readback start: 0

[12:16:10.913] <TB2>     INFO:   Pixel decoding errors:	   0

[12:16:10.913] <TB2>     INFO: 	 pixel data incomplete:    0

[12:16:10.913] <TB2>     INFO: 	 pixel address:            0

[12:16:10.913] <TB2>     INFO: 	 pulse height fill bit:    0

[12:16:10.913] <TB2>     INFO: 	 buffer corruption:        0

[12:16:11.646] <TB2>     INFO: ######################################################################

[12:16:11.646] <TB2>     INFO: PixTestPhOptimization::doTest() Ntrig = 10

[12:16:11.646] <TB2>     INFO: ######################################################################

[12:16:11.971] <TB2>     INFO: Expecting 41600 events.

[12:16:16.489] <TB2>     INFO: 41600 events read in total (3802ms).

[12:16:16.490] <TB2>     INFO: Test took 4842ms.

[12:16:16.498] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:17.091] <TB2>     INFO: Expecting 41600 events.

[12:16:21.680] <TB2>     INFO: 41600 events read in total (3873ms).

[12:16:21.680] <TB2>     INFO: Test took 4929ms.

[12:16:21.686] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:22.041] <TB2>     INFO: Expecting 41600 events.

[12:16:26.216] <TB2>     INFO: 41600 events read in total (3460ms).

[12:16:26.217] <TB2>     INFO: Test took 4499ms.

[12:16:26.223] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:26.575] <TB2>     INFO: Expecting 41600 events.

[12:16:30.872] <TB2>     INFO: 41600 events read in total (3582ms).

[12:16:30.872] <TB2>     INFO: Test took 4620ms.

[12:16:30.878] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:31.233] <TB2>     INFO: Expecting 41600 events.

[12:16:35.698] <TB2>     INFO: 41600 events read in total (3749ms).

[12:16:35.699] <TB2>     INFO: Test took 4788ms.

[12:16:35.705] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:36.060] <TB2>     INFO: Expecting 41600 events.

[12:16:40.461] <TB2>     INFO: 41600 events read in total (3685ms).

[12:16:40.461] <TB2>     INFO: Test took 4724ms.

[12:16:40.467] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:40.822] <TB2>     INFO: Expecting 41600 events.

[12:16:45.269] <TB2>     INFO: 41600 events read in total (3731ms).

[12:16:45.270] <TB2>     INFO: Test took 4770ms.

[12:16:45.276] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:45.619] <TB2>     INFO: Expecting 41600 events.

[12:16:49.962] <TB2>     INFO: 41600 events read in total (3627ms).

[12:16:49.963] <TB2>     INFO: Test took 4666ms.

[12:16:49.969] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:50.318] <TB2>     INFO: Expecting 41600 events.

[12:16:54.603] <TB2>     INFO: 41600 events read in total (3570ms).

[12:16:54.604] <TB2>     INFO: Test took 4609ms.

[12:16:54.610] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:54.957] <TB2>     INFO: Expecting 41600 events.

[12:16:59.589] <TB2>     INFO: 41600 events read in total (3917ms).

[12:16:59.590] <TB2>     INFO: Test took 4956ms.

[12:16:59.600] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:16:59.948] <TB2>     INFO: Expecting 41600 events.

[12:17:04.419] <TB2>     INFO: 41600 events read in total (3755ms).

[12:17:04.420] <TB2>     INFO: Test took 4794ms.

[12:17:04.426] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:04.780] <TB2>     INFO: Expecting 41600 events.

[12:17:09.327] <TB2>     INFO: 41600 events read in total (3831ms).

[12:17:09.328] <TB2>     INFO: Test took 4871ms.

[12:17:09.334] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:09.674] <TB2>     INFO: Expecting 41600 events.

[12:17:14.230] <TB2>     INFO: 41600 events read in total (3841ms).

[12:17:14.231] <TB2>     INFO: Test took 4880ms.

[12:17:14.238] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:14.571] <TB2>     INFO: Expecting 41600 events.

[12:17:18.876] <TB2>     INFO: 41600 events read in total (3590ms).

[12:17:18.877] <TB2>     INFO: Test took 4629ms.

[12:17:18.883] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:19.239] <TB2>     INFO: Expecting 41600 events.

[12:17:23.693] <TB2>     INFO: 41600 events read in total (3739ms).

[12:17:23.694] <TB2>     INFO: Test took 4778ms.

[12:17:23.701] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:24.042] <TB2>     INFO: Expecting 41600 events.

[12:17:28.656] <TB2>     INFO: 41600 events read in total (3899ms).

[12:17:28.656] <TB2>     INFO: Test took 4938ms.

[12:17:28.662] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:29.015] <TB2>     INFO: Expecting 41600 events.

[12:17:33.544] <TB2>     INFO: 41600 events read in total (3813ms).

[12:17:33.544] <TB2>     INFO: Test took 4858ms.

[12:17:33.550] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:33.906] <TB2>     INFO: Expecting 41600 events.

[12:17:38.475] <TB2>     INFO: 41600 events read in total (3854ms).

[12:17:38.475] <TB2>     INFO: Test took 4892ms.

[12:17:38.482] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:38.822] <TB2>     INFO: Expecting 41600 events.

[12:17:43.140] <TB2>     INFO: 41600 events read in total (3602ms).

[12:17:43.140] <TB2>     INFO: Test took 4641ms.

[12:17:43.146] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:43.490] <TB2>     INFO: Expecting 41600 events.

[12:17:47.731] <TB2>     INFO: 41600 events read in total (3526ms).

[12:17:47.732] <TB2>     INFO: Test took 4568ms.

[12:17:47.738] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:48.085] <TB2>     INFO: Expecting 41600 events.

[12:17:52.604] <TB2>     INFO: 41600 events read in total (3803ms).

[12:17:52.605] <TB2>     INFO: Test took 4842ms.

[12:17:52.611] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:52.958] <TB2>     INFO: Expecting 41600 events.

[12:17:57.364] <TB2>     INFO: 41600 events read in total (3690ms).

[12:17:57.365] <TB2>     INFO: Test took 4729ms.

[12:17:57.371] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:17:57.723] <TB2>     INFO: Expecting 41600 events.

[12:18:02.472] <TB2>     INFO: 41600 events read in total (4033ms).

[12:18:02.473] <TB2>     INFO: Test took 5072ms.

[12:18:02.479] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:02.813] <TB2>     INFO: Expecting 41600 events.

[12:18:07.420] <TB2>     INFO: 41600 events read in total (3891ms).

[12:18:07.420] <TB2>     INFO: Test took 4930ms.

[12:18:07.426] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:07.777] <TB2>     INFO: Expecting 41600 events.

[12:18:12.103] <TB2>     INFO: 41600 events read in total (3610ms).

[12:18:12.103] <TB2>     INFO: Test took 4648ms.

[12:18:12.110] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:12.458] <TB2>     INFO: Expecting 41600 events.

[12:18:16.956] <TB2>     INFO: 41600 events read in total (3782ms).

[12:18:16.956] <TB2>     INFO: Test took 4829ms.

[12:18:16.962] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:17.315] <TB2>     INFO: Expecting 41600 events.

[12:18:21.971] <TB2>     INFO: 41600 events read in total (3940ms).

[12:18:21.971] <TB2>     INFO: Test took 4978ms.

[12:18:21.978] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:22.317] <TB2>     INFO: Expecting 41600 events.

[12:18:26.734] <TB2>     INFO: 41600 events read in total (3701ms).

[12:18:26.735] <TB2>     INFO: Test took 4740ms.

[12:18:26.741] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:27.079] <TB2>     INFO: Expecting 41600 events.

[12:18:31.694] <TB2>     INFO: 41600 events read in total (3900ms).

[12:18:31.694] <TB2>     INFO: Test took 4938ms.

[12:18:31.700] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:32.047] <TB2>     INFO: Expecting 41600 events.

[12:18:36.353] <TB2>     INFO: 41600 events read in total (3591ms).

[12:18:36.354] <TB2>     INFO: Test took 4630ms.

[12:18:36.360] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:36.695] <TB2>     INFO: Expecting 41600 events.

[12:18:40.950] <TB2>     INFO: 41600 events read in total (3540ms).

[12:18:40.950] <TB2>     INFO: Test took 4578ms.

[12:18:40.956] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:41.306] <TB2>     INFO: Expecting 41600 events.

[12:18:46.060] <TB2>     INFO: 41600 events read in total (4038ms).

[12:18:46.061] <TB2>     INFO: Test took 5078ms.

[12:18:46.067] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:46.417] <TB2>     INFO: Expecting 41600 events.

[12:18:50.857] <TB2>     INFO: 41600 events read in total (3724ms).

[12:18:50.857] <TB2>     INFO: Test took 4763ms.

[12:18:50.863] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:51.217] <TB2>     INFO: Expecting 41600 events.

[12:18:55.829] <TB2>     INFO: 41600 events read in total (3897ms).

[12:18:55.829] <TB2>     INFO: Test took 4935ms.

[12:18:55.835] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:18:56.190] <TB2>     INFO: Expecting 41600 events.

[12:19:00.554] <TB2>     INFO: 41600 events read in total (3648ms).

[12:19:00.555] <TB2>     INFO: Test took 4688ms.

[12:19:00.561] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:00.916] <TB2>     INFO: Expecting 41600 events.

[12:19:05.189] <TB2>     INFO: 41600 events read in total (3557ms).

[12:19:05.189] <TB2>     INFO: Test took 4596ms.

[12:19:05.197] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:05.544] <TB2>     INFO: Expecting 41600 events.

[12:19:10.096] <TB2>     INFO: 41600 events read in total (3837ms).

[12:19:10.097] <TB2>     INFO: Test took 4887ms.

[12:19:10.103] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:10.457] <TB2>     INFO: Expecting 41600 events.

[12:19:14.962] <TB2>     INFO: 41600 events read in total (3787ms).

[12:19:14.963] <TB2>     INFO: Test took 4828ms.

[12:19:14.969] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:15.299] <TB2>     INFO: Expecting 41600 events.

[12:19:19.885] <TB2>     INFO: 41600 events read in total (3866ms).

[12:19:19.886] <TB2>     INFO: Test took 4908ms.

[12:19:19.893] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:20.234] <TB2>     INFO: Expecting 41600 events.

[12:19:24.677] <TB2>     INFO: 41600 events read in total (3727ms).

[12:19:24.677] <TB2>     INFO: Test took 4766ms.

[12:19:24.684] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:25.024] <TB2>     INFO: Expecting 41600 events.

[12:19:29.200] <TB2>     INFO: 41600 events read in total (3461ms).

[12:19:29.201] <TB2>     INFO: Test took 4500ms.

[12:19:29.207] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:29.578] <TB2>     INFO: Expecting 41600 events.

[12:19:33.765] <TB2>     INFO: 41600 events read in total (3472ms).

[12:19:33.765] <TB2>     INFO: Test took 4529ms.

[12:19:33.772] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:34.124] <TB2>     INFO: Expecting 41600 events.

[12:19:38.549] <TB2>     INFO: 41600 events read in total (3710ms).

[12:19:38.550] <TB2>     INFO: Test took 4749ms.

[12:19:38.556] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:38.910] <TB2>     INFO: Expecting 41600 events.

[12:19:43.435] <TB2>     INFO: 41600 events read in total (3810ms).

[12:19:43.435] <TB2>     INFO: Test took 4848ms.

[12:19:43.441] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:43.793] <TB2>     INFO: Expecting 41600 events.

[12:19:48.232] <TB2>     INFO: 41600 events read in total (3723ms).

[12:19:48.233] <TB2>     INFO: Test took 4763ms.

[12:19:48.239] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:48.591] <TB2>     INFO: Expecting 41600 events.

[12:19:53.101] <TB2>     INFO: 41600 events read in total (3794ms).

[12:19:53.102] <TB2>     INFO: Test took 4834ms.

[12:19:53.108] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:53.461] <TB2>     INFO: Expecting 41600 events.

[12:19:57.773] <TB2>     INFO: 41600 events read in total (3596ms).

[12:19:57.773] <TB2>     INFO: Test took 4634ms.

[12:19:57.779] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:19:58.125] <TB2>     INFO: Expecting 41600 events.

[12:20:02.718] <TB2>     INFO: 41600 events read in total (3877ms).

[12:20:02.718] <TB2>     INFO: Test took 4915ms.

[12:20:02.725] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:03.079] <TB2>     INFO: Expecting 41600 events.

[12:20:07.585] <TB2>     INFO: 41600 events read in total (3791ms).

[12:20:07.586] <TB2>     INFO: Test took 4830ms.

[12:20:07.598] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:07.942] <TB2>     INFO: Expecting 41600 events.

[12:20:12.434] <TB2>     INFO: 41600 events read in total (3777ms).

[12:20:12.435] <TB2>     INFO: Test took 4816ms.

[12:20:12.441] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:12.791] <TB2>     INFO: Expecting 41600 events.

[12:20:17.394] <TB2>     INFO: 41600 events read in total (3887ms).

[12:20:17.395] <TB2>     INFO: Test took 4926ms.

[12:20:17.402] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:17.750] <TB2>     INFO: Expecting 41600 events.

[12:20:22.160] <TB2>     INFO: 41600 events read in total (3694ms).

[12:20:22.161] <TB2>     INFO: Test took 4748ms.

[12:20:22.167] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:22.512] <TB2>     INFO: Expecting 41600 events.

[12:20:27.041] <TB2>     INFO: 41600 events read in total (3813ms).

[12:20:27.042] <TB2>     INFO: Test took 4867ms.

[12:20:27.049] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:27.385] <TB2>     INFO: Expecting 41600 events.

[12:20:31.855] <TB2>     INFO: 41600 events read in total (3754ms).

[12:20:31.856] <TB2>     INFO: Test took 4796ms.

[12:20:31.862] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:20:32.197] <TB2>     INFO: Expecting 2560 events.

[12:20:33.261] <TB2>     INFO: 2560 events read in total (348ms).

[12:20:33.261] <TB2>     INFO: Test took 1390ms.

[12:20:33.675] <TB2>     INFO: Expecting 2560 events.

[12:20:34.767] <TB2>     INFO: 2560 events read in total (377ms).

[12:20:34.767] <TB2>     INFO: Test took 1506ms.

[12:20:35.181] <TB2>     INFO: Expecting 2560 events.

[12:20:36.241] <TB2>     INFO: 2560 events read in total (345ms).

[12:20:36.242] <TB2>     INFO: Test took 1475ms.

[12:20:36.655] <TB2>     INFO: Expecting 2560 events.

[12:20:37.730] <TB2>     INFO: 2560 events read in total (359ms).

[12:20:37.730] <TB2>     INFO: Test took 1488ms.

[12:20:38.144] <TB2>     INFO: Expecting 2560 events.

[12:20:39.206] <TB2>     INFO: 2560 events read in total (346ms).

[12:20:39.206] <TB2>     INFO: Test took 1475ms.

[12:20:39.620] <TB2>     INFO: Expecting 2560 events.

[12:20:40.697] <TB2>     INFO: 2560 events read in total (361ms).

[12:20:40.697] <TB2>     INFO: Test took 1490ms.

[12:20:41.111] <TB2>     INFO: Expecting 2560 events.

[12:20:42.187] <TB2>     INFO: 2560 events read in total (361ms).

[12:20:42.187] <TB2>     INFO: Test took 1490ms.

[12:20:42.601] <TB2>     INFO: Expecting 2560 events.

[12:20:43.664] <TB2>     INFO: 2560 events read in total (347ms).

[12:20:43.664] <TB2>     INFO: Test took 1476ms.

[12:20:44.078] <TB2>     INFO: Expecting 2560 events.

[12:20:45.138] <TB2>     INFO: 2560 events read in total (345ms).

[12:20:45.138] <TB2>     INFO: Test took 1474ms.

[12:20:45.552] <TB2>     INFO: Expecting 2560 events.

[12:20:46.613] <TB2>     INFO: 2560 events read in total (346ms).

[12:20:46.613] <TB2>     INFO: Test took 1475ms.

[12:20:47.027] <TB2>     INFO: Expecting 2560 events.

[12:20:48.102] <TB2>     INFO: 2560 events read in total (360ms).

[12:20:48.102] <TB2>     INFO: Test took 1489ms.

[12:20:48.516] <TB2>     INFO: Expecting 2560 events.

[12:20:49.577] <TB2>     INFO: 2560 events read in total (346ms).

[12:20:49.577] <TB2>     INFO: Test took 1475ms.

[12:20:49.991] <TB2>     INFO: Expecting 2560 events.

[12:20:51.053] <TB2>     INFO: 2560 events read in total (346ms).

[12:20:51.053] <TB2>     INFO: Test took 1475ms.

[12:20:51.467] <TB2>     INFO: Expecting 2560 events.

[12:20:52.558] <TB2>     INFO: 2560 events read in total (375ms).

[12:20:52.558] <TB2>     INFO: Test took 1504ms.

[12:20:52.972] <TB2>     INFO: Expecting 2560 events.

[12:20:54.034] <TB2>     INFO: 2560 events read in total (346ms).

[12:20:54.034] <TB2>     INFO: Test took 1475ms.

[12:20:54.448] <TB2>     INFO: Expecting 2560 events.

[12:20:55.523] <TB2>     INFO: 2560 events read in total (360ms).

[12:20:55.523] <TB2>     INFO: Test took 1489ms.

[12:20:55.526] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:20:55.939] <TB2>     INFO: Expecting 655360 events.

[12:21:12.273] <TB2>     INFO: 655360 events read in total (15618ms).

[12:21:12.288] <TB2>     INFO: Expecting 655360 events.

[12:21:28.706] <TB2>     INFO: 655360 events read in total (15890ms).

[12:21:28.720] <TB2>     INFO: Expecting 655360 events.

[12:21:44.427] <TB2>     INFO: 655360 events read in total (15180ms).

[12:21:44.450] <TB2>     INFO: Expecting 655360 events.

[12:22:00.955] <TB2>     INFO: 655360 events read in total (15977ms).

[12:22:00.978] <TB2>     INFO: Expecting 655360 events.

[12:22:15.739] <TB2>     INFO: 655360 events read in total (14234ms).

[12:22:15.772] <TB2>     INFO: Expecting 655360 events.

[12:22:32.269] <TB2>     INFO: 655360 events read in total (15969ms).

[12:22:32.295] <TB2>     INFO: Expecting 655360 events.

[12:22:47.010] <TB2>     INFO: 655360 events read in total (14188ms).

[12:22:47.040] <TB2>     INFO: Expecting 655360 events.

[12:23:03.553] <TB2>     INFO: 655360 events read in total (15986ms).

[12:23:03.592] <TB2>     INFO: Expecting 655360 events.

[12:23:19.165] <TB2>     INFO: 655360 events read in total (15046ms).

[12:23:19.200] <TB2>     INFO: Expecting 655360 events.

[12:23:35.913] <TB2>     INFO: 655360 events read in total (16186ms).

[12:23:35.976] <TB2>     INFO: Expecting 655360 events.

[12:23:52.001] <TB2>     INFO: 655360 events read in total (15498ms).

[12:23:52.046] <TB2>     INFO: Expecting 655360 events.

[12:24:08.256] <TB2>     INFO: 655360 events read in total (15683ms).

[12:24:08.304] <TB2>     INFO: Expecting 655360 events.

[12:24:23.959] <TB2>     INFO: 655360 events read in total (15128ms).

[12:24:24.012] <TB2>     INFO: Expecting 655360 events.

[12:24:40.697] <TB2>     INFO: 655360 events read in total (16158ms).

[12:24:40.754] <TB2>     INFO: Expecting 655360 events.

[12:24:56.519] <TB2>     INFO: 655360 events read in total (15238ms).

[12:24:56.579] <TB2>     INFO: Expecting 655360 events.

[12:25:12.773] <TB2>     INFO: 655360 events read in total (15667ms).

[12:25:12.837] <TB2>     INFO: Test took 257311ms.

[12:25:12.918] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:25:13.227] <TB2>     INFO: Expecting 655360 events.

[12:25:30.078] <TB2>     INFO: 655360 events read in total (16135ms).

[12:25:30.089] <TB2>     INFO: Expecting 655360 events.

[12:25:45.577] <TB2>     INFO: 655360 events read in total (14960ms).

[12:25:45.591] <TB2>     INFO: Expecting 655360 events.

[12:26:02.113] <TB2>     INFO: 655360 events read in total (15995ms).

[12:26:02.131] <TB2>     INFO: Expecting 655360 events.

[12:26:17.416] <TB2>     INFO: 655360 events read in total (14757ms).

[12:26:17.438] <TB2>     INFO: Expecting 655360 events.

[12:26:33.863] <TB2>     INFO: 655360 events read in total (15898ms).

[12:26:33.894] <TB2>     INFO: Expecting 655360 events.

[12:26:48.678] <TB2>     INFO: 655360 events read in total (14256ms).

[12:26:48.705] <TB2>     INFO: Expecting 655360 events.

[12:27:04.991] <TB2>     INFO: 655360 events read in total (15759ms).

[12:27:05.025] <TB2>     INFO: Expecting 655360 events.

[12:27:20.358] <TB2>     INFO: 655360 events read in total (14806ms).

[12:27:20.399] <TB2>     INFO: Expecting 655360 events.

[12:27:36.980] <TB2>     INFO: 655360 events read in total (16053ms).

[12:27:37.015] <TB2>     INFO: Expecting 655360 events.

[12:27:53.070] <TB2>     INFO: 655360 events read in total (15527ms).

[12:27:53.113] <TB2>     INFO: Expecting 655360 events.

[12:28:08.890] <TB2>     INFO: 655360 events read in total (15250ms).

[12:28:08.953] <TB2>     INFO: Expecting 655360 events.

[12:28:25.296] <TB2>     INFO: 655360 events read in total (15816ms).

[12:28:25.344] <TB2>     INFO: Expecting 655360 events.

[12:28:40.410] <TB2>     INFO: 655360 events read in total (14538ms).

[12:28:40.473] <TB2>     INFO: Expecting 655360 events.

[12:28:56.971] <TB2>     INFO: 655360 events read in total (15970ms).

[12:28:57.028] <TB2>     INFO: Expecting 655360 events.

[12:29:11.626] <TB2>     INFO: 655360 events read in total (14070ms).

[12:29:11.685] <TB2>     INFO: Expecting 655360 events.

[12:29:28.347] <TB2>     INFO: 655360 events read in total (16135ms).

[12:29:28.411] <TB2>     INFO: Test took 255494ms.

[12:29:28.608] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.614] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.621] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.628] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.635] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.642] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.649] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.656] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.663] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.670] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.676] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.683] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.690] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.697] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.704] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.711] <TB2>     INFO: safety margin for low PH: adding 0, margin is now 20

[12:29:28.718] <TB2>     INFO: safety margin for low PH: adding 1, margin is now 21

[12:29:28.725] <TB2>     INFO: safety margin for low PH: adding 2, margin is now 22

[12:29:28.731] <TB2>     INFO: safety margin for low PH: adding 3, margin is now 23

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C0.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C1.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C2.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C3.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C4.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C5.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C6.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C7.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C8.dat

[12:29:28.769] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C9.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C10.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C11.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C12.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C13.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C14.dat

[12:29:28.770] <TB2>     INFO: write dac parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//dacParameters35_C15.dat

[12:29:29.078] <TB2>     INFO: Expecting 41600 events.

[12:29:33.322] <TB2>     INFO: 41600 events read in total (3528ms).

[12:29:33.323] <TB2>     INFO: Test took 4550ms.

[12:29:33.902] <TB2>     INFO: Expecting 41600 events.

[12:29:37.864] <TB2>     INFO: 41600 events read in total (3247ms).

[12:29:37.865] <TB2>     INFO: Test took 4310ms.

[12:29:38.427] <TB2>     INFO: Expecting 41600 events.

[12:29:42.550] <TB2>     INFO: 41600 events read in total (3408ms).

[12:29:42.551] <TB2>     INFO: Test took 4462ms.

[12:29:42.791] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:42.922] <TB2>     INFO: Expecting 2560 events.

[12:29:43.983] <TB2>     INFO: 2560 events read in total (346ms).

[12:29:43.983] <TB2>     INFO: Test took 1192ms.

[12:29:43.985] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:44.398] <TB2>     INFO: Expecting 2560 events.

[12:29:45.459] <TB2>     INFO: 2560 events read in total (346ms).

[12:29:45.459] <TB2>     INFO: Test took 1474ms.

[12:29:45.461] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:45.874] <TB2>     INFO: Expecting 2560 events.

[12:29:47.010] <TB2>     INFO: 2560 events read in total (420ms).

[12:29:47.010] <TB2>     INFO: Test took 1549ms.

[12:29:47.012] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:47.425] <TB2>     INFO: Expecting 2560 events.

[12:29:48.503] <TB2>     INFO: 2560 events read in total (362ms).

[12:29:48.503] <TB2>     INFO: Test took 1491ms.

[12:29:48.505] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:48.918] <TB2>     INFO: Expecting 2560 events.

[12:29:50.000] <TB2>     INFO: 2560 events read in total (367ms).

[12:29:50.001] <TB2>     INFO: Test took 1496ms.

[12:29:50.003] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:50.415] <TB2>     INFO: Expecting 2560 events.

[12:29:51.513] <TB2>     INFO: 2560 events read in total (382ms).

[12:29:51.513] <TB2>     INFO: Test took 1510ms.

[12:29:51.516] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:51.928] <TB2>     INFO: Expecting 2560 events.

[12:29:53.014] <TB2>     INFO: 2560 events read in total (371ms).

[12:29:53.014] <TB2>     INFO: Test took 1498ms.

[12:29:53.017] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:53.429] <TB2>     INFO: Expecting 2560 events.

[12:29:54.504] <TB2>     INFO: 2560 events read in total (360ms).

[12:29:54.504] <TB2>     INFO: Test took 1488ms.

[12:29:54.506] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:54.920] <TB2>     INFO: Expecting 2560 events.

[12:29:55.998] <TB2>     INFO: 2560 events read in total (362ms).

[12:29:55.998] <TB2>     INFO: Test took 1492ms.

[12:29:56.000] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:56.413] <TB2>     INFO: Expecting 2560 events.

[12:29:57.481] <TB2>     INFO: 2560 events read in total (352ms).

[12:29:57.482] <TB2>     INFO: Test took 1482ms.

[12:29:57.489] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:57.896] <TB2>     INFO: Expecting 2560 events.

[12:29:58.959] <TB2>     INFO: 2560 events read in total (347ms).

[12:29:58.959] <TB2>     INFO: Test took 1470ms.

[12:29:58.961] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:29:59.373] <TB2>     INFO: Expecting 2560 events.

[12:30:00.443] <TB2>     INFO: 2560 events read in total (354ms).

[12:30:00.443] <TB2>     INFO: Test took 1483ms.

[12:30:00.444] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:00.858] <TB2>     INFO: Expecting 2560 events.

[12:30:01.930] <TB2>     INFO: 2560 events read in total (356ms).

[12:30:01.930] <TB2>     INFO: Test took 1486ms.

[12:30:01.932] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:02.345] <TB2>     INFO: Expecting 2560 events.

[12:30:03.416] <TB2>     INFO: 2560 events read in total (355ms).

[12:30:03.416] <TB2>     INFO: Test took 1484ms.

[12:30:03.419] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:03.831] <TB2>     INFO: Expecting 2560 events.

[12:30:04.899] <TB2>     INFO: 2560 events read in total (352ms).

[12:30:04.899] <TB2>     INFO: Test took 1480ms.

[12:30:04.902] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:05.314] <TB2>     INFO: Expecting 2560 events.

[12:30:06.383] <TB2>     INFO: 2560 events read in total (353ms).

[12:30:06.383] <TB2>     INFO: Test took 1481ms.

[12:30:06.386] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:06.798] <TB2>     INFO: Expecting 2560 events.

[12:30:07.889] <TB2>     INFO: 2560 events read in total (375ms).

[12:30:07.890] <TB2>     INFO: Test took 1505ms.

[12:30:07.891] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:08.304] <TB2>     INFO: Expecting 2560 events.

[12:30:09.388] <TB2>     INFO: 2560 events read in total (368ms).

[12:30:09.388] <TB2>     INFO: Test took 1497ms.

[12:30:09.390] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:09.802] <TB2>     INFO: Expecting 2560 events.

[12:30:10.870] <TB2>     INFO: 2560 events read in total (352ms).

[12:30:10.871] <TB2>     INFO: Test took 1481ms.

[12:30:10.873] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:11.285] <TB2>     INFO: Expecting 2560 events.

[12:30:12.346] <TB2>     INFO: 2560 events read in total (346ms).

[12:30:12.346] <TB2>     INFO: Test took 1473ms.

[12:30:12.348] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:12.761] <TB2>     INFO: Expecting 2560 events.

[12:30:13.837] <TB2>     INFO: 2560 events read in total (360ms).

[12:30:13.837] <TB2>     INFO: Test took 1489ms.

[12:30:13.838] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:14.251] <TB2>     INFO: Expecting 2560 events.

[12:30:15.313] <TB2>     INFO: 2560 events read in total (346ms).

[12:30:15.313] <TB2>     INFO: Test took 1475ms.

[12:30:15.315] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:15.728] <TB2>     INFO: Expecting 2560 events.

[12:30:16.812] <TB2>     INFO: 2560 events read in total (368ms).

[12:30:16.812] <TB2>     INFO: Test took 1497ms.

[12:30:16.814] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:17.228] <TB2>     INFO: Expecting 2560 events.

[12:30:18.290] <TB2>     INFO: 2560 events read in total (346ms).

[12:30:18.290] <TB2>     INFO: Test took 1476ms.

[12:30:18.292] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:18.705] <TB2>     INFO: Expecting 2560 events.

[12:30:19.775] <TB2>     INFO: 2560 events read in total (354ms).

[12:30:19.776] <TB2>     INFO: Test took 1484ms.

[12:30:19.778] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:20.190] <TB2>     INFO: Expecting 2560 events.

[12:30:21.266] <TB2>     INFO: 2560 events read in total (360ms).

[12:30:21.267] <TB2>     INFO: Test took 1489ms.

[12:30:21.268] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:21.682] <TB2>     INFO: Expecting 2560 events.

[12:30:22.758] <TB2>     INFO: 2560 events read in total (361ms).

[12:30:22.758] <TB2>     INFO: Test took 1490ms.

[12:30:22.761] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:23.172] <TB2>     INFO: Expecting 2560 events.

[12:30:24.234] <TB2>     INFO: 2560 events read in total (346ms).

[12:30:24.234] <TB2>     INFO: Test took 1474ms.

[12:30:24.236] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:24.648] <TB2>     INFO: Expecting 2560 events.

[12:30:25.711] <TB2>     INFO: 2560 events read in total (347ms).

[12:30:25.711] <TB2>     INFO: Test took 1475ms.

[12:30:25.714] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:26.126] <TB2>     INFO: Expecting 2560 events.

[12:30:27.216] <TB2>     INFO: 2560 events read in total (375ms).

[12:30:27.216] <TB2>     INFO: Test took 1502ms.

[12:30:27.218] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:27.632] <TB2>     INFO: Expecting 2560 events.

[12:30:28.692] <TB2>     INFO: 2560 events read in total (345ms).

[12:30:28.692] <TB2>     INFO: Test took 1474ms.

[12:30:28.694] <TB2>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:30:29.108] <TB2>     INFO: Expecting 2560 events.

[12:30:30.174] <TB2>     INFO: 2560 events read in total (350ms).

[12:30:30.175] <TB2>     INFO: Test took 1481ms.

[12:30:30.794] <TB2>     INFO: PixTestPhOptimization::doTest() done, duration: 859 seconds

[12:30:30.794] <TB2>     INFO: PH scale (per ROC):    83  81  80  79  80  80  74  91  80  75  90  88  68  86  79  80

[12:30:30.794] <TB2>     INFO: PH offset (per ROC):  164 153 159 167 171 165 158 152 175 171 145 158 176 166 147 171

[12:30:30.803] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:30:30.803] <TB2>     INFO: Decoding statistics:

[12:30:30.803] <TB2>     INFO:   General information:

[12:30:30.803] <TB2>     INFO: 	 16bit words read:         91928

[12:30:30.803] <TB2>     INFO: 	 valid events total:       10240

[12:30:30.803] <TB2>     INFO: 	 empty events:             7738

[12:30:30.803] <TB2>     INFO: 	 valid events with pixels: 2502

[12:30:30.803] <TB2>     INFO: 	 valid pixel hits:         2502

[12:30:30.803] <TB2>     INFO:   Event errors: 	           0

[12:30:30.803] <TB2>     INFO: 	 start marker:             0

[12:30:30.803] <TB2>     INFO: 	 stop marker:              0

[12:30:30.803] <TB2>     INFO: 	 overflow:                 0

[12:30:30.803] <TB2>     INFO: 	 invalid 5bit words:       0

[12:30:30.803] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[12:30:30.803] <TB2>     INFO:   TBM errors: 		           0

[12:30:30.803] <TB2>     INFO: 	 flawed TBM headers:       0

[12:30:30.803] <TB2>     INFO: 	 flawed TBM trailers:      0

[12:30:30.803] <TB2>     INFO: 	 event ID mismatches:      0

[12:30:30.803] <TB2>     INFO:   ROC errors: 		           0

[12:30:30.803] <TB2>     INFO: 	 missing ROC header(s):    0

[12:30:30.803] <TB2>     INFO: 	 misplaced readback start: 0

[12:30:30.803] <TB2>     INFO:   Pixel decoding errors:	   0

[12:30:30.803] <TB2>     INFO: 	 pixel data incomplete:    0

[12:30:30.803] <TB2>     INFO: 	 pixel address:            0

[12:30:30.803] <TB2>     INFO: 	 pulse height fill bit:    0

[12:30:30.803] <TB2>     INFO: 	 buffer corruption:        0

[12:30:30.974] <TB2>     INFO: ######################################################################

[12:30:30.974] <TB2>     INFO: PixTestGainPedestal::fullTest() ntrig = 10

[12:30:30.974] <TB2>     INFO: ######################################################################

[12:30:30.984] <TB2>     INFO: scanning low vcal = 10

[12:30:31.288] <TB2>     INFO: Expecting 41600 events.

[12:30:35.115] <TB2>     INFO: 41600 events read in total (3111ms).

[12:30:35.115] <TB2>     INFO: Test took 4131ms.

[12:30:35.117] <TB2>     INFO: scanning low vcal = 20

[12:30:35.529] <TB2>     INFO: Expecting 41600 events.

[12:30:39.416] <TB2>     INFO: 41600 events read in total (3172ms).

[12:30:39.416] <TB2>     INFO: Test took 4299ms.

[12:30:39.418] <TB2>     INFO: scanning low vcal = 30

[12:30:39.829] <TB2>     INFO: Expecting 41600 events.

[12:30:43.691] <TB2>     INFO: 41600 events read in total (3146ms).

[12:30:43.692] <TB2>     INFO: Test took 4274ms.

[12:30:43.695] <TB2>     INFO: scanning low vcal = 40

[12:30:44.100] <TB2>     INFO: Expecting 41600 events.

[12:30:48.656] <TB2>     INFO: 41600 events read in total (3840ms).

[12:30:48.657] <TB2>     INFO: Test took 4962ms.

[12:30:48.660] <TB2>     INFO: scanning low vcal = 50

[12:30:49.012] <TB2>     INFO: Expecting 41600 events.

[12:30:53.543] <TB2>     INFO: 41600 events read in total (3816ms).

[12:30:53.544] <TB2>     INFO: Test took 4884ms.

[12:30:53.547] <TB2>     INFO: scanning low vcal = 60

[12:30:53.897] <TB2>     INFO: Expecting 41600 events.

[12:30:58.230] <TB2>     INFO: 41600 events read in total (3617ms).

[12:30:58.231] <TB2>     INFO: Test took 4684ms.

[12:30:58.233] <TB2>     INFO: scanning low vcal = 70

[12:30:58.581] <TB2>     INFO: Expecting 41600 events.

[12:31:02.960] <TB2>     INFO: 41600 events read in total (3663ms).

[12:31:02.961] <TB2>     INFO: Test took 4728ms.

[12:31:02.963] <TB2>     INFO: scanning low vcal = 80

[12:31:03.314] <TB2>     INFO: Expecting 41600 events.

[12:31:07.860] <TB2>     INFO: 41600 events read in total (3830ms).

[12:31:07.861] <TB2>     INFO: Test took 4898ms.

[12:31:07.864] <TB2>     INFO: scanning low vcal = 90

[12:31:08.195] <TB2>     INFO: Expecting 41600 events.

[12:31:12.681] <TB2>     INFO: 41600 events read in total (3770ms).

[12:31:12.681] <TB2>     INFO: Test took 4817ms.

[12:31:12.685] <TB2>     INFO: scanning low vcal = 100

[12:31:13.037] <TB2>     INFO: Expecting 41600 events.

[12:31:17.750] <TB2>     INFO: 41600 events read in total (3998ms).

[12:31:17.751] <TB2>     INFO: Test took 5066ms.

[12:31:17.753] <TB2>     INFO: scanning low vcal = 110

[12:31:18.101] <TB2>     INFO: Expecting 41600 events.

[12:31:22.600] <TB2>     INFO: 41600 events read in total (3784ms).

[12:31:22.601] <TB2>     INFO: Test took 4848ms.

[12:31:22.603] <TB2>     INFO: scanning low vcal = 120

[12:31:22.951] <TB2>     INFO: Expecting 41600 events.

[12:31:27.304] <TB2>     INFO: 41600 events read in total (3637ms).

[12:31:27.304] <TB2>     INFO: Test took 4701ms.

[12:31:27.307] <TB2>     INFO: scanning low vcal = 130

[12:31:27.648] <TB2>     INFO: Expecting 41600 events.

[12:31:32.182] <TB2>     INFO: 41600 events read in total (3819ms).

[12:31:32.183] <TB2>     INFO: Test took 4876ms.

[12:31:32.185] <TB2>     INFO: scanning low vcal = 140

[12:31:32.537] <TB2>     INFO: Expecting 41600 events.

[12:31:37.114] <TB2>     INFO: 41600 events read in total (3862ms).

[12:31:37.114] <TB2>     INFO: Test took 4928ms.

[12:31:37.118] <TB2>     INFO: scanning low vcal = 150

[12:31:37.437] <TB2>     INFO: Expecting 41600 events.

[12:31:42.048] <TB2>     INFO: 41600 events read in total (3895ms).

[12:31:42.049] <TB2>     INFO: Test took 4931ms.

[12:31:42.052] <TB2>     INFO: scanning low vcal = 160

[12:31:42.398] <TB2>     INFO: Expecting 41600 events.

[12:31:47.028] <TB2>     INFO: 41600 events read in total (3915ms).

[12:31:47.029] <TB2>     INFO: Test took 4977ms.

[12:31:47.031] <TB2>     INFO: scanning low vcal = 170

[12:31:47.381] <TB2>     INFO: Expecting 41600 events.

[12:31:51.724] <TB2>     INFO: 41600 events read in total (3628ms).

[12:31:51.725] <TB2>     INFO: Test took 4694ms.

[12:31:51.730] <TB2>     INFO: scanning low vcal = 180

[12:31:52.082] <TB2>     INFO: Expecting 41600 events.

[12:31:56.402] <TB2>     INFO: 41600 events read in total (3604ms).

[12:31:56.402] <TB2>     INFO: Test took 4672ms.

[12:31:56.405] <TB2>     INFO: scanning low vcal = 190

[12:31:56.738] <TB2>     INFO: Expecting 41600 events.

[12:32:01.266] <TB2>     INFO: 41600 events read in total (3813ms).

[12:32:01.266] <TB2>     INFO: Test took 4861ms.

[12:32:01.269] <TB2>     INFO: scanning low vcal = 200

[12:32:01.624] <TB2>     INFO: Expecting 41600 events.

[12:32:06.271] <TB2>     INFO: 41600 events read in total (3932ms).

[12:32:06.272] <TB2>     INFO: Test took 5003ms.

[12:32:06.274] <TB2>     INFO: scanning low vcal = 210

[12:32:06.629] <TB2>     INFO: Expecting 41600 events.

[12:32:11.206] <TB2>     INFO: 41600 events read in total (3861ms).

[12:32:11.206] <TB2>     INFO: Test took 4932ms.

[12:32:11.209] <TB2>     INFO: scanning low vcal = 220

[12:32:11.543] <TB2>     INFO: Expecting 41600 events.

[12:32:16.253] <TB2>     INFO: 41600 events read in total (3994ms).

[12:32:16.253] <TB2>     INFO: Test took 5044ms.

[12:32:16.256] <TB2>     INFO: scanning low vcal = 230

[12:32:16.590] <TB2>     INFO: Expecting 41600 events.

[12:32:20.964] <TB2>     INFO: 41600 events read in total (3658ms).

[12:32:20.964] <TB2>     INFO: Test took 4708ms.

[12:32:20.969] <TB2>     INFO: scanning low vcal = 240

[12:32:21.300] <TB2>     INFO: Expecting 41600 events.

[12:32:25.755] <TB2>     INFO: 41600 events read in total (3740ms).

[12:32:25.756] <TB2>     INFO: Test took 4787ms.

[12:32:25.758] <TB2>     INFO: scanning low vcal = 250

[12:32:26.099] <TB2>     INFO: Expecting 41600 events.

[12:32:30.627] <TB2>     INFO: 41600 events read in total (3812ms).

[12:32:30.627] <TB2>     INFO: Test took 4869ms.

[12:32:30.631] <TB2>     INFO: scanning high vcal = 30 (= 210 in low range)

[12:32:30.975] <TB2>     INFO: Expecting 41600 events.

[12:32:35.503] <TB2>     INFO: 41600 events read in total (3813ms).

[12:32:35.504] <TB2>     INFO: Test took 4873ms.

[12:32:35.506] <TB2>     INFO: scanning high vcal = 50 (= 350 in low range)

[12:32:35.854] <TB2>     INFO: Expecting 41600 events.

[12:32:40.303] <TB2>     INFO: 41600 events read in total (3733ms).

[12:32:40.304] <TB2>     INFO: Test took 4798ms.

[12:32:40.307] <TB2>     INFO: scanning high vcal = 70 (= 490 in low range)

[12:32:40.651] <TB2>     INFO: Expecting 41600 events.

[12:32:45.221] <TB2>     INFO: 41600 events read in total (3854ms).

[12:32:45.221] <TB2>     INFO: Test took 4914ms.

[12:32:45.224] <TB2>     INFO: scanning high vcal = 90 (= 630 in low range)

[12:32:45.576] <TB2>     INFO: Expecting 41600 events.

[12:32:49.980] <TB2>     INFO: 41600 events read in total (3689ms).

[12:32:49.981] <TB2>     INFO: Test took 4757ms.

[12:32:49.983] <TB2>     INFO: scanning high vcal = 200 (= 1400 in low range)

[12:32:50.336] <TB2>     INFO: Expecting 41600 events.

[12:32:54.983] <TB2>     INFO: 41600 events read in total (3931ms).

[12:32:54.983] <TB2>     INFO: Test took 5000ms.

[12:32:55.422] <TB2>     INFO: PixTestGainPedestal::measure() done 

[12:33:28.668] <TB2>     INFO: PixTestGainPedestal::fit() done

[12:33:28.668] <TB2>     INFO: non-linearity mean:  0.955 0.947 0.952 0.956 0.950 0.958 0.952 0.957 0.963 0.953 0.946 0.953 0.962 0.958 0.961 0.963

[12:33:28.668] <TB2>     INFO: non-linearity RMS:   0.006 0.005 0.007 0.006 0.006 0.005 0.006 0.005 0.005 0.007 0.006 0.006 0.006 0.006 0.006 0.005

[12:33:28.669] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat

[12:33:28.694] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat

[12:33:28.718] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat

[12:33:28.742] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat

[12:33:28.767] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat

[12:33:28.790] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat

[12:33:28.808] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat

[12:33:28.831] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat

[12:33:28.854] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat

[12:33:28.873] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat

[12:33:28.892] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat

[12:33:28.910] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat

[12:33:28.929] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat

[12:33:28.948] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat

[12:33:28.967] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat

[12:33:28.985] <TB2>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat

[12:33:29.003] <TB2>     INFO: PixTestGainPedestal::fullTest() done, duration: 178 seconds

[12:33:29.003] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:33:29.003] <TB2>     INFO: Decoding statistics:

[12:33:29.003] <TB2>     INFO:   General information:

[12:33:29.003] <TB2>     INFO: 	 16bit words read:         2662400

[12:33:29.003] <TB2>     INFO: 	 valid events total:       166400

[12:33:29.003] <TB2>     INFO: 	 empty events:             0

[12:33:29.003] <TB2>     INFO: 	 valid events with pixels: 166400

[12:33:29.003] <TB2>     INFO: 	 valid pixel hits:         665566

[12:33:29.003] <TB2>     INFO:   Event errors: 	           0

[12:33:29.003] <TB2>     INFO: 	 start marker:             0

[12:33:29.003] <TB2>     INFO: 	 stop marker:              0

[12:33:29.003] <TB2>     INFO: 	 overflow:                 0

[12:33:29.003] <TB2>     INFO: 	 invalid 5bit words:       0

[12:33:29.003] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[12:33:29.003] <TB2>     INFO:   TBM errors: 		           0

[12:33:29.003] <TB2>     INFO: 	 flawed TBM headers:       0

[12:33:29.003] <TB2>     INFO: 	 flawed TBM trailers:      0

[12:33:29.003] <TB2>     INFO: 	 event ID mismatches:      0

[12:33:29.003] <TB2>     INFO:   ROC errors: 		           0

[12:33:29.003] <TB2>     INFO: 	 missing ROC header(s):    0

[12:33:29.003] <TB2>     INFO: 	 misplaced readback start: 0

[12:33:29.003] <TB2>     INFO:   Pixel decoding errors:	   0

[12:33:29.003] <TB2>     INFO: 	 pixel data incomplete:    0

[12:33:29.003] <TB2>     INFO: 	 pixel address:            0

[12:33:29.003] <TB2>     INFO: 	 pulse height fill bit:    0

[12:33:29.003] <TB2>     INFO: 	 buffer corruption:        0

[12:33:29.009] <TB2>     INFO: readReadbackCal: /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C15.dat

[12:33:29.010] <TB2>     INFO: ######################################################################

[12:33:29.010] <TB2>     INFO: PixTestReadback::doTest()

[12:33:29.010] <TB2>     INFO: ######################################################################

[12:33:29.011] <TB2>     INFO: PixTestReadback::RES sent once 

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C0.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C1.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C2.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C3.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C4.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C5.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C6.dat

[12:33:40.210] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C7.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C8.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C9.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C10.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C11.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C12.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C13.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C14.dat

[12:33:40.211] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C15.dat

[12:33:40.235] <TB2>     INFO: PixTestPattern::       pg_setup set to default.

[12:33:40.235] <TB2>     INFO: PixTestReadback::RES sent once 

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C0.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C1.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C2.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C3.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C4.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C5.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C6.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C7.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C8.dat

[12:33:51.398] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C9.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C10.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C11.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C12.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C13.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C14.dat

[12:33:51.399] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C15.dat

[12:33:51.429] <TB2>     INFO: PixTestPattern::       pg_setup set to default.

[12:33:51.430] <TB2>     INFO: PixTestReadback::RES sent once 

[12:34:00.019] <TB2>     INFO: PixTestPattern::       pg_setup set to default.

[12:34:00.019] <TB2>     INFO: Vbg will be calibrated using Vd calibration

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 148.1calibrated Vbg = 1.17962 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 154.2calibrated Vbg = 1.1777 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 158.9calibrated Vbg = 1.18111 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 155.9calibrated Vbg = 1.19479 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149.6calibrated Vbg = 1.18766 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 153calibrated Vbg = 1.19531 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 143.7calibrated Vbg = 1.19418 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 153.2calibrated Vbg = 1.1998 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 147calibrated Vbg = 1.20192 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 153.4calibrated Vbg = 1.19938 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 154.2calibrated Vbg = 1.19361 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 144.1calibrated Vbg = 1.1904 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 151.2calibrated Vbg = 1.19141 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 148.8calibrated Vbg = 1.19244 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 146.1calibrated Vbg = 1.19747 :::*/*/*/*/

[12:34:00.019] <TB2>     INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 151.3calibrated Vbg = 1.18461 :::*/*/*/*/

[12:34:00.022] <TB2>     INFO: PixTestReadback::RES sent once 

[12:36:54.319] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C0.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C1.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C2.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C3.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C4.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C5.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C6.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C7.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C8.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C9.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C10.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C11.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C12.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C13.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C14.dat

[12:36:54.320] <TB2>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2143_FullQualification_2016-01-20_11h57m_1453287477//000_FulltestPxar_m20//readbackCal_C15.dat

[12:36:54.349] <TB2>     INFO: PixTestPattern::       pg_setup set to default.

[12:36:54.350] <TB2>     INFO: PixTestReadback::doTest() done

[12:36:54.350] <TB2>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:36:54.350] <TB2>     INFO: Decoding statistics:

[12:36:54.350] <TB2>     INFO:   General information:

[12:36:54.350] <TB2>     INFO: 	 16bit words read:         1024

[12:36:54.350] <TB2>     INFO: 	 valid events total:       128

[12:36:54.350] <TB2>     INFO: 	 empty events:             128

[12:36:54.350] <TB2>     INFO: 	 valid events with pixels: 0

[12:36:54.350] <TB2>     INFO: 	 valid pixel hits:         0

[12:36:54.350] <TB2>     INFO:   Event errors: 	           0

[12:36:54.350] <TB2>     INFO: 	 start marker:             0

[12:36:54.350] <TB2>     INFO: 	 stop marker:              0

[12:36:54.350] <TB2>     INFO: 	 overflow:                 0

[12:36:54.350] <TB2>     INFO: 	 invalid 5bit words:       0

[12:36:54.350] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[12:36:54.350] <TB2>     INFO:   TBM errors: 		           0

[12:36:54.350] <TB2>     INFO: 	 flawed TBM headers:       0

[12:36:54.350] <TB2>     INFO: 	 flawed TBM trailers:      0

[12:36:54.350] <TB2>     INFO: 	 event ID mismatches:      0

[12:36:54.350] <TB2>     INFO:   ROC errors: 		           0

[12:36:54.350] <TB2>     INFO: 	 missing ROC header(s):    0

[12:36:54.350] <TB2>     INFO: 	 misplaced readback start: 0

[12:36:54.350] <TB2>     INFO:   Pixel decoding errors:	   0

[12:36:54.350] <TB2>     INFO: 	 pixel data incomplete:    0

[12:36:54.350] <TB2>     INFO: 	 pixel address:            0

[12:36:54.350] <TB2>     INFO: 	 pulse height fill bit:    0

[12:36:54.350] <TB2>     INFO: 	 buffer corruption:        0

[12:36:54.365] <TB2>     INFO: Decoding statistics:

[12:36:54.365] <TB2>     INFO:   General information:

[12:36:54.365] <TB2>     INFO: 	 16bit words read:         2755352

[12:36:54.365] <TB2>     INFO: 	 valid events total:       176768

[12:36:54.365] <TB2>     INFO: 	 empty events:             7866

[12:36:54.365] <TB2>     INFO: 	 valid events with pixels: 168902

[12:36:54.365] <TB2>     INFO: 	 valid pixel hits:         668068

[12:36:54.365] <TB2>     INFO:   Event errors: 	           0

[12:36:54.366] <TB2>     INFO: 	 start marker:             0

[12:36:54.366] <TB2>     INFO: 	 stop marker:              0

[12:36:54.366] <TB2>     INFO: 	 overflow:                 0

[12:36:54.366] <TB2>     INFO: 	 invalid 5bit words:       0

[12:36:54.366] <TB2>     INFO: 	 invalid XOR eye diagram:  0

[12:36:54.366] <TB2>     INFO:   TBM errors: 		           0

[12:36:54.366] <TB2>     INFO: 	 flawed TBM headers:       0

[12:36:54.366] <TB2>     INFO: 	 flawed TBM trailers:      0

[12:36:54.366] <TB2>     INFO: 	 event ID mismatches:      0

[12:36:54.366] <TB2>     INFO:   ROC errors: 		           0

[12:36:54.366] <TB2>     INFO: 	 missing ROC header(s):    0

[12:36:54.366] <TB2>     INFO: 	 misplaced readback start: 0

[12:36:54.366] <TB2>     INFO:   Pixel decoding errors:	   0

[12:36:54.366] <TB2>     INFO: 	 pixel data incomplete:    0

[12:36:54.366] <TB2>     INFO: 	 pixel address:            0

[12:36:54.366] <TB2>     INFO: 	 pulse height fill bit:    0

[12:36:54.366] <TB2>     INFO: 	 buffer corruption:        0

[12:36:54.366] <TB2>     INFO: enter test to run

[12:36:54.366] <TB2>     INFO:   test: exit no parameter change

[12:36:54.681] <TB2>    QUIET: Connection to board 156 closed.

[12:36:54.760] <TB2>     INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master