[15:13:26.216] <TB2> INFO: *** Welcome to pxar ***
[15:13:26.216] <TB2> INFO: *** Today: 2015/08/28
[15:13:26.216] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C15.dat
[15:13:26.218] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//tbmParameters_C0b.dat
[15:13:26.219] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//defaultMaskFile.dat
[15:13:26.219] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters_C15.dat
[15:13:26.302] <TB2> INFO: clk: 4
[15:13:26.302] <TB2> INFO: ctr: 4
[15:13:26.302] <TB2> INFO: sda: 19
[15:13:26.302] <TB2> INFO: tin: 9
[15:13:26.302] <TB2> INFO: level: 15
[15:13:26.302] <TB2> INFO: triggerdelay: 0
[15:13:26.302] <TB2> QUIET: Instanciating API for pxar v2.5+57~g44d0777
[15:13:26.302] <TB2> INFO: Log level: INFO
[15:13:26.309] <TB2> INFO: Found DTB DTB_WXC55Z
[15:13:26.321] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[15:13:26.324] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[15:13:26.326] <TB2> INFO: RPC call hashes of host and DTB match: 397073690
[15:13:27.852] <TB2> INFO: DUT info:
[15:13:27.852] <TB2> INFO: The DUT currently contains the following objects:
[15:13:27.852] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:13:27.852] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:13:27.852] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:13:27.852] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:13:27.852] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.852] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:27.853] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:13:28.254] <TB2> INFO: enter 'restricted' command line mode
[15:13:28.254] <TB2> INFO: enter test to run
[15:13:28.254] <TB2> INFO: test: pretest no parameter change
[15:13:28.254] <TB2> INFO: running: pretest
[15:13:28.260] <TB2> INFO: ######################################################################
[15:13:28.260] <TB2> INFO: PixTestPretest::doTest()
[15:13:28.260] <TB2> INFO: ######################################################################
[15:13:28.261] <TB2> INFO: ----------------------------------------------------------------------
[15:13:28.261] <TB2> INFO: PixTestPretest::programROC()
[15:13:28.261] <TB2> INFO: ----------------------------------------------------------------------
[15:13:46.279] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[15:13:46.279] <TB2> INFO: IA differences per ROC: 20.1 19.3 20.9 16.9 17.7 16.9 18.5 18.5 20.1 18.5 18.5 19.3 18.5 17.7 18.5 20.1
[15:13:46.356] <TB2> INFO: ----------------------------------------------------------------------
[15:13:46.356] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[15:13:46.357] <TB2> INFO: ----------------------------------------------------------------------
[15:14:05.932] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 366.6 mA = 22.9125 mA/ROC
[15:14:05.933] <TB2> INFO: ----------------------------------------------------------------------
[15:14:05.933] <TB2> INFO: PixTestPretest::findTiming()
[15:14:05.933] <TB2> INFO: ----------------------------------------------------------------------
[15:14:05.933] <TB2> INFO: PixTestCmd::init()

[15:15:49.561] <TB2> INFO: TBM phases: 160MHz: 0, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[15:15:49.561] <TB2> INFO: (success/tries = 100/100), width = 3
[15:15:49.563] <TB2> INFO: ----------------------------------------------------------------------
[15:15:49.563] <TB2> INFO: PixTestPretest::findWorkingPixel()
[15:15:49.563] <TB2> INFO: ----------------------------------------------------------------------
[15:15:49.699] <TB2> INFO: Expecting 231680 events.
[15:15:58.706] <TB2> INFO: 231680 events read in total (8290ms).
[15:15:58.710] <TB2> INFO: Test took 9144ms.
[15:15:59.021] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[15:15:59.058] <TB2> INFO: ----------------------------------------------------------------------
[15:15:59.058] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[15:15:59.058] <TB2> INFO: ----------------------------------------------------------------------
[15:15:59.195] <TB2> INFO: Expecting 231680 events.
[15:16:08.646] <TB2> INFO: 231680 events read in total (8735ms).
[15:16:08.650] <TB2> INFO: Test took 9587ms.
[15:16:08.982] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[15:16:08.982] <TB2> INFO: CalDel: 123 127 126 129 127 145 136 143 144 168 148 160 128 140 161 142
[15:16:08.982] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[15:16:08.985] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C0.dat
[15:16:08.985] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C1.dat
[15:16:08.986] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C2.dat
[15:16:08.986] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C3.dat
[15:16:08.986] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C4.dat
[15:16:08.986] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C5.dat
[15:16:08.987] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C6.dat
[15:16:08.987] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C7.dat
[15:16:08.987] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C8.dat
[15:16:08.987] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C9.dat
[15:16:08.987] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C10.dat
[15:16:08.988] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C11.dat
[15:16:08.988] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C12.dat
[15:16:08.988] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C13.dat
[15:16:08.988] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C14.dat
[15:16:08.988] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters_C15.dat
[15:16:08.989] <TB2> INFO: write tbm parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//tbmParameters_C0a.dat
[15:16:08.989] <TB2> INFO: write tbm parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//tbmParameters_C0b.dat
[15:16:08.989] <TB2> INFO: PixTestPretest::doTest() done, duration: 160 seconds
[15:16:09.070] <TB2> INFO: enter test to run
[15:16:09.070] <TB2> INFO: test: fulltest no parameter change
[15:16:09.070] <TB2> INFO: running: fulltest
[15:16:09.070] <TB2> INFO: ######################################################################
[15:16:09.070] <TB2> INFO: PixTestFullTest::doTest()
[15:16:09.070] <TB2> INFO: ######################################################################
[15:16:09.072] <TB2> INFO: ######################################################################
[15:16:09.072] <TB2> INFO: PixTestAlive::doTest()
[15:16:09.072] <TB2> INFO: ######################################################################
[15:16:09.073] <TB2> INFO: ----------------------------------------------------------------------
[15:16:09.073] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:16:09.073] <TB2> INFO: ----------------------------------------------------------------------
[15:16:09.416] <TB2> INFO: Expecting 41600 events.
[15:16:14.045] <TB2> INFO: 41600 events read in total (3912ms).
[15:16:14.045] <TB2> INFO: Test took 4970ms.
[15:16:14.052] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:14.342] <TB2> INFO: PixTestAlive::aliveTest() done
[15:16:14.342] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 1 2 1 0 0 0 0 1 0 0 0 0 0
[15:16:14.344] <TB2> INFO: ----------------------------------------------------------------------
[15:16:14.344] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:16:14.344] <TB2> INFO: ----------------------------------------------------------------------
[15:16:14.655] <TB2> INFO: Expecting 41600 events.
[15:16:17.817] <TB2> INFO: 41600 events read in total (2446ms).
[15:16:17.817] <TB2> INFO: Test took 3471ms.
[15:16:17.817] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:17.818] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:16:18.135] <TB2> INFO: PixTestAlive::maskTest() done
[15:16:18.135] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:16:18.137] <TB2> INFO: ----------------------------------------------------------------------
[15:16:18.137] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:16:18.137] <TB2> INFO: ----------------------------------------------------------------------
[15:16:18.486] <TB2> INFO: Expecting 41600 events.
[15:16:23.265] <TB2> INFO: 41600 events read in total (4063ms).
[15:16:23.266] <TB2> INFO: Test took 5127ms.
[15:16:23.272] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:23.561] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[15:16:23.561] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:16:23.561] <TB2> INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:16:23.576] <TB2> INFO: ######################################################################
[15:16:23.576] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[15:16:23.576] <TB2> INFO: ######################################################################
[15:16:23.580] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 2 (plus default)
[15:16:23.593] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[15:16:23.593] <TB2> INFO: run 1 of 1
[15:16:23.908] <TB2> INFO: Expecting 3120000 events.
[15:17:00.164] <TB2> INFO: 872035 events read in total (35539ms).
[15:17:36.221] <TB2> INFO: 1734390 events read in total (71596ms).
[15:18:12.507] <TB2> INFO: 2612605 events read in total (107882ms).
[15:18:33.835] <TB2> INFO: 3120000 events read in total (129210ms).
[15:18:33.884] <TB2> INFO: Test took 130291ms.
[15:18:33.981] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:57.810] <TB2> INFO: PixTestBBMap::doTest() done, duration: 154 seconds
[15:18:57.810] <TB2> INFO: number of dead bumps (per ROC): 1 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[15:18:57.810] <TB2> INFO: separation cut (per ROC): 85 76 89 86 72 92 84 91 85 65 84 66 77 80 65 73
[15:18:57.881] <TB2> INFO: ######################################################################
[15:18:57.881] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:18:57.881] <TB2> INFO: ######################################################################
[15:18:57.882] <TB2> INFO: ----------------------------------------------------------------------
[15:18:57.882] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:18:57.882] <TB2> INFO: ----------------------------------------------------------------------
[15:18:57.882] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 0 .. 149 (-1/-1) hits flags = 16 (plus default)
[15:18:57.890] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[15:18:57.890] <TB2> INFO: run 1 of 1
[15:18:58.196] <TB2> INFO: Expecting 31200000 events.




[15:19:20.666] <TB2> INFO: 947850 events read in total (21754ms).
[15:19:44.977] <TB2> INFO: 1882950 events read in total (46065ms).
[15:20:11.435] <TB2> INFO: 2812100 events read in total (72523ms).








[15:20:38.146] <TB2> INFO: 3747050 events read in total (99234ms).







