MORE-Web

Test Date: 2015-09-03 10:31
Analysis date: 2016-05-26 01:08
Logfile
LogfileView
[12:04:27.572] <TB3>     INFO: *** Welcome to pxar ***

[12:04:27.572] <TB3>     INFO: *** Today: 2015/09/03

[12:04:27.572] <TB3>     INFO: readRocDacs: /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C15.dat

[12:04:27.573] <TB3>     INFO: readTbmDacs: /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//tbmParameters_C0b.dat

[12:04:27.573] <TB3>     INFO: readMaskFile: /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//defaultMaskFile.dat

[12:04:27.573] <TB3>     INFO: readTrimFile: /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters_C15.dat

[12:04:27.649] <TB3>     INFO:         clk: 4

[12:04:27.649] <TB3>     INFO:         ctr: 4

[12:04:27.649] <TB3>     INFO:         sda: 19

[12:04:27.649] <TB3>     INFO:         tin: 9

[12:04:27.649] <TB3>     INFO:         level: 15

[12:04:27.649] <TB3>     INFO:         triggerdelay: 0

[12:04:27.649] <TB3>    QUIET: Instanciating API for pxar prod-10

[12:04:27.649] <TB3>     INFO: Log level: INFO

[12:04:27.657] <TB3>     INFO: Found DTB DTB_WZ4I6J

[12:04:27.670] <TB3>    QUIET: Connection to board DTB_WZ4I6J opened.

[12:04:27.673] <TB3>     INFO: DTB startup information

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

Board id:    170

HW version:  DTB1.2

FW version:  4.2

SW version:  4.4

USB id:      DTB_WZ4I6J

MAC address: 40D8551180AA

Hostname:    pixelDTB170

Comment:     

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

[12:04:27.675] <TB3>     INFO: RPC call hashes of host and DTB match: 397073690

[12:04:29.206] <TB3>     INFO: DUT info: 

[12:04:29.206] <TB3>     INFO: The DUT currently contains the following objects:

[12:04:29.206] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[12:04:29.206] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[12:04:29.206] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[12:04:29.206] <TB3>     INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs

[12:04:29.206] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.206] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.207] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.207] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.207] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.207] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.207] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.

[12:04:29.608] <TB3>     INFO: enter 'restricted' command line mode

[12:04:29.608] <TB3>     INFO: enter test to run

[12:04:29.608] <TB3>     INFO:   test: pretest no parameter change

[12:04:29.608] <TB3>     INFO:   running: pretest

[12:04:29.615] <TB3>     INFO: ######################################################################

[12:04:29.615] <TB3>     INFO: PixTestPretest::doTest()

[12:04:29.615] <TB3>     INFO: ######################################################################

[12:04:29.617] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:29.617] <TB3>     INFO:    PixTestPretest::programROC() 

[12:04:29.617] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:47.635] <TB3>     INFO: PixTestPretest::programROC() done: ROCs are all programmable

[12:04:47.635] <TB3>     INFO: IA differences per ROC:  18.5 18.5 17.7 20.1 18.5 19.3 19.3 20.1 17.7 18.5 18.5 19.3 21.7 18.5 18.5 21.7

[12:04:47.707] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:47.707] <TB3>     INFO:    PixTestPretest::setVana() target Ia = 24 mA/ROC

[12:04:47.707] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:51.981] <TB3>     INFO: PixTestPretest::setVana() done, Module Ia 386.7 mA = 24.1687 mA/ROC

[12:04:51.984] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:51.984] <TB3>     INFO:    PixTestPretest::findWorkingPixel()

[12:04:51.984] <TB3>     INFO:    ----------------------------------------------------------------------

[12:04:52.124] <TB3>     INFO: Expecting 231680 events.

[12:05:01.402] <TB3>     INFO: 231680 events read in total (8559ms).

[12:05:01.470] <TB3>     INFO: Test took 9480ms.

[12:05:01.741] <TB3>     INFO: Found working pixel in all ROCs: col/row = 12/22

[12:05:01.770] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:01.770] <TB3>     INFO:    PixTestPretest::setVthrCompCalDel()

[12:05:01.770] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:01.907] <TB3>     INFO: Expecting 231680 events.

[12:05:10.754] <TB3>     INFO: 231680 events read in total (8130ms).

[12:05:10.759] <TB3>     INFO: Test took 8984ms.

[12:05:11.069] <TB3>     INFO: PixTestPretest::setVthrCompCalDel() done

[12:05:11.069] <TB3>     INFO: CalDel:      154   139   145   137   148   130   130   163   137   151   142   171   152   124   120   153

[12:05:11.069] <TB3>     INFO: VthrComp:     51    51    51    51    51    51    51    51    51    51    51    51    51    51    51    51

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C0.dat

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C1.dat

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C2.dat

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C3.dat

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C4.dat

[12:05:11.072] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C5.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C6.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C7.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C8.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C9.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C10.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C11.dat

[12:05:11.073] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C12.dat

[12:05:11.074] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C13.dat

[12:05:11.074] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C14.dat

[12:05:11.074] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters_C15.dat

[12:05:11.074] <TB3>     INFO: write tbm parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//tbmParameters_C0a.dat

[12:05:11.074] <TB3>     INFO: write tbm parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//tbmParameters_C0b.dat

[12:05:11.074] <TB3>     INFO: PixTestPretest::doTest() done, duration: 41 seconds

[12:05:11.211] <TB3>     INFO: enter test to run

[12:05:11.211] <TB3>     INFO:   test: fulltest no parameter change

[12:05:11.211] <TB3>     INFO:   running: fulltest

[12:05:11.211] <TB3>     INFO: ######################################################################

[12:05:11.211] <TB3>     INFO: PixTestFullTest::doTest()

[12:05:11.211] <TB3>     INFO: ######################################################################

[12:05:11.213] <TB3>     INFO: ######################################################################

[12:05:11.213] <TB3>     INFO: PixTestAlive::doTest()

[12:05:11.213] <TB3>     INFO: ######################################################################

[12:05:11.214] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:11.214] <TB3>     INFO:    PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[12:05:11.214] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:11.555] <TB3>     INFO: Expecting 41600 events.

[12:05:15.834] <TB3>     INFO: 41600 events read in total (3562ms).

[12:05:15.835] <TB3>     INFO: Test took 4619ms.

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

[12:05:16.132] <TB3>     INFO: PixTestAlive::aliveTest() done

[12:05:16.132] <TB3>     INFO: number of dead pixels (per ROC):     0    0    0    1    1    0    0    0    0    0    0    0    0    0    0    1

[12:05:16.134] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:16.134] <TB3>     INFO:    PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[12:05:16.134] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:16.464] <TB3>     INFO: Expecting 41600 events.

[12:05:19.541] <TB3>     INFO: 41600 events read in total (2361ms).

[12:05:19.541] <TB3>     INFO: Test took 3406ms.

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

[12:05:19.541] <TB3>     INFO: mask vs. old pixelAlive PixelAlive_C0_V0 ..  PixelAlive_C15_V0

[12:05:19.855] <TB3>     INFO: PixTestAlive::maskTest() done

[12:05:19.855] <TB3>     INFO: number of mask-defect pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[12:05:19.858] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:19.858] <TB3>     INFO:    PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[12:05:19.858] <TB3>     INFO:    ----------------------------------------------------------------------

[12:05:20.189] <TB3>     INFO: Expecting 41600 events.

[12:05:24.485] <TB3>     INFO: 41600 events read in total (3580ms).

[12:05:24.485] <TB3>     INFO: Test took 4625ms.

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

[12:05:24.774] <TB3>     INFO: PixTestAlive::addressDecodingTest() done

[12:05:24.774] <TB3>     INFO: number of address-decoding pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[12:05:24.774] <TB3>     INFO: PixTestAlive::doTest() done, duration: 13 seconds

[12:05:24.782] <TB3>     INFO: ######################################################################

[12:05:24.782] <TB3>     INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)

[12:05:24.782] <TB3>     INFO: ######################################################################

[12:05:24.786] <TB3>     INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 2 (plus default)

[12:05:24.798] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 5

[12:05:24.798] <TB3>     INFO:     run 1 of 1

[12:05:25.118] <TB3>     INFO: Expecting 3120000 events.

[12:05:58.367] <TB3>     INFO: 840060 events read in total (32533ms).

[12:06:30.847] <TB3>     INFO: 1669125 events read in total (65013ms).

[12:07:05.667] <TB3>     INFO: 2508350 events read in total (99833ms).

[12:07:29.565] <TB3>     INFO: 3120000 events read in total (123731ms).

[12:07:29.634] <TB3>     INFO: Test took 124836ms.

[12:07:29.757] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:07:52.847] <TB3>     INFO: PixTestBBMap::doTest() done, duration: 148 seconds

[12:07:52.847] <TB3>     INFO: number of dead bumps (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    1   35

[12:07:52.847] <TB3>     INFO: separation cut       (per ROC):    67   69   68   75   91   89   84   72   63   74   77   73   81   71   95   67

[12:07:52.927] <TB3>     INFO: ######################################################################

[12:07:52.927] <TB3>     INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1

[12:07:52.927] <TB3>     INFO: ######################################################################

[12:07:52.927] <TB3>     INFO:    ----------------------------------------------------------------------

[12:07:52.927] <TB3>     INFO:    PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1

[12:07:52.927] <TB3>     INFO:    ----------------------------------------------------------------------

[12:07:52.927] <TB3>     INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 0 .. 149 (-1/-1) hits flags = 16 (plus default)

[12:07:52.937] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 50

[12:07:52.937] <TB3>     INFO:     run 1 of 1

[12:07:53.247] <TB3>     INFO: Expecting 31200000 events.

[12:08:17.635] <TB3>     INFO: 907550 events read in total (23672ms).

[12:08:41.872] <TB3>     INFO: 1804200 events read in total (47909ms).

[12:09:06.034] <TB3>     INFO: 2696600 events read in total (72071ms).

[12:09:30.368] <TB3>     INFO: 3589750 events read in total (96405ms).

[12:09:54.541] <TB3>     INFO: 4479850 events read in total (120578ms).

[12:10:18.606] <TB3>     INFO: 5369500 events read in total (144643ms).

[12:10:42.696] <TB3>     INFO: 6257850 events read in total (168733ms).

[12:11:06.633] <TB3>     INFO: 7146750 events read in total (192670ms).

[12:11:30.962] <TB3>     INFO: 8037400 events read in total (216999ms).

[12:11:54.972] <TB3>     INFO: 8924700 events read in total (241009ms).

[12:12:19.105] <TB3>     INFO: 9815050 events read in total (265142ms).

[12:12:43.354] <TB3>     INFO: 10701850 events read in total (289391ms).

[12:13:07.336] <TB3>     INFO: 11589300 events read in total (313373ms).

[12:13:31.256] <TB3>     INFO: 12476500 events read in total (337293ms).

[12:13:55.136] <TB3>     INFO: 13363550 events read in total (361173ms).

[12:14:19.172] <TB3>     INFO: 14248750 events read in total (385209ms).

[12:14:43.105] <TB3>     INFO: 15135850 events read in total (409142ms).

[12:15:07.117] <TB3>     INFO: 16014800 events read in total (433154ms).

[12:15:31.154] <TB3>     INFO: 16894400 events read in total (457191ms).

[12:15:55.287] <TB3>     INFO: 17770350 events read in total (481324ms).

[12:16:19.391] <TB3>     INFO: 18649000 events read in total (505428ms).

[12:16:43.513] <TB3>     INFO: 19522400 events read in total (529550ms).

[12:17:07.548] <TB3>     INFO: 20397750 events read in total (553585ms).

[12:17:31.540] <TB3>     INFO: 21272650 events read in total (577577ms).

[12:17:55.583] <TB3>     INFO: 22146350 events read in total (601620ms).

[12:18:19.514] <TB3>     INFO: 23018850 events read in total (625551ms).

[12:18:43.345] <TB3>     INFO: 23891500 events read in total (649382ms).

[12:19:07.345] <TB3>     INFO: 24764600 events read in total (673382ms).

[12:19:31.256] <TB3>     INFO: 25636300 events read in total (697293ms).

[12:19:55.349] <TB3>     INFO: 26508950 events read in total (721386ms).

[12:20:19.108] <TB3>     INFO: 27380000 events read in total (745145ms).

[12:20:43.127] <TB3>     INFO: 28254300 events read in total (769164ms).

[12:21:07.101] <TB3>     INFO: 29127100 events read in total (793138ms).

[12:21:30.983] <TB3>     INFO: 30001150 events read in total (817020ms).

[12:21:54.082] <TB3>     INFO: 30882350 events read in total (840119ms).

[12:22:02.164] <TB3>     INFO: 31200000 events read in total (848201ms).

[12:22:02.199] <TB3>     INFO: Test took 849262ms.

[12:22:02.289] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:22:02.418] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:04.115] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:05.667] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:07.150] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:08.586] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:09.987] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:11.392] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:12.860] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:14.443] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:15.943] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:17.446] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:18.954] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:20.455] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:21.975] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:23.522] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:24.872] <TB3>     INFO: dumping ASCII scurve output file: SCurveData

