[14:44:33.302] <TB3> INFO: *** Welcome to pxar ***
[14:44:33.302] <TB3> INFO: *** Today: 2015/07/08
[14:44:33.303] <TB3> INFO: readRocDacs: /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C15.dat
[14:44:33.304] <TB3> INFO: readTbmDacs: /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//tbmParameters_C0b.dat
[14:44:33.304] <TB3> INFO: readMaskFile: /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//defaultMaskFile.dat
[14:44:33.304] <TB3> INFO: readTrimFile: /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters_C15.dat
[14:44:33.376] <TB3> INFO: clk: 4
[14:44:33.376] <TB3> INFO: ctr: 4
[14:44:33.376] <TB3> INFO: sda: 19
[14:44:33.376] <TB3> INFO: tin: 9
[14:44:33.376] <TB3> INFO: level: 15
[14:44:33.376] <TB3> INFO: triggerdelay: 0
[14:44:33.376] <TB3> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[14:44:33.376] <TB3> INFO: Log level: INFO
[14:44:33.383] <TB3> INFO: Found DTB DTB_WZ4I6J
[14:44:33.391] <TB3> QUIET: Connection to board DTB_WZ4I6J opened.
[14:44:33.395] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 170
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WZ4I6J
MAC address: 40D8551180AA
Hostname: pixelDTB170
Comment:
------------------------------------------------------
[14:44:33.397] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[14:44:34.953] <TB3> INFO: DUT info:
[14:44:34.953] <TB3> INFO: The DUT currently contains the following objects:
[14:44:34.953] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[14:44:34.953] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:44:34.953] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:44:34.953] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:44:34.953] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:34.953] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:44:35.355] <TB3> INFO: enter 'restricted' command line mode
[14:44:35.355] <TB3> INFO: enter test to run
[14:44:35.355] <TB3> INFO: test: pretest no parameter change
[14:44:35.355] <TB3> INFO: running: pretest
[14:44:35.362] <TB3> INFO: ######################################################################
[14:44:35.362] <TB3> INFO: PixTestPretest::doTest()
[14:44:35.362] <TB3> INFO: ######################################################################
[14:44:35.364] <TB3> INFO: ----------------------------------------------------------------------
[14:44:35.364] <TB3> INFO: PixTestPretest::programROC()
[14:44:35.364] <TB3> INFO: ----------------------------------------------------------------------
[14:44:53.381] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[14:44:53.381] <TB3> INFO: IA differences per ROC: 18.5 17.7 16.9 18.5 16.9 20.1 18.5 17.7 18.5 17.7 18.5 17.7 18.5 18.5 20.1 18.5
[14:44:53.462] <TB3> INFO: ----------------------------------------------------------------------
[14:44:53.462] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[14:44:53.462] <TB3> INFO: ----------------------------------------------------------------------
[14:45:01.063] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 385.1 mA = 24.0688 mA/ROC
[14:45:01.066] <TB3> INFO: ----------------------------------------------------------------------
[14:45:01.066] <TB3> INFO: PixTestPretest::findWorkingPixel()
[14:45:01.066] <TB3> INFO: ----------------------------------------------------------------------
[14:45:09.338] <TB3> INFO: Test took 8267ms.
[14:45:09.640] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[14:45:09.680] <TB3> INFO: ----------------------------------------------------------------------
[14:45:09.680] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[14:45:09.680] <TB3> INFO: ----------------------------------------------------------------------
[14:45:17.873] <TB3> INFO: Test took 8187ms.
[14:45:18.172] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[14:45:18.172] <TB3> INFO: CalDel: 135 124 138 148 138 155 118 129 133 128 128 125 142 129 131 131
[14:45:18.172] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[14:45:18.175] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C0.dat
[14:45:18.175] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C1.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C2.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C3.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C4.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C5.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C6.dat
[14:45:18.176] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C7.dat
[14:45:18.177] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C8.dat
[14:45:18.177] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C9.dat
[14:45:18.177] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C10.dat
[14:45:18.177] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C11.dat
[14:45:18.177] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C12.dat
[14:45:18.178] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C13.dat
[14:45:18.178] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C14.dat
[14:45:18.178] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters_C15.dat
[14:45:18.178] <TB3> INFO: PixTestPretest::doTest() done, duration: 42 seconds
[14:45:18.273] <TB3> INFO: enter test to run
[14:45:18.273] <TB3> INFO: test: fulltest no parameter change
[14:45:18.273] <TB3> INFO: running: fulltest
[14:45:18.273] <TB3> INFO: ######################################################################
[14:45:18.273] <TB3> INFO: PixTestFullTest::doTest()
[14:45:18.273] <TB3> INFO: ######################################################################
[14:45:18.274] <TB3> INFO: ######################################################################
[14:45:18.275] <TB3> INFO: PixTestAlive::doTest()
[14:45:18.275] <TB3> INFO: ######################################################################
[14:45:18.276] <TB3> INFO: ----------------------------------------------------------------------
[14:45:18.276] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:45:18.276] <TB3> INFO: ----------------------------------------------------------------------
[14:45:21.657] <TB3> INFO: Test took 3379ms.
[14:45:21.681] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:45:21.911] <TB3> INFO: PixTestAlive::aliveTest() done
[14:45:21.911] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:45:21.913] <TB3> INFO: ----------------------------------------------------------------------
[14:45:21.913] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:45:21.913] <TB3> INFO: ----------------------------------------------------------------------
[14:45:24.649] <TB3> INFO: Test took 2735ms.
[14:45:24.652] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:45:24.652] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:45:24.882] <TB3> INFO: PixTestAlive::maskTest() done
[14:45:24.882] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:45:24.884] <TB3> INFO: ----------------------------------------------------------------------
[14:45:24.884] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:45:24.884] <TB3> INFO: ----------------------------------------------------------------------
[14:45:28.342] <TB3> INFO: Test took 3457ms.
[14:45:28.364] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:45:28.595] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:45:28.595] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:45:28.596] <TB3> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[14:45:28.610] <TB3> INFO: ######################################################################
[14:45:28.610] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[14:45:28.610] <TB3> INFO: ######################################################################
[14:45:28.613] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (30) hits flags = 2 (plus default)
[14:45:28.624] <TB3> INFO: dacScan step from 0 .. 29
[14:45:49.965] <TB3> INFO: Test took 21340ms.
[14:45:49.997] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:45:49.999] <TB3> INFO: dacScan step from 30 .. 59
[14:46:12.531] <TB3> INFO: Test took 22532ms.
[14:46:12.611] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:46:12.622] <TB3> INFO: dacScan step from 60 .. 89
[14:46:41.428] <TB3> INFO: Test took 28806ms.
[14:46:41.738] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:46:41.813] <TB3> INFO: dacScan step from 90 .. 119
[14:47:10.223] <TB3> INFO: Test took 28410ms.
[14:47:10.628] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:10.706] <TB3> INFO: dacScan step from 120 .. 149
[14:47:35.189] <TB3> INFO: Test took 24483ms.
[14:47:35.388] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:58.867] <TB3> INFO: PixTestBBMap::doTest() done, duration: 150 seconds
[14:47:58.867] <TB3> INFO: number of dead bumps (per ROC): 5 0 0 0 0 0 0 0 0 0 0 10 2 0 5 10
[14:47:58.867] <TB3> INFO: separation cut (per ROC): 95 81 72 77 82 90 93 88 89 86 96 96 98 98 95 99
[14:47:58.957] <TB3> INFO: ######################################################################
[14:47:58.957] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50
[14:47:58.957] <TB3> INFO: ######################################################################
[14:47:58.957] <TB3> INFO: ----------------------------------------------------------------------
[14:47:58.957] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50
[14:47:58.957] <TB3> INFO: ----------------------------------------------------------------------
[14:47:58.957] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 0 .. 149 (4) hits flags = 16 (plus default)
[14:47:58.966] <TB3> INFO: dacScan step from 0 .. 3
[14:48:16.229] <TB3> INFO: Test took 17263ms.
[14:48:16.254] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:16.254] <TB3> INFO: dacScan step from 4 .. 7
[14:48:35.011] <TB3> INFO: Test took 18756ms.
[14:48:35.040] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:35.041] <TB3> INFO: dacScan step from 8 .. 11
[14:48:53.880] <TB3> INFO: Test took 18839ms.
[14:48:53.905] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:53.909] <TB3> INFO: dacScan step from 12 .. 15
[14:49:12.702] <TB3> INFO: Test took 18792ms.
[14:49:12.730] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:12.730] <TB3> INFO: dacScan step from 16 .. 19
[14:49:31.285] <TB3> INFO: Test took 18555ms.
[14:49:31.312] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:31.312] <TB3> INFO: dacScan step from 20 .. 23
[14:49:50.226] <TB3> INFO: Test took 18914ms.
[14:49:50.256] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:50.256] <TB3> INFO: dacScan step from 24 .. 27
[14:50:09.125] <TB3> INFO: Test took 18869ms.
[14:50:09.152] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:50:09.152] <TB3> INFO: dacScan step from 28 .. 31
[14:50:27.946] <TB3> INFO: Test took 18794ms.
[14:50:27.974] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:50:27.974] <TB3> INFO: dacScan step from 32 .. 35
[14:50:46.871] <TB3> INFO: Test took 18897ms.
[14:50:46.903] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:50:46.903] <TB3> INFO: dacScan step from 36 .. 39
[14:51:05.621] <TB3> INFO: Test took 18718ms.
[14:51:05.656] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:05.656] <TB3> INFO: dacScan step from 40 .. 43
[14:51:24.437] <TB3> INFO: Test took 18780ms.
[14:51:24.467] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:24.468] <TB3> INFO: dacScan step from 44 .. 47
[14:51:43.238] <TB3> INFO: Test took 18770ms.
[14:51:43.266] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:43.266] <TB3> INFO: dacScan step from 48 .. 51
[14:52:02.139] <TB3> INFO: Test took 18873ms.
[14:52:02.164] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:52:02.164] <TB3> INFO: dacScan step from 52 .. 55
[14:52:21.029] <TB3> INFO: Test took 18865ms.
[14:52:21.062] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:52:21.062] <TB3> INFO: dacScan step from 56 .. 59
[14:52:39.872] <TB3> INFO: Test took 18810ms.
[14:52:39.902] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:52:39.902] <TB3> INFO: dacScan step from 60 .. 63
[14:52:58.760] <TB3> INFO: Test took 18858ms.
[14:52:58.790] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:52:58.790] <TB3> INFO: dacScan step from 64 .. 67
[14:53:17.592] <TB3> INFO: Test took 18802ms.
[14:53:17.621] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:17.621] <TB3> INFO: dacScan step from 68 .. 71
[14:53:36.431] <TB3> INFO: Test took 18810ms.
[14:53:36.462] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:36.462] <TB3> INFO: dacScan step from 72 .. 75
[14:53:55.350] <TB3> INFO: Test took 18887ms.
[14:53:55.384] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:55.384] <TB3> INFO: dacScan step from 76 .. 79
[14:54:14.440] <TB3> INFO: Test took 19056ms.
[14:54:14.493] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:14.494] <TB3> INFO: dacScan step from 80 .. 83
[14:54:35.089] <TB3> INFO: Test took 20595ms.
[14:54:35.167] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:35.170] <TB3> INFO: dacScan step from 84 .. 87
[14:54:57.244] <TB3> INFO: Test took 22074ms.
[14:54:57.352] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:57.357] <TB3> INFO: dacScan step from 88 .. 91
[14:55:20.959] <TB3> INFO: Test took 23602ms.
[14:55:21.112] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:55:21.118] <TB3> INFO: dacScan step from 92 .. 95
[14:55:47.253] <TB3> INFO: Test took 26135ms.
[14:55:47.532] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:55:47.548] <TB3> INFO: dacScan step from 96 .. 99
[14:56:15.426] <TB3> INFO: Test took 27877ms.
[14:56:15.659] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:56:15.670] <TB3> INFO: dacScan step from 100 .. 103