[15:21:04.319] <TB2> INFO: 4671950 events read in total (125407ms).
[15:21:30.804] <TB2> INFO: 5600100 events read in total (151892ms).
[15:21:56.604] <TB2> INFO: 6525500 events read in total (177693ms).













[15:22:23.591] <TB2> INFO: 7454850 events read in total (204679ms).





[15:22:50.226] <TB2> INFO: 8383450 events read in total (231314ms).




[15:23:16.917] <TB2> INFO: 9307300 events read in total (258005ms).
[15:23:43.365] <TB2> INFO: 10232100 events read in total (284453ms).




[15:24:09.336] <TB2> INFO: 11156650 events read in total (310424ms).










[15:24:32.396] <TB2> INFO: 12080050 events read in total (333484ms).
[15:24:56.139] <TB2> INFO: 13001600 events read in total (357227ms).







[15:25:20.052] <TB2> INFO: 13923550 events read in total (381140ms).


[15:25:45.073] <TB2> INFO: 14842450 events read in total (406161ms).





[15:26:11.752] <TB2> INFO: 15763600 events read in total (432840ms).










[15:26:38.022] <TB2> INFO: 16676300 events read in total (459110ms).








[15:27:04.398] <TB2> INFO: 17588250 events read in total (485486ms).
[15:27:30.460] <TB2> INFO: 18499600 events read in total (511548ms).
















[15:27:56.315] <TB2> INFO: 19409750 events read in total (537403ms).
[15:28:21.987] <TB2> INFO: 20320050 events read in total (563075ms).


[15:28:47.855] <TB2> INFO: 21229800 events read in total (588943ms).







[15:29:13.773] <TB2> INFO: 22138500 events read in total (614861ms).










[15:29:40.167] <TB2> INFO: 23047750 events read in total (641255ms).
[15:30:06.550] <TB2> INFO: 23957600 events read in total (667638ms).
[15:30:32.651] <TB2> INFO: 24864650 events read in total (693739ms).















[15:30:59.105] <TB2> INFO: 25773100 events read in total (720193ms).









[15:31:25.182] <TB2> INFO: 26677400 events read in total (746270ms).


[15:31:51.425] <TB2> INFO: 27587500 events read in total (772513ms).
[15:32:17.737] <TB2> INFO: 28495550 events read in total (798825ms).
[15:32:44.312] <TB2> INFO: 29405700 events read in total (825400ms).
[15:33:09.517] <TB2> INFO: 30314850 events read in total (850605ms).







[15:33:36.215] <TB2> INFO: 31200000 events read in total (877303ms).
[15:33:36.248] <TB2> INFO: Test took 878358ms.
[15:33:36.335] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:36.446] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:38.036] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:39.628] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:41.115] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:42.558] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:44.043] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:45.450] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:46.896] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:48.336] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:49.779] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:51.263] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:52.727] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:54.293] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:55.789] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:57.365] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:33:58.985] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:34:00.546] <TB2> INFO: PixTestScurves::scurves() done
[15:34:00.546] <TB2> INFO: Vcal mean: 91.23 91.23 93.42 92.96 80.37 102.96 85.47 96.39 94.01 84.56 99.32 81.43 86.99 85.02 78.00 80.23
[15:34:00.546] <TB2> INFO: Vcal RMS: 6.24 6.06 5.17 5.90 5.75 5.84 5.48 6.11 5.61 5.46 5.54 4.56 5.74 5.44 4.93 4.85
[15:34:00.546] <TB2> INFO: PixTestScurves::fullTest() done, duration: 902 seconds
[15:34:00.622] <TB2> INFO: ######################################################################
[15:34:00.622] <TB2> INFO: PixTestTrim::doTest()
[15:34:00.622] <TB2> INFO: ######################################################################
[15:34:00.623] <TB2> INFO: ----------------------------------------------------------------------
[15:34:00.623] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[15:34:00.623] <TB2> INFO: ----------------------------------------------------------------------
[15:34:00.707] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[15:34:00.707] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 20 dacrange: 0 .. 159 (-1/-1) hits flags = 16 (plus default)
[15:34:00.716] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[15:34:00.716] <TB2> INFO: run 1 of 1
[15:34:01.031] <TB2> INFO: Expecting 13312000 events.















[15:34:32.726] <TB2> INFO: 1114200 events read in total (30977ms).







[15:35:04.036] <TB2> INFO: 2224460 events read in total (62287ms).



















[15:35:34.799] <TB2> INFO: 3331920 events read in total (93050ms).





[15:36:05.297] <TB2> INFO: 4434780 events read in total (123548ms).




















[15:36:36.469] <TB2> INFO: 5534920 events read in total (154720ms).







[15:37:07.603] <TB2> INFO: 6631920 events read in total (185854ms).


[15:37:38.591] <TB2> INFO: 7734300 events read in total (216842ms).











[15:38:09.730] <TB2> INFO: 8841940 events read in total (247981ms).




























[15:38:41.136] <TB2> INFO: 9951700 events read in total (279387ms).





[15:39:10.667] <TB2> INFO: 11061320 events read in total (308918ms).





















[15:39:42.130] <TB2> INFO: 12174940 events read in total (340381ms).















[15:40:13.319] <TB2> INFO: 13292660 events read in total (371570ms).
[15:40:14.421] <TB2> INFO: 13312000 events read in total (372672ms).
[15:40:14.455] <TB2> INFO: Test took 373739ms.
[15:40:14.501] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:32.370] <TB2> INFO: ROC 0 VthrComp = 90
[15:40:32.371] <TB2> INFO: ROC 1 VthrComp = 88
[15:40:32.371] <TB2> INFO: ROC 2 VthrComp = 97
[15:40:32.371] <TB2> INFO: ROC 3 VthrComp = 91
[15:40:32.371] <TB2> INFO: ROC 4 VthrComp = 79
[15:40:32.371] <TB2> INFO: ROC 5 VthrComp = 101
[15:40:32.371] <TB2> INFO: ROC 6 VthrComp = 87
[15:40:32.371] <TB2> INFO: ROC 7 VthrComp = 93
[15:40:32.371] <TB2> INFO: ROC 8 VthrComp = 92
[15:40:32.371] <TB2> INFO: ROC 9 VthrComp = 81
[15:40:32.371] <TB2> INFO: ROC 10 VthrComp = 96
[15:40:32.372] <TB2> INFO: ROC 11 VthrComp = 80
[15:40:32.372] <TB2> INFO: ROC 12 VthrComp = 88
[15:40:32.372] <TB2> INFO: ROC 13 VthrComp = 82
[15:40:32.372] <TB2> INFO: ROC 14 VthrComp = 74
[15:40:32.372] <TB2> INFO: ROC 15 VthrComp = 81
[15:40:32.372] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[15:40:32.372] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 20 dacrange: 0 .. 159 (-1/-1) hits flags = 16 (plus default)
[15:40:32.380] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[15:40:32.380] <TB2> INFO: run 1 of 1
[15:40:32.689] <TB2> INFO: Expecting 13312000 events.
[15:40:59.850] <TB2> INFO: 785140 events read in total (26445ms).






[15:41:27.288] <TB2> INFO: 785140 events read in total (53883ms).





[15:41:54.500] <TB2> INFO: 1565420 events read in total (81095ms).




[15:42:21.714] <TB2> INFO: 2346440 events read in total (108309ms).
[15:42:48.952] <TB2> INFO: 3126520 events read in total (135547ms).










[15:43:16.678] <TB2> INFO: 3906980 events read in total (163273ms).
[15:43:44.425] <TB2> INFO: 4687140 events read in total (191020ms).
[15:44:11.764] <TB2> INFO: 5467240 events read in total (218359ms).
[15:44:38.944] <TB2> INFO: 6243540 events read in total (245539ms).








[15:45:06.453] <TB2> INFO: 7015960 events read in total (273048ms).







[15:45:33.628] <TB2> INFO: 7786500 events read in total (300223ms).












[15:46:01.818] <TB2> INFO: 8556240 events read in total (328413ms).
[15:46:28.931] <TB2> INFO: 9323920 events read in total (355526ms).
[15:46:55.560] <TB2> INFO: 10091140 events read in total (382155ms).
[15:47:23.115] <TB2> INFO: 10857040 events read in total (409710ms).
















[15:47:50.438] <TB2> INFO: 11623840 events read in total (437033ms).



[15:48:17.978] <TB2> INFO: 12391840 events read in total (464573ms).
[15:48:23.547] <TB2> INFO: 12530880 events read in total (470142ms).

[15:48:23.890] <TB2> INFO: Expecting 13312000 events.
[15:48:47.785] <TB2> INFO: 785120 events read in total (23179ms).


[15:49:14.880] <TB2> INFO: 1566280 events read in total (50274ms).




[15:49:42.113] <TB2> INFO: 2346580 events read in total (77507ms).
















[15:50:09.873] <TB2> INFO: 3127580 events read in total (105267ms).
[15:50:37.872] <TB2> INFO: 3907640 events read in total (133266ms).
[15:51:05.691] <TB2> INFO: 4688360 events read in total (161085ms).











[15:51:34.616] <TB2> INFO: 5468360 events read in total (190010ms).













[15:52:03.173] <TB2> INFO: 6248420 events read in total (218568ms).
[15:52:31.329] <TB2> INFO: 7024760 events read in total (246723ms).
[15:52:59.821] <TB2> INFO: 7797140 events read in total (275215ms).




[15:53:27.167] <TB2> INFO: 8567720 events read in total (302561ms).