[12:22:26.339] <TB3>     INFO: PixTestScurves::scurves() done 

[12:22:26.339] <TB3>     INFO: Vcal mean:  75.68  72.85  67.87  77.71  91.16  92.66  86.84  78.80  69.03  77.84  74.05  74.01  80.28  75.38  96.37  77.11 

[12:22:26.339] <TB3>     INFO: Vcal RMS:    4.11   5.16   4.87   4.34   5.41   5.82   5.50   3.95   4.59   4.73   4.83   4.73   4.22   5.28   5.22   4.93 

[12:22:26.339] <TB3>     INFO: PixTestScurves::fullTest() done, duration: 873 seconds

[12:22:26.429] <TB3>     INFO: ######################################################################

[12:22:26.429] <TB3>     INFO: PixTestTrim::doTest()

[12:22:26.429] <TB3>     INFO: ######################################################################

[12:22:26.431] <TB3>     INFO:    ----------------------------------------------------------------------

[12:22:26.431] <TB3>     INFO:    PixTestTrim::trimTest() ntrig = 20, vcal = 35

[12:22:26.431] <TB3>     INFO:    ----------------------------------------------------------------------

[12:22:26.520] <TB3>     INFO: ---> VthrComp thr map (minimal VthrComp)

[12:22:26.520] <TB3>     INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 20 dacrange: 0 .. 159 (-1/-1) hits flags = 16 (plus default)

[12:22:26.529] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[12:22:26.529] <TB3>     INFO:     run 1 of 1

[12:22:26.832] <TB3>     INFO: Expecting 13312000 events.

[12:22:55.205] <TB3>     INFO: 1055680 events read in total (27656ms).

[12:23:20.241] <TB3>     INFO: 2104860 events read in total (52692ms).

[12:23:46.528] <TB3>     INFO: 3151240 events read in total (78979ms).

[12:24:13.869] <TB3>     INFO: 4197400 events read in total (106320ms).

[12:24:41.167] <TB3>     INFO: 5238140 events read in total (133618ms).

[12:25:08.440] <TB3>     INFO: 6276000 events read in total (160891ms).

[12:25:35.681] <TB3>     INFO: 7313860 events read in total (188132ms).

[12:26:03.112] <TB3>     INFO: 8356740 events read in total (215563ms).

[12:26:30.691] <TB3>     INFO: 9401700 events read in total (243142ms).

[12:26:57.926] <TB3>     INFO: 10449040 events read in total (270377ms).

[12:27:25.438] <TB3>     INFO: 11496900 events read in total (297889ms).

[12:27:52.796] <TB3>     INFO: 12546540 events read in total (325247ms).

[12:28:11.143] <TB3>     INFO: 13312000 events read in total (343594ms).

[12:28:11.175] <TB3>     INFO: Test took 344646ms.

[12:28:11.229] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:28:29.888] <TB3>     INFO: ROC 0 VthrComp = 79

[12:28:29.888] <TB3>     INFO: ROC 1 VthrComp = 77

[12:28:29.888] <TB3>     INFO: ROC 2 VthrComp = 74

[12:28:29.888] <TB3>     INFO: ROC 3 VthrComp = 85

[12:28:29.888] <TB3>     INFO: ROC 4 VthrComp = 95

[12:28:29.888] <TB3>     INFO: ROC 5 VthrComp = 98

[12:28:29.888] <TB3>     INFO: ROC 6 VthrComp = 91

[12:28:29.889] <TB3>     INFO: ROC 7 VthrComp = 85

[12:28:29.889] <TB3>     INFO: ROC 8 VthrComp = 74

[12:28:29.889] <TB3>     INFO: ROC 9 VthrComp = 81

[12:28:29.889] <TB3>     INFO: ROC 10 VthrComp = 77

[12:28:29.889] <TB3>     INFO: ROC 11 VthrComp = 77

[12:28:29.889] <TB3>     INFO: ROC 12 VthrComp = 88

[12:28:29.889] <TB3>     INFO: ROC 13 VthrComp = 77

[12:28:29.889] <TB3>     INFO: ROC 14 VthrComp = 100

[12:28:29.889] <TB3>     INFO: ROC 15 VthrComp = 81

[12:28:29.890] <TB3>     INFO: ---> Vcal thr map (pixel with maximum Vcal thr)

[12:28:29.890] <TB3>     INFO: ---> dac: vcal name: TrimThr1 ntrig: 20 dacrange: 0 .. 159 (-1/-1) hits flags = 16 (plus default)

[12:28:29.899] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[12:28:29.899] <TB3>     INFO:     run 1 of 1

[12:28:30.207] <TB3>     INFO: Expecting 13312000 events.

[12:28:55.963] <TB3>     INFO: 781860 events read in total (25039ms).

[12:29:21.101] <TB3>     INFO: 1559740 events read in total (50177ms).

[12:29:43.847] <TB3>     INFO: 2336080 events read in total (72923ms).

[12:30:07.912] <TB3>     INFO: 3112720 events read in total (96988ms).

[12:30:32.990] <TB3>     INFO: 3889520 events read in total (122066ms).

[12:30:57.832] <TB3>     INFO: 4665380 events read in total (146908ms).

[12:31:23.020] <TB3>     INFO: 5442300 events read in total (172096ms).

[12:31:48.065] <TB3>     INFO: 6219260 events read in total (197141ms).

[12:32:12.993] <TB3>     INFO: 6992960 events read in total (222069ms).

[12:32:38.064] <TB3>     INFO: 7763480 events read in total (247140ms).

[12:33:03.036] <TB3>     INFO: 8532620 events read in total (272112ms).

[12:33:28.009] <TB3>     INFO: 9301100 events read in total (297085ms).

[12:33:52.858] <TB3>     INFO: 10068060 events read in total (321934ms).

[12:34:17.804] <TB3>     INFO: 10834580 events read in total (346880ms).

[12:34:42.817] <TB3>     INFO: 11600780 events read in total (371893ms).

[12:35:07.673] <TB3>     INFO: 12367760 events read in total (396749ms).

[12:35:30.716] <TB3>     INFO: 13136500 events read in total (419792ms).

[12:35:36.084] <TB3>     INFO: 13312000 events read in total (425160ms).

[12:35:36.127] <TB3>     INFO: Test took 426228ms.

[12:35:36.265] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:35:59.995] <TB3>     INFO:    roc 0 with ID = 0  has maximal Vcal 58.2021 for pixel 1/1 mean/min/max = 46.9275/35.3963/58.4587

[12:35:59.995] <TB3>     INFO:    roc 1 with ID = 1  has maximal Vcal 61.398 for pixel 0/76 mean/min/max = 47.8556/34.2775/61.4336

[12:35:59.995] <TB3>     INFO:    roc 2 with ID = 2  has maximal Vcal 57.3335 for pixel 10/1 mean/min/max = 45.6785/33.9554/57.4015

[12:35:59.996] <TB3>     INFO:    roc 3 with ID = 3  has maximal Vcal 56.2031 for pixel 5/5 mean/min/max = 44.5406/32.6008/56.4803

[12:35:59.996] <TB3>     INFO:    roc 4 with ID = 4  has maximal Vcal 57.8933 for pixel 0/5 mean/min/max = 44.8858/31.4086/58.363

[12:35:59.996] <TB3>     INFO:    roc 5 with ID = 5  has maximal Vcal 58.5851 for pixel 17/75 mean/min/max = 45.0926/31.5549/58.6302

[12:35:59.996] <TB3>     INFO:    roc 6 with ID = 6  has maximal Vcal 59.4385 for pixel 0/32 mean/min/max = 45.9921/32.405/59.5792

[12:35:59.997] <TB3>     INFO:    roc 7 with ID = 7  has maximal Vcal 56.1393 for pixel 51/11 mean/min/max = 44.3618/32.5625/56.1611

[12:35:59.997] <TB3>     INFO:    roc 8 with ID = 8  has maximal Vcal 56.7307 for pixel 5/79 mean/min/max = 45.7342/34.6687/56.7997

[12:35:59.997] <TB3>     INFO:    roc 9 with ID = 9  has maximal Vcal 59.1315 for pixel 17/4 mean/min/max = 45.8107/32.4584/59.163

[12:35:59.998] <TB3>     INFO:    roc 10 with ID = 10  has maximal Vcal 60.0152 for pixel 3/25 mean/min/max = 47.4835/34.7574/60.2096

[12:35:59.998] <TB3>     INFO:    roc 11 with ID = 11  has maximal Vcal 58.6821 for pixel 17/2 mean/min/max = 46.5501/34.392/58.7082

[12:35:59.998] <TB3>     INFO:    roc 12 with ID = 12  has maximal Vcal 56.2059 for pixel 5/2 mean/min/max = 44.4741/32.5487/56.3995

[12:35:59.998] <TB3>     INFO:    roc 13 with ID = 13  has maximal Vcal 63.877 for pixel 0/79 mean/min/max = 48.8195/33.7044/63.9347

[12:35:59.999] <TB3>     INFO:    roc 14 with ID = 14  has maximal Vcal 59.0324 for pixel 51/5 mean/min/max = 45.6521/32.2365/59.0678

[12:35:59.999] <TB3>     INFO:    roc 15 with ID = 15  has maximal Vcal 59.1377 for pixel 4/1 mean/min/max = 45.3779/31.5824/59.1733

[12:35:59.999] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[12:36:00.131] <TB3>     INFO: Expecting 1029120 events.

[12:36:22.221] <TB3>     INFO: 1029120 events read in total (21370ms).

[12:36:22.226] <TB3>     INFO: Expecting 1029120 events.

[12:36:44.134] <TB3>     INFO: 1029120 events read in total (21358ms).

[12:36:44.141] <TB3>     INFO: Expecting 1029120 events.

[12:37:07.747] <TB3>     INFO: 1029120 events read in total (23061ms).

