[09:03:47.913] <TB3> INFO: *** Welcome to pxar ***
[09:03:47.913] <TB3> INFO: *** Today: 2015/11/20
[09:03:48.022] <TB3> INFO: *** Version: 9da6-dirty
[09:03:48.022] <TB3> INFO: readRocDacs: /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C15.dat
[09:03:48.024] <TB3> INFO: readTbmDacs: /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//tbmParameters_C0b.dat
[09:03:48.024] <TB3> INFO: readMaskFile: /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//defaultMaskFile.dat
[09:03:48.024] <TB3> INFO: readTrimFile: /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters_C15.dat
[09:03:48.111] <TB3> INFO: clk: 4
[09:03:48.111] <TB3> INFO: ctr: 4
[09:03:48.111] <TB3> INFO: sda: 19
[09:03:48.111] <TB3> INFO: tin: 9
[09:03:48.111] <TB3> INFO: level: 15
[09:03:48.111] <TB3> INFO: triggerdelay: 0
[09:03:48.111] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[09:03:48.111] <TB3> INFO: Log level: INFO
[09:03:48.119] <TB3> INFO: Found DTB DTB_WZ4I6J
[09:03:48.132] <TB3> QUIET: Connection to board DTB_WZ4I6J opened.
[09:03:48.136] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 170
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WZ4I6J
MAC address: 40D8551180AA
Hostname: pixelDTB170
Comment:
------------------------------------------------------
[09:03:48.138] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:03:49.720] <TB3> INFO: DUT info:
[09:03:49.720] <TB3> INFO: The DUT currently contains the following objects:
[09:03:49.720] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:03:49.720] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:03:49.720] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:03:49.720] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:03:49.720] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.720] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:49.721] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:50.122] <TB3> INFO: enter 'restricted' command line mode
[09:03:50.122] <TB3> INFO: enter test to run
[09:03:50.122] <TB3> INFO: test: pretest no parameter change
[09:03:50.122] <TB3> INFO: running: pretest
[09:03:50.131] <TB3> INFO: ######################################################################
[09:03:50.131] <TB3> INFO: PixTestPretest::doTest()
[09:03:50.131] <TB3> INFO: ######################################################################
[09:03:50.133] <TB3> INFO: ----------------------------------------------------------------------
[09:03:50.133] <TB3> INFO: PixTestPretest::programROC()
[09:03:50.133] <TB3> INFO: ----------------------------------------------------------------------
[09:04:08.151] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[09:04:08.151] <TB3> INFO: IA differences per ROC: 16.1 17.7 18.5 19.3 17.7 17.7 16.9 16.9 19.3 16.1 20.1 17.7 16.9 15.3 18.5 16.9
[09:04:08.222] <TB3> INFO: ----------------------------------------------------------------------
[09:04:08.222] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[09:04:08.222] <TB3> INFO: ----------------------------------------------------------------------
[09:04:14.723] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 396.3 mA = 24.7688 mA/ROC
[09:04:14.723] <TB3> INFO: i(loss) [mA/ROC]: 20.9 20.9 20.1 20.1 20.1 20.9 20.9 20.1 20.1 20.9 20.1 20.1 20.9 20.1 20.9 20.1
[09:04:14.751] <TB3> INFO: ----------------------------------------------------------------------
[09:04:14.751] <TB3> INFO: PixTestPretest::findTiming()
[09:04:14.751] <TB3> INFO: ----------------------------------------------------------------------
[09:04:14.752] <TB3> INFO: PixTestCmd::init()

