[10:00:47.699] <TB2> INFO: *** Welcome to pxar ***
[10:00:47.699] <TB2> INFO: *** Today: 2016/06/15
[10:00:47.806] <TB2> INFO: *** Version: 9751-dirty
[10:00:47.806] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C15.dat
[10:00:47.808] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//tbmParameters_C0b.dat
[10:00:47.808] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//defaultMaskFile.dat
[10:00:47.808] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters_C15.dat
[10:00:47.877] <TB2> INFO: clk: 4
[10:00:47.877] <TB2> INFO: ctr: 4
[10:00:47.877] <TB2> INFO: sda: 19
[10:00:47.877] <TB2> INFO: tin: 9
[10:00:47.877] <TB2> INFO: level: 15
[10:00:47.877] <TB2> INFO: triggerdelay: 0
[10:00:47.877] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[10:00:47.877] <TB2> INFO: Log level: INFO
[10:00:47.884] <TB2> INFO: Found DTB DTB_WXC55Z
[10:00:47.894] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[10:00:47.896] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[10:00:47.897] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[10:00:49.431] <TB2> INFO: DUT info:
[10:00:49.431] <TB2> INFO: The DUT currently contains the following objects:
[10:00:49.431] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[10:00:49.431] <TB2> INFO: TBM Core alpha (0): 7 registers set
[10:00:49.431] <TB2> INFO: TBM Core beta (1): 7 registers set
[10:00:49.431] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:00:49.431] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.431] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.432] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.432] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:49.832] <TB2> INFO: enter 'restricted' command line mode
[10:00:49.832] <TB2> INFO: enter test to run
[10:00:49.833] <TB2> INFO: test: pretest no parameter change
[10:00:49.833] <TB2> INFO: running: pretest
[10:00:49.838] <TB2> INFO: ----------------------------------------------------------------------
[10:00:49.838] <TB2> INFO: PixTestPretest::programROC()
[10:00:49.838] <TB2> INFO: ----------------------------------------------------------------------
[10:01:07.852] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[10:01:07.852] <TB2> INFO: IA differences per ROC: 17.7 17.7 16.9 20.9 20.1 20.9 20.9 18.5 19.3 17.7 19.3 18.5 20.9 18.5 19.3 20.1
[10:01:07.949] <TB2> INFO: enter test to run
[10:01:07.949] <TB2> INFO: test: pretest no parameter change
[10:01:07.949] <TB2> INFO: running: pretest
[10:01:07.950] <TB2> INFO: ----------------------------------------------------------------------
[10:01:07.950] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[10:01:07.950] <TB2> INFO: ----------------------------------------------------------------------
[10:01:15.037] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 385.1 mA = 24.0688 mA/ROC
[10:01:15.037] <TB2> INFO: i(loss) [mA/ROC]: 18.5 18.5 18.5 18.5 18.5 19.3 18.5 18.5 18.5 18.5 18.5 17.7 18.5 18.5 18.5 18.5
[10:01:15.074] <TB2> INFO: enter test to run
[10:01:15.074] <TB2> INFO: test: pretest no parameter change
[10:01:15.074] <TB2> INFO: running: pretest
[10:01:15.075] <TB2> INFO: ----------------------------------------------------------------------
[10:01:15.075] <TB2> INFO: PixTestPretest::findTiming()
[10:01:15.075] <TB2> INFO: ----------------------------------------------------------------------
[10:01:15.075] <TB2> INFO: PixTestCmd::init()
[10:01:16.035] <TB2> WARNING: Not unmasking DUT, not setting Calibrate bits!
[10:02:43.146] <TB2> INFO: TBM phases: 160MHz: 3, 400MHz: 2, TBM delays: ROC(0/1):2, header/trailer: 1, token: 0
[10:02:43.146] <TB2> INFO: (success/tries = 100/100), width = 3
[10:02:43.151] <TB2> INFO: enter test to run
[10:02:43.151] <TB2> INFO: test: pretest no parameter change
[10:02:43.151] <TB2> INFO: running: pretest
[10:02:43.153] <TB2> INFO: ----------------------------------------------------------------------
[10:02:43.153] <TB2> INFO: PixTestPretest::findWorkingPixel()
[10:02:43.153] <TB2> INFO: ----------------------------------------------------------------------
[10:02:43.246] <TB2> INFO: Expecting 231680 events.
[10:02:49.020] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[10:02:49.105] <TB2> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[10:02:53.488] <TB2> INFO: 231680 events read in total (9686ms).
[10:02:53.492] <TB2> INFO: Test took 10335ms.
[10:02:53.721] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[10:02:53.786] <TB2> INFO: enter test to run
[10:02:53.786] <TB2> INFO: test: pretest no parameter change
[10:02:53.786] <TB2> INFO: running: pretest
[10:02:53.787] <TB2> INFO: ----------------------------------------------------------------------
[10:02:53.787] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[10:02:53.787] <TB2> INFO: ----------------------------------------------------------------------
[10:02:53.879] <TB2> INFO: Expecting 231680 events.
[10:03:04.161] <TB2> INFO: 231680 events read in total (9725ms).
[10:03:04.164] <TB2> INFO: Test took 10373ms.
[10:03:04.406] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[10:03:04.406] <TB2> INFO: CalDel: 142 144 127 137 135 145 131 122 137 145 137 117 153 128 138 126
[10:03:04.406] <TB2> INFO: VthrComp: 51 51 51 52 51 51 51 51 51 51 51 51 51 51 51 51
[10:03:04.441] <TB2> INFO: enter test to run
[10:03:04.441] <TB2> INFO: test: pretest no parameter change
[10:03:04.441] <TB2> INFO: running: pretest
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C0.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C1.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C2.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C3.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C4.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C5.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C6.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C7.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C8.dat
[10:03:04.442] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C9.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C10.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C11.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C12.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C13.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C14.dat
[10:03:04.443] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters_C15.dat
[10:03:04.443] <TB2> INFO: enter test to run
[10:03:04.443] <TB2> INFO: test: fulltest no parameter change
[10:03:04.443] <TB2> INFO: running: fulltest
[10:03:04.443] <TB2> INFO: ######################################################################
[10:03:04.443] <TB2> INFO: PixTestFullTest::doTest()
[10:03:04.443] <TB2> INFO: ######################################################################
[10:03:04.444] <TB2> INFO: ######################################################################
[10:03:04.444] <TB2> INFO: PixTestAlive::doTest()
[10:03:04.444] <TB2> INFO: ######################################################################
[10:03:04.446] <TB2> INFO: ----------------------------------------------------------------------
[10:03:04.446] <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)
[10:03:04.446] <TB2> INFO: ----------------------------------------------------------------------
[10:03:04.716] <TB2> INFO: Expecting 41600 events.
[10:03:08.520] <TB2> INFO: 41600 events read in total (3248ms).
[10:03:08.520] <TB2> INFO: Test took 4073ms.
[10:03:08.758] <TB2> INFO: PixTestAlive::aliveTest() done
[10:03:08.759] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 1 0 0 0 0 0 0 0 0 0
[10:03:08.760] <TB2> INFO: ----------------------------------------------------------------------
[10:03:08.760] <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)
[10:03:08.760] <TB2> INFO: ----------------------------------------------------------------------
[10:03:09.027] <TB2> INFO: Expecting 41600 events.
[10:03:11.987] <TB2> INFO: 41600 events read in total (2404ms).
[10:03:11.987] <TB2> INFO: Test took 3226ms.
[10:03:11.988] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:03:12.234] <TB2> INFO: PixTestAlive::maskTest() done
[10:03:12.234] <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
[10:03:12.235] <TB2> INFO: ----------------------------------------------------------------------
[10:03:12.235] <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)
[10:03:12.235] <TB2> INFO: ----------------------------------------------------------------------
[10:03:12.537] <TB2> INFO: Expecting 41600 events.
[10:03:16.362] <TB2> INFO: 41600 events read in total (3269ms).
[10:03:16.363] <TB2> INFO: Test took 4127ms.
[10:03:16.592] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[10:03:16.592] <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
[10:03:16.592] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[10:03:16.592] <TB2> INFO: Decoding statistics:
[10:03:16.592] <TB2> INFO: General information:
[10:03:16.592] <TB2> INFO: 16bit words read: 0
[10:03:16.592] <TB2> INFO: valid events total: 0
[10:03:16.592] <TB2> INFO: empty events: 0
[10:03:16.592] <TB2> INFO: valid events with pixels: 0
[10:03:16.592] <TB2> INFO: valid pixel hits: 0
[10:03:16.592] <TB2> INFO: Event errors: 0
[10:03:16.592] <TB2> INFO: start marker: 0
[10:03:16.592] <TB2> INFO: stop marker: 0
[10:03:16.592] <TB2> INFO: overflow: 0
[10:03:16.592] <TB2> INFO: invalid 5bit words: 0
[10:03:16.592] <TB2> INFO: invalid XOR eye diagram: 0
[10:03:16.592] <TB2> INFO: frame (failed synchr.): 0
[10:03:16.592] <TB2> INFO: idle data (no TBM trl): 0
[10:03:16.592] <TB2> INFO: no data (only TBM hdr): 0
[10:03:16.592] <TB2> INFO: TBM errors: 0
[10:03:16.592] <TB2> INFO: flawed TBM headers: 0
[10:03:16.592] <TB2> INFO: flawed TBM trailers: 0
[10:03:16.592] <TB2> INFO: event ID mismatches: 0
[10:03:16.592] <TB2> INFO: ROC errors: 0
[10:03:16.592] <TB2> INFO: missing ROC header(s): 0
[10:03:16.593] <TB2> INFO: misplaced readback start: 0
[10:03:16.593] <TB2> INFO: Pixel decoding errors: 0
[10:03:16.593] <TB2> INFO: pixel data incomplete: 0
[10:03:16.593] <TB2> INFO: pixel address: 0
[10:03:16.593] <TB2> INFO: pulse height fill bit: 0
[10:03:16.593] <TB2> INFO: buffer corruption: 0
[10:03:16.602] <TB2> INFO: ######################################################################
[10:03:16.602] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[10:03:16.602] <TB2> INFO: ######################################################################
[10:03:16.604] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[10:03:16.615] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[10:03:16.615] <TB2> INFO: run 1 of 1
[10:03:16.889] <TB2> INFO: Expecting 3120000 events.
[10:03:58.133] <TB2> INFO: 864645 events read in total (40688ms).
[10:04:38.426] <TB2> INFO: 1723330 events read in total (80981ms).
[10:05:18.993] <TB2> INFO: 2594075 events read in total (121548ms).
[10:05:43.465] <TB2> INFO: 3120000 events read in total (146020ms).
[10:05:43.511] <TB2> INFO: Test took 146896ms.
[10:06:07.702] <TB2> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[10:06:07.702] <TB2> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:06:07.702] <TB2> INFO: separation cut (per ROC): 85 83 90 101 91 111 102 85 81 79 83 87 87 88 85 92
[10:06:07.703] <TB2> INFO: Decoding statistics:
[10:06:07.703] <TB2> INFO: General information:
[10:06:07.703] <TB2> INFO: 16bit words read: 0
[10:06:07.703] <TB2> INFO: valid events total: 0
[10:06:07.703] <TB2> INFO: empty events: 0
[10:06:07.703] <TB2> INFO: valid events with pixels: 0
[10:06:07.703] <TB2> INFO: valid pixel hits: 0
[10:06:07.703] <TB2> INFO: Event errors: 0
[10:06:07.703] <TB2> INFO: start marker: 0
[10:06:07.703] <TB2> INFO: stop marker: 0
[10:06:07.703] <TB2> INFO: overflow: 0
[10:06:07.703] <TB2> INFO: invalid 5bit words: 0
[10:06:07.703] <TB2> INFO: invalid XOR eye diagram: 0
[10:06:07.703] <TB2> INFO: frame (failed synchr.): 0
[10:06:07.703] <TB2> INFO: idle data (no TBM trl): 0
[10:06:07.703] <TB2> INFO: no data (only TBM hdr): 0
[10:06:07.703] <TB2> INFO: TBM errors: 0
[10:06:07.703] <TB2> INFO: flawed TBM headers: 0
[10:06:07.703] <TB2> INFO: flawed TBM trailers: 0
[10:06:07.703] <TB2> INFO: event ID mismatches: 0
[10:06:07.703] <TB2> INFO: ROC errors: 0
[10:06:07.703] <TB2> INFO: missing ROC header(s): 0
[10:06:07.703] <TB2> INFO: misplaced readback start: 0
[10:06:07.703] <TB2> INFO: Pixel decoding errors: 0
[10:06:07.703] <TB2> INFO: pixel data incomplete: 0
[10:06:07.703] <TB2> INFO: pixel address: 0
[10:06:07.703] <TB2> INFO: pulse height fill bit: 0
[10:06:07.703] <TB2> INFO: buffer corruption: 0
[10:06:07.777] <TB2> INFO: ######################################################################
[10:06:07.777] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[10:06:07.777] <TB2> INFO: ######################################################################
[10:06:07.777] <TB2> INFO: ----------------------------------------------------------------------
[10:06:07.777] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[10:06:07.777] <TB2> INFO: ----------------------------------------------------------------------
[10:06:07.777] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[10:06:07.785] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[10:06:07.785] <TB2> INFO: run 1 of 1
[10:06:08.048] <TB2> INFO: Expecting 26208000 events.
[10:06:41.281] <TB2> INFO: 892700 events read in total (32677ms).
[10:07:13.331] <TB2> INFO: 1770350 events read in total (64727ms).
[10:07:45.982] <TB2> INFO: 2648650 events read in total (97378ms).
[10:08:18.773] <TB2> INFO: 3522150 events read in total (130169ms).
[10:08:51.231] <TB2> INFO: 4396200 events read in total (162627ms).
[10:09:23.624] <TB2> INFO: 5270950 events read in total (195020ms).
[10:09:55.999] <TB2> INFO: 6146050 events read in total (227395ms).
[10:10:28.523] <TB2> INFO: 7017150 events read in total (259919ms).
[10:11:01.294] <TB2> INFO: 7890450 events read in total (292690ms).
[10:11:34.031] <TB2> INFO: 8764100 events read in total (325427ms).
[10:12:06.147] <TB2> INFO: 9638750 events read in total (357543ms).
[10:12:38.406] <TB2> INFO: 10508900 events read in total (389802ms).
[10:13:10.837] <TB2> INFO: 11381350 events read in total (422233ms).
[10:13:43.491] <TB2> INFO: 12253250 events read in total (454887ms).
[10:14:15.904] <TB2> INFO: 13122650 events read in total (487300ms).
[10:14:48.257] <TB2> INFO: 13983600 events read in total (519653ms).
[10:15:20.780] <TB2> INFO: 14846050 events read in total (552176ms).
[10:15:53.077] <TB2> INFO: 15708350 events read in total (584473ms).
[10:16:25.844] <TB2> INFO: 16566050 events read in total (617240ms).
[10:16:58.095] <TB2> INFO: 17425050 events read in total (649491ms).
[10:17:30.844] <TB2> INFO: 18286100 events read in total (682240ms).
[10:18:03.463] <TB2> INFO: 19144300 events read in total (714859ms).
[10:18:35.640] <TB2> INFO: 20001750 events read in total (747036ms).
[10:19:07.758] <TB2> INFO: 20860200 events read in total (779154ms).
[10:19:40.116] <TB2> INFO: 21719700 events read in total (811512ms).
[10:20:12.615] <TB2> INFO: 22575950 events read in total (844011ms).
[10:20:44.501] <TB2> INFO: 23435900 events read in total (875897ms).
[10:21:16.993] <TB2> INFO: 24296250 events read in total (908389ms).
[10:21:49.391] <TB2> INFO: 25154700 events read in total (940787ms).
[10:22:21.875] <TB2> INFO: 26025800 events read in total (973271ms).
[10:22:28.909] <TB2> INFO: 26208000 events read in total (980305ms).
[10:22:28.938] <TB2> INFO: Test took 981153ms.
[10:22:29.183] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:30.669] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:32.156] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:33.612] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:35.025] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:36.456] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:37.866] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:39.385] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:40.931] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:42.413] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:43.904] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:45.403] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:46.979] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:48.628] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:50.079] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:51.551] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[10:22:53.150] <TB2> INFO: PixTestScurves::scurves() done
[10:22:53.150] <TB2> INFO: Vcal mean: 85.77 85.13 92.94 101.26 94.46 107.78 92.20 85.77 82.02 87.34 84.63 82.57 92.85 82.44 82.88 89.13
[10:22:53.150] <TB2> INFO: Vcal RMS: 5.70 4.79 5.47 6.63 6.39 5.97 5.92 5.31 5.10 5.24 5.03 4.45 5.89 5.07 5.13 5.87
[10:22:53.150] <TB2> INFO: PixTestScurves::fullTest() done, duration: 1005 seconds
[10:22:53.150] <TB2> INFO: Decoding statistics:
[10:22:53.150] <TB2> INFO: General information:
[10:22:53.150] <TB2> INFO: 16bit words read: 0
[10:22:53.150] <TB2> INFO: valid events total: 0
[10:22:53.150] <TB2> INFO: empty events: 0
[10:22:53.150] <TB2> INFO: valid events with pixels: 0
[10:22:53.150] <TB2> INFO: valid pixel hits: 0
[10:22:53.150] <TB2> INFO: Event errors: 0
[10:22:53.150] <TB2> INFO: start marker: 0
[10:22:53.150] <TB2> INFO: stop marker: 0
[10:22:53.150] <TB2> INFO: overflow: 0
[10:22:53.150] <TB2> INFO: invalid 5bit words: 0
[10:22:53.150] <TB2> INFO: invalid XOR eye diagram: 0
[10:22:53.150] <TB2> INFO: frame (failed synchr.): 0
[10:22:53.150] <TB2> INFO: idle data (no TBM trl): 0
[10:22:53.150] <TB2> INFO: no data (only TBM hdr): 0
[10:22:53.150] <TB2> INFO: TBM errors: 0
[10:22:53.150] <TB2> INFO: flawed TBM headers: 0
[10:22:53.150] <TB2> INFO: flawed TBM trailers: 0
[10:22:53.150] <TB2> INFO: event ID mismatches: 0
[10:22:53.150] <TB2> INFO: ROC errors: 0
[10:22:53.150] <TB2> INFO: missing ROC header(s): 0
[10:22:53.150] <TB2> INFO: misplaced readback start: 0
[10:22:53.150] <TB2> INFO: Pixel decoding errors: 0
[10:22:53.150] <TB2> INFO: pixel data incomplete: 0
[10:22:53.150] <TB2> INFO: pixel address: 0
[10:22:53.150] <TB2> INFO: pulse height fill bit: 0
[10:22:53.150] <TB2> INFO: buffer corruption: 0
[10:22:53.234] <TB2> INFO: ######################################################################
[10:22:53.234] <TB2> INFO: PixTestTrim::doTest()
[10:22:53.234] <TB2> INFO: ######################################################################
[10:22:53.235] <TB2> INFO: ----------------------------------------------------------------------
[10:22:53.235] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[10:22:53.235] <TB2> INFO: ----------------------------------------------------------------------
[10:22:53.322] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[10:22:53.322] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[10:22:53.330] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:22:53.330] <TB2> INFO: run 1 of 1
[10:22:53.597] <TB2> INFO: Expecting 6281600 events.
[10:23:34.667] <TB2> INFO: 1080270 events read in total (40511ms).
[10:24:14.527] <TB2> INFO: 2158920 events read in total (80371ms).
[10:24:53.952] <TB2> INFO: 3233480 events read in total (119796ms).
[10:25:33.272] <TB2> INFO: 4314920 events read in total (159116ms).
[10:26:12.619] <TB2> INFO: 5402580 events read in total (198463ms).
[10:26:44.812] <TB2> INFO: 6281600 events read in total (230656ms).
[10:26:44.843] <TB2> INFO: Test took 231513ms.
[10:27:03.919] <TB2> INFO: ROC 0 VthrComp = 86
[10:27:03.919] <TB2> INFO: ROC 1 VthrComp = 88
[10:27:03.919] <TB2> INFO: ROC 2 VthrComp = 91
[10:27:03.919] <TB2> INFO: ROC 3 VthrComp = 98
[10:27:03.919] <TB2> INFO: ROC 4 VthrComp = 94
[10:27:03.920] <TB2> INFO: ROC 5 VthrComp = 105
[10:27:03.920] <TB2> INFO: ROC 6 VthrComp = 96
[10:27:03.920] <TB2> INFO: ROC 7 VthrComp = 89
[10:27:03.920] <TB2> INFO: ROC 8 VthrComp = 83
[10:27:03.920] <TB2> INFO: ROC 9 VthrComp = 88
[10:27:03.920] <TB2> INFO: ROC 10 VthrComp = 88
[10:27:03.920] <TB2> INFO: ROC 11 VthrComp = 88
[10:27:03.920] <TB2> INFO: ROC 12 VthrComp = 93
[10:27:03.920] <TB2> INFO: ROC 13 VthrComp = 87
[10:27:03.921] <TB2> INFO: ROC 14 VthrComp = 85
[10:27:03.921] <TB2> INFO: ROC 15 VthrComp = 93
[10:27:03.921] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[10:27:03.921] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[10:27:03.929] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:27:03.929] <TB2> INFO: run 1 of 1
[10:27:04.188] <TB2> INFO: Expecting 6281600 events.
[10:27:39.662] <TB2> INFO: 757540 events read in total (34918ms).
[10:28:14.449] <TB2> INFO: 1512550 events read in total (69705ms).
[10:28:48.974] <TB2> INFO: 2268020 events read in total (104230ms).
[10:29:23.939] <TB2> INFO: 3023810 events read in total (139195ms).
[10:29:58.570] <TB2> INFO: 3773990 events read in total (173826ms).
[10:30:33.186] <TB2> INFO: 4520880 events read in total (208442ms).
[10:31:07.629] <TB2> INFO: 5266170 events read in total (242885ms).
[10:31:42.314] <TB2> INFO: 6011120 events read in total (277570ms).
[10:31:55.159] <TB2> INFO: 6281600 events read in total (290415ms).
[10:31:55.202] <TB2> INFO: Test took 291273ms.
[10:32:19.914] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 61.1865 for pixel 22/13 mean/min/max = 46.2645/31.1796/61.3493
[10:32:19.915] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 58.244 for pixel 1/2 mean/min/max = 45.5743/32.8978/58.2509
[10:32:19.915] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 60.3502 for pixel 10/8 mean/min/max = 46.3732/32.2296/60.5168
[10:32:19.915] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 62.2159 for pixel 36/76 mean/min/max = 46.6526/30.9636/62.3416
[10:32:19.915] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 60.7859 for pixel 39/79 mean/min/max = 46.074/31.2784/60.8695
[10:32:19.916] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 63.9499 for pixel 32/73 mean/min/max = 48.7701/33.579/63.9612
[10:32:19.916] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 59.6329 for pixel 0/5 mean/min/max = 45.3564/31.0529/59.6599
[10:32:19.916] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 60.1296 for pixel 5/4 mean/min/max = 46.3527/32.4844/60.2209
[10:32:19.916] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 59.3012 for pixel 8/72 mean/min/max = 45.3578/31.3758/59.3398
[10:32:19.917] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 59.661 for pixel 15/61 mean/min/max = 46.6002/33.3379/59.8626
[10:32:19.917] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 58.3751 for pixel 23/78 mean/min/max = 45.3646/32.2241/58.505
[10:32:19.917] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 56.6013 for pixel 47/79 mean/min/max = 45.116/33.3119/56.9201
[10:32:19.917] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 60.626 for pixel 0/40 mean/min/max = 46.2417/31.6371/60.8463
[10:32:19.918] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.9476 for pixel 20/14 mean/min/max = 45.6579/32.3058/59.0099
[10:32:19.918] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 59.3851 for pixel 15/12 mean/min/max = 45.9274/32.2816/59.5733
[10:32:19.918] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 59.0298 for pixel 0/76 mean/min/max = 45.6766/31.9268/59.4264
[10:32:19.918] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:32:20.006] <TB2> INFO: Expecting 514560 events.
[10:32:32.784] <TB2> INFO: 514560 events read in total (12221ms).
[10:32:32.789] <TB2> INFO: Expecting 514560 events.
[10:32:45.361] <TB2> INFO: 514560 events read in total (12149ms).
[10:32:45.368] <TB2> INFO: Expecting 514560 events.
[10:32:58.246] <TB2> INFO: 514560 events read in total (12458ms).
[10:32:58.254] <TB2> INFO: Expecting 514560 events.
[10:33:11.205] <TB2> INFO: 514560 events read in total (12537ms).
[10:33:11.214] <TB2> INFO: Expecting 514560 events.
[10:33:24.049] <TB2> INFO: 514560 events read in total (12414ms).
[10:33:24.061] <TB2> INFO: Expecting 514560 events.
[10:33:37.070] <TB2> INFO: 514560 events read in total (12595ms).
[10:33:37.083] <TB2> INFO: Expecting 514560 events.
[10:33:50.016] <TB2> INFO: 514560 events read in total (12520ms).
[10:33:50.032] <TB2> INFO: Expecting 514560 events.
[10:34:02.913] <TB2> INFO: 514560 events read in total (12471ms).
[10:34:02.931] <TB2> INFO: Expecting 514560 events.
[10:34:15.833] <TB2> INFO: 514560 events read in total (12493ms).
[10:34:15.852] <TB2> INFO: Expecting 514560 events.
[10:34:28.665] <TB2> INFO: 514560 events read in total (12411ms).
[10:34:28.686] <TB2> INFO: Expecting 514560 events.
[10:34:41.670] <TB2> INFO: 514560 events read in total (12579ms).
[10:34:41.695] <TB2> INFO: Expecting 514560 events.
[10:34:54.636] <TB2> INFO: 514560 events read in total (12540ms).
[10:34:54.662] <TB2> INFO: Expecting 514560 events.
[10:35:07.594] <TB2> INFO: 514560 events read in total (12530ms).
[10:35:07.621] <TB2> INFO: Expecting 514560 events.
[10:35:20.633] <TB2> INFO: 514560 events read in total (12607ms).
[10:35:20.662] <TB2> INFO: Expecting 514560 events.
[10:35:33.556] <TB2> INFO: 514560 events read in total (12493ms).
[10:35:33.587] <TB2> INFO: Expecting 514560 events.
[10:35:46.323] <TB2> INFO: 514560 events read in total (12334ms).
[10:35:46.358] <TB2> INFO: Test took 206440ms.
[10:35:47.325] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[10:35:47.333] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:35:47.333] <TB2> INFO: run 1 of 1
[10:35:47.600] <TB2> INFO: Expecting 6281600 events.
[10:36:22.454] <TB2> INFO: 741410 events read in total (34297ms).
[10:36:57.173] <TB2> INFO: 1481970 events read in total (69016ms).
[10:37:31.680] <TB2> INFO: 2222280 events read in total (103523ms).
[10:38:06.231] <TB2> INFO: 2963330 events read in total (138074ms).
[10:38:40.731] <TB2> INFO: 3698410 events read in total (172574ms).
[10:39:15.071] <TB2> INFO: 4429070 events read in total (206914ms).
[10:39:49.780] <TB2> INFO: 5158060 events read in total (241623ms).
[10:40:24.043] <TB2> INFO: 5887050 events read in total (275886ms).
[10:40:42.976] <TB2> INFO: 6281600 events read in total (294819ms).
[10:40:43.018] <TB2> INFO: Test took 295685ms.
[10:41:06.440] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.039570 .. 255.000000
[10:41:06.519] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[10:41:06.527] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:41:06.527] <TB2> INFO: run 1 of 1
[10:41:06.787] <TB2> INFO: Expecting 10649600 events.
[10:41:41.188] <TB2> INFO: 712290 events read in total (33845ms).
[10:42:15.375] <TB2> INFO: 1424560 events read in total (68032ms).
[10:42:49.760] <TB2> INFO: 2137210 events read in total (102417ms).
[10:43:23.985] <TB2> INFO: 2850080 events read in total (136642ms).
[10:43:58.225] <TB2> INFO: 3562550 events read in total (170882ms).
[10:44:31.892] <TB2> INFO: 4274970 events read in total (204549ms).
[10:45:06.014] <TB2> INFO: 4987700 events read in total (238671ms).
[10:45:40.313] <TB2> INFO: 5700210 events read in total (272970ms).
[10:46:14.565] <TB2> INFO: 6412470 events read in total (307222ms).
[10:46:48.505] <TB2> INFO: 7123930 events read in total (341162ms).
[10:47:22.713] <TB2> INFO: 7835500 events read in total (375370ms).
[10:47:57.072] <TB2> INFO: 8546380 events read in total (409729ms).
[10:48:30.897] <TB2> INFO: 9257080 events read in total (443554ms).
[10:49:05.180] <TB2> INFO: 9967660 events read in total (477837ms).
[10:49:38.066] <TB2> INFO: 10649600 events read in total (510723ms).
[10:49:38.168] <TB2> INFO: Test took 511641ms.
[10:50:06.755] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 2.602481 .. 51.673955
[10:50:06.832] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 2 .. 61 (-1/-1) hits flags = 528 (plus default)
[10:50:06.840] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:50:06.840] <TB2> INFO: run 1 of 1
[10:50:07.103] <TB2> INFO: Expecting 2496000 events.
[10:50:44.635] <TB2> INFO: 913090 events read in total (36976ms).
[10:51:21.505] <TB2> INFO: 1825090 events read in total (73847ms).
[10:51:48.884] <TB2> INFO: 2496000 events read in total (101226ms).
[10:51:48.916] <TB2> INFO: Test took 102077ms.
[10:52:03.740] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 18.984168 .. 47.385165
[10:52:03.816] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 8 .. 57 (-1/-1) hits flags = 528 (plus default)
[10:52:03.824] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:52:03.824] <TB2> INFO: run 1 of 1
[10:52:04.085] <TB2> INFO: Expecting 2080000 events.
[10:52:42.347] <TB2> INFO: 908470 events read in total (37701ms).
[10:53:20.285] <TB2> INFO: 1816290 events read in total (75639ms).
[10:53:31.734] <TB2> INFO: 2080000 events read in total (87089ms).
[10:53:31.757] <TB2> INFO: Test took 87933ms.
[10:53:46.950] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 1.850348 .. 47.385165
[10:53:47.031] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 1 .. 57 (-1/-1) hits flags = 528 (plus default)
[10:53:47.040] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:53:47.040] <TB2> INFO: run 1 of 1
[10:53:47.325] <TB2> INFO: Expecting 2371200 events.
[10:54:27.054] <TB2> INFO: 945690 events read in total (39173ms).
[10:55:05.281] <TB2> INFO: 1891040 events read in total (77400ms).
[10:55:24.944] <TB2> INFO: 2371200 events read in total (97063ms).
[10:55:24.959] <TB2> INFO: Test took 97920ms.
[10:55:39.599] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[10:55:39.599] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[10:55:39.607] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[10:55:39.607] <TB2> INFO: run 1 of 1
[10:55:39.867] <TB2> INFO: Expecting 1705600 events.
[10:56:17.220] <TB2> INFO: 878580 events read in total (36797ms).
[10:56:52.237] <TB2> INFO: 1705600 events read in total (71814ms).
[10:56:52.250] <TB2> INFO: Test took 72643ms.
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C0.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C1.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C2.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C3.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C4.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C5.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C6.dat
[10:57:05.629] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C7.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C8.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C9.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C10.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C11.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C12.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C13.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C14.dat
[10:57:05.630] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C15.dat
[10:57:05.630] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C0.dat
[10:57:05.637] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C1.dat
[10:57:05.643] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C2.dat
[10:57:05.650] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C3.dat
[10:57:05.656] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C4.dat
[10:57:05.662] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C5.dat
[10:57:05.668] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C6.dat
[10:57:05.675] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C7.dat
[10:57:05.681] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C8.dat
[10:57:05.687] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C9.dat
[10:57:05.693] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C10.dat
[10:57:05.700] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C11.dat
[10:57:05.706] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C12.dat
[10:57:05.712] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C13.dat
[10:57:05.718] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C14.dat
[10:57:05.725] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//trimParameters35_C15.dat
[10:57:05.731] <TB2> INFO: PixTestTrim::trimTest() done
[10:57:05.731] <TB2> INFO: vtrim: 99 92 96 96 97 103 104 93 95 89 91 84 87 97 93 85
[10:57:05.731] <TB2> INFO: vthrcomp: 86 88 91 98 94 105 96 89 83 88 88 88 93 87 85 93
[10:57:05.731] <TB2> INFO: vcal mean: 34.97 35.05 34.98 34.99 34.96 35.00 34.94 34.94 35.01 34.98 34.90 34.99 34.95 35.01 34.98 34.99
[10:57:05.731] <TB2> INFO: vcal RMS: 0.93 0.86 0.96 0.97 1.07 0.90 1.12 0.86 0.97 0.89 0.85 0.81 1.02 0.91 0.88 0.88
[10:57:05.731] <TB2> INFO: bits mean: 9.40 9.75 9.64 9.39 9.32 8.48 9.43 9.25 9.87 9.14 9.12 9.04 9.03 9.80 9.44 8.74
[10:57:05.731] <TB2> INFO: bits RMS: 2.84 2.50 2.58 2.78 2.84 2.64 2.90 2.65 2.60 2.62 2.83 2.76 2.93 2.55 2.64 3.07
[10:57:05.737] <TB2> INFO: ----------------------------------------------------------------------
[10:57:05.737] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[10:57:05.737] <TB2> INFO: ----------------------------------------------------------------------
[10:57:05.739] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[10:57:05.748] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[10:57:05.748] <TB2> INFO: run 1 of 1
[10:57:06.012] <TB2> INFO: Expecting 4160000 events.
[10:57:47.839] <TB2> INFO: 925620 events read in total (41271ms).
[10:58:28.536] <TB2> INFO: 1845685 events read in total (81968ms).
[10:59:09.536] <TB2> INFO: 2758075 events read in total (122969ms).
[10:59:50.228] <TB2> INFO: 3668230 events read in total (163660ms).
[11:00:12.647] <TB2> INFO: 4160000 events read in total (186080ms).
[11:00:12.686] <TB2> INFO: Test took 186939ms.
[11:00:41.215] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 192 (-1/-1) hits flags = 528 (plus default)
[11:00:41.223] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:00:41.223] <TB2> INFO: run 1 of 1
[11:00:41.494] <TB2> INFO: Expecting 4014400 events.
[11:01:22.867] <TB2> INFO: 906825 events read in total (40817ms).
[11:02:03.368] <TB2> INFO: 1808410 events read in total (81319ms).
[11:02:44.502] <TB2> INFO: 2701840 events read in total (122453ms).
[11:03:24.812] <TB2> INFO: 3592695 events read in total (162762ms).
[11:03:44.284] <TB2> INFO: 4014400 events read in total (182234ms).
[11:03:44.335] <TB2> INFO: Test took 183112ms.
[11:04:15.182] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 181 (-1/-1) hits flags = 528 (plus default)
[11:04:15.190] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:04:15.192] <TB2> INFO: run 1 of 1
[11:04:15.487] <TB2> INFO: Expecting 3785600 events.
[11:04:57.636] <TB2> INFO: 926560 events read in total (41593ms).
[11:05:39.138] <TB2> INFO: 1847170 events read in total (83095ms).
[11:06:19.693] <TB2> INFO: 2757215 events read in total (123650ms).
[11:07:00.857] <TB2> INFO: 3666790 events read in total (164814ms).
[11:07:06.512] <TB2> INFO: 3785600 events read in total (170469ms).
[11:07:06.541] <TB2> INFO: Test took 171349ms.
[11:07:34.556] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 180 (-1/-1) hits flags = 528 (plus default)
[11:07:34.564] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:07:34.564] <TB2> INFO: run 1 of 1
[11:07:34.831] <TB2> INFO: Expecting 3764800 events.
[11:08:16.424] <TB2> INFO: 927645 events read in total (41037ms).
[11:08:57.953] <TB2> INFO: 1849325 events read in total (82566ms).
[11:09:38.559] <TB2> INFO: 2760445 events read in total (123172ms).
[11:10:19.471] <TB2> INFO: 3670580 events read in total (164084ms).
[11:10:24.033] <TB2> INFO: 3764800 events read in total (168646ms).
[11:10:24.066] <TB2> INFO: Test took 169501ms.
[11:10:52.360] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 179 (-1/-1) hits flags = 528 (plus default)
[11:10:52.368] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:10:52.368] <TB2> INFO: run 1 of 1
[11:10:52.659] <TB2> INFO: Expecting 3744000 events.
[11:11:34.281] <TB2> INFO: 929355 events read in total (41066ms).
[11:12:15.401] <TB2> INFO: 1852105 events read in total (82186ms).
[11:12:56.229] <TB2> INFO: 2764320 events read in total (123014ms).
[11:13:37.021] <TB2> INFO: 3676005 events read in total (163806ms).
[11:13:40.366] <TB2> INFO: 3744000 events read in total (167151ms).
[11:13:40.399] <TB2> INFO: Test took 168031ms.
[11:14:09.093] <TB2> INFO: PixTestTrim::trimBitTest() done
[11:14:09.094] <TB2> INFO: PixTestTrim::doTest() done, duration: 3075 seconds
[11:14:09.094] <TB2> INFO: Decoding statistics:
[11:14:09.094] <TB2> INFO: General information:
[11:14:09.094] <TB2> INFO: 16bit words read: 0
[11:14:09.094] <TB2> INFO: valid events total: 0
[11:14:09.094] <TB2> INFO: empty events: 0
[11:14:09.094] <TB2> INFO: valid events with pixels: 0
[11:14:09.094] <TB2> INFO: valid pixel hits: 0
[11:14:09.094] <TB2> INFO: Event errors: 0
[11:14:09.094] <TB2> INFO: start marker: 0
[11:14:09.094] <TB2> INFO: stop marker: 0
[11:14:09.094] <TB2> INFO: overflow: 0
[11:14:09.094] <TB2> INFO: invalid 5bit words: 0
[11:14:09.094] <TB2> INFO: invalid XOR eye diagram: 0
[11:14:09.094] <TB2> INFO: frame (failed synchr.): 0
[11:14:09.094] <TB2> INFO: idle data (no TBM trl): 0
[11:14:09.094] <TB2> INFO: no data (only TBM hdr): 0
[11:14:09.094] <TB2> INFO: TBM errors: 0
[11:14:09.094] <TB2> INFO: flawed TBM headers: 0
[11:14:09.094] <TB2> INFO: flawed TBM trailers: 0
[11:14:09.094] <TB2> INFO: event ID mismatches: 0
[11:14:09.094] <TB2> INFO: ROC errors: 0
[11:14:09.094] <TB2> INFO: missing ROC header(s): 0
[11:14:09.094] <TB2> INFO: misplaced readback start: 0
[11:14:09.094] <TB2> INFO: Pixel decoding errors: 0
[11:14:09.094] <TB2> INFO: pixel data incomplete: 0
[11:14:09.094] <TB2> INFO: pixel address: 0
[11:14:09.094] <TB2> INFO: pulse height fill bit: 0
[11:14:09.094] <TB2> INFO: buffer corruption: 0
[11:14:09.807] <TB2> INFO: ######################################################################
[11:14:09.807] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[11:14:09.807] <TB2> INFO: ######################################################################
[11:14:10.081] <TB2> INFO: Expecting 41600 events.
[11:14:13.869] <TB2> INFO: 41600 events read in total (3232ms).
[11:14:13.869] <TB2> INFO: Test took 4061ms.
[11:14:14.361] <TB2> INFO: Expecting 41600 events.
[11:14:18.195] <TB2> INFO: 41600 events read in total (3277ms).
[11:14:18.196] <TB2> INFO: Test took 4129ms.
[11:14:18.496] <TB2> INFO: Expecting 41600 events.
[11:14:22.400] <TB2> INFO: 41600 events read in total (3347ms).
[11:14:22.401] <TB2> INFO: Test took 4183ms.
[11:14:22.657] <TB2> INFO: Expecting 2560 events.
[11:14:23.516] <TB2> INFO: 2560 events read in total (302ms).
[11:14:23.516] <TB2> INFO: Test took 1101ms.
[11:14:23.820] <TB2> INFO: Expecting 2560 events.
[11:14:24.673] <TB2> INFO: 2560 events read in total (297ms).
[11:14:24.674] <TB2> INFO: Test took 1157ms.
[11:14:24.979] <TB2> INFO: Expecting 2560 events.
[11:14:25.834] <TB2> INFO: 2560 events read in total (299ms).
[11:14:25.834] <TB2> INFO: Test took 1160ms.
[11:14:26.140] <TB2> INFO: Expecting 2560 events.
[11:14:26.994] <TB2> INFO: 2560 events read in total (298ms).
[11:14:26.995] <TB2> INFO: Test took 1160ms.
[11:14:27.300] <TB2> INFO: Expecting 2560 events.
[11:14:28.152] <TB2> INFO: 2560 events read in total (296ms).
[11:14:28.152] <TB2> INFO: Test took 1157ms.
[11:14:28.458] <TB2> INFO: Expecting 2560 events.
[11:14:29.312] <TB2> INFO: 2560 events read in total (298ms).
[11:14:29.312] <TB2> INFO: Test took 1159ms.
[11:14:29.617] <TB2> INFO: Expecting 2560 events.
[11:14:30.470] <TB2> INFO: 2560 events read in total (297ms).
[11:14:30.470] <TB2> INFO: Test took 1158ms.
[11:14:30.775] <TB2> INFO: Expecting 2560 events.
[11:14:31.628] <TB2> INFO: 2560 events read in total (297ms).
[11:14:31.628] <TB2> INFO: Test took 1157ms.
[11:14:31.933] <TB2> INFO: Expecting 2560 events.
[11:14:32.786] <TB2> INFO: 2560 events read in total (297ms).
[11:14:32.786] <TB2> INFO: Test took 1157ms.
[11:14:33.091] <TB2> INFO: Expecting 2560 events.
[11:14:33.944] <TB2> INFO: 2560 events read in total (297ms).
[11:14:33.944] <TB2> INFO: Test took 1157ms.
[11:14:34.249] <TB2> INFO: Expecting 2560 events.
[11:14:35.102] <TB2> INFO: 2560 events read in total (297ms).
[11:14:35.102] <TB2> INFO: Test took 1158ms.
[11:14:35.407] <TB2> INFO: Expecting 2560 events.
[11:14:36.260] <TB2> INFO: 2560 events read in total (297ms).
[11:14:36.261] <TB2> INFO: Test took 1159ms.
[11:14:36.566] <TB2> INFO: Expecting 2560 events.
[11:14:37.419] <TB2> INFO: 2560 events read in total (297ms).
[11:14:37.419] <TB2> INFO: Test took 1158ms.
[11:14:37.724] <TB2> INFO: Expecting 2560 events.
[11:14:38.576] <TB2> INFO: 2560 events read in total (297ms).
[11:14:38.577] <TB2> INFO: Test took 1158ms.
[11:14:38.882] <TB2> INFO: Expecting 2560 events.
[11:14:39.735] <TB2> INFO: 2560 events read in total (297ms).
[11:14:39.736] <TB2> INFO: Test took 1159ms.
[11:14:40.040] <TB2> INFO: Expecting 2560 events.
[11:14:40.893] <TB2> INFO: 2560 events read in total (296ms).
[11:14:40.894] <TB2> INFO: Test took 1158ms.
[11:14:40.897] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:14:41.200] <TB2> INFO: Expecting 655360 events.
[11:14:58.030] <TB2> INFO: 655360 events read in total (16274ms).
[11:14:58.039] <TB2> INFO: Expecting 655360 events.
[11:15:14.814] <TB2> INFO: 655360 events read in total (16374ms).
[11:15:14.826] <TB2> INFO: Expecting 655360 events.
[11:15:31.742] <TB2> INFO: 655360 events read in total (16514ms).
[11:15:31.758] <TB2> INFO: Expecting 655360 events.
[11:15:48.515] <TB2> INFO: 655360 events read in total (16355ms).
[11:15:48.534] <TB2> INFO: Expecting 655360 events.
[11:16:05.250] <TB2> INFO: 655360 events read in total (16314ms).
[11:16:05.276] <TB2> INFO: Expecting 655360 events.
[11:16:22.105] <TB2> INFO: 655360 events read in total (16428ms).
[11:16:22.132] <TB2> INFO: Expecting 655360 events.
[11:16:38.781] <TB2> INFO: 655360 events read in total (16247ms).
[11:16:38.810] <TB2> INFO: Expecting 655360 events.
[11:16:55.664] <TB2> INFO: 655360 events read in total (16453ms).
[11:16:55.697] <TB2> INFO: Expecting 655360 events.
[11:17:12.368] <TB2> INFO: 655360 events read in total (16269ms).
[11:17:12.405] <TB2> INFO: Expecting 655360 events.
[11:17:29.235] <TB2> INFO: 655360 events read in total (16429ms).
[11:17:29.280] <TB2> INFO: Expecting 655360 events.
[11:17:46.102] <TB2> INFO: 655360 events read in total (16420ms).
[11:17:46.147] <TB2> INFO: Expecting 655360 events.
[11:18:02.954] <TB2> INFO: 655360 events read in total (16405ms).
[11:18:03.004] <TB2> INFO: Expecting 655360 events.
[11:18:19.713] <TB2> INFO: 655360 events read in total (16308ms).
[11:18:19.771] <TB2> INFO: Expecting 655360 events.
[11:18:36.477] <TB2> INFO: 655360 events read in total (16304ms).
[11:18:36.531] <TB2> INFO: Expecting 655360 events.
[11:18:53.306] <TB2> INFO: 655360 events read in total (16373ms).
[11:18:53.364] <TB2> INFO: Expecting 655360 events.
[11:19:09.976] <TB2> INFO: 655360 events read in total (16210ms).
[11:19:10.038] <TB2> INFO: Test took 269141ms.
[11:19:10.120] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:19:10.351] <TB2> INFO: Expecting 655360 events.
[11:19:27.355] <TB2> INFO: 655360 events read in total (16448ms).
[11:19:27.364] <TB2> INFO: Expecting 655360 events.
[11:19:44.025] <TB2> INFO: 655360 events read in total (16259ms).
[11:19:44.036] <TB2> INFO: Expecting 655360 events.
[11:20:00.628] <TB2> INFO: 655360 events read in total (16190ms).
[11:20:00.643] <TB2> INFO: Expecting 655360 events.
[11:20:17.408] <TB2> INFO: 655360 events read in total (16363ms).
[11:20:17.429] <TB2> INFO: Expecting 655360 events.
[11:20:34.183] <TB2> INFO: 655360 events read in total (16352ms).
[11:20:34.206] <TB2> INFO: Expecting 655360 events.
[11:20:50.908] <TB2> INFO: 655360 events read in total (16300ms).
[11:20:50.935] <TB2> INFO: Expecting 655360 events.
[11:21:07.846] <TB2> INFO: 655360 events read in total (16510ms).
[11:21:07.877] <TB2> INFO: Expecting 655360 events.
[11:21:24.684] <TB2> INFO: 655360 events read in total (16405ms).
[11:21:24.718] <TB2> INFO: Expecting 655360 events.
[11:21:41.493] <TB2> INFO: 655360 events read in total (16373ms).
[11:21:41.532] <TB2> INFO: Expecting 655360 events.
[11:21:58.219] <TB2> INFO: 655360 events read in total (16285ms).
[11:21:58.261] <TB2> INFO: Expecting 655360 events.
[11:22:14.942] <TB2> INFO: 655360 events read in total (16279ms).
[11:22:14.985] <TB2> INFO: Expecting 655360 events.
[11:22:31.671] <TB2> INFO: 655360 events read in total (16285ms).
[11:22:31.720] <TB2> INFO: Expecting 655360 events.
[11:22:48.574] <TB2> INFO: 655360 events read in total (16452ms).
[11:22:48.627] <TB2> INFO: Expecting 655360 events.
[11:23:05.531] <TB2> INFO: 655360 events read in total (16502ms).
[11:23:05.584] <TB2> INFO: Expecting 655360 events.
[11:23:22.242] <TB2> INFO: 655360 events read in total (16256ms).
[11:23:22.310] <TB2> INFO: Expecting 655360 events.
[11:23:38.862] <TB2> INFO: 655360 events read in total (16150ms).
[11:23:38.922] <TB2> INFO: Test took 268802ms.
[11:23:39.115] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.122] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.128] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.135] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.142] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.149] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.155] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.162] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.169] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.175] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.182] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.189] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.196] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.202] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.209] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.216] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[11:23:39.251] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C0.dat
[11:23:39.252] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C1.dat
[11:23:39.252] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C2.dat
[11:23:39.252] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C3.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C4.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C5.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C6.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C7.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C8.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C9.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C10.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C11.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C12.dat
[11:23:39.253] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C13.dat
[11:23:39.254] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C14.dat
[11:23:39.254] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//dacParameters35_C15.dat
[11:23:39.523] <TB2> INFO: Expecting 41600 events.
[11:23:43.019] <TB2> INFO: 41600 events read in total (2940ms).
[11:23:43.019] <TB2> INFO: Test took 3762ms.
[11:23:43.466] <TB2> INFO: Expecting 41600 events.
[11:23:46.969] <TB2> INFO: 41600 events read in total (2947ms).
[11:23:46.970] <TB2> INFO: Test took 3775ms.
[11:23:47.431] <TB2> INFO: Expecting 41600 events.
[11:23:50.884] <TB2> INFO: 41600 events read in total (2897ms).
[11:23:50.884] <TB2> INFO: Test took 3736ms.
[11:23:51.066] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:51.154] <TB2> INFO: Expecting 2560 events.
[11:23:52.007] <TB2> INFO: 2560 events read in total (297ms).
[11:23:52.007] <TB2> INFO: Test took 941ms.
[11:23:52.009] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:52.312] <TB2> INFO: Expecting 2560 events.
[11:23:53.165] <TB2> INFO: 2560 events read in total (297ms).
[11:23:53.165] <TB2> INFO: Test took 1156ms.
[11:23:53.167] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:53.471] <TB2> INFO: Expecting 2560 events.
[11:23:54.324] <TB2> INFO: 2560 events read in total (297ms).
[11:23:54.325] <TB2> INFO: Test took 1158ms.
[11:23:54.327] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:54.630] <TB2> INFO: Expecting 2560 events.
[11:23:55.483] <TB2> INFO: 2560 events read in total (297ms).
[11:23:55.483] <TB2> INFO: Test took 1157ms.
[11:23:55.484] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:55.789] <TB2> INFO: Expecting 2560 events.
[11:23:56.644] <TB2> INFO: 2560 events read in total (299ms).
[11:23:56.644] <TB2> INFO: Test took 1160ms.
[11:23:56.646] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:56.949] <TB2> INFO: Expecting 2560 events.
[11:23:57.802] <TB2> INFO: 2560 events read in total (297ms).
[11:23:57.803] <TB2> INFO: Test took 1157ms.
[11:23:57.804] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:58.108] <TB2> INFO: Expecting 2560 events.
[11:23:58.960] <TB2> INFO: 2560 events read in total (296ms).
[11:23:58.961] <TB2> INFO: Test took 1157ms.
[11:23:58.962] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:23:59.266] <TB2> INFO: Expecting 2560 events.
[11:24:00.119] <TB2> INFO: 2560 events read in total (297ms).
[11:24:00.119] <TB2> INFO: Test took 1157ms.
[11:24:00.128] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:00.424] <TB2> INFO: Expecting 2560 events.
[11:24:01.277] <TB2> INFO: 2560 events read in total (296ms).
[11:24:01.278] <TB2> INFO: Test took 1150ms.
[11:24:01.280] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:01.583] <TB2> INFO: Expecting 2560 events.
[11:24:02.436] <TB2> INFO: 2560 events read in total (297ms).
[11:24:02.436] <TB2> INFO: Test took 1156ms.
[11:24:02.438] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:02.741] <TB2> INFO: Expecting 2560 events.
[11:24:03.594] <TB2> INFO: 2560 events read in total (296ms).
[11:24:03.594] <TB2> INFO: Test took 1156ms.
[11:24:03.596] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:03.900] <TB2> INFO: Expecting 2560 events.
[11:24:04.752] <TB2> INFO: 2560 events read in total (296ms).
[11:24:04.752] <TB2> INFO: Test took 1156ms.
[11:24:04.754] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:05.058] <TB2> INFO: Expecting 2560 events.
[11:24:05.910] <TB2> INFO: 2560 events read in total (296ms).
[11:24:05.910] <TB2> INFO: Test took 1156ms.
[11:24:05.912] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:06.216] <TB2> INFO: Expecting 2560 events.
[11:24:07.068] <TB2> INFO: 2560 events read in total (296ms).
[11:24:07.068] <TB2> INFO: Test took 1156ms.
[11:24:07.070] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:07.374] <TB2> INFO: Expecting 2560 events.
[11:24:08.226] <TB2> INFO: 2560 events read in total (296ms).
[11:24:08.226] <TB2> INFO: Test took 1156ms.
[11:24:08.228] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:08.532] <TB2> INFO: Expecting 2560 events.
[11:24:09.385] <TB2> INFO: 2560 events read in total (297ms).
[11:24:09.385] <TB2> INFO: Test took 1157ms.
[11:24:09.387] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:09.691] <TB2> INFO: Expecting 2560 events.
[11:24:10.543] <TB2> INFO: 2560 events read in total (296ms).
[11:24:10.543] <TB2> INFO: Test took 1156ms.
[11:24:10.555] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:10.849] <TB2> INFO: Expecting 2560 events.
[11:24:11.702] <TB2> INFO: 2560 events read in total (297ms).
[11:24:11.702] <TB2> INFO: Test took 1147ms.
[11:24:11.704] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:12.008] <TB2> INFO: Expecting 2560 events.
[11:24:12.861] <TB2> INFO: 2560 events read in total (297ms).
[11:24:12.861] <TB2> INFO: Test took 1157ms.
[11:24:12.863] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:13.167] <TB2> INFO: Expecting 2560 events.
[11:24:14.020] <TB2> INFO: 2560 events read in total (297ms).
[11:24:14.020] <TB2> INFO: Test took 1157ms.
[11:24:14.022] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:14.326] <TB2> INFO: Expecting 2560 events.
[11:24:15.179] <TB2> INFO: 2560 events read in total (297ms).
[11:24:15.180] <TB2> INFO: Test took 1159ms.
[11:24:15.182] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:15.485] <TB2> INFO: Expecting 2560 events.
[11:24:16.338] <TB2> INFO: 2560 events read in total (297ms).
[11:24:16.338] <TB2> INFO: Test took 1157ms.
[11:24:16.339] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:16.644] <TB2> INFO: Expecting 2560 events.
[11:24:17.497] <TB2> INFO: 2560 events read in total (297ms).
[11:24:17.497] <TB2> INFO: Test took 1158ms.
[11:24:17.499] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:17.803] <TB2> INFO: Expecting 2560 events.
[11:24:18.655] <TB2> INFO: 2560 events read in total (296ms).
[11:24:18.655] <TB2> INFO: Test took 1156ms.
[11:24:18.657] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:18.961] <TB2> INFO: Expecting 2560 events.
[11:24:19.814] <TB2> INFO: 2560 events read in total (297ms).
[11:24:19.814] <TB2> INFO: Test took 1158ms.
[11:24:19.816] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:20.120] <TB2> INFO: Expecting 2560 events.
[11:24:20.974] <TB2> INFO: 2560 events read in total (298ms).
[11:24:20.974] <TB2> INFO: Test took 1158ms.
[11:24:20.976] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:21.280] <TB2> INFO: Expecting 2560 events.
[11:24:22.133] <TB2> INFO: 2560 events read in total (297ms).
[11:24:22.133] <TB2> INFO: Test took 1157ms.
[11:24:22.135] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:22.438] <TB2> INFO: Expecting 2560 events.
[11:24:23.292] <TB2> INFO: 2560 events read in total (297ms).
[11:24:23.292] <TB2> INFO: Test took 1157ms.
[11:24:23.294] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:23.597] <TB2> INFO: Expecting 2560 events.
[11:24:24.451] <TB2> INFO: 2560 events read in total (298ms).
[11:24:24.451] <TB2> INFO: Test took 1157ms.
[11:24:24.453] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:24.757] <TB2> INFO: Expecting 2560 events.
[11:24:25.611] <TB2> INFO: 2560 events read in total (298ms).
[11:24:25.611] <TB2> INFO: Test took 1158ms.
[11:24:25.613] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:25.917] <TB2> INFO: Expecting 2560 events.
[11:24:26.770] <TB2> INFO: 2560 events read in total (297ms).
[11:24:26.770] <TB2> INFO: Test took 1157ms.
[11:24:26.772] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:24:27.076] <TB2> INFO: Expecting 2560 events.
[11:24:27.930] <TB2> INFO: 2560 events read in total (298ms).
[11:24:27.930] <TB2> INFO: Test took 1158ms.
[11:24:28.390] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 618 seconds
[11:24:28.390] <TB2> INFO: PH scale (per ROC): 78 83 79 83 73 80 79 91 89 80 87 87 71 84 80 79
[11:24:28.390] <TB2> INFO: PH offset (per ROC): 171 161 176 151 166 169 146 161 154 154 159 148 169 147 161 155
[11:24:28.395] <TB2> INFO: Decoding statistics:
[11:24:28.395] <TB2> INFO: General information:
[11:24:28.395] <TB2> INFO: 16bit words read: 91920
[11:24:28.395] <TB2> INFO: valid events total: 10240
[11:24:28.395] <TB2> INFO: empty events: 7740
[11:24:28.395] <TB2> INFO: valid events with pixels: 2500
[11:24:28.395] <TB2> INFO: valid pixel hits: 2500
[11:24:28.395] <TB2> INFO: Event errors: 0
[11:24:28.395] <TB2> INFO: start marker: 0
[11:24:28.395] <TB2> INFO: stop marker: 0
[11:24:28.395] <TB2> INFO: overflow: 0
[11:24:28.395] <TB2> INFO: invalid 5bit words: 0
[11:24:28.395] <TB2> INFO: invalid XOR eye diagram: 0
[11:24:28.395] <TB2> INFO: frame (failed synchr.): 0
[11:24:28.395] <TB2> INFO: idle data (no TBM trl): 0
[11:24:28.395] <TB2> INFO: no data (only TBM hdr): 0
[11:24:28.395] <TB2> INFO: TBM errors: 0
[11:24:28.395] <TB2> INFO: flawed TBM headers: 0
[11:24:28.395] <TB2> INFO: flawed TBM trailers: 0
[11:24:28.395] <TB2> INFO: event ID mismatches: 0
[11:24:28.395] <TB2> INFO: ROC errors: 0
[11:24:28.395] <TB2> INFO: missing ROC header(s): 0
[11:24:28.395] <TB2> INFO: misplaced readback start: 0
[11:24:28.395] <TB2> INFO: Pixel decoding errors: 0
[11:24:28.395] <TB2> INFO: pixel data incomplete: 0
[11:24:28.395] <TB2> INFO: pixel address: 0
[11:24:28.395] <TB2> INFO: pulse height fill bit: 0
[11:24:28.395] <TB2> INFO: buffer corruption: 0
[11:24:28.579] <TB2> INFO: ######################################################################
[11:24:28.579] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[11:24:28.579] <TB2> INFO: ######################################################################
[11:24:28.589] <TB2> INFO: scanning low vcal = 10
[11:24:28.863] <TB2> INFO: Expecting 41600 events.
[11:24:32.396] <TB2> INFO: 41600 events read in total (2977ms).
[11:24:32.396] <TB2> INFO: Test took 3807ms.
[11:24:32.398] <TB2> INFO: scanning low vcal = 20
[11:24:32.764] <TB2> INFO: Expecting 41600 events.
[11:24:36.305] <TB2> INFO: 41600 events read in total (2985ms).
[11:24:36.305] <TB2> INFO: Test took 3907ms.
[11:24:36.307] <TB2> INFO: scanning low vcal = 30
[11:24:36.615] <TB2> INFO: Expecting 41600 events.
[11:24:40.168] <TB2> INFO: 41600 events read in total (2997ms).
[11:24:40.169] <TB2> INFO: Test took 3862ms.
[11:24:40.171] <TB2> INFO: scanning low vcal = 40
[11:24:40.466] <TB2> INFO: Expecting 41600 events.
[11:24:44.611] <TB2> INFO: 41600 events read in total (3589ms).
[11:24:44.612] <TB2> INFO: Test took 4441ms.
[11:24:44.614] <TB2> INFO: scanning low vcal = 50
[11:24:44.888] <TB2> INFO: Expecting 41600 events.
[11:24:49.067] <TB2> INFO: 41600 events read in total (3623ms).
[11:24:49.068] <TB2> INFO: Test took 4454ms.
[11:24:49.071] <TB2> INFO: scanning low vcal = 60
[11:24:49.340] <TB2> INFO: Expecting 41600 events.
[11:24:53.520] <TB2> INFO: 41600 events read in total (3623ms).
[11:24:53.521] <TB2> INFO: Test took 4450ms.
[11:24:53.523] <TB2> INFO: scanning low vcal = 70
[11:24:53.801] <TB2> INFO: Expecting 41600 events.
[11:24:58.017] <TB2> INFO: 41600 events read in total (3660ms).
[11:24:58.018] <TB2> INFO: Test took 4495ms.
[11:24:58.020] <TB2> INFO: scanning low vcal = 80
[11:24:58.282] <TB2> INFO: Expecting 41600 events.
[11:25:02.462] <TB2> INFO: 41600 events read in total (3624ms).
[11:25:02.463] <TB2> INFO: Test took 4443ms.
[11:25:02.465] <TB2> INFO: scanning low vcal = 90
[11:25:02.734] <TB2> INFO: Expecting 41600 events.
[11:25:06.896] <TB2> INFO: 41600 events read in total (3606ms).
[11:25:06.897] <TB2> INFO: Test took 4432ms.
[11:25:06.900] <TB2> INFO: scanning low vcal = 100
[11:25:07.165] <TB2> INFO: Expecting 41600 events.
[11:25:11.371] <TB2> INFO: 41600 events read in total (3649ms).
[11:25:11.372] <TB2> INFO: Test took 4472ms.
[11:25:11.374] <TB2> INFO: scanning low vcal = 110
[11:25:11.637] <TB2> INFO: Expecting 41600 events.
[11:25:15.867] <TB2> INFO: 41600 events read in total (3674ms).
[11:25:15.868] <TB2> INFO: Test took 4494ms.
[11:25:15.871] <TB2> INFO: scanning low vcal = 120
[11:25:16.168] <TB2> INFO: Expecting 41600 events.
[11:25:20.338] <TB2> INFO: 41600 events read in total (3614ms).
[11:25:20.338] <TB2> INFO: Test took 4467ms.
[11:25:20.341] <TB2> INFO: scanning low vcal = 130
[11:25:20.601] <TB2> INFO: Expecting 41600 events.
[11:25:24.837] <TB2> INFO: 41600 events read in total (3680ms).
[11:25:24.837] <TB2> INFO: Test took 4496ms.
[11:25:24.840] <TB2> INFO: scanning low vcal = 140
[11:25:25.123] <TB2> INFO: Expecting 41600 events.
[11:25:29.371] <TB2> INFO: 41600 events read in total (3692ms).
[11:25:29.372] <TB2> INFO: Test took 4532ms.
[11:25:29.375] <TB2> INFO: scanning low vcal = 150
[11:25:29.669] <TB2> INFO: Expecting 41600 events.
[11:25:33.838] <TB2> INFO: 41600 events read in total (3613ms).
[11:25:33.838] <TB2> INFO: Test took 4463ms.
[11:25:33.841] <TB2> INFO: scanning low vcal = 160
[11:25:34.115] <TB2> INFO: Expecting 41600 events.
[11:25:38.292] <TB2> INFO: 41600 events read in total (3621ms).
[11:25:38.292] <TB2> INFO: Test took 4451ms.
[11:25:38.294] <TB2> INFO: scanning low vcal = 170
[11:25:38.567] <TB2> INFO: Expecting 41600 events.
[11:25:42.746] <TB2> INFO: 41600 events read in total (3623ms).
[11:25:42.746] <TB2> INFO: Test took 4451ms.
[11:25:42.750] <TB2> INFO: scanning low vcal = 180
[11:25:43.023] <TB2> INFO: Expecting 41600 events.
[11:25:47.201] <TB2> INFO: 41600 events read in total (3622ms).
[11:25:47.201] <TB2> INFO: Test took 4451ms.
[11:25:47.204] <TB2> INFO: scanning low vcal = 190
[11:25:47.479] <TB2> INFO: Expecting 41600 events.
[11:25:51.652] <TB2> INFO: 41600 events read in total (3617ms).
[11:25:51.653] <TB2> INFO: Test took 4449ms.
[11:25:51.655] <TB2> INFO: scanning low vcal = 200
[11:25:51.921] <TB2> INFO: Expecting 41600 events.
[11:25:56.090] <TB2> INFO: 41600 events read in total (3612ms).
[11:25:56.091] <TB2> INFO: Test took 4436ms.
[11:25:56.093] <TB2> INFO: scanning low vcal = 210
[11:25:56.358] <TB2> INFO: Expecting 41600 events.
[11:26:00.603] <TB2> INFO: 41600 events read in total (3689ms).
[11:26:00.603] <TB2> INFO: Test took 4510ms.
[11:26:00.606] <TB2> INFO: scanning low vcal = 220
[11:26:00.869] <TB2> INFO: Expecting 41600 events.
[11:26:05.093] <TB2> INFO: 41600 events read in total (3668ms).
[11:26:05.094] <TB2> INFO: Test took 4488ms.
[11:26:05.096] <TB2> INFO: scanning low vcal = 230
[11:26:05.360] <TB2> INFO: Expecting 41600 events.
[11:26:09.574] <TB2> INFO: 41600 events read in total (3658ms).
[11:26:09.575] <TB2> INFO: Test took 4478ms.
[11:26:09.577] <TB2> INFO: scanning low vcal = 240
[11:26:09.845] <TB2> INFO: Expecting 41600 events.
[11:26:14.090] <TB2> INFO: 41600 events read in total (3689ms).
[11:26:14.090] <TB2> INFO: Test took 4512ms.
[11:26:14.093] <TB2> INFO: scanning low vcal = 250
[11:26:14.363] <TB2> INFO: Expecting 41600 events.
[11:26:18.588] <TB2> INFO: 41600 events read in total (3669ms).
[11:26:18.589] <TB2> INFO: Test took 4496ms.
[11:26:18.593] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[11:26:18.866] <TB2> INFO: Expecting 41600 events.
[11:26:23.074] <TB2> INFO: 41600 events read in total (3652ms).
[11:26:23.075] <TB2> INFO: Test took 4482ms.
[11:26:23.077] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[11:26:23.338] <TB2> INFO: Expecting 41600 events.
[11:26:27.572] <TB2> INFO: 41600 events read in total (3678ms).
[11:26:27.573] <TB2> INFO: Test took 4496ms.
[11:26:27.580] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[11:26:27.848] <TB2> INFO: Expecting 41600 events.
[11:26:32.067] <TB2> INFO: 41600 events read in total (3663ms).
[11:26:32.067] <TB2> INFO: Test took 4487ms.
[11:26:32.070] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[11:26:32.348] <TB2> INFO: Expecting 41600 events.
[11:26:36.580] <TB2> INFO: 41600 events read in total (3676ms).
[11:26:36.581] <TB2> INFO: Test took 4511ms.
[11:26:36.583] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[11:26:36.855] <TB2> INFO: Expecting 41600 events.
[11:26:41.074] <TB2> INFO: 41600 events read in total (3663ms).
[11:26:41.075] <TB2> INFO: Test took 4492ms.
[11:26:41.550] <TB2> INFO: PixTestGainPedestal::measure() done
[11:27:14.537] <TB2> INFO: PixTestGainPedestal::fit() done
[11:27:14.537] <TB2> INFO: non-linearity mean: 0.957 0.960 0.956 0.957 0.957 0.959 0.953 0.960 0.955 0.960 0.955 0.953 0.951 0.954 0.954 0.953
[11:27:14.537] <TB2> INFO: non-linearity RMS: 0.005 0.006 0.006 0.006 0.006 0.006 0.006 0.005 0.006 0.005 0.006 0.005 0.007 0.005 0.007 0.005
[11:27:14.537] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[11:27:14.556] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[11:27:14.575] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[11:27:14.594] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[11:27:14.614] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[11:27:14.634] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[11:27:14.655] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[11:27:14.675] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[11:27:14.696] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[11:27:14.808] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[11:27:14.831] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[11:27:14.854] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[11:27:14.876] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[11:27:14.898] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[11:27:14.921] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[11:27:14.943] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[11:27:14.966] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 166 seconds
[11:27:14.966] <TB2> INFO: Decoding statistics:
[11:27:14.966] <TB2> INFO: General information:
[11:27:14.966] <TB2> INFO: 16bit words read: 2662400
[11:27:14.966] <TB2> INFO: valid events total: 166400
[11:27:14.966] <TB2> INFO: empty events: 0
[11:27:14.966] <TB2> INFO: valid events with pixels: 166400
[11:27:14.966] <TB2> INFO: valid pixel hits: 665571
[11:27:14.966] <TB2> INFO: Event errors: 0
[11:27:14.966] <TB2> INFO: start marker: 0
[11:27:14.966] <TB2> INFO: stop marker: 0
[11:27:14.966] <TB2> INFO: overflow: 0
[11:27:14.966] <TB2> INFO: invalid 5bit words: 0
[11:27:14.966] <TB2> INFO: invalid XOR eye diagram: 0
[11:27:14.966] <TB2> INFO: frame (failed synchr.): 0
[11:27:14.966] <TB2> INFO: idle data (no TBM trl): 0
[11:27:14.966] <TB2> INFO: no data (only TBM hdr): 0
[11:27:14.966] <TB2> INFO: TBM errors: 0
[11:27:14.966] <TB2> INFO: flawed TBM headers: 0
[11:27:14.966] <TB2> INFO: flawed TBM trailers: 0
[11:27:14.966] <TB2> INFO: event ID mismatches: 0
[11:27:14.966] <TB2> INFO: ROC errors: 0
[11:27:14.966] <TB2> INFO: missing ROC header(s): 0
[11:27:14.966] <TB2> INFO: misplaced readback start: 0
[11:27:14.966] <TB2> INFO: Pixel decoding errors: 0
[11:27:14.966] <TB2> INFO: pixel data incomplete: 0
[11:27:14.966] <TB2> INFO: pixel address: 0
[11:27:14.966] <TB2> INFO: pulse height fill bit: 0
[11:27:14.966] <TB2> INFO: buffer corruption: 0
[11:27:14.975] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C15.dat
[11:27:14.976] <TB2> INFO: ######################################################################
[11:27:14.976] <TB2> INFO: PixTestReadback::doTest()
[11:27:14.976] <TB2> INFO: ######################################################################
[11:27:14.976] <TB2> INFO: ----------------------------------------------------------------------
[11:27:14.976] <TB2> INFO: PixTestReadback::CalibrateVd()
[11:27:14.976] <TB2> INFO: ----------------------------------------------------------------------
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C0.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C1.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C2.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C3.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C4.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C5.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C6.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C7.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C8.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C9.dat
[11:27:24.465] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C10.dat
[11:27:24.466] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C11.dat
[11:27:24.466] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C12.dat
[11:27:24.466] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C13.dat
[11:27:24.466] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C14.dat
[11:27:24.466] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C15.dat
[11:27:24.498] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[11:27:24.498] <TB2> INFO: ----------------------------------------------------------------------
[11:27:24.498] <TB2> INFO: PixTestReadback::CalibrateVa()
[11:27:24.498] <TB2> INFO: ----------------------------------------------------------------------
[11:27:33.991] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C0.dat
[11:27:33.992] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C1.dat
[11:27:33.992] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C2.dat
[11:27:33.992] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C3.dat
[11:27:33.992] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C4.dat
[11:27:33.992] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C5.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C6.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C7.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C8.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C9.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C10.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C11.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C12.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C13.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C14.dat
[11:27:33.993] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C15.dat
[11:27:34.019] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[11:27:34.019] <TB2> INFO: ----------------------------------------------------------------------
[11:27:34.019] <TB2> INFO: PixTestReadback::readbackVbg()
[11:27:34.019] <TB2> INFO: ----------------------------------------------------------------------
[11:27:41.322] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[11:27:41.322] <TB2> INFO: ----------------------------------------------------------------------
[11:27:41.322] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[11:27:41.322] <TB2> INFO: ----------------------------------------------------------------------
[11:27:41.322] <TB2> INFO: Vbg will be calibrated using Vd calibration
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 153.1calibrated Vbg = 1.18859 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 149.2calibrated Vbg = 1.18723 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 153.1calibrated Vbg = 1.18938 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 155.4calibrated Vbg = 1.19313 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 155.5calibrated Vbg = 1.1976 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 156.7calibrated Vbg = 1.19752 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 144.8calibrated Vbg = 1.20607 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 158.8calibrated Vbg = 1.20304 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 158.3calibrated Vbg = 1.20356 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152.4calibrated Vbg = 1.20147 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 147.7calibrated Vbg = 1.19658 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.2calibrated Vbg = 1.19641 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 164calibrated Vbg = 1.19262 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 157calibrated Vbg = 1.19566 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 157.8calibrated Vbg = 1.19778 :::*/*/*/*/
[11:27:41.322] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 149.4calibrated Vbg = 1.20294 :::*/*/*/*/
[11:27:41.324] <TB2> INFO: ----------------------------------------------------------------------
[11:27:41.324] <TB2> INFO: PixTestReadback::CalibrateIa()
[11:27:41.324] <TB2> INFO: ----------------------------------------------------------------------
[11:30:16.780] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C0.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C1.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C2.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C3.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C4.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C5.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C6.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C7.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C8.dat
[11:30:16.781] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C9.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C10.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C11.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C12.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C13.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C14.dat
[11:30:16.782] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//002_FulltestPxar_m20//readbackCal_C15.dat
[11:30:16.813] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[11:30:16.814] <TB2> INFO: PixTestReadback::doTest() done
[11:30:16.814] <TB2> INFO: Decoding statistics:
[11:30:16.814] <TB2> INFO: General information:
[11:30:16.814] <TB2> INFO: 16bit words read: 1024
[11:30:16.814] <TB2> INFO: valid events total: 128
[11:30:16.814] <TB2> INFO: empty events: 128
[11:30:16.814] <TB2> INFO: valid events with pixels: 0
[11:30:16.814] <TB2> INFO: valid pixel hits: 0
[11:30:16.814] <TB2> INFO: Event errors: 0
[11:30:16.814] <TB2> INFO: start marker: 0
[11:30:16.814] <TB2> INFO: stop marker: 0
[11:30:16.814] <TB2> INFO: overflow: 0
[11:30:16.814] <TB2> INFO: invalid 5bit words: 0
[11:30:16.814] <TB2> INFO: invalid XOR eye diagram: 0
[11:30:16.814] <TB2> INFO: frame (failed synchr.): 0
[11:30:16.814] <TB2> INFO: idle data (no TBM trl): 0
[11:30:16.814] <TB2> INFO: no data (only TBM hdr): 0
[11:30:16.814] <TB2> INFO: TBM errors: 0
[11:30:16.814] <TB2> INFO: flawed TBM headers: 0
[11:30:16.814] <TB2> INFO: flawed TBM trailers: 0
[11:30:16.814] <TB2> INFO: event ID mismatches: 0
[11:30:16.814] <TB2> INFO: ROC errors: 0
[11:30:16.814] <TB2> INFO: missing ROC header(s): 0
[11:30:16.814] <TB2> INFO: misplaced readback start: 0
[11:30:16.814] <TB2> INFO: Pixel decoding errors: 0
[11:30:16.814] <TB2> INFO: pixel data incomplete: 0
[11:30:16.814] <TB2> INFO: pixel address: 0
[11:30:16.814] <TB2> INFO: pulse height fill bit: 0
[11:30:16.814] <TB2> INFO: buffer corruption: 0
[11:30:16.833] <TB2> INFO: Decoding statistics:
[11:30:16.833] <TB2> INFO: General information:
[11:30:16.833] <TB2> INFO: 16bit words read: 2755344
[11:30:16.833] <TB2> INFO: valid events total: 176768
[11:30:16.833] <TB2> INFO: empty events: 7868
[11:30:16.833] <TB2> INFO: valid events with pixels: 168900
[11:30:16.833] <TB2> INFO: valid pixel hits: 668071
[11:30:16.833] <TB2> INFO: Event errors: 0
[11:30:16.833] <TB2> INFO: start marker: 0
[11:30:16.833] <TB2> INFO: stop marker: 0
[11:30:16.833] <TB2> INFO: overflow: 0
[11:30:16.833] <TB2> INFO: invalid 5bit words: 0
[11:30:16.833] <TB2> INFO: invalid XOR eye diagram: 0
[11:30:16.833] <TB2> INFO: frame (failed synchr.): 0
[11:30:16.833] <TB2> INFO: idle data (no TBM trl): 0
[11:30:16.833] <TB2> INFO: no data (only TBM hdr): 0
[11:30:16.833] <TB2> INFO: TBM errors: 0
[11:30:16.833] <TB2> INFO: flawed TBM headers: 0
[11:30:16.833] <TB2> INFO: flawed TBM trailers: 0
[11:30:16.833] <TB2> INFO: event ID mismatches: 0
[11:30:16.833] <TB2> INFO: ROC errors: 0
[11:30:16.833] <TB2> INFO: missing ROC header(s): 0
[11:30:16.833] <TB2> INFO: misplaced readback start: 0
[11:30:16.833] <TB2> INFO: Pixel decoding errors: 0
[11:30:16.833] <TB2> INFO: pixel data incomplete: 0
[11:30:16.833] <TB2> INFO: pixel address: 0
[11:30:16.833] <TB2> INFO: pulse height fill bit: 0
[11:30:16.833] <TB2> INFO: buffer corruption: 0
[11:30:16.833] <TB2> INFO: enter test to run
[11:30:16.833] <TB2> INFO: test: exit no parameter change
[11:30:17.007] <TB2> QUIET: Connection to board 156 closed.
[11:30:17.086] <TB2> INFO: pXar: this is the end, my friend