[15:53:54.624] <TB2> INFO: 9337460 events read in total (330018ms).
[15:54:19.531] <TB2> INFO: 10105180 events read in total (354925ms).






[15:54:44.427] <TB2> INFO: 10872460 events read in total (379821ms).















[15:55:09.136] <TB2> INFO: 11638380 events read in total (404530ms).





[15:55:32.745] <TB2> INFO: 12405160 events read in total (428139ms).
[15:55:58.664] <TB2> INFO: 13173160 events read in total (454058ms).
[15:56:04.115] <TB2> INFO: 13312000 events read in total (459509ms).
[15:56:04.155] <TB2> INFO: Test took 460591ms.
[15:56:04.291] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:27.838] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 61.5275 for pixel 3/32 mean/min/max = 47.2617/32.6754/61.8479
[15:56:27.838] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 63.4072 for pixel 15/2 mean/min/max = 48.2285/32.9762/63.4808
[15:56:27.838] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 56.6419 for pixel 1/54 mean/min/max = 44.1867/31.6691/56.7042
[15:56:27.839] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 60.0922 for pixel 19/78 mean/min/max = 46.3894/32.6654/60.1135
[15:56:27.839] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 62.5486 for pixel 12/75 mean/min/max = 48.2186/33.8093/62.6279
[15:56:27.839] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 59.4302 for pixel 5/78 mean/min/max = 45.8309/32.1071/59.5546
[15:56:27.840] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 58.0411 for pixel 17/73 mean/min/max = 45.1857/32.2863/58.0851
[15:56:27.840] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 62.0082 for pixel 0/52 mean/min/max = 47.2349/32.4596/62.0102
[15:56:27.840] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 60.211 for pixel 11/79 mean/min/max = 46.5235/32.7822/60.2648
[15:56:27.840] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 62.5287 for pixel 25/6 mean/min/max = 47.3976/32.1443/62.6509
[15:56:27.841] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 59.9962 for pixel 21/8 mean/min/max = 46.6161/33.2195/60.0126
[15:56:27.841] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 59.7528 for pixel 8/62 mean/min/max = 46.3955/32.9942/59.7968
[15:56:27.841] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 60.6284 for pixel 17/73 mean/min/max = 46.944/33.2284/60.6597
[15:56:27.841] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.9644 for pixel 25/66 mean/min/max = 45.7327/32.3745/59.0909
[15:56:27.842] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 64.8411 for pixel 10/0 mean/min/max = 49.8326/34.7484/64.9169
[15:56:27.842] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 58.4355 for pixel 9/1 mean/min/max = 45.5474/32.2912/58.8036
[15:56:27.842] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:56:27.974] <TB2> INFO: Expecting 1029120 events.


















[15:56:52.857] <TB2> INFO: 1029120 events read in total (24167ms).
[15:56:52.862] <TB2> INFO: Expecting 1029120 events.




[15:57:18.542] <TB2> INFO: 1029120 events read in total (25131ms).
[15:57:18.548] <TB2> INFO: Expecting 1029120 events.





[15:57:44.786] <TB2> INFO: 1029120 events read in total (25696ms).
[15:57:44.794] <TB2> INFO: Expecting 1029120 events.
[15:58:10.781] <TB2> INFO: 1029120 events read in total (25443ms).
[15:58:10.793] <TB2> INFO: Expecting 1029120 events.

















[15:58:36.055] <TB2> INFO: 1029120 events read in total (24727ms).
[15:58:36.067] <TB2> INFO: Expecting 1029120 events.



















[15:59:02.244] <TB2> INFO: 1029120 events read in total (25637ms).
[15:59:02.260] <TB2> INFO: Expecting 1029120 events.

[15:59:27.773] <TB2> INFO: 1029120 events read in total (24985ms).
[15:59:27.789] <TB2> INFO: Expecting 1029120 events.

































[15:59:52.546] <TB2> INFO: 1029120 events read in total (24212ms).
[15:59:52.564] <TB2> INFO: Expecting 1029120 events.


[16:00:17.448] <TB2> INFO: 0 events read in total (24343ms).


[16:00:17.457] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:00:17.626] <TB2> INFO: Expecting 1029120 events.
[16:00:43.039] <TB2> INFO: 1029120 events read in total (24697ms).
[16:00:43.044] <TB2> INFO: Expecting 1029120 events.
[16:01:09.591] <TB2> INFO: 1029120 events read in total (26006ms).
[16:01:09.597] <TB2> INFO: Expecting 1029120 events.
[16:01:32.817] <TB2> INFO: 1029120 events read in total (22671ms).
[16:01:32.828] <TB2> INFO: Expecting 1029120 events.
[16:01:56.200] <TB2> INFO: 1029120 events read in total (22844ms).
[16:01:56.210] <TB2> INFO: Expecting 1029120 events.









[16:02:22.168] <TB2> INFO: 1029120 events read in total (25422ms).
[16:02:22.180] <TB2> INFO: Expecting 1029120 events.
[16:02:47.510] <TB2> INFO: 1029120 events read in total (24790ms).
[16:02:47.525] <TB2> INFO: Expecting 1029120 events.
[16:03:12.910] <TB2> INFO: 1029120 events read in total (24854ms).
[16:03:12.926] <TB2> INFO: Expecting 1029120 events.
[16:03:38.745] <TB2> INFO: 1029120 events read in total (25276ms).
[16:03:38.765] <TB2> INFO: Expecting 1029120 events.
[16:04:05.236] <TB2> INFO: 1029120 events read in total (25931ms).
[16:04:05.256] <TB2> INFO: Expecting 1029120 events.
[16:04:31.656] <TB2> INFO: 1029120 events read in total (25865ms).
[16:04:31.679] <TB2> INFO: Expecting 1029120 events.
[16:04:58.333] <TB2> INFO: 1029120 events read in total (26127ms).
[16:04:58.355] <TB2> INFO: Expecting 1029120 events.









[16:05:24.906] <TB2> INFO: 1029120 events read in total (26016ms).
[16:05:24.933] <TB2> INFO: Expecting 1029120 events.








[16:05:51.808] <TB2> INFO: 1029120 events read in total (26343ms).
[16:05:51.835] <TB2> INFO: Expecting 1029120 events.
[16:06:18.659] <TB2> INFO: 1029120 events read in total (26297ms).
[16:06:18.686] <TB2> INFO: Expecting 1029120 events.
[16:06:46.061] <TB2> INFO: 1029120 events read in total (26842ms).
[16:06:46.091] <TB2> INFO: Expecting 1029120 events.
[16:07:13.392] <TB2> INFO: 1029120 events read in total (26773ms).
[16:07:13.427] <TB2> INFO: Test took 415970ms.
[16:07:14.416] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 199 (-1/-1) hits flags = 16 (plus default)
[16:07:14.425] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:07:14.425] <TB2> INFO: run 1 of 1
[16:07:14.741] <TB2> INFO: Expecting 8320000 events.
[16:07:45.091] <TB2> INFO: 723750 events read in total (29634ms).
[16:08:13.640] <TB2> INFO: 1446140 events read in total (58183ms).




[16:08:43.052] <TB2> INFO: 1446140 events read in total (87595ms).






[16:09:12.499] <TB2> INFO: 2168520 events read in total (117042ms).
[16:09:41.362] <TB2> INFO: 2890320 events read in total (145905ms).








[16:10:11.524] <TB2> INFO: 3611230 events read in total (176067ms).
[16:10:41.040] <TB2> INFO: 4327530 events read in total (205583ms).
[16:11:10.699] <TB2> INFO: 5042370 events read in total (235242ms).
[16:11:41.153] <TB2> INFO: 5755090 events read in total (265696ms).






[16:12:10.861] <TB2> INFO: 6466840 events read in total (295404ms).


[16:12:40.217] <TB2> INFO: 6466840 events read in total (324760ms).
[16:12:58.220] <TB2> INFO: 6886070 events read in total (342763ms).

[16:12:58.556] <TB2> INFO: Expecting 8320000 events.
[16:13:26.747] <TB2> INFO: 723830 events read in total (27475ms).


[16:13:56.037] <TB2> INFO: 1446150 events read in total (56765ms).








[16:14:25.079] <TB2> INFO: 2168460 events read in total (85807ms).




[16:14:54.241] <TB2> INFO: 2890820 events read in total (114969ms).




[16:15:18.984] <TB2> INFO: 3612610 events read in total (139712ms).
[16:15:44.291] <TB2> INFO: 4333570 events read in total (165019ms).
[16:16:13.425] <TB2> INFO: 5049810 events read in total (194153ms).
[16:16:42.369] <TB2> INFO: 5764590 events read in total (223097ms).
[16:17:11.371] <TB2> INFO: 6477300 events read in total (252099ms).





[16:17:40.585] <TB2> INFO: 7189070 events read in total (281313ms).
[16:18:07.680] <TB2> INFO: 7900770 events read in total (308408ms).
[16:18:24.174] <TB2> INFO: 8320000 events read in total (324902ms).
[16:18:24.237] <TB2> INFO: Test took 325989ms.
[16:18:24.452] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:18:49.670] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.034027 .. 255.000000
[16:18:49.747] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 20 dacrange: 0 .. 255 (-1/-1) hits flags = 16 (plus default)
[16:18:49.756] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[16:18:49.756] <TB2> INFO: run 1 of 1
[16:18:50.072] <TB2> INFO: Expecting 21299200 events.




[16:19:15.740] <TB2> INFO: 712260 events read in total (24951ms).
[16:19:38.315] <TB2> INFO: 1424400 events read in total (47526ms).