[14:56:44.139] <TB3> INFO: Test took 28469ms.
[14:56:44.417] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:56:44.434] <TB3> INFO: dacScan step from 104 .. 107






[14:57:13.673] <TB3> INFO: Test took 29239ms.
[14:57:13.925] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:57:13.942] <TB3> INFO: dacScan step from 108 .. 111




[14:57:43.080] <TB3> INFO: Test took 29138ms.
[14:57:43.314] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:57:43.326] <TB3> INFO: dacScan step from 112 .. 115



[14:58:12.579] <TB3> INFO: Test took 29253ms.
[14:58:12.819] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:58:12.832] <TB3> INFO: dacScan step from 116 .. 119
[14:58:41.923] <TB3> INFO: Test took 29091ms.
[14:58:42.163] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:58:42.174] <TB3> INFO: dacScan step from 120 .. 123



[14:59:11.428] <TB3> INFO: Test took 29254ms.
[14:59:11.692] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:59:11.705] <TB3> INFO: dacScan step from 124 .. 127



[14:59:41.018] <TB3> INFO: Test took 29313ms.
[14:59:41.255] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:59:41.268] <TB3> INFO: dacScan step from 128 .. 131






[15:00:10.328] <TB3> INFO: Test took 29060ms.
[15:00:10.547] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:00:10.558] <TB3> INFO: dacScan step from 132 .. 135
[15:00:39.681] <TB3> INFO: Test took 29122ms.
[15:00:39.916] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:00:39.932] <TB3> INFO: dacScan step from 136 .. 139
[15:01:08.937] <TB3> INFO: Test took 29005ms.
[15:01:09.179] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:01:09.192] <TB3> INFO: dacScan step from 140 .. 143
[15:01:38.332] <TB3> INFO: Test took 29140ms.
[15:01:38.565] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:01:38.577] <TB3> INFO: dacScan step from 144 .. 147
[15:02:07.458] <TB3> INFO: Test took 28880ms.
[15:02:07.680] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:02:07.693] <TB3> INFO: dacScan step from 148 .. 149
[15:02:23.568] <TB3> INFO: Test took 15875ms.
[15:02:23.699] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:02:23.710] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:25.476] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:27.073] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:28.681] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:30.265] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:31.857] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:33.615] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:35.016] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:36.421] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:38.030] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:39.688] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:41.064] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:42.493] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:43.908] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:45.359] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:46.759] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[15:02:48.239] <TB3> INFO: PixTestScurves::scurves() done
[15:02:48.239] <TB3> INFO: Vcal mean: 95.05 84.84 81.79 95.65 88.55 99.09 94.49 94.47 87.05 90.02 95.72 91.89 94.53 95.41 93.32 98.56
[15:02:48.239] <TB3> INFO: Vcal RMS: 6.71 4.63 4.27 7.46 4.96 7.65 5.54 5.50 5.55 5.02 6.25 5.58 5.48 6.10 5.19 5.94
[15:02:48.239] <TB3> INFO: PixTestScurves::fullTest() done, duration: 889 seconds
[15:02:48.313] <TB3> INFO: ######################################################################
[15:02:48.313] <TB3> INFO: PixTestTrim::doTest()
[15:02:48.313] <TB3> INFO: ######################################################################
[15:02:48.315] <TB3> INFO: ----------------------------------------------------------------------
[15:02:48.315] <TB3> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[15:02:48.315] <TB3> INFO: ----------------------------------------------------------------------
[15:02:48.399] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[15:02:48.400] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 5 dacrange: 0 .. 159 (20) hits flags = 16 (plus default)
[15:02:48.407] <TB3> INFO: dacScan step from 0 .. 19
[15:03:03.506] <TB3> INFO: Test took 15099ms.
[15:03:03.528] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:03:03.528] <TB3> INFO: dacScan step from 20 .. 39
[15:03:18.655] <TB3> INFO: Test took 15126ms.
[15:03:18.678] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:03:18.678] <TB3> INFO: dacScan step from 40 .. 59
[15:03:33.682] <TB3> INFO: Test took 15004ms.
[15:03:33.707] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:03:33.707] <TB3> INFO: dacScan step from 60 .. 79
[15:03:48.802] <TB3> INFO: Test took 15095ms.
[15:03:48.826] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:03:48.826] <TB3> INFO: dacScan step from 80 .. 99
[15:04:04.224] <TB3> INFO: Test took 15398ms.
[15:04:04.276] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:04:04.280] <TB3> INFO: dacScan step from 100 .. 119
[15:04:23.204] <TB3> INFO: Test took 18923ms.
[15:04:23.360] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:04:23.397] <TB3> INFO: dacScan step from 120 .. 139
[15:04:42.722] <TB3> INFO: Test took 19325ms.
[15:04:42.881] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:04:42.920] <TB3> INFO: dacScan step from 140 .. 159
[15:04:59.069] <TB3> INFO: Test took 16149ms.
[15:04:59.143] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:05:21.960] <TB3> INFO: ROC 0 VthrComp = 94
[15:05:21.960] <TB3> INFO: ROC 1 VthrComp = 89
[15:05:21.961] <TB3> INFO: ROC 2 VthrComp = 87
[15:05:21.961] <TB3> INFO: ROC 3 VthrComp = 92
[15:05:21.961] <TB3> INFO: ROC 4 VthrComp = 92
[15:05:21.961] <TB3> INFO: ROC 5 VthrComp = 96
[15:05:21.961] <TB3> INFO: ROC 6 VthrComp = 99
[15:05:21.961] <TB3> INFO: ROC 7 VthrComp = 97
[15:05:21.961] <TB3> INFO: ROC 8 VthrComp = 90
[15:05:21.961] <TB3> INFO: ROC 9 VthrComp = 92
[15:05:21.961] <TB3> INFO: ROC 10 VthrComp = 96
[15:05:21.961] <TB3> INFO: ROC 11 VthrComp = 94
[15:05:21.962] <TB3> INFO: ROC 12 VthrComp = 99
[15:05:21.962] <TB3> INFO: ROC 13 VthrComp = 98
[15:05:21.962] <TB3> INFO: ROC 14 VthrComp = 97
[15:05:21.962] <TB3> INFO: ROC 15 VthrComp = 99
[15:05:21.962] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[15:05:21.962] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 5 dacrange: 0 .. 159 (20) hits flags = 16 (plus default)
[15:05:21.970] <TB3> INFO: dacScan step from 0 .. 19
[15:05:36.886] <TB3> INFO: Test took 14916ms.
[15:05:36.908] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:05:36.908] <TB3> INFO: dacScan step from 20 .. 39
[15:05:51.349] <TB3> INFO: Test took 14441ms.
[15:05:51.386] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:05:51.390] <TB3> INFO: dacScan step from 40 .. 59
[15:06:09.874] <TB3> INFO: Test took 18484ms.
[15:06:10.037] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:06:10.077] <TB3> INFO: dacScan step from 60 .. 79
[15:06:30.397] <TB3> INFO: Test took 20320ms.
[15:06:30.572] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:06:30.632] <TB3> INFO: dacScan step from 80 .. 99
[15:06:50.805] <TB3> INFO: Test took 20173ms.
[15:06:50.979] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:06:51.033] <TB3> INFO: dacScan step from 100 .. 119
[15:07:11.193] <TB3> INFO: Test took 20160ms.
[15:07:11.402] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:07:11.471] <TB3> INFO: dacScan step from 120 .. 139
[15:07:31.618] <TB3> INFO: Test took 20147ms.
[15:07:31.783] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:07:31.847] <TB3> INFO: dacScan step from 140 .. 159
[15:07:51.871] <TB3> INFO: Test took 20024ms.
[15:07:52.044] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:08:18.079] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 62.2881 for pixel 0/33 mean/min/max = 47.1847/31.8493/62.52
[15:08:18.079] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 56.6344 for pixel 20/79 mean/min/max = 45.451/34.2592/56.6428
[15:08:18.079] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 56.2366 for pixel 13/1 mean/min/max = 44.1763/31.9738/56.3788
[15:08:18.080] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 64.5407 for pixel 18/0 mean/min/max = 48.2841/31.9577/64.6104
[15:08:18.080] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 57.2205 for pixel 4/79 mean/min/max = 45.3655/33.4206/57.3105
[15:08:18.080] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 65.136 for pixel 4/74 mean/min/max = 47.9271/30.6174/65.2368
[15:08:18.080] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 56.5533 for pixel 36/75 mean/min/max = 44.3508/32.0258/56.6757
[15:08:18.081] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 58.1204 for pixel 5/35 mean/min/max = 45.2783/32.3066/58.2499
[15:08:18.081] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 59.7781 for pixel 10/2 mean/min/max = 46.8164/33.8529/59.7799
[15:08:18.081] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 57.1262 for pixel 7/16 mean/min/max = 45.4845/33.5784/57.3906
[15:08:18.082] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 61.2385 for pixel 2/74 mean/min/max = 46.3169/31.3511/61.2827
[15:08:18.082] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 59.2752 for pixel 3/0 mean/min/max = 45.6782/32.0689/59.2875
[15:08:18.082] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 58.7498 for pixel 2/0 mean/min/max = 45.1863/31.6138/58.7587
[15:08:18.083] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 60.5832 for pixel 19/77 mean/min/max = 45.6503/30.5664/60.7341
[15:08:18.083] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 58.0916 for pixel 20/79 mean/min/max = 44.7512/31.3896/58.1129
[15:08:18.083] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 60.974 for pixel 0/25 mean/min/max = 46.1099/31.1257/61.0942
[15:08:18.083] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:51.373] <TB3> INFO: Test took 93290ms.
[15:09:52.848] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 199 (20) hits flags = 16 (plus default)
[15:09:52.856] <TB3> INFO: dacScan step from 0 .. 19
[15:10:15.627] <TB3> INFO: Test took 22771ms.
[15:10:15.676] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:10:15.677] <TB3> INFO: dacScan step from 20 .. 39
[15:10:44.222] <TB3> INFO: Test took 28545ms.
[15:10:44.459] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:10:44.494] <TB3> INFO: dacScan step from 40 .. 59
[15:11:17.628] <TB3> INFO: Test took 33133ms.
[15:11:17.920] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:11:17.977] <TB3> INFO: dacScan step from 60 .. 79






