[16:59:52.557] <TB2> INFO: *** Welcome to pxar ***
[16:59:52.557] <TB2> INFO: *** Today: 2015/08/04
[16:59:52.557] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C15.dat
[16:59:52.558] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//tbmParameters_C0b.dat
[16:59:52.559] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//defaultMaskFile.dat
[16:59:52.559] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters_C15.dat
[16:59:52.629] <TB2> INFO: clk: 4
[16:59:52.629] <TB2> INFO: ctr: 4
[16:59:52.629] <TB2> INFO: sda: 19
[16:59:52.629] <TB2> INFO: tin: 9
[16:59:52.629] <TB2> INFO: level: 15
[16:59:52.629] <TB2> INFO: triggerdelay: 0
[16:59:52.629] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:59:52.629] <TB2> INFO: Log level: INFO
[16:59:52.647] <TB2> INFO: Found DTB DTB_WXC55Z
[16:59:52.662] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[16:59:52.665] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[16:59:52.668] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:59:54.245] <TB2> INFO: DUT info:
[16:59:54.246] <TB2> INFO: The DUT currently contains the following objects:
[16:59:54.246] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:59:54.246] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:59:54.246] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:59:54.246] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:59:54.246] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.246] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:59:54.647] <TB2> INFO: enter 'restricted' command line mode
[16:59:54.648] <TB2> INFO: enter test to run
[16:59:54.648] <TB2> INFO: test: pretest no parameter change
[16:59:54.648] <TB2> INFO: running: pretest
[16:59:54.654] <TB2> INFO: ######################################################################
[16:59:54.654] <TB2> INFO: PixTestPretest::doTest()
[16:59:54.654] <TB2> INFO: ######################################################################
[16:59:54.656] <TB2> INFO: ----------------------------------------------------------------------
[16:59:54.656] <TB2> INFO: PixTestPretest::programROC()
[16:59:54.656] <TB2> INFO: ----------------------------------------------------------------------
[17:00:12.671] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[17:00:12.671] <TB2> INFO: IA differences per ROC: 18.5 18.5 18.5 18.5 17.7 20.1 19.3 19.3 21.7 19.3 16.9 16.9 18.5 20.1 20.1 18.5
[17:00:12.735] <TB2> INFO: ----------------------------------------------------------------------
[17:00:12.735] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[17:00:12.735] <TB2> INFO: ----------------------------------------------------------------------
[17:00:18.295] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 393.9 mA = 24.6187 mA/ROC
[17:00:18.298] <TB2> INFO: ----------------------------------------------------------------------
[17:00:18.298] <TB2> INFO: PixTestPretest::findWorkingPixel()
[17:00:18.298] <TB2> INFO: ----------------------------------------------------------------------
[17:00:27.009] <TB2> INFO: Test took 8705ms.
[17:00:27.311] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[17:00:27.331] <TB2> INFO: ----------------------------------------------------------------------
[17:00:27.331] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[17:00:27.331] <TB2> INFO: ----------------------------------------------------------------------
[17:00:36.032] <TB2> INFO: Test took 8697ms.
[17:00:36.324] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[17:00:36.324] <TB2> INFO: CalDel: 141 125 132 140 130 126 141 154 147 147 117 125 141 141 128 137
[17:00:36.324] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[17:00:36.328] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C0.dat
[17:00:36.328] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C1.dat
[17:00:36.328] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C2.dat
[17:00:36.329] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C3.dat
[17:00:36.329] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C4.dat
[17:00:36.329] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C5.dat
[17:00:36.329] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C6.dat
[17:00:36.330] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C7.dat
[17:00:36.330] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C8.dat
[17:00:36.330] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C9.dat
[17:00:36.330] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C10.dat
[17:00:36.331] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C11.dat
[17:00:36.331] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C12.dat
[17:00:36.331] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C13.dat
[17:00:36.331] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C14.dat
[17:00:36.332] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters_C15.dat
[17:00:36.332] <TB2> INFO: PixTestPretest::doTest() done, duration: 41 seconds
[17:00:36.443] <TB2> INFO: enter test to run
[17:00:36.443] <TB2> INFO: test: fulltest no parameter change
[17:00:36.443] <TB2> INFO: running: fulltest
[17:00:36.443] <TB2> INFO: ######################################################################
[17:00:36.443] <TB2> INFO: PixTestFullTest::doTest()
[17:00:36.444] <TB2> INFO: ######################################################################
[17:00:36.445] <TB2> INFO: ######################################################################
[17:00:36.445] <TB2> INFO: PixTestAlive::doTest()
[17:00:36.445] <TB2> INFO: ######################################################################
[17:00:36.447] <TB2> INFO: ----------------------------------------------------------------------
[17:00:36.447] <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)
[17:00:36.447] <TB2> INFO: ----------------------------------------------------------------------
[17:00:40.027] <TB2> INFO: Test took 3580ms.
[17:00:40.054] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:00:40.264] <TB2> INFO: PixTestAlive::aliveTest() done
[17:00:40.264] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[17:00:40.266] <TB2> INFO: ----------------------------------------------------------------------
[17:00:40.266] <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)
[17:00:40.266] <TB2> INFO: ----------------------------------------------------------------------
[17:00:43.129] <TB2> INFO: Test took 2862ms.
[17:00:43.133] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:00:43.134] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[17:00:43.343] <TB2> INFO: PixTestAlive::maskTest() done
[17:00:43.343] <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
[17:00:43.345] <TB2> INFO: ----------------------------------------------------------------------
[17:00:43.345] <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)
[17:00:43.345] <TB2> INFO: ----------------------------------------------------------------------
[17:00:46.945] <TB2> INFO: Test took 3599ms.
[17:00:46.971] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:00:47.183] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[17:00:47.184] <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
[17:00:47.184] <TB2> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[17:00:47.198] <TB2> INFO: ######################################################################
[17:00:47.198] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[17:00:47.198] <TB2> INFO: ######################################################################
[17:00:47.199] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (30) hits flags = 2 (plus default)
[17:00:47.212] <TB2> INFO: dacScan step from 0 .. 29
[17:01:09.493] <TB2> INFO: Test took 22281ms.
[17:01:09.532] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:09.532] <TB2> INFO: dacScan step from 30 .. 59
[17:01:32.663] <TB2> INFO: Test took 23131ms.
[17:01:32.748] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:01:32.757] <TB2> INFO: dacScan step from 60 .. 89
[17:02:03.848] <TB2> INFO: Test took 31091ms.
[17:02:04.158] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:02:04.246] <TB2> INFO: dacScan step from 90 .. 119
[17:02:35.246] <TB2> INFO: Test took 31000ms.
[17:02:35.518] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:02:35.616] <TB2> INFO: dacScan step from 120 .. 149
[17:03:04.098] <TB2> INFO: Test took 28482ms.
[17:03:04.358] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:03:27.700] <TB2> INFO: PixTestBBMap::doTest() done, duration: 160 seconds
[17:03:27.700] <TB2> INFO: number of dead bumps (per ROC): 3 0 0 0 0 0 0 0 0 0 0 0 0 0 0 4
[17:03:27.700] <TB2> INFO: separation cut (per ROC): 84 86 90 91 93 96 95 91 87 92 99 95 89 86 90 87
[17:03:27.770] <TB2> INFO: ######################################################################
[17:03:27.770] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50
[17:03:27.770] <TB2> INFO: ######################################################################
[17:03:27.770] <TB2> INFO: ----------------------------------------------------------------------
[17:03:27.770] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50
[17:03:27.770] <TB2> INFO: ----------------------------------------------------------------------
[17:03:27.770] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 0 .. 149 (4) hits flags = 16 (plus default)
[17:03:27.779] <TB2> INFO: dacScan step from 0 .. 3
[17:03:47.316] <TB2> INFO: Test took 19537ms.
[17:03:47.344] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:03:47.344] <TB2> INFO: dacScan step from 4 .. 7
[17:04:05.753] <TB2> INFO: Test took 18408ms.
[17:04:05.777] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:04:05.777] <TB2> INFO: dacScan step from 8 .. 11
[17:04:25.814] <TB2> INFO: Test took 20036ms.
[17:04:25.842] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:04:25.842] <TB2> INFO: dacScan step from 12 .. 15
[17:04:45.919] <TB2> INFO: Test took 20076ms.
[17:04:45.949] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:04:45.949] <TB2> INFO: dacScan step from 16 .. 19
[17:05:06.162] <TB2> INFO: Test took 20213ms.
[17:05:06.188] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:05:06.188] <TB2> INFO: dacScan step from 20 .. 23
[17:05:26.424] <TB2> INFO: Test took 20236ms.
[17:05:26.450] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:05:26.450] <TB2> INFO: dacScan step from 24 .. 27
[17:05:46.477] <TB2> INFO: Test took 20027ms.
[17:05:46.510] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:05:46.510] <TB2> INFO: dacScan step from 28 .. 31
[17:06:06.510] <TB2> INFO: Test took 20000ms.
[17:06:06.539] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:06:06.539] <TB2> INFO: dacScan step from 32 .. 35
[17:06:26.675] <TB2> INFO: Test took 20136ms.
[17:06:26.699] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:06:26.699] <TB2> INFO: dacScan step from 36 .. 39
[17:06:46.924] <TB2> INFO: Test took 20225ms.
[17:06:46.950] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:06:46.950] <TB2> INFO: dacScan step from 40 .. 43
[17:07:07.056] <TB2> INFO: Test took 20106ms.
[17:07:07.081] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:07:07.081] <TB2> INFO: dacScan step from 44 .. 47
[17:07:27.089] <TB2> INFO: Test took 20008ms.
[17:07:27.122] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:07:27.122] <TB2> INFO: dacScan step from 48 .. 51
[17:07:47.180] <TB2> INFO: Test took 20058ms.
[17:07:47.210] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:07:47.210] <TB2> INFO: dacScan step from 52 .. 55
[17:08:07.559] <TB2> INFO: Test took 20349ms.
[17:08:07.586] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:08:07.586] <TB2> INFO: dacScan step from 56 .. 59
[17:08:28.112] <TB2> INFO: Test took 20526ms.
[17:08:28.145] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:08:28.145] <TB2> INFO: dacScan step from 60 .. 63
[17:08:48.278] <TB2> INFO: Test took 20133ms.
[17:08:48.305] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:08:48.305] <TB2> INFO: dacScan step from 64 .. 67
[17:09:08.352] <TB2> INFO: Test took 20046ms.
[17:09:08.382] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:09:08.382] <TB2> INFO: dacScan step from 68 .. 71
[17:09:28.488] <TB2> INFO: Test took 20106ms.
[17:09:28.516] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:09:28.516] <TB2> INFO: dacScan step from 72 .. 75
[17:09:48.671] <TB2> INFO: Test took 20155ms.
[17:09:48.697] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:09:48.697] <TB2> INFO: dacScan step from 76 .. 79
[17:10:08.833] <TB2> INFO: Test took 20136ms.
[17:10:08.860] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:10:08.861] <TB2> INFO: dacScan step from 80 .. 83
[17:10:29.370] <TB2> INFO: Test took 20509ms.
[17:10:29.416] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:10:29.418] <TB2> INFO: dacScan step from 84 .. 87
[17:10:50.839] <TB2> INFO: Test took 21421ms.
[17:10:50.912] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:10:50.915] <TB2> INFO: dacScan step from 88 .. 91
[17:11:13.471] <TB2> INFO: Test took 22556ms.
[17:11:13.554] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:11:13.559] <TB2> INFO: dacScan step from 92 .. 95
[17:11:43.599] <TB2> INFO: Test took 30040ms.
[17:11:43.737] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:11:43.747] <TB2> INFO: dacScan step from 96 .. 99
[17:12:11.838] <TB2> INFO: Test took 28091ms.
[17:12:12.065] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:12:12.078] <TB2> INFO: dacScan step from 100 .. 103
[17:12:42.376] <TB2> INFO: Test took 30298ms.
[17:12:42.604] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:12:42.617] <TB2> INFO: dacScan step from 104 .. 107