[16:20:06.470] <TB2> INFO: 2136800 events read in total (75681ms).
[16:20:33.624] <TB2> INFO: 2849580 events read in total (102835ms).



















[16:21:01.255] <TB2> INFO: 3562660 events read in total (130466ms).










[16:21:28.320] <TB2> INFO: 4275440 events read in total (157531ms).
[16:21:54.801] <TB2> INFO: 4988120 events read in total (184012ms).
[16:22:21.576] <TB2> INFO: 5700840 events read in total (210787ms).
[16:22:48.138] <TB2> INFO: 6413820 events read in total (237349ms).
[16:23:10.888] <TB2> INFO: 7126560 events read in total (260099ms).


[16:23:36.785] <TB2> INFO: 7839340 events read in total (285996ms).



[16:24:03.123] <TB2> INFO: 8552440 events read in total (312335ms).


[16:24:27.145] <TB2> INFO: 9265320 events read in total (336356ms).






[16:24:53.026] <TB2> INFO: 9978080 events read in total (362237ms).






[16:25:17.853] <TB2> INFO: 10690900 events read in total (387064ms).
[16:25:42.625] <TB2> INFO: 11403980 events read in total (411836ms).
[16:26:06.535] <TB2> INFO: 12116600 events read in total (435746ms).








[16:26:31.973] <TB2> INFO: 12829340 events read in total (461184ms).
[16:26:57.507] <TB2> INFO: 13541340 events read in total (486718ms).
[16:27:22.863] <TB2> INFO: 14253340 events read in total (512074ms).
[16:27:47.145] <TB2> INFO: 14965640 events read in total (536356ms).
[16:28:11.249] <TB2> INFO: 15677200 events read in total (560460ms).
[16:28:36.643] <TB2> INFO: 16388460 events read in total (585854ms).





[16:29:05.094] <TB2> INFO: 17099540 events read in total (614305ms).










[16:29:32.366] <TB2> INFO: 17810900 events read in total (641577ms).
[16:29:58.059] <TB2> INFO: 18521880 events read in total (667270ms).
[16:30:23.516] <TB2> INFO: 19232800 events read in total (692727ms).


[16:30:49.455] <TB2> INFO: 19943460 events read in total (718666ms).
[16:31:16.707] <TB2> INFO: 20654600 events read in total (745918ms).
[16:31:42.047] <TB2> INFO: 21299200 events read in total (771258ms).
[16:31:42.152] <TB2> INFO: Test took 772396ms.
[16:31:42.413] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:12.171] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 14.320275 .. 46.044440
[16:32:12.247] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 20 dacrange: 4 .. 56 (-1/-1) hits flags = 16 (plus default)
[16:32:12.255] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[16:32:12.255] <TB2> INFO: run 1 of 1
[16:32:12.559] <TB2> INFO: Expecting 4409600 events.






[16:32:37.945] <TB2> INFO: 936080 events read in total (24669ms).









[16:33:07.603] <TB2> INFO: 1871880 events read in total (54327ms).
[16:33:36.208] <TB2> INFO: 2806840 events read in total (82932ms).


[16:34:04.428] <TB2> INFO: 3740360 events read in total (111152ms).
[16:34:24.694] <TB2> INFO: 4409600 events read in total (131418ms).
[16:34:24.707] <TB2> INFO: Test took 132452ms.
[16:34:24.739] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:38.497] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 1.500000 .. 43.238993
[16:34:38.572] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 20 dacrange: 1 .. 53 (-1/-1) hits flags = 16 (plus default)
[16:34:38.580] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[16:34:38.580] <TB2> INFO: run 1 of 1
[16:34:38.896] <TB2> INFO: Expecting 4409600 events.
[16:35:08.740] <TB2> INFO: 976400 events read in total (29128ms).
[16:35:37.435] <TB2> INFO: 1953040 events read in total (57823ms).


[16:36:02.623] <TB2> INFO: 2928800 events read in total (83011ms).
[16:36:30.269] <TB2> INFO: 3904240 events read in total (110657ms).
[16:36:43.533] <TB2> INFO: 4409600 events read in total (123921ms).
[16:36:43.548] <TB2> INFO: Test took 124969ms.
[16:36:43.585] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:57.273] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 3.500000 .. 43.238993
[16:36:57.349] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 20 dacrange: 3 .. 53 (-1/-1) hits flags = 16 (plus default)
[16:36:57.357] <TB2> INFO: dacScan split into 1 runs with ntrig = 20
[16:36:57.357] <TB2> INFO: run 1 of 1
[16:36:57.662] <TB2> INFO: Expecting 4243200 events.
[16:37:27.499] <TB2> INFO: 966620 events read in total (29121ms).
[16:37:57.070] <TB2> INFO: 1933480 events read in total (58692ms).
[16:38:27.186] <TB2> INFO: 2899920 events read in total (88808ms).









[16:38:56.779] <TB2> INFO: 3866520 events read in total (118401ms).
[16:39:07.738] <TB2> INFO: 4243200 events read in total (129360ms).
[16:39:07.754] <TB2> INFO: Test took 130398ms.
[16:39:07.790] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:21.114] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[16:39:21.114] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 16 (plus default)
[16:39:21.123] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:39:21.123] <TB2> INFO: run 1 of 1
[16:39:21.463] <TB2> INFO: Expecting 1705600 events.
[16:39:52.635] <TB2> INFO: 877070 events read in total (30456ms).
[16:40:20.503] <TB2> INFO: 1705600 events read in total (58324ms).
[16:40:20.515] <TB2> INFO: Test took 59392ms.
[16:40:20.546] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:33.657] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C0.dat
[16:40:33.662] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C1.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C2.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C3.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C4.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C5.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C6.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C7.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C8.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C9.dat
[16:40:33.663] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C10.dat
[16:40:33.664] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C11.dat
[16:40:33.672] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C12.dat
[16:40:33.672] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C13.dat
[16:40:33.672] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C14.dat
[16:40:33.672] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C15.dat
[16:40:33.672] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C0.dat
[16:40:33.680] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C1.dat
[16:40:33.687] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C2.dat
[16:40:33.696] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C3.dat
[16:40:33.703] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C4.dat
[16:40:33.709] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C5.dat
[16:40:33.715] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C6.dat
[16:40:33.721] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C7.dat
[16:40:33.728] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C8.dat
[16:40:33.734] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C9.dat
[16:40:33.740] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C10.dat
[16:40:33.747] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C11.dat
[16:40:33.753] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C12.dat
[16:40:33.759] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C13.dat
[16:40:33.765] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C14.dat
[16:40:33.772] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//trimParameters35_C15.dat
[16:40:33.778] <TB2> INFO: PixTestTrim::trimTest() done
[16:40:33.778] <TB2> INFO: vtrim: 100 100 92 111 102 103 85 96 95 102 92 80 103 85 107 94
[16:40:33.778] <TB2> INFO: vthrcomp: 90 88 97 91 79 101 87 93 92 81 96 80 88 82 74 81
[16:40:33.778] <TB2> INFO: vcal mean: 34.91 34.88 34.89 34.90 34.89 34.88 34.88 34.91 34.86 34.85 34.91 34.95 34.89 34.89 34.87 34.89
[16:40:33.778] <TB2> INFO: vcal RMS: 1.07 0.88 0.79 0.98 1.12 0.97 1.11 0.84 0.81 0.99 0.98 0.80 1.00 0.99 0.98 0.81
[16:40:33.778] <TB2> INFO: bits mean: 8.59 8.94 9.86 9.44 8.81 9.29 9.51 8.60 8.96 9.22 8.86 9.06 8.79 9.31 8.71 9.47
[16:40:33.778] <TB2> INFO: bits RMS: 2.92 2.60 2.71 2.60 2.59 2.76 2.71 2.90 2.74 2.68 2.74 2.68 2.73 2.74 2.42 2.70
[16:40:33.784] <TB2> INFO: ----------------------------------------------------------------------
[16:40:33.784] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 10, vtrims = 254 126 63 32
[16:40:33.784] <TB2> INFO: ----------------------------------------------------------------------
[16:40:33.787] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 10 dacrange: 0 .. 199 (-1/-1) hits flags = 16 (plus default)
[16:40:33.795] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:40:33.795] <TB2> INFO: run 1 of 1
[16:40:34.111] <TB2> INFO: Expecting 8320000 events.
[16:41:04.613] <TB2> INFO: 935270 events read in total (29786ms).




[16:41:37.040] <TB2> INFO: 1861660 events read in total (62213ms).
[16:42:08.907] <TB2> INFO: 2785970 events read in total (94080ms).





[16:42:40.564] <TB2> INFO: 3707210 events read in total (125737ms).
[16:43:12.276] <TB2> INFO: 4622340 events read in total (157449ms).
[16:43:43.493] <TB2> INFO: 5533880 events read in total (188666ms).
[16:44:12.078] <TB2> INFO: 6445540 events read in total (217251ms).
[16:44:42.240] <TB2> INFO: 7355870 events read in total (247413ms).







[16:45:12.434] <TB2> INFO: 8271740 events read in total (277607ms).
[16:45:14.567] <TB2> INFO: 8320000 events read in total (279740ms).
[16:45:14.599] <TB2> INFO: Test took 280805ms.
[16:45:14.707] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:40.838] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 10 dacrange: 0 .. 170 (-1/-1) hits flags = 16 (plus default)
[16:45:40.847] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:45:40.847] <TB2> INFO: run 1 of 1
[16:45:41.164] <TB2> INFO: Expecting 7113600 events.
[16:46:12.620] <TB2> INFO: 960560 events read in total (30740ms).
[16:46:43.332] <TB2> INFO: 1912120 events read in total (61452ms).
[16:47:13.799] <TB2> INFO: 2858760 events read in total (91919ms).


