[12:08:03.781] <TB0> INFO: *** Welcome to pxar ***
[12:08:03.781] <TB0> INFO: *** Today: 2015/12/15
[12:08:04.925] <TB0> INFO: *** Version: 3197
[12:08:04.925] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C15.dat
[12:08:04.926] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:08:04.926] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//defaultMaskFile.dat
[12:08:04.926] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters_C15.dat
[12:08:04.989] <TB0> INFO: clk: 4
[12:08:04.989] <TB0> INFO: ctr: 4
[12:08:04.989] <TB0> INFO: sda: 19
[12:08:04.989] <TB0> INFO: tin: 9
[12:08:04.989] <TB0> INFO: level: 15
[12:08:04.989] <TB0> INFO: triggerdelay: 0
[12:08:04.989] <TB0> QUIET: Instanciating API for pxar prod-12
[12:08:04.989] <TB0> INFO: Log level: INFO
[12:08:04.997] <TB0> INFO: Found DTB DTB_WS6AYH
[12:08:05.007] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[12:08:05.010] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[12:08:05.013] <TB0> INFO: RPC call hashes of host and DTB match: 398089610
[12:08:06.523] <TB0> INFO: DUT info:
[12:08:06.523] <TB0> INFO: The DUT currently contains the following objects:
[12:08:06.523] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[12:08:06.523] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:08:06.523] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:08:06.523] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:08:06.523] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.523] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:08:06.924] <TB0> INFO: enter 'restricted' command line mode
[12:08:06.924] <TB0> INFO: enter test to run
[12:08:06.924] <TB0> INFO: test: pretest no parameter change
[12:08:06.924] <TB0> INFO: running: pretest
[12:08:06.928] <TB0> INFO: ######################################################################
[12:08:06.928] <TB0> INFO: PixTestPretest::doTest()
[12:08:06.928] <TB0> INFO: ######################################################################
[12:08:06.930] <TB0> INFO: ----------------------------------------------------------------------
[12:08:06.930] <TB0> INFO: PixTestPretest::programROC()
[12:08:06.930] <TB0> INFO: ----------------------------------------------------------------------
[12:08:24.946] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:08:24.946] <TB0> INFO: IA differences per ROC: 20.1 18.5 20.1 19.3 20.9 19.3 16.9 19.3 19.3 20.9 19.3 18.5 17.7 16.9 18.5 20.9
[12:08:25.010] <TB0> INFO: ----------------------------------------------------------------------
[12:08:25.010] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:08:25.010] <TB0> INFO: ----------------------------------------------------------------------
[12:08:46.294] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 383.5 mA = 23.9688 mA/ROC
[12:08:46.294] <TB0> INFO: i(loss) [mA/ROC]: 18.5 19.3 18.5 19.3 18.5 19.3 18.5 19.3 19.3 17.7 19.3 19.3 18.5 18.5 19.3 18.5
[12:08:46.322] <TB0> INFO: ----------------------------------------------------------------------
[12:08:46.322] <TB0> INFO: PixTestPretest::findTiming()
[12:08:46.322] <TB0> INFO: ----------------------------------------------------------------------
[12:08:46.322] <TB0> INFO: PixTestCmd::init()
[12:08:46.934] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!
[12:10:37.469] <TB0> INFO: TBM phases: 160MHz: 4, 400MHz: 6, TBM delays: ROC(0/1):3, header/trailer: 1, token: 0
[12:10:37.469] <TB0> INFO: (success/tries = 100/100), width = 4
[12:10:37.471] <TB0> INFO: ----------------------------------------------------------------------
[12:10:37.471] <TB0> INFO: PixTestPretest::findWorkingPixel()
[12:10:37.471] <TB0> INFO: ----------------------------------------------------------------------
[12:10:37.609] <TB0> INFO: Expecting 231680 events.
[12:10:46.121] <TB0> INFO: 231680 events read in total (7796ms).
[12:10:46.125] <TB0> INFO: Test took 8651ms.
[12:10:46.429] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:10:46.459] <TB0> INFO: ----------------------------------------------------------------------
[12:10:46.459] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[12:10:46.459] <TB0> INFO: ----------------------------------------------------------------------
[12:10:46.594] <TB0> INFO: Expecting 231680 events.
[12:10:55.293] <TB0> INFO: 231680 events read in total (7984ms).
[12:10:55.298] <TB0> INFO: Test took 8835ms.
[12:10:55.593] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[12:10:55.593] <TB0> INFO: CalDel: 153 142 143 125 146 143 122 144 131 167 137 149 149 140 139 163
[12:10:55.593] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[12:10:55.595] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C0.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C1.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C2.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C3.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C4.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C5.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C6.dat
[12:10:55.596] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C7.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C8.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C9.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C10.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C11.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C12.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C13.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C14.dat
[12:10:55.597] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters_C15.dat
[12:10:55.597] <TB0> INFO: write tbm parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//tbmParameters_C0a.dat
[12:10:55.597] <TB0> INFO: write tbm parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:10:55.598] <TB0> INFO: PixTestPretest::doTest() done, duration: 168 seconds
[12:10:55.662] <TB0> INFO: enter test to run
[12:10:55.662] <TB0> INFO: test: fulltest no parameter change
[12:10:55.662] <TB0> INFO: running: fulltest
[12:10:55.662] <TB0> INFO: ######################################################################
[12:10:55.662] <TB0> INFO: PixTestFullTest::doTest()
[12:10:55.662] <TB0> INFO: ######################################################################
[12:10:55.663] <TB0> INFO: ######################################################################
[12:10:55.663] <TB0> INFO: PixTestAlive::doTest()
[12:10:55.663] <TB0> INFO: ######################################################################
[12:10:55.665] <TB0> INFO: ----------------------------------------------------------------------
[12:10:55.665] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:10:55.665] <TB0> INFO: ----------------------------------------------------------------------
[12:10:55.995] <TB0> INFO: Expecting 41600 events.
[12:11:00.289] <TB0> INFO: 41600 events read in total (3578ms).
[12:11:00.289] <TB0> INFO: Test took 4622ms.
[12:11:00.295] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:00.585] <TB0> INFO: PixTestAlive::aliveTest() done
[12:11:00.585] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:11:00.587] <TB0> INFO: ----------------------------------------------------------------------
[12:11:00.587] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:11:00.587] <TB0> INFO: ----------------------------------------------------------------------
[12:11:00.901] <TB0> INFO: Expecting 41600 events.
[12:11:04.017] <TB0> INFO: 41600 events read in total (2400ms).
[12:11:04.017] <TB0> INFO: Test took 3428ms.
[12:11:04.017] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:04.017] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:11:04.329] <TB0> INFO: PixTestAlive::maskTest() done
[12:11:04.330] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:11:04.331] <TB0> INFO: ----------------------------------------------------------------------
[12:11:04.331] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:11:04.331] <TB0> INFO: ----------------------------------------------------------------------
[12:11:04.637] <TB0> INFO: Expecting 41600 events.
[12:11:08.946] <TB0> INFO: 41600 events read in total (3593ms).
[12:11:08.946] <TB0> INFO: Test took 4614ms.
[12:11:08.953] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:09.249] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[12:11:09.249] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:11:09.249] <TB0> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[12:11:09.249] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:09.249] <TB0> INFO: Decoding statistics:
[12:11:09.249] <TB0> INFO: General information:
[12:11:09.249] <TB0> INFO: 16bit words read: 0
[12:11:09.249] <TB0> INFO: valid events total: 0
[12:11:09.249] <TB0> INFO: empty events: 0
[12:11:09.249] <TB0> INFO: valid events with pixels: 0
[12:11:09.249] <TB0> INFO: valid pixel hits: 0
[12:11:09.249] <TB0> INFO: Event errors: 0
[12:11:09.249] <TB0> INFO: start marker: 0
[12:11:09.249] <TB0> INFO: stop marker: 0
[12:11:09.249] <TB0> INFO: overflow: 0
[12:11:09.249] <TB0> INFO: invalid 5bit words: 0
[12:11:09.250] <TB0> INFO: invalid XOR eye diagram: 0
[12:11:09.250] <TB0> INFO: TBM errors: 0
[12:11:09.250] <TB0> INFO: flawed TBM headers: 0
[12:11:09.250] <TB0> INFO: flawed TBM trailers: 0
[12:11:09.250] <TB0> INFO: event ID mismatches: 0
[12:11:09.250] <TB0> INFO: ROC errors: 0
[12:11:09.250] <TB0> INFO: missing ROC header(s): 0
[12:11:09.250] <TB0> INFO: misplaced readback start: 0
[12:11:09.250] <TB0> INFO: Pixel decoding errors: 0
[12:11:09.250] <TB0> INFO: pixel data incomplete: 0
[12:11:09.250] <TB0> INFO: pixel address: 0
[12:11:09.250] <TB0> INFO: pulse height fill bit: 0
[12:11:09.250] <TB0> INFO: buffer corruption: 0
[12:11:09.263] <TB0> INFO: ######################################################################
[12:11:09.263] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:11:09.263] <TB0> INFO: ######################################################################
[12:11:09.265] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:11:09.276] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:11:09.276] <TB0> INFO: run 1 of 1
[12:11:09.583] <TB0> INFO: Expecting 3120000 events.
[12:11:50.113] <TB0> INFO: 884425 events read in total (39814ms).
[12:12:28.746] <TB0> INFO: 1751240 events read in total (78448ms).
[12:13:08.349] <TB0> INFO: 2626745 events read in total (118051ms).
[12:13:31.977] <TB0> INFO: 3120000 events read in total (141678ms).
[12:13:32.030] <TB0> INFO: Test took 142754ms.
[12:13:32.123] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:55.227] <TB0> INFO: PixTestBBMap::doTest() done, duration: 165 seconds
[12:13:55.227] <TB0> INFO: number of dead bumps (per ROC): 7 0 0 0 13 2 0 1 0 0 0 0 0 0 0 32
[12:13:55.227] <TB0> INFO: separation cut (per ROC): 91 87 99 92 84 83 93 92 82 80 92 87 88 89 89 81
[12:13:55.227] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:55.227] <TB0> INFO: Decoding statistics:
[12:13:55.227] <TB0> INFO: General information:
[12:13:55.227] <TB0> INFO: 16bit words read: 0
[12:13:55.227] <TB0> INFO: valid events total: 0
[12:13:55.227] <TB0> INFO: empty events: 0
[12:13:55.227] <TB0> INFO: valid events with pixels: 0
[12:13:55.227] <TB0> INFO: valid pixel hits: 0
[12:13:55.227] <TB0> INFO: Event errors: 0
[12:13:55.227] <TB0> INFO: start marker: 0
[12:13:55.227] <TB0> INFO: stop marker: 0
[12:13:55.227] <TB0> INFO: overflow: 0
[12:13:55.227] <TB0> INFO: invalid 5bit words: 0
[12:13:55.227] <TB0> INFO: invalid XOR eye diagram: 0
[12:13:55.227] <TB0> INFO: TBM errors: 0
[12:13:55.227] <TB0> INFO: flawed TBM headers: 0
[12:13:55.227] <TB0> INFO: flawed TBM trailers: 0
[12:13:55.227] <TB0> INFO: event ID mismatches: 0
[12:13:55.227] <TB0> INFO: ROC errors: 0
[12:13:55.227] <TB0> INFO: missing ROC header(s): 0
[12:13:55.227] <TB0> INFO: misplaced readback start: 0
[12:13:55.227] <TB0> INFO: Pixel decoding errors: 0
[12:13:55.227] <TB0> INFO: pixel data incomplete: 0
[12:13:55.227] <TB0> INFO: pixel address: 0
[12:13:55.227] <TB0> INFO: pulse height fill bit: 0
[12:13:55.227] <TB0> INFO: buffer corruption: 0
[12:13:55.267] <TB0> INFO: ######################################################################
[12:13:55.267] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:13:55.267] <TB0> INFO: ######################################################################
[12:13:55.267] <TB0> INFO: ----------------------------------------------------------------------
[12:13:55.267] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:13:55.267] <TB0> INFO: ----------------------------------------------------------------------
[12:13:55.267] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:13:55.275] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[12:13:55.275] <TB0> INFO: run 1 of 1
[12:13:55.583] <TB0> INFO: Expecting 26208000 events.
[12:14:25.654] <TB0> INFO: 859900 events read in total (29355ms).
[12:14:53.306] <TB0> INFO: 1706700 events read in total (57007ms).
[12:15:22.784] <TB0> INFO: 2551500 events read in total (86485ms).
[12:15:52.628] <TB0> INFO: 3396500 events read in total (116329ms).
[12:16:22.248] <TB0> INFO: 4242700 events read in total (145949ms).
[12:16:51.472] <TB0> INFO: 5088350 events read in total (175173ms).
[12:17:21.088] <TB0> INFO: 5933200 events read in total (204789ms).
[12:17:51.058] <TB0> INFO: 6778150 events read in total (234759ms).
[12:18:20.889] <TB0> INFO: 7623050 events read in total (264590ms).
[12:18:50.983] <TB0> INFO: 8466100 events read in total (294684ms).
[12:19:21.625] <TB0> INFO: 9310700 events read in total (325326ms).
[12:19:51.855] <TB0> INFO: 10153950 events read in total (355556ms).
[12:20:22.065] <TB0> INFO: 10995450 events read in total (385766ms).
[12:20:52.391] <TB0> INFO: 11836650 events read in total (416093ms).
[12:21:22.068] <TB0> INFO: 12679000 events read in total (445769ms).
[12:21:51.546] <TB0> INFO: 13512700 events read in total (475247ms).
[12:22:21.635] <TB0> INFO: 14345600 events read in total (505336ms).
[12:22:51.687] <TB0> INFO: 15178000 events read in total (535388ms).
[12:23:21.451] <TB0> INFO: 16008000 events read in total (565152ms).
[12:23:51.380] <TB0> INFO: 16839000 events read in total (595081ms).
[12:24:20.782] <TB0> INFO: 17669150 events read in total (624483ms).
[12:24:50.051] <TB0> INFO: 18498550 events read in total (653752ms).
[12:25:19.621] <TB0> INFO: 19327900 events read in total (683322ms).
[12:25:49.168] <TB0> INFO: 20157650 events read in total (712869ms).
[12:26:18.562] <TB0> INFO: 20984300 events read in total (742263ms).
[12:26:47.607] <TB0> INFO: 21814100 events read in total (771308ms).
[12:27:18.176] <TB0> INFO: 22640800 events read in total (801877ms).
[12:27:48.294] <TB0> INFO: 23471850 events read in total (831995ms).
[12:28:18.834] <TB0> INFO: 24303250 events read in total (862535ms).
[12:28:49.389] <TB0> INFO: 25133900 events read in total (893090ms).
[12:29:19.399] <TB0> INFO: 25972500 events read in total (923100ms).
[12:29:28.690] <TB0> INFO: 26208000 events read in total (932391ms).
[12:29:28.719] <TB0> INFO: Test took 933444ms.
[12:29:28.805] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:29:28.987] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:30.446] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:31.915] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:33.405] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:34.860] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:36.371] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:37.892] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:39.685] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:41.419] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:43.144] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:44.725] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:46.175] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:47.665] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:49.101] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:50.510] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:51.998] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:29:53.406] <TB0> INFO: PixTestScurves::scurves() done
[12:29:53.406] <TB0> INFO: Vcal mean: 84.58 89.78 84.80 83.83 91.80 80.27 83.80 93.96 74.23 73.78 81.85 77.38 78.71 74.21 84.59 90.59
[12:29:53.406] <TB0> INFO: Vcal RMS: 4.72 6.90 4.92 4.56 6.35 4.26 5.14 5.26 4.46 4.89 4.81 3.82 4.46 4.06 5.07 5.74
[12:29:53.406] <TB0> INFO: PixTestScurves::fullTest() done, duration: 958 seconds
[12:29:53.406] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:29:53.406] <TB0> INFO: Decoding statistics:
[12:29:53.406] <TB0> INFO: General information:
[12:29:53.406] <TB0> INFO: 16bit words read: 0
[12:29:53.406] <TB0> INFO: valid events total: 0
[12:29:53.406] <TB0> INFO: empty events: 0
[12:29:53.406] <TB0> INFO: valid events with pixels: 0
[12:29:53.406] <TB0> INFO: valid pixel hits: 0
[12:29:53.406] <TB0> INFO: Event errors: 0
[12:29:53.406] <TB0> INFO: start marker: 0
[12:29:53.406] <TB0> INFO: stop marker: 0
[12:29:53.406] <TB0> INFO: overflow: 0
[12:29:53.406] <TB0> INFO: invalid 5bit words: 0
[12:29:53.406] <TB0> INFO: invalid XOR eye diagram: 0
[12:29:53.406] <TB0> INFO: TBM errors: 0
[12:29:53.406] <TB0> INFO: flawed TBM headers: 0
[12:29:53.406] <TB0> INFO: flawed TBM trailers: 0
[12:29:53.406] <TB0> INFO: event ID mismatches: 0
[12:29:53.406] <TB0> INFO: ROC errors: 0
[12:29:53.406] <TB0> INFO: missing ROC header(s): 0
[12:29:53.406] <TB0> INFO: misplaced readback start: 0
[12:29:53.406] <TB0> INFO: Pixel decoding errors: 0
[12:29:53.406] <TB0> INFO: pixel data incomplete: 0
[12:29:53.406] <TB0> INFO: pixel address: 0
[12:29:53.406] <TB0> INFO: pulse height fill bit: 0
[12:29:53.406] <TB0> INFO: buffer corruption: 0
[12:29:53.477] <TB0> INFO: ######################################################################
[12:29:53.477] <TB0> INFO: PixTestTrim::doTest()
[12:29:53.477] <TB0> INFO: ######################################################################
[12:29:53.479] <TB0> INFO: ----------------------------------------------------------------------
[12:29:53.479] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[12:29:53.479] <TB0> INFO: ----------------------------------------------------------------------
[12:29:53.557] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[12:29:53.557] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:29:53.566] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:29:53.566] <TB0> INFO: run 1 of 1
[12:29:53.880] <TB0> INFO: Expecting 6281600 events.
[12:30:32.531] <TB0> INFO: 1076200 events read in total (37935ms).
[12:31:07.604] <TB0> INFO: 2146480 events read in total (73008ms).
[12:31:45.371] <TB0> INFO: 3209520 events read in total (110775ms).
[12:32:23.132] <TB0> INFO: 4278950 events read in total (148536ms).
[12:32:59.801] <TB0> INFO: 5352520 events read in total (185205ms).
[12:33:32.539] <TB0> INFO: 6281600 events read in total (217943ms).
[12:33:32.573] <TB0> INFO: Test took 219007ms.
[12:33:32.626] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:51.520] <TB0> INFO: ROC 0 VthrComp = 90
[12:33:51.520] <TB0> INFO: ROC 1 VthrComp = 91
[12:33:51.520] <TB0> INFO: ROC 2 VthrComp = 92
[12:33:51.520] <TB0> INFO: ROC 3 VthrComp = 91
[12:33:51.520] <TB0> INFO: ROC 4 VthrComp = 93
[12:33:51.520] <TB0> INFO: ROC 5 VthrComp = 86
[12:33:51.520] <TB0> INFO: ROC 6 VthrComp = 86
[12:33:51.520] <TB0> INFO: ROC 7 VthrComp = 96
[12:33:51.520] <TB0> INFO: ROC 8 VthrComp = 80
[12:33:51.521] <TB0> INFO: ROC 9 VthrComp = 76
[12:33:51.521] <TB0> INFO: ROC 10 VthrComp = 87
[12:33:51.521] <TB0> INFO: ROC 11 VthrComp = 85
[12:33:51.521] <TB0> INFO: ROC 12 VthrComp = 80
[12:33:51.521] <TB0> INFO: ROC 13 VthrComp = 81
[12:33:51.521] <TB0> INFO: ROC 14 VthrComp = 90
[12:33:51.521] <TB0> INFO: ROC 15 VthrComp = 91
[12:33:51.521] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[12:33:51.521] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:33:51.531] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:33:51.531] <TB0> INFO: run 1 of 1
[12:33:51.862] <TB0> INFO: Expecting 6281600 events.
[12:34:25.641] <TB0> INFO: 756150 events read in total (33064ms).
[12:34:57.395] <TB0> INFO: 1509930 events read in total (64818ms).
[12:35:31.930] <TB0> INFO: 2263930 events read in total (99353ms).
[12:36:07.185] <TB0> INFO: 3018340 events read in total (134608ms).
[12:36:41.908] <TB0> INFO: 3767470 events read in total (169331ms).
[12:37:17.017] <TB0> INFO: 4513290 events read in total (204441ms).
[12:37:51.523] <TB0> INFO: 5257220 events read in total (238946ms).
[12:38:26.609] <TB0> INFO: 6001850 events read in total (274032ms).
[12:38:39.415] <TB0> INFO: 6281600 events read in total (286838ms).
[12:38:39.456] <TB0> INFO: Test took 287925ms.
[12:38:39.595] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:39:03.183] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 56.7197 for pixel 51/45 mean/min/max = 44.9871/33.0683/56.9059
[12:39:03.183] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 62.0959 for pixel 22/79 mean/min/max = 47.0503/31.8177/62.2828
[12:39:03.183] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 56.861 for pixel 6/58 mean/min/max = 44.4501/32.0299/56.8703
[12:39:03.183] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 56.0017 for pixel 51/1 mean/min/max = 44.3337/32.5795/56.0879
[12:39:03.184] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 59.9124 for pixel 9/79 mean/min/max = 45.782/31.622/59.9421
[12:39:03.184] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 57.1791 for pixel 6/3 mean/min/max = 44.8752/32.5435/57.207
[12:39:03.184] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 58.7048 for pixel 1/58 mean/min/max = 45.5992/32.3556/58.8428
[12:39:03.184] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 59.1243 for pixel 3/78 mean/min/max = 45.6051/31.9249/59.2853
[12:39:03.185] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 56.1851 for pixel 13/78 mean/min/max = 44.7319/33.0363/56.4275
[12:39:03.185] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 60.633 for pixel 17/70 mean/min/max = 47.5351/34.4008/60.6695
[12:39:03.185] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 58.5581 for pixel 25/2 mean/min/max = 45.4732/31.9352/59.0113
[12:39:03.185] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 55.0853 for pixel 0/3 mean/min/max = 44.0334/32.4713/55.5956
[12:39:03.186] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 59.0462 for pixel 22/70 mean/min/max = 45.9586/32.8195/59.0977
[12:39:03.186] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 54.8682 for pixel 51/7 mean/min/max = 43.8295/32.6382/55.0209
[12:39:03.186] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 57.8893 for pixel 0/10 mean/min/max = 45.1069/32.317/57.8968
[12:39:03.186] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 60.8017 for pixel 0/79 mean/min/max = 46.4529/31.902/61.0038
[12:39:03.187] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:39:03.317] <TB0> INFO: Expecting 514560 events.
[12:39:15.964] <TB0> INFO: 514560 events read in total (11931ms).
[12:39:15.969] <TB0> INFO: Expecting 514560 events.
[12:39:28.288] <TB0> INFO: 514560 events read in total (11748ms).
[12:39:28.295] <TB0> INFO: Expecting 514560 events.
[12:39:40.323] <TB0> INFO: 514560 events read in total (11450ms).
[12:39:40.331] <TB0> INFO: Expecting 514560 events.
[12:39:50.830] <TB0> INFO: 514560 events read in total (9921ms).
[12:39:50.840] <TB0> INFO: Expecting 514560 events.
[12:40:01.454] <TB0> INFO: 514560 events read in total (10040ms).
[12:40:01.467] <TB0> INFO: Expecting 514560 events.
[12:40:12.173] <TB0> INFO: 514560 events read in total (10134ms).
[12:40:12.190] <TB0> INFO: Expecting 514560 events.
[12:40:24.143] <TB0> INFO: 514560 events read in total (11391ms).
[12:40:24.159] <TB0> INFO: Expecting 514560 events.
[12:40:35.198] <TB0> INFO: 514560 events read in total (10471ms).
[12:40:35.216] <TB0> INFO: Expecting 514560 events.
[12:40:46.527] <TB0> INFO: 514560 events read in total (10749ms).
[12:40:46.550] <TB0> INFO: Expecting 514560 events.
[12:40:58.125] <TB0> INFO: 514560 events read in total (11020ms).
[12:40:58.152] <TB0> INFO: Expecting 514560 events.
[12:41:09.902] <TB0> INFO: 514560 events read in total (11204ms).
[12:41:09.930] <TB0> INFO: Expecting 514560 events.
[12:41:21.660] <TB0> INFO: 514560 events read in total (11186ms).
[12:41:21.691] <TB0> INFO: Expecting 514560 events.
[12:41:33.257] <TB0> INFO: 514560 events read in total (11017ms).
[12:41:33.284] <TB0> INFO: Expecting 514560 events.
[12:41:44.961] <TB0> INFO: 514560 events read in total (11118ms).
[12:41:44.990] <TB0> INFO: Expecting 514560 events.
[12:41:56.416] <TB0> INFO: 514560 events read in total (10874ms).
[12:41:56.446] <TB0> INFO: Expecting 514560 events.
[12:42:07.909] <TB0> INFO: 514560 events read in total (10903ms).
[12:42:07.947] <TB0> INFO: Test took 184760ms.
[12:42:09.115] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:42:09.124] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:42:09.124] <TB0> INFO: run 1 of 1
[12:42:09.425] <TB0> INFO: Expecting 6281600 events.
[12:42:44.891] <TB0> INFO: 742910 events read in total (34750ms).
[12:43:19.098] <TB0> INFO: 1484580 events read in total (68957ms).
[12:43:52.936] <TB0> INFO: 2226200 events read in total (102795ms).
[12:44:28.183] <TB0> INFO: 2968750 events read in total (138042ms).
[12:45:02.787] <TB0> INFO: 3705750 events read in total (172646ms).
[12:45:38.169] <TB0> INFO: 4439010 events read in total (208028ms).
[12:46:12.253] <TB0> INFO: 5170440 events read in total (242112ms).
[12:46:46.062] <TB0> INFO: 5902280 events read in total (275921ms).
[12:47:04.442] <TB0> INFO: 6281600 events read in total (294301ms).
[12:47:04.492] <TB0> INFO: Test took 295368ms.
[12:47:04.650] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:47:29.251] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.059832 .. 50.410116
[12:47:29.328] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 60 (-1/-1) hits flags = 528 (plus default)
[12:47:29.337] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:47:29.337] <TB0> INFO: run 1 of 1
[12:47:29.643] <TB0> INFO: Expecting 2537600 events.
[12:48:07.323] <TB0> INFO: 931340 events read in total (36964ms).
[12:48:42.194] <TB0> INFO: 1859710 events read in total (71835ms).
[12:49:08.695] <TB0> INFO: 2537600 events read in total (98336ms).
[12:49:08.710] <TB0> INFO: Test took 99373ms.
[12:49:08.744] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:49:22.706] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 16.910660 .. 45.992093
[12:49:22.781] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[12:49:22.789] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:49:22.789] <TB0> INFO: run 1 of 1
[12:49:23.091] <TB0> INFO: Expecting 2080000 events.
[12:50:01.835] <TB0> INFO: 933470 events read in total (38029ms).
[12:50:40.011] <TB0> INFO: 1863910 events read in total (76205ms).
[12:50:48.437] <TB0> INFO: 2080000 events read in total (84631ms).
[12:50:48.452] <TB0> INFO: Test took 85663ms.
[12:50:48.483] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:51:02.783] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 20.461468 .. 42.596552
[12:51:02.859] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 10 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:51:02.867] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:51:02.867] <TB0> INFO: run 1 of 1
[12:51:03.170] <TB0> INFO: Expecting 1788800 events.
[12:51:40.574] <TB0> INFO: 937520 events read in total (36688ms).
[12:52:14.451] <TB0> INFO: 1788800 events read in total (70565ms).
[12:52:14.461] <TB0> INFO: Test took 71594ms.
[12:52:14.486] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:52:27.606] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 20.461468 .. 42.086424
[12:52:27.702] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 10 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:52:27.710] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:52:27.711] <TB0> INFO: run 1 of 1
[12:52:28.023] <TB0> INFO: Expecting 1788800 events.
[12:53:04.613] <TB0> INFO: 936590 events read in total (35875ms).
[12:53:37.573] <TB0> INFO: 1788800 events read in total (68835ms).
[12:53:37.586] <TB0> INFO: Test took 69875ms.
[12:53:37.613] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:53:50.926] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[12:53:50.926] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[12:53:50.934] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:53:50.934] <TB0> INFO: run 1 of 1
[12:53:51.237] <TB0> INFO: Expecting 1705600 events.
[12:54:28.839] <TB0> INFO: 879030 events read in total (36887ms).
[12:55:03.639] <TB0> INFO: 1705600 events read in total (71687ms).
[12:55:03.651] <TB0> INFO: Test took 72717ms.
[12:55:03.679] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C0.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C1.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C2.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C3.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C4.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C5.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C6.dat
[12:55:18.442] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C7.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C8.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C9.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C10.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C11.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C12.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C13.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C14.dat
[12:55:18.443] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C15.dat
[12:55:18.444] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C0.dat
[12:55:18.454] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C1.dat
[12:55:18.462] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C2.dat
[12:55:18.470] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C3.dat
[12:55:18.479] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C4.dat
[12:55:18.487] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C5.dat
[12:55:18.497] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C6.dat
[12:55:18.505] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C7.dat
[12:55:18.513] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C8.dat
[12:55:18.521] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C9.dat
[12:55:18.529] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C10.dat
[12:55:18.540] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C11.dat
[12:55:18.548] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C12.dat
[12:55:18.557] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C13.dat
[12:55:18.565] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C14.dat
[12:55:18.573] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//trimParameters35_C15.dat
[12:55:18.582] <TB0> INFO: PixTestTrim::trimTest() done
[12:55:18.582] <TB0> INFO: vtrim: 98 106 86 85 103 94 89 97 91 104 103 94 95 91 83 89
[12:55:18.582] <TB0> INFO: vthrcomp: 90 91 92 91 93 86 86 96 80 76 87 85 80 81 90 91
[12:55:18.582] <TB0> INFO: vcal mean: 34.97 34.98 34.85 34.98 34.95 34.97 34.99 35.01 34.98 34.98 34.97 34.96 35.00 34.97 35.01 35.00
[12:55:18.582] <TB0> INFO: vcal RMS: 0.77 0.91 0.80 0.77 0.84 0.84 0.85 0.87 0.74 0.83 0.82 0.77 0.92 0.76 0.80 0.85
[12:55:18.582] <TB0> INFO: bits mean: 9.29 9.26 9.50 9.44 9.34 9.57 8.98 9.35 9.33 8.93 9.79 9.23 9.32 9.80 9.01 8.68
[12:55:18.582] <TB0> INFO: bits RMS: 2.68 2.72 2.73 2.72 2.78 2.62 2.84 2.75 2.67 2.47 2.55 2.77 2.67 2.57 2.85 2.99
[12:55:18.589] <TB0> INFO: ----------------------------------------------------------------------
[12:55:18.589] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[12:55:18.589] <TB0> INFO: ----------------------------------------------------------------------
[12:55:18.591] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[12:55:18.601] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:55:18.601] <TB0> INFO: run 1 of 1
[12:55:18.946] <TB0> INFO: Expecting 4160000 events.
[12:56:02.237] <TB0> INFO: 896205 events read in total (42575ms).
[12:56:43.714] <TB0> INFO: 1787720 events read in total (84052ms).
[12:57:23.618] <TB0> INFO: 2671260 events read in total (123956ms).
[12:58:05.271] <TB0> INFO: 3551615 events read in total (165609ms).
[12:58:32.404] <TB0> INFO: 4160000 events read in total (192742ms).
[12:58:32.441] <TB0> INFO: Test took 193841ms.
[12:58:32.556] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:01.600] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 156 (-1/-1) hits flags = 528 (plus default)
[12:59:01.608] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:59:01.608] <TB0> INFO: run 1 of 1
[12:59:01.914] <TB0> INFO: Expecting 3265600 events.
[12:59:45.049] <TB0> INFO: 948200 events read in total (42420ms).
[13:00:25.132] <TB0> INFO: 1886040 events read in total (82503ms).
[13:01:06.785] <TB0> INFO: 2813565 events read in total (124156ms).
[13:01:27.270] <TB0> INFO: 3265600 events read in total (144641ms).
[13:01:27.307] <TB0> INFO: Test took 145699ms.
[13:01:27.389] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:52.567] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 147 (-1/-1) hits flags = 528 (plus default)
[13:01:52.575] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:01:52.575] <TB0> INFO: run 1 of 1
[13:01:52.876] <TB0> INFO: Expecting 3078400 events.
[13:02:37.019] <TB0> INFO: 972460 events read in total (43427ms).
[13:03:18.393] <TB0> INFO: 1931815 events read in total (84802ms).
[13:03:58.610] <TB0> INFO: 2882390 events read in total (125019ms).
[13:04:08.062] <TB0> INFO: 3078400 events read in total (134470ms).
[13:04:08.089] <TB0> INFO: Test took 135514ms.
[13:04:08.152] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:04:31.263] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 148 (-1/-1) hits flags = 528 (plus default)
[13:04:31.272] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:04:31.272] <TB0> INFO: run 1 of 1
[13:04:31.574] <TB0> INFO: Expecting 3099200 events.
[13:05:15.459] <TB0> INFO: 968480 events read in total (43170ms).
[13:05:55.560] <TB0> INFO: 1924270 events read in total (83271ms).
[13:06:36.387] <TB0> INFO: 2871440 events read in total (124098ms).
[13:06:46.125] <TB0> INFO: 3099200 events read in total (133836ms).
[13:06:46.156] <TB0> INFO: Test took 134884ms.
[13:06:46.220] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:07:10.601] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 147 (-1/-1) hits flags = 528 (plus default)
[13:07:10.610] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:07:10.610] <TB0> INFO: run 1 of 1
[13:07:10.919] <TB0> INFO: Expecting 3078400 events.
[13:07:54.797] <TB0> INFO: 970485 events read in total (43162ms).
[13:08:37.258] <TB0> INFO: 1927795 events read in total (85623ms).
[13:09:19.906] <TB0> INFO: 2877005 events read in total (128271ms).
[13:09:28.916] <TB0> INFO: 3078400 events read in total (137281ms).
[13:09:28.941] <TB0> INFO: Test took 138331ms.
[13:09:29.003] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:09:54.498] <TB0> INFO: PixTestTrim::trimBitTest() done
[13:09:54.500] <TB0> INFO: PixTestTrim::doTest() done, duration: 2401 seconds
[13:09:54.500] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:09:54.500] <TB0> INFO: Decoding statistics:
[13:09:54.500] <TB0> INFO: General information:
[13:09:54.500] <TB0> INFO: 16bit words read: 0
[13:09:54.500] <TB0> INFO: valid events total: 0
[13:09:54.500] <TB0> INFO: empty events: 0
[13:09:54.500] <TB0> INFO: valid events with pixels: 0
[13:09:54.500] <TB0> INFO: valid pixel hits: 0
[13:09:54.500] <TB0> INFO: Event errors: 0
[13:09:54.500] <TB0> INFO: start marker: 0
[13:09:54.500] <TB0> INFO: stop marker: 0
[13:09:54.500] <TB0> INFO: overflow: 0
[13:09:54.500] <TB0> INFO: invalid 5bit words: 0
[13:09:54.500] <TB0> INFO: invalid XOR eye diagram: 0
[13:09:54.500] <TB0> INFO: TBM errors: 0
[13:09:54.500] <TB0> INFO: flawed TBM headers: 0
[13:09:54.500] <TB0> INFO: flawed TBM trailers: 0
[13:09:54.500] <TB0> INFO: event ID mismatches: 0
[13:09:54.500] <TB0> INFO: ROC errors: 0
[13:09:54.500] <TB0> INFO: missing ROC header(s): 0
[13:09:54.500] <TB0> INFO: misplaced readback start: 0
[13:09:54.500] <TB0> INFO: Pixel decoding errors: 0
[13:09:54.500] <TB0> INFO: pixel data incomplete: 0
[13:09:54.500] <TB0> INFO: pixel address: 0
[13:09:54.500] <TB0> INFO: pulse height fill bit: 0
[13:09:54.500] <TB0> INFO: buffer corruption: 0
[13:09:55.195] <TB0> INFO: ######################################################################
[13:09:55.195] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[13:09:55.195] <TB0> INFO: ######################################################################
[13:09:55.509] <TB0> INFO: Expecting 41600 events.
[13:09:59.779] <TB0> INFO: 41600 events read in total (3555ms).
[13:09:59.780] <TB0> INFO: Test took 4583ms.
[13:09:59.786] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:10:00.372] <TB0> INFO: Expecting 41600 events.
[13:10:04.933] <TB0> INFO: 41600 events read in total (3845ms).
[13:10:04.933] <TB0> INFO: Test took 4888ms.
[13:10:04.940] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:10:05.281] <TB0> INFO: Expecting 41600 events.
[13:10:09.736] <TB0> INFO: 41600 events read in total (3740ms).
[13:10:09.736] <TB0> INFO: Test took 4778ms.
[13:10:09.743] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:10:10.095] <TB0> INFO: Expecting 2560 events.
[13:10:11.164] <TB0> INFO: 2560 events read in total (353ms).
[13:10:11.164] <TB0> INFO: Test took 1415ms.
[13:10:11.579] <TB0> INFO: Expecting 2560 events.
[13:10:12.640] <TB0> INFO: 2560 events read in total (346ms).
[13:10:12.640] <TB0> INFO: Test took 1475ms.
[13:10:13.055] <TB0> INFO: Expecting 2560 events.
[13:10:14.117] <TB0> INFO: 2560 events read in total (347ms).
[13:10:14.117] <TB0> INFO: Test took 1476ms.
[13:10:14.531] <TB0> INFO: Expecting 2560 events.
[13:10:15.599] <TB0> INFO: 2560 events read in total (352ms).
[13:10:15.599] <TB0> INFO: Test took 1481ms.
[13:10:16.013] <TB0> INFO: Expecting 2560 events.
[13:10:17.093] <TB0> INFO: 2560 events read in total (364ms).
[13:10:17.093] <TB0> INFO: Test took 1493ms.
[13:10:17.507] <TB0> INFO: Expecting 2560 events.
[13:10:18.587] <TB0> INFO: 2560 events read in total (364ms).
[13:10:18.588] <TB0> INFO: Test took 1495ms.
[13:10:19.000] <TB0> INFO: Expecting 2560 events.
[13:10:20.063] <TB0> INFO: 2560 events read in total (347ms).
[13:10:20.063] <TB0> INFO: Test took 1475ms.
[13:10:20.477] <TB0> INFO: Expecting 2560 events.
[13:10:21.539] <TB0> INFO: 2560 events read in total (346ms).
[13:10:21.540] <TB0> INFO: Test took 1477ms.
[13:10:21.953] <TB0> INFO: Expecting 2560 events.
[13:10:23.029] <TB0> INFO: 2560 events read in total (360ms).
[13:10:23.029] <TB0> INFO: Test took 1489ms.
[13:10:23.442] <TB0> INFO: Expecting 2560 events.
[13:10:24.547] <TB0> INFO: 2560 events read in total (389ms).
[13:10:24.547] <TB0> INFO: Test took 1517ms.
[13:10:24.961] <TB0> INFO: Expecting 2560 events.
[13:10:26.022] <TB0> INFO: 2560 events read in total (347ms).
[13:10:26.023] <TB0> INFO: Test took 1476ms.
[13:10:26.440] <TB0> INFO: Expecting 2560 events.
[13:10:27.509] <TB0> INFO: 2560 events read in total (353ms).
[13:10:27.509] <TB0> INFO: Test took 1486ms.
[13:10:27.923] <TB0> INFO: Expecting 2560 events.
[13:10:28.990] <TB0> INFO: 2560 events read in total (351ms).
[13:10:28.991] <TB0> INFO: Test took 1482ms.
[13:10:29.404] <TB0> INFO: Expecting 2560 events.
[13:10:30.473] <TB0> INFO: 2560 events read in total (353ms).
[13:10:30.474] <TB0> INFO: Test took 1483ms.
[13:10:30.888] <TB0> INFO: Expecting 2560 events.
[13:10:31.952] <TB0> INFO: 2560 events read in total (349ms).
[13:10:31.953] <TB0> INFO: Test took 1479ms.
[13:10:32.367] <TB0> INFO: Expecting 2560 events.
[13:10:33.429] <TB0> INFO: 2560 events read in total (347ms).
[13:10:33.429] <TB0> INFO: Test took 1474ms.
[13:10:33.431] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:10:33.845] <TB0> INFO: Expecting 655360 events.
[13:10:49.014] <TB0> INFO: 655360 events read in total (14453ms).
[13:10:49.025] <TB0> INFO: Expecting 655360 events.
[13:11:05.169] <TB0> INFO: 655360 events read in total (15617ms).
[13:11:05.184] <TB0> INFO: Expecting 655360 events.
[13:11:19.987] <TB0> INFO: 655360 events read in total (14275ms).
[13:11:20.004] <TB0> INFO: Expecting 655360 events.
[13:11:35.756] <TB0> INFO: 655360 events read in total (15224ms).
[13:11:35.781] <TB0> INFO: Expecting 655360 events.
[13:11:52.247] <TB0> INFO: 655360 events read in total (15939ms).
[13:11:52.280] <TB0> INFO: Expecting 655360 events.
[13:12:07.585] <TB0> INFO: 655360 events read in total (14778ms).
[13:12:07.613] <TB0> INFO: Expecting 655360 events.
[13:12:21.316] <TB0> INFO: 655360 events read in total (13176ms).
[13:12:21.345] <TB0> INFO: Expecting 655360 events.
[13:12:34.840] <TB0> INFO: 655360 events read in total (12968ms).
[13:12:34.874] <TB0> INFO: Expecting 655360 events.
[13:12:49.062] <TB0> INFO: 655360 events read in total (13661ms).
[13:12:49.099] <TB0> INFO: Expecting 655360 events.
[13:13:04.526] <TB0> INFO: 655360 events read in total (14900ms).
[13:13:04.566] <TB0> INFO: Expecting 655360 events.
[13:13:20.460] <TB0> INFO: 655360 events read in total (15366ms).
[13:13:20.518] <TB0> INFO: Expecting 655360 events.
[13:13:34.476] <TB0> INFO: 655360 events read in total (13430ms).
[13:13:34.524] <TB0> INFO: Expecting 655360 events.
[13:13:50.047] <TB0> INFO: 655360 events read in total (14996ms).
[13:13:50.098] <TB0> INFO: Expecting 655360 events.
[13:14:05.764] <TB0> INFO: 655360 events read in total (15138ms).
[13:14:05.817] <TB0> INFO: Expecting 655360 events.
[13:14:20.247] <TB0> INFO: 655360 events read in total (13902ms).
[13:14:20.311] <TB0> INFO: Expecting 655360 events.
[13:14:35.809] <TB0> INFO: 655360 events read in total (14971ms).
[13:14:35.872] <TB0> INFO: Test took 242441ms.
[13:14:35.955] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:14:36.264] <TB0> INFO: Expecting 655360 events.
[13:14:51.743] <TB0> INFO: 655360 events read in total (14764ms).
[13:14:51.753] <TB0> INFO: Expecting 655360 events.
[13:15:07.720] <TB0> INFO: 655360 events read in total (15440ms).
[13:15:07.733] <TB0> INFO: Expecting 655360 events.
[13:15:21.231] <TB0> INFO: 655360 events read in total (12971ms).
[13:15:21.249] <TB0> INFO: Expecting 655360 events.
[13:15:34.824] <TB0> INFO: 655360 events read in total (13048ms).
[13:15:34.849] <TB0> INFO: Expecting 655360 events.
[13:15:49.371] <TB0> INFO: 655360 events read in total (13993ms).
[13:15:49.394] <TB0> INFO: Expecting 655360 events.
[13:16:05.026] <TB0> INFO: 655360 events read in total (15105ms).
[13:16:05.053] <TB0> INFO: Expecting 655360 events.
[13:16:20.972] <TB0> INFO: 655360 events read in total (15391ms).
[13:16:21.008] <TB0> INFO: Expecting 655360 events.
[13:16:35.336] <TB0> INFO: 655360 events read in total (13800ms).
[13:16:35.373] <TB0> INFO: Expecting 655360 events.
[13:16:51.277] <TB0> INFO: 655360 events read in total (15377ms).
[13:16:51.319] <TB0> INFO: Expecting 655360 events.
[13:17:07.131] <TB0> INFO: 655360 events read in total (15285ms).
[13:17:07.174] <TB0> INFO: Expecting 655360 events.
[13:17:21.846] <TB0> INFO: 655360 events read in total (14144ms).
[13:17:21.895] <TB0> INFO: Expecting 655360 events.
[13:17:38.189] <TB0> INFO: 655360 events read in total (15766ms).
[13:17:38.238] <TB0> INFO: Expecting 655360 events.
[13:17:53.171] <TB0> INFO: 655360 events read in total (14405ms).
[13:17:53.227] <TB0> INFO: Expecting 655360 events.
[13:18:08.046] <TB0> INFO: 655360 events read in total (14292ms).
[13:18:08.101] <TB0> INFO: Expecting 655360 events.
[13:18:22.064] <TB0> INFO: 655360 events read in total (13435ms).
[13:18:22.148] <TB0> INFO: Expecting 655360 events.
[13:18:36.149] <TB0> INFO: 655360 events read in total (13474ms).
[13:18:36.213] <TB0> INFO: Test took 240258ms.
[13:18:36.426] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.434] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.440] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.449] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.456] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.464] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.472] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.479] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.486] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.493] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.500] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.507] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.514] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:18:36.521] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.528] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:18:36.535] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.542] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:18:36.549] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[13:18:36.556] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[13:18:36.563] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[13:18:36.570] <TB0> INFO: safety margin for low PH: adding 5, margin is now 25
[13:18:36.577] <TB0> INFO: safety margin for low PH: adding 6, margin is now 26
[13:18:36.584] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.591] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:18:36.598] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:18:36.604] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[13:18:36.641] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:18:36.642] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:18:36.643] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:18:36.643] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:18:36.643] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:18:36.643] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:18:36.955] <TB0> INFO: Expecting 41600 events.
[13:18:40.791] <TB0> INFO: 41600 events read in total (3120ms).
[13:18:40.791] <TB0> INFO: Test took 4146ms.
[13:18:41.348] <TB0> INFO: Expecting 41600 events.
[13:18:45.199] <TB0> INFO: 41600 events read in total (3135ms).
[13:18:45.200] <TB0> INFO: Test took 4171ms.
[13:18:45.773] <TB0> INFO: Expecting 41600 events.
[13:18:49.618] <TB0> INFO: 41600 events read in total (3130ms).
[13:18:49.619] <TB0> INFO: Test took 4183ms.
[13:18:49.852] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:49.985] <TB0> INFO: Expecting 2560 events.
[13:18:51.045] <TB0> INFO: 2560 events read in total (345ms).
[13:18:51.045] <TB0> INFO: Test took 1193ms.
[13:18:51.047] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:51.460] <TB0> INFO: Expecting 2560 events.
[13:18:52.520] <TB0> INFO: 2560 events read in total (345ms).
[13:18:52.520] <TB0> INFO: Test took 1473ms.
[13:18:52.523] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:52.935] <TB0> INFO: Expecting 2560 events.
[13:18:54.003] <TB0> INFO: 2560 events read in total (352ms).
[13:18:54.003] <TB0> INFO: Test took 1480ms.
[13:18:54.006] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:54.418] <TB0> INFO: Expecting 2560 events.
[13:18:55.493] <TB0> INFO: 2560 events read in total (359ms).
[13:18:55.493] <TB0> INFO: Test took 1487ms.
[13:18:55.495] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:55.908] <TB0> INFO: Expecting 2560 events.
[13:18:56.977] <TB0> INFO: 2560 events read in total (353ms).
[13:18:56.977] <TB0> INFO: Test took 1482ms.
[13:18:56.980] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:57.392] <TB0> INFO: Expecting 2560 events.
[13:18:58.461] <TB0> INFO: 2560 events read in total (353ms).
[13:18:58.462] <TB0> INFO: Test took 1483ms.
[13:18:58.464] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:58.876] <TB0> INFO: Expecting 2560 events.
[13:18:59.954] <TB0> INFO: 2560 events read in total (362ms).
[13:18:59.954] <TB0> INFO: Test took 1490ms.
[13:18:59.957] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:00.369] <TB0> INFO: Expecting 2560 events.
[13:19:01.431] <TB0> INFO: 2560 events read in total (346ms).
[13:19:01.431] <TB0> INFO: Test took 1474ms.
[13:19:01.434] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:01.846] <TB0> INFO: Expecting 2560 events.
[13:19:02.914] <TB0> INFO: 2560 events read in total (352ms).
[13:19:02.914] <TB0> INFO: Test took 1481ms.
[13:19:02.916] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:03.330] <TB0> INFO: Expecting 2560 events.
[13:19:04.391] <TB0> INFO: 2560 events read in total (345ms).
[13:19:04.391] <TB0> INFO: Test took 1475ms.
[13:19:04.393] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:04.806] <TB0> INFO: Expecting 2560 events.
[13:19:05.868] <TB0> INFO: 2560 events read in total (347ms).
[13:19:05.868] <TB0> INFO: Test took 1475ms.
[13:19:05.871] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:06.283] <TB0> INFO: Expecting 2560 events.
[13:19:07.352] <TB0> INFO: 2560 events read in total (353ms).
[13:19:07.353] <TB0> INFO: Test took 1482ms.
[13:19:07.355] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:07.768] <TB0> INFO: Expecting 2560 events.
[13:19:08.850] <TB0> INFO: 2560 events read in total (367ms).
[13:19:08.850] <TB0> INFO: Test took 1495ms.
[13:19:08.852] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:09.266] <TB0> INFO: Expecting 2560 events.
[13:19:10.334] <TB0> INFO: 2560 events read in total (353ms).
[13:19:10.334] <TB0> INFO: Test took 1482ms.
[13:19:10.337] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:10.751] <TB0> INFO: Expecting 2560 events.
[13:19:11.819] <TB0> INFO: 2560 events read in total (353ms).
[13:19:11.819] <TB0> INFO: Test took 1482ms.
[13:19:11.822] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:12.235] <TB0> INFO: Expecting 2560 events.
[13:19:13.303] <TB0> INFO: 2560 events read in total (353ms).
[13:19:13.304] <TB0> INFO: Test took 1482ms.
[13:19:13.307] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:13.718] <TB0> INFO: Expecting 2560 events.
[13:19:14.781] <TB0> INFO: 2560 events read in total (348ms).
[13:19:14.781] <TB0> INFO: Test took 1474ms.
[13:19:14.783] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:15.195] <TB0> INFO: Expecting 2560 events.
[13:19:16.264] <TB0> INFO: 2560 events read in total (353ms).
[13:19:16.264] <TB0> INFO: Test took 1481ms.
[13:19:16.266] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:16.679] <TB0> INFO: Expecting 2560 events.
[13:19:17.748] <TB0> INFO: 2560 events read in total (354ms).
[13:19:17.749] <TB0> INFO: Test took 1483ms.
[13:19:17.752] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:18.163] <TB0> INFO: Expecting 2560 events.
[13:19:19.254] <TB0> INFO: 2560 events read in total (375ms).
[13:19:19.254] <TB0> INFO: Test took 1503ms.
[13:19:19.257] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:19.669] <TB0> INFO: Expecting 2560 events.
[13:19:20.738] <TB0> INFO: 2560 events read in total (354ms).
[13:19:20.738] <TB0> INFO: Test took 1481ms.
[13:19:20.741] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:21.153] <TB0> INFO: Expecting 2560 events.
[13:19:22.222] <TB0> INFO: 2560 events read in total (353ms).
[13:19:22.223] <TB0> INFO: Test took 1483ms.
[13:19:22.225] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:22.637] <TB0> INFO: Expecting 2560 events.
[13:19:23.714] <TB0> INFO: 2560 events read in total (361ms).
[13:19:23.714] <TB0> INFO: Test took 1489ms.
[13:19:23.717] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:24.128] <TB0> INFO: Expecting 2560 events.
[13:19:25.198] <TB0> INFO: 2560 events read in total (354ms).
[13:19:25.198] <TB0> INFO: Test took 1481ms.
[13:19:25.201] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:25.613] <TB0> INFO: Expecting 2560 events.
[13:19:26.682] <TB0> INFO: 2560 events read in total (353ms).
[13:19:26.682] <TB0> INFO: Test took 1482ms.
[13:19:26.685] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:27.097] <TB0> INFO: Expecting 2560 events.
[13:19:28.188] <TB0> INFO: 2560 events read in total (375ms).
[13:19:28.188] <TB0> INFO: Test took 1503ms.
[13:19:28.190] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:28.603] <TB0> INFO: Expecting 2560 events.
[13:19:29.665] <TB0> INFO: 2560 events read in total (346ms).
[13:19:29.665] <TB0> INFO: Test took 1475ms.
[13:19:29.669] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:30.080] <TB0> INFO: Expecting 2560 events.
[13:19:31.149] <TB0> INFO: 2560 events read in total (353ms).
[13:19:31.150] <TB0> INFO: Test took 1481ms.
[13:19:31.153] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:31.565] <TB0> INFO: Expecting 2560 events.
[13:19:32.626] <TB0> INFO: 2560 events read in total (346ms).
[13:19:32.627] <TB0> INFO: Test took 1475ms.
[13:19:32.628] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:33.041] <TB0> INFO: Expecting 2560 events.
[13:19:34.105] <TB0> INFO: 2560 events read in total (347ms).
[13:19:34.105] <TB0> INFO: Test took 1477ms.
[13:19:34.107] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:34.520] <TB0> INFO: Expecting 2560 events.
[13:19:35.589] <TB0> INFO: 2560 events read in total (353ms).
[13:19:35.589] <TB0> INFO: Test took 1482ms.
[13:19:35.592] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:19:36.004] <TB0> INFO: Expecting 2560 events.
[13:19:37.071] <TB0> INFO: 2560 events read in total (352ms).
[13:19:37.071] <TB0> INFO: Test took 1479ms.
[13:19:37.691] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 582 seconds
[13:19:37.691] <TB0> INFO: PH scale (per ROC): 80 75 91 82 78 92 81 77 98 85 80 91 80 91 80 74
[13:19:37.691] <TB0> INFO: PH offset (per ROC): 155 161 156 145 167 159 156 165 148 164 159 144 166 144 173 176
[13:19:37.701] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:19:37.701] <TB0> INFO: Decoding statistics:
[13:19:37.701] <TB0> INFO: General information:
[13:19:37.701] <TB0> INFO: 16bit words read: 91936
[13:19:37.701] <TB0> INFO: valid events total: 10240
[13:19:37.701] <TB0> INFO: empty events: 7736
[13:19:37.701] <TB0> INFO: valid events with pixels: 2504
[13:19:37.701] <TB0> INFO: valid pixel hits: 2504
[13:19:37.701] <TB0> INFO: Event errors: 0
[13:19:37.701] <TB0> INFO: start marker: 0
[13:19:37.701] <TB0> INFO: stop marker: 0
[13:19:37.701] <TB0> INFO: overflow: 0
[13:19:37.701] <TB0> INFO: invalid 5bit words: 0
[13:19:37.701] <TB0> INFO: invalid XOR eye diagram: 0
[13:19:37.701] <TB0> INFO: TBM errors: 0
[13:19:37.701] <TB0> INFO: flawed TBM headers: 0
[13:19:37.701] <TB0> INFO: flawed TBM trailers: 0
[13:19:37.701] <TB0> INFO: event ID mismatches: 0
[13:19:37.701] <TB0> INFO: ROC errors: 0
[13:19:37.701] <TB0> INFO: missing ROC header(s): 0
[13:19:37.701] <TB0> INFO: misplaced readback start: 0
[13:19:37.701] <TB0> INFO: Pixel decoding errors: 0
[13:19:37.701] <TB0> INFO: pixel data incomplete: 0
[13:19:37.701] <TB0> INFO: pixel address: 0
[13:19:37.701] <TB0> INFO: pulse height fill bit: 0
[13:19:37.701] <TB0> INFO: buffer corruption: 0
[13:19:37.906] <TB0> INFO: ######################################################################
[13:19:37.906] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[13:19:37.906] <TB0> INFO: ######################################################################
[13:19:37.917] <TB0> INFO: scanning low vcal = 10
[13:19:38.256] <TB0> INFO: Expecting 41600 events.
[13:19:42.124] <TB0> INFO: 41600 events read in total (3153ms).
[13:19:42.125] <TB0> INFO: Test took 4208ms.
[13:19:42.128] <TB0> INFO: scanning low vcal = 20
[13:19:42.539] <TB0> INFO: Expecting 41600 events.
[13:19:46.328] <TB0> INFO: 41600 events read in total (3074ms).
[13:19:46.328] <TB0> INFO: Test took 4200ms.
[13:19:46.330] <TB0> INFO: scanning low vcal = 30
[13:19:46.742] <TB0> INFO: Expecting 41600 events.
[13:19:50.591] <TB0> INFO: 41600 events read in total (3133ms).
[13:19:50.591] <TB0> INFO: Test took 4261ms.
[13:19:50.593] <TB0> INFO: scanning low vcal = 40
[13:19:50.998] <TB0> INFO: Expecting 41600 events.
[13:19:55.413] <TB0> INFO: 41600 events read in total (3700ms).
[13:19:55.414] <TB0> INFO: Test took 4821ms.
[13:19:55.416] <TB0> INFO: scanning low vcal = 50
[13:19:55.759] <TB0> INFO: Expecting 41600 events.
[13:20:00.153] <TB0> INFO: 41600 events read in total (3678ms).
[13:20:00.153] <TB0> INFO: Test took 4737ms.
[13:20:00.156] <TB0> INFO: scanning low vcal = 60
[13:20:00.506] <TB0> INFO: Expecting 41600 events.
[13:20:04.854] <TB0> INFO: 41600 events read in total (3632ms).
[13:20:04.855] <TB0> INFO: Test took 4699ms.
[13:20:04.858] <TB0> INFO: scanning low vcal = 70
[13:20:05.211] <TB0> INFO: Expecting 41600 events.
[13:20:09.565] <TB0> INFO: 41600 events read in total (3638ms).
[13:20:09.565] <TB0> INFO: Test took 4707ms.
[13:20:09.568] <TB0> INFO: scanning low vcal = 80
[13:20:09.919] <TB0> INFO: Expecting 41600 events.
[13:20:14.329] <TB0> INFO: 41600 events read in total (3694ms).
[13:20:14.329] <TB0> INFO: Test took 4761ms.
[13:20:14.332] <TB0> INFO: scanning low vcal = 90
[13:20:14.674] <TB0> INFO: Expecting 41600 events.
[13:20:19.076] <TB0> INFO: 41600 events read in total (3687ms).
[13:20:19.077] <TB0> INFO: Test took 4745ms.
[13:20:19.080] <TB0> INFO: scanning low vcal = 100
[13:20:19.428] <TB0> INFO: Expecting 41600 events.
[13:20:24.045] <TB0> INFO: 41600 events read in total (3901ms).
[13:20:24.045] <TB0> INFO: Test took 4965ms.
[13:20:24.048] <TB0> INFO: scanning low vcal = 110
[13:20:24.398] <TB0> INFO: Expecting 41600 events.
[13:20:28.891] <TB0> INFO: 41600 events read in total (3777ms).
[13:20:28.891] <TB0> INFO: Test took 4843ms.
[13:20:28.894] <TB0> INFO: scanning low vcal = 120
[13:20:29.240] <TB0> INFO: Expecting 41600 events.
[13:20:33.755] <TB0> INFO: 41600 events read in total (3800ms).
[13:20:33.755] <TB0> INFO: Test took 4861ms.
[13:20:33.758] <TB0> INFO: scanning low vcal = 130
[13:20:34.098] <TB0> INFO: Expecting 41600 events.
[13:20:38.640] <TB0> INFO: 41600 events read in total (3826ms).
[13:20:38.641] <TB0> INFO: Test took 4883ms.
[13:20:38.643] <TB0> INFO: scanning low vcal = 140
[13:20:38.999] <TB0> INFO: Expecting 41600 events.
[13:20:43.502] <TB0> INFO: 41600 events read in total (3787ms).
[13:20:43.503] <TB0> INFO: Test took 4860ms.
[13:20:43.505] <TB0> INFO: scanning low vcal = 150
[13:20:43.862] <TB0> INFO: Expecting 41600 events.
[13:20:48.506] <TB0> INFO: 41600 events read in total (3928ms).
[13:20:48.506] <TB0> INFO: Test took 5001ms.
[13:20:48.509] <TB0> INFO: scanning low vcal = 160
[13:20:48.865] <TB0> INFO: Expecting 41600 events.
[13:20:53.316] <TB0> INFO: 41600 events read in total (3735ms).
[13:20:53.317] <TB0> INFO: Test took 4808ms.
[13:20:53.321] <TB0> INFO: scanning low vcal = 170
[13:20:53.666] <TB0> INFO: Expecting 41600 events.
[13:20:58.203] <TB0> INFO: 41600 events read in total (3814ms).
[13:20:58.203] <TB0> INFO: Test took 4882ms.
[13:20:58.207] <TB0> INFO: scanning low vcal = 180
[13:20:58.559] <TB0> INFO: Expecting 41600 events.
[13:21:03.046] <TB0> INFO: 41600 events read in total (3771ms).
[13:21:03.047] <TB0> INFO: Test took 4840ms.
[13:21:03.049] <TB0> INFO: scanning low vcal = 190
[13:21:03.390] <TB0> INFO: Expecting 41600 events.
[13:21:07.832] <TB0> INFO: 41600 events read in total (3727ms).
[13:21:07.832] <TB0> INFO: Test took 4783ms.
[13:21:07.835] <TB0> INFO: scanning low vcal = 200
[13:21:08.190] <TB0> INFO: Expecting 41600 events.
[13:21:12.769] <TB0> INFO: 41600 events read in total (3864ms).
[13:21:12.770] <TB0> INFO: Test took 4935ms.
[13:21:12.773] <TB0> INFO: scanning low vcal = 210
[13:21:13.120] <TB0> INFO: Expecting 41600 events.
[13:21:17.607] <TB0> INFO: 41600 events read in total (3772ms).
[13:21:17.608] <TB0> INFO: Test took 4835ms.
[13:21:17.610] <TB0> INFO: scanning low vcal = 220
[13:21:17.966] <TB0> INFO: Expecting 41600 events.
[13:21:22.449] <TB0> INFO: 41600 events read in total (3768ms).
[13:21:22.449] <TB0> INFO: Test took 4839ms.
[13:21:22.452] <TB0> INFO: scanning low vcal = 230
[13:21:22.790] <TB0> INFO: Expecting 41600 events.
[13:21:27.177] <TB0> INFO: 41600 events read in total (3672ms).
[13:21:27.178] <TB0> INFO: Test took 4726ms.
[13:21:27.180] <TB0> INFO: scanning low vcal = 240
[13:21:27.535] <TB0> INFO: Expecting 41600 events.
[13:21:31.897] <TB0> INFO: 41600 events read in total (3647ms).
[13:21:31.898] <TB0> INFO: Test took 4718ms.
[13:21:31.913] <TB0> INFO: scanning low vcal = 250
[13:21:32.251] <TB0> INFO: Expecting 41600 events.
[13:21:36.573] <TB0> INFO: 41600 events read in total (3606ms).
[13:21:36.573] <TB0> INFO: Test took 4660ms.
[13:21:36.577] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[13:21:36.932] <TB0> INFO: Expecting 41600 events.
[13:21:41.314] <TB0> INFO: 41600 events read in total (3667ms).
[13:21:41.315] <TB0> INFO: Test took 4738ms.
[13:21:41.317] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[13:21:41.671] <TB0> INFO: Expecting 41600 events.
[13:21:46.012] <TB0> INFO: 41600 events read in total (3626ms).
[13:21:46.012] <TB0> INFO: Test took 4695ms.
[13:21:46.015] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[13:21:46.367] <TB0> INFO: Expecting 41600 events.
[13:21:50.735] <TB0> INFO: 41600 events read in total (3652ms).
[13:21:50.735] <TB0> INFO: Test took 4720ms.
[13:21:50.738] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[13:21:51.089] <TB0> INFO: Expecting 41600 events.
[13:21:55.585] <TB0> INFO: 41600 events read in total (3781ms).
[13:21:55.586] <TB0> INFO: Test took 4848ms.
[13:21:55.589] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[13:21:55.936] <TB0> INFO: Expecting 41600 events.
[13:22:00.325] <TB0> INFO: 41600 events read in total (3674ms).
[13:22:00.325] <TB0> INFO: Test took 4736ms.
[13:22:00.847] <TB0> INFO: PixTestGainPedestal::measure() done
[13:22:34.385] <TB0> INFO: PixTestGainPedestal::fit() done
[13:22:34.385] <TB0> INFO: non-linearity mean: 0.955 0.955 0.953 0.956 0.955 0.955 0.956 0.954 0.954 0.954 0.958 0.958 0.956 0.965 0.950 0.957
[13:22:34.385] <TB0> INFO: non-linearity RMS: 0.005 0.006 0.005 0.005 0.006 0.006 0.005 0.006 0.007 0.006 0.005 0.004 0.008 0.003 0.006 0.006
[13:22:34.385] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[13:22:34.403] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[13:22:34.421] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[13:22:34.450] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[13:22:34.469] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[13:22:34.491] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[13:22:34.509] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[13:22:34.527] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[13:22:34.545] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[13:22:34.563] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[13:22:34.581] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[13:22:34.613] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[13:22:34.635] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[13:22:34.653] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[13:22:34.671] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[13:22:34.689] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[13:22:34.706] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 176 seconds
[13:22:34.706] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:22:34.706] <TB0> INFO: Decoding statistics:
[13:22:34.706] <TB0> INFO: General information:
[13:22:34.706] <TB0> INFO: 16bit words read: 2662400
[13:22:34.706] <TB0> INFO: valid events total: 166400
[13:22:34.706] <TB0> INFO: empty events: 0
[13:22:34.706] <TB0> INFO: valid events with pixels: 166400
[13:22:34.706] <TB0> INFO: valid pixel hits: 665590
[13:22:34.706] <TB0> INFO: Event errors: 0
[13:22:34.707] <TB0> INFO: start marker: 0
[13:22:34.707] <TB0> INFO: stop marker: 0
[13:22:34.707] <TB0> INFO: overflow: 0
[13:22:34.707] <TB0> INFO: invalid 5bit words: 0
[13:22:34.707] <TB0> INFO: invalid XOR eye diagram: 0
[13:22:34.707] <TB0> INFO: TBM errors: 0
[13:22:34.707] <TB0> INFO: flawed TBM headers: 0
[13:22:34.707] <TB0> INFO: flawed TBM trailers: 0
[13:22:34.707] <TB0> INFO: event ID mismatches: 0
[13:22:34.707] <TB0> INFO: ROC errors: 0
[13:22:34.707] <TB0> INFO: missing ROC header(s): 0
[13:22:34.707] <TB0> INFO: misplaced readback start: 0
[13:22:34.707] <TB0> INFO: Pixel decoding errors: 0
[13:22:34.707] <TB0> INFO: pixel data incomplete: 0
[13:22:34.707] <TB0> INFO: pixel address: 0
[13:22:34.707] <TB0> INFO: pulse height fill bit: 0
[13:22:34.707] <TB0> INFO: buffer corruption: 0
[13:22:34.715] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C15.dat
[13:22:34.716] <TB0> INFO: ######################################################################
[13:22:34.716] <TB0> INFO: PixTestReadback::doTest()
[13:22:34.716] <TB0> INFO: ######################################################################
[13:22:34.717] <TB0> INFO: PixTestReadback::RES sent once
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C0.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C1.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C2.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C3.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C4.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C5.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C6.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C7.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C8.dat
[13:22:45.968] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C9.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C10.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C11.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C12.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C13.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C14.dat
[13:22:45.969] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C15.dat
[13:22:45.996] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:22:45.996] <TB0> INFO: PixTestReadback::RES sent once
[13:22:57.173] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C0.dat
[13:22:57.173] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C1.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C2.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C3.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C4.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C5.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C6.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C7.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C8.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C9.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C10.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C11.dat
[13:22:57.174] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C12.dat
[13:22:57.175] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C13.dat
[13:22:57.175] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C14.dat
[13:22:57.175] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C15.dat
[13:22:57.205] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:22:57.205] <TB0> INFO: PixTestReadback::RES sent once
[13:23:05.801] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:23:05.801] <TB0> INFO: Vbg will be calibrated using Vd calibration
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 151.4calibrated Vbg = 1.21617 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 156.7calibrated Vbg = 1.21101 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 159.9calibrated Vbg = 1.21666 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 148.5calibrated Vbg = 1.22447 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 159.8calibrated Vbg = 1.22832 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 150.7calibrated Vbg = 1.22473 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 157.3calibrated Vbg = 1.2265 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 153.5calibrated Vbg = 1.22771 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 146.9calibrated Vbg = 1.22584 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 148.4calibrated Vbg = 1.22856 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 157.1calibrated Vbg = 1.23199 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 154.9calibrated Vbg = 1.22289 :::*/*/*/*/
[13:23:05.801] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.9calibrated Vbg = 1.2217 :::*/*/*/*/
[13:23:05.802] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 150.7calibrated Vbg = 1.21424 :::*/*/*/*/
[13:23:05.802] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 168.1calibrated Vbg = 1.21222 :::*/*/*/*/
[13:23:05.802] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 164.1calibrated Vbg = 1.20799 :::*/*/*/*/
[13:23:05.805] <TB0> INFO: PixTestReadback::RES sent once
[13:26:00.176] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C0.dat
[13:26:00.176] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C1.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C2.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C3.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C4.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C5.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C6.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C7.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C8.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C9.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C10.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C11.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C12.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C13.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C14.dat
[13:26:00.177] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2125_FullQualification_2015-12-15_09h42m_1450168934//002_FulltestPxar_m20//readbackCal_C15.dat
[13:26:00.205] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:26:00.206] <TB0> INFO: PixTestReadback::doTest() done
[13:26:00.206] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:26:00.206] <TB0> INFO: Decoding statistics:
[13:26:00.206] <TB0> INFO: General information:
[13:26:00.206] <TB0> INFO: 16bit words read: 1024
[13:26:00.206] <TB0> INFO: valid events total: 128
[13:26:00.206] <TB0> INFO: empty events: 128
[13:26:00.206] <TB0> INFO: valid events with pixels: 0
[13:26:00.206] <TB0> INFO: valid pixel hits: 0
[13:26:00.206] <TB0> INFO: Event errors: 0
[13:26:00.206] <TB0> INFO: start marker: 0
[13:26:00.206] <TB0> INFO: stop marker: 0
[13:26:00.206] <TB0> INFO: overflow: 0
[13:26:00.206] <TB0> INFO: invalid 5bit words: 0
[13:26:00.206] <TB0> INFO: invalid XOR eye diagram: 0
[13:26:00.206] <TB0> INFO: TBM errors: 0
[13:26:00.206] <TB0> INFO: flawed TBM headers: 0
[13:26:00.206] <TB0> INFO: flawed TBM trailers: 0
[13:26:00.206] <TB0> INFO: event ID mismatches: 0
[13:26:00.206] <TB0> INFO: ROC errors: 0
[13:26:00.206] <TB0> INFO: missing ROC header(s): 0
[13:26:00.206] <TB0> INFO: misplaced readback start: 0
[13:26:00.206] <TB0> INFO: Pixel decoding errors: 0
[13:26:00.206] <TB0> INFO: pixel data incomplete: 0
[13:26:00.206] <TB0> INFO: pixel address: 0
[13:26:00.206] <TB0> INFO: pulse height fill bit: 0
[13:26:00.206] <TB0> INFO: buffer corruption: 0
[13:26:00.226] <TB0> INFO: Decoding statistics:
[13:26:00.226] <TB0> INFO: General information:
[13:26:00.226] <TB0> INFO: 16bit words read: 2755360
[13:26:00.226] <TB0> INFO: valid events total: 176768
[13:26:00.226] <TB0> INFO: empty events: 7864
[13:26:00.226] <TB0> INFO: valid events with pixels: 168904
[13:26:00.226] <TB0> INFO: valid pixel hits: 668094
[13:26:00.226] <TB0> INFO: Event errors: 0
[13:26:00.226] <TB0> INFO: start marker: 0
[13:26:00.226] <TB0> INFO: stop marker: 0
[13:26:00.226] <TB0> INFO: overflow: 0
[13:26:00.226] <TB0> INFO: invalid 5bit words: 0
[13:26:00.226] <TB0> INFO: invalid XOR eye diagram: 0
[13:26:00.226] <TB0> INFO: TBM errors: 0
[13:26:00.226] <TB0> INFO: flawed TBM headers: 0
[13:26:00.226] <TB0> INFO: flawed TBM trailers: 0
[13:26:00.226] <TB0> INFO: event ID mismatches: 0
[13:26:00.226] <TB0> INFO: ROC errors: 0
[13:26:00.226] <TB0> INFO: missing ROC header(s): 0
[13:26:00.226] <TB0> INFO: misplaced readback start: 0
[13:26:00.226] <TB0> INFO: Pixel decoding errors: 0
[13:26:00.226] <TB0> INFO: pixel data incomplete: 0
[13:26:00.226] <TB0> INFO: pixel address: 0
[13:26:00.226] <TB0> INFO: pulse height fill bit: 0
[13:26:00.226] <TB0> INFO: buffer corruption: 0
[13:26:00.226] <TB0> INFO: enter test to run
[13:26:00.226] <TB0> INFO: test: exit no parameter change
[13:26:00.453] <TB0> QUIET: Connection to board 73 closed.
[13:26:00.533] <TB0> INFO: pXar: this is the end, my friend