[12:47:31.379] <TB1> INFO: *** Welcome to pxar ***
[12:47:31.379] <TB1> INFO: *** Today: 2016/02/10
[12:47:31.463] <TB1> INFO: *** Version: 9751-dirty
[12:47:31.463] <TB1> INFO: readRocDacs: /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C15.dat
[12:47:31.464] <TB1> INFO: readTbmDacs: /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:47:31.464] <TB1> INFO: readMaskFile: /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//defaultMaskFile.dat
[12:47:31.464] <TB1> INFO: readTrimFile: /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters_C15.dat
[12:47:31.531] <TB1> INFO: clk: 4
[12:47:31.531] <TB1> INFO: ctr: 4
[12:47:31.531] <TB1> INFO: sda: 19
[12:47:31.531] <TB1> INFO: tin: 9
[12:47:31.531] <TB1> INFO: level: 15
[12:47:31.532] <TB1> INFO: triggerdelay: 0
[12:47:31.532] <TB1> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[12:47:31.532] <TB1> INFO: Log level: INFO
[12:47:31.539] <TB1> INFO: Found DTB DTB_WXBYFL
[12:47:31.551] <TB1> QUIET: Connection to board DTB_WXBYFL opened.
[12:47:31.552] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 153
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXBYFL
MAC address: 40D855118099
Hostname: pixelDTB153
Comment:
------------------------------------------------------
[12:47:31.554] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[12:47:33.122] <TB1> INFO: DUT info:
[12:47:33.122] <TB1> INFO: The DUT currently contains the following objects:
[12:47:33.122] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:47:33.122] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:47:33.122] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:47:33.122] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:47:33.122] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.122] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.123] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:47:33.523] <TB1> INFO: enter 'restricted' command line mode
[12:47:33.523] <TB1> INFO: enter test to run
[12:47:33.524] <TB1> INFO: test: pretest no parameter change
[12:47:33.524] <TB1> INFO: running: pretest
[12:47:33.530] <TB1> INFO: ----------------------------------------------------------------------
[12:47:33.530] <TB1> INFO: PixTestPretest::programROC()
[12:47:33.530] <TB1> INFO: ----------------------------------------------------------------------
[12:47:51.545] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:47:51.545] <TB1> INFO: IA differences per ROC: 16.1 18.5 18.5 20.1 20.9 20.1 16.9 19.3 21.7 19.3 17.7 20.1 20.1 16.9 18.5 20.1
[12:47:51.648] <TB1> INFO: enter test to run
[12:47:51.648] <TB1> INFO: test: pretest no parameter change
[12:47:51.648] <TB1> INFO: running: pretest
[12:47:51.649] <TB1> INFO: ----------------------------------------------------------------------
[12:47:51.649] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:47:51.649] <TB1> INFO: ----------------------------------------------------------------------
[12:47:58.941] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 383.5 mA = 23.9688 mA/ROC
[12:47:58.942] <TB1> INFO: i(loss) [mA/ROC]: 19.3 19.3 20.1 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3 19.3
[12:47:58.968] <TB1> INFO: enter test to run
[12:47:58.968] <TB1> INFO: test: pretest no parameter change
[12:47:58.968] <TB1> INFO: running: pretest
[12:47:58.968] <TB1> INFO: ----------------------------------------------------------------------
[12:47:58.968] <TB1> INFO: PixTestPretest::findTiming()
[12:47:58.968] <TB1> INFO: ----------------------------------------------------------------------
[12:47:58.968] <TB1> INFO: PixTestCmd::init()

[12:49:27.723] <TB1> INFO: TBM phases: 160MHz: 0, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[12:49:27.724] <TB1> INFO: (success/tries = 100/100), width = 3
[12:49:27.724] <TB1> INFO: enter test to run
[12:49:27.724] <TB1> INFO: test: pretest no parameter change
[12:49:27.724] <TB1> INFO: running: pretest
[12:49:27.725] <TB1> INFO: ----------------------------------------------------------------------
[12:49:27.725] <TB1> INFO: PixTestPretest::findWorkingPixel()
[12:49:27.725] <TB1> INFO: ----------------------------------------------------------------------
[12:49:27.816] <TB1> INFO: Expecting 231680 events.