[12:37:07.756] <TB3>     INFO: Expecting 1029120 events.

[12:37:30.011] <TB3>     INFO: 1029120 events read in total (21712ms).

[12:37:30.022] <TB3>     INFO: Expecting 1029120 events.

[12:37:51.853] <TB3>     INFO: 1029120 events read in total (21296ms).

[12:37:51.866] <TB3>     INFO: Expecting 1029120 events.

[12:38:15.953] <TB3>     INFO: 1029120 events read in total (23543ms).

[12:38:15.969] <TB3>     INFO: Expecting 1029120 events.

[12:38:39.598] <TB3>     INFO: 1029120 events read in total (23099ms).

[12:38:39.615] <TB3>     INFO: Expecting 1029120 events.

[12:39:03.479] <TB3>     INFO: 1029120 events read in total (23318ms).

[12:39:03.499] <TB3>     INFO: Expecting 1029120 events.

[12:39:27.260] <TB3>     INFO: 1029120 events read in total (23230ms).

[12:39:27.282] <TB3>     INFO: Expecting 1029120 events.

[12:39:51.201] <TB3>     INFO: 1029120 events read in total (23391ms).

[12:39:51.224] <TB3>     INFO: Expecting 1029120 events.

[12:40:14.913] <TB3>     INFO: 1029120 events read in total (23161ms).

[12:40:14.937] <TB3>     INFO: Expecting 1029120 events.

[12:40:38.782] <TB3>     INFO: 1029120 events read in total (23317ms).

[12:40:38.808] <TB3>     INFO: Expecting 1029120 events.

[12:41:02.667] <TB3>     INFO: 1029120 events read in total (23332ms).

[12:41:02.699] <TB3>     INFO: Expecting 1029120 events.

[12:41:26.462] <TB3>     INFO: 1029120 events read in total (23236ms).

[12:41:26.492] <TB3>     INFO: Expecting 1029120 events.

[12:41:50.112] <TB3>     INFO: 1029120 events read in total (23091ms).

[12:41:50.144] <TB3>     INFO: Expecting 1029120 events.

[12:42:14.047] <TB3>     INFO: 1029120 events read in total (23375ms).

[12:42:14.080] <TB3>     INFO: Test took 374081ms.

[12:42:15.128] <TB3>     INFO: ---> dac: vcal name: TrimThr2 ntrig: 20 dacrange: 0 .. 199 (-1/-1) hits flags = 16 (plus default)

[12:42:15.137] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[12:42:15.137] <TB3>     INFO:     run 1 of 1

[12:42:15.441] <TB3>     INFO: Expecting 16640000 events.

[12:42:40.532] <TB3>     INFO: 727120 events read in total (24375ms).

[12:43:05.128] <TB3>     INFO: 1451120 events read in total (48971ms).

[12:43:29.713] <TB3>     INFO: 2174720 events read in total (73556ms).

[12:43:54.262] <TB3>     INFO: 2898260 events read in total (98105ms).

[12:44:18.876] <TB3>     INFO: 3621320 events read in total (122719ms).

[12:44:43.252] <TB3>     INFO: 4344580 events read in total (147095ms).

[12:45:07.696] <TB3>     INFO: 5067440 events read in total (171539ms).

[12:45:32.389] <TB3>     INFO: 5790800 events read in total (196232ms).

[12:45:57.004] <TB3>     INFO: 6514300 events read in total (220847ms).

[12:46:21.548] <TB3>     INFO: 7237340 events read in total (245391ms).

[12:46:45.850] <TB3>     INFO: 7960920 events read in total (269693ms).

[12:47:10.177] <TB3>     INFO: 8681420 events read in total (294020ms).

[12:47:34.652] <TB3>     INFO: 9399720 events read in total (318495ms).

[12:47:59.118] <TB3>     INFO: 10117600 events read in total (342961ms).

[12:48:23.579] <TB3>     INFO: 10833960 events read in total (367422ms).

[12:48:48.140] <TB3>     INFO: 11550580 events read in total (391983ms).

[12:49:12.493] <TB3>     INFO: 12265820 events read in total (416336ms).

[12:49:37.100] <TB3>     INFO: 12980800 events read in total (440943ms).

[12:50:01.561] <TB3>     INFO: 13695180 events read in total (465404ms).

[12:50:25.933] <TB3>     INFO: 14409580 events read in total (489776ms).

[12:50:50.524] <TB3>     INFO: 15124840 events read in total (514367ms).

[12:51:15.111] <TB3>     INFO: 15838940 events read in total (538954ms).

[12:51:36.898] <TB3>     INFO: 16555160 events read in total (560741ms).

[12:51:39.950] <TB3>     INFO: 16640000 events read in total (563793ms).

[12:51:40.007] <TB3>     INFO: Test took 564870ms.

[12:51:40.209] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[12:52:05.179] <TB3>     INFO: ---> TrimStepCorr4 extremal thresholds: 0.015610 .. 169.945696

[12:52:05.256] <TB3>     INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 20 dacrange: 0 .. 179 (-1/-1) hits flags = 16 (plus default)

[12:52:05.264] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[12:52:05.264] <TB3>     INFO:     run 1 of 1

[12:52:05.575] <TB3>     INFO: Expecting 14976000 events.

[12:52:30.864] <TB3>     INFO: 734280 events read in total (24559ms).

[12:52:55.377] <TB3>     INFO: 1468840 events read in total (49072ms).

[12:53:19.750] <TB3>     INFO: 2203940 events read in total (73445ms).

[12:53:44.402] <TB3>     INFO: 2938860 events read in total (98097ms).

[12:54:09.021] <TB3>     INFO: 3673840 events read in total (122716ms).

[12:54:31.355] <TB3>     INFO: 4408580 events read in total (145050ms).

[12:54:54.134] <TB3>     INFO: 5143700 events read in total (167829ms).

[12:55:16.371] <TB3>     INFO: 5878640 events read in total (190066ms).

[12:55:41.148] <TB3>     INFO: 6614320 events read in total (214843ms).

[12:56:05.718] <TB3>     INFO: 7349000 events read in total (239413ms).

[12:56:29.725] <TB3>     INFO: 8084140 events read in total (263420ms).

[12:56:53.781] <TB3>     INFO: 8819100 events read in total (287476ms).

[12:57:18.253] <TB3>     INFO: 9553540 events read in total (311948ms).

[12:57:42.877] <TB3>     INFO: 10287920 events read in total (336572ms).

[12:58:07.509] <TB3>     INFO: 11021680 events read in total (361204ms).

[12:58:29.768] <TB3>     INFO: 11755120 events read in total (383463ms).

[12:58:54.354] <TB3>     INFO: 12489200 events read in total (408049ms).

[12:59:18.921] <TB3>     INFO: 13222280 events read in total (432616ms).

[12:59:43.609] <TB3>     INFO: 13956120 events read in total (457304ms).

[13:00:08.054] <TB3>     INFO: 14689900 events read in total (481749ms).

[13:00:17.019] <TB3>     INFO: 14976000 events read in total (490714ms).

[13:00:17.070] <TB3>     INFO: Test took 491806ms.

[13:00:17.250] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:00:42.058] <TB3>     INFO: ---> TrimStepCorr2 extremal thresholds: 17.757439 .. 132.176316

[13:00:42.136] <TB3>     INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 20 dacrange: 7 .. 142 (-1/-1) hits flags = 16 (plus default)

[13:00:42.145] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[13:00:42.145] <TB3>     INFO:     run 1 of 1

[13:00:42.460] <TB3>     INFO: Expecting 11315200 events.

[13:01:07.661] <TB3>     INFO: 739780 events read in total (24485ms).

[13:01:32.234] <TB3>     INFO: 1479380 events read in total (49058ms).

[13:01:56.676] <TB3>     INFO: 2219280 events read in total (73500ms).

[13:02:19.264] <TB3>     INFO: 2958980 events read in total (96088ms).

[13:02:43.720] <TB3>     INFO: 3698840 events read in total (120544ms).

[13:03:07.109] <TB3>     INFO: 4438620 events read in total (143933ms).

[13:03:31.623] <TB3>     INFO: 5178380 events read in total (168447ms).

[13:03:56.159] <TB3>     INFO: 5918000 events read in total (192983ms).

[13:04:20.812] <TB3>     INFO: 6657540 events read in total (217636ms).

[13:04:45.619] <TB3>     INFO: 7396940 events read in total (242443ms).

[13:05:08.109] <TB3>     INFO: 8136080 events read in total (264933ms).

[13:05:30.590] <TB3>     INFO: 8874860 events read in total (287414ms).

[13:05:53.082] <TB3>     INFO: 9614060 events read in total (309906ms).

[13:06:15.427] <TB3>     INFO: 10353320 events read in total (332251ms).

[13:06:38.598] <TB3>     INFO: 11092280 events read in total (355422ms).

[13:06:45.897] <TB3>     INFO: 11315200 events read in total (362721ms).

[13:06:45.939] <TB3>     INFO: Test took 363794ms.

[13:06:46.076] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:07:09.187] <TB3>     INFO: ---> TrimStepCorr1a extremal thresholds: 22.592392 .. 115.256451

[13:07:09.263] <TB3>     INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 20 dacrange: 12 .. 125 (-1/-1) hits flags = 16 (plus default)

[13:07:09.272] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[13:07:09.272] <TB3>     INFO:     run 1 of 1

[13:07:09.577] <TB3>     INFO: Expecting 9484800 events.

[13:07:34.882] <TB3>     INFO: 738720 events read in total (24589ms).

[13:07:59.168] <TB3>     INFO: 1477340 events read in total (48875ms).

[13:08:21.438] <TB3>     INFO: 2215940 events read in total (71145ms).

[13:08:44.676] <TB3>     INFO: 2954540 events read in total (94383ms).

[13:09:09.349] <TB3>     INFO: 3693200 events read in total (119056ms).

[13:09:34.258] <TB3>     INFO: 4431940 events read in total (143965ms).

[13:09:58.721] <TB3>     INFO: 5170420 events read in total (168428ms).

[13:10:23.337] <TB3>     INFO: 5909040 events read in total (193044ms).

[13:10:46.631] <TB3>     INFO: 6647320 events read in total (216338ms).

[13:11:09.454] <TB3>     INFO: 7385540 events read in total (239161ms).

[13:11:33.400] <TB3>     INFO: 8123520 events read in total (263107ms).

[13:11:57.686] <TB3>     INFO: 8861720 events read in total (287393ms).

[13:12:16.549] <TB3>     INFO: 9484800 events read in total (306256ms).

[13:12:16.580] <TB3>     INFO: Test took 307308ms.

[13:12:16.692] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:12:37.019] <TB3>     INFO: ---> TrimStepCorr1b extremal thresholds: 24.780531 .. 43.662731

[13:12:37.112] <TB3>     INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 20 dacrange: 14 .. 53 (-1/-1) hits flags = 16 (plus default)

[13:12:37.122] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[13:12:37.122] <TB3>     INFO:     run 1 of 1

[13:12:37.433] <TB3>     INFO: Expecting 3328000 events.

[13:13:04.516] <TB3>     INFO: 900820 events read in total (26367ms).

[13:13:30.229] <TB3>     INFO: 1801820 events read in total (52080ms).

[13:13:56.574] <TB3>     INFO: 2702260 events read in total (78426ms).

[13:14:14.352] <TB3>     INFO: 3328000 events read in total (96203ms).

[13:14:14.371] <TB3>     INFO: Test took 97249ms.

[13:14:14.404] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:14:27.667] <TB3>     INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55