[15:11:50.488] <TB3> INFO: Test took 32511ms.
[15:11:50.904] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:11:50.964] <TB3> INFO: dacScan step from 80 .. 99



[15:12:22.740] <TB3> INFO: Test took 31776ms.
[15:12:23.030] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:12:23.089] <TB3> INFO: dacScan step from 100 .. 119


[15:12:56.337] <TB3> INFO: Test took 33248ms.
[15:12:56.616] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:12:56.674] <TB3> INFO: dacScan step from 120 .. 139




[15:13:29.871] <TB3> INFO: Test took 33197ms.
[15:13:30.142] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:13:30.198] <TB3> INFO: dacScan step from 140 .. 159




[15:14:03.051] <TB3> INFO: Test took 32853ms.
[15:14:03.330] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:03.394] <TB3> INFO: dacScan step from 160 .. 179



[15:14:36.755] <TB3> INFO: Test took 33360ms.
[15:14:37.042] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:37.095] <TB3> INFO: dacScan step from 180 .. 199



[15:15:10.975] <TB3> INFO: Test took 33879ms.
[15:15:11.275] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:15:38.287] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 0.063158 .. 255.000000
[15:15:38.370] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 4 dacrange: 0 .. 255 (20) hits flags = 16 (plus default)
[15:15:38.378] <TB3> INFO: dacScan step from 0 .. 19
[15:15:51.974] <TB3> INFO: Test took 13596ms.
[15:15:52.004] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:15:52.004] <TB3> INFO: dacScan step from 20 .. 39
[15:16:06.899] <TB3> INFO: Test took 14895ms.
[15:16:06.981] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:06.998] <TB3> INFO: dacScan step from 40 .. 59
[15:16:24.609] <TB3> INFO: Test took 17611ms.
[15:16:24.771] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:24.826] <TB3> INFO: dacScan step from 60 .. 79
[15:16:42.496] <TB3> INFO: Test took 17670ms.
[15:16:42.637] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:42.693] <TB3> INFO: dacScan step from 80 .. 99
[15:17:00.343] <TB3> INFO: Test took 17650ms.
[15:17:00.493] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:17:00.548] <TB3> INFO: dacScan step from 100 .. 119
[15:17:18.261] <TB3> INFO: Test took 17712ms.
[15:17:18.403] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:17:18.455] <TB3> INFO: dacScan step from 120 .. 139
[15:17:36.181] <TB3> INFO: Test took 17726ms.
[15:17:36.332] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:17:36.388] <TB3> INFO: dacScan step from 140 .. 159
[15:17:54.070] <TB3> INFO: Test took 17682ms.
[15:17:54.227] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:17:54.285] <TB3> INFO: dacScan step from 160 .. 179
[15:18:12.131] <TB3> INFO: Test took 17846ms.
[15:18:12.281] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:12.341] <TB3> INFO: dacScan step from 180 .. 199
[15:18:30.887] <TB3> INFO: Test took 18546ms.
[15:18:31.071] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:31.157] <TB3> INFO: dacScan step from 200 .. 219
[15:18:48.887] <TB3> INFO: Test took 17730ms.
[15:18:49.028] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:49.093] <TB3> INFO: dacScan step from 220 .. 239
[15:19:06.650] <TB3> INFO: Test took 17556ms.
[15:19:06.822] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:19:06.886] <TB3> INFO: dacScan step from 240 .. 255
[15:19:21.629] <TB3> INFO: Test took 14743ms.
[15:19:21.755] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:19:54.328] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 14.112666 .. 45.398941
[15:19:54.421] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 4 dacrange: 4 .. 55 (20) hits flags = 16 (plus default)
[15:19:54.429] <TB3> INFO: dacScan step from 4 .. 23
[15:20:07.974] <TB3> INFO: Test took 13545ms.
[15:20:07.995] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:20:07.995] <TB3> INFO: dacScan step from 24 .. 43
[15:20:22.657] <TB3> INFO: Test took 14662ms.
[15:20:22.764] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:20:22.793] <TB3> INFO: dacScan step from 44 .. 55
[15:20:33.824] <TB3> INFO: Test took 11031ms.
[15:20:33.916] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:20:51.678] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 20.055034 .. 42.198762
[15:20:51.773] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 4 dacrange: 10 .. 52 (20) hits flags = 16 (plus default)
[15:20:51.783] <TB3> INFO: dacScan step from 10 .. 29
[15:21:05.437] <TB3> INFO: Test took 13654ms.
[15:21:05.459] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:05.459] <TB3> INFO: dacScan step from 30 .. 49
[15:21:22.196] <TB3> INFO: Test took 16737ms.
[15:21:22.347] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:22.389] <TB3> INFO: dacScan step from 50 .. 52
[15:21:27.483] <TB3> INFO: Test took 5094ms.
[15:21:27.507] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:43.717] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 2.790106 .. 69.829893
[15:21:43.797] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 4 dacrange: 2 .. 79 (20) hits flags = 16 (plus default)
[15:21:43.805] <TB3> INFO: dacScan step from 2 .. 21
[15:21:56.807] <TB3> INFO: Test took 13002ms.
[15:21:56.825] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:56.825] <TB3> INFO: dacScan step from 22 .. 41
[15:22:11.876] <TB3> INFO: Test took 15050ms.
[15:22:11.988] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:12.009] <TB3> INFO: dacScan step from 42 .. 61
[15:22:28.897] <TB3> INFO: Test took 16888ms.
[15:22:29.039] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:29.102] <TB3> INFO: dacScan step from 62 .. 79
[15:22:44.173] <TB3> INFO: Test took 15070ms.
[15:22:44.299] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:03.874] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[15:23:03.874] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (20) hits flags = 16 (plus default)
[15:23:03.885] <TB3> INFO: dacScan step from 15 .. 34
[15:23:27.159] <TB3> INFO: Test took 23274ms.
[15:23:27.231] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:27.241] <TB3> INFO: dacScan step from 35 .. 54