[12:49:38.021] <TB1> INFO: 231680 events read in total (9649ms).
[12:49:38.025] <TB1> INFO: Test took 10297ms.
[12:49:38.257] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:49:38.327] <TB1> INFO: enter test to run
[12:49:38.327] <TB1> INFO: test: pretest no parameter change
[12:49:38.327] <TB1> INFO: running: pretest
[12:49:38.328] <TB1> INFO: ----------------------------------------------------------------------
[12:49:38.328] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[12:49:38.328] <TB1> INFO: ----------------------------------------------------------------------
[12:49:38.419] <TB1> INFO: Expecting 231680 events.
[12:49:48.613] <TB1> INFO: 231680 events read in total (9638ms).
[12:49:48.617] <TB1> INFO: Test took 10285ms.
[12:49:48.877] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[12:49:48.877] <TB1> INFO: CalDel: 133 148 142 141 148 156 166 147 142 151 125 134 146 137 143 147
[12:49:48.877] <TB1> INFO: VthrComp: 51 51 51 51 51 51 55 51 51 51 51 51 51 51 51 51
[12:49:48.922] <TB1> INFO: enter test to run
[12:49:48.922] <TB1> INFO: test: pretest no parameter change
[12:49:48.922] <TB1> INFO: running: pretest
[12:49:48.922] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C0.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C1.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C2.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C3.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C4.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C5.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C6.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C7.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C8.dat
[12:49:48.923] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C9.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C10.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C11.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C12.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C13.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C14.dat
[12:49:48.924] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters_C15.dat
[12:49:48.924] <TB1> INFO: enter test to run
[12:49:48.924] <TB1> INFO: test: fulltest no parameter change
[12:49:48.924] <TB1> INFO: running: fulltest
[12:49:48.924] <TB1> INFO: ######################################################################
[12:49:48.924] <TB1> INFO: PixTestFullTest::doTest()
[12:49:48.924] <TB1> INFO: ######################################################################
[12:49:48.925] <TB1> INFO: ######################################################################
[12:49:48.925] <TB1> INFO: PixTestAlive::doTest()
[12:49:48.925] <TB1> INFO: ######################################################################
[12:49:48.927] <TB1> INFO: ----------------------------------------------------------------------
[12:49:48.927] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:49:48.927] <TB1> INFO: ----------------------------------------------------------------------
[12:49:49.186] <TB1> INFO: Expecting 41600 events.
[12:49:52.933] <TB1> INFO: 41600 events read in total (3190ms).
[12:49:52.934] <TB1> INFO: Test took 4006ms.
[12:49:53.158] <TB1> INFO: PixTestAlive::aliveTest() done
[12:49:53.158] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[12:49:53.159] <TB1> INFO: ----------------------------------------------------------------------
[12:49:53.159] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:49:53.159] <TB1> INFO: ----------------------------------------------------------------------
[12:49:53.423] <TB1> INFO: Expecting 41600 events.
[12:49:56.443] <TB1> INFO: 41600 events read in total (2464ms).
[12:49:56.443] <TB1> INFO: Test took 3283ms.
[12:49:56.444] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:49:56.694] <TB1> INFO: PixTestAlive::maskTest() done
[12:49:56.694] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:49:56.697] <TB1> INFO: ----------------------------------------------------------------------
[12:49:56.697] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:49:56.697] <TB1> INFO: ----------------------------------------------------------------------
[12:49:56.967] <TB1> INFO: Expecting 41600 events.
[12:50:00.766] <TB1> INFO: 41600 events read in total (3242ms).
[12:50:00.766] <TB1> INFO: Test took 4067ms.
[12:50:01.001] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:50:01.001] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:50:01.001] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[12:50:01.001] <TB1> INFO: Decoding statistics:
[12:50:01.001] <TB1> INFO: General information:
[12:50:01.001] <TB1> INFO: 16bit words read: 0
[12:50:01.001] <TB1> INFO: valid events total: 0
[12:50:01.001] <TB1> INFO: empty events: 0
[12:50:01.001] <TB1> INFO: valid events with pixels: 0
[12:50:01.002] <TB1> INFO: valid pixel hits: 0
[12:50:01.002] <TB1> INFO: Event errors: 0
[12:50:01.002] <TB1> INFO: start marker: 0
[12:50:01.002] <TB1> INFO: stop marker: 0
[12:50:01.002] <TB1> INFO: overflow: 0
[12:50:01.002] <TB1> INFO: invalid 5bit words: 0
[12:50:01.002] <TB1> INFO: invalid XOR eye diagram: 0
[12:50:01.002] <TB1> INFO: frame (failed synchr.): 0
[12:50:01.002] <TB1> INFO: idle data (no TBM trl): 0
[12:50:01.002] <TB1> INFO: no data (only TBM hdr): 0
[12:50:01.002] <TB1> INFO: TBM errors: 0
[12:50:01.002] <TB1> INFO: flawed TBM headers: 0
[12:50:01.002] <TB1> INFO: flawed TBM trailers: 0
[12:50:01.002] <TB1> INFO: event ID mismatches: 0
[12:50:01.002] <TB1> INFO: ROC errors: 0
[12:50:01.002] <TB1> INFO: missing ROC header(s): 0
[12:50:01.002] <TB1> INFO: misplaced readback start: 0
[12:50:01.002] <TB1> INFO: Pixel decoding errors: 0
[12:50:01.002] <TB1> INFO: pixel data incomplete: 0
[12:50:01.002] <TB1> INFO: pixel address: 0
[12:50:01.002] <TB1> INFO: pulse height fill bit: 0
[12:50:01.002] <TB1> INFO: buffer corruption: 0
[12:50:01.012] <TB1> INFO: ######################################################################
[12:50:01.012] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:50:01.012] <TB1> INFO: ######################################################################
[12:50:01.014] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:50:01.025] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[12:50:01.025] <TB1> INFO: run 1 of 1
[12:50:01.291] <TB1> INFO: Expecting 3120000 events.
[12:50:42.826] <TB1> INFO: 872990 events read in total (40979ms).
[12:51:23.669] <TB1> INFO: 1735160 events read in total (81823ms).
[12:52:04.549] <TB1> INFO: 2605255 events read in total (122703ms).
[12:52:28.409] <TB1> INFO: 3120000 events read in total (146562ms).
[12:52:28.453] <TB1> INFO: Test took 147427ms.
[12:52:53.461] <TB1> INFO: PixTestBBMap::doTest() done, duration: 172 seconds
[12:52:53.461] <TB1> INFO: number of dead bumps (per ROC): 3 0 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[12:52:53.461] <TB1> INFO: separation cut (per ROC): 84 88 96 103 104 90 95 84 89 71 91 107 90 81 101 87
[12:52:53.461] <TB1> INFO: Decoding statistics:
[12:52:53.461] <TB1> INFO: General information:
[12:52:53.461] <TB1> INFO: 16bit words read: 0
[12:52:53.461] <TB1> INFO: valid events total: 0
[12:52:53.461] <TB1> INFO: empty events: 0
[12:52:53.461] <TB1> INFO: valid events with pixels: 0
[12:52:53.461] <TB1> INFO: valid pixel hits: 0
[12:52:53.461] <TB1> INFO: Event errors: 0
[12:52:53.461] <TB1> INFO: start marker: 0
[12:52:53.461] <TB1> INFO: stop marker: 0
[12:52:53.461] <TB1> INFO: overflow: 0
[12:52:53.461] <TB1> INFO: invalid 5bit words: 0
[12:52:53.461] <TB1> INFO: invalid XOR eye diagram: 0
[12:52:53.461] <TB1> INFO: frame (failed synchr.): 0
[12:52:53.462] <TB1> INFO: idle data (no TBM trl): 0
[12:52:53.462] <TB1> INFO: no data (only TBM hdr): 0
[12:52:53.462] <TB1> INFO: TBM errors: 0
[12:52:53.462] <TB1> INFO: flawed TBM headers: 0
[12:52:53.462] <TB1> INFO: flawed TBM trailers: 0
[12:52:53.462] <TB1> INFO: event ID mismatches: 0
[12:52:53.462] <TB1> INFO: ROC errors: 0
[12:52:53.462] <TB1> INFO: missing ROC header(s): 0
[12:52:53.462] <TB1> INFO: misplaced readback start: 0
[12:52:53.462] <TB1> INFO: Pixel decoding errors: 0
[12:52:53.462] <TB1> INFO: pixel data incomplete: 0
[12:52:53.462] <TB1> INFO: pixel address: 0
[12:52:53.462] <TB1> INFO: pulse height fill bit: 0
[12:52:53.462] <TB1> INFO: buffer corruption: 0
[12:52:53.566] <TB1> INFO: ######################################################################
[12:52:53.566] <TB1> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:52:53.566] <TB1> INFO: ######################################################################
[12:52:53.566] <TB1> INFO: ----------------------------------------------------------------------
[12:52:53.566] <TB1> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:52:53.566] <TB1> INFO: ----------------------------------------------------------------------
[12:52:53.566] <TB1> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:52:53.577] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:52:53.577] <TB1> INFO: run 1 of 1
[12:52:53.920] <TB1> INFO: Expecting 26208000 events.
[12:53:28.321] <TB1> INFO: 918800 events read in total (33841ms).
[12:54:00.897] <TB1> INFO: 1819900 events read in total (66417ms).
[12:54:33.575] <TB1> INFO: 2720750 events read in total (99095ms).
[12:55:06.863] <TB1> INFO: 3621900 events read in total (132383ms).
[12:55:39.874] <TB1> INFO: 4517650 events read in total (165394ms).
[12:56:13.236] <TB1> INFO: 5412750 events read in total (198756ms).
[12:56:46.855] <TB1> INFO: 6314200 events read in total (232375ms).
[12:57:19.991] <TB1> INFO: 7210300 events read in total (265511ms).
[12:57:52.687] <TB1> INFO: 8106500 events read in total (298207ms).
[12:58:25.881] <TB1> INFO: 9001050 events read in total (331401ms).
[12:58:59.501] <TB1> INFO: 9896300 events read in total (365021ms).
[12:59:32.449] <TB1> INFO: 10792900 events read in total (397969ms).
[13:00:05.198] <TB1> INFO: 11688950 events read in total (430718ms).
[13:00:37.945] <TB1> INFO: 12581750 events read in total (463465ms).
[13:01:10.523] <TB1> INFO: 13469000 events read in total (496043ms).
[13:01:43.609] <TB1> INFO: 14354800 events read in total (529129ms).
[13:02:16.771] <TB1> INFO: 15237500 events read in total (562291ms).
[13:02:49.839] <TB1> INFO: 16116850 events read in total (595359ms).
[13:03:22.600] <TB1> INFO: 16996300 events read in total (628120ms).
[13:03:54.959] <TB1> INFO: 17877700 events read in total (660479ms).
[13:04:27.580] <TB1> INFO: 18758850 events read in total (693100ms).
[13:05:00.939] <TB1> INFO: 19635950 events read in total (726459ms).
[13:05:34.208] <TB1> INFO: 20515750 events read in total (759728ms).
[13:06:07.206] <TB1> INFO: 21394800 events read in total (792726ms).
[13:06:39.799] <TB1> INFO: 22274950 events read in total (825319ms).
[13:07:12.669] <TB1> INFO: 23155450 events read in total (858189ms).
[13:07:45.261] <TB1> INFO: 24037450 events read in total (890781ms).
[13:08:18.116] <TB1> INFO: 24921250 events read in total (923636ms).
[13:08:50.775] <TB1> INFO: 25809700 events read in total (956295ms).
[13:09:05.573] <TB1> INFO: 26208000 events read in total (971093ms).
[13:09:05.600] <TB1> INFO: Test took 972023ms.
[13:09:05.856] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:07.340] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:08.883] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:10.310] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:11.966] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:13.457] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:15.046] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:16.705] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:18.218] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:19.604] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:21.159] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:22.634] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:24.117] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:25.585] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:27.037] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:28.717] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:09:30.344] <TB1> INFO: PixTestScurves::scurves() done
[13:09:30.344] <TB1> INFO: Vcal mean: 95.19 95.18 96.63 102.71 97.38 95.81 97.69 84.59 90.79 74.92 90.77 103.54 89.85 84.92 100.55 93.69
[13:09:30.344] <TB1> INFO: Vcal RMS: 5.77 5.97 5.62 6.24 6.25 5.94 6.42 4.86 5.46 4.75 6.11 6.10 5.58 4.70 6.11 5.32
[13:09:30.344] <TB1> INFO: PixTestScurves::fullTest() done, duration: 996 seconds
[13:09:30.344] <TB1> INFO: Decoding statistics:
[13:09:30.344] <TB1> INFO: General information:
[13:09:30.344] <TB1> INFO: 16bit words read: 0
[13:09:30.344] <TB1> INFO: valid events total: 0
[13:09:30.344] <TB1> INFO: empty events: 0
[13:09:30.344] <TB1> INFO: valid events with pixels: 0
[13:09:30.344] <TB1> INFO: valid pixel hits: 0
[13:09:30.344] <TB1> INFO: Event errors: 0
[13:09:30.344] <TB1> INFO: start marker: 0
[13:09:30.344] <TB1> INFO: stop marker: 0
[13:09:30.344] <TB1> INFO: overflow: 0
[13:09:30.344] <TB1> INFO: invalid 5bit words: 0
[13:09:30.344] <TB1> INFO: invalid XOR eye diagram: 0
[13:09:30.344] <TB1> INFO: frame (failed synchr.): 0
[13:09:30.344] <TB1> INFO: idle data (no TBM trl): 0
[13:09:30.344] <TB1> INFO: no data (only TBM hdr): 0
[13:09:30.344] <TB1> INFO: TBM errors: 0
[13:09:30.344] <TB1> INFO: flawed TBM headers: 0
[13:09:30.344] <TB1> INFO: flawed TBM trailers: 0
[13:09:30.344] <TB1> INFO: event ID mismatches: 0
[13:09:30.344] <TB1> INFO: ROC errors: 0
[13:09:30.344] <TB1> INFO: missing ROC header(s): 0
[13:09:30.344] <TB1> INFO: misplaced readback start: 0
[13:09:30.344] <TB1> INFO: Pixel decoding errors: 0
[13:09:30.344] <TB1> INFO: pixel data incomplete: 0
[13:09:30.344] <TB1> INFO: pixel address: 0
[13:09:30.345] <TB1> INFO: pulse height fill bit: 0
[13:09:30.345] <TB1> INFO: buffer corruption: 0
[13:09:30.420] <TB1> INFO: ######################################################################
[13:09:30.420] <TB1> INFO: PixTestTrim::doTest()
[13:09:30.420] <TB1> INFO: ######################################################################
[13:09:30.421] <TB1> INFO: ----------------------------------------------------------------------
[13:09:30.421] <TB1> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[13:09:30.421] <TB1> INFO: ----------------------------------------------------------------------
[13:09:30.511] <TB1> INFO: ---> VthrComp thr map (minimal VthrComp)
[13:09:30.511] <TB1> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:09:30.519] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:09:30.519] <TB1> INFO: run 1 of 1
[13:09:30.798] <TB1> INFO: Expecting 6281600 events.
[13:10:11.311] <TB1> INFO: 1090870 events read in total (39956ms).
[13:10:50.740] <TB1> INFO: 2177350 events read in total (79385ms).
[13:11:30.465] <TB1> INFO: 3257350 events read in total (119110ms).
[13:12:09.906] <TB1> INFO: 4343700 events read in total (158551ms).
[13:12:48.993] <TB1> INFO: 5432040 events read in total (197638ms).
[13:13:20.134] <TB1> INFO: 6281600 events read in total (228779ms).
[13:13:20.172] <TB1> INFO: Test took 229653ms.
[13:13:39.312] <TB1> INFO: ROC 0 VthrComp = 98
[13:13:39.312] <TB1> INFO: ROC 1 VthrComp = 92
[13:13:39.312] <TB1> INFO: ROC 2 VthrComp = 98
[13:13:39.312] <TB1> INFO: ROC 3 VthrComp = 100
[13:13:39.313] <TB1> INFO: ROC 4 VthrComp = 98
[13:13:39.313] <TB1> INFO: ROC 5 VthrComp = 91
[13:13:39.313] <TB1> INFO: ROC 6 VthrComp = 92
[13:13:39.313] <TB1> INFO: ROC 7 VthrComp = 85
[13:13:39.313] <TB1> INFO: ROC 8 VthrComp = 96
[13:13:39.313] <TB1> INFO: ROC 9 VthrComp = 79
[13:13:39.313] <TB1> INFO: ROC 10 VthrComp = 92
[13:13:39.313] <TB1> INFO: ROC 11 VthrComp = 102
[13:13:39.313] <TB1> INFO: ROC 12 VthrComp = 92
[13:13:39.314] <TB1> INFO: ROC 13 VthrComp = 89
[13:13:39.314] <TB1> INFO: ROC 14 VthrComp = 98
[13:13:39.314] <TB1> INFO: ROC 15 VthrComp = 94
[13:13:39.314] <TB1> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:13:39.314] <TB1> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:13:39.323] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:13:39.323] <TB1> INFO: run 1 of 1
[13:13:39.587] <TB1> INFO: Expecting 6281600 events.
[13:14:14.971] <TB1> INFO: 757630 events read in total (34825ms).
[13:14:49.805] <TB1> INFO: 1512910 events read in total (69659ms).
[13:15:24.442] <TB1> INFO: 2268440 events read in total (104296ms).
[13:15:59.065] <TB1> INFO: 3024410 events read in total (138919ms).
[13:16:33.454] <TB1> INFO: 3775400 events read in total (173308ms).
[13:17:08.036] <TB1> INFO: 4522730 events read in total (207890ms).
[13:17:42.736] <TB1> INFO: 5268640 events read in total (242590ms).
[13:18:17.714] <TB1> INFO: 6015120 events read in total (277568ms).
[13:18:30.333] <TB1> INFO: 6281600 events read in total (290187ms).
[13:18:30.377] <TB1> INFO: Test took 291055ms.
[13:18:55.741] <TB1> INFO: roc 0 with ID = 0 has maximal Vcal 62.3004 for pixel 42/0 mean/min/max = 46.8628/31.3879/62.3377
[13:18:55.741] <TB1> INFO: roc 1 with ID = 1 has maximal Vcal 61.3897 for pixel 17/20 mean/min/max = 46.9784/32.5145/61.4423
[13:18:55.742] <TB1> INFO: roc 2 with ID = 2 has maximal Vcal 57.9154 for pixel 11/2 mean/min/max = 44.7135/31.4986/57.9285
[13:18:55.742] <TB1> INFO: roc 3 with ID = 3 has maximal Vcal 61.4185 for pixel 0/78 mean/min/max = 46.5606/31.699/61.4223
[13:18:55.742] <TB1> INFO: roc 4 with ID = 4 has maximal Vcal 61.5916 for pixel 0/13 mean/min/max = 46.5708/31.4539/61.6877
[13:18:55.742] <TB1> INFO: roc 5 with ID = 5 has maximal Vcal 60.9624 for pixel 33/11 mean/min/max = 46.4605/31.7792/61.1417
[13:18:55.743] <TB1> INFO: roc 6 with ID = 6 has maximal Vcal 65.8536 for pixel 1/79 mean/min/max = 49.227/32.5765/65.8775
[13:18:55.743] <TB1> INFO: roc 7 with ID = 7 has maximal Vcal 58.7131 for pixel 5/3 mean/min/max = 45.5491/32.3207/58.7774
[13:18:55.743] <TB1> INFO: roc 8 with ID = 8 has maximal Vcal 57.7685 for pixel 51/71 mean/min/max = 44.7831/31.4639/58.1023
[13:18:55.743] <TB1> INFO: roc 9 with ID = 9 has maximal Vcal 59.7645 for pixel 0/31 mean/min/max = 47.0654/34.2563/59.8744
[13:18:55.743] <TB1> INFO: roc 10 with ID = 10 has maximal Vcal 58.631 for pixel 14/76 mean/min/max = 45.8562/32.9306/58.7819
[13:18:55.744] <TB1> INFO: roc 11 with ID = 11 has maximal Vcal 62.1913 for pixel 2/8 mean/min/max = 46.8933/31.5897/62.197
[13:18:55.744] <TB1> INFO: roc 12 with ID = 12 has maximal Vcal 59.2171 for pixel 0/54 mean/min/max = 45.7786/32.1857/59.3715
[13:18:55.744] <TB1> INFO: roc 13 with ID = 13 has maximal Vcal 57.3918 for pixel 0/13 mean/min/max = 45.206/32.9433/57.4687
[13:18:55.744] <TB1> INFO: roc 14 with ID = 14 has maximal Vcal 62.9196 for pixel 5/2 mean/min/max = 47.311/31.6705/62.9516
[13:18:55.745] <TB1> INFO: roc 15 with ID = 15 has maximal Vcal 58.2715 for pixel 50/7 mean/min/max = 45.0851/31.8244/58.3458
[13:18:55.745] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:55.833] <TB1> INFO: Expecting 514560 events.
[13:19:08.775] <TB1> INFO: 514560 events read in total (12383ms).
[13:19:08.782] <TB1> INFO: Expecting 514560 events.
[13:19:21.402] <TB1> INFO: 514560 events read in total (12215ms).
[13:19:21.408] <TB1> INFO: Expecting 514560 events.
[13:19:34.261] <TB1> INFO: 514560 events read in total (12426ms).
[13:19:34.272] <TB1> INFO: Expecting 514560 events.
[13:19:47.127] <TB1> INFO: 514560 events read in total (12449ms).
[13:19:47.140] <TB1> INFO: Expecting 514560 events.
[13:19:59.987] <TB1> INFO: 514560 events read in total (12441ms).
[13:19:59.999] <TB1> INFO: Expecting 514560 events.
[13:20:12.839] <TB1> INFO: 514560 events read in total (12432ms).
[13:20:12.855] <TB1> INFO: Expecting 514560 events.
[13:20:25.639] <TB1> INFO: 514560 events read in total (12373ms).
[13:20:25.655] <TB1> INFO: Expecting 514560 events.
[13:20:38.510] <TB1> INFO: 514560 events read in total (12450ms).
[13:20:38.533] <TB1> INFO: Expecting 514560 events.
[13:20:51.363] <TB1> INFO: 514560 events read in total (12425ms).
[13:20:51.383] <TB1> INFO: Expecting 514560 events.
[13:21:04.192] <TB1> INFO: 514560 events read in total (12399ms).
[13:21:04.218] <TB1> INFO: Expecting 514560 events.
[13:21:16.976] <TB1> INFO: 514560 events read in total (12357ms).
[13:21:17.003] <TB1> INFO: Expecting 514560 events.
[13:21:29.826] <TB1> INFO: 514560 events read in total (12421ms).
[13:21:29.853] <TB1> INFO: Expecting 514560 events.
[13:21:42.622] <TB1> INFO: 514560 events read in total (12367ms).
[13:21:42.649] <TB1> INFO: Expecting 514560 events.
[13:21:55.391] <TB1> INFO: 514560 events read in total (12338ms).
[13:21:55.429] <TB1> INFO: Expecting 514560 events.
[13:22:08.261] <TB1> INFO: 514560 events read in total (12431ms).
[13:22:08.296] <TB1> INFO: Expecting 514560 events.
[13:22:21.145] <TB1> INFO: 514560 events read in total (12447ms).
[13:22:21.186] <TB1> INFO: Test took 205441ms.
[13:22:22.115] <TB1> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:22:22.123] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:22:22.123] <TB1> INFO: run 1 of 1
[13:22:22.395] <TB1> INFO: Expecting 6281600 events.
[13:22:57.833] <TB1> INFO: 741250 events read in total (34882ms).
[13:23:32.356] <TB1> INFO: 1480780 events read in total (69405ms).
[13:24:07.047] <TB1> INFO: 2220180 events read in total (104096ms).
[13:24:42.046] <TB1> INFO: 2960860 events read in total (139095ms).
[13:25:16.758] <TB1> INFO: 3695920 events read in total (173807ms).
[13:25:51.001] <TB1> INFO: 4426490 events read in total (208050ms).
[13:26:25.377] <TB1> INFO: 5154880 events read in total (242426ms).
[13:26:59.858] <TB1> INFO: 5882740 events read in total (276907ms).
[13:27:19.060] <TB1> INFO: 6281600 events read in total (296109ms).
[13:27:19.102] <TB1> INFO: Test took 296979ms.
[13:27:44.048] <TB1> INFO: ---> TrimStepCorr4 extremal thresholds: 0.011721 .. 255.000000
[13:27:44.123] <TB1> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[13:27:44.130] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:27:44.130] <TB1> INFO: run 1 of 1
[13:27:44.389] <TB1> INFO: Expecting 10649600 events.
[13:28:19.222] <TB1> INFO: 712140 events read in total (34272ms).
[13:28:53.320] <TB1> INFO: 1424400 events read in total (68370ms).
[13:29:27.679] <TB1> INFO: 2136610 events read in total (102729ms).
[13:30:02.090] <TB1> INFO: 2848930 events read in total (137140ms).
[13:30:36.388] <TB1> INFO: 3561370 events read in total (171438ms).
[13:31:10.677] <TB1> INFO: 4273800 events read in total (205727ms).
[13:31:45.017] <TB1> INFO: 4986170 events read in total (240067ms).
[13:32:19.547] <TB1> INFO: 5698780 events read in total (274597ms).
[13:32:53.965] <TB1> INFO: 6410990 events read in total (309015ms).
[13:33:28.292] <TB1> INFO: 7122400 events read in total (343342ms).
[13:34:02.448] <TB1> INFO: 7833690 events read in total (377498ms).
[13:34:37.267] <TB1> INFO: 8544550 events read in total (412317ms).
[13:35:12.065] <TB1> INFO: 9255330 events read in total (447115ms).
[13:35:46.388] <TB1> INFO: 9965950 events read in total (481438ms).
[13:36:18.958] <TB1> INFO: 10649600 events read in total (514008ms).
[13:36:19.046] <TB1> INFO: Test took 514916ms.
[13:36:48.706] <TB1> INFO: ---> TrimStepCorr2 extremal thresholds: 1.936418 .. 57.841077
[13:36:48.783] <TB1> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 1 .. 67 (-1/-1) hits flags = 528 (plus default)
[13:36:48.791] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:36:48.791] <TB1> INFO: run 1 of 1
[13:36:49.056] <TB1> INFO: Expecting 2787200 events.
[13:37:26.877] <TB1> INFO: 887070 events read in total (37265ms).
[13:38:03.799] <TB1> INFO: 1773960 events read in total (74187ms).
[13:38:40.669] <TB1> INFO: 2658930 events read in total (111057ms).
[13:38:46.287] <TB1> INFO: 2787200 events read in total (116675ms).
[13:38:46.304] <TB1> INFO: Test took 117513ms.
[13:39:03.309] <TB1> INFO: ---> TrimStepCorr1a extremal thresholds: 0.351079 .. 57.841077
[13:39:03.411] <TB1> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 0 .. 67 (-1/-1) hits flags = 528 (plus default)
[13:39:03.419] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:39:03.419] <TB1> INFO: run 1 of 1
[13:39:03.705] <TB1> INFO: Expecting 2828800 events.
[13:39:41.319] <TB1> INFO: 893650 events read in total (37058ms).
[13:40:17.944] <TB1> INFO: 1786980 events read in total (73683ms).
[13:40:54.955] <TB1> INFO: 2679580 events read in total (110694ms).
[13:41:01.495] <TB1> INFO: 2828800 events read in total (117234ms).
[13:41:01.513] <TB1> INFO: Test took 118094ms.
[13:41:16.429] <TB1> INFO: ---> TrimStepCorr1b extremal thresholds: 0.351079 .. 57.841077
[13:41:16.504] <TB1> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 0 .. 67 (-1/-1) hits flags = 528 (plus default)
[13:41:16.512] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:41:16.512] <TB1> INFO: run 1 of 1
[13:41:16.773] <TB1> INFO: Expecting 2828800 events.
[13:41:54.288] <TB1> INFO: 893700 events read in total (36959ms).
[13:42:31.491] <TB1> INFO: 1787300 events read in total (74162ms).
[13:43:08.086] <TB1> INFO: 2680860 events read in total (110757ms).
[13:43:14.495] <TB1> INFO: 2828800 events read in total (117166ms).
[13:43:14.513] <TB1> INFO: Test took 118001ms.
[13:43:31.303] <TB1> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[13:43:31.303] <TB1> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:43:31.312] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:43:31.312] <TB1> INFO: run 1 of 1
[13:43:31.593] <TB1> INFO: Expecting 1705600 events.
[13:44:09.364] <TB1> INFO: 878610 events read in total (37215ms).
[13:44:44.059] <TB1> INFO: 1705600 events read in total (71910ms).
[13:44:44.083] <TB1> INFO: Test took 72772ms.
[13:44:57.587] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:44:57.587] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:44:57.587] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:44:57.587] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:44:57.588] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:44:57.588] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:44:57.588] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:44:57.588] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:44:57.589] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:44:57.589] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:44:57.589] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:44:57.589] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:44:57.590] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:44:57.590] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:44:57.590] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:44:57.590] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:44:57.591] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C0.dat
[13:44:57.602] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C1.dat
[13:44:57.609] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C2.dat
[13:44:57.615] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C3.dat
[13:44:57.621] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C4.dat
[13:44:57.628] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C5.dat
[13:44:57.634] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C6.dat
[13:44:57.641] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C7.dat
[13:44:57.647] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C8.dat
[13:44:57.654] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C9.dat
[13:44:57.661] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C10.dat
[13:44:57.667] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C11.dat
[13:44:57.674] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C12.dat
[13:44:57.680] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C13.dat
[13:44:57.687] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C14.dat
[13:44:57.694] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//trimParameters35_C15.dat
[13:44:57.700] <TB1> INFO: PixTestTrim::trimTest() done
[13:44:57.700] <TB1> INFO: vtrim: 123 91 86 92 102 104 101 90 93 96 92 104 91 87 115 95
[13:44:57.700] <TB1> INFO: vthrcomp: 98 92 98 100 98 91 92 85 96 79 92 102 92 89 98 94
[13:44:57.700] <TB1> INFO: vcal mean: 35.00 34.97 34.97 35.02 34.99 34.96 34.98 35.01 35.01 35.02 34.99 34.97 35.01 34.96 34.99 34.93
[13:44:57.700] <TB1> INFO: vcal RMS: 0.93 1.08 0.86 0.86 0.87 1.11 0.97 0.96 0.89 0.83 1.26 0.89 0.84 0.86 1.06 0.92
[13:44:57.700] <TB1> INFO: bits mean: 9.47 9.33 9.97 8.90 9.08 9.63 8.84 9.54 9.27 8.66 9.16 9.05 9.07 9.49 9.67 9.94
[13:44:57.700] <TB1> INFO: bits RMS: 2.77 2.61 2.61 2.91 2.84 2.61 2.62 2.66 2.90 2.62 2.73 2.88 2.88 2.63 2.52 2.56
[13:44:57.706] <TB1> INFO: ----------------------------------------------------------------------
[13:44:57.706] <TB1> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[13:44:57.706] <TB1> INFO: ----------------------------------------------------------------------
[13:44:57.709] <TB1> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[13:44:57.717] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:44:57.717] <TB1> INFO: run 1 of 1
[13:44:57.994] <TB1> INFO: Expecting 4160000 events.
[13:45:40.710] <TB1> INFO: 942830 events read in total (42160ms).
[13:46:22.100] <TB1> INFO: 1879250 events read in total (83550ms).
[13:47:03.119] <TB1> INFO: 2807110 events read in total (124570ms).
[13:47:44.221] <TB1> INFO: 3732845 events read in total (165671ms).
[13:48:03.551] <TB1> INFO: 4160000 events read in total (185001ms).
[13:48:03.589] <TB1> INFO: Test took 185872ms.
[13:48:32.996] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 190 (-1/-1) hits flags = 528 (plus default)
[13:48:33.004] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:48:33.005] <TB1> INFO: run 1 of 1
[13:48:33.266] <TB1> INFO: Expecting 3972800 events.
[13:49:15.324] <TB1> INFO: 927580 events read in total (41501ms).
[13:49:56.742] <TB1> INFO: 1848970 events read in total (82919ms).
[13:50:37.668] <TB1> INFO: 2761630 events read in total (123845ms).
[13:51:18.759] <TB1> INFO: 3673040 events read in total (164936ms).
[13:51:32.479] <TB1> INFO: 3972800 events read in total (178656ms).
[13:51:32.524] <TB1> INFO: Test took 179519ms.
[13:52:03.840] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 177 (-1/-1) hits flags = 528 (plus default)
[13:52:03.849] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:52:03.849] <TB1> INFO: run 1 of 1
[13:52:04.113] <TB1> INFO: Expecting 3702400 events.
[13:52:47.064] <TB1> INFO: 954475 events read in total (42395ms).
[13:53:29.659] <TB1> INFO: 1901035 events read in total (84990ms).
[13:54:11.155] <TB1> INFO: 2837685 events read in total (126486ms).
[13:54:49.817] <TB1> INFO: 3702400 events read in total (165148ms).
[13:54:49.862] <TB1> INFO: Test took 166013ms.
[13:55:16.509] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 176 (-1/-1) hits flags = 528 (plus default)
[13:55:16.517] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:55:16.517] <TB1> INFO: run 1 of 1
[13:55:16.804] <TB1> INFO: Expecting 3681600 events.
[13:55:59.274] <TB1> INFO: 956200 events read in total (41914ms).
[13:56:40.936] <TB1> INFO: 1904510 events read in total (83576ms).
[13:57:22.649] <TB1> INFO: 2842735 events read in total (125290ms).
[13:57:59.626] <TB1> INFO: 3681600 events read in total (162266ms).
[13:57:59.665] <TB1> INFO: Test took 163148ms.
[13:58:26.497] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 176 (-1/-1) hits flags = 528 (plus default)
[13:58:26.506] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:58:26.506] <TB1> INFO: run 1 of 1
[13:58:26.770] <TB1> INFO: Expecting 3681600 events.
[13:59:10.055] <TB1> INFO: 955650 events read in total (42729ms).
[13:59:51.626] <TB1> INFO: 1903500 events read in total (84300ms).
[14:00:33.447] <TB1> INFO: 2841185 events read in total (126122ms).
[14:01:10.671] <TB1> INFO: 3681600 events read in total (163345ms).
[14:01:10.711] <TB1> INFO: Test took 164205ms.
[14:01:37.202] <TB1> INFO: PixTestTrim::trimBitTest() done
[14:01:37.203] <TB1> INFO: PixTestTrim::doTest() done, duration: 3126 seconds
[14:01:37.203] <TB1> INFO: Decoding statistics:
[14:01:37.203] <TB1> INFO: General information:
[14:01:37.203] <TB1> INFO: 16bit words read: 0
[14:01:37.203] <TB1> INFO: valid events total: 0
[14:01:37.203] <TB1> INFO: empty events: 0
[14:01:37.203] <TB1> INFO: valid events with pixels: 0
[14:01:37.203] <TB1> INFO: valid pixel hits: 0
[14:01:37.203] <TB1> INFO: Event errors: 0
[14:01:37.203] <TB1> INFO: start marker: 0
[14:01:37.203] <TB1> INFO: stop marker: 0
[14:01:37.203] <TB1> INFO: overflow: 0
[14:01:37.203] <TB1> INFO: invalid 5bit words: 0
[14:01:37.203] <TB1> INFO: invalid XOR eye diagram: 0
[14:01:37.203] <TB1> INFO: frame (failed synchr.): 0
[14:01:37.203] <TB1> INFO: idle data (no TBM trl): 0
[14:01:37.203] <TB1> INFO: no data (only TBM hdr): 0
[14:01:37.203] <TB1> INFO: TBM errors: 0
[14:01:37.203] <TB1> INFO: flawed TBM headers: 0
[14:01:37.203] <TB1> INFO: flawed TBM trailers: 0
[14:01:37.203] <TB1> INFO: event ID mismatches: 0
[14:01:37.203] <TB1> INFO: ROC errors: 0
[14:01:37.203] <TB1> INFO: missing ROC header(s): 0
[14:01:37.203] <TB1> INFO: misplaced readback start: 0
[14:01:37.203] <TB1> INFO: Pixel decoding errors: 0
[14:01:37.203] <TB1> INFO: pixel data incomplete: 0
[14:01:37.203] <TB1> INFO: pixel address: 0
[14:01:37.203] <TB1> INFO: pulse height fill bit: 0
[14:01:37.203] <TB1> INFO: buffer corruption: 0
[14:01:37.925] <TB1> INFO: ######################################################################
[14:01:37.925] <TB1> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[14:01:37.925] <TB1> INFO: ######################################################################
[14:01:38.198] <TB1> INFO: Expecting 41600 events.
[14:01:41.907] <TB1> INFO: 41600 events read in total (3153ms).
[14:01:41.908] <TB1> INFO: Test took 3982ms.
[14:01:42.373] <TB1> INFO: Expecting 41600 events.
[14:01:46.151] <TB1> INFO: 41600 events read in total (3222ms).
[14:01:46.152] <TB1> INFO: Test took 4039ms.
[14:01:46.436] <TB1> INFO: Expecting 41600 events.
[14:01:50.214] <TB1> INFO: 41600 events read in total (3221ms).
[14:01:50.214] <TB1> INFO: Test took 4041ms.
[14:01:50.475] <TB1> INFO: Expecting 2560 events.
[14:01:51.331] <TB1> INFO: 2560 events read in total (300ms).
[14:01:51.331] <TB1> INFO: Test took 1098ms.
[14:01:51.636] <TB1> INFO: Expecting 2560 events.
[14:01:52.488] <TB1> INFO: 2560 events read in total (296ms).
[14:01:52.488] <TB1> INFO: Test took 1157ms.
[14:01:52.794] <TB1> INFO: Expecting 2560 events.
[14:01:53.647] <TB1> INFO: 2560 events read in total (297ms).
[14:01:53.647] <TB1> INFO: Test took 1158ms.
[14:01:53.952] <TB1> INFO: Expecting 2560 events.
[14:01:54.804] <TB1> INFO: 2560 events read in total (296ms).
[14:01:54.805] <TB1> INFO: Test took 1158ms.
[14:01:55.110] <TB1> INFO: Expecting 2560 events.
[14:01:55.964] <TB1> INFO: 2560 events read in total (298ms).
[14:01:55.964] <TB1> INFO: Test took 1159ms.
[14:01:56.269] <TB1> INFO: Expecting 2560 events.
[14:01:57.122] <TB1> INFO: 2560 events read in total (296ms).
[14:01:57.122] <TB1> INFO: Test took 1157ms.
[14:01:57.427] <TB1> INFO: Expecting 2560 events.
[14:01:58.285] <TB1> INFO: 2560 events read in total (301ms).
[14:01:58.285] <TB1> INFO: Test took 1163ms.
[14:01:58.590] <TB1> INFO: Expecting 2560 events.
[14:01:59.444] <TB1> INFO: 2560 events read in total (298ms).
[14:01:59.444] <TB1> INFO: Test took 1158ms.
[14:01:59.749] <TB1> INFO: Expecting 2560 events.
[14:02:00.606] <TB1> INFO: 2560 events read in total (301ms).
[14:02:00.606] <TB1> INFO: Test took 1161ms.
[14:02:00.912] <TB1> INFO: Expecting 2560 events.
[14:02:01.771] <TB1> INFO: 2560 events read in total (303ms).
[14:02:01.771] <TB1> INFO: Test took 1164ms.
[14:02:02.077] <TB1> INFO: Expecting 2560 events.
[14:02:02.930] <TB1> INFO: 2560 events read in total (297ms).
[14:02:02.930] <TB1> INFO: Test took 1158ms.
[14:02:03.236] <TB1> INFO: Expecting 2560 events.
[14:02:04.094] <TB1> INFO: 2560 events read in total (302ms).
[14:02:04.094] <TB1> INFO: Test took 1163ms.
[14:02:04.399] <TB1> INFO: Expecting 2560 events.
[14:02:05.257] <TB1> INFO: 2560 events read in total (302ms).
[14:02:05.257] <TB1> INFO: Test took 1162ms.
[14:02:05.563] <TB1> INFO: Expecting 2560 events.
[14:02:06.419] <TB1> INFO: 2560 events read in total (299ms).
[14:02:06.419] <TB1> INFO: Test took 1161ms.
[14:02:06.725] <TB1> INFO: Expecting 2560 events.
[14:02:07.583] <TB1> INFO: 2560 events read in total (303ms).
[14:02:07.584] <TB1> INFO: Test took 1165ms.
[14:02:07.889] <TB1> INFO: Expecting 2560 events.
[14:02:08.747] <TB1> INFO: 2560 events read in total (302ms).
[14:02:08.747] <TB1> INFO: Test took 1163ms.
[14:02:08.751] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:02:09.054] <TB1> INFO: Expecting 655360 events.
[14:02:25.917] <TB1> INFO: 655360 events read in total (16307ms).
[14:02:25.925] <TB1> INFO: Expecting 655360 events.
[14:02:42.522] <TB1> INFO: 655360 events read in total (16196ms).
[14:02:42.534] <TB1> INFO: Expecting 655360 events.
[14:02:59.054] <TB1> INFO: 655360 events read in total (16118ms).
[14:02:59.070] <TB1> INFO: Expecting 655360 events.
[14:03:15.890] <TB1> INFO: 655360 events read in total (16419ms).
[14:03:15.912] <TB1> INFO: Expecting 655360 events.
[14:03:32.807] <TB1> INFO: 655360 events read in total (16493ms).
[14:03:32.831] <TB1> INFO: Expecting 655360 events.
[14:03:49.537] <TB1> INFO: 655360 events read in total (16305ms).
[14:03:49.562] <TB1> INFO: Expecting 655360 events.
[14:04:06.392] <TB1> INFO: 655360 events read in total (16428ms).
[14:04:06.424] <TB1> INFO: Expecting 655360 events.
[14:04:23.202] <TB1> INFO: 655360 events read in total (16376ms).
[14:04:23.235] <TB1> INFO: Expecting 655360 events.
[14:04:39.879] <TB1> INFO: 655360 events read in total (16243ms).
[14:04:39.921] <TB1> INFO: Expecting 655360 events.
[14:04:56.622] <TB1> INFO: 655360 events read in total (16300ms).
[14:04:56.660] <TB1> INFO: Expecting 655360 events.
[14:05:13.267] <TB1> INFO: 655360 events read in total (16205ms).
[14:05:13.310] <TB1> INFO: Expecting 655360 events.
[14:05:29.853] <TB1> INFO: 655360 events read in total (16141ms).
[14:05:29.900] <TB1> INFO: Expecting 655360 events.
[14:05:46.434] <TB1> INFO: 655360 events read in total (16132ms).
[14:05:46.482] <TB1> INFO: Expecting 655360 events.
[14:06:03.246] <TB1> INFO: 655360 events read in total (16362ms).
[14:06:03.305] <TB1> INFO: Expecting 655360 events.
[14:06:20.032] <TB1> INFO: 655360 events read in total (16325ms).
[14:06:20.090] <TB1> INFO: Expecting 655360 events.
[14:06:36.922] <TB1> INFO: 655360 events read in total (16430ms).
[14:06:36.982] <TB1> INFO: Test took 268231ms.
[14:06:37.067] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:06:37.298] <TB1> INFO: Expecting 655360 events.
[14:06:54.065] <TB1> INFO: 655360 events read in total (16211ms).
[14:06:54.074] <TB1> INFO: Expecting 655360 events.
[14:07:10.735] <TB1> INFO: 655360 events read in total (16259ms).
[14:07:10.746] <TB1> INFO: Expecting 655360 events.
[14:07:27.522] <TB1> INFO: 655360 events read in total (16374ms).
[14:07:27.538] <TB1> INFO: Expecting 655360 events.
[14:07:44.324] <TB1> INFO: 655360 events read in total (16384ms).
[14:07:44.342] <TB1> INFO: Expecting 655360 events.
[14:08:01.174] <TB1> INFO: 655360 events read in total (16430ms).
[14:08:01.197] <TB1> INFO: Expecting 655360 events.
[14:08:17.884] <TB1> INFO: 655360 events read in total (16286ms).
[14:08:17.910] <TB1> INFO: Expecting 655360 events.
[14:08:34.660] <TB1> INFO: 655360 events read in total (16348ms).
[14:08:34.689] <TB1> INFO: Expecting 655360 events.
[14:08:51.465] <TB1> INFO: 655360 events read in total (16374ms).
[14:08:51.501] <TB1> INFO: Expecting 655360 events.
[14:09:08.238] <TB1> INFO: 655360 events read in total (16335ms).
[14:09:08.282] <TB1> INFO: Expecting 655360 events.
[14:09:25.130] <TB1> INFO: 655360 events read in total (16446ms).
[14:09:25.169] <TB1> INFO: Expecting 655360 events.
[14:09:41.903] <TB1> INFO: 655360 events read in total (16332ms).
[14:09:41.952] <TB1> INFO: Expecting 655360 events.
[14:09:58.752] <TB1> INFO: 655360 events read in total (16398ms).
[14:09:58.799] <TB1> INFO: Expecting 655360 events.
[14:10:15.627] <TB1> INFO: 655360 events read in total (16426ms).
[14:10:15.676] <TB1> INFO: Expecting 655360 events.
[14:10:32.385] <TB1> INFO: 655360 events read in total (16307ms).
[14:10:32.441] <TB1> INFO: Expecting 655360 events.
[14:10:49.214] <TB1> INFO: 655360 events read in total (16372ms).
[14:10:49.277] <TB1> INFO: Expecting 655360 events.
[14:11:06.084] <TB1> INFO: 655360 events read in total (16405ms).
[14:11:06.146] <TB1> INFO: Test took 269079ms.
[14:11:06.338] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.345] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.352] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.359] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.367] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.374] <TB1> INFO: safety margin for low PH: adding 1, margin is now 21
[14:11:06.381] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.388] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.394] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.401] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.407] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.414] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.420] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.427] <TB1> INFO: safety margin for low PH: adding 1, margin is now 21
[14:11:06.433] <TB1> INFO: safety margin for low PH: adding 2, margin is now 22
[14:11:06.440] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.446] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.453] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.459] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C0.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C1.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C2.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C3.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C4.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C5.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C6.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C7.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C8.dat
[14:11:06.495] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C9.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C10.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C11.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C12.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C13.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C14.dat
[14:11:06.496] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//dacParameters35_C15.dat
[14:11:06.762] <TB1> INFO: Expecting 41600 events.
[14:11:10.235] <TB1> INFO: 41600 events read in total (2917ms).
[14:11:10.236] <TB1> INFO: Test took 3737ms.
[14:11:10.681] <TB1> INFO: Expecting 41600 events.
[14:11:14.191] <TB1> INFO: 41600 events read in total (2953ms).
[14:11:14.191] <TB1> INFO: Test took 3778ms.
[14:11:14.636] <TB1> INFO: Expecting 41600 events.
[14:11:18.112] <TB1> INFO: 41600 events read in total (2920ms).
[14:11:18.112] <TB1> INFO: Test took 3745ms.
[14:11:18.298] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:18.386] <TB1> INFO: Expecting 2560 events.
[14:11:19.244] <TB1> INFO: 2560 events read in total (302ms).
[14:11:19.244] <TB1> INFO: Test took 946ms.
[14:11:19.246] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:19.549] <TB1> INFO: Expecting 2560 events.
[14:11:20.408] <TB1> INFO: 2560 events read in total (302ms).
[14:11:20.408] <TB1> INFO: Test took 1162ms.
[14:11:20.411] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:20.713] <TB1> INFO: Expecting 2560 events.
[14:11:21.567] <TB1> INFO: 2560 events read in total (298ms).
[14:11:21.568] <TB1> INFO: Test took 1157ms.
[14:11:21.569] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:21.873] <TB1> INFO: Expecting 2560 events.
[14:11:22.729] <TB1> INFO: 2560 events read in total (300ms).
[14:11:22.729] <TB1> INFO: Test took 1160ms.
[14:11:22.730] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:23.035] <TB1> INFO: Expecting 2560 events.
[14:11:23.890] <TB1> INFO: 2560 events read in total (299ms).
[14:11:23.890] <TB1> INFO: Test took 1160ms.
[14:11:23.893] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:24.195] <TB1> INFO: Expecting 2560 events.
[14:11:25.054] <TB1> INFO: 2560 events read in total (303ms).
[14:11:25.054] <TB1> INFO: Test took 1161ms.
[14:11:25.056] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:25.359] <TB1> INFO: Expecting 2560 events.
[14:11:26.217] <TB1> INFO: 2560 events read in total (301ms).
[14:11:26.218] <TB1> INFO: Test took 1162ms.
[14:11:26.220] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:26.524] <TB1> INFO: Expecting 2560 events.
[14:11:27.378] <TB1> INFO: 2560 events read in total (298ms).
[14:11:27.378] <TB1> INFO: Test took 1158ms.
[14:11:27.381] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:27.684] <TB1> INFO: Expecting 2560 events.
[14:11:28.542] <TB1> INFO: 2560 events read in total (302ms).
[14:11:28.542] <TB1> INFO: Test took 1161ms.
[14:11:28.544] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:28.849] <TB1> INFO: Expecting 2560 events.
[14:11:29.707] <TB1> INFO: 2560 events read in total (302ms).
[14:11:29.707] <TB1> INFO: Test took 1163ms.
[14:11:29.709] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:30.014] <TB1> INFO: Expecting 2560 events.
[14:11:30.873] <TB1> INFO: 2560 events read in total (303ms).
[14:11:30.874] <TB1> INFO: Test took 1165ms.
[14:11:30.876] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:31.178] <TB1> INFO: Expecting 2560 events.
[14:11:32.032] <TB1> INFO: 2560 events read in total (298ms).
[14:11:32.032] <TB1> INFO: Test took 1156ms.
[14:11:32.034] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:32.338] <TB1> INFO: Expecting 2560 events.
[14:11:33.192] <TB1> INFO: 2560 events read in total (298ms).
[14:11:33.192] <TB1> INFO: Test took 1158ms.
[14:11:33.194] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:33.498] <TB1> INFO: Expecting 2560 events.
[14:11:34.357] <TB1> INFO: 2560 events read in total (303ms).
[14:11:34.357] <TB1> INFO: Test took 1163ms.
[14:11:34.359] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:34.662] <TB1> INFO: Expecting 2560 events.
[14:11:35.516] <TB1> INFO: 2560 events read in total (298ms).
[14:11:35.517] <TB1> INFO: Test took 1158ms.
[14:11:35.519] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:35.822] <TB1> INFO: Expecting 2560 events.
[14:11:36.675] <TB1> INFO: 2560 events read in total (297ms).
[14:11:36.675] <TB1> INFO: Test took 1156ms.
[14:11:36.677] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:36.981] <TB1> INFO: Expecting 2560 events.
[14:11:37.840] <TB1> INFO: 2560 events read in total (303ms).
[14:11:37.840] <TB1> INFO: Test took 1163ms.
[14:11:37.842] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:38.145] <TB1> INFO: Expecting 2560 events.
[14:11:39.000] <TB1> INFO: 2560 events read in total (299ms).
[14:11:39.000] <TB1> INFO: Test took 1159ms.
[14:11:39.002] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:39.305] <TB1> INFO: Expecting 2560 events.
[14:11:40.163] <TB1> INFO: 2560 events read in total (301ms).
[14:11:40.163] <TB1> INFO: Test took 1161ms.
[14:11:40.165] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:40.470] <TB1> INFO: Expecting 2560 events.
[14:11:41.325] <TB1> INFO: 2560 events read in total (299ms).
[14:11:41.325] <TB1> INFO: Test took 1160ms.
[14:11:41.328] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:41.630] <TB1> INFO: Expecting 2560 events.
[14:11:42.484] <TB1> INFO: 2560 events read in total (298ms).
[14:11:42.484] <TB1> INFO: Test took 1156ms.
[14:11:42.487] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:42.790] <TB1> INFO: Expecting 2560 events.
[14:11:43.644] <TB1> INFO: 2560 events read in total (298ms).
[14:11:43.645] <TB1> INFO: Test took 1159ms.
[14:11:43.647] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:43.950] <TB1> INFO: Expecting 2560 events.
[14:11:44.807] <TB1> INFO: 2560 events read in total (300ms).
[14:11:44.807] <TB1> INFO: Test took 1160ms.
[14:11:44.809] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:45.113] <TB1> INFO: Expecting 2560 events.
[14:11:45.972] <TB1> INFO: 2560 events read in total (303ms).
[14:11:45.973] <TB1> INFO: Test took 1164ms.
[14:11:45.975] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:46.279] <TB1> INFO: Expecting 2560 events.
[14:11:47.134] <TB1> INFO: 2560 events read in total (299ms).
[14:11:47.134] <TB1> INFO: Test took 1159ms.
[14:11:47.136] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:47.439] <TB1> INFO: Expecting 2560 events.
[14:11:48.294] <TB1> INFO: 2560 events read in total (299ms).
[14:11:48.295] <TB1> INFO: Test took 1159ms.
[14:11:48.297] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:48.600] <TB1> INFO: Expecting 2560 events.
[14:11:49.455] <TB1> INFO: 2560 events read in total (299ms).
[14:11:49.456] <TB1> INFO: Test took 1159ms.
[14:11:49.458] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:49.761] <TB1> INFO: Expecting 2560 events.
[14:11:50.616] <TB1> INFO: 2560 events read in total (299ms).
[14:11:50.617] <TB1> INFO: Test took 1160ms.
[14:11:50.619] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:50.922] <TB1> INFO: Expecting 2560 events.
[14:11:51.777] <TB1> INFO: 2560 events read in total (299ms).
[14:11:51.778] <TB1> INFO: Test took 1160ms.
[14:11:51.780] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:52.083] <TB1> INFO: Expecting 2560 events.
[14:11:52.938] <TB1> INFO: 2560 events read in total (299ms).
[14:11:52.938] <TB1> INFO: Test took 1159ms.
[14:11:52.941] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:53.244] <TB1> INFO: Expecting 2560 events.
[14:11:54.099] <TB1> INFO: 2560 events read in total (299ms).
[14:11:54.099] <TB1> INFO: Test took 1159ms.
[14:11:54.101] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:54.405] <TB1> INFO: Expecting 2560 events.
[14:11:55.260] <TB1> INFO: 2560 events read in total (299ms).
[14:11:55.260] <TB1> INFO: Test took 1159ms.
[14:11:55.729] <TB1> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[14:11:55.729] <TB1> INFO: PH scale (per ROC): 90 75 79 77 80 76 78 73 82 84 87 80 83 85 65 80
[14:11:55.729] <TB1> INFO: PH offset (per ROC): 169 160 160 172 171 172 179 160 155 166 179 154 160 146 162 159
[14:11:55.732] <TB1> INFO: Decoding statistics:
[14:11:55.733] <TB1> INFO: General information:
[14:11:55.733] <TB1> INFO: 16bit words read: 91924
[14:11:55.733] <TB1> INFO: valid events total: 10240
[14:11:55.733] <TB1> INFO: empty events: 7739
[14:11:55.733] <TB1> INFO: valid events with pixels: 2501
[14:11:55.733] <TB1> INFO: valid pixel hits: 2501
[14:11:55.733] <TB1> INFO: Event errors: 0
[14:11:55.733] <TB1> INFO: start marker: 0
[14:11:55.733] <TB1> INFO: stop marker: 0
[14:11:55.733] <TB1> INFO: overflow: 0
[14:11:55.733] <TB1> INFO: invalid 5bit words: 0
[14:11:55.733] <TB1> INFO: invalid XOR eye diagram: 0
[14:11:55.733] <TB1> INFO: frame (failed synchr.): 0
[14:11:55.733] <TB1> INFO: idle data (no TBM trl): 0
[14:11:55.733] <TB1> INFO: no data (only TBM hdr): 0
[14:11:55.733] <TB1> INFO: TBM errors: 0
[14:11:55.733] <TB1> INFO: flawed TBM headers: 0
[14:11:55.733] <TB1> INFO: flawed TBM trailers: 0
[14:11:55.733] <TB1> INFO: event ID mismatches: 0
[14:11:55.733] <TB1> INFO: ROC errors: 0
[14:11:55.733] <TB1> INFO: missing ROC header(s): 0
[14:11:55.733] <TB1> INFO: misplaced readback start: 0
[14:11:55.733] <TB1> INFO: Pixel decoding errors: 0
[14:11:55.733] <TB1> INFO: pixel data incomplete: 0
[14:11:55.733] <TB1> INFO: pixel address: 0
[14:11:55.733] <TB1> INFO: pulse height fill bit: 0
[14:11:55.733] <TB1> INFO: buffer corruption: 0
[14:11:55.921] <TB1> INFO: ######################################################################
[14:11:55.921] <TB1> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[14:11:55.921] <TB1> INFO: ######################################################################
[14:11:55.931] <TB1> INFO: scanning low vcal = 10
[14:11:56.198] <TB1> INFO: Expecting 41600 events.
[14:11:59.735] <TB1> INFO: 41600 events read in total (2981ms).
[14:11:59.736] <TB1> INFO: Test took 3805ms.
[14:11:59.737] <TB1> INFO: scanning low vcal = 20
[14:12:00.041] <TB1> INFO: Expecting 41600 events.
[14:12:03.590] <TB1> INFO: 41600 events read in total (2993ms).
[14:12:03.590] <TB1> INFO: Test took 3853ms.
[14:12:03.592] <TB1> INFO: scanning low vcal = 30
[14:12:03.896] <TB1> INFO: Expecting 41600 events.
[14:12:07.458] <TB1> INFO: 41600 events read in total (3006ms).
[14:12:07.459] <TB1> INFO: Test took 3867ms.
[14:12:07.461] <TB1> INFO: scanning low vcal = 40
[14:12:07.757] <TB1> INFO: Expecting 41600 events.
[14:12:11.880] <TB1> INFO: 41600 events read in total (3567ms).
[14:12:11.880] <TB1> INFO: Test took 4419ms.
[14:12:11.883] <TB1> INFO: scanning low vcal = 50
[14:12:12.166] <TB1> INFO: Expecting 41600 events.
[14:12:16.337] <TB1> INFO: 41600 events read in total (3615ms).
[14:12:16.338] <TB1> INFO: Test took 4455ms.
[14:12:16.340] <TB1> INFO: scanning low vcal = 60
[14:12:16.616] <TB1> INFO: Expecting 41600 events.
[14:12:20.851] <TB1> INFO: 41600 events read in total (3679ms).
[14:12:20.852] <TB1> INFO: Test took 4512ms.
[14:12:20.854] <TB1> INFO: scanning low vcal = 70
[14:12:21.123] <TB1> INFO: Expecting 41600 events.
[14:12:25.349] <TB1> INFO: 41600 events read in total (3670ms).
[14:12:25.350] <TB1> INFO: Test took 4496ms.
[14:12:25.352] <TB1> INFO: scanning low vcal = 80
[14:12:25.642] <TB1> INFO: Expecting 41600 events.
[14:12:29.855] <TB1> INFO: 41600 events read in total (3656ms).
[14:12:29.855] <TB1> INFO: Test took 4503ms.
[14:12:29.857] <TB1> INFO: scanning low vcal = 90
[14:12:30.120] <TB1> INFO: Expecting 41600 events.
[14:12:34.372] <TB1> INFO: 41600 events read in total (3695ms).
[14:12:34.373] <TB1> INFO: Test took 4515ms.
[14:12:34.375] <TB1> INFO: scanning low vcal = 100
[14:12:34.645] <TB1> INFO: Expecting 41600 events.
[14:12:38.881] <TB1> INFO: 41600 events read in total (3680ms).
[14:12:38.882] <TB1> INFO: Test took 4507ms.
[14:12:38.885] <TB1> INFO: scanning low vcal = 110
[14:12:39.177] <TB1> INFO: Expecting 41600 events.
[14:12:43.423] <TB1> INFO: 41600 events read in total (3689ms).
[14:12:43.424] <TB1> INFO: Test took 4539ms.
[14:12:43.426] <TB1> INFO: scanning low vcal = 120
[14:12:43.700] <TB1> INFO: Expecting 41600 events.
[14:12:47.909] <TB1> INFO: 41600 events read in total (3652ms).
[14:12:47.909] <TB1> INFO: Test took 4483ms.
[14:12:47.912] <TB1> INFO: scanning low vcal = 130
[14:12:48.174] <TB1> INFO: Expecting 41600 events.
[14:12:52.383] <TB1> INFO: 41600 events read in total (3652ms).
[14:12:52.383] <TB1> INFO: Test took 4471ms.
[14:12:52.386] <TB1> INFO: scanning low vcal = 140
[14:12:52.649] <TB1> INFO: Expecting 41600 events.
[14:12:56.884] <TB1> INFO: 41600 events read in total (3679ms).
[14:12:56.884] <TB1> INFO: Test took 4498ms.
[14:12:56.887] <TB1> INFO: scanning low vcal = 150
[14:12:57.158] <TB1> INFO: Expecting 41600 events.
[14:13:01.396] <TB1> INFO: 41600 events read in total (3682ms).
[14:13:01.397] <TB1> INFO: Test took 4510ms.
[14:13:01.399] <TB1> INFO: scanning low vcal = 160
[14:13:01.662] <TB1> INFO: Expecting 41600 events.
[14:13:05.875] <TB1> INFO: 41600 events read in total (3657ms).
[14:13:05.876] <TB1> INFO: Test took 4477ms.
[14:13:05.878] <TB1> INFO: scanning low vcal = 170
[14:13:06.144] <TB1> INFO: Expecting 41600 events.
[14:13:10.407] <TB1> INFO: 41600 events read in total (3706ms).
[14:13:10.407] <TB1> INFO: Test took 4529ms.
[14:13:10.411] <TB1> INFO: scanning low vcal = 180
[14:13:10.700] <TB1> INFO: Expecting 41600 events.
[14:13:14.940] <TB1> INFO: 41600 events read in total (3683ms).
[14:13:14.941] <TB1> INFO: Test took 4530ms.
[14:13:14.943] <TB1> INFO: scanning low vcal = 190
[14:13:15.210] <TB1> INFO: Expecting 41600 events.
[14:13:19.461] <TB1> INFO: 41600 events read in total (3695ms).
[14:13:19.462] <TB1> INFO: Test took 4519ms.
[14:13:19.464] <TB1> INFO: scanning low vcal = 200
[14:13:19.758] <TB1> INFO: Expecting 41600 events.
[14:13:24.002] <TB1> INFO: 41600 events read in total (3688ms).
[14:13:24.002] <TB1> INFO: Test took 4538ms.
[14:13:24.005] <TB1> INFO: scanning low vcal = 210
[14:13:24.268] <TB1> INFO: Expecting 41600 events.
[14:13:28.503] <TB1> INFO: 41600 events read in total (3678ms).
[14:13:28.504] <TB1> INFO: Test took 4499ms.
[14:13:28.506] <TB1> INFO: scanning low vcal = 220
[14:13:28.777] <TB1> INFO: Expecting 41600 events.
[14:13:33.014] <TB1> INFO: 41600 events read in total (3681ms).
[14:13:33.014] <TB1> INFO: Test took 4507ms.
[14:13:33.017] <TB1> INFO: scanning low vcal = 230
[14:13:33.279] <TB1> INFO: Expecting 41600 events.
[14:13:37.497] <TB1> INFO: 41600 events read in total (3661ms).
[14:13:37.498] <TB1> INFO: Test took 4481ms.
[14:13:37.500] <TB1> INFO: scanning low vcal = 240
[14:13:37.763] <TB1> INFO: Expecting 41600 events.
[14:13:42.025] <TB1> INFO: 41600 events read in total (3706ms).
[14:13:42.026] <TB1> INFO: Test took 4526ms.
[14:13:42.028] <TB1> INFO: scanning low vcal = 250
[14:13:42.303] <TB1> INFO: Expecting 41600 events.
[14:13:46.528] <TB1> INFO: 41600 events read in total (3669ms).
[14:13:46.528] <TB1> INFO: Test took 4500ms.
[14:13:46.532] <TB1> INFO: scanning high vcal = 30 (= 210 in low range)
[14:13:46.800] <TB1> INFO: Expecting 41600 events.
[14:13:51.017] <TB1> INFO: 41600 events read in total (3660ms).
[14:13:51.017] <TB1> INFO: Test took 4485ms.
[14:13:51.020] <TB1> INFO: scanning high vcal = 50 (= 350 in low range)
[14:13:51.284] <TB1> INFO: Expecting 41600 events.
[14:13:55.494] <TB1> INFO: 41600 events read in total (3653ms).
[14:13:55.495] <TB1> INFO: Test took 4475ms.
[14:13:55.497] <TB1> INFO: scanning high vcal = 70 (= 490 in low range)
[14:13:55.764] <TB1> INFO: Expecting 41600 events.
[14:13:59.992] <TB1> INFO: 41600 events read in total (3672ms).
[14:13:59.992] <TB1> INFO: Test took 4495ms.
[14:13:59.995] <TB1> INFO: scanning high vcal = 90 (= 630 in low range)
[14:14:00.262] <TB1> INFO: Expecting 41600 events.
[14:14:04.469] <TB1> INFO: 41600 events read in total (3651ms).
[14:14:04.470] <TB1> INFO: Test took 4475ms.
[14:14:04.472] <TB1> INFO: scanning high vcal = 200 (= 1400 in low range)
[14:14:04.735] <TB1> INFO: Expecting 41600 events.
[14:14:08.937] <TB1> INFO: 41600 events read in total (3646ms).
[14:14:08.938] <TB1> INFO: Test took 4466ms.
[14:14:09.386] <TB1> INFO: PixTestGainPedestal::measure() done
[14:14:42.502] <TB1> INFO: PixTestGainPedestal::fit() done
[14:14:42.502] <TB1> INFO: non-linearity mean: 0.967 0.961 0.962 0.955 0.957 0.962 0.956 0.956 0.956 0.955 0.960 0.962 0.954 0.960 0.957 0.964
[14:14:42.502] <TB1> INFO: non-linearity RMS: 0.005 0.006 0.005 0.006 0.005 0.006 0.006 0.007 0.005 0.007 0.007 0.004 0.005 0.006 0.005 0.006
[14:14:42.502] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[14:14:42.521] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[14:14:42.540] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[14:14:42.562] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[14:14:42.581] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[14:14:42.601] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[14:14:42.621] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[14:14:42.641] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[14:14:42.662] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[14:14:42.684] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[14:14:42.704] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[14:14:42.724] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[14:14:42.743] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[14:14:42.762] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[14:14:42.782] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[14:14:42.800] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[14:14:42.818] <TB1> INFO: PixTestGainPedestal::fullTest() done, duration: 166 seconds
[14:14:42.818] <TB1> INFO: Decoding statistics:
[14:14:42.818] <TB1> INFO: General information:
[14:14:42.818] <TB1> INFO: 16bit words read: 2662400
[14:14:42.818] <TB1> INFO: valid events total: 166400
[14:14:42.818] <TB1> INFO: empty events: 0
[14:14:42.818] <TB1> INFO: valid events with pixels: 166400
[14:14:42.818] <TB1> INFO: valid pixel hits: 665521
[14:14:42.818] <TB1> INFO: Event errors: 0
[14:14:42.818] <TB1> INFO: start marker: 0
[14:14:42.818] <TB1> INFO: stop marker: 0
[14:14:42.818] <TB1> INFO: overflow: 0
[14:14:42.818] <TB1> INFO: invalid 5bit words: 0
[14:14:42.818] <TB1> INFO: invalid XOR eye diagram: 0
[14:14:42.818] <TB1> INFO: frame (failed synchr.): 0
[14:14:42.818] <TB1> INFO: idle data (no TBM trl): 0
[14:14:42.818] <TB1> INFO: no data (only TBM hdr): 0
[14:14:42.818] <TB1> INFO: TBM errors: 0
[14:14:42.818] <TB1> INFO: flawed TBM headers: 0
[14:14:42.818] <TB1> INFO: flawed TBM trailers: 0
[14:14:42.818] <TB1> INFO: event ID mismatches: 0
[14:14:42.818] <TB1> INFO: ROC errors: 0
[14:14:42.818] <TB1> INFO: missing ROC header(s): 0
[14:14:42.818] <TB1> INFO: misplaced readback start: 0
[14:14:42.818] <TB1> INFO: Pixel decoding errors: 0
[14:14:42.818] <TB1> INFO: pixel data incomplete: 0
[14:14:42.818] <TB1> INFO: pixel address: 0
[14:14:42.818] <TB1> INFO: pulse height fill bit: 0
[14:14:42.818] <TB1> INFO: buffer corruption: 0
[14:14:42.826] <TB1> INFO: readReadbackCal: /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C15.dat
[14:14:42.827] <TB1> INFO: ######################################################################
[14:14:42.827] <TB1> INFO: PixTestReadback::doTest()
[14:14:42.827] <TB1> INFO: ######################################################################
[14:14:42.827] <TB1> INFO: ----------------------------------------------------------------------
[14:14:42.827] <TB1> INFO: PixTestReadback::CalibrateVd()
[14:14:42.827] <TB1> INFO: ----------------------------------------------------------------------
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C0.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C1.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C2.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C3.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C4.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C5.dat
[14:14:52.284] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C6.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C7.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C8.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C9.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C10.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C11.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C12.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C13.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C14.dat
[14:14:52.285] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C15.dat
[14:14:52.314] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:14:52.314] <TB1> INFO: ----------------------------------------------------------------------
[14:14:52.314] <TB1> INFO: PixTestReadback::CalibrateVa()
[14:14:52.314] <TB1> INFO: ----------------------------------------------------------------------
[14:15:01.800] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C0.dat
[14:15:01.800] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C1.dat
[14:15:01.800] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C2.dat
[14:15:01.800] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C3.dat
[14:15:01.800] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C4.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C5.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C6.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C7.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C8.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C9.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C10.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C11.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C12.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C13.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C14.dat
[14:15:01.801] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C15.dat
[14:15:01.830] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:15:01.830] <TB1> INFO: ----------------------------------------------------------------------
[14:15:01.830] <TB1> INFO: PixTestReadback::readbackVbg()
[14:15:01.830] <TB1> INFO: ----------------------------------------------------------------------
[14:15:09.140] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:15:09.140] <TB1> INFO: ----------------------------------------------------------------------
[14:15:09.140] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[14:15:09.140] <TB1> INFO: ----------------------------------------------------------------------
[14:15:09.140] <TB1> INFO: Vbg will be calibrated using Vd calibration
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 157.7calibrated Vbg = 1.17577 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 166.8calibrated Vbg = 1.17075 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 149.3calibrated Vbg = 1.17743 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 157.3calibrated Vbg = 1.17966 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 158.3calibrated Vbg = 1.18662 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 162.7calibrated Vbg = 1.18847 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 166.3calibrated Vbg = 1.18849 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 156calibrated Vbg = 1.19651 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 150.1calibrated Vbg = 1.1875 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 155.2calibrated Vbg = 1.19479 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 157.7calibrated Vbg = 1.17944 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 155.3calibrated Vbg = 1.18368 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.4calibrated Vbg = 1.17493 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 145.9calibrated Vbg = 1.17597 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 156.6calibrated Vbg = 1.18683 :::*/*/*/*/
[14:15:09.141] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 147.1calibrated Vbg = 1.18907 :::*/*/*/*/
[14:15:09.144] <TB1> INFO: ----------------------------------------------------------------------
[14:15:09.144] <TB1> INFO: PixTestReadback::CalibrateIa()
[14:15:09.144] <TB1> INFO: ----------------------------------------------------------------------
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C0.dat
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C1.dat
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C2.dat
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C3.dat
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C4.dat
[14:17:44.540] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C5.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C6.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C7.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C8.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C9.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C10.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C11.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C12.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C13.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C14.dat
[14:17:44.541] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2157_FullQualification17C_2016-02-10_10h02m_1455094972//002_FulltestPxar_m20//readbackCal_C15.dat
[14:17:44.569] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:17:44.569] <TB1> INFO: PixTestReadback::doTest() done
[14:17:44.569] <TB1> INFO: Decoding statistics:
[14:17:44.569] <TB1> INFO: General information:
[14:17:44.569] <TB1> INFO: 16bit words read: 1024
[14:17:44.569] <TB1> INFO: valid events total: 128
[14:17:44.569] <TB1> INFO: empty events: 128
[14:17:44.569] <TB1> INFO: valid events with pixels: 0
[14:17:44.569] <TB1> INFO: valid pixel hits: 0
[14:17:44.569] <TB1> INFO: Event errors: 0
[14:17:44.569] <TB1> INFO: start marker: 0
[14:17:44.570] <TB1> INFO: stop marker: 0
[14:17:44.570] <TB1> INFO: overflow: 0
[14:17:44.570] <TB1> INFO: invalid 5bit words: 0
[14:17:44.570] <TB1> INFO: invalid XOR eye diagram: 0
[14:17:44.570] <TB1> INFO: frame (failed synchr.): 0
[14:17:44.570] <TB1> INFO: idle data (no TBM trl): 0
[14:17:44.570] <TB1> INFO: no data (only TBM hdr): 0
[14:17:44.570] <TB1> INFO: TBM errors: 0
[14:17:44.570] <TB1> INFO: flawed TBM headers: 0
[14:17:44.570] <TB1> INFO: flawed TBM trailers: 0
[14:17:44.570] <TB1> INFO: event ID mismatches: 0
[14:17:44.570] <TB1> INFO: ROC errors: 0
[14:17:44.570] <TB1> INFO: missing ROC header(s): 0
[14:17:44.570] <TB1> INFO: misplaced readback start: 0
[14:17:44.570] <TB1> INFO: Pixel decoding errors: 0
[14:17:44.570] <TB1> INFO: pixel data incomplete: 0
[14:17:44.570] <TB1> INFO: pixel address: 0
[14:17:44.570] <TB1> INFO: pulse height fill bit: 0
[14:17:44.570] <TB1> INFO: buffer corruption: 0
[14:17:44.588] <TB1> INFO: Decoding statistics:
[14:17:44.588] <TB1> INFO: General information:
[14:17:44.588] <TB1> INFO: 16bit words read: 2755348
[14:17:44.588] <TB1> INFO: valid events total: 176768
[14:17:44.588] <TB1> INFO: empty events: 7867
[14:17:44.588] <TB1> INFO: valid events with pixels: 168901
[14:17:44.588] <TB1> INFO: valid pixel hits: 668022
[14:17:44.588] <TB1> INFO: Event errors: 0
[14:17:44.588] <TB1> INFO: start marker: 0
[14:17:44.588] <TB1> INFO: stop marker: 0
[14:17:44.588] <TB1> INFO: overflow: 0
[14:17:44.588] <TB1> INFO: invalid 5bit words: 0
[14:17:44.588] <TB1> INFO: invalid XOR eye diagram: 0
[14:17:44.588] <TB1> INFO: frame (failed synchr.): 0
[14:17:44.588] <TB1> INFO: idle data (no TBM trl): 0
[14:17:44.588] <TB1> INFO: no data (only TBM hdr): 0
[14:17:44.588] <TB1> INFO: TBM errors: 0
[14:17:44.588] <TB1> INFO: flawed TBM headers: 0
[14:17:44.588] <TB1> INFO: flawed TBM trailers: 0
[14:17:44.588] <TB1> INFO: event ID mismatches: 0
[14:17:44.588] <TB1> INFO: ROC errors: 0
[14:17:44.588] <TB1> INFO: missing ROC header(s): 0
[14:17:44.588] <TB1> INFO: misplaced readback start: 0
[14:17:44.588] <TB1> INFO: Pixel decoding errors: 0
[14:17:44.588] <TB1> INFO: pixel data incomplete: 0
[14:17:44.588] <TB1> INFO: pixel address: 0
[14:17:44.588] <TB1> INFO: pulse height fill bit: 0
[14:17:44.588] <TB1> INFO: buffer corruption: 0
[14:17:44.588] <TB1> INFO: enter test to run
[14:17:44.588] <TB1> INFO: test: exit no parameter change
[14:17:44.754] <TB1> QUIET: Connection to board 153 closed.
[14:17:44.834] <TB1> INFO: pXar: this is the end, my friend