[13:14:27.667] <TB3>     INFO: ---> dac: vcal name: TrimThrFinal ntrig: 20 dacrange: 15 .. 55 (-1/-1) hits flags = 16 (plus default)

[13:14:27.679] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 20

[13:14:27.679] <TB3>     INFO:     run 1 of 1

[13:14:28.059] <TB3>     INFO: Expecting 3411200 events.

[13:14:55.174] <TB3>     INFO: 878940 events read in total (26399ms).

[13:15:21.454] <TB3>     INFO: 1757820 events read in total (52679ms).

[13:15:47.564] <TB3>     INFO: 2636220 events read in total (78789ms).

[13:16:09.876] <TB3>     INFO: 3411200 events read in total (101101ms).

[13:16:09.894] <TB3>     INFO: Test took 102216ms.

[13:16:09.931] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:16:23.149] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C0.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C1.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C2.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C3.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C4.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C5.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C6.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C7.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C8.dat

[13:16:23.160] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C9.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C10.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C11.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C12.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C13.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C14.dat

[13:16:23.161] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C15.dat

[13:16:23.161] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C0.dat

[13:16:23.170] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C1.dat

[13:16:23.177] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C2.dat

[13:16:23.183] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C3.dat

[13:16:23.190] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C4.dat

[13:16:23.197] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C5.dat

[13:16:23.203] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C6.dat

[13:16:23.210] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C7.dat

[13:16:23.217] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C8.dat

[13:16:23.224] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C9.dat

[13:16:23.230] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C10.dat

[13:16:23.237] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C11.dat

[13:16:23.244] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C12.dat

[13:16:23.250] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C13.dat

[13:16:23.257] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C14.dat

[13:16:23.265] <TB3>     INFO: write trim parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//trimParameters35_C15.dat

[13:16:23.272] <TB3>     INFO: PixTestTrim::trimTest() done

[13:16:23.272] <TB3>     INFO: vtrim:      92 100  91  99  90 106  84  90  94 110 101 102  92  96  85 101 

[13:16:23.272] <TB3>     INFO: vthrcomp:   79  77  74  85  95  98  91  85  74  81  77  77  88  77 100  81 

[13:16:23.272] <TB3>     INFO: vcal mean:  34.95  35.03  34.99  34.96  34.90  34.93  34.99  34.97  34.99  34.99  35.01  35.00  35.00  35.02  34.95  34.96 

[13:16:23.272] <TB3>     INFO: vcal RMS:    0.66   0.68   0.63   0.87   0.90   0.77   0.74   0.65   0.65   0.71   0.68   0.67   0.67   0.74   0.74   0.88 

[13:16:23.272] <TB3>     INFO: bits mean:   8.24   7.71   8.76   9.69   9.05   9.47   8.51   9.06   8.68   9.31   8.41   8.74   9.36   7.63   8.81   9.36 

[13:16:23.272] <TB3>     INFO: bits RMS:    2.63   2.89   2.72   2.59   3.05   2.81   3.00   2.89   2.60   2.72   2.62   2.57   2.76   3.01   2.98   2.83 

[13:16:23.279] <TB3>     INFO:    ----------------------------------------------------------------------

[13:16:23.279] <TB3>     INFO:    PixTestTrim::trimBitTest() ntrig = 10, vtrims = 254 126 63 32

[13:16:23.279] <TB3>     INFO:    ----------------------------------------------------------------------

[13:16:23.283] <TB3>     INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 10 dacrange: 0 .. 199 (-1/-1) hits flags = 16 (plus default)

[13:16:23.292] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 10

[13:16:23.292] <TB3>     INFO:     run 1 of 1

[13:16:23.595] <TB3>     INFO: Expecting 8320000 events.

[13:16:53.450] <TB3>     INFO: 892100 events read in total (29139ms).

[13:17:22.603] <TB3>     INFO: 1777060 events read in total (58292ms).

[13:17:50.083] <TB3>     INFO: 2659730 events read in total (85772ms).

[13:18:18.839] <TB3>     INFO: 3541150 events read in total (114528ms).

[13:18:47.780] <TB3>     INFO: 4417560 events read in total (143469ms).

[13:19:16.624] <TB3>     INFO: 5290280 events read in total (172313ms).

[13:19:45.436] <TB3>     INFO: 6161530 events read in total (201125ms).

[13:20:13.380] <TB3>     INFO: 7033700 events read in total (229069ms).

[13:20:40.976] <TB3>     INFO: 7907230 events read in total (256665ms).

[13:20:54.861] <TB3>     INFO: 8320000 events read in total (270550ms).

[13:20:54.902] <TB3>     INFO: Test took 271610ms.

[13:20:55.020] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:21:21.911] <TB3>     INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 10 dacrange: 0 .. 156 (-1/-1) hits flags = 16 (plus default)

[13:21:21.920] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 10

[13:21:21.920] <TB3>     INFO:     run 1 of 1

[13:21:22.236] <TB3>     INFO: Expecting 6531200 events.

[13:21:52.496] <TB3>     INFO: 942090 events read in total (29544ms).

[13:22:22.173] <TB3>     INFO: 1874850 events read in total (59221ms).

[13:22:50.670] <TB3>     INFO: 2804920 events read in total (87718ms).

[13:23:19.545] <TB3>     INFO: 3727080 events read in total (116593ms).

[13:23:48.920] <TB3>     INFO: 4645470 events read in total (145968ms).

[13:24:17.332] <TB3>     INFO: 5562600 events read in total (174380ms).

[13:24:46.745] <TB3>     INFO: 6484570 events read in total (203793ms).

[13:24:48.659] <TB3>     INFO: 6531200 events read in total (205707ms).

[13:24:48.689] <TB3>     INFO: Test took 206769ms.

[13:24:48.772] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:25:10.539] <TB3>     INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 10 dacrange: 0 .. 146 (-1/-1) hits flags = 16 (plus default)

[13:25:10.547] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 10

[13:25:10.547] <TB3>     INFO:     run 1 of 1

[13:25:10.851] <TB3>     INFO: Expecting 6115200 events.

[13:25:41.903] <TB3>     INFO: 969050 events read in total (30334ms).

[13:26:12.008] <TB3>     INFO: 1927460 events read in total (60439ms).

[13:26:42.065] <TB3>     INFO: 2882150 events read in total (90496ms).

[13:27:11.996] <TB3>     INFO: 3826010 events read in total (120427ms).

[13:27:41.659] <TB3>     INFO: 4767500 events read in total (150090ms).

[13:28:09.189] <TB3>     INFO: 5710330 events read in total (177620ms).

[13:28:21.160] <TB3>     INFO: 6115200 events read in total (189591ms).

[13:28:21.193] <TB3>     INFO: Test took 190645ms.

[13:28:21.266] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:28:43.642] <TB3>     INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 10 dacrange: 0 .. 146 (-1/-1) hits flags = 16 (plus default)

[13:28:43.651] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 10

[13:28:43.651] <TB3>     INFO:     run 1 of 1

[13:28:43.971] <TB3>     INFO: Expecting 6115200 events.

[13:29:14.842] <TB3>     INFO: 968530 events read in total (30155ms).

[13:29:44.943] <TB3>     INFO: 1926670 events read in total (60256ms).

[13:30:15.031] <TB3>     INFO: 2880710 events read in total (90345ms).

[13:30:44.940] <TB3>     INFO: 3824080 events read in total (120253ms).

[13:31:14.937] <TB3>     INFO: 4765230 events read in total (150250ms).

[13:31:44.792] <TB3>     INFO: 5707440 events read in total (180105ms).

[13:31:58.015] <TB3>     INFO: 6115200 events read in total (193328ms).

[13:31:58.047] <TB3>     INFO: Test took 194396ms.

[13:31:58.118] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:32:20.967] <TB3>     INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 10 dacrange: 0 .. 146 (-1/-1) hits flags = 16 (plus default)

[13:32:20.976] <TB3>     INFO:   dacScan split into 1 runs with ntrig = 10

[13:32:20.976] <TB3>     INFO:     run 1 of 1

[13:32:21.294] <TB3>     INFO: Expecting 6115200 events.

[13:32:51.957] <TB3>     INFO: 967900 events read in total (29947ms).

[13:33:21.809] <TB3>     INFO: 1925170 events read in total (59799ms).

[13:33:51.669] <TB3>     INFO: 2878390 events read in total (89660ms).

[13:34:19.887] <TB3>     INFO: 3821390 events read in total (117877ms).

[13:34:47.409] <TB3>     INFO: 4761600 events read in total (145399ms).

[13:35:15.718] <TB3>     INFO: 5703480 events read in total (173708ms).

[13:35:27.877] <TB3>     INFO: 6115200 events read in total (185867ms).

[13:35:27.904] <TB3>     INFO: Test took 186928ms.

[13:35:27.971] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:35:50.797] <TB3>     INFO: PixTestTrim::trimBitTest() done 

[13:35:50.799] <TB3>     INFO: PixTestTrim::doTest() done, duration: 4404 seconds

[13:35:51.482] <TB3>     INFO: ######################################################################

[13:35:51.482] <TB3>     INFO: PixTestPhOptimization::doTest() Ntrig = 10

[13:35:51.482] <TB3>     INFO: ######################################################################

[13:35:51.790] <TB3>     INFO: Expecting 41600 events.

[13:35:56.112] <TB3>     INFO: 41600 events read in total (3606ms).

[13:35:56.113] <TB3>     INFO: Test took 4630ms.

[13:35:56.121] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:35:56.700] <TB3>     INFO: Expecting 41600 events.

[13:36:01.045] <TB3>     INFO: 41600 events read in total (3629ms).

[13:36:01.045] <TB3>     INFO: Test took 4672ms.

[13:36:01.051] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:01.401] <TB3>     INFO: Expecting 41600 events.

[13:36:05.788] <TB3>     INFO: 41600 events read in total (3671ms).

[13:36:05.788] <TB3>     INFO: Test took 4711ms.

[13:36:05.794] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:06.147] <TB3>     INFO: Expecting 41600 events.

[13:36:10.540] <TB3>     INFO: 41600 events read in total (3677ms).

[13:36:10.540] <TB3>     INFO: Test took 4716ms.

[13:36:10.547] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:10.922] <TB3>     INFO: Expecting 41600 events.

[13:36:15.249] <TB3>     INFO: 41600 events read in total (3611ms).

[13:36:15.249] <TB3>     INFO: Test took 4693ms.

[13:36:15.256] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:15.608] <TB3>     INFO: Expecting 41600 events.

[13:36:19.968] <TB3>     INFO: 41600 events read in total (3644ms).

[13:36:19.968] <TB3>     INFO: Test took 4684ms.

[13:36:19.974] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:20.318] <TB3>     INFO: Expecting 41600 events.

[13:36:24.626] <TB3>     INFO: 41600 events read in total (3591ms).

[13:36:24.627] <TB3>     INFO: Test took 4633ms.

[13:36:24.645] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:24.983] <TB3>     INFO: Expecting 41600 events.

[13:36:29.313] <TB3>     INFO: 41600 events read in total (3614ms).

[13:36:29.313] <TB3>     INFO: Test took 4654ms.

[13:36:29.320] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:29.673] <TB3>     INFO: Expecting 41600 events.

[13:36:34.119] <TB3>     INFO: 41600 events read in total (3730ms).

[13:36:34.120] <TB3>     INFO: Test took 4772ms.

[13:36:34.126] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:34.475] <TB3>     INFO: Expecting 41600 events.