[16:47:44.894] <TB2> INFO: 3799400 events read in total (123014ms).
[16:48:13.497] <TB2> INFO: 4732780 events read in total (151617ms).
[16:48:43.869] <TB2> INFO: 5665150 events read in total (181989ms).
[16:49:14.242] <TB2> INFO: 6597660 events read in total (212362ms).
[16:49:31.444] <TB2> INFO: 7113600 events read in total (229564ms).
[16:49:31.479] <TB2> INFO: Test took 230632ms.
[16:49:31.571] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:58.456] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 10 dacrange: 0 .. 157 (-1/-1) hits flags = 16 (plus default)
[16:49:58.465] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:49:58.465] <TB2> INFO: run 1 of 1
[16:49:58.784] <TB2> INFO: Expecting 6572800 events.
[16:50:30.583] <TB2> INFO: 996310 events read in total (31083ms).
[16:51:01.464] <TB2> INFO: 1982410 events read in total (61964ms).
[16:51:32.146] <TB2> INFO: 2961930 events read in total (92646ms).
[16:52:03.346] <TB2> INFO: 3932210 events read in total (123846ms).





[16:52:34.077] <TB2> INFO: 4896470 events read in total (154577ms).








[16:53:01.986] <TB2> INFO: 5861100 events read in total (182486ms).
[16:53:23.474] <TB2> INFO: 6572800 events read in total (203974ms).
[16:53:23.508] <TB2> INFO: Test took 205043ms.
[16:53:23.578] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:47.178] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 10 dacrange: 0 .. 156 (-1/-1) hits flags = 16 (plus default)
[16:53:47.186] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:53:47.186] <TB2> INFO: run 1 of 1
[16:53:47.488] <TB2> INFO: Expecting 6531200 events.
[16:54:19.183] <TB2> INFO: 999220 events read in total (30979ms).
[16:54:49.035] <TB2> INFO: 1987690 events read in total (60831ms).




[16:55:18.637] <TB2> INFO: 2970020 events read in total (90433ms).
[16:55:50.546] <TB2> INFO: 3942160 events read in total (122342ms).
[16:56:22.878] <TB2> INFO: 4909840 events read in total (154674ms).

[16:56:54.602] <TB2> INFO: 5876110 events read in total (186398ms).
[16:57:16.061] <TB2> INFO: 6531200 events read in total (207857ms).
[16:57:16.089] <TB2> INFO: Test took 208903ms.
[16:57:16.153] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:57:38.028] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 10 dacrange: 0 .. 154 (-1/-1) hits flags = 16 (plus default)
[16:57:38.036] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:57:38.036] <TB2> INFO: run 1 of 1
[16:57:38.365] <TB2> INFO: Expecting 6448000 events.
[16:58:12.706] <TB2> INFO: 1005150 events read in total (33625ms).



[16:58:45.928] <TB2> INFO: 1999550 events read in total (66847ms).

[16:59:18.638] <TB2> INFO: 2986750 events read in total (99557ms).
[16:59:51.484] <TB2> INFO: 3963130 events read in total (132403ms).
[17:00:23.018] <TB2> INFO: 4935410 events read in total (163937ms).
[17:00:56.688] <TB2> INFO: 5907010 events read in total (197607ms).
[17:01:15.446] <TB2> INFO: 6448000 events read in total (216365ms).
[17:01:15.481] <TB2> INFO: Test took 217444ms.
[17:01:15.547] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:36.476] <TB2> INFO: PixTestTrim::trimBitTest() done
[17:01:36.477] <TB2> INFO: PixTestTrim::doTest() done, duration: 5255 seconds
[17:01:37.145] <TB2> INFO: ######################################################################
[17:01:37.145] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[17:01:37.145] <TB2> INFO: ######################################################################
[17:01:37.463] <TB2> INFO: Expecting 41600 events.
[17:01:42.228] <TB2> INFO: 41600 events read in total (4049ms).
[17:01:42.229] <TB2> INFO: Test took 5083ms.
[17:01:42.234] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:42.823] <TB2> INFO: Expecting 41600 events.
[17:01:47.560] <TB2> INFO: 41600 events read in total (4021ms).
[17:01:47.560] <TB2> INFO: Test took 5060ms.
[17:01:47.566] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:47.896] <TB2> INFO: Expecting 41600 events.
[17:01:52.386] <TB2> INFO: 41600 events read in total (3773ms).
[17:01:52.387] <TB2> INFO: Test took 4811ms.
[17:01:52.392] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:52.399] <TB2> INFO: The DUT currently contains the following objects:
[17:01:52.399] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:52.399] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:52.399] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:52.399] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:52.399] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.399] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:52.746] <TB2> INFO: Expecting 2560 events.
[17:01:53.813] <TB2> INFO: 2560 events read in total (351ms).
[17:01:53.813] <TB2> INFO: Test took 1414ms.
[17:01:53.814] <TB2> INFO: The DUT currently contains the following objects:
[17:01:53.814] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:53.814] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:53.814] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:53.814] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:53.814] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.814] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:53.815] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:54.228] <TB2> INFO: Expecting 2560 events.
[17:01:55.296] <TB2> INFO: 2560 events read in total (352ms).
[17:01:55.296] <TB2> INFO: Test took 1481ms.
[17:01:55.296] <TB2> INFO: The DUT currently contains the following objects:
[17:01:55.296] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:55.296] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:55.296] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:55.296] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:55.296] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.296] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.297] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:55.711] <TB2> INFO: Expecting 2560 events.
[17:01:56.777] <TB2> INFO: 2560 events read in total (350ms).
[17:01:56.777] <TB2> INFO: Test took 1480ms.
[17:01:56.778] <TB2> INFO: The DUT currently contains the following objects:
[17:01:56.778] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:56.778] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:56.778] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:56.778] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:56.778] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:56.778] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:57.192] <TB2> INFO: Expecting 2560 events.
[17:01:58.287] <TB2> INFO: 2560 events read in total (379ms).
[17:01:58.288] <TB2> INFO: Test took 1510ms.
[17:01:58.288] <TB2> INFO: The DUT currently contains the following objects:
[17:01:58.288] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:58.288] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:58.288] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:58.288] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:58.288] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.288] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.289] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:58.704] <TB2> INFO: Expecting 2560 events.
[17:01:59.770] <TB2> INFO: 2560 events read in total (350ms).
[17:01:59.770] <TB2> INFO: Test took 1481ms.
[17:01:59.771] <TB2> INFO: The DUT currently contains the following objects:
[17:01:59.771] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:01:59.771] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:01:59.771] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:01:59.771] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:01:59.771] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.771] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:01:59.772] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:00.185] <TB2> INFO: Expecting 2560 events.
[17:02:01.254] <TB2> INFO: 2560 events read in total (352ms).
[17:02:01.254] <TB2> INFO: Test took 1482ms.
[17:02:01.254] <TB2> INFO: The DUT currently contains the following objects:
[17:02:01.254] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:01.254] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:01.254] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:01.254] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:01.254] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.254] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.255] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:01.668] <TB2> INFO: Expecting 2560 events.
[17:02:02.738] <TB2> INFO: 2560 events read in total (353ms).
[17:02:02.738] <TB2> INFO: Test took 1483ms.
[17:02:02.738] <TB2> INFO: The DUT currently contains the following objects:
[17:02:02.738] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:02.738] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:02.738] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:02.738] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:02.739] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:02.739] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:03.153] <TB2> INFO: Expecting 2560 events.
[17:02:04.248] <TB2> INFO: 2560 events read in total (379ms).
[17:02:04.249] <TB2> INFO: Test took 1510ms.
[17:02:04.249] <TB2> INFO: The DUT currently contains the following objects:
[17:02:04.249] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:04.249] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:04.249] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:04.249] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:04.249] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.249] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.250] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.250] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.250] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.250] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.250] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:04.663] <TB2> INFO: Expecting 2560 events.
[17:02:05.750] <TB2> INFO: 2560 events read in total (370ms).
[17:02:05.750] <TB2> INFO: Test took 1500ms.
[17:02:05.751] <TB2> INFO: The DUT currently contains the following objects:
[17:02:05.751] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:05.751] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:05.751] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:05.751] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:05.751] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.751] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.752] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.752] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.752] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:05.752] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:06.164] <TB2> INFO: Expecting 2560 events.
[17:02:07.231] <TB2> INFO: 2560 events read in total (351ms).
[17:02:07.231] <TB2> INFO: Test took 1479ms.
[17:02:07.232] <TB2> INFO: The DUT currently contains the following objects:
[17:02:07.232] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:07.232] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:07.232] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:07.232] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:07.232] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.232] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:07.646] <TB2> INFO: Expecting 2560 events.
[17:02:08.726] <TB2> INFO: 2560 events read in total (364ms).
[17:02:08.727] <TB2> INFO: Test took 1495ms.
[17:02:08.727] <TB2> INFO: The DUT currently contains the following objects:
[17:02:08.727] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:08.727] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:08.727] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:08.727] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:08.728] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:08.728] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:09.142] <TB2> INFO: Expecting 2560 events.
[17:02:10.208] <TB2> INFO: 2560 events read in total (350ms).
[17:02:10.208] <TB2> INFO: Test took 1480ms.
[17:02:10.209] <TB2> INFO: The DUT currently contains the following objects:
[17:02:10.209] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:10.209] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:10.209] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:10.209] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:10.209] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.209] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.210] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.210] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.210] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:10.624] <TB2> INFO: Expecting 2560 events.
[17:02:11.696] <TB2> INFO: 2560 events read in total (356ms).
[17:02:11.697] <TB2> INFO: Test took 1487ms.
[17:02:11.699] <TB2> INFO: The DUT currently contains the following objects:
[17:02:11.699] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:11.699] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:11.699] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:11.699] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:11.699] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.699] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:11.700] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:12.111] <TB2> INFO: Expecting 2560 events.
[17:02:13.173] <TB2> INFO: 2560 events read in total (346ms).
[17:02:13.173] <TB2> INFO: Test took 1473ms.
[17:02:13.173] <TB2> INFO: The DUT currently contains the following objects:
[17:02:13.174] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:13.174] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:13.174] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:13.174] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:13.174] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.174] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:13.588] <TB2> INFO: Expecting 2560 events.
[17:02:14.674] <TB2> INFO: 2560 events read in total (370ms).
[17:02:14.675] <TB2> INFO: Test took 1501ms.
[17:02:14.675] <TB2> INFO: The DUT currently contains the following objects:
[17:02:14.675] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:02:14.675] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:02:14.675] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:02:14.675] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[17:02:14.675] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.675] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:14.676] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[17:02:15.089] <TB2> INFO: Expecting 2560 events.
[17:02:16.161] <TB2> INFO: 2560 events read in total (355ms).
[17:02:16.162] <TB2> INFO: Test took 1486ms.
[17:02:16.165] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:02:16.578] <TB2> INFO: Expecting 655360 events.