[15:23:57.413] <TB3> INFO: Test took 30172ms.
[15:23:57.794] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:57.852] <TB3> INFO: dacScan step from 55 .. 55
[15:24:02.031] <TB3> INFO: Test took 4179ms.
[15:24:02.046] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:15.741] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C0.dat
[15:24:15.741] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C1.dat
[15:24:15.741] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C2.dat
[15:24:15.742] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C3.dat
[15:24:15.742] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C4.dat
[15:24:15.742] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C5.dat
[15:24:15.742] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C6.dat
[15:24:15.742] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C7.dat
[15:24:15.743] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C8.dat
[15:24:15.743] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C9.dat
[15:24:15.743] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C10.dat
[15:24:15.743] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C11.dat
[15:24:15.744] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C12.dat
[15:24:15.744] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C13.dat
[15:24:15.744] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C14.dat
[15:24:15.744] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C15.dat
[15:24:15.745] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C0.dat
[15:24:15.755] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C1.dat
[15:24:15.761] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C2.dat
[15:24:15.767] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C3.dat
[15:24:15.773] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C4.dat
[15:24:15.779] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C5.dat
[15:24:15.785] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C6.dat
[15:24:15.791] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C7.dat
[15:24:15.796] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C8.dat
[15:24:15.805] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C9.dat
[15:24:15.811] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C10.dat
[15:24:15.821] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C11.dat
[15:24:15.831] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C12.dat
[15:24:15.840] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C13.dat
[15:24:15.850] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C14.dat
[15:24:15.860] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//trimParameters35_C15.dat
[15:24:15.870] <TB3> INFO: PixTestTrim::trimTest() done
[15:24:15.870] <TB3> INFO: vtrim: 115 97 105 126 102 133 115 109 106 106 119 114 116 114 114 119
[15:24:15.870] <TB3> INFO: vthrcomp: 94 89 87 92 92 96 99 97 90 92 96 94 99 98 97 99
[15:24:15.870] <TB3> INFO: vcal mean: 35.12 35.04 35.09 35.07 35.07 35.12 35.11 35.05 35.06 35.05 35.07 35.08 35.08 34.73 35.08 35.07
[15:24:15.870] <TB3> INFO: vcal RMS: 1.08 0.97 1.08 1.16 1.01 1.18 1.05 1.04 1.09 0.98 1.09 1.04 1.01 1.03 1.07 1.15
[15:24:15.870] <TB3> INFO: bits mean: 9.51 9.32 10.46 9.48 9.64 9.81 10.55 9.81 9.22 9.74 9.82 10.00 10.39 9.75 10.13 9.84
[15:24:15.870] <TB3> INFO: bits RMS: 2.64 2.43 2.36 2.45 2.48 2.52 2.29 2.58 2.56 2.41 2.67 2.50 2.36 2.73 2.58 2.67
[15:24:15.875] <TB3> INFO: ----------------------------------------------------------------------
[15:24:15.875] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 10, vtrims = 254 240 150 100
[15:24:15.875] <TB3> INFO: ----------------------------------------------------------------------
[15:24:15.879] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 10 dacrange: 0 .. 199 (20) hits flags = 16 (plus default)
[15:24:15.891] <TB3> INFO: dacScan step from 0 .. 19
[15:24:38.590] <TB3> INFO: Test took 22698ms.
[15:24:38.630] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:24:38.630] <TB3> INFO: dacScan step from 20 .. 39
[15:25:00.405] <TB3> INFO: Test took 21775ms.
[15:25:00.465] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:00.468] <TB3> INFO: dacScan step from 40 .. 59
[15:25:30.679] <TB3> INFO: Test took 30211ms.
[15:25:30.944] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:30.982] <TB3> INFO: dacScan step from 60 .. 79
[15:26:04.031] <TB3> INFO: Test took 33049ms.
[15:26:04.296] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:04.341] <TB3> INFO: dacScan step from 80 .. 99
[15:26:36.066] <TB3> INFO: Test took 31725ms.
[15:26:36.333] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:36.381] <TB3> INFO: dacScan step from 100 .. 119
[15:27:09.303] <TB3> INFO: Test took 32922ms.
[15:27:09.587] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:09.642] <TB3> INFO: dacScan step from 120 .. 139
[15:27:42.495] <TB3> INFO: Test took 32853ms.
[15:27:42.781] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:27:42.837] <TB3> INFO: dacScan step from 140 .. 159
[15:28:15.734] <TB3> INFO: Test took 32897ms.
[15:28:16.025] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:16.080] <TB3> INFO: dacScan step from 160 .. 179
[15:28:49.031] <TB3> INFO: Test took 32951ms.
[15:28:49.343] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:49.405] <TB3> INFO: dacScan step from 180 .. 199
[15:29:21.269] <TB3> INFO: Test took 31864ms.
[15:29:21.715] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:46.769] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 10 dacrange: 0 .. 84 (20) hits flags = 16 (plus default)
[15:29:46.777] <TB3> INFO: dacScan step from 0 .. 19
[15:30:09.378] <TB3> INFO: Test took 22601ms.
[15:30:09.415] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:09.415] <TB3> INFO: dacScan step from 20 .. 39
[15:30:33.080] <TB3> INFO: Test took 23665ms.
[15:30:33.172] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:33.181] <TB3> INFO: dacScan step from 40 .. 59
[15:31:04.675] <TB3> INFO: Test took 31493ms.
[15:31:05.033] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:05.076] <TB3> INFO: dacScan step from 60 .. 79