[13:36:38.790] <TB3>     INFO: 41600 events read in total (3599ms).

[13:36:38.791] <TB3>     INFO: Test took 4640ms.

[13:36:38.796] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:39.151] <TB3>     INFO: Expecting 41600 events.

[13:36:43.493] <TB3>     INFO: 41600 events read in total (3626ms).

[13:36:43.493] <TB3>     INFO: Test took 4666ms.

[13:36:43.500] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:43.848] <TB3>     INFO: Expecting 41600 events.

[13:36:48.156] <TB3>     INFO: 41600 events read in total (3592ms).

[13:36:48.156] <TB3>     INFO: Test took 4632ms.

[13:36:48.163] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:48.505] <TB3>     INFO: Expecting 41600 events.

[13:36:52.841] <TB3>     INFO: 41600 events read in total (3620ms).

[13:36:52.842] <TB3>     INFO: Test took 4661ms.

[13:36:52.847] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:53.204] <TB3>     INFO: Expecting 41600 events.

[13:36:57.535] <TB3>     INFO: 41600 events read in total (3615ms).

[13:36:57.535] <TB3>     INFO: Test took 4655ms.

[13:36:57.541] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:36:57.896] <TB3>     INFO: Expecting 41600 events.

[13:37:02.215] <TB3>     INFO: 41600 events read in total (3603ms).

[13:37:02.215] <TB3>     INFO: Test took 4643ms.

[13:37:02.222] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:02.577] <TB3>     INFO: Expecting 41600 events.

[13:37:07.038] <TB3>     INFO: 41600 events read in total (3744ms).

[13:37:07.039] <TB3>     INFO: Test took 4786ms.

[13:37:07.046] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:07.389] <TB3>     INFO: Expecting 41600 events.

[13:37:11.886] <TB3>     INFO: 41600 events read in total (3780ms).

[13:37:11.887] <TB3>     INFO: Test took 4824ms.

[13:37:11.894] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:12.224] <TB3>     INFO: Expecting 41600 events.

[13:37:16.748] <TB3>     INFO: 41600 events read in total (3807ms).

[13:37:16.749] <TB3>     INFO: Test took 4843ms.

[13:37:16.755] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:17.104] <TB3>     INFO: Expecting 41600 events.

[13:37:21.623] <TB3>     INFO: 41600 events read in total (3803ms).

[13:37:21.624] <TB3>     INFO: Test took 4845ms.

[13:37:21.630] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:21.974] <TB3>     INFO: Expecting 41600 events.

[13:37:26.408] <TB3>     INFO: 41600 events read in total (3719ms).

[13:37:26.409] <TB3>     INFO: Test took 4760ms.

[13:37:26.416] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:26.765] <TB3>     INFO: Expecting 41600 events.

[13:37:31.230] <TB3>     INFO: 41600 events read in total (3749ms).

[13:37:31.230] <TB3>     INFO: Test took 4790ms.

[13:37:31.237] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:31.579] <TB3>     INFO: Expecting 41600 events.

[13:37:36.021] <TB3>     INFO: 41600 events read in total (3726ms).

[13:37:36.022] <TB3>     INFO: Test took 4767ms.

[13:37:36.029] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:36.383] <TB3>     INFO: Expecting 41600 events.

[13:37:40.880] <TB3>     INFO: 41600 events read in total (3781ms).

[13:37:40.881] <TB3>     INFO: Test took 4829ms.

[13:37:40.887] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:41.234] <TB3>     INFO: Expecting 41600 events.

[13:37:45.721] <TB3>     INFO: 41600 events read in total (3770ms).

[13:37:45.722] <TB3>     INFO: Test took 4813ms.

[13:37:45.728] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:46.076] <TB3>     INFO: Expecting 41600 events.

[13:37:50.555] <TB3>     INFO: 41600 events read in total (3763ms).

[13:37:50.556] <TB3>     INFO: Test took 4805ms.

[13:37:50.562] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:50.914] <TB3>     INFO: Expecting 41600 events.

[13:37:55.422] <TB3>     INFO: 41600 events read in total (3791ms).

[13:37:55.423] <TB3>     INFO: Test took 4833ms.

[13:37:55.429] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:37:55.772] <TB3>     INFO: Expecting 41600 events.

[13:38:00.241] <TB3>     INFO: 41600 events read in total (3752ms).

[13:38:00.242] <TB3>     INFO: Test took 4794ms.

[13:38:00.248] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:00.599] <TB3>     INFO: Expecting 41600 events.

[13:38:05.099] <TB3>     INFO: 41600 events read in total (3784ms).

[13:38:05.100] <TB3>     INFO: Test took 4826ms.

[13:38:05.107] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:05.452] <TB3>     INFO: Expecting 41600 events.

[13:38:09.937] <TB3>     INFO: 41600 events read in total (3768ms).

[13:38:09.938] <TB3>     INFO: Test took 4810ms.

[13:38:09.945] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:10.291] <TB3>     INFO: Expecting 41600 events.

[13:38:14.774] <TB3>     INFO: 41600 events read in total (3766ms).

[13:38:14.774] <TB3>     INFO: Test took 4807ms.

[13:38:14.781] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:15.136] <TB3>     INFO: Expecting 41600 events.

[13:38:19.618] <TB3>     INFO: 41600 events read in total (3766ms).

[13:38:19.619] <TB3>     INFO: Test took 4811ms.

[13:38:19.626] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:19.992] <TB3>     INFO: Expecting 41600 events.

[13:38:24.521] <TB3>     INFO: 41600 events read in total (3813ms).

[13:38:24.522] <TB3>     INFO: Test took 4869ms.

[13:38:24.529] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:24.874] <TB3>     INFO: Expecting 41600 events.

[13:38:29.333] <TB3>     INFO: 41600 events read in total (3743ms).

[13:38:29.334] <TB3>     INFO: Test took 4785ms.

[13:38:29.341] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:29.683] <TB3>     INFO: Expecting 41600 events.

[13:38:34.177] <TB3>     INFO: 41600 events read in total (3778ms).

[13:38:34.178] <TB3>     INFO: Test took 4820ms.

[13:38:34.185] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:34.531] <TB3>     INFO: Expecting 41600 events.

[13:38:39.011] <TB3>     INFO: 41600 events read in total (3763ms).

[13:38:39.012] <TB3>     INFO: Test took 4805ms.

[13:38:39.020] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:39.350] <TB3>     INFO: Expecting 41600 events.

[13:38:43.849] <TB3>     INFO: 41600 events read in total (3783ms).

[13:38:43.850] <TB3>     INFO: Test took 4819ms.

[13:38:43.856] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:44.209] <TB3>     INFO: Expecting 41600 events.

[13:38:48.684] <TB3>     INFO: 41600 events read in total (3759ms).

[13:38:48.685] <TB3>     INFO: Test took 4801ms.

[13:38:48.693] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:49.030] <TB3>     INFO: Expecting 41600 events.

[13:38:53.560] <TB3>     INFO: 41600 events read in total (3814ms).

[13:38:53.561] <TB3>     INFO: Test took 4856ms.

[13:38:53.567] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:53.912] <TB3>     INFO: Expecting 41600 events.

[13:38:58.411] <TB3>     INFO: 41600 events read in total (3783ms).

[13:38:58.412] <TB3>     INFO: Test took 4825ms.

[13:38:58.418] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:38:58.767] <TB3>     INFO: Expecting 41600 events.

[13:39:03.252] <TB3>     INFO: 41600 events read in total (3769ms).

[13:39:03.253] <TB3>     INFO: Test took 4810ms.

[13:39:03.260] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:03.606] <TB3>     INFO: Expecting 41600 events.

[13:39:08.077] <TB3>     INFO: 41600 events read in total (3755ms).

[13:39:08.078] <TB3>     INFO: Test took 4797ms.

[13:39:08.085] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:08.434] <TB3>     INFO: Expecting 41600 events.

[13:39:12.930] <TB3>     INFO: 41600 events read in total (3780ms).

[13:39:12.930] <TB3>     INFO: Test took 4833ms.

[13:39:12.937] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:13.275] <TB3>     INFO: Expecting 41600 events.

[13:39:17.729] <TB3>     INFO: 41600 events read in total (3737ms).

[13:39:17.730] <TB3>     INFO: Test took 4780ms.

[13:39:17.736] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:18.088] <TB3>     INFO: Expecting 41600 events.

[13:39:22.500] <TB3>     INFO: 41600 events read in total (3696ms).

[13:39:22.501] <TB3>     INFO: Test took 4738ms.

[13:39:22.507] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:22.860] <TB3>     INFO: Expecting 41600 events.

[13:39:27.280] <TB3>     INFO: 41600 events read in total (3703ms).

[13:39:27.281] <TB3>     INFO: Test took 4745ms.

[13:39:27.287] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:27.639] <TB3>     INFO: Expecting 41600 events.

[13:39:32.114] <TB3>     INFO: 41600 events read in total (3759ms).

[13:39:32.115] <TB3>     INFO: Test took 4801ms.

[13:39:32.121] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:32.471] <TB3>     INFO: Expecting 41600 events.

[13:39:36.941] <TB3>     INFO: 41600 events read in total (3753ms).

[13:39:36.941] <TB3>     INFO: Test took 4794ms.

[13:39:36.948] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:37.293] <TB3>     INFO: Expecting 41600 events.

[13:39:41.783] <TB3>     INFO: 41600 events read in total (3774ms).

[13:39:41.784] <TB3>     INFO: Test took 4815ms.

[13:39:41.791] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:42.142] <TB3>     INFO: Expecting 41600 events.

[13:39:46.611] <TB3>     INFO: 41600 events read in total (3754ms).

[13:39:46.613] <TB3>     INFO: Test took 4796ms.

[13:39:46.626] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:46.967] <TB3>     INFO: Expecting 41600 events.

[13:39:51.485] <TB3>     INFO: 41600 events read in total (3801ms).

[13:39:51.485] <TB3>     INFO: Test took 4842ms.

[13:39:51.493] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:51.839] <TB3>     INFO: Expecting 41600 events.

[13:39:56.280] <TB3>     INFO: 41600 events read in total (3724ms).

[13:39:56.281] <TB3>     INFO: Test took 4774ms.

[13:39:56.287] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:39:56.640] <TB3>     INFO: Expecting 41600 events.

[13:40:01.115] <TB3>     INFO: 41600 events read in total (3759ms).

[13:40:01.116] <TB3>     INFO: Test took 4801ms.

[13:40:01.122] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:40:01.469] <TB3>     INFO: Expecting 41600 events.

[13:40:05.983] <TB3>     INFO: 41600 events read in total (3798ms).

[13:40:05.984] <TB3>     INFO: Test took 4841ms.

[13:40:05.991] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:40:06.335] <TB3>     INFO: Expecting 41600 events.

[13:40:10.821] <TB3>     INFO: 41600 events read in total (3770ms).

[13:40:10.822] <TB3>     INFO: Test took 4812ms.

[13:40:10.829] <TB3>     INFO: Fetched DAQ statistics. Counters are being reset now.

[13:40:10.838] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:10.838] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:10.838] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:10.838] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:10.838] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:10.838] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:10.838] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:11.159] <TB3>     INFO: Expecting 2560 events.

[13:40:12.222] <TB3>     INFO: 2560 events read in total (347ms).

[13:40:12.223] <TB3>     INFO: Test took 1384ms.

[13:40:12.223] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:12.223] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:12.223] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:12.223] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:12.223] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:12.223] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.223] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.223] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.223] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.224] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:12.638] <TB3>     INFO: Expecting 2560 events.