[09:06:08.837] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[09:06:08.837] <TB3> INFO: (success/tries = 100/100), width = 4
[09:06:08.840] <TB3> INFO: ----------------------------------------------------------------------
[09:06:08.840] <TB3> INFO: PixTestPretest::findWorkingPixel()
[09:06:08.840] <TB3> INFO: ----------------------------------------------------------------------
[09:06:08.979] <TB3> INFO: Expecting 231680 events.
[09:06:17.468] <TB3> INFO: 231680 events read in total (7773ms).
[09:06:17.472] <TB3> INFO: Test took 8629ms.
[09:06:17.761] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[09:06:17.800] <TB3> INFO: ----------------------------------------------------------------------
[09:06:17.800] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[09:06:17.800] <TB3> INFO: ----------------------------------------------------------------------
[09:06:17.936] <TB3> INFO: Expecting 231680 events.
[09:06:26.697] <TB3> INFO: 231680 events read in total (8045ms).
[09:06:26.701] <TB3> INFO: Test took 8897ms.
[09:06:27.001] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[09:06:27.001] <TB3> INFO: CalDel: 145 141 143 144 138 149 122 131 141 138 162 158 141 132 143 123
[09:06:27.001] <TB3> INFO: VthrComp: 51 51 52 51 51 51 51 52 54 53 51 51 54 56 51 51
[09:06:27.004] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C0.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C1.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C2.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C3.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C4.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C5.dat
[09:06:27.005] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C6.dat
[09:06:27.006] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C7.dat
[09:06:27.006] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C8.dat
[09:06:27.006] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C9.dat
[09:06:27.006] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C10.dat
[09:06:27.007] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C11.dat
[09:06:27.007] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C12.dat
[09:06:27.007] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C13.dat
[09:06:27.007] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C14.dat
[09:06:27.008] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters_C15.dat
[09:06:27.008] <TB3> INFO: write tbm parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//tbmParameters_C0a.dat
[09:06:27.008] <TB3> INFO: write tbm parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//tbmParameters_C0b.dat
[09:06:27.008] <TB3> INFO: PixTestPretest::doTest() done, duration: 156 seconds
[09:06:27.079] <TB3> INFO: enter test to run
[09:06:27.079] <TB3> INFO: test: fulltest no parameter change
[09:06:27.079] <TB3> INFO: running: fulltest
[09:06:27.079] <TB3> INFO: ######################################################################
[09:06:27.079] <TB3> INFO: PixTestFullTest::doTest()
[09:06:27.079] <TB3> INFO: ######################################################################
[09:06:27.080] <TB3> INFO: ######################################################################
[09:06:27.080] <TB3> INFO: PixTestAlive::doTest()
[09:06:27.080] <TB3> INFO: ######################################################################
[09:06:27.082] <TB3> INFO: ----------------------------------------------------------------------
[09:06:27.082] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:06:27.082] <TB3> INFO: ----------------------------------------------------------------------
[09:06:27.391] <TB3> INFO: Expecting 41600 events.
[09:06:31.715] <TB3> INFO: 41600 events read in total (3609ms).
[09:06:31.715] <TB3> INFO: Test took 4632ms.
[09:06:31.721] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:32.014] <TB3> INFO: PixTestAlive::aliveTest() done
[09:06:32.014] <TB3> INFO: number of dead pixels (per ROC): 2 1 0 0 0 0 0 0 0 0 0 0 0 0 1 1
[09:06:32.015] <TB3> INFO: ----------------------------------------------------------------------
[09:06:32.015] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:06:32.015] <TB3> INFO: ----------------------------------------------------------------------
[09:06:32.319] <TB3> INFO: Expecting 41600 events.
[09:06:35.401] <TB3> INFO: 41600 events read in total (2366ms).
[09:06:35.401] <TB3> INFO: Test took 3384ms.
[09:06:35.401] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:35.402] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:06:35.715] <TB3> INFO: PixTestAlive::maskTest() done
[09:06:35.715] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:06:35.717] <TB3> INFO: ----------------------------------------------------------------------
[09:06:35.717] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:06:35.717] <TB3> INFO: ----------------------------------------------------------------------
[09:06:36.031] <TB3> INFO: Expecting 41600 events.
[09:06:40.197] <TB3> INFO: 41600 events read in total (3451ms).
[09:06:40.198] <TB3> INFO: Test took 4480ms.
[09:06:40.204] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:40.489] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[09:06:40.489] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:06:40.489] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:06:40.489] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:40.489] <TB3> INFO: Decoding statistics:
[09:06:40.489] <TB3> INFO: General information:
[09:06:40.489] <TB3> INFO: 16bit words read: 0
[09:06:40.489] <TB3> INFO: valid events total: 0
[09:06:40.489] <TB3> INFO: empty events: 0
[09:06:40.489] <TB3> INFO: valid events with pixels: 0
[09:06:40.489] <TB3> INFO: valid pixel hits: 0
[09:06:40.489] <TB3> INFO: Event errors: 0
[09:06:40.489] <TB3> INFO: start marker: 0
[09:06:40.489] <TB3> INFO: stop marker: 0
[09:06:40.489] <TB3> INFO: overflow: 0
[09:06:40.489] <TB3> INFO: invalid 5bit words: 0
[09:06:40.489] <TB3> INFO: invalid XOR eye diagram: 0
[09:06:40.489] <TB3> INFO: TBM errors: 0
[09:06:40.489] <TB3> INFO: flawed TBM headers: 0
[09:06:40.490] <TB3> INFO: flawed TBM trailers: 0
[09:06:40.490] <TB3> INFO: event ID mismatches: 0
[09:06:40.490] <TB3> INFO: ROC errors: 0
[09:06:40.490] <TB3> INFO: missing ROC header(s): 0
[09:06:40.490] <TB3> INFO: misplaced readback start: 0
[09:06:40.490] <TB3> INFO: Pixel decoding errors: 0
[09:06:40.490] <TB3> INFO: pixel data incomplete: 0
[09:06:40.490] <TB3> INFO: pixel address: 0
[09:06:40.490] <TB3> INFO: pulse height fill bit: 0
[09:06:40.490] <TB3> INFO: buffer corruption: 0
[09:06:40.497] <TB3> INFO: ######################################################################
[09:06:40.497] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[09:06:40.497] <TB3> INFO: ######################################################################
[09:06:40.499] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[09:06:40.600] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[09:06:40.600] <TB3> INFO: run 1 of 1
[09:06:40.926] <TB3> INFO: Expecting 3120000 events.
[09:07:25.154] <TB3> INFO: 995735 events read in total (43513ms).
[09:08:09.246] <TB3> INFO: 1982560 events read in total (87605ms).
[09:08:53.336] <TB3> INFO: 2964710 events read in total (131695ms).
[09:09:00.389] <TB3> INFO: 3120000 events read in total (138748ms).
[09:09:00.426] <TB3> INFO: Test took 139826ms.
[09:09:00.492] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:09:23.764] <TB3> INFO: PixTestBBMap::doTest() done, duration: 163 seconds
[09:09:23.764] <TB3> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:09:23.764] <TB3> INFO: separation cut (per ROC): 139 130 134 136 142 143 134 148 148 142 141 135 147 144 146 140
[09:09:23.764] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:09:23.764] <TB3> INFO: Decoding statistics:
[09:09:23.764] <TB3> INFO: General information:
[09:09:23.764] <TB3> INFO: 16bit words read: 0
[09:09:23.764] <TB3> INFO: valid events total: 0
[09:09:23.764] <TB3> INFO: empty events: 0
[09:09:23.764] <TB3> INFO: valid events with pixels: 0
[09:09:23.764] <TB3> INFO: valid pixel hits: 0
[09:09:23.764] <TB3> INFO: Event errors: 0
[09:09:23.764] <TB3> INFO: start marker: 0
[09:09:23.764] <TB3> INFO: stop marker: 0
[09:09:23.764] <TB3> INFO: overflow: 0
[09:09:23.764] <TB3> INFO: invalid 5bit words: 0
[09:09:23.764] <TB3> INFO: invalid XOR eye diagram: 0
[09:09:23.764] <TB3> INFO: TBM errors: 0
[09:09:23.764] <TB3> INFO: flawed TBM headers: 0
[09:09:23.764] <TB3> INFO: flawed TBM trailers: 0
[09:09:23.764] <TB3> INFO: event ID mismatches: 0
[09:09:23.764] <TB3> INFO: ROC errors: 0
[09:09:23.764] <TB3> INFO: missing ROC header(s): 0
[09:09:23.764] <TB3> INFO: misplaced readback start: 0
[09:09:23.764] <TB3> INFO: Pixel decoding errors: 0
[09:09:23.764] <TB3> INFO: pixel data incomplete: 0
[09:09:23.764] <TB3> INFO: pixel address: 0
[09:09:23.764] <TB3> INFO: pulse height fill bit: 0
[09:09:23.764] <TB3> INFO: buffer corruption: 0
[09:09:23.866] <TB3> INFO: ######################################################################
[09:09:23.866] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:09:23.866] <TB3> INFO: ######################################################################
[09:09:23.866] <TB3> INFO: ----------------------------------------------------------------------
[09:09:23.866] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:09:23.866] <TB3> INFO: ----------------------------------------------------------------------
[09:09:23.866] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[09:09:23.876] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:09:23.877] <TB3> INFO: run 1 of 1
[09:09:24.180] <TB3> INFO: Expecting 26208000 events.
[09:09:54.569] <TB3> INFO: 1009650 events read in total (29674ms).
[09:10:25.855] <TB3> INFO: 2001250 events read in total (60960ms).
[09:10:57.214] <TB3> INFO: 2987450 events read in total (92319ms).
[09:11:28.865] <TB3> INFO: 3973150 events read in total (123970ms).
[09:12:00.631] <TB3> INFO: 4952300 events read in total (155736ms).
[09:12:31.585] <TB3> INFO: 5935950 events read in total (186690ms).
[09:13:03.467] <TB3> INFO: 6919250 events read in total (218572ms).
[09:13:35.184] <TB3> INFO: 7901500 events read in total (250289ms).
[09:14:07.436] <TB3> INFO: 8884300 events read in total (282541ms).
[09:14:39.265] <TB3> INFO: 9865700 events read in total (314370ms).
[09:15:10.331] <TB3> INFO: 10846450 events read in total (345436ms).
[09:15:41.322] <TB3> INFO: 11824650 events read in total (376427ms).
[09:16:12.181] <TB3> INFO: 12804500 events read in total (407286ms).
[09:16:42.467] <TB3> INFO: 13771500 events read in total (437572ms).
[09:17:13.638] <TB3> INFO: 14737800 events read in total (468744ms).
[09:17:44.706] <TB3> INFO: 15701300 events read in total (499811ms).
[09:18:15.839] <TB3> INFO: 16662350 events read in total (530944ms).
[09:18:46.712] <TB3> INFO: 17621850 events read in total (561817ms).
[09:19:17.925] <TB3> INFO: 18582050 events read in total (593030ms).
[09:19:49.407] <TB3> INFO: 19539100 events read in total (624512ms).
[09:20:20.968] <TB3> INFO: 20498450 events read in total (656073ms).
[09:20:51.685] <TB3> INFO: 21455850 events read in total (686790ms).
[09:21:22.075] <TB3> INFO: 22411150 events read in total (717180ms).
[09:21:50.725] <TB3> INFO: 23368600 events read in total (745830ms).
[09:22:20.834] <TB3> INFO: 24324000 events read in total (775939ms).
[09:22:53.036] <TB3> INFO: 25280700 events read in total (808141ms).
[09:23:23.107] <TB3> INFO: 26208000 events read in total (838212ms).
[09:23:23.135] <TB3> INFO: Test took 839258ms.
[09:23:23.204] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:23:23.317] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:24.815] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:26.342] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:27.730] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:29.232] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:30.712] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:32.167] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:33.637] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:34.994] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:36.352] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:37.765] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:39.167] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:40.632] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:42.140] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:43.663] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:45.136] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:23:46.620] <TB3> INFO: PixTestScurves::scurves() done
[09:23:46.620] <TB3> INFO: Vcal mean: 105.60 102.38 112.14 100.42 106.38 112.12 98.68 116.05 114.26 111.48 106.89 116.82 117.99 116.46 114.30 109.00
[09:23:46.620] <TB3> INFO: Vcal RMS: 6.00 5.91 5.29 5.68 5.35 5.40 5.01 5.59 6.59 5.38 5.05 5.66 6.27 5.66 5.30 5.13
[09:23:46.620] <TB3> INFO: PixTestScurves::fullTest() done, duration: 862 seconds
[09:23:46.620] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:23:46.620] <TB3> INFO: Decoding statistics:
[09:23:46.620] <TB3> INFO: General information:
[09:23:46.620] <TB3> INFO: 16bit words read: 0
[09:23:46.620] <TB3> INFO: valid events total: 0
[09:23:46.620] <TB3> INFO: empty events: 0
[09:23:46.620] <TB3> INFO: valid events with pixels: 0
[09:23:46.620] <TB3> INFO: valid pixel hits: 0
[09:23:46.620] <TB3> INFO: Event errors: 0
[09:23:46.620] <TB3> INFO: start marker: 0
[09:23:46.620] <TB3> INFO: stop marker: 0
[09:23:46.620] <TB3> INFO: overflow: 0
[09:23:46.620] <TB3> INFO: invalid 5bit words: 0
[09:23:46.620] <TB3> INFO: invalid XOR eye diagram: 0
[09:23:46.620] <TB3> INFO: TBM errors: 0
[09:23:46.620] <TB3> INFO: flawed TBM headers: 0
[09:23:46.620] <TB3> INFO: flawed TBM trailers: 0
[09:23:46.620] <TB3> INFO: event ID mismatches: 0
[09:23:46.620] <TB3> INFO: ROC errors: 0
[09:23:46.620] <TB3> INFO: missing ROC header(s): 0
[09:23:46.620] <TB3> INFO: misplaced readback start: 0
[09:23:46.620] <TB3> INFO: Pixel decoding errors: 0
[09:23:46.620] <TB3> INFO: pixel data incomplete: 0
[09:23:46.620] <TB3> INFO: pixel address: 0
[09:23:46.620] <TB3> INFO: pulse height fill bit: 0
[09:23:46.620] <TB3> INFO: buffer corruption: 0
[09:23:46.691] <TB3> INFO: ######################################################################
[09:23:46.691] <TB3> INFO: PixTestTrim::doTest()
[09:23:46.691] <TB3> INFO: ######################################################################
[09:23:46.693] <TB3> INFO: ----------------------------------------------------------------------
[09:23:46.693] <TB3> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[09:23:46.693] <TB3> INFO: ----------------------------------------------------------------------
[09:23:46.776] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[09:23:46.776] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[09:23:46.785] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:23:46.785] <TB3> INFO: run 1 of 1
[09:23:47.111] <TB3> INFO: Expecting 5025280 events.
[09:24:27.911] <TB3> INFO: 1082880 events read in total (40084ms).
[09:25:06.471] <TB3> INFO: 2161336 events read in total (78644ms).
[09:25:43.105] <TB3> INFO: 3234448 events read in total (115279ms).
[09:26:22.105] <TB3> INFO: 4302672 events read in total (154278ms).
[09:26:48.659] <TB3> INFO: 5025280 events read in total (180832ms).
[09:26:48.682] <TB3> INFO: Test took 181898ms.
[09:26:48.733] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:27:09.446] <TB3> INFO: ROC 0 VthrComp = 105
[09:27:09.446] <TB3> INFO: ROC 1 VthrComp = 100
[09:27:09.446] <TB3> INFO: ROC 2 VthrComp = 106
[09:27:09.446] <TB3> INFO: ROC 3 VthrComp = 103
[09:27:09.446] <TB3> INFO: ROC 4 VthrComp = 107
[09:27:09.447] <TB3> INFO: ROC 5 VthrComp = 109
[09:27:09.447] <TB3> INFO: ROC 6 VthrComp = 105
[09:27:09.447] <TB3> INFO: ROC 7 VthrComp = 109
[09:27:09.447] <TB3> INFO: ROC 8 VthrComp = 108
[09:27:09.447] <TB3> INFO: ROC 9 VthrComp = 108
[09:27:09.447] <TB3> INFO: ROC 10 VthrComp = 107
[09:27:09.447] <TB3> INFO: ROC 11 VthrComp = 107
[09:27:09.447] <TB3> INFO: ROC 12 VthrComp = 111
[09:27:09.447] <TB3> INFO: ROC 13 VthrComp = 110
[09:27:09.447] <TB3> INFO: ROC 14 VthrComp = 112
[09:27:09.448] <TB3> INFO: ROC 15 VthrComp = 109
[09:27:09.448] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[09:27:09.448] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[09:27:09.456] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:27:09.457] <TB3> INFO: run 1 of 1
[09:27:09.795] <TB3> INFO: Expecting 5025280 events.
[09:27:44.890] <TB3> INFO: 764464 events read in total (34379ms).
[09:28:19.089] <TB3> INFO: 1526992 events read in total (68578ms).
[09:28:53.863] <TB3> INFO: 2290904 events read in total (103352ms).
[09:29:25.168] <TB3> INFO: 3049728 events read in total (134657ms).
[09:30:00.058] <TB3> INFO: 3802784 events read in total (169547ms).
[09:30:34.909] <TB3> INFO: 4553536 events read in total (204398ms).
[09:30:57.223] <TB3> INFO: 5025280 events read in total (226712ms).
[09:30:57.283] <TB3> INFO: Test took 227826ms.
[09:30:57.431] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:31:21.292] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 62.7424 for pixel 32/1 mean/min/max = 47.8642/32.8978/62.8305
[09:31:21.293] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 61.0138 for pixel 2/7 mean/min/max = 46.454/31.7522/61.1558
[09:31:21.293] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 65.2755 for pixel 19/15 mean/min/max = 49.545/33.6054/65.4846
[09:31:21.293] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 59.4866 for pixel 13/78 mean/min/max = 45.9493/32.3754/59.5233
[09:31:21.293] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 61.1618 for pixel 51/22 mean/min/max = 47.3462/33.3334/61.359
[09:31:21.294] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 64.3916 for pixel 14/61 mean/min/max = 49.5496/34.6751/64.4241
[09:31:21.294] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 58.6546 for pixel 0/9 mean/min/max = 46.7671/34.7925/58.7416
[09:31:21.294] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 72.2167 for pixel 0/73 mean/min/max = 55.4345/38.5415/72.3276
[09:31:21.295] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 73.4568 for pixel 2/78 mean/min/max = 54.5573/35.6352/73.4795
[09:31:21.295] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 64.8052 for pixel 30/2 mean/min/max = 49.3144/33.7353/64.8935
[09:31:21.295] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 61.0747 for pixel 13/0 mean/min/max = 47.7769/34.3874/61.1663
[09:31:21.295] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 65.6563 for pixel 51/12 mean/min/max = 50.1536/34.2932/66.014
[09:31:21.296] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 68.9207 for pixel 14/66 mean/min/max = 51.8939/34.6495/69.1384
[09:31:21.296] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 69.3813 for pixel 41/65 mean/min/max = 53.1722/36.4185/69.9258
[09:31:21.296] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 61.6005 for pixel 46/0 mean/min/max = 47.7967/33.9917/61.6016
[09:31:21.296] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 61.5741 for pixel 13/2 mean/min/max = 47.8533/33.9178/61.7888
[09:31:21.296] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:31:21.429] <TB3> INFO: Expecting 411648 events.
[09:31:31.257] <TB3> INFO: 411648 events read in total (9112ms).
[09:31:31.263] <TB3> INFO: Expecting 411648 events.
[09:31:40.369] <TB3> INFO: 411648 events read in total (8526ms).
[09:31:40.376] <TB3> INFO: Expecting 411648 events.
[09:31:49.601] <TB3> INFO: 411648 events read in total (8642ms).
[09:31:49.610] <TB3> INFO: Expecting 411648 events.
[09:31:58.899] <TB3> INFO: 411648 events read in total (8712ms).
[09:31:58.914] <TB3> INFO: Expecting 411648 events.
[09:32:08.720] <TB3> INFO: 411648 events read in total (9245ms).
[09:32:08.738] <TB3> INFO: Expecting 411648 events.
[09:32:17.832] <TB3> INFO: 411648 events read in total (8540ms).
[09:32:17.848] <TB3> INFO: Expecting 411648 events.
[09:32:26.997] <TB3> INFO: 411648 events read in total (8577ms).
[09:32:27.019] <TB3> INFO: Expecting 411648 events.
[09:32:36.231] <TB3> INFO: 411648 events read in total (8652ms).
[09:32:36.250] <TB3> INFO: Expecting 411648 events.
[09:32:46.115] <TB3> INFO: 411648 events read in total (9299ms).
[09:32:46.137] <TB3> INFO: Expecting 411648 events.
[09:32:55.439] <TB3> INFO: 411648 events read in total (8753ms).
[09:32:55.468] <TB3> INFO: Expecting 411648 events.
[09:33:04.655] <TB3> INFO: 411648 events read in total (8633ms).
[09:33:04.681] <TB3> INFO: Expecting 411648 events.
[09:33:13.854] <TB3> INFO: 411648 events read in total (8609ms).
[09:33:13.889] <TB3> INFO: Expecting 411648 events.
[09:33:23.616] <TB3> INFO: 411648 events read in total (9186ms).
[09:33:23.648] <TB3> INFO: Expecting 411648 events.
[09:33:33.164] <TB3> INFO: 411648 events read in total (8974ms).
[09:33:33.203] <TB3> INFO: Expecting 411648 events.
[09:33:42.467] <TB3> INFO: 411648 events read in total (8719ms).
[09:33:42.507] <TB3> INFO: Expecting 411648 events.
[09:33:51.364] <TB3> INFO: 411648 events read in total (8313ms).
[09:33:51.407] <TB3> INFO: Test took 150111ms.
[09:33:52.459] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[09:33:52.467] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:33:52.467] <TB3> INFO: run 1 of 1
[09:33:52.769] <TB3> INFO: Expecting 5025280 events.
[09:34:27.366] <TB3> INFO: 744232 events read in total (33881ms).
[09:35:02.758] <TB3> INFO: 1487648 events read in total (69273ms).
[09:35:36.984] <TB3> INFO: 2232160 events read in total (103499ms).
[09:36:11.549] <TB3> INFO: 2972000 events read in total (138064ms).
[09:36:48.061] <TB3> INFO: 3705280 events read in total (174576ms).
[09:37:22.919] <TB3> INFO: 4435600 events read in total (209434ms).
[09:37:50.592] <TB3> INFO: 5025280 events read in total (237107ms).
[09:37:50.669] <TB3> INFO: Test took 238202ms.
[09:37:50.837] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:38:17.101] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 0.157185 .. 255.000000
[09:38:17.194] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[09:38:17.204] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:38:17.204] <TB3> INFO: run 1 of 1
[09:38:17.546] <TB3> INFO: Expecting 8519680 events.
[09:38:51.426] <TB3> INFO: 711872 events read in total (33165ms).
[09:39:24.732] <TB3> INFO: 1423728 events read in total (66471ms).
[09:39:57.561] <TB3> INFO: 2135736 events read in total (99300ms).
[09:40:30.573] <TB3> INFO: 2847856 events read in total (132312ms).
[09:41:03.286] <TB3> INFO: 3560008 events read in total (165025ms).
[09:41:36.676] <TB3> INFO: 4271872 events read in total (198415ms).
[09:42:10.858] <TB3> INFO: 4984712 events read in total (232597ms).
[09:42:43.643] <TB3> INFO: 5697320 events read in total (265382ms).
[09:43:16.917] <TB3> INFO: 6409344 events read in total (298656ms).
[09:43:49.186] <TB3> INFO: 7121208 events read in total (330925ms).
[09:44:22.838] <TB3> INFO: 7832592 events read in total (364577ms).
[09:44:55.299] <TB3> INFO: 8519680 events read in total (397038ms).
[09:44:55.373] <TB3> INFO: Test took 398170ms.
[09:44:55.630] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:45:25.321] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 15.686995 .. 48.835599
[09:45:25.405] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 5 .. 58 (-1/-1) hits flags = 528 (plus default)
[09:45:25.413] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:45:25.413] <TB3> INFO: run 1 of 1
[09:45:25.717] <TB3> INFO: Expecting 1797120 events.
[09:46:03.765] <TB3> INFO: 915680 events read in total (37332ms).
[09:46:39.958] <TB3> INFO: 1797120 events read in total (73525ms).
[09:46:39.985] <TB3> INFO: Test took 74573ms.
[09:46:40.024] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:46:54.633] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 5.500000 .. 46.153277
[09:46:54.714] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 5 .. 56 (-1/-1) hits flags = 528 (plus default)
[09:46:54.723] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:46:54.723] <TB3> INFO: run 1 of 1
[09:46:55.029] <TB3> INFO: Expecting 1730560 events.
[09:47:32.159] <TB3> INFO: 932224 events read in total (36414ms).
[09:48:03.998] <TB3> INFO: 1730560 events read in total (68253ms).
[09:48:04.023] <TB3> INFO: Test took 69301ms.
[09:48:04.066] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:48:18.434] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 5.500000 .. 45.753819
[09:48:18.543] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 5 .. 55 (-1/-1) hits flags = 528 (plus default)
[09:48:18.553] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:48:18.553] <TB3> INFO: run 1 of 1
[09:48:18.877] <TB3> INFO: Expecting 1697280 events.
[09:48:55.762] <TB3> INFO: 939560 events read in total (36169ms).
[09:49:25.812] <TB3> INFO: 1697280 events read in total (66219ms).
[09:49:25.831] <TB3> INFO: Test took 67278ms.
[09:49:25.872] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:49:39.211] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[09:49:39.211] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[09:49:39.219] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[09:49:39.219] <TB3> INFO: run 1 of 1
[09:49:39.524] <TB3> INFO: Expecting 1364480 events.
[09:50:17.199] <TB3> INFO: 878048 events read in total (36959ms).
[09:50:37.388] <TB3> INFO: 1364480 events read in total (57148ms).
[09:50:37.405] <TB3> INFO: Test took 58185ms.
[09:50:37.438] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:50:52.563] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C0.dat
[09:50:52.563] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C1.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C2.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C3.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C4.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C5.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C6.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C7.dat
[09:50:52.564] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C8.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C9.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C10.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C11.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C12.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C13.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C14.dat
[09:50:52.565] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C15.dat
[09:50:52.566] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C0.dat
[09:50:52.575] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C1.dat
[09:50:52.584] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C2.dat
[09:50:52.592] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C3.dat
[09:50:52.600] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C4.dat
[09:50:52.609] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C5.dat
[09:50:52.617] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C6.dat
[09:50:52.627] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C7.dat
[09:50:52.634] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C8.dat
[09:50:52.642] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C9.dat
[09:50:52.652] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C10.dat
[09:50:52.659] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C11.dat
[09:50:52.669] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C12.dat
[09:50:52.677] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C13.dat
[09:50:52.686] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C14.dat
[09:50:52.693] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//trimParameters35_C15.dat
[09:50:52.699] <TB3> INFO: PixTestTrim::trimTest() done
[09:50:52.699] <TB3> INFO: vtrim: 131 108 127 115 127 117 104 137 156 128 106 119 129 131 128 122
[09:50:52.699] <TB3> INFO: vthrcomp: 105 100 106 103 107 109 105 109 108 108 107 107 111 110 112 109
[09:50:52.699] <TB3> INFO: vcal mean: 35.00 34.96 35.03 34.98 34.97 35.01 34.97 35.00 35.00 35.00 35.01 35.00 35.00 34.99 34.95 34.98
[09:50:52.699] <TB3> INFO: vcal RMS: 1.07 1.09 1.11 0.96 0.92 1.08 0.90 1.03 1.06 0.99 0.91 1.02 1.02 1.05 1.06 1.10
[09:50:52.699] <TB3> INFO: bits mean: 9.10 9.32 8.59 9.52 8.94 8.83 8.50 6.83 7.90 8.64 8.27 8.08 8.04 7.78 8.59 8.96
[09:50:52.699] <TB3> INFO: bits RMS: 2.55 2.75 2.55 2.61 2.66 2.31 2.61 2.28 2.33 2.53 2.70 2.65 2.51 2.29 2.62 2.49
[09:50:52.707] <TB3> INFO: ----------------------------------------------------------------------
[09:50:52.707] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 10, vtrims = 254 126 63 32
[09:50:52.707] <TB3> INFO: ----------------------------------------------------------------------
[09:50:52.710] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 10 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[09:50:52.719] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[09:50:52.719] <TB3> INFO: run 1 of 1
[09:50:53.024] <TB3> INFO: Expecting 8320000 events.
[09:51:28.059] <TB3> INFO: 1009720 events read in total (34319ms).
[09:52:02.396] <TB3> INFO: 2009210 events read in total (68656ms).
[09:52:39.251] <TB3> INFO: 3007420 events read in total (105511ms).
[09:53:16.686] <TB3> INFO: 4002060 events read in total (142946ms).
[09:53:54.103] <TB3> INFO: 4987680 events read in total (180363ms).
[09:54:30.586] <TB3> INFO: 5969830 events read in total (216846ms).
[09:55:04.408] <TB3> INFO: 6951190 events read in total (250668ms).
[09:55:40.331] <TB3> INFO: 7931350 events read in total (286591ms).
[09:55:54.809] <TB3> INFO: 8320000 events read in total (301069ms).
[09:55:54.846] <TB3> INFO: Test took 302127ms.
[09:55:54.946] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:56:20.387] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 10 dacrange: 0 .. 195 (-1/-1) hits flags = 528 (plus default)
[09:56:20.396] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[09:56:20.396] <TB3> INFO: run 1 of 1
[09:56:20.703] <TB3> INFO: Expecting 8153600 events.
[09:56:57.837] <TB3> INFO: 980130 events read in total (36418ms).
[09:57:33.206] <TB3> INFO: 1950450 events read in total (71787ms).
[09:58:09.271] <TB3> INFO: 2920040 events read in total (107852ms).
[09:58:45.244] <TB3> INFO: 3886580 events read in total (143825ms).
[09:59:18.666] <TB3> INFO: 4845090 events read in total (177247ms).
[09:59:54.386] <TB3> INFO: 5800480 events read in total (212967ms).
[10:00:30.005] <TB3> INFO: 6754760 events read in total (248586ms).
[10:01:05.150] <TB3> INFO: 7708210 events read in total (283731ms).
[10:01:22.042] <TB3> INFO: 8153600 events read in total (300623ms).
[10:01:22.079] <TB3> INFO: Test took 301683ms.
[10:01:22.171] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:01:47.578] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 10 dacrange: 0 .. 183 (-1/-1) hits flags = 528 (plus default)
[10:01:47.586] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:01:47.586] <TB3> INFO: run 1 of 1
[10:01:47.899] <TB3> INFO: Expecting 7654400 events.
[10:02:24.985] <TB3> INFO: 1010600 events read in total (36370ms).
[10:03:00.778] <TB3> INFO: 2010710 events read in total (72164ms).
[10:03:36.336] <TB3> INFO: 3009650 events read in total (107722ms).
[10:04:12.833] <TB3> INFO: 4003200 events read in total (144218ms).
[10:04:47.229] <TB3> INFO: 4987670 events read in total (178615ms).
[10:05:22.358] <TB3> INFO: 5970060 events read in total (213743ms).
[10:05:57.939] <TB3> INFO: 6951480 events read in total (249324ms).
[10:06:23.620] <TB3> INFO: 7654400 events read in total (275005ms).
[10:06:23.663] <TB3> INFO: Test took 276077ms.
[10:06:23.744] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:06:49.451] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 10 dacrange: 0 .. 183 (-1/-1) hits flags = 528 (plus default)
[10:06:49.459] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:06:49.459] <TB3> INFO: run 1 of 1
[10:06:49.764] <TB3> INFO: Expecting 7654400 events.
[10:07:26.663] <TB3> INFO: 1010100 events read in total (36183ms).
[10:08:02.889] <TB3> INFO: 2009910 events read in total (72410ms).
[10:08:39.163] <TB3> INFO: 3008200 events read in total (108683ms).
[10:09:15.660] <TB3> INFO: 4001560 events read in total (145180ms).
[10:09:52.719] <TB3> INFO: 4985540 events read in total (182239ms).
[10:10:28.694] <TB3> INFO: 5967600 events read in total (218214ms).
[10:11:01.458] <TB3> INFO: 6949250 events read in total (250978ms).
[10:11:28.025] <TB3> INFO: 7654400 events read in total (277545ms).
[10:11:28.065] <TB3> INFO: Test took 278607ms.
[10:11:28.151] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:11:52.601] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 10 dacrange: 0 .. 184 (-1/-1) hits flags = 528 (plus default)
[10:11:52.609] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:11:52.609] <TB3> INFO: run 1 of 1
[10:11:52.911] <TB3> INFO: Expecting 7696000 events.
[10:12:29.436] <TB3> INFO: 1006980 events read in total (35809ms).
[10:13:04.939] <TB3> INFO: 2003770 events read in total (71312ms).
[10:13:40.300] <TB3> INFO: 2999390 events read in total (106673ms).
[10:14:16.230] <TB3> INFO: 3989800 events read in total (142603ms).
[10:14:52.461] <TB3> INFO: 4970910 events read in total (178834ms).
[10:15:28.237] <TB3> INFO: 5950810 events read in total (214610ms).
[10:16:04.328] <TB3> INFO: 6929070 events read in total (250701ms).
[10:16:31.700] <TB3> INFO: 7696000 events read in total (278073ms).
[10:16:31.743] <TB3> INFO: Test took 279134ms.
[10:16:31.834] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:16:55.711] <TB3> INFO: PixTestTrim::trimBitTest() done
[10:16:55.712] <TB3> INFO: PixTestTrim::doTest() done, duration: 3189 seconds
[10:16:55.712] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:16:55.712] <TB3> INFO: Decoding statistics:
[10:16:55.712] <TB3> INFO: General information:
[10:16:55.712] <TB3> INFO: 16bit words read: 0
[10:16:55.713] <TB3> INFO: valid events total: 0
[10:16:55.713] <TB3> INFO: empty events: 0
[10:16:55.713] <TB3> INFO: valid events with pixels: 0
[10:16:55.713] <TB3> INFO: valid pixel hits: 0
[10:16:55.713] <TB3> INFO: Event errors: 0
[10:16:55.713] <TB3> INFO: start marker: 0
[10:16:55.713] <TB3> INFO: stop marker: 0
[10:16:55.713] <TB3> INFO: overflow: 0
[10:16:55.713] <TB3> INFO: invalid 5bit words: 0
[10:16:55.713] <TB3> INFO: invalid XOR eye diagram: 0
[10:16:55.713] <TB3> INFO: TBM errors: 0
[10:16:55.713] <TB3> INFO: flawed TBM headers: 0
[10:16:55.713] <TB3> INFO: flawed TBM trailers: 0
[10:16:55.713] <TB3> INFO: event ID mismatches: 0
[10:16:55.713] <TB3> INFO: ROC errors: 0
[10:16:55.713] <TB3> INFO: missing ROC header(s): 0
[10:16:55.713] <TB3> INFO: misplaced readback start: 0
[10:16:55.713] <TB3> INFO: Pixel decoding errors: 0
[10:16:55.713] <TB3> INFO: pixel data incomplete: 0
[10:16:55.713] <TB3> INFO: pixel address: 0
[10:16:55.713] <TB3> INFO: pulse height fill bit: 0
[10:16:55.713] <TB3> INFO: buffer corruption: 0
[10:16:56.462] <TB3> INFO: ######################################################################
[10:16:56.463] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[10:16:56.463] <TB3> INFO: ######################################################################
[10:16:56.788] <TB3> INFO: Expecting 41600 events.
[10:17:01.153] <TB3> INFO: 41600 events read in total (3648ms).
[10:17:01.154] <TB3> INFO: Test took 4690ms.
[10:17:01.161] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:17:01.726] <TB3> INFO: Expecting 41600 events.
[10:17:06.213] <TB3> INFO: 41600 events read in total (3771ms).
[10:17:06.214] <TB3> INFO: Test took 4802ms.
[10:17:06.221] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:17:06.578] <TB3> INFO: Expecting 41600 events.
[10:17:10.932] <TB3> INFO: 41600 events read in total (3638ms).
[10:17:10.932] <TB3> INFO: Test took 4697ms.
[10:17:10.938] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:17:11.286] <TB3> INFO: Expecting 2560 events.
[10:17:12.354] <TB3> INFO: 2560 events read in total (352ms).
[10:17:12.354] <TB3> INFO: Test took 1409ms.
[10:17:12.768] <TB3> INFO: Expecting 2560 events.
[10:17:13.835] <TB3> INFO: 2560 events read in total (351ms).
[10:17:13.835] <TB3> INFO: Test took 1480ms.
[10:17:14.250] <TB3> INFO: Expecting 2560 events.
[10:17:15.317] <TB3> INFO: 2560 events read in total (351ms).
[10:17:15.317] <TB3> INFO: Test took 1481ms.
[10:17:15.731] <TB3> INFO: Expecting 2560 events.
[10:17:16.800] <TB3> INFO: 2560 events read in total (353ms).
[10:17:16.800] <TB3> INFO: Test took 1482ms.
[10:17:17.215] <TB3> INFO: Expecting 2560 events.
[10:17:18.280] <TB3> INFO: 2560 events read in total (349ms).
[10:17:18.280] <TB3> INFO: Test took 1479ms.
[10:17:18.694] <TB3> INFO: Expecting 2560 events.
[10:17:19.762] <TB3> INFO: 2560 events read in total (352ms).
[10:17:19.763] <TB3> INFO: Test took 1483ms.
[10:17:20.176] <TB3> INFO: Expecting 2560 events.
[10:17:21.244] <TB3> INFO: 2560 events read in total (352ms).
[10:17:21.244] <TB3> INFO: Test took 1481ms.
[10:17:21.658] <TB3> INFO: Expecting 2560 events.
[10:17:22.723] <TB3> INFO: 2560 events read in total (349ms).
[10:17:22.723] <TB3> INFO: Test took 1478ms.
[10:17:23.137] <TB3> INFO: Expecting 2560 events.
[10:17:24.202] <TB3> INFO: 2560 events read in total (349ms).
[10:17:24.202] <TB3> INFO: Test took 1479ms.
[10:17:24.617] <TB3> INFO: Expecting 2560 events.
[10:17:25.681] <TB3> INFO: 2560 events read in total (348ms).
[10:17:25.681] <TB3> INFO: Test took 1478ms.
[10:17:26.095] <TB3> INFO: Expecting 2560 events.
[10:17:27.161] <TB3> INFO: 2560 events read in total (350ms).
[10:17:27.161] <TB3> INFO: Test took 1480ms.
[10:17:27.575] <TB3> INFO: Expecting 2560 events.
[10:17:28.639] <TB3> INFO: 2560 events read in total (348ms).
[10:17:28.640] <TB3> INFO: Test took 1479ms.
[10:17:29.054] <TB3> INFO: Expecting 2560 events.
[10:17:30.119] <TB3> INFO: 2560 events read in total (350ms).
[10:17:30.120] <TB3> INFO: Test took 1479ms.
[10:17:30.535] <TB3> INFO: Expecting 2560 events.
[10:17:31.598] <TB3> INFO: 2560 events read in total (347ms).
[10:17:31.598] <TB3> INFO: Test took 1478ms.
[10:17:32.012] <TB3> INFO: Expecting 2560 events.
[10:17:33.078] <TB3> INFO: 2560 events read in total (350ms).
[10:17:33.079] <TB3> INFO: Test took 1480ms.
[10:17:33.493] <TB3> INFO: Expecting 2560 events.
[10:17:34.557] <TB3> INFO: 2560 events read in total (349ms).
[10:17:34.558] <TB3> INFO: Test took 1479ms.
[10:17:34.561] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:17:34.974] <TB3> INFO: Expecting 655360 events.
[10:17:49.549] <TB3> INFO: 655360 events read in total (13856ms).
[10:17:49.560] <TB3> INFO: Expecting 655360 events.
[10:18:04.198] <TB3> INFO: 655360 events read in total (14111ms).
[10:18:04.212] <TB3> INFO: Expecting 655360 events.
[10:18:18.442] <TB3> INFO: 655360 events read in total (13702ms).
[10:18:18.458] <TB3> INFO: Expecting 655360 events.
[10:18:33.316] <TB3> INFO: 655360 events read in total (14330ms).
[10:18:33.338] <TB3> INFO: Expecting 655360 events.
[10:18:47.438] <TB3> INFO: 655360 events read in total (13573ms).
[10:18:47.462] <TB3> INFO: Expecting 655360 events.
[10:19:01.028] <TB3> INFO: 655360 events read in total (13038ms).
[10:19:01.055] <TB3> INFO: Expecting 655360 events.
[10:19:16.017] <TB3> INFO: 655360 events read in total (14435ms).
[10:19:16.055] <TB3> INFO: Expecting 655360 events.
[10:19:30.257] <TB3> INFO: 655360 events read in total (13675ms).
[10:19:30.297] <TB3> INFO: Expecting 655360 events.
[10:19:44.914] <TB3> INFO: 655360 events read in total (14089ms).
[10:19:44.954] <TB3> INFO: Expecting 655360 events.
[10:19:59.356] <TB3> INFO: 655360 events read in total (13874ms).
[10:19:59.398] <TB3> INFO: Expecting 655360 events.
[10:20:13.844] <TB3> INFO: 655360 events read in total (13919ms).
[10:20:13.889] <TB3> INFO: Expecting 655360 events.
[10:20:28.985] <TB3> INFO: 655360 events read in total (14569ms).
[10:20:29.042] <TB3> INFO: Expecting 655360 events.
[10:20:43.236] <TB3> INFO: 655360 events read in total (13666ms).
[10:20:43.308] <TB3> INFO: Expecting 655360 events.
[10:20:57.760] <TB3> INFO: 655360 events read in total (13924ms).
[10:20:57.831] <TB3> INFO: Expecting 655360 events.
[10:21:12.261] <TB3> INFO: 655360 events read in total (13902ms).
[10:21:12.326] <TB3> INFO: Expecting 655360 events.
[10:21:26.577] <TB3> INFO: 655360 events read in total (13724ms).
[10:21:26.638] <TB3> INFO: Test took 232077ms.
[10:21:26.715] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:21:27.025] <TB3> INFO: Expecting 655360 events.
[10:21:41.753] <TB3> INFO: 655360 events read in total (14012ms).
[10:21:41.764] <TB3> INFO: Expecting 655360 events.
[10:21:56.061] <TB3> INFO: 655360 events read in total (13769ms).
[10:21:56.073] <TB3> INFO: Expecting 655360 events.
[10:22:10.373] <TB3> INFO: 655360 events read in total (13772ms).
[10:22:10.390] <TB3> INFO: Expecting 655360 events.
[10:22:24.534] <TB3> INFO: 655360 events read in total (13617ms).
[10:22:24.553] <TB3> INFO: Expecting 655360 events.
[10:22:38.260] <TB3> INFO: 655360 events read in total (13179ms).
[10:22:38.283] <TB3> INFO: Expecting 655360 events.
[10:22:51.978] <TB3> INFO: 655360 events read in total (13167ms).
[10:22:52.005] <TB3> INFO: Expecting 655360 events.
[10:23:06.411] <TB3> INFO: 655360 events read in total (13878ms).
[10:23:06.440] <TB3> INFO: Expecting 655360 events.
[10:23:20.705] <TB3> INFO: 655360 events read in total (13738ms).
[10:23:20.738] <TB3> INFO: Expecting 655360 events.
[10:23:35.395] <TB3> INFO: 655360 events read in total (14130ms).
[10:23:35.431] <TB3> INFO: Expecting 655360 events.
[10:23:49.804] <TB3> INFO: 655360 events read in total (13845ms).
[10:23:49.855] <TB3> INFO: Expecting 655360 events.
[10:24:04.252] <TB3> INFO: 655360 events read in total (13870ms).
[10:24:04.304] <TB3> INFO: Expecting 655360 events.
[10:24:18.703] <TB3> INFO: 655360 events read in total (13871ms).
[10:24:18.772] <TB3> INFO: Expecting 655360 events.
[10:24:33.131] <TB3> INFO: 655360 events read in total (13832ms).
[10:24:33.182] <TB3> INFO: Expecting 655360 events.
[10:24:47.433] <TB3> INFO: 655360 events read in total (13724ms).
[10:24:47.503] <TB3> INFO: Expecting 655360 events.
[10:25:02.014] <TB3> INFO: 655360 events read in total (13983ms).
[10:25:02.074] <TB3> INFO: Expecting 655360 events.
[10:25:16.151] <TB3> INFO: 655360 events read in total (13550ms).
[10:25:16.213] <TB3> INFO: Test took 229498ms.
[10:25:16.407] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.414] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.421] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.430] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.439] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.446] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:25:16.456] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[10:25:16.466] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[10:25:16.476] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[10:25:16.484] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.494] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.503] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.512] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.521] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.529] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.537] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.544] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.550] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.557] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.564] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:25:16.571] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:25:16.578] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[10:25:16.585] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[10:25:16.592] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[10:25:16.599] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[10:25:16.605] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C0.dat
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C1.dat
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C2.dat
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C3.dat
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C4.dat
[10:25:16.640] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C5.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C6.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C7.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C8.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C9.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C10.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C11.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C12.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C13.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C14.dat
[10:25:16.641] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//dacParameters35_C15.dat
[10:25:16.979] <TB3> INFO: Expecting 41600 events.
[10:25:20.892] <TB3> INFO: 41600 events read in total (3197ms).
[10:25:20.892] <TB3> INFO: Test took 4248ms.
[10:25:21.463] <TB3> INFO: Expecting 41600 events.
[10:25:25.439] <TB3> INFO: 41600 events read in total (3261ms).
[10:25:25.440] <TB3> INFO: Test took 4308ms.
[10:25:26.014] <TB3> INFO: Expecting 41600 events.
[10:25:29.958] <TB3> INFO: 41600 events read in total (3228ms).
[10:25:29.958] <TB3> INFO: Test took 4277ms.
[10:25:30.194] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:30.326] <TB3> INFO: Expecting 2560 events.
[10:25:31.391] <TB3> INFO: 2560 events read in total (349ms).
[10:25:31.392] <TB3> INFO: Test took 1198ms.
[10:25:31.394] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:31.807] <TB3> INFO: Expecting 2560 events.
[10:25:32.874] <TB3> INFO: 2560 events read in total (352ms).
[10:25:32.874] <TB3> INFO: Test took 1480ms.
[10:25:32.877] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:33.290] <TB3> INFO: Expecting 2560 events.
[10:25:34.360] <TB3> INFO: 2560 events read in total (355ms).
[10:25:34.360] <TB3> INFO: Test took 1483ms.
[10:25:34.362] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:34.775] <TB3> INFO: Expecting 2560 events.
[10:25:35.842] <TB3> INFO: 2560 events read in total (352ms).
[10:25:35.842] <TB3> INFO: Test took 1480ms.
[10:25:35.844] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:36.257] <TB3> INFO: Expecting 2560 events.
[10:25:37.328] <TB3> INFO: 2560 events read in total (355ms).
[10:25:37.328] <TB3> INFO: Test took 1484ms.
[10:25:37.330] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:37.744] <TB3> INFO: Expecting 2560 events.
[10:25:38.816] <TB3> INFO: 2560 events read in total (356ms).
[10:25:38.816] <TB3> INFO: Test took 1486ms.
[10:25:38.819] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:39.231] <TB3> INFO: Expecting 2560 events.
[10:25:40.300] <TB3> INFO: 2560 events read in total (353ms).
[10:25:40.300] <TB3> INFO: Test took 1481ms.
[10:25:40.303] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:40.715] <TB3> INFO: Expecting 2560 events.
[10:25:41.785] <TB3> INFO: 2560 events read in total (354ms).
[10:25:41.786] <TB3> INFO: Test took 1483ms.
[10:25:41.788] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:42.201] <TB3> INFO: Expecting 2560 events.
[10:25:43.264] <TB3> INFO: 2560 events read in total (347ms).
[10:25:43.265] <TB3> INFO: Test took 1477ms.
[10:25:43.267] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:43.680] <TB3> INFO: Expecting 2560 events.
[10:25:44.747] <TB3> INFO: 2560 events read in total (351ms).
[10:25:44.747] <TB3> INFO: Test took 1480ms.
[10:25:44.753] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:45.162] <TB3> INFO: Expecting 2560 events.
[10:25:46.225] <TB3> INFO: 2560 events read in total (347ms).
[10:25:46.226] <TB3> INFO: Test took 1473ms.
[10:25:46.227] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:46.641] <TB3> INFO: Expecting 2560 events.
[10:25:47.705] <TB3> INFO: 2560 events read in total (348ms).
[10:25:47.705] <TB3> INFO: Test took 1478ms.
[10:25:47.708] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:48.120] <TB3> INFO: Expecting 2560 events.
[10:25:49.188] <TB3> INFO: 2560 events read in total (352ms).
[10:25:49.188] <TB3> INFO: Test took 1480ms.
[10:25:49.191] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:49.604] <TB3> INFO: Expecting 2560 events.
[10:25:50.669] <TB3> INFO: 2560 events read in total (349ms).
[10:25:50.669] <TB3> INFO: Test took 1478ms.
[10:25:50.674] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:51.084] <TB3> INFO: Expecting 2560 events.
[10:25:52.150] <TB3> INFO: 2560 events read in total (350ms).
[10:25:52.150] <TB3> INFO: Test took 1477ms.
[10:25:52.152] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:52.565] <TB3> INFO: Expecting 2560 events.
[10:25:53.629] <TB3> INFO: 2560 events read in total (349ms).
[10:25:53.629] <TB3> INFO: Test took 1477ms.
[10:25:53.633] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:54.044] <TB3> INFO: Expecting 2560 events.
[10:25:55.106] <TB3> INFO: 2560 events read in total (347ms).
[10:25:55.106] <TB3> INFO: Test took 1473ms.
[10:25:55.108] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:55.521] <TB3> INFO: Expecting 2560 events.
[10:25:56.582] <TB3> INFO: 2560 events read in total (346ms).
[10:25:56.582] <TB3> INFO: Test took 1474ms.
[10:25:56.584] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:56.997] <TB3> INFO: Expecting 2560 events.
[10:25:58.059] <TB3> INFO: 2560 events read in total (347ms).
[10:25:58.059] <TB3> INFO: Test took 1475ms.
[10:25:58.062] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:58.473] <TB3> INFO: Expecting 2560 events.
[10:25:59.534] <TB3> INFO: 2560 events read in total (345ms).
[10:25:59.535] <TB3> INFO: Test took 1473ms.
[10:25:59.538] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:25:59.949] <TB3> INFO: Expecting 2560 events.
[10:26:01.013] <TB3> INFO: 2560 events read in total (348ms).
[10:26:01.013] <TB3> INFO: Test took 1476ms.
[10:26:01.017] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:01.428] <TB3> INFO: Expecting 2560 events.
[10:26:02.492] <TB3> INFO: 2560 events read in total (348ms).
[10:26:02.492] <TB3> INFO: Test took 1476ms.
[10:26:02.496] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:02.907] <TB3> INFO: Expecting 2560 events.
[10:26:03.971] <TB3> INFO: 2560 events read in total (348ms).
[10:26:03.971] <TB3> INFO: Test took 1475ms.
[10:26:03.973] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:04.386] <TB3> INFO: Expecting 2560 events.
[10:26:05.450] <TB3> INFO: 2560 events read in total (348ms).
[10:26:05.450] <TB3> INFO: Test took 1477ms.
[10:26:05.452] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:05.865] <TB3> INFO: Expecting 2560 events.
[10:26:06.928] <TB3> INFO: 2560 events read in total (348ms).
[10:26:06.929] <TB3> INFO: Test took 1477ms.
[10:26:06.931] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:07.344] <TB3> INFO: Expecting 2560 events.
[10:26:08.407] <TB3> INFO: 2560 events read in total (348ms).
[10:26:08.407] <TB3> INFO: Test took 1476ms.
[10:26:08.410] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:08.822] <TB3> INFO: Expecting 2560 events.
[10:26:09.885] <TB3> INFO: 2560 events read in total (347ms).
[10:26:09.885] <TB3> INFO: Test took 1475ms.
[10:26:09.888] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:10.300] <TB3> INFO: Expecting 2560 events.
[10:26:11.362] <TB3> INFO: 2560 events read in total (347ms).
[10:26:11.362] <TB3> INFO: Test took 1474ms.
[10:26:11.366] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:11.777] <TB3> INFO: Expecting 2560 events.
[10:26:12.840] <TB3> INFO: 2560 events read in total (347ms).
[10:26:12.840] <TB3> INFO: Test took 1475ms.
[10:26:12.843] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:13.255] <TB3> INFO: Expecting 2560 events.
[10:26:14.322] <TB3> INFO: 2560 events read in total (351ms).
[10:26:14.322] <TB3> INFO: Test took 1479ms.
[10:26:14.324] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:14.738] <TB3> INFO: Expecting 2560 events.
[10:26:15.808] <TB3> INFO: 2560 events read in total (354ms).
[10:26:15.808] <TB3> INFO: Test took 1484ms.
[10:26:15.812] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:26:16.224] <TB3> INFO: Expecting 2560 events.
[10:26:17.289] <TB3> INFO: 2560 events read in total (349ms).
[10:26:17.289] <TB3> INFO: Test took 1477ms.
[10:26:17.905] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 561 seconds
[10:26:17.905] <TB3> INFO: PH scale (per ROC): 67 77 69 74 80 75 80 74 68 69 76 70 75 69 72 81
[10:26:17.905] <TB3> INFO: PH offset (per ROC): 171 158 157 145 172 177 166 177 176 174 148 182 165 167 176 176
[10:26:17.910] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:17.910] <TB3> INFO: Decoding statistics:
[10:26:17.910] <TB3> INFO: General information:
[10:26:17.910] <TB3> INFO: 16bit words read: 91920
[10:26:17.910] <TB3> INFO: valid events total: 10240
[10:26:17.910] <TB3> INFO: empty events: 7740
[10:26:17.910] <TB3> INFO: valid events with pixels: 2500
[10:26:17.910] <TB3> INFO: valid pixel hits: 2500
[10:26:17.910] <TB3> INFO: Event errors: 0
[10:26:17.910] <TB3> INFO: start marker: 0
[10:26:17.910] <TB3> INFO: stop marker: 0
[10:26:17.910] <TB3> INFO: overflow: 0
[10:26:17.910] <TB3> INFO: invalid 5bit words: 0
[10:26:17.910] <TB3> INFO: invalid XOR eye diagram: 0
[10:26:17.910] <TB3> INFO: TBM errors: 0
[10:26:17.910] <TB3> INFO: flawed TBM headers: 0
[10:26:17.910] <TB3> INFO: flawed TBM trailers: 0
[10:26:17.910] <TB3> INFO: event ID mismatches: 0
[10:26:17.910] <TB3> INFO: ROC errors: 0
[10:26:17.910] <TB3> INFO: missing ROC header(s): 0
[10:26:17.910] <TB3> INFO: misplaced readback start: 0
[10:26:17.910] <TB3> INFO: Pixel decoding errors: 0
[10:26:17.910] <TB3> INFO: pixel data incomplete: 0
[10:26:17.910] <TB3> INFO: pixel address: 0
[10:26:17.910] <TB3> INFO: pulse height fill bit: 0
[10:26:17.910] <TB3> INFO: buffer corruption: 0
[10:26:18.079] <TB3> INFO: ######################################################################
[10:26:18.079] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[10:26:18.079] <TB3> INFO: ######################################################################
[10:26:18.090] <TB3> INFO: scanning low vcal = 10
[10:26:18.389] <TB3> INFO: Expecting 41600 events.
[10:26:22.161] <TB3> INFO: 41600 events read in total (3056ms).
[10:26:22.161] <TB3> INFO: Test took 4071ms.
[10:26:22.162] <TB3> INFO: scanning low vcal = 20
[10:26:22.575] <TB3> INFO: Expecting 41600 events.
[10:26:26.358] <TB3> INFO: 41600 events read in total (3067ms).
[10:26:26.358] <TB3> INFO: Test took 4196ms.
[10:26:26.360] <TB3> INFO: scanning low vcal = 30
[10:26:26.773] <TB3> INFO: Expecting 41600 events.
[10:26:30.622] <TB3> INFO: 41600 events read in total (3133ms).
[10:26:30.623] <TB3> INFO: Test took 4263ms.
[10:26:30.626] <TB3> INFO: scanning low vcal = 40
[10:26:31.027] <TB3> INFO: Expecting 41600 events.
[10:26:35.336] <TB3> INFO: 41600 events read in total (3593ms).
[10:26:35.337] <TB3> INFO: Test took 4711ms.
[10:26:35.340] <TB3> INFO: scanning low vcal = 50
[10:26:35.679] <TB3> INFO: Expecting 41600 events.
[10:26:39.971] <TB3> INFO: 41600 events read in total (3576ms).
[10:26:39.972] <TB3> INFO: Test took 4632ms.
[10:26:39.974] <TB3> INFO: scanning low vcal = 60
[10:26:40.331] <TB3> INFO: Expecting 41600 events.
[10:26:44.631] <TB3> INFO: 41600 events read in total (3585ms).
[10:26:44.632] <TB3> INFO: Test took 4658ms.
[10:26:44.634] <TB3> INFO: scanning low vcal = 70
[10:26:44.988] <TB3> INFO: Expecting 41600 events.
[10:26:49.447] <TB3> INFO: 41600 events read in total (3743ms).
[10:26:49.448] <TB3> INFO: Test took 4814ms.
[10:26:49.451] <TB3> INFO: scanning low vcal = 80
[10:26:49.798] <TB3> INFO: Expecting 41600 events.
[10:26:54.274] <TB3> INFO: 41600 events read in total (3760ms).
[10:26:54.275] <TB3> INFO: Test took 4824ms.
[10:26:54.278] <TB3> INFO: scanning low vcal = 90
[10:26:54.625] <TB3> INFO: Expecting 41600 events.
[10:26:58.947] <TB3> INFO: 41600 events read in total (3606ms).
[10:26:58.947] <TB3> INFO: Test took 4669ms.
[10:26:58.951] <TB3> INFO: scanning low vcal = 100
[10:26:59.305] <TB3> INFO: Expecting 41600 events.
[10:27:03.803] <TB3> INFO: 41600 events read in total (3783ms).
[10:27:03.804] <TB3> INFO: Test took 4853ms.
[10:27:03.807] <TB3> INFO: scanning low vcal = 110
[10:27:04.155] <TB3> INFO: Expecting 41600 events.
[10:27:08.479] <TB3> INFO: 41600 events read in total (3608ms).
[10:27:08.480] <TB3> INFO: Test took 4673ms.
[10:27:08.483] <TB3> INFO: scanning low vcal = 120
[10:27:08.835] <TB3> INFO: Expecting 41600 events.
[10:27:13.185] <TB3> INFO: 41600 events read in total (3634ms).
[10:27:13.186] <TB3> INFO: Test took 4703ms.
[10:27:13.189] <TB3> INFO: scanning low vcal = 130
[10:27:13.530] <TB3> INFO: Expecting 41600 events.
[10:27:17.894] <TB3> INFO: 41600 events read in total (3648ms).
[10:27:17.894] <TB3> INFO: Test took 4705ms.
[10:27:17.897] <TB3> INFO: scanning low vcal = 140
[10:27:18.240] <TB3> INFO: Expecting 41600 events.
[10:27:22.584] <TB3> INFO: 41600 events read in total (3629ms).
[10:27:22.585] <TB3> INFO: Test took 4688ms.
[10:27:22.588] <TB3> INFO: scanning low vcal = 150
[10:27:22.915] <TB3> INFO: Expecting 41600 events.
[10:27:27.305] <TB3> INFO: 41600 events read in total (3674ms).
[10:27:27.306] <TB3> INFO: Test took 4718ms.
[10:27:27.309] <TB3> INFO: scanning low vcal = 160
[10:27:27.652] <TB3> INFO: Expecting 41600 events.
[10:27:32.080] <TB3> INFO: 41600 events read in total (3712ms).
[10:27:32.081] <TB3> INFO: Test took 4772ms.
[10:27:32.084] <TB3> INFO: scanning low vcal = 170
[10:27:32.432] <TB3> INFO: Expecting 41600 events.
[10:27:36.855] <TB3> INFO: 41600 events read in total (3708ms).
[10:27:36.856] <TB3> INFO: Test took 4772ms.
[10:27:36.860] <TB3> INFO: scanning low vcal = 180
[10:27:37.208] <TB3> INFO: Expecting 41600 events.
[10:27:41.535] <TB3> INFO: 41600 events read in total (3611ms).
[10:27:41.536] <TB3> INFO: Test took 4676ms.
[10:27:41.539] <TB3> INFO: scanning low vcal = 190
[10:27:41.888] <TB3> INFO: Expecting 41600 events.
[10:27:46.281] <TB3> INFO: 41600 events read in total (3677ms).
[10:27:46.281] <TB3> INFO: Test took 4742ms.
[10:27:46.284] <TB3> INFO: scanning low vcal = 200
[10:27:46.632] <TB3> INFO: Expecting 41600 events.
[10:27:50.972] <TB3> INFO: 41600 events read in total (3624ms).
[10:27:50.972] <TB3> INFO: Test took 4688ms.
[10:27:50.975] <TB3> INFO: scanning low vcal = 210
[10:27:51.322] <TB3> INFO: Expecting 41600 events.
[10:27:55.655] <TB3> INFO: 41600 events read in total (3617ms).
[10:27:55.656] <TB3> INFO: Test took 4681ms.
[10:27:55.659] <TB3> INFO: scanning low vcal = 220
[10:27:56.012] <TB3> INFO: Expecting 41600 events.
[10:28:00.368] <TB3> INFO: 41600 events read in total (3641ms).
[10:28:00.369] <TB3> INFO: Test took 4710ms.
[10:28:00.372] <TB3> INFO: scanning low vcal = 230
[10:28:00.705] <TB3> INFO: Expecting 41600 events.
[10:28:05.086] <TB3> INFO: 41600 events read in total (3665ms).
[10:28:05.086] <TB3> INFO: Test took 4714ms.
[10:28:05.089] <TB3> INFO: scanning low vcal = 240
[10:28:05.443] <TB3> INFO: Expecting 41600 events.
[10:28:09.676] <TB3> INFO: 41600 events read in total (3517ms).
[10:28:09.677] <TB3> INFO: Test took 4588ms.
[10:28:09.680] <TB3> INFO: scanning low vcal = 250
[10:28:10.018] <TB3> INFO: Expecting 41600 events.
[10:28:14.303] <TB3> INFO: 41600 events read in total (3569ms).
[10:28:14.304] <TB3> INFO: Test took 4624ms.
[10:28:14.308] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[10:28:14.648] <TB3> INFO: Expecting 41600 events.
[10:28:18.878] <TB3> INFO: 41600 events read in total (3514ms).
[10:28:18.879] <TB3> INFO: Test took 4571ms.
[10:28:18.881] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[10:28:19.238] <TB3> INFO: Expecting 41600 events.
[10:28:23.480] <TB3> INFO: 41600 events read in total (3526ms).
[10:28:23.481] <TB3> INFO: Test took 4600ms.
[10:28:23.484] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[10:28:23.826] <TB3> INFO: Expecting 41600 events.
[10:28:28.060] <TB3> INFO: 41600 events read in total (3518ms).
[10:28:28.060] <TB3> INFO: Test took 4576ms.
[10:28:28.063] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[10:28:28.419] <TB3> INFO: Expecting 41600 events.
[10:28:32.702] <TB3> INFO: 41600 events read in total (3567ms).
[10:28:32.703] <TB3> INFO: Test took 4640ms.
[10:28:32.706] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[10:28:33.054] <TB3> INFO: Expecting 41600 events.
[10:28:37.459] <TB3> INFO: 41600 events read in total (3691ms).
[10:28:37.461] <TB3> INFO: Test took 4755ms.
[10:28:37.982] <TB3> INFO: PixTestGainPedestal::measure() done
[10:29:11.398] <TB3> INFO: PixTestGainPedestal::fit() done
[10:29:11.398] <TB3> INFO: non-linearity mean: 0.951 0.957 0.968 0.957 0.959 0.952 0.957 0.959 0.957 0.958 0.955 0.964 0.959 0.953 0.956 0.965
[10:29:11.398] <TB3> INFO: non-linearity RMS: 0.006 0.005 0.005 0.006 0.005 0.008 0.005 0.006 0.007 0.006 0.006 0.006 0.006 0.008 0.006 0.004
[10:29:11.398] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[10:29:11.418] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[10:29:11.439] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[10:29:11.458] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[10:29:11.478] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[10:29:11.500] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[10:29:11.520] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[10:29:11.539] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[10:29:11.558] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[10:29:11.578] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[10:29:11.597] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[10:29:11.616] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[10:29:11.635] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[10:29:11.654] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[10:29:11.674] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[10:29:11.693] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[10:29:11.712] <TB3> INFO: PixTestGainPedestal::fullTest() done, duration: 173 seconds
[10:29:11.712] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:11.712] <TB3> INFO: Decoding statistics:
[10:29:11.712] <TB3> INFO: General information:
[10:29:11.712] <TB3> INFO: 16bit words read: 2662400
[10:29:11.712] <TB3> INFO: valid events total: 166400
[10:29:11.712] <TB3> INFO: empty events: 0
[10:29:11.712] <TB3> INFO: valid events with pixels: 166400
[10:29:11.712] <TB3> INFO: valid pixel hits: 665539
[10:29:11.712] <TB3> INFO: Event errors: 0
[10:29:11.712] <TB3> INFO: start marker: 0
[10:29:11.712] <TB3> INFO: stop marker: 0
[10:29:11.712] <TB3> INFO: overflow: 0
[10:29:11.712] <TB3> INFO: invalid 5bit words: 0
[10:29:11.712] <TB3> INFO: invalid XOR eye diagram: 0
[10:29:11.712] <TB3> INFO: TBM errors: 0
[10:29:11.712] <TB3> INFO: flawed TBM headers: 0
[10:29:11.712] <TB3> INFO: flawed TBM trailers: 0
[10:29:11.712] <TB3> INFO: event ID mismatches: 0
[10:29:11.712] <TB3> INFO: ROC errors: 0
[10:29:11.712] <TB3> INFO: missing ROC header(s): 0
[10:29:11.712] <TB3> INFO: misplaced readback start: 0
[10:29:11.712] <TB3> INFO: Pixel decoding errors: 0
[10:29:11.712] <TB3> INFO: pixel data incomplete: 0
[10:29:11.712] <TB3> INFO: pixel address: 0
[10:29:11.712] <TB3> INFO: pulse height fill bit: 0
[10:29:11.712] <TB3> INFO: buffer corruption: 0
[10:29:11.718] <TB3> INFO: readReadbackCal: /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C15.dat
[10:29:11.720] <TB3> INFO: ######################################################################
[10:29:11.720] <TB3> INFO: PixTestReadback::doTest()
[10:29:11.720] <TB3> INFO: ######################################################################
[10:29:11.720] <TB3> INFO: PixTestReadback::RES sent once
[10:29:23.035] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C0.dat
[10:29:23.035] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C1.dat
[10:29:23.035] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C2.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C3.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C4.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C5.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C6.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C7.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C8.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C9.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C10.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C11.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C12.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C13.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C14.dat
[10:29:23.036] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C15.dat
[10:29:23.069] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:29:23.069] <TB3> INFO: PixTestReadback::RES sent once
[10:29:34.275] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C0.dat
[10:29:34.275] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C1.dat
[10:29:34.275] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C2.dat
[10:29:34.275] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C3.dat
[10:29:34.275] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C4.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C5.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C6.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C7.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C8.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C9.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C10.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C11.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C12.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C13.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C14.dat
[10:29:34.276] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C15.dat
[10:29:34.317] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:29:34.317] <TB3> INFO: PixTestReadback::RES sent once
[10:29:42.935] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:29:42.935] <TB3> INFO: Vbg will be calibrated using Vd calibration
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 156.1calibrated Vbg = 1.20426 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 147.7calibrated Vbg = 1.20472 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 156calibrated Vbg = 1.21099 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 148.8calibrated Vbg = 1.221 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 150.4calibrated Vbg = 1.21973 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 146.9calibrated Vbg = 1.22153 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 146.8calibrated Vbg = 1.21609 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 146.8calibrated Vbg = 1.21605 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 151.4calibrated Vbg = 1.23054 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 148.4calibrated Vbg = 1.22155 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 153.1calibrated Vbg = 1.23155 :::*/*/*/*/
[10:29:42.935] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.7calibrated Vbg = 1.21998 :::*/*/*/*/
[10:29:42.936] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.8calibrated Vbg = 1.216 :::*/*/*/*/
[10:29:42.936] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 170calibrated Vbg = 1.22119 :::*/*/*/*/
[10:29:42.936] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 152.9calibrated Vbg = 1.22511 :::*/*/*/*/
[10:29:42.936] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.7calibrated Vbg = 1.21807 :::*/*/*/*/
[10:29:42.940] <TB3> INFO: PixTestReadback::RES sent once
[10:32:37.542] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C0.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C1.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C2.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C3.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C4.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C5.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C6.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C7.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C8.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C9.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C10.dat
[10:32:37.543] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C11.dat
[10:32:37.544] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C12.dat
[10:32:37.544] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C13.dat
[10:32:37.544] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C14.dat
[10:32:37.544] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2120_FullQualification_2015-11-20_09h55m_1448009726//000_FulltestPxar_m20//readbackCal_C15.dat
[10:32:37.576] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:32:37.577] <TB3> INFO: PixTestReadback::doTest() done
[10:32:37.577] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:32:37.577] <TB3> INFO: Decoding statistics:
[10:32:37.577] <TB3> INFO: General information:
[10:32:37.577] <TB3> INFO: 16bit words read: 1024
[10:32:37.578] <TB3> INFO: valid events total: 128
[10:32:37.578] <TB3> INFO: empty events: 128
[10:32:37.578] <TB3> INFO: valid events with pixels: 0
[10:32:37.578] <TB3> INFO: valid pixel hits: 0
[10:32:37.578] <TB3> INFO: Event errors: 0
[10:32:37.578] <TB3> INFO: start marker: 0
[10:32:37.578] <TB3> INFO: stop marker: 0
[10:32:37.578] <TB3> INFO: overflow: 0
[10:32:37.578] <TB3> INFO: invalid 5bit words: 0
[10:32:37.578] <TB3> INFO: invalid XOR eye diagram: 0
[10:32:37.578] <TB3> INFO: TBM errors: 0
[10:32:37.578] <TB3> INFO: flawed TBM headers: 0
[10:32:37.578] <TB3> INFO: flawed TBM trailers: 0
[10:32:37.578] <TB3> INFO: event ID mismatches: 0
[10:32:37.578] <TB3> INFO: ROC errors: 0
[10:32:37.578] <TB3> INFO: missing ROC header(s): 0
[10:32:37.578] <TB3> INFO: misplaced readback start: 0
[10:32:37.578] <TB3> INFO: Pixel decoding errors: 0
[10:32:37.578] <TB3> INFO: pixel data incomplete: 0
[10:32:37.578] <TB3> INFO: pixel address: 0
[10:32:37.578] <TB3> INFO: pulse height fill bit: 0
[10:32:37.578] <TB3> INFO: buffer corruption: 0
[10:32:37.593] <TB3> INFO: Decoding statistics:
[10:32:37.593] <TB3> INFO: General information:
[10:32:37.593] <TB3> INFO: 16bit words read: 2755344
[10:32:37.593] <TB3> INFO: valid events total: 176768
[10:32:37.593] <TB3> INFO: empty events: 7868
[10:32:37.593] <TB3> INFO: valid events with pixels: 168900
[10:32:37.593] <TB3> INFO: valid pixel hits: 668039
[10:32:37.593] <TB3> INFO: Event errors: 0
[10:32:37.593] <TB3> INFO: start marker: 0
[10:32:37.593] <TB3> INFO: stop marker: 0
[10:32:37.593] <TB3> INFO: overflow: 0
[10:32:37.593] <TB3> INFO: invalid 5bit words: 0
[10:32:37.593] <TB3> INFO: invalid XOR eye diagram: 0
[10:32:37.593] <TB3> INFO: TBM errors: 0
[10:32:37.593] <TB3> INFO: flawed TBM headers: 0
[10:32:37.593] <TB3> INFO: flawed TBM trailers: 0
[10:32:37.593] <TB3> INFO: event ID mismatches: 0
[10:32:37.593] <TB3> INFO: ROC errors: 0
[10:32:37.593] <TB3> INFO: missing ROC header(s): 0
[10:32:37.593] <TB3> INFO: misplaced readback start: 0
[10:32:37.593] <TB3> INFO: Pixel decoding errors: 0
[10:32:37.593] <TB3> INFO: pixel data incomplete: 0
[10:32:37.593] <TB3> INFO: pixel address: 0
[10:32:37.593] <TB3> INFO: pulse height fill bit: 0
[10:32:37.593] <TB3> INFO: buffer corruption: 0
[10:32:37.593] <TB3> INFO: enter test to run
[10:32:37.593] <TB3> INFO: test: exit no parameter change
[10:32:37.827] <TB3> QUIET: Connection to board 170 closed.
[10:32:37.907] <TB3> INFO: pXar: this is the end, my friend