[15:31:37.970] <TB3> INFO: Test took 32894ms.
[15:31:38.415] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:38.478] <TB3> INFO: dacScan step from 80 .. 84
[15:31:48.069] <TB3> INFO: Test took 9591ms.
[15:31:48.133] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:05.928] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 10 dacrange: 0 .. 77 (20) hits flags = 16 (plus default)
[15:32:05.938] <TB3> INFO: dacScan step from 0 .. 19
[15:32:27.396] <TB3> INFO: Test took 21458ms.
[15:32:27.431] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:27.432] <TB3> INFO: dacScan step from 20 .. 39
[15:32:51.479] <TB3> INFO: Test took 24047ms.
[15:32:51.607] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:51.622] <TB3> INFO: dacScan step from 40 .. 59
[15:33:23.968] <TB3> INFO: Test took 32345ms.
[15:33:24.311] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:24.362] <TB3> INFO: dacScan step from 60 .. 77
[15:33:53.586] <TB3> INFO: Test took 29224ms.
[15:33:53.820] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:09.974] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 10 dacrange: 0 .. 74 (20) hits flags = 16 (plus default)
[15:34:09.982] <TB3> INFO: dacScan step from 0 .. 19
[15:34:32.287] <TB3> INFO: Test took 22305ms.
[15:34:32.325] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:32.325] <TB3> INFO: dacScan step from 20 .. 39
[15:34:58.100] <TB3> INFO: Test took 25775ms.
[15:34:58.278] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:58.301] <TB3> INFO: dacScan step from 40 .. 59