[17:13:13.886] <TB2> INFO: Test took 31269ms.
[17:13:14.159] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:13:14.173] <TB2> INFO: dacScan step from 108 .. 111

[17:13:46.233] <TB2> INFO: Test took 32060ms.
[17:13:46.482] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:13:46.496] <TB2> INFO: dacScan step from 112 .. 115


[17:14:18.697] <TB2> INFO: Test took 32201ms.
[17:14:18.945] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:18.958] <TB2> INFO: dacScan step from 116 .. 119


[17:14:51.122] <TB2> INFO: Test took 32164ms.
[17:14:51.406] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:51.420] <TB2> INFO: dacScan step from 120 .. 123


[17:15:23.591] <TB2> INFO: Test took 32171ms.
[17:15:23.851] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:23.862] <TB2> INFO: dacScan step from 124 .. 127


[17:15:56.163] <TB2> INFO: Test took 32301ms.
[17:15:56.450] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:56.464] <TB2> INFO: dacScan step from 128 .. 131
[17:16:28.200] <TB2> INFO: Test took 31736ms.
[17:16:28.463] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:16:28.474] <TB2> INFO: dacScan step from 132 .. 135
[17:17:00.038] <TB2> INFO: Test took 31564ms.
[17:17:00.253] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:17:00.265] <TB2> INFO: dacScan step from 136 .. 139
[17:17:32.181] <TB2> INFO: Test took 31917ms.
[17:17:32.462] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:17:32.474] <TB2> INFO: dacScan step from 140 .. 143
[17:18:04.341] <TB2> INFO: Test took 31867ms.
[17:18:04.611] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:18:04.624] <TB2> INFO: dacScan step from 144 .. 147
[17:18:36.398] <TB2> INFO: Test took 31774ms.
[17:18:36.644] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:18:36.657] <TB2> INFO: dacScan step from 148 .. 149
[17:18:53.908] <TB2> INFO: Test took 17251ms.
[17:18:54.055] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:18:54.061] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:18:55.676] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:18:57.412] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:18:59.099] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:00.781] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:02.415] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:04.127] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:05.780] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:07.396] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:08.973] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:10.498] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:12.161] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:13.875] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:15.473] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:17.199] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:18.720] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:19:20.493] <TB2> INFO: PixTestScurves::scurves() done
[17:19:20.493] <TB2> INFO: Vcal mean: 101.10 87.49 96.86 93.87 93.81 97.05 101.72 100.86 98.44 101.72 97.95 102.23 94.34 93.83 100.20 95.86
[17:19:20.493] <TB2> INFO: Vcal RMS: 6.88 4.63 4.87 6.40 5.08 5.06 7.81 5.65 5.21 5.71 6.09 5.08 4.87 5.88 5.07 4.90
[17:19:20.493] <TB2> INFO: PixTestScurves::fullTest() done, duration: 952 seconds
[17:19:20.563] <TB2> INFO: ######################################################################
[17:19:20.563] <TB2> INFO: PixTestTrim::doTest()
[17:19:20.563] <TB2> INFO: ######################################################################
[17:19:20.564] <TB2> INFO: ----------------------------------------------------------------------
[17:19:20.564] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[17:19:20.564] <TB2> INFO: ----------------------------------------------------------------------
[17:19:20.661] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[17:19:20.661] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 5 dacrange: 0 .. 159 (20) hits flags = 16 (plus default)
[17:19:20.672] <TB2> INFO: dacScan step from 0 .. 19
[17:19:35.455] <TB2> INFO: Test took 14783ms.
[17:19:35.474] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:19:35.474] <TB2> INFO: dacScan step from 20 .. 39
[17:19:51.212] <TB2> INFO: Test took 15738ms.
[17:19:51.236] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:19:51.236] <TB2> INFO: dacScan step from 40 .. 59
[17:20:06.839] <TB2> INFO: Test took 15603ms.
[17:20:06.862] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:06.862] <TB2> INFO: dacScan step from 60 .. 79
[17:20:22.575] <TB2> INFO: Test took 15713ms.
[17:20:22.603] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:22.603] <TB2> INFO: dacScan step from 80 .. 99
[17:20:38.440] <TB2> INFO: Test took 15837ms.
[17:20:38.469] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:38.471] <TB2> INFO: dacScan step from 100 .. 119
[17:20:57.529] <TB2> INFO: Test took 19058ms.
[17:20:57.663] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:57.691] <TB2> INFO: dacScan step from 120 .. 139
[17:21:18.662] <TB2> INFO: Test took 20971ms.
[17:21:18.832] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:21:18.868] <TB2> INFO: dacScan step from 140 .. 159
[17:21:36.007] <TB2> INFO: Test took 17139ms.
[17:21:36.094] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:22:01.158] <TB2> INFO: ROC 0 VthrComp = 97
[17:22:01.158] <TB2> INFO: ROC 1 VthrComp = 91
[17:22:01.158] <TB2> INFO: ROC 2 VthrComp = 97
[17:22:01.158] <TB2> INFO: ROC 3 VthrComp = 94
[17:22:01.158] <TB2> INFO: ROC 4 VthrComp = 98
[17:22:01.158] <TB2> INFO: ROC 5 VthrComp = 102
[17:22:01.158] <TB2> INFO: ROC 6 VthrComp = 99
[17:22:01.158] <TB2> INFO: ROC 7 VthrComp = 101
[17:22:01.158] <TB2> INFO: ROC 8 VthrComp = 101
[17:22:01.158] <TB2> INFO: ROC 9 VthrComp = 100
[17:22:01.158] <TB2> INFO: ROC 10 VthrComp = 101
[17:22:01.158] <TB2> INFO: ROC 11 VthrComp = 103
[17:22:01.158] <TB2> INFO: ROC 12 VthrComp = 100
[17:22:01.158] <TB2> INFO: ROC 13 VthrComp = 93
[17:22:01.158] <TB2> INFO: ROC 14 VthrComp = 101
[17:22:01.158] <TB2> INFO: ROC 15 VthrComp = 95
[17:22:01.159] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[17:22:01.159] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 5 dacrange: 0 .. 159 (20) hits flags = 16 (plus default)
[17:22:01.167] <TB2> INFO: dacScan step from 0 .. 19
[17:22:15.989] <TB2> INFO: Test took 14821ms.
[17:22:16.011] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:22:16.011] <TB2> INFO: dacScan step from 20 .. 39
[17:22:31.197] <TB2> INFO: Test took 15186ms.
[17:22:31.236] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:22:31.241] <TB2> INFO: dacScan step from 40 .. 59
[17:22:50.103] <TB2> INFO: Test took 18862ms.
[17:22:50.337] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:22:50.427] <TB2> INFO: dacScan step from 60 .. 79
[17:23:10.464] <TB2> INFO: Test took 20037ms.
[17:23:10.719] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:10.782] <TB2> INFO: dacScan step from 80 .. 99
[17:23:30.767] <TB2> INFO: Test took 19984ms.
[17:23:30.923] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:30.990] <TB2> INFO: dacScan step from 100 .. 119
[17:23:50.898] <TB2> INFO: Test took 19908ms.
[17:23:51.072] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:51.159] <TB2> INFO: dacScan step from 120 .. 139
[17:24:12.599] <TB2> INFO: Test took 21440ms.
[17:24:12.789] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:12.838] <TB2> INFO: dacScan step from 140 .. 159
[17:24:34.277] <TB2> INFO: Test took 21439ms.
[17:24:34.435] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:25:03.893] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 62.5852 for pixel 19/0 mean/min/max = 46.9161/31.0951/62.7372
[17:25:03.893] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 56.2378 for pixel 14/2 mean/min/max = 44.5457/32.7371/56.3543
[17:25:03.893] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 57.8219 for pixel 26/2 mean/min/max = 45.1176/32.3652/57.87
[17:25:03.894] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 61.2253 for pixel 15/79 mean/min/max = 46.6207/31.9877/61.2538
[17:25:03.894] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 57.5567 for pixel 0/68 mean/min/max = 44.7839/32.0095/57.5583
[17:25:03.894] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 56.5581 for pixel 38/76 mean/min/max = 44.3874/31.9009/56.874
[17:25:03.894] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 61.5833 for pixel 6/2 mean/min/max = 46.19/30.7355/61.6444
[17:25:03.895] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 58.3536 for pixel 11/79 mean/min/max = 45.321/32.1453/58.4968
[17:25:03.895] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 58.1889 for pixel 11/79 mean/min/max = 45.2137/32.0401/58.3874
[17:25:03.895] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 59.9748 for pixel 24/79 mean/min/max = 46.126/32.2715/59.9805
[17:25:03.896] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 59.455 for pixel 17/79 mean/min/max = 45.8306/32.1062/59.5549
[17:25:03.896] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 56.9581 for pixel 22/69 mean/min/max = 44.7306/32.3805/57.0808
[17:25:03.896] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 56.8458 for pixel 20/2 mean/min/max = 44.5321/32.1378/56.9264
[17:25:03.897] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 59.3998 for pixel 27/6 mean/min/max = 46.0354/32.6421/59.4288
[17:25:03.897] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 56.8064 for pixel 20/79 mean/min/max = 44.8977/32.91/56.8853
[17:25:03.897] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 57.75 for pixel 15/51 mean/min/max = 45.442/32.8734/58.0107
[17:25:03.897] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:26:43.477] <TB2> INFO: Test took 99580ms.
[17:26:44.943] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 199 (20) hits flags = 16 (plus default)
[17:26:44.951] <TB2> INFO: dacScan step from 0 .. 19
[17:27:08.940] <TB2> INFO: Test took 23988ms.
[17:27:08.987] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:27:08.990] <TB2> INFO: dacScan step from 20 .. 39
[17:27:39.385] <TB2> INFO: Test took 30395ms.
[17:27:39.662] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:27:39.695] <TB2> INFO: dacScan step from 40 .. 59