[13:40:13.707] <TB3>     INFO: 2560 events read in total (353ms).

[13:40:13.707] <TB3>     INFO: Test took 1483ms.

[13:40:13.708] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:13.708] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:13.708] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:13.708] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:13.708] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:13.708] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:13.708] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:14.122] <TB3>     INFO: Expecting 2560 events.

[13:40:15.189] <TB3>     INFO: 2560 events read in total (350ms).

[13:40:15.190] <TB3>     INFO: Test took 1481ms.

[13:40:15.190] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:15.190] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:15.190] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:15.190] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:15.190] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:15.190] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.190] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.190] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.190] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.190] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.191] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:15.604] <TB3>     INFO: Expecting 2560 events.

[13:40:16.667] <TB3>     INFO: 2560 events read in total (346ms).

[13:40:16.668] <TB3>     INFO: Test took 1477ms.

[13:40:16.668] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:16.668] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:16.668] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:16.668] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:16.668] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:16.668] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.668] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:16.669] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:17.082] <TB3>     INFO: Expecting 2560 events.

[13:40:18.151] <TB3>     INFO: 2560 events read in total (352ms).

[13:40:18.151] <TB3>     INFO: Test took 1482ms.

[13:40:18.151] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:18.151] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:18.152] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:18.152] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:18.152] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:18.152] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.152] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:18.566] <TB3>     INFO: Expecting 2560 events.

[13:40:19.635] <TB3>     INFO: 2560 events read in total (353ms).

[13:40:19.635] <TB3>     INFO: Test took 1483ms.

[13:40:19.635] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:19.635] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:19.635] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:19.636] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:19.636] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:19.636] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:19.636] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:20.050] <TB3>     INFO: Expecting 2560 events.

[13:40:21.133] <TB3>     INFO: 2560 events read in total (367ms).

[13:40:21.133] <TB3>     INFO: Test took 1497ms.

[13:40:21.133] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:21.133] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:21.133] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:21.133] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:21.133] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:21.133] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.133] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.134] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:21.548] <TB3>     INFO: Expecting 2560 events.

[13:40:22.616] <TB3>     INFO: 2560 events read in total (352ms).

[13:40:22.616] <TB3>     INFO: Test took 1482ms.

[13:40:22.617] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:22.617] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:22.617] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:22.617] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:22.617] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:22.617] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.617] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.618] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.618] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.618] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.618] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:22.618] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:23.031] <TB3>     INFO: Expecting 2560 events.

[13:40:24.101] <TB3>     INFO: 2560 events read in total (354ms).

[13:40:24.101] <TB3>     INFO: Test took 1483ms.

[13:40:24.101] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:24.102] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:24.102] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:24.102] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:24.102] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:24.102] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.102] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:24.516] <TB3>     INFO: Expecting 2560 events.

[13:40:25.589] <TB3>     INFO: 2560 events read in total (357ms).

[13:40:25.589] <TB3>     INFO: Test took 1487ms.

[13:40:25.590] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:25.590] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:25.590] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:25.590] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:25.590] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:25.590] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:25.590] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:26.004] <TB3>     INFO: Expecting 2560 events.

[13:40:27.074] <TB3>     INFO: 2560 events read in total (354ms).

[13:40:27.074] <TB3>     INFO: Test took 1484ms.

[13:40:27.078] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:27.078] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:27.078] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:27.078] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:27.078] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:27.078] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.078] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:27.489] <TB3>     INFO: Expecting 2560 events.

[13:40:28.553] <TB3>     INFO: 2560 events read in total (348ms).

[13:40:28.554] <TB3>     INFO: Test took 1476ms.

[13:40:28.554] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:28.554] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:28.554] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:28.554] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:28.554] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:28.554] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.554] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:28.969] <TB3>     INFO: Expecting 2560 events.

[13:40:30.037] <TB3>     INFO: 2560 events read in total (352ms).

[13:40:30.037] <TB3>     INFO: Test took 1483ms.

[13:40:30.037] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:30.037] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:30.037] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:30.038] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:30.038] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:30.038] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.038] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:30.452] <TB3>     INFO: Expecting 2560 events.

[13:40:31.534] <TB3>     INFO: 2560 events read in total (366ms).

[13:40:31.534] <TB3>     INFO: Test took 1496ms.

[13:40:31.535] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:31.535] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:31.535] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:31.535] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:31.535] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:31.535] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.535] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:31.949] <TB3>     INFO: Expecting 2560 events.

[13:40:33.018] <TB3>     INFO: 2560 events read in total (352ms).

[13:40:33.019] <TB3>     INFO: Test took 1484ms.

[13:40:33.019] <TB3>     INFO: The DUT currently contains the following objects:

[13:40:33.019] <TB3>     INFO:  2 TBM Cores tbm09c (2 ON)

[13:40:33.019] <TB3>     INFO: 	TBM Core alpha (0): 7 registers set

[13:40:33.019] <TB3>     INFO: 	TBM Core beta  (1): 7 registers set

[13:40:33.019] <TB3>     INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs

[13:40:33.019] <TB3>     INFO: 	ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.019] <TB3>     INFO: 	ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.019] <TB3>     INFO: 	ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.019] <TB3>     INFO: 	ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.019] <TB3>     INFO: 	ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.020] <TB3>     INFO: 	ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.

[13:40:33.433] <TB3>     INFO: Expecting 2560 events.

[13:40:34.502] <TB3>     INFO: 2560 events read in total (352ms).

[13:40:34.503] <TB3>     INFO: Test took 1483ms.

[13:40:34.507] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:40:34.920] <TB3>     INFO: Expecting 655360 events.

[13:40:51.612] <TB3>     INFO: 655360 events read in total (15976ms).

[13:40:51.624] <TB3>     INFO: Expecting 655360 events.

[13:41:07.302] <TB3>     INFO: 655360 events read in total (15150ms).

[13:41:07.317] <TB3>     INFO: Expecting 655360 events.

[13:41:22.527] <TB3>     INFO: 655360 events read in total (14682ms).

[13:41:22.544] <TB3>     INFO: Expecting 655360 events.

[13:41:38.839] <TB3>     INFO: 655360 events read in total (15768ms).

[13:41:38.862] <TB3>     INFO: Expecting 655360 events.

[13:41:53.817] <TB3>     INFO: 655360 events read in total (14427ms).

[13:41:53.840] <TB3>     INFO: Expecting 655360 events.

[13:42:08.871] <TB3>     INFO: 655360 events read in total (14503ms).

[13:42:08.900] <TB3>     INFO: Expecting 655360 events.

[13:42:25.292] <TB3>     INFO: 655360 events read in total (15864ms).

[13:42:25.330] <TB3>     INFO: Expecting 655360 events.

[13:42:41.893] <TB3>     INFO: 655360 events read in total (16035ms).

[13:42:41.933] <TB3>     INFO: Expecting 655360 events.

[13:42:58.409] <TB3>     INFO: 655360 events read in total (15948ms).

[13:42:58.448] <TB3>     INFO: Expecting 655360 events.

[13:43:15.140] <TB3>     INFO: 655360 events read in total (16165ms).

[13:43:15.183] <TB3>     INFO: Expecting 655360 events.

[13:43:31.651] <TB3>     INFO: 655360 events read in total (15940ms).

[13:43:31.695] <TB3>     INFO: Expecting 655360 events.

[13:43:48.190] <TB3>     INFO: 655360 events read in total (15967ms).

[13:43:48.237] <TB3>     INFO: Expecting 655360 events.

[13:44:04.779] <TB3>     INFO: 655360 events read in total (16015ms).

[13:44:04.830] <TB3>     INFO: Expecting 655360 events.

[13:44:21.348] <TB3>     INFO: 655360 events read in total (15990ms).

[13:44:21.403] <TB3>     INFO: Expecting 655360 events.

[13:44:38.044] <TB3>     INFO: 655360 events read in total (16113ms).

[13:44:38.100] <TB3>     INFO: Expecting 655360 events.

[13:44:54.678] <TB3>     INFO: 655360 events read in total (16050ms).

[13:44:54.754] <TB3>     INFO: Test took 260248ms.

[13:44:54.848] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:44:55.158] <TB3>     INFO: Expecting 655360 events.

[13:45:11.949] <TB3>     INFO: 655360 events read in total (16074ms).

[13:45:11.958] <TB3>     INFO: Expecting 655360 events.

[13:45:28.485] <TB3>     INFO: 655360 events read in total (15999ms).

[13:45:28.498] <TB3>     INFO: Expecting 655360 events.

[13:45:44.844] <TB3>     INFO: 655360 events read in total (15819ms).

[13:45:44.861] <TB3>     INFO: Expecting 655360 events.

[13:46:01.242] <TB3>     INFO: 655360 events read in total (15854ms).

[13:46:01.266] <TB3>     INFO: Expecting 655360 events.

[13:46:17.559] <TB3>     INFO: 655360 events read in total (15765ms).

[13:46:17.584] <TB3>     INFO: Expecting 655360 events.

[13:46:34.028] <TB3>     INFO: 655360 events read in total (15916ms).

[13:46:34.058] <TB3>     INFO: Expecting 655360 events.

[13:46:50.492] <TB3>     INFO: 655360 events read in total (15906ms).

[13:46:50.529] <TB3>     INFO: Expecting 655360 events.

[13:47:06.843] <TB3>     INFO: 655360 events read in total (15786ms).

[13:47:06.879] <TB3>     INFO: Expecting 655360 events.

[13:47:23.389] <TB3>     INFO: 655360 events read in total (15982ms).

[13:47:23.429] <TB3>     INFO: Expecting 655360 events.

[13:47:39.843] <TB3>     INFO: 655360 events read in total (15886ms).

[13:47:39.882] <TB3>     INFO: Expecting 655360 events.

[13:47:56.482] <TB3>     INFO: 655360 events read in total (16072ms).

[13:47:56.529] <TB3>     INFO: Expecting 655360 events.

[13:48:13.480] <TB3>     INFO: 655360 events read in total (16424ms).

[13:48:13.529] <TB3>     INFO: Expecting 655360 events.

[13:48:30.247] <TB3>     INFO: 655360 events read in total (16191ms).

[13:48:30.303] <TB3>     INFO: Expecting 655360 events.

[13:48:46.970] <TB3>     INFO: 655360 events read in total (16139ms).

[13:48:47.025] <TB3>     INFO: Expecting 655360 events.

[13:49:04.236] <TB3>     INFO: 655360 events read in total (16683ms).

[13:49:04.300] <TB3>     INFO: Expecting 655360 events.

[13:49:21.308] <TB3>     INFO: 655360 events read in total (16480ms).

[13:49:21.369] <TB3>     INFO: Test took 266521ms.

[13:49:21.621] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.628] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.635] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.642] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.649] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.657] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.664] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.672] <TB3>     INFO: safety margin for low PH: adding 1, margin is now 21

[13:49:21.679] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.687] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.694] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.705] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.714] <TB3>     INFO: safety margin for low PH: adding 1, margin is now 21

[13:49:21.721] <TB3>     INFO: safety margin for low PH: adding 2, margin is now 22

[13:49:21.728] <TB3>     INFO: safety margin for low PH: adding 3, margin is now 23

[13:49:21.735] <TB3>     INFO: safety margin for low PH: adding 4, margin is now 24

[13:49:21.742] <TB3>     INFO: safety margin for low PH: adding 5, margin is now 25