[17:02:34.049] <TB2> INFO: 655360 events read in total (16754ms).
[17:02:34.059] <TB2> INFO: Expecting 655360 events.
[17:02:51.530] <TB2> INFO: 655360 events read in total (16943ms).
[17:02:51.542] <TB2> INFO: Expecting 655360 events.





































[17:03:08.983] <TB2> INFO: 655360 events read in total (16913ms).
[17:03:08.999] <TB2> INFO: Expecting 655360 events.
[17:03:25.950] <TB2> INFO: 655360 events read in total (16423ms).
[17:03:25.969] <TB2> INFO: Expecting 655360 events.
[17:03:43.009] <TB2> INFO: 655360 events read in total (16512ms).
[17:03:43.033] <TB2> INFO: Expecting 655360 events.





[17:04:00.405] <TB2> INFO: 655360 events read in total (16844ms).
[17:04:00.433] <TB2> INFO: Expecting 655360 events.



































[17:04:18.053] <TB2> INFO: 655360 events read in total (17092ms).
[17:04:18.081] <TB2> INFO: Expecting 655360 events.










[17:04:35.398] <TB2> INFO: 655360 events read in total (16789ms).
[17:04:35.429] <TB2> INFO: Expecting 655360 events.



[17:04:53.105] <TB2> INFO: 655360 events read in total (17148ms).
[17:04:53.143] <TB2> INFO: Expecting 655360 events.
[17:05:10.669] <TB2> INFO: 655360 events read in total (16999ms).
[17:05:10.707] <TB2> INFO: Expecting 655360 events.
[17:05:28.405] <TB2> INFO: 655360 events read in total (17171ms).
[17:05:28.447] <TB2> INFO: Expecting 655360 events.
[17:05:43.959] <TB2> INFO: 655360 events read in total (14985ms).
[17:05:44.008] <TB2> INFO: Expecting 655360 events.
[17:05:59.547] <TB2> INFO: 655360 events read in total (15012ms).
[17:05:59.594] <TB2> INFO: Expecting 655360 events.
[17:06:16.386] <TB2> INFO: 655360 events read in total (16265ms).
[17:06:16.439] <TB2> INFO: Expecting 655360 events.
[17:06:33.736] <TB2> INFO: 655360 events read in total (16770ms).
[17:06:33.792] <TB2> INFO: Expecting 655360 events.
[17:06:50.486] <TB2> INFO: 655360 events read in total (16167ms).
[17:06:50.544] <TB2> INFO: Test took 274379ms.
[17:06:50.622] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:06:50.933] <TB2> INFO: Expecting 655360 events.
[17:07:07.840] <TB2> INFO: 655360 events read in total (16191ms).
[17:07:07.848] <TB2> INFO: Expecting 655360 events.
[17:07:25.011] <TB2> INFO: 655360 events read in total (16635ms).
[17:07:25.023] <TB2> INFO: Expecting 655360 events.


[17:07:41.914] <TB2> INFO: 655360 events read in total (16363ms).
[17:07:41.929] <TB2> INFO: Expecting 655360 events.




[17:07:58.703] <TB2> INFO: 655360 events read in total (16247ms).
[17:07:58.721] <TB2> INFO: Expecting 655360 events.
[17:08:15.625] <TB2> INFO: 655360 events read in total (16376ms).
[17:08:15.648] <TB2> INFO: Expecting 655360 events.
[17:08:32.585] <TB2> INFO: 655360 events read in total (16410ms).
[17:08:32.610] <TB2> INFO: Expecting 655360 events.
[17:08:48.980] <TB2> INFO: 655360 events read in total (15842ms).
[17:08:49.010] <TB2> INFO: Expecting 655360 events.







[17:09:05.536] <TB2> INFO: 655360 events read in total (15999ms).
[17:09:05.569] <TB2> INFO: Expecting 655360 events.








[17:09:21.987] <TB2> INFO: 655360 events read in total (15890ms).
[17:09:22.038] <TB2> INFO: Expecting 655360 events.
[17:09:37.844] <TB2> INFO: 655360 events read in total (15278ms).
[17:09:37.882] <TB2> INFO: Expecting 655360 events.
[17:09:52.705] <TB2> INFO: 655360 events read in total (14296ms).
[17:09:52.746] <TB2> INFO: Expecting 655360 events.
[17:10:07.775] <TB2> INFO: 655360 events read in total (14502ms).
[17:10:07.819] <TB2> INFO: Expecting 655360 events.
[17:10:22.792] <TB2> INFO: 655360 events read in total (14445ms).
[17:10:22.839] <TB2> INFO: Expecting 655360 events.
[17:10:37.781] <TB2> INFO: 655360 events read in total (14414ms).
[17:10:37.836] <TB2> INFO: Expecting 655360 events.















[17:10:53.136] <TB2> INFO: 655360 events read in total (14772ms).
[17:10:53.190] <TB2> INFO: Expecting 655360 events.
















[17:11:08.337] <TB2> INFO: 655360 events read in total (14619ms).
[17:11:08.393] <TB2> INFO: Test took 257771ms.
[17:11:08.576] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.583] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.589] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.596] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.602] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.608] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.615] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.621] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.628] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.634] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.641] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.647] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.653] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.660] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.666] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[17:11:08.673] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[17:11:08.679] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[17:11:08.686] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.692] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:11:08.699] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[17:11:08.705] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[17:11:08.712] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[17:11:08.718] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C0.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C1.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C2.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C3.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C4.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C5.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C6.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C7.dat
[17:11:08.754] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C8.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C9.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C10.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C11.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C12.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C13.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C14.dat
[17:11:08.755] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//dacParameters35_C15.dat
[17:11:09.056] <TB2> INFO: Expecting 41600 events.
[17:11:13.367] <TB2> INFO: 41600 events read in total (3595ms).
[17:11:13.368] <TB2> INFO: Test took 4610ms.
[17:11:13.909] <TB2> INFO: Expecting 41600 events.
[17:11:18.194] <TB2> INFO: 41600 events read in total (3569ms).
[17:11:18.194] <TB2> INFO: Test took 4582ms.
[17:11:18.735] <TB2> INFO: Expecting 41600 events.
[17:11:23.056] <TB2> INFO: 41600 events read in total (3605ms).
[17:11:23.056] <TB2> INFO: Test took 4618ms.
[17:11:23.299] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:23.431] <TB2> INFO: Expecting 2560 events.
[17:11:24.492] <TB2> INFO: 2560 events read in total (345ms).
[17:11:24.492] <TB2> INFO: Test took 1193ms.
[17:11:24.494] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:24.908] <TB2> INFO: Expecting 2560 events.
[17:11:25.969] <TB2> INFO: 2560 events read in total (345ms).
[17:11:25.969] <TB2> INFO: Test took 1475ms.
[17:11:25.971] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:26.385] <TB2> INFO: Expecting 2560 events.
[17:11:27.446] <TB2> INFO: 2560 events read in total (345ms).
[17:11:27.446] <TB2> INFO: Test took 1475ms.
[17:11:27.448] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:27.862] <TB2> INFO: Expecting 2560 events.
[17:11:28.938] <TB2> INFO: 2560 events read in total (360ms).
[17:11:28.938] <TB2> INFO: Test took 1490ms.
[17:11:28.940] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:29.354] <TB2> INFO: Expecting 2560 events.
[17:11:30.415] <TB2> INFO: 2560 events read in total (345ms).
[17:11:30.415] <TB2> INFO: Test took 1475ms.
[17:11:30.417] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:30.831] <TB2> INFO: Expecting 2560 events.
[17:11:31.892] <TB2> INFO: 2560 events read in total (345ms).
[17:11:31.892] <TB2> INFO: Test took 1475ms.
[17:11:31.894] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:32.308] <TB2> INFO: Expecting 2560 events.
[17:11:33.369] <TB2> INFO: 2560 events read in total (345ms).
[17:11:33.369] <TB2> INFO: Test took 1475ms.
[17:11:33.371] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:33.785] <TB2> INFO: Expecting 2560 events.