[17:28:15.343] <TB2> INFO: Test took 35648ms.
[17:28:15.637] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:28:15.688] <TB2> INFO: dacScan step from 60 .. 79


[17:28:51.112] <TB2> INFO: Test took 35424ms.
[17:28:51.450] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:28:51.506] <TB2> INFO: dacScan step from 80 .. 99


[17:29:26.932] <TB2> INFO: Test took 35426ms.
[17:29:27.234] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:29:27.283] <TB2> INFO: dacScan step from 100 .. 119


[17:30:01.068] <TB2> INFO: Test took 33785ms.
[17:30:01.347] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:30:01.394] <TB2> INFO: dacScan step from 120 .. 139


[17:30:37.621] <TB2> INFO: Test took 36227ms.
[17:30:37.883] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:30:37.930] <TB2> INFO: dacScan step from 140 .. 159



[17:31:12.330] <TB2> INFO: Test took 34400ms.
[17:31:12.732] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:31:12.783] <TB2> INFO: dacScan step from 160 .. 179



[17:31:47.512] <TB2> INFO: Test took 34729ms.
[17:31:47.832] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:31:47.880] <TB2> INFO: dacScan step from 180 .. 199

[17:32:24.381] <TB2> INFO: Test took 36501ms.
[17:32:24.724] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:32:50.188] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.007154 .. 255.000000
[17:32:50.277] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 4 dacrange: 0 .. 255 (20) hits flags = 16 (plus default)
[17:32:50.286] <TB2> INFO: dacScan step from 0 .. 19
[17:33:03.669] <TB2> INFO: Test took 13383ms.
[17:33:03.691] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:33:03.691] <TB2> INFO: dacScan step from 20 .. 39
[17:33:19.114] <TB2> INFO: Test took 15423ms.
[17:33:19.195] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:33:19.211] <TB2> INFO: dacScan step from 40 .. 59
[17:33:38.004] <TB2> INFO: Test took 18792ms.
[17:33:38.153] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:33:38.221] <TB2> INFO: dacScan step from 60 .. 79
[17:33:56.925] <TB2> INFO: Test took 18704ms.
[17:33:57.096] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:33:57.140] <TB2> INFO: dacScan step from 80 .. 99
[17:34:15.791] <TB2> INFO: Test took 18651ms.
[17:34:15.932] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:34:15.976] <TB2> INFO: dacScan step from 100 .. 119
[17:34:33.380] <TB2> INFO: Test took 17403ms.
[17:34:33.545] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:34:33.592] <TB2> INFO: dacScan step from 120 .. 139
[17:34:51.929] <TB2> INFO: Test took 18337ms.
[17:34:52.103] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:34:52.145] <TB2> INFO: dacScan step from 140 .. 159
[17:35:10.789] <TB2> INFO: Test took 18644ms.
[17:35:10.932] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:35:10.972] <TB2> INFO: dacScan step from 160 .. 179
[17:35:29.671] <TB2> INFO: Test took 18699ms.
[17:35:29.814] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:35:29.855] <TB2> INFO: dacScan step from 180 .. 199
[17:35:49.462] <TB2> INFO: Test took 19607ms.
[17:35:49.625] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:35:49.669] <TB2> INFO: dacScan step from 200 .. 219
[17:36:08.260] <TB2> INFO: Test took 18591ms.
[17:36:08.441] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:36:08.485] <TB2> INFO: dacScan step from 220 .. 239
[17:36:27.301] <TB2> INFO: Test took 18816ms.
[17:36:27.443] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:36:27.485] <TB2> INFO: dacScan step from 240 .. 255
[17:36:42.950] <TB2> INFO: Test took 15465ms.
[17:36:43.075] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:37:16.537] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 15.512775 .. 48.947660
[17:37:16.623] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 4 dacrange: 5 .. 58 (20) hits flags = 16 (plus default)
[17:37:16.632] <TB2> INFO: dacScan step from 5 .. 24
[17:37:29.989] <TB2> INFO: Test took 13357ms.
[17:37:30.008] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:37:30.008] <TB2> INFO: dacScan step from 25 .. 44
[17:37:46.667] <TB2> INFO: Test took 16659ms.
[17:37:46.780] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:37:46.807] <TB2> INFO: dacScan step from 45 .. 58
[17:38:00.758] <TB2> INFO: Test took 13951ms.
[17:38:00.860] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:38:16.796] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 2.143400 .. 47.377065
[17:38:16.871] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 4 dacrange: 2 .. 57 (20) hits flags = 16 (plus default)
[17:38:16.879] <TB2> INFO: dacScan step from 2 .. 21
[17:38:30.223] <TB2> INFO: Test took 13344ms.
[17:38:30.243] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:38:30.243] <TB2> INFO: dacScan step from 22 .. 41
[17:38:45.954] <TB2> INFO: Test took 15711ms.
[17:38:46.054] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:38:46.097] <TB2> INFO: dacScan step from 42 .. 57
[17:39:01.193] <TB2> INFO: Test took 15095ms.
[17:39:01.305] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:39:18.030] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 1.629391 .. 45.647557
[17:39:18.117] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 4 dacrange: 1 .. 55 (20) hits flags = 16 (plus default)
[17:39:18.125] <TB2> INFO: dacScan step from 1 .. 20
[17:39:31.650] <TB2> INFO: Test took 13524ms.
[17:39:31.668] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:39:31.669] <TB2> INFO: dacScan step from 21 .. 40
[17:39:46.359] <TB2> INFO: Test took 14690ms.
[17:39:46.438] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:39:46.457] <TB2> INFO: dacScan step from 41 .. 55
[17:40:01.319] <TB2> INFO: Test took 14862ms.
[17:40:01.426] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:40:16.965] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[17:40:16.965] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (20) hits flags = 16 (plus default)
[17:40:16.975] <TB2> INFO: dacScan step from 15 .. 34
[17:40:41.534] <TB2> INFO: Test took 24559ms.
[17:40:41.598] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:40:41.607] <TB2> INFO: dacScan step from 35 .. 54