[13:49:21.750] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.757] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.764] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.772] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.779] <TB3>     INFO: safety margin for low PH: adding 0, margin is now 20

[13:49:21.819] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C0.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C1.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C2.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C3.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C4.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C5.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C6.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C7.dat

[13:49:21.820] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C8.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C9.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C10.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C11.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C12.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C13.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C14.dat

[13:49:21.821] <TB3>     INFO: write dac parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//dacParameters35_C15.dat

[13:49:22.125] <TB3>     INFO: Expecting 41600 events.

[13:49:26.617] <TB3>     INFO: 41600 events read in total (3776ms).

[13:49:26.618] <TB3>     INFO: Test took 4794ms.

[13:49:27.155] <TB3>     INFO: Expecting 41600 events.

[13:49:31.743] <TB3>     INFO: 41600 events read in total (3872ms).

[13:49:31.743] <TB3>     INFO: Test took 4892ms.

[13:49:32.274] <TB3>     INFO: Expecting 41600 events.

[13:49:36.768] <TB3>     INFO: 41600 events read in total (3778ms).

[13:49:36.768] <TB3>     INFO: Test took 4805ms.

[13:49:37.007] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:37.139] <TB3>     INFO: Expecting 2560 events.

[13:49:38.211] <TB3>     INFO: 2560 events read in total (355ms).

[13:49:38.212] <TB3>     INFO: Test took 1205ms.

[13:49:38.214] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:38.628] <TB3>     INFO: Expecting 2560 events.

[13:49:39.702] <TB3>     INFO: 2560 events read in total (358ms).

[13:49:39.703] <TB3>     INFO: Test took 1489ms.

[13:49:39.705] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:40.118] <TB3>     INFO: Expecting 2560 events.

[13:49:41.193] <TB3>     INFO: 2560 events read in total (358ms).

[13:49:41.193] <TB3>     INFO: Test took 1488ms.

[13:49:41.196] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:41.609] <TB3>     INFO: Expecting 2560 events.

[13:49:42.678] <TB3>     INFO: 2560 events read in total (352ms).

[13:49:42.679] <TB3>     INFO: Test took 1483ms.

[13:49:42.682] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:43.095] <TB3>     INFO: Expecting 2560 events.

[13:49:44.165] <TB3>     INFO: 2560 events read in total (353ms).

[13:49:44.165] <TB3>     INFO: Test took 1484ms.

[13:49:44.168] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:44.581] <TB3>     INFO: Expecting 2560 events.

[13:49:45.651] <TB3>     INFO: 2560 events read in total (353ms).

[13:49:45.651] <TB3>     INFO: Test took 1483ms.

[13:49:45.654] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:46.067] <TB3>     INFO: Expecting 2560 events.

[13:49:47.138] <TB3>     INFO: 2560 events read in total (354ms).

[13:49:47.138] <TB3>     INFO: Test took 1484ms.

[13:49:47.141] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:47.554] <TB3>     INFO: Expecting 2560 events.

[13:49:48.622] <TB3>     INFO: 2560 events read in total (352ms).

[13:49:48.622] <TB3>     INFO: Test took 1481ms.

[13:49:48.626] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:49.037] <TB3>     INFO: Expecting 2560 events.

[13:49:50.110] <TB3>     INFO: 2560 events read in total (356ms).

[13:49:50.110] <TB3>     INFO: Test took 1484ms.

[13:49:50.112] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:50.525] <TB3>     INFO: Expecting 2560 events.

[13:49:51.595] <TB3>     INFO: 2560 events read in total (353ms).

[13:49:51.595] <TB3>     INFO: Test took 1483ms.

[13:49:51.597] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:52.011] <TB3>     INFO: Expecting 2560 events.

[13:49:53.081] <TB3>     INFO: 2560 events read in total (353ms).

[13:49:53.081] <TB3>     INFO: Test took 1484ms.

[13:49:53.083] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:53.498] <TB3>     INFO: Expecting 2560 events.

[13:49:54.572] <TB3>     INFO: 2560 events read in total (358ms).

[13:49:54.573] <TB3>     INFO: Test took 1490ms.

[13:49:54.576] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:54.989] <TB3>     INFO: Expecting 2560 events.

[13:49:56.063] <TB3>     INFO: 2560 events read in total (358ms).

[13:49:56.063] <TB3>     INFO: Test took 1488ms.

[13:49:56.066] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:56.479] <TB3>     INFO: Expecting 2560 events.

[13:49:57.553] <TB3>     INFO: 2560 events read in total (357ms).

[13:49:57.554] <TB3>     INFO: Test took 1488ms.

[13:49:57.556] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:57.970] <TB3>     INFO: Expecting 2560 events.

[13:49:59.045] <TB3>     INFO: 2560 events read in total (359ms).

[13:49:59.046] <TB3>     INFO: Test took 1490ms.

[13:49:59.048] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:49:59.462] <TB3>     INFO: Expecting 2560 events.

[13:50:00.536] <TB3>     INFO: 2560 events read in total (358ms).

[13:50:00.537] <TB3>     INFO: Test took 1489ms.

[13:50:00.539] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:00.953] <TB3>     INFO: Expecting 2560 events.

[13:50:02.020] <TB3>     INFO: 2560 events read in total (350ms).

[13:50:02.020] <TB3>     INFO: Test took 1481ms.

[13:50:02.025] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:02.436] <TB3>     INFO: Expecting 2560 events.

[13:50:03.503] <TB3>     INFO: 2560 events read in total (351ms).

[13:50:03.503] <TB3>     INFO: Test took 1478ms.

[13:50:03.506] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:03.919] <TB3>     INFO: Expecting 2560 events.

[13:50:04.988] <TB3>     INFO: 2560 events read in total (353ms).

[13:50:04.989] <TB3>     INFO: Test took 1484ms.

[13:50:04.991] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:05.405] <TB3>     INFO: Expecting 2560 events.

[13:50:06.473] <TB3>     INFO: 2560 events read in total (352ms).

[13:50:06.473] <TB3>     INFO: Test took 1482ms.

[13:50:06.475] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:06.888] <TB3>     INFO: Expecting 2560 events.

[13:50:07.957] <TB3>     INFO: 2560 events read in total (352ms).

[13:50:07.958] <TB3>     INFO: Test took 1483ms.

[13:50:07.961] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:08.373] <TB3>     INFO: Expecting 2560 events.

[13:50:09.444] <TB3>     INFO: 2560 events read in total (355ms).

[13:50:09.445] <TB3>     INFO: Test took 1484ms.

[13:50:09.448] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:09.860] <TB3>     INFO: Expecting 2560 events.

[13:50:10.930] <TB3>     INFO: 2560 events read in total (353ms).

[13:50:10.931] <TB3>     INFO: Test took 1483ms.

[13:50:10.933] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:11.347] <TB3>     INFO: Expecting 2560 events.

[13:50:12.412] <TB3>     INFO: 2560 events read in total (349ms).

[13:50:12.413] <TB3>     INFO: Test took 1480ms.

[13:50:12.415] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:12.830] <TB3>     INFO: Expecting 2560 events.

[13:50:13.904] <TB3>     INFO: 2560 events read in total (357ms).

[13:50:13.905] <TB3>     INFO: Test took 1490ms.

[13:50:13.908] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:14.321] <TB3>     INFO: Expecting 2560 events.

[13:50:15.395] <TB3>     INFO: 2560 events read in total (358ms).

[13:50:15.395] <TB3>     INFO: Test took 1488ms.

[13:50:15.399] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:15.812] <TB3>     INFO: Expecting 2560 events.

[13:50:16.881] <TB3>     INFO: 2560 events read in total (353ms).

[13:50:16.881] <TB3>     INFO: Test took 1483ms.

[13:50:16.884] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:17.298] <TB3>     INFO: Expecting 2560 events.

[13:50:18.371] <TB3>     INFO: 2560 events read in total (356ms).

[13:50:18.372] <TB3>     INFO: Test took 1489ms.

[13:50:18.375] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:18.788] <TB3>     INFO: Expecting 2560 events.

[13:50:19.862] <TB3>     INFO: 2560 events read in total (358ms).

[13:50:19.862] <TB3>     INFO: Test took 1488ms.

[13:50:19.866] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:20.278] <TB3>     INFO: Expecting 2560 events.

[13:50:21.350] <TB3>     INFO: 2560 events read in total (356ms).

[13:50:21.350] <TB3>     INFO: Test took 1485ms.

[13:50:21.354] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:21.766] <TB3>     INFO: Expecting 2560 events.

[13:50:22.853] <TB3>     INFO: 2560 events read in total (370ms).

[13:50:22.854] <TB3>     INFO: Test took 1500ms.

[13:50:22.857] <TB3>     INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.

[13:50:23.270] <TB3>     INFO: Expecting 2560 events.

[13:50:24.343] <TB3>     INFO: 2560 events read in total (357ms).

[13:50:24.344] <TB3>     INFO: Test took 1487ms.

[13:50:24.978] <TB3>     INFO: PixTestPhOptimization::doTest() done, duration: 873 seconds

[13:50:24.978] <TB3>     INFO: PH scale (per ROC):    81  91  86  99  80  82  80  81  79  87  85  93  91  78  78  85

[13:50:24.978] <TB3>     INFO: PH offset (per ROC):  158 158 150 156 154 173 176 158 154 158 144 151 149 149 158 151

[13:50:25.154] <TB3>     INFO: ######################################################################

[13:50:25.154] <TB3>     INFO: PixTestGainPedestal::fullTest() ntrig = 10

[13:50:25.154] <TB3>     INFO: ######################################################################

[13:50:25.166] <TB3>     INFO: scanning low vcal = 10

[13:50:25.486] <TB3>     INFO: Expecting 41600 events.

[13:50:29.097] <TB3>     INFO: 41600 events read in total (2894ms).

[13:50:29.097] <TB3>     INFO: Test took 3931ms.

[13:50:29.100] <TB3>     INFO: scanning low vcal = 20

[13:50:29.513] <TB3>     INFO: Expecting 41600 events.

[13:50:33.143] <TB3>     INFO: 41600 events read in total (2914ms).

[13:50:33.143] <TB3>     INFO: Test took 4043ms.

[13:50:33.145] <TB3>     INFO: scanning low vcal = 30

[13:50:33.559] <TB3>     INFO: Expecting 41600 events.

[13:50:37.237] <TB3>     INFO: 41600 events read in total (2961ms).

[13:50:37.237] <TB3>     INFO: Test took 4092ms.

[13:50:37.239] <TB3>     INFO: scanning low vcal = 40

[13:50:37.646] <TB3>     INFO: Expecting 41600 events.

[13:50:41.881] <TB3>     INFO: 41600 events read in total (3519ms).

[13:50:41.881] <TB3>     INFO: Test took 4642ms.

[13:50:41.885] <TB3>     INFO: scanning low vcal = 50

[13:50:42.239] <TB3>     INFO: Expecting 41600 events.

[13:50:46.525] <TB3>     INFO: 41600 events read in total (3570ms).

[13:50:46.525] <TB3>     INFO: Test took 4640ms.

[13:50:46.529] <TB3>     INFO: scanning low vcal = 60

[13:50:46.865] <TB3>     INFO: Expecting 41600 events.

[13:50:51.080] <TB3>     INFO: 41600 events read in total (3499ms).

[13:50:51.081] <TB3>     INFO: Test took 4552ms.

[13:50:51.084] <TB3>     INFO: scanning low vcal = 70

[13:50:51.435] <TB3>     INFO: Expecting 41600 events.