[17:11:34.846] <TB2> INFO: 2560 events read in total (345ms).
[17:11:34.847] <TB2> INFO: Test took 1476ms.
[17:11:34.848] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:35.262] <TB2> INFO: Expecting 2560 events.
[17:11:36.323] <TB2> INFO: 2560 events read in total (345ms).
[17:11:36.324] <TB2> INFO: Test took 1476ms.
[17:11:36.325] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:36.739] <TB2> INFO: Expecting 2560 events.
[17:11:37.800] <TB2> INFO: 2560 events read in total (345ms).
[17:11:37.801] <TB2> INFO: Test took 1476ms.
[17:11:37.802] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:38.216] <TB2> INFO: Expecting 2560 events.
[17:11:39.278] <TB2> INFO: 2560 events read in total (345ms).
[17:11:39.278] <TB2> INFO: Test took 1476ms.
[17:11:39.280] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:39.693] <TB2> INFO: Expecting 2560 events.
[17:11:40.755] <TB2> INFO: 2560 events read in total (345ms).
[17:11:40.755] <TB2> INFO: Test took 1476ms.
[17:11:40.757] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:41.171] <TB2> INFO: Expecting 2560 events.
[17:11:42.232] <TB2> INFO: 2560 events read in total (345ms).
[17:11:42.232] <TB2> INFO: Test took 1475ms.
[17:11:42.234] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:42.647] <TB2> INFO: Expecting 2560 events.
[17:11:43.709] <TB2> INFO: 2560 events read in total (345ms).
[17:11:43.709] <TB2> INFO: Test took 1475ms.
[17:11:43.711] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:44.125] <TB2> INFO: Expecting 2560 events.
[17:11:45.186] <TB2> INFO: 2560 events read in total (345ms).
[17:11:45.186] <TB2> INFO: Test took 1475ms.
[17:11:45.188] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:45.602] <TB2> INFO: Expecting 2560 events.
[17:11:46.663] <TB2> INFO: 2560 events read in total (345ms).
[17:11:46.663] <TB2> INFO: Test took 1475ms.
[17:11:46.665] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:47.079] <TB2> INFO: Expecting 2560 events.
[17:11:48.140] <TB2> INFO: 2560 events read in total (345ms).
[17:11:48.140] <TB2> INFO: Test took 1475ms.
[17:11:48.142] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:48.556] <TB2> INFO: Expecting 2560 events.
[17:11:49.617] <TB2> INFO: 2560 events read in total (345ms).
[17:11:49.617] <TB2> INFO: Test took 1475ms.
[17:11:49.619] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:50.033] <TB2> INFO: Expecting 2560 events.
[17:11:51.108] <TB2> INFO: 2560 events read in total (359ms).
[17:11:51.108] <TB2> INFO: Test took 1489ms.
[17:11:51.110] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:51.524] <TB2> INFO: Expecting 2560 events.
[17:11:52.585] <TB2> INFO: 2560 events read in total (345ms).
[17:11:52.585] <TB2> INFO: Test took 1475ms.
[17:11:52.587] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:53.001] <TB2> INFO: Expecting 2560 events.
[17:11:54.062] <TB2> INFO: 2560 events read in total (345ms).
[17:11:54.062] <TB2> INFO: Test took 1475ms.
[17:11:54.064] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:54.478] <TB2> INFO: Expecting 2560 events.
[17:11:55.539] <TB2> INFO: 2560 events read in total (345ms).
[17:11:55.539] <TB2> INFO: Test took 1475ms.
[17:11:55.541] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:55.955] <TB2> INFO: Expecting 2560 events.
[17:11:57.016] <TB2> INFO: 2560 events read in total (345ms).
[17:11:57.016] <TB2> INFO: Test took 1475ms.
[17:11:57.018] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:57.432] <TB2> INFO: Expecting 2560 events.
[17:11:58.493] <TB2> INFO: 2560 events read in total (345ms).
[17:11:58.493] <TB2> INFO: Test took 1475ms.
[17:11:58.495] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:11:58.909] <TB2> INFO: Expecting 2560 events.
[17:11:59.970] <TB2> INFO: 2560 events read in total (345ms).
[17:11:59.970] <TB2> INFO: Test took 1475ms.
[17:11:59.972] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:00.386] <TB2> INFO: Expecting 2560 events.
[17:12:01.447] <TB2> INFO: 2560 events read in total (345ms).
[17:12:01.448] <TB2> INFO: Test took 1476ms.
[17:12:01.449] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:01.863] <TB2> INFO: Expecting 2560 events.
[17:12:02.924] <TB2> INFO: 2560 events read in total (345ms).
[17:12:02.925] <TB2> INFO: Test took 1476ms.
[17:12:02.926] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:03.340] <TB2> INFO: Expecting 2560 events.
[17:12:04.401] <TB2> INFO: 2560 events read in total (345ms).
[17:12:04.402] <TB2> INFO: Test took 1476ms.
[17:12:04.403] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:04.817] <TB2> INFO: Expecting 2560 events.
[17:12:05.878] <TB2> INFO: 2560 events read in total (345ms).
[17:12:05.878] <TB2> INFO: Test took 1475ms.
[17:12:05.880] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:06.294] <TB2> INFO: Expecting 2560 events.
[17:12:07.355] <TB2> INFO: 2560 events read in total (345ms).
[17:12:07.355] <TB2> INFO: Test took 1475ms.
[17:12:07.357] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:07.771] <TB2> INFO: Expecting 2560 events.
[17:12:08.833] <TB2> INFO: 2560 events read in total (346ms).
[17:12:08.833] <TB2> INFO: Test took 1476ms.
[17:12:08.835] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:12:09.249] <TB2> INFO: Expecting 2560 events.
[17:12:10.311] <TB2> INFO: 2560 events read in total (346ms).
[17:12:10.311] <TB2> INFO: Test took 1476ms.
[17:12:10.918] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 633 seconds
[17:12:10.918] <TB2> INFO: PH scale (per ROC): 64 63 79 75 78 77 78 75 74 73 68 66 77 75 66 74
[17:12:10.918] <TB2> INFO: PH offset (per ROC): 181 194 166 169 176 182 161 173 174 181 178 184 177 176 171 176
[17:12:11.080] <TB2> INFO: ######################################################################
[17:12:11.080] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[17:12:11.080] <TB2> INFO: ######################################################################
[17:12:11.090] <TB2> INFO: scanning low vcal = 10
[17:12:11.386] <TB2> INFO: Expecting 41600 events.
[17:12:14.937] <TB2> INFO: 41600 events read in total (2834ms).
[17:12:14.938] <TB2> INFO: Test took 3848ms.
[17:12:14.939] <TB2> INFO: scanning low vcal = 20
[17:12:15.353] <TB2> INFO: Expecting 41600 events.
[17:12:18.877] <TB2> INFO: 41600 events read in total (2807ms).
[17:12:18.877] <TB2> INFO: Test took 3938ms.
[17:12:18.878] <TB2> INFO: scanning low vcal = 30
[17:12:19.292] <TB2> INFO: Expecting 41600 events.
[17:12:22.843] <TB2> INFO: 41600 events read in total (2834ms).
[17:12:22.844] <TB2> INFO: Test took 3966ms.
[17:12:22.846] <TB2> INFO: scanning low vcal = 40
[17:12:23.254] <TB2> INFO: Expecting 41600 events.
[17:12:27.288] <TB2> INFO: 41600 events read in total (3318ms).
[17:12:27.289] <TB2> INFO: Test took 4443ms.
[17:12:27.291] <TB2> INFO: scanning low vcal = 50
[17:12:27.650] <TB2> INFO: Expecting 41600 events.
[17:12:31.652] <TB2> INFO: 41600 events read in total (3286ms).
[17:12:31.652] <TB2> INFO: Test took 4361ms.
[17:12:31.655] <TB2> INFO: scanning low vcal = 60
[17:12:32.015] <TB2> INFO: Expecting 41600 events.
[17:12:36.029] <TB2> INFO: 41600 events read in total (3297ms).
[17:12:36.029] <TB2> INFO: Test took 4374ms.
[17:12:36.032] <TB2> INFO: scanning low vcal = 70
[17:12:36.393] <TB2> INFO: Expecting 41600 events.
[17:12:40.400] <TB2> INFO: 41600 events read in total (3291ms).
[17:12:40.400] <TB2> INFO: Test took 4368ms.
[17:12:40.403] <TB2> INFO: scanning low vcal = 80
[17:12:40.763] <TB2> INFO: Expecting 41600 events.
[17:12:44.771] <TB2> INFO: 41600 events read in total (3292ms).
[17:12:44.771] <TB2> INFO: Test took 4368ms.
[17:12:44.774] <TB2> INFO: scanning low vcal = 90
[17:12:45.134] <TB2> INFO: Expecting 41600 events.
[17:12:49.287] <TB2> INFO: 41600 events read in total (3437ms).
[17:12:49.288] <TB2> INFO: Test took 4514ms.
[17:12:49.290] <TB2> INFO: scanning low vcal = 100
[17:12:49.650] <TB2> INFO: Expecting 41600 events.