[17:41:16.745] <TB2> INFO: Test took 35138ms.
[17:41:17.029] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:41:17.074] <TB2> INFO: dacScan step from 55 .. 55
[17:41:21.521] <TB2> INFO: Test took 4447ms.
[17:41:21.538] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C0.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C1.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C2.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C3.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C4.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C5.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C6.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C7.dat
[17:41:35.040] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C8.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C9.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C10.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C11.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C12.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C13.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C14.dat
[17:41:35.041] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C15.dat
[17:41:35.041] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C0.dat
[17:41:35.047] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C1.dat
[17:41:35.053] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C2.dat
[17:41:35.060] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C3.dat
[17:41:35.067] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C4.dat
[17:41:35.074] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C5.dat
[17:41:35.081] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C6.dat
[17:41:35.088] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C7.dat
[17:41:35.094] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C8.dat
[17:41:35.102] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C9.dat
[17:41:35.109] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C10.dat
[17:41:35.116] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C11.dat
[17:41:35.123] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C12.dat
[17:41:35.130] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C13.dat
[17:41:35.137] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C14.dat
[17:41:35.144] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//trimParameters35_C15.dat
[17:41:35.151] <TB2> INFO: PixTestTrim::trimTest() done
[17:41:35.151] <TB2> INFO: vtrim: 121 106 107 116 99 112 109 103 101 105 100 111 113 114 101 101
[17:41:35.151] <TB2> INFO: vthrcomp: 97 91 97 94 98 102 99 101 101 100 101 103 100 93 101 95
[17:41:35.151] <TB2> INFO: vcal mean: 35.14 35.09 35.10 35.07 35.05 35.04 35.05 35.10 35.05 35.07 35.06 35.10 35.07 35.10 35.07 35.09
[17:41:35.151] <TB2> INFO: vcal RMS: 1.19 1.00 1.05 1.21 1.03 1.03 1.49 1.10 1.04 1.08 1.06 1.06 1.03 1.07 1.06 1.19
[17:41:35.151] <TB2> INFO: bits mean: 9.93 10.40 9.85 9.39 9.81 10.08 9.64 9.98 9.63 9.31 9.42 10.13 10.43 10.18 10.07 10.05
[17:41:35.151] <TB2> INFO: bits RMS: 2.53 2.25 2.55 2.72 2.64 2.48 2.77 2.49 2.68 2.78 2.70 2.42 2.33 2.31 2.38 2.41
[17:41:35.158] <TB2> INFO: ----------------------------------------------------------------------
[17:41:35.158] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 10, vtrims = 254 126 63 32
[17:41:35.158] <TB2> INFO: ----------------------------------------------------------------------
[17:41:35.160] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 10 dacrange: 0 .. 199 (20) hits flags = 16 (plus default)
[17:41:35.169] <TB2> INFO: dacScan step from 0 .. 19
[17:41:59.183] <TB2> INFO: Test took 24014ms.
[17:41:59.222] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:41:59.222] <TB2> INFO: dacScan step from 20 .. 39
[17:42:22.984] <TB2> INFO: Test took 23763ms.
[17:42:23.019] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:42:23.019] <TB2> INFO: dacScan step from 40 .. 59
[17:42:47.133] <TB2> INFO: Test took 24114ms.
[17:42:47.168] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:42:47.168] <TB2> INFO: dacScan step from 60 .. 79
[17:43:11.227] <TB2> INFO: Test took 24058ms.
[17:43:11.262] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:43:11.262] <TB2> INFO: dacScan step from 80 .. 99
[17:43:35.113] <TB2> INFO: Test took 23851ms.
[17:43:35.147] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:43:35.147] <TB2> INFO: dacScan step from 100 .. 119
[17:43:59.734] <TB2> INFO: Test took 24587ms.
[17:43:59.818] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:43:59.828] <TB2> INFO: dacScan step from 120 .. 139
[17:44:31.629] <TB2> INFO: Test took 31801ms.
[17:44:31.877] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:44:31.912] <TB2> INFO: dacScan step from 140 .. 159