[13:50:55.787] <TB3>     INFO: 41600 events read in total (3636ms).

[13:50:55.788] <TB3>     INFO: Test took 4704ms.

[13:50:55.791] <TB3>     INFO: scanning low vcal = 80

[13:50:56.111] <TB3>     INFO: Expecting 41600 events.

[13:51:00.310] <TB3>     INFO: 41600 events read in total (3482ms).

[13:51:00.311] <TB3>     INFO: Test took 4520ms.

[13:51:00.314] <TB3>     INFO: scanning low vcal = 90

[13:51:00.671] <TB3>     INFO: Expecting 41600 events.

[13:51:05.104] <TB3>     INFO: 41600 events read in total (3717ms).

[13:51:05.104] <TB3>     INFO: Test took 4790ms.

[13:51:05.107] <TB3>     INFO: scanning low vcal = 100

[13:51:05.449] <TB3>     INFO: Expecting 41600 events.

[13:51:09.699] <TB3>     INFO: 41600 events read in total (3534ms).

[13:51:09.699] <TB3>     INFO: Test took 4592ms.

[13:51:09.702] <TB3>     INFO: scanning low vcal = 110

[13:51:10.056] <TB3>     INFO: Expecting 41600 events.

[13:51:14.297] <TB3>     INFO: 41600 events read in total (3525ms).

[13:51:14.298] <TB3>     INFO: Test took 4596ms.

[13:51:14.301] <TB3>     INFO: scanning low vcal = 120

[13:51:14.656] <TB3>     INFO: Expecting 41600 events.

[13:51:18.889] <TB3>     INFO: 41600 events read in total (3517ms).

[13:51:18.889] <TB3>     INFO: Test took 4588ms.

[13:51:18.892] <TB3>     INFO: scanning low vcal = 130

[13:51:19.216] <TB3>     INFO: Expecting 41600 events.

[13:51:23.468] <TB3>     INFO: 41600 events read in total (3535ms).

[13:51:23.468] <TB3>     INFO: Test took 4576ms.

[13:51:23.472] <TB3>     INFO: scanning low vcal = 140

[13:51:23.803] <TB3>     INFO: Expecting 41600 events.

[13:51:28.109] <TB3>     INFO: 41600 events read in total (3590ms).

[13:51:28.109] <TB3>     INFO: Test took 4637ms.

[13:51:28.112] <TB3>     INFO: scanning low vcal = 150

[13:51:28.465] <TB3>     INFO: Expecting 41600 events.

[13:51:32.690] <TB3>     INFO: 41600 events read in total (3508ms).

[13:51:32.690] <TB3>     INFO: Test took 4578ms.

[13:51:32.693] <TB3>     INFO: scanning low vcal = 160

[13:51:33.049] <TB3>     INFO: Expecting 41600 events.

[13:51:37.278] <TB3>     INFO: 41600 events read in total (3512ms).

[13:51:37.278] <TB3>     INFO: Test took 4585ms.

[13:51:37.281] <TB3>     INFO: scanning low vcal = 170

[13:51:37.634] <TB3>     INFO: Expecting 41600 events.

[13:51:41.834] <TB3>     INFO: 41600 events read in total (3483ms).

[13:51:41.834] <TB3>     INFO: Test took 4553ms.

[13:51:41.838] <TB3>     INFO: scanning low vcal = 180

[13:51:42.186] <TB3>     INFO: Expecting 41600 events.

[13:51:46.418] <TB3>     INFO: 41600 events read in total (3516ms).

[13:51:46.418] <TB3>     INFO: Test took 4580ms.

[13:51:46.421] <TB3>     INFO: scanning low vcal = 190

[13:51:46.777] <TB3>     INFO: Expecting 41600 events.

[13:51:51.017] <TB3>     INFO: 41600 events read in total (3524ms).

[13:51:51.017] <TB3>     INFO: Test took 4596ms.

[13:51:51.020] <TB3>     INFO: scanning low vcal = 200

[13:51:51.374] <TB3>     INFO: Expecting 41600 events.

[13:51:55.657] <TB3>     INFO: 41600 events read in total (3567ms).

[13:51:55.658] <TB3>     INFO: Test took 4638ms.

[13:51:55.661] <TB3>     INFO: scanning low vcal = 210

[13:51:56.016] <TB3>     INFO: Expecting 41600 events.

[13:52:00.196] <TB3>     INFO: 41600 events read in total (3463ms).

[13:52:00.196] <TB3>     INFO: Test took 4535ms.

[13:52:00.199] <TB3>     INFO: scanning low vcal = 220

[13:52:00.550] <TB3>     INFO: Expecting 41600 events.

[13:52:04.724] <TB3>     INFO: 41600 events read in total (3457ms).

[13:52:04.725] <TB3>     INFO: Test took 4526ms.

[13:52:04.727] <TB3>     INFO: scanning low vcal = 230

[13:52:05.078] <TB3>     INFO: Expecting 41600 events.

[13:52:09.237] <TB3>     INFO: 41600 events read in total (3442ms).

[13:52:09.238] <TB3>     INFO: Test took 4511ms.

[13:52:09.241] <TB3>     INFO: scanning low vcal = 240

[13:52:09.593] <TB3>     INFO: Expecting 41600 events.

[13:52:13.819] <TB3>     INFO: 41600 events read in total (3509ms).

[13:52:13.819] <TB3>     INFO: Test took 4578ms.

[13:52:13.822] <TB3>     INFO: scanning low vcal = 250

[13:52:14.178] <TB3>     INFO: Expecting 41600 events.

[13:52:18.430] <TB3>     INFO: 41600 events read in total (3536ms).

[13:52:18.430] <TB3>     INFO: Test took 4608ms.

[13:52:18.435] <TB3>     INFO: scanning high vcal = 30 (= 210 in low range)

[13:52:18.783] <TB3>     INFO: Expecting 41600 events.

[13:52:22.970] <TB3>     INFO: 41600 events read in total (3471ms).

[13:52:22.971] <TB3>     INFO: Test took 4536ms.

[13:52:22.974] <TB3>     INFO: scanning high vcal = 50 (= 350 in low range)

[13:52:23.322] <TB3>     INFO: Expecting 41600 events.

[13:52:27.567] <TB3>     INFO: 41600 events read in total (3528ms).

[13:52:27.568] <TB3>     INFO: Test took 4594ms.

[13:52:27.570] <TB3>     INFO: scanning high vcal = 70 (= 490 in low range)

[13:52:27.924] <TB3>     INFO: Expecting 41600 events.

[13:52:32.160] <TB3>     INFO: 41600 events read in total (3519ms).

[13:52:32.161] <TB3>     INFO: Test took 4591ms.

[13:52:32.164] <TB3>     INFO: scanning high vcal = 90 (= 630 in low range)

[13:52:32.491] <TB3>     INFO: Expecting 41600 events.

[13:52:36.787] <TB3>     INFO: 41600 events read in total (3580ms).

[13:52:36.787] <TB3>     INFO: Test took 4623ms.

[13:52:36.790] <TB3>     INFO: scanning high vcal = 200 (= 1400 in low range)

[13:52:37.144] <TB3>     INFO: Expecting 41600 events.

[13:52:41.318] <TB3>     INFO: 41600 events read in total (3458ms).

[13:52:41.319] <TB3>     INFO: Test took 4529ms.

[13:52:41.750] <TB3>     INFO: PixTestGainPedestal::measure() done 

[13:53:13.048] <TB3>     INFO: PixTestGainPedestal::fit() done

[13:53:13.048] <TB3>     INFO: non-linearity mean:  0.962 0.958 0.944 0.956 0.956 0.960 0.959 0.957 0.949 0.951 0.955 0.947 0.958 0.954 0.957 0.962

[13:53:13.048] <TB3>     INFO: non-linearity RMS:   0.006 0.005 0.006 0.006 0.006 0.007 0.005 0.006 0.006 0.007 0.004 0.007 0.006 0.005 0.008 0.005

[13:53:13.048] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat

[13:53:13.066] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat

[13:53:13.084] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat

[13:53:13.101] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat

[13:53:13.118] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat

[13:53:13.136] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat

[13:53:13.154] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat

[13:53:13.171] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat

[13:53:13.188] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat

[13:53:13.205] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat

[13:53:13.222] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat

[13:53:13.239] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat

[13:53:13.256] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat

[13:53:13.273] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat

[13:53:13.290] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat

[13:53:13.308] <TB3>     INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat

[13:53:13.325] <TB3>     INFO: PixTestGainPedestal::doTest() done, duration: 168 seconds

[13:53:13.331] <TB3>     INFO: readReadbackCal: /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C15.dat

[13:53:13.332] <TB3>     INFO: PixTestReadback::doTest() start.

[13:53:13.333] <TB3>     INFO: PixTestReadback::RES sent once 

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C0.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C1.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C2.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C3.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C4.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C5.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C6.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C7.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C8.dat

[13:53:35.117] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C9.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C10.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C11.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C12.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C13.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C14.dat

[13:53:35.118] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C15.dat

[13:53:35.149] <TB3>     INFO: PixTestPattern::       pg_setup set to default.

[13:53:35.149] <TB3>     INFO: PixTestReadback::RES sent once 

[13:53:56.885] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C0.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C1.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C2.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C3.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C4.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C5.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C6.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C7.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C8.dat

[13:53:56.886] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C9.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C10.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C11.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C12.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C13.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C14.dat

[13:53:56.887] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C15.dat

[13:53:56.921] <TB3>     INFO: PixTestPattern::       pg_setup set to default.

[13:53:56.921] <TB3>     INFO: PixTestReadback::RES sent once 

[13:54:13.798] <TB3>     INFO: PixTestPattern::       pg_setup set to default.

[13:54:13.798] <TB3>     INFO: Vbg will be calibrated using Vd calibration

[13:54:13.798] <TB3>     INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 145calibrated Vbg = 1.19022 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 154.2calibrated Vbg = 1.19205 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 148calibrated Vbg = 1.19738 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 255calibrated Vbg = 1.1775 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 150.8calibrated Vbg = 1.20183 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 158.4calibrated Vbg = 1.20763 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 151.9calibrated Vbg = 1.20695 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 255calibrated Vbg = 1.1775 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 144calibrated Vbg = 1.20224 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 151.4calibrated Vbg = 1.20109 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 156calibrated Vbg = 1.20516 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 255calibrated Vbg = 1.1775 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 154calibrated Vbg = 1.19448 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 148.1calibrated Vbg = 1.19543 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 151calibrated Vbg = 1.18862 :::*/*/*/*/

[13:54:13.799] <TB3>     INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 255calibrated Vbg = 1.1775 :::*/*/*/*/

[13:54:13.802] <TB3>     INFO: PixTestReadback::RES sent once 

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C0.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C1.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C2.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C3.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C4.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C5.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C6.dat

[13:58:54.257] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C7.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C8.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C9.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C10.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C11.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C12.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C13.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C14.dat

[13:58:54.258] <TB3>     INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2068_FullQualification_2015-09-03_10h31m_1441269084//002_FulltestPxar_m20//readbackCal_C15.dat

[13:58:54.290] <TB3>     INFO: PixTestPattern::       pg_setup set to default.

[13:58:54.291] <TB3>     INFO: PixTestReadback::doTest() done

[13:58:54.310] <TB3>     INFO: enter test to run

[13:58:54.310] <TB3>     INFO:   test: exit no parameter change

[13:58:54.920] <TB3>    QUIET: Connection to board 170 closed.

[13:58:55.000] <TB3>     INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master