[17:12:53.696] <TB2> INFO: 41600 events read in total (3330ms).
[17:12:53.697] <TB2> INFO: Test took 4406ms.
[17:12:53.699] <TB2> INFO: scanning low vcal = 110
[17:12:54.059] <TB2> INFO: Expecting 41600 events.










[17:12:58.280] <TB2> INFO: 41600 events read in total (3505ms).
[17:12:58.281] <TB2> INFO: Test took 4582ms.
[17:12:58.284] <TB2> INFO: scanning low vcal = 120
[17:12:58.643] <TB2> INFO: Expecting 41600 events.
[17:13:02.688] <TB2> INFO: 41600 events read in total (3329ms).
[17:13:02.688] <TB2> INFO: Test took 4404ms.
[17:13:02.691] <TB2> INFO: scanning low vcal = 130
[17:13:03.051] <TB2> INFO: Expecting 41600 events.


[17:13:07.086] <TB2> INFO: 41600 events read in total (3319ms).
[17:13:07.087] <TB2> INFO: Test took 4396ms.
[17:13:07.090] <TB2> INFO: scanning low vcal = 140
[17:13:07.448] <TB2> INFO: Expecting 41600 events.
[17:13:11.466] <TB2> INFO: 41600 events read in total (3302ms).
[17:13:11.467] <TB2> INFO: Test took 4377ms.
[17:13:11.470] <TB2> INFO: scanning low vcal = 150
[17:13:11.829] <TB2> INFO: Expecting 41600 events.
[17:13:15.846] <TB2> INFO: 41600 events read in total (3300ms).
[17:13:15.847] <TB2> INFO: Test took 4377ms.
[17:13:15.849] <TB2> INFO: scanning low vcal = 160
[17:13:16.210] <TB2> INFO: Expecting 41600 events.
[17:13:20.213] <TB2> INFO: 41600 events read in total (3287ms).
[17:13:20.213] <TB2> INFO: Test took 4364ms.
[17:13:20.216] <TB2> INFO: scanning low vcal = 170
[17:13:20.575] <TB2> INFO: Expecting 41600 events.
[17:13:24.593] <TB2> INFO: 41600 events read in total (3302ms).
[17:13:24.593] <TB2> INFO: Test took 4377ms.
[17:13:24.597] <TB2> INFO: scanning low vcal = 180
[17:13:24.956] <TB2> INFO: Expecting 41600 events.
[17:13:28.972] <TB2> INFO: 41600 events read in total (3300ms).
[17:13:28.972] <TB2> INFO: Test took 4375ms.
[17:13:28.975] <TB2> INFO: scanning low vcal = 190
[17:13:29.335] <TB2> INFO: Expecting 41600 events.
[17:13:33.397] <TB2> INFO: 41600 events read in total (3346ms).
[17:13:33.397] <TB2> INFO: Test took 4422ms.
[17:13:33.400] <TB2> INFO: scanning low vcal = 200
[17:13:33.760] <TB2> INFO: Expecting 41600 events.
[17:13:37.777] <TB2> INFO: 41600 events read in total (3301ms).
[17:13:37.778] <TB2> INFO: Test took 4378ms.
[17:13:37.780] <TB2> INFO: scanning low vcal = 210
[17:13:38.140] <TB2> INFO: Expecting 41600 events.
[17:13:42.157] <TB2> INFO: 41600 events read in total (3300ms).
[17:13:42.158] <TB2> INFO: Test took 4378ms.
[17:13:42.160] <TB2> INFO: scanning low vcal = 220
[17:13:42.520] <TB2> INFO: Expecting 41600 events.
[17:13:46.567] <TB2> INFO: 41600 events read in total (3331ms).
[17:13:46.567] <TB2> INFO: Test took 4407ms.
[17:13:46.570] <TB2> INFO: scanning low vcal = 230
[17:13:46.930] <TB2> INFO: Expecting 41600 events.
[17:13:50.943] <TB2> INFO: 41600 events read in total (3297ms).
[17:13:50.944] <TB2> INFO: Test took 4374ms.
[17:13:50.946] <TB2> INFO: scanning low vcal = 240
[17:13:51.306] <TB2> INFO: Expecting 41600 events.








[17:13:55.363] <TB2> INFO: 41600 events read in total (3341ms).
[17:13:55.363] <TB2> INFO: Test took 4417ms.
[17:13:55.366] <TB2> INFO: scanning low vcal = 250
[17:13:55.725] <TB2> INFO: Expecting 41600 events.
[17:13:59.738] <TB2> INFO: 41600 events read in total (3297ms).
[17:13:59.738] <TB2> INFO: Test took 4372ms.
[17:13:59.742] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[17:14:00.100] <TB2> INFO: Expecting 41600 events.
[17:14:04.116] <TB2> INFO: 41600 events read in total (3299ms).
[17:14:04.117] <TB2> INFO: Test took 4375ms.
[17:14:04.120] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[17:14:04.479] <TB2> INFO: Expecting 41600 events.
[17:14:08.478] <TB2> INFO: 41600 events read in total (3283ms).
[17:14:08.479] <TB2> INFO: Test took 4359ms.
[17:14:08.481] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[17:14:08.841] <TB2> INFO: Expecting 41600 events.
[17:14:12.875] <TB2> INFO: 41600 events read in total (3318ms).
[17:14:12.876] <TB2> INFO: Test took 4395ms.
[17:14:12.879] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[17:14:13.238] <TB2> INFO: Expecting 41600 events.
[17:14:17.404] <TB2> INFO: 41600 events read in total (3450ms).
[17:14:17.405] <TB2> INFO: Test took 4526ms.
[17:14:17.407] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[17:14:17.766] <TB2> INFO: Expecting 41600 events.
[17:14:21.810] <TB2> INFO: 41600 events read in total (3328ms).
[17:14:21.811] <TB2> INFO: Test took 4404ms.
[17:14:22.217] <TB2> INFO: PixTestGainPedestal::measure() done
[17:14:52.907] <TB2> INFO: PixTestGainPedestal::fit() done
[17:14:52.908] <TB2> INFO: non-linearity mean: 0.950 0.958 0.957 0.958 0.956 0.960 0.956 0.960 0.963 0.958 0.963 0.945 0.955 0.957 0.955 0.959
[17:14:52.908] <TB2> INFO: non-linearity RMS: 0.010 0.008 0.007 0.008 0.007 0.007 0.008 0.006 0.007 0.008 0.006 0.011 0.008 0.006 0.007 0.006
[17:14:52.908] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[17:14:52.925] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[17:14:52.943] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[17:14:52.960] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[17:14:52.977] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[17:14:52.995] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[17:14:53.013] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[17:14:53.031] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[17:14:53.048] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[17:14:53.065] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[17:14:53.083] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[17:14:53.100] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[17:14:53.118] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[17:14:53.135] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[17:14:53.152] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[17:14:53.169] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[17:14:53.187] <TB2> INFO: PixTestGainPedestal::doTest() done, duration: 162 seconds
[17:14:53.193] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C15.dat
[17:14:53.194] <TB2> INFO: PixTestReadback::doTest() start.
[17:14:53.194] <TB2> INFO: PixTestReadback::RES sent once
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C0.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C1.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C2.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C3.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C4.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C5.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C6.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C7.dat
[17:15:04.388] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C8.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C9.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C10.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C11.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C12.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C13.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C14.dat
[17:15:04.389] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C15.dat
[17:15:04.417] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:15:04.417] <TB2> INFO: PixTestReadback::RES sent once
[17:15:15.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C0.dat
[17:15:15.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C1.dat
[17:15:15.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C2.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C3.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C4.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C5.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C6.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C7.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C8.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C9.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C10.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C11.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C12.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C13.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C14.dat
[17:15:15.580] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C15.dat
[17:15:15.609] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:15:15.609] <TB2> INFO: PixTestReadback::RES sent once
[17:15:24.204] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:15:24.204] <TB2> INFO: Vbg will be calibrated using Vd calibration
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 154.9calibrated Vbg = 1.20377 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 159calibrated Vbg = 1.2083 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 142.3calibrated Vbg = 1.20607 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 157.2calibrated Vbg = 1.21727 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 151calibrated Vbg = 1.22364 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 156.6calibrated Vbg = 1.22347 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 153.9calibrated Vbg = 1.23031 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 156.8calibrated Vbg = 1.22486 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 151.6calibrated Vbg = 1.2305 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 159calibrated Vbg = 1.22544 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 151.5calibrated Vbg = 1.2231 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 151.7calibrated Vbg = 1.22213 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 148.7calibrated Vbg = 1.20871 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 153.9calibrated Vbg = 1.20654 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 158.1calibrated Vbg = 1.21358 :::*/*/*/*/
[17:15:24.204] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 155.9calibrated Vbg = 1.21205 :::*/*/*/*/
[17:15:24.206] <TB2> INFO: PixTestReadback::RES sent once
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C0.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C1.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C2.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C3.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C4.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C5.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C6.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C7.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C8.dat
[17:18:18.453] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C9.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C10.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C11.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C12.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C13.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C14.dat
[17:18:18.454] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2090_FullQualification_2015-08-28_10h45m_1440751527//004_FulltestPxar_p17//readbackCal_C15.dat
[17:18:18.481] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:18:18.482] <TB2> INFO: PixTestReadback::doTest() done
[17:18:18.493] <TB2> INFO: enter test to run
[17:18:18.493] <TB2> INFO: test: exit no parameter change
[17:18:19.105] <TB2> QUIET: Connection to board 156 closed.
[17:18:19.185] <TB2> INFO: pXar: this is the end, my friend