[17:45:07.661] <TB2> INFO: Test took 35749ms.
[17:45:07.932] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:45:07.981] <TB2> INFO: dacScan step from 160 .. 179
[17:45:42.228] <TB2> INFO: Test took 34247ms.
[17:45:42.505] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:45:42.550] <TB2> INFO: dacScan step from 180 .. 199
[17:46:18.891] <TB2> INFO: Test took 36341ms.
[17:46:19.162] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:46:45.739] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 10 dacrange: 0 .. 182 (20) hits flags = 16 (plus default)
[17:46:45.747] <TB2> INFO: dacScan step from 0 .. 19
[17:47:09.638] <TB2> INFO: Test took 23891ms.
[17:47:09.674] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:47:09.674] <TB2> INFO: dacScan step from 20 .. 39
[17:47:31.768] <TB2> INFO: Test took 22094ms.
[17:47:31.800] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:47:31.800] <TB2> INFO: dacScan step from 40 .. 59
[17:47:55.969] <TB2> INFO: Test took 24169ms.
[17:47:56.005] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:47:56.005] <TB2> INFO: dacScan step from 60 .. 79
[17:48:19.683] <TB2> INFO: Test took 23678ms.
[17:48:19.717] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:48:19.717] <TB2> INFO: dacScan step from 80 .. 99
[17:48:43.766] <TB2> INFO: Test took 24049ms.
[17:48:43.813] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:48:43.813] <TB2> INFO: dacScan step from 100 .. 119
[17:49:10.666] <TB2> INFO: Test took 26852ms.
[17:49:10.895] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:49:10.914] <TB2> INFO: dacScan step from 120 .. 139


[17:49:46.557] <TB2> INFO: Test took 35642ms.
[17:49:46.833] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:49:46.874] <TB2> INFO: dacScan step from 140 .. 159