[15:35:28.757] <TB3> INFO: Test took 30456ms.
[15:35:29.049] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:29.097] <TB3> INFO: dacScan step from 60 .. 74
[15:35:53.188] <TB3> INFO: Test took 24091ms.
[15:35:53.387] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:09.847] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 10 dacrange: 0 .. 71 (20) hits flags = 16 (plus default)
[15:36:09.866] <TB3> INFO: dacScan step from 0 .. 19
[15:36:31.023] <TB3> INFO: Test took 21157ms.
[15:36:31.074] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:31.075] <TB3> INFO: dacScan step from 20 .. 39
[15:36:58.617] <TB3> INFO: Test took 27541ms.
[15:36:58.821] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:58.846] <TB3> INFO: dacScan step from 40 .. 59



[15:37:31.136] <TB3> INFO: Test took 32290ms.
[15:37:31.412] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:31.463] <TB3> INFO: dacScan step from 60 .. 71
[15:37:51.593] <TB3> INFO: Test took 20130ms.
[15:37:51.756] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:08.038] <TB3> INFO: PixTestTrim::trimBitTest() done
[15:38:08.039] <TB3> INFO: PixTestTrim::doTest() done, duration: 2119 seconds
[15:38:08.730] <TB3> INFO: ######################################################################
[15:38:08.730] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[15:38:08.730] <TB3> INFO: ######################################################################
[15:38:12.166] <TB3> INFO: Test took 3434ms.
[15:38:12.184] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:15.662] <TB3> INFO: Test took 3282ms.
[15:38:15.744] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:19.046] <TB3> INFO: Test took 3290ms.
[15:38:19.121] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:19.128] <TB3> INFO: The DUT currently contains the following objects:
[15:38:19.128] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:19.128] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:19.128] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:19.128] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:19.128] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:19.128] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.230] <TB3> INFO: Test took 1102ms.
[15:38:20.230] <TB3> INFO: The DUT currently contains the following objects:
[15:38:20.230] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:20.230] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:20.230] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:20.230] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:20.230] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.230] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:20.231] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.333] <TB3> INFO: Test took 1102ms.
[15:38:21.334] <TB3> INFO: The DUT currently contains the following objects:
[15:38:21.334] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:21.334] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:21.334] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:21.334] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:21.334] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:21.334] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.435] <TB3> INFO: Test took 1101ms.
[15:38:22.435] <TB3> INFO: The DUT currently contains the following objects:
[15:38:22.436] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:22.436] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:22.436] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:22.436] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:22.436] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:22.436] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.539] <TB3> INFO: Test took 1103ms.
[15:38:23.540] <TB3> INFO: The DUT currently contains the following objects:
[15:38:23.540] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:23.540] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:23.540] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:23.540] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:23.540] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:23.540] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: Test took 1102ms.
[15:38:24.642] <TB3> INFO: The DUT currently contains the following objects:
[15:38:24.642] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:24.642] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:24.642] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:24.642] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:24.642] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:24.642] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.743] <TB3> INFO: Test took 1101ms.
[15:38:25.744] <TB3> INFO: The DUT currently contains the following objects:
[15:38:25.744] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:25.744] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:25.744] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:25.744] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:25.744] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:25.744] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: Test took 1102ms.
[15:38:26.846] <TB3> INFO: The DUT currently contains the following objects:
[15:38:26.846] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:26.846] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:26.846] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:26.846] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:26.846] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:26.846] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.948] <TB3> INFO: Test took 1102ms.
[15:38:27.949] <TB3> INFO: The DUT currently contains the following objects:
[15:38:27.949] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:27.949] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:27.949] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:27.949] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:27.949] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:27.949] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: Test took 1102ms.
[15:38:29.051] <TB3> INFO: The DUT currently contains the following objects:
[15:38:29.051] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:29.051] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:29.051] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:29.051] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:29.051] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.051] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.052] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.052] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:29.052] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.153] <TB3> INFO: Test took 1101ms.
[15:38:30.154] <TB3> INFO: The DUT currently contains the following objects:
[15:38:30.154] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:30.154] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:30.154] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:30.154] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:30.154] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:30.154] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: Test took 1102ms.
[15:38:31.256] <TB3> INFO: The DUT currently contains the following objects:
[15:38:31.256] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:31.256] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:31.256] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:31.256] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:31.256] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:31.256] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: Test took 1102ms.
[15:38:32.358] <TB3> INFO: The DUT currently contains the following objects:
[15:38:32.358] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:32.358] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:32.358] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:32.358] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:32.358] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:32.358] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.468] <TB3> INFO: Test took 1110ms.
[15:38:33.469] <TB3> INFO: The DUT currently contains the following objects:
[15:38:33.469] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:33.469] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:33.469] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:33.469] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:33.469] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.469] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.469] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.469] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:33.470] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.577] <TB3> INFO: Test took 1107ms.
[15:38:34.578] <TB3> INFO: The DUT currently contains the following objects:
[15:38:34.578] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:34.578] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:34.578] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:34.578] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:34.578] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.578] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:34.579] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.687] <TB3> INFO: Test took 1108ms.
[15:38:35.688] <TB3> INFO: The DUT currently contains the following objects:
[15:38:35.688] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:35.688] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:38:35.688] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:38:35.688] <TB3> INFO: 16 ROCs psi46digv21respin (1 ON) with 4160 pixelConfigs
[15:38:35.688] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:35.688] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 4159 masked, 1 active.
[15:38:36.798] <TB3> INFO: Test took 1109ms.
[15:38:36.802] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:42:20.900] <TB3> INFO: Test took 224098ms.
[15:42:22.623] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:10.212] <TB3> INFO: Test took 227589ms.
[15:46:11.678] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.686] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.693] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.701] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.708] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.716] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.723] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.729] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.737] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.744] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.751] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.758] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.765] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.771] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[15:46:11.778] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[15:46:11.785] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[15:46:11.792] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[15:46:11.798] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[15:46:11.805] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.812] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.818] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:11.879] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C0.dat
[15:46:11.880] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C1.dat
[15:46:11.888] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C2.dat
[15:46:11.890] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C3.dat
[15:46:11.890] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C4.dat
[15:46:11.891] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C5.dat
[15:46:11.891] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C6.dat
[15:46:11.899] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C7.dat
[15:46:11.905] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C8.dat
[15:46:11.905] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C9.dat
[15:46:11.905] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C10.dat
[15:46:11.905] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C11.dat
[15:46:11.906] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C12.dat
[15:46:11.906] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C13.dat
[15:46:11.906] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C14.dat
[15:46:11.910] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//dacParameters35_C15.dat
[15:46:15.513] <TB3> INFO: Test took 3601ms.
[15:46:19.249] <TB3> INFO: Test took 3441ms.
[15:46:22.932] <TB3> INFO: Test took 3415ms.
[15:46:23.206] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:24.126] <TB3> INFO: Test took 920ms.
[15:46:24.129] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:25.237] <TB3> INFO: Test took 1108ms.
[15:46:25.240] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:26.363] <TB3> INFO: Test took 1123ms.
[15:46:26.366] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:27.475] <TB3> INFO: Test took 1109ms.
[15:46:27.478] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:28.581] <TB3> INFO: Test took 1103ms.
[15:46:28.583] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:29.691] <TB3> INFO: Test took 1108ms.
[15:46:29.694] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:30.804] <TB3> INFO: Test took 1110ms.
[15:46:30.807] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:31.915] <TB3> INFO: Test took 1109ms.
[15:46:31.919] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:33.027] <TB3> INFO: Test took 1108ms.
[15:46:33.030] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:34.134] <TB3> INFO: Test took 1104ms.
[15:46:34.136] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:35.238] <TB3> INFO: Test took 1102ms.
[15:46:35.240] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:36.343] <TB3> INFO: Test took 1103ms.
[15:46:36.345] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:37.452] <TB3> INFO: Test took 1107ms.
[15:46:37.455] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:38.561] <TB3> INFO: Test took 1106ms.
[15:46:38.563] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:39.672] <TB3> INFO: Test took 1109ms.
[15:46:39.676] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:40.777] <TB3> INFO: Test took 1102ms.
[15:46:40.779] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:41.888] <TB3> INFO: Test took 1109ms.
[15:46:41.892] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:42.998] <TB3> INFO: Test took 1106ms.
[15:46:43.001] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:44.106] <TB3> INFO: Test took 1105ms.
[15:46:44.108] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:45.216] <TB3> INFO: Test took 1108ms.
[15:46:45.219] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:46.326] <TB3> INFO: Test took 1107ms.
[15:46:46.330] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:47.438] <TB3> INFO: Test took 1109ms.
[15:46:47.441] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:48.549] <TB3> INFO: Test took 1109ms.
[15:46:48.552] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:49.662] <TB3> INFO: Test took 1110ms.
[15:46:49.665] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:50.773] <TB3> INFO: Test took 1108ms.
[15:46:50.777] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:51.885] <TB3> INFO: Test took 1108ms.
[15:46:51.888] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:52.995] <TB3> INFO: Test took 1107ms.
[15:46:52.999] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:54.107] <TB3> INFO: Test took 1109ms.
[15:46:54.110] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:55.218] <TB3> INFO: Test took 1108ms.
[15:46:55.222] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:56.328] <TB3> INFO: Test took 1107ms.
[15:46:56.332] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:57.439] <TB3> INFO: Test took 1108ms.
[15:46:57.443] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:46:58.550] <TB3> INFO: Test took 1107ms.
[15:46:59.098] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 530 seconds
[15:46:59.098] <TB3> INFO: PH scale (per ROC): 78 78 78 63 76 71 80 77 79 65 73 75 75 78 79 70
[15:46:59.098] <TB3> INFO: PH offset (per ROC): 176 166 182 177 171 176 180 180 191 194 173 176 176 176 167 189
[15:46:59.300] <TB3> INFO: ######################################################################
[15:46:59.300] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[15:46:59.300] <TB3> INFO: ######################################################################
[15:46:59.311] <TB3> INFO: scanning low vcal = 50
[15:47:03.553] <TB3> INFO: Test took 4242ms.
[15:47:03.608] <TB3> INFO: scanning low vcal = 100
[15:47:07.980] <TB3> INFO: Test took 4372ms.
[15:47:08.043] <TB3> INFO: scanning low vcal = 150
[15:47:12.441] <TB3> INFO: Test took 4398ms.
[15:47:12.517] <TB3> INFO: scanning low vcal = 200
[15:47:16.894] <TB3> INFO: Test took 4377ms.
[15:47:16.960] <TB3> INFO: scanning low vcal = 250
[15:47:21.338] <TB3> INFO: Test took 4378ms.
[15:47:21.401] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[15:47:25.772] <TB3> INFO: Test took 4371ms.
[15:47:25.834] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[15:47:30.159] <TB3> INFO: Test took 4325ms.
[15:47:30.221] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[15:47:34.620] <TB3> INFO: Test took 4399ms.
[15:47:34.680] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[15:47:39.025] <TB3> INFO: Test took 4345ms.
[15:47:39.082] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[15:47:43.451] <TB3> INFO: Test took 4369ms.
[15:47:43.835] <TB3> INFO: PixTestGainPedestal::measure() done
[15:48:10.818] <TB3> INFO: PixTestGainPedestal::fit() done
[15:48:10.818] <TB3> INFO: non-linearity mean: 0.959 0.954 0.950 0.950 0.952 0.955 0.953 0.958 0.960 0.953 0.949 0.955 0.957 0.958 0.956 0.958
[15:48:10.818] <TB3> INFO: non-linearity RMS: 0.006 0.006 0.007 0.006 0.006 0.006 0.006 0.006 0.006 0.006 0.007 0.007 0.005 0.006 0.006 0.007
[15:48:10.818] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[15:48:10.838] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[15:48:10.858] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[15:48:10.878] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[15:48:10.897] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[15:48:10.917] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[15:48:10.936] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[15:48:10.954] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[15:48:10.972] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[15:48:10.991] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[15:48:11.009] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[15:48:11.027] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[15:48:11.045] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[15:48:11.064] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[15:48:11.082] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[15:48:11.100] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2039_FullQualification_2015-07-08_10h58m_1436345921//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[15:48:11.119] <TB3> INFO: PixTestGainPedestal::doTest() done, duration: 71 seconds
[15:48:11.125] <TB3> INFO: enter test to run
[15:48:11.125] <TB3> INFO: test: exit no parameter change
[15:48:11.551] <TB3> QUIET: Connection to board 170 closed.
[15:48:11.630] <TB3> INFO: pXar: this is the end, my friend