[17:50:22.575] <TB2> INFO: Test took 35701ms.
[17:50:22.849] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:50:22.896] <TB2> INFO: dacScan step from 160 .. 179
[17:50:57.348] <TB2> INFO: Test took 34451ms.
[17:50:57.616] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:50:57.665] <TB2> INFO: dacScan step from 180 .. 182
[17:51:04.897] <TB2> INFO: Test took 7232ms.
[17:51:04.944] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:51:29.426] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 10 dacrange: 0 .. 168 (20) hits flags = 16 (plus default)
[17:51:29.435] <TB2> INFO: dacScan step from 0 .. 19
[17:51:53.228] <TB2> INFO: Test took 23793ms.
[17:51:53.264] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:51:53.264] <TB2> INFO: dacScan step from 20 .. 39
[17:52:17.159] <TB2> INFO: Test took 23895ms.
[17:52:17.194] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:52:17.194] <TB2> INFO: dacScan step from 40 .. 59
[17:52:39.364] <TB2> INFO: Test took 22170ms.
[17:52:39.400] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:52:39.400] <TB2> INFO: dacScan step from 60 .. 79
[17:53:01.834] <TB2> INFO: Test took 22434ms.
[17:53:01.868] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:53:01.868] <TB2> INFO: dacScan step from 80 .. 99
[17:53:24.426] <TB2> INFO: Test took 22557ms.
[17:53:24.465] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:53:24.465] <TB2> INFO: dacScan step from 100 .. 119
[17:53:51.121] <TB2> INFO: Test took 26656ms.
[17:53:51.305] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:53:51.326] <TB2> INFO: dacScan step from 120 .. 139


[17:54:26.744] <TB2> INFO: Test took 35417ms.
[17:54:27.047] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:54:27.095] <TB2> INFO: dacScan step from 140 .. 159



[17:54:59.802] <TB2> INFO: Test took 32707ms.
[17:55:00.116] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:55:00.162] <TB2> INFO: dacScan step from 160 .. 168
[17:55:16.515] <TB2> INFO: Test took 16353ms.
[17:55:16.641] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:55:39.661] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 10 dacrange: 0 .. 167 (20) hits flags = 16 (plus default)
[17:55:39.670] <TB2> INFO: dacScan step from 0 .. 19
[17:56:03.602] <TB2> INFO: Test took 23932ms.
[17:56:03.634] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:56:03.634] <TB2> INFO: dacScan step from 20 .. 39
[17:56:27.424] <TB2> INFO: Test took 23790ms.
[17:56:27.457] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:56:27.457] <TB2> INFO: dacScan step from 40 .. 59
[17:56:51.044] <TB2> INFO: Test took 23587ms.
[17:56:51.077] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:56:51.077] <TB2> INFO: dacScan step from 60 .. 79
[17:57:14.804] <TB2> INFO: Test took 23727ms.
[17:57:14.842] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:57:14.842] <TB2> INFO: dacScan step from 80 .. 99
[17:57:38.734] <TB2> INFO: Test took 23892ms.
[17:57:38.772] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:57:38.773] <TB2> INFO: dacScan step from 100 .. 119
[17:58:07.405] <TB2> INFO: Test took 28632ms.
[17:58:07.585] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:58:07.605] <TB2> INFO: dacScan step from 120 .. 139



[17:58:41.070] <TB2> INFO: Test took 33465ms.
[17:58:41.366] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:58:41.411] <TB2> INFO: dacScan step from 140 .. 159
[17:59:16.997] <TB2> INFO: Test took 35586ms.
[17:59:17.264] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:59:17.310] <TB2> INFO: dacScan step from 160 .. 167
[17:59:33.335] <TB2> INFO: Test took 16025ms.
[17:59:33.450] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:59:57.064] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 10 dacrange: 0 .. 166 (20) hits flags = 16 (plus default)
[17:59:57.073] <TB2> INFO: dacScan step from 0 .. 19
[18:00:19.572] <TB2> INFO: Test took 22499ms.
[18:00:19.609] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:00:19.609] <TB2> INFO: dacScan step from 20 .. 39
[18:00:42.866] <TB2> INFO: Test took 23257ms.
[18:00:42.911] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:00:42.911] <TB2> INFO: dacScan step from 40 .. 59
[18:01:05.937] <TB2> INFO: Test took 23025ms.
[18:01:05.973] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:01:05.973] <TB2> INFO: dacScan step from 60 .. 79
[18:01:28.753] <TB2> INFO: Test took 22780ms.
[18:01:28.790] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:01:28.790] <TB2> INFO: dacScan step from 80 .. 99
[18:01:52.963] <TB2> INFO: Test took 24173ms.
[18:01:53.007] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:01:53.008] <TB2> INFO: dacScan step from 100 .. 119
[18:02:21.125] <TB2> INFO: Test took 28117ms.
[18:02:21.305] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:02:21.328] <TB2> INFO: dacScan step from 120 .. 139


[18:02:53.770] <TB2> INFO: Test took 32442ms.
[18:02:54.040] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:02:54.085] <TB2> INFO: dacScan step from 140 .. 159


[18:03:29.813] <TB2> INFO: Test took 35727ms.
[18:03:30.072] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:03:30.119] <TB2> INFO: dacScan step from 160 .. 166
[18:03:44.496] <TB2> INFO: Test took 14376ms.
[18:03:44.594] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:04:06.236] <TB2> INFO: PixTestTrim::trimBitTest() done
[18:04:06.238] <TB2> INFO: PixTestTrim::doTest() done, duration: 2685 seconds
[18:04:06.896] <TB2> INFO: ######################################################################
[18:04:06.896] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[18:04:06.896] <TB2> INFO: ######################################################################
[18:04:10.280] <TB2> INFO: Test took 3383ms.
[18:04:10.298] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:04:13.883] <TB2> INFO: Test took 3388ms.
[18:04:13.947] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:04:17.344] <TB2> INFO: Test took 3389ms.
[18:04:17.405] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[18:04:17.412] <TB2> INFO: The DUT currently contains the following objects:
[18:04:17.412] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:17.412] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:17.412] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:17.412] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:17.412] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:17.412] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.517] <TB2> INFO: Test took 1105ms.
[18:04:18.518] <TB2> INFO: The DUT currently contains the following objects:
[18:04:18.518] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:18.518] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:18.518] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:18.518] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:18.518] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:18.518] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: Test took 1104ms.
[18:04:19.622] <TB2> INFO: The DUT currently contains the following objects:
[18:04:19.622] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:19.622] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:19.622] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:19.622] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:19.622] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:19.622] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: Test took 1104ms.
[18:04:20.726] <TB2> INFO: The DUT currently contains the following objects:
[18:04:20.726] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:20.726] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:20.726] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:20.726] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:20.726] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:20.726] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.830] <TB2> INFO: Test took 1104ms.
[18:04:21.831] <TB2> INFO: The DUT currently contains the following objects:
[18:04:21.831] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:21.831] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:21.831] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:21.831] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:21.831] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:21.831] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.935] <TB2> INFO: Test took 1104ms.
[18:04:22.935] <TB2> INFO: The DUT currently contains the following objects:
[18:04:22.936] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:22.936] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:22.936] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:22.936] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:22.936] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:22.936] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.039] <TB2> INFO: Test took 1103ms.
[18:04:24.040] <TB2> INFO: The DUT currently contains the following objects:
[18:04:24.040] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:24.040] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:24.040] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:24.040] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:24.040] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:24.040] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.151] <TB2> INFO: Test took 1111ms.
[18:04:25.152] <TB2> INFO: The DUT currently contains the following objects:
[18:04:25.152] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:25.152] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:25.152] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:25.152] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:25.152] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.152] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:25.153] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.263] <TB2> INFO: Test took 1110ms.
[18:04:26.264] <TB2> INFO: The DUT currently contains the following objects:
[18:04:26.265] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:26.265] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:26.265] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:26.265] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:26.265] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:26.265] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.376] <TB2> INFO: Test took 1111ms.
[18:04:27.377] <TB2> INFO: The DUT currently contains the following objects:
[18:04:27.377] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:27.377] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:27.377] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:27.377] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:27.377] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.377] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.377] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:27.378] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.489] <TB2> INFO: Test took 1111ms.
[18:04:28.490] <TB2> INFO: The DUT currently contains the following objects:
[18:04:28.497] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:28.497] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:28.497] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:28.497] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:28.497] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:28.497] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.602] <TB2> INFO: Test took 1105ms.
[18:04:29.603] <TB2> INFO: The DUT currently contains the following objects:
[18:04:29.603] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:29.603] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:29.603] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:29.603] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:29.603] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.603] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.604] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.604] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.604] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.604] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:29.604] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.715] <TB2> INFO: Test took 1111ms.
[18:04:30.716] <TB2> INFO: The DUT currently contains the following objects:
[18:04:30.716] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:30.716] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:30.716] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:30.716] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:30.716] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.716] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:30.717] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.828] <TB2> INFO: Test took 1111ms.
[18:04:31.829] <TB2> INFO: The DUT currently contains the following objects:
[18:04:31.829] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:31.829] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:31.829] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:31.829] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:31.829] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:31.830] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.942] <TB2> INFO: Test took 1112ms.
[18:04:32.943] <TB2> INFO: The DUT currently contains the following objects:
[18:04:32.943] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:32.943] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:32.943] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:32.943] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:32.943] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.943] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:32.944] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.057] <TB2> INFO: Test took 1113ms.
[18:04:34.058] <TB2> INFO: The DUT currently contains the following objects:
[18:04:34.058] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[18:04:34.058] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:04:34.058] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:04:34.058] <TB2> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[18:04:34.058] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:34.058] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[18:04:35.169] <TB2> INFO: Test took 1110ms.
[18:04:35.172] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:08:34.678] <TB2> INFO: Test took 239506ms.
[18:08:36.116] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:35.407] <TB2> INFO: Test took 239291ms.
[18:12:37.046] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.054] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.061] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.068] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.074] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.082] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.089] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.097] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.104] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[18:12:37.112] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[18:12:37.118] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[18:12:37.125] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[18:12:37.133] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[18:12:37.139] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[18:12:37.146] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.153] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[18:12:37.160] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[18:12:37.167] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[18:12:37.174] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[18:12:37.181] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[18:12:37.188] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[18:12:37.195] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.202] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[18:12:37.210] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[18:12:37.217] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[18:12:37.224] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[18:12:37.231] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[18:12:37.237] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[18:12:37.244] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[18:12:37.251] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.258] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.265] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.272] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[18:12:37.279] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[18:12:37.286] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[18:12:37.293] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[18:12:37.300] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.308] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.314] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:12:37.339] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C0.dat
[18:12:37.339] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C1.dat
[18:12:37.339] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C2.dat
[18:12:37.340] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C3.dat
[18:12:37.340] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C4.dat
[18:12:37.340] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C5.dat
[18:12:37.340] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C6.dat
[18:12:37.340] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C7.dat
[18:12:37.341] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C8.dat
[18:12:37.341] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C9.dat
[18:12:37.341] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C10.dat
[18:12:37.341] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C11.dat
[18:12:37.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C12.dat
[18:12:37.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C13.dat
[18:12:37.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C14.dat
[18:12:37.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//dacParameters35_C15.dat
[18:12:40.918] <TB2> INFO: Test took 3574ms.
[18:12:44.783] <TB2> INFO: Test took 3598ms.
[18:12:48.637] <TB2> INFO: Test took 3567ms.
[18:12:48.909] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:49.835] <TB2> INFO: Test took 926ms.
[18:12:49.839] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:50.950] <TB2> INFO: Test took 1111ms.
[18:12:50.953] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:52.065] <TB2> INFO: Test took 1112ms.
[18:12:52.067] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:53.180] <TB2> INFO: Test took 1113ms.
[18:12:53.182] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:54.295] <TB2> INFO: Test took 1113ms.
[18:12:54.297] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:55.410] <TB2> INFO: Test took 1113ms.
[18:12:55.412] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:56.525] <TB2> INFO: Test took 1113ms.
[18:12:56.528] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:57.641] <TB2> INFO: Test took 1114ms.
[18:12:57.643] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:58.756] <TB2> INFO: Test took 1113ms.
[18:12:58.759] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:12:59.872] <TB2> INFO: Test took 1113ms.
[18:12:59.874] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:00.987] <TB2> INFO: Test took 1113ms.
[18:13:00.989] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:02.102] <TB2> INFO: Test took 1113ms.
[18:13:02.104] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:03.217] <TB2> INFO: Test took 1113ms.
[18:13:03.219] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:04.331] <TB2> INFO: Test took 1112ms.
[18:13:04.334] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:05.447] <TB2> INFO: Test took 1114ms.
[18:13:05.449] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:06.561] <TB2> INFO: Test took 1112ms.
[18:13:06.564] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:07.677] <TB2> INFO: Test took 1113ms.
[18:13:07.680] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:08.785] <TB2> INFO: Test took 1106ms.
[18:13:08.787] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:09.899] <TB2> INFO: Test took 1113ms.
[18:13:09.903] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:11.014] <TB2> INFO: Test took 1112ms.
[18:13:11.017] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:12.130] <TB2> INFO: Test took 1113ms.
[18:13:12.132] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:13.239] <TB2> INFO: Test took 1107ms.
[18:13:13.240] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:14.353] <TB2> INFO: Test took 1113ms.
[18:13:14.356] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:15.468] <TB2> INFO: Test took 1113ms.
[18:13:15.470] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:16.583] <TB2> INFO: Test took 1113ms.
[18:13:16.585] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:17.698] <TB2> INFO: Test took 1113ms.
[18:13:17.700] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:18.811] <TB2> INFO: Test took 1111ms.
[18:13:18.814] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:19.926] <TB2> INFO: Test took 1112ms.
[18:13:19.929] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:21.042] <TB2> INFO: Test took 1113ms.
[18:13:21.045] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:22.157] <TB2> INFO: Test took 1113ms.
[18:13:22.160] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:23.271] <TB2> INFO: Test took 1112ms.
[18:13:23.274] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:13:24.380] <TB2> INFO: Test took 1106ms.
[18:13:24.891] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 557 seconds
[18:13:24.891] <TB2> INFO: PH scale (per ROC): 68 80 70 75 78 77 69 72 69 70 71 79 78 66 77 75
[18:13:24.891] <TB2> INFO: PH offset (per ROC): 190 170 180 181 177 176 190 176 176 176 181 172 176 173 184 180
[18:13:25.061] <TB2> INFO: ######################################################################
[18:13:25.061] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[18:13:25.061] <TB2> INFO: ######################################################################
[18:13:25.071] <TB2> INFO: scanning low vcal = 10
[18:13:28.936] <TB2> INFO: Test took 3865ms.
[18:13:28.938] <TB2> INFO: scanning low vcal = 20
[18:13:32.822] <TB2> INFO: Test took 3883ms.
[18:13:32.824] <TB2> INFO: scanning low vcal = 30
[18:13:36.669] <TB2> INFO: Test took 3845ms.
[18:13:36.676] <TB2> INFO: scanning low vcal = 40
[18:13:41.004] <TB2> INFO: Test took 4328ms.
[18:13:41.090] <TB2> INFO: scanning low vcal = 50
[18:13:45.398] <TB2> INFO: Test took 4308ms.
[18:13:45.455] <TB2> INFO: scanning low vcal = 60
[18:13:49.757] <TB2> INFO: Test took 4302ms.
[18:13:49.813] <TB2> INFO: scanning low vcal = 70
[18:13:54.251] <TB2> INFO: Test took 4438ms.
[18:13:54.308] <TB2> INFO: scanning low vcal = 80
[18:13:58.756] <TB2> INFO: Test took 4448ms.
[18:13:58.820] <TB2> INFO: scanning low vcal = 90
[18:14:03.254] <TB2> INFO: Test took 4434ms.
[18:14:03.316] <TB2> INFO: scanning low vcal = 100
[18:14:07.768] <TB2> INFO: Test took 4452ms.
[18:14:07.830] <TB2> INFO: scanning low vcal = 110
[18:14:12.285] <TB2> INFO: Test took 4455ms.
[18:14:12.345] <TB2> INFO: scanning low vcal = 120
[18:14:16.828] <TB2> INFO: Test took 4483ms.
[18:14:16.888] <TB2> INFO: scanning low vcal = 130
[18:14:21.341] <TB2> INFO: Test took 4453ms.
[18:14:21.400] <TB2> INFO: scanning low vcal = 140
[18:14:25.704] <TB2> INFO: Test took 4304ms.
[18:14:25.759] <TB2> INFO: scanning low vcal = 150
[18:14:30.083] <TB2> INFO: Test took 4324ms.
[18:14:30.144] <TB2> INFO: scanning low vcal = 160
[18:14:34.449] <TB2> INFO: Test took 4305ms.
[18:14:34.510] <TB2> INFO: scanning low vcal = 170
[18:14:38.820] <TB2> INFO: Test took 4310ms.
[18:14:38.881] <TB2> INFO: scanning low vcal = 180
[18:14:43.186] <TB2> INFO: Test took 4305ms.
[18:14:43.243] <TB2> INFO: scanning low vcal = 190
[18:14:47.687] <TB2> INFO: Test took 4444ms.
[18:14:47.747] <TB2> INFO: scanning low vcal = 200
[18:14:52.054] <TB2> INFO: Test took 4307ms.
[18:14:52.154] <TB2> INFO: scanning low vcal = 210
[18:14:56.461] <TB2> INFO: Test took 4307ms.
[18:14:56.517] <TB2> INFO: scanning low vcal = 220
[18:15:01.009] <TB2> INFO: Test took 4492ms.
[18:15:01.070] <TB2> INFO: scanning low vcal = 230
[18:15:05.569] <TB2> INFO: Test took 4499ms.
[18:15:05.664] <TB2> INFO: scanning low vcal = 240
[18:15:10.185] <TB2> INFO: Test took 4521ms.
[18:15:10.248] <TB2> INFO: scanning low vcal = 250
[18:15:14.754] <TB2> INFO: Test took 4506ms.
[18:15:14.821] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[18:15:19.306] <TB2> INFO: Test took 4485ms.
[18:15:19.368] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[18:15:23.851] <TB2> INFO: Test took 4483ms.
[18:15:23.918] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[18:15:28.394] <TB2> INFO: Test took 4476ms.
[18:15:28.459] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[18:15:32.925] <TB2> INFO: Test took 4466ms.
[18:15:32.980] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[18:15:37.444] <TB2> INFO: Test took 4464ms.
[18:15:37.946] <TB2> INFO: PixTestGainPedestal::measure() done
[18:16:10.257] <TB2> INFO: PixTestGainPedestal::fit() done
[18:16:10.257] <TB2> INFO: non-linearity mean: 0.960 0.956 0.960 0.950 0.951 0.961 0.952 0.968 0.963 0.972 0.957 0.964 0.969 0.962 0.958 0.958
[18:16:10.257] <TB2> INFO: non-linearity RMS: 0.006 0.006 0.006 0.007 0.007 0.006 0.008 0.004 0.005 0.004 0.006 0.005 0.004 0.005 0.007 0.008
[18:16:10.257] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[18:16:10.289] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[18:16:10.309] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[18:16:10.329] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[18:16:10.349] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[18:16:10.371] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[18:16:10.392] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[18:16:10.414] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[18:16:10.436] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[18:16:10.455] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[18:16:10.475] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[18:16:10.494] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[18:16:10.514] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[18:16:10.533] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[18:16:10.554] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[18:16:10.573] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2058_FullQualification_2015-08-04_13h03m_1438686194//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[18:16:10.593] <TB2> INFO: PixTestGainPedestal::doTest() done, duration: 165 seconds
[18:16:10.599] <TB2> INFO: enter test to run
[18:16:10.600] <TB2> INFO: test: exit no parameter change
[18:16:11.017] <TB2> QUIET: Connection to board 156 closed.
[18:16:11.032] <TB2> INFO: pXar: this is the end, my friend