Test Date: 2016-05-11 11:13
Analysis date: 2016-05-26 17:55
Logfile
LogfileView
[12:00:24.637] <TB0> INFO: *** Welcome to pxar ***
[12:00:24.637] <TB0> INFO: *** Today: 2016/05/11
[12:00:25.660] <TB0> INFO: *** Version: 9751-dirty
[12:00:25.660] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C15.dat
[12:00:25.660] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:00:25.660] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//defaultMaskFile.dat
[12:00:25.660] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters_C15.dat
[12:00:25.727] <TB0> INFO: clk: 4
[12:00:25.727] <TB0> INFO: ctr: 4
[12:00:25.727] <TB0> INFO: sda: 19
[12:00:25.727] <TB0> INFO: tin: 9
[12:00:25.727] <TB0> INFO: level: 15
[12:00:25.727] <TB0> INFO: triggerdelay: 0
[12:00:25.727] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[12:00:25.727] <TB0> INFO: Log level: INFO
[12:00:25.734] <TB0> INFO: Found DTB DTB_WS6AYH
[12:00:25.746] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[12:00:25.748] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[12:00:25.750] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[12:00:27.274] <TB0> INFO: DUT info:
[12:00:27.275] <TB0> INFO: The DUT currently contains the following objects:
[12:00:27.275] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[12:00:27.275] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:00:27.275] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:00:27.275] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:00:27.275] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.275] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:27.675] <TB0> INFO: enter 'restricted' command line mode
[12:00:27.675] <TB0> INFO: enter test to run
[12:00:27.675] <TB0> INFO: test: pretest no parameter change
[12:00:27.675] <TB0> INFO: running: pretest
[12:00:27.679] <TB0> INFO: ----------------------------------------------------------------------
[12:00:27.679] <TB0> INFO: PixTestPretest::programROC()
[12:00:27.679] <TB0> INFO: ----------------------------------------------------------------------
[12:00:45.694] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:00:45.694] <TB0> INFO: IA differences per ROC: 20.9 18.5 21.7 17.7 17.7 19.3 18.5 18.5 20.9 19.3 17.7 19.3 18.5 20.1 18.5 18.5
[12:00:45.788] <TB0> INFO: enter test to run
[12:00:45.788] <TB0> INFO: test: pretest no parameter change
[12:00:45.788] <TB0> INFO: running: pretest
[12:00:45.789] <TB0> INFO: ----------------------------------------------------------------------
[12:00:45.789] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:00:45.789] <TB0> INFO: ----------------------------------------------------------------------
[12:00:53.388] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 381.9 mA = 23.8688 mA/ROC
[12:00:53.388] <TB0> INFO: i(loss) [mA/ROC]: 19.3 20.1 20.1 19.3 18.5 19.3 19.3 19.3 18.5 18.5 18.5 18.5 18.5 19.3 18.5 18.5
[12:00:53.422] <TB0> INFO: enter test to run
[12:00:53.422] <TB0> INFO: test: pretest no parameter change
[12:00:53.422] <TB0> INFO: running: pretest
[12:00:53.422] <TB0> INFO: ----------------------------------------------------------------------
[12:00:53.422] <TB0> INFO: PixTestPretest::findTiming()
[12:00:53.422] <TB0> INFO: ----------------------------------------------------------------------
[12:00:53.422] <TB0> INFO: PixTestCmd::init()
[12:00:54.381] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!

[12:02:22.826] <TB0> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[12:02:22.826] <TB0> INFO: (success/tries = 100/100), width = 4
[12:02:22.827] <TB0> INFO: enter test to run
[12:02:22.827] <TB0> INFO: test: pretest no parameter change
[12:02:22.827] <TB0> INFO: running: pretest
[12:02:22.829] <TB0> INFO: ----------------------------------------------------------------------
[12:02:22.829] <TB0> INFO: PixTestPretest::findWorkingPixel()
[12:02:22.829] <TB0> INFO: ----------------------------------------------------------------------
[12:02:22.924] <TB0> INFO: Expecting 231680 events.
[12:02:28.703] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)

[12:02:28.787] <TB0> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)

[12:02:33.202] <TB0> INFO: 231680 events read in total (9722ms).
[12:02:33.207] <TB0> INFO: Test took 10372ms.
[12:02:33.442] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:02:33.515] <TB0> INFO: enter test to run
[12:02:33.515] <TB0> INFO: test: pretest no parameter change
[12:02:33.515] <TB0> INFO: running: pretest
[12:02:33.516] <TB0> INFO: ----------------------------------------------------------------------
[12:02:33.516] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[12:02:33.516] <TB0> INFO: ----------------------------------------------------------------------
[12:02:33.608] <TB0> INFO: Expecting 231680 events.
[12:02:43.892] <TB0> INFO: 231680 events read in total (9728ms).
[12:02:43.896] <TB0> INFO: Test took 10376ms.
[12:02:44.155] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[12:02:44.155] <TB0> INFO: CalDel: 144 154 154 140 128 132 154 141 164 139 149 133 131 120 145 114
[12:02:44.155] <TB0> INFO: VthrComp: 51 51 51 51 58 51 51 51 51 51 51 51 51 51 51 51
[12:02:44.195] <TB0> INFO: enter test to run
[12:02:44.195] <TB0> INFO: test: pretest no parameter change
[12:02:44.195] <TB0> INFO: running: pretest
[12:02:44.196] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C0.dat
[12:02:44.197] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C1.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C2.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C3.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C4.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C5.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C6.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C7.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C8.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C9.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C10.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C11.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C12.dat
[12:02:44.198] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C13.dat
[12:02:44.199] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C14.dat
[12:02:44.199] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters_C15.dat
[12:02:44.199] <TB0> INFO: enter test to run
[12:02:44.199] <TB0> INFO: test: fulltest no parameter change
[12:02:44.199] <TB0> INFO: running: fulltest
[12:02:44.199] <TB0> INFO: ######################################################################
[12:02:44.199] <TB0> INFO: PixTestFullTest::doTest()
[12:02:44.199] <TB0> INFO: ######################################################################
[12:02:44.200] <TB0> INFO: ######################################################################
[12:02:44.200] <TB0> INFO: PixTestAlive::doTest()
[12:02:44.200] <TB0> INFO: ######################################################################
[12:02:44.201] <TB0> INFO: ----------------------------------------------------------------------
[12:02:44.201] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:02:44.201] <TB0> INFO: ----------------------------------------------------------------------
[12:02:44.463] <TB0> INFO: Expecting 41600 events.
[12:02:48.188] <TB0> INFO: 41600 events read in total (3168ms).
[12:02:48.188] <TB0> INFO: Test took 3985ms.
[12:02:48.418] <TB0> INFO: PixTestAlive::aliveTest() done
[12:02:48.418] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:48.419] <TB0> INFO: ----------------------------------------------------------------------
[12:02:48.419] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:02:48.419] <TB0> INFO: ----------------------------------------------------------------------
[12:02:48.684] <TB0> INFO: Expecting 41600 events.
[12:02:51.643] <TB0> INFO: 41600 events read in total (2403ms).
[12:02:51.643] <TB0> INFO: Test took 3222ms.
[12:02:51.643] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:02:51.885] <TB0> INFO: PixTestAlive::maskTest() done
[12:02:51.885] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:51.887] <TB0> INFO: ----------------------------------------------------------------------
[12:02:51.887] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:02:51.887] <TB0> INFO: ----------------------------------------------------------------------
[12:02:52.163] <TB0> INFO: Expecting 41600 events.
[12:02:55.956] <TB0> INFO: 41600 events read in total (3236ms).
[12:02:55.957] <TB0> INFO: Test took 4069ms.
[12:02:56.177] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[12:02:56.178] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:56.178] <TB0> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[12:02:56.178] <TB0> INFO: Decoding statistics:
[12:02:56.178] <TB0> INFO: General information:
[12:02:56.178] <TB0> INFO: 16bit words read: 0
[12:02:56.178] <TB0> INFO: valid events total: 0
[12:02:56.178] <TB0> INFO: empty events: 0
[12:02:56.178] <TB0> INFO: valid events with pixels: 0
[12:02:56.178] <TB0> INFO: valid pixel hits: 0
[12:02:56.178] <TB0> INFO: Event errors: 0
[12:02:56.178] <TB0> INFO: start marker: 0
[12:02:56.178] <TB0> INFO: stop marker: 0
[12:02:56.178] <TB0> INFO: overflow: 0
[12:02:56.178] <TB0> INFO: invalid 5bit words: 0
[12:02:56.178] <TB0> INFO: invalid XOR eye diagram: 0
[12:02:56.178] <TB0> INFO: frame (failed synchr.): 0
[12:02:56.178] <TB0> INFO: idle data (no TBM trl): 0
[12:02:56.178] <TB0> INFO: no data (only TBM hdr): 0
[12:02:56.178] <TB0> INFO: TBM errors: 0
[12:02:56.178] <TB0> INFO: flawed TBM headers: 0
[12:02:56.178] <TB0> INFO: flawed TBM trailers: 0
[12:02:56.178] <TB0> INFO: event ID mismatches: 0
[12:02:56.178] <TB0> INFO: ROC errors: 0
[12:02:56.178] <TB0> INFO: missing ROC header(s): 0
[12:02:56.178] <TB0> INFO: misplaced readback start: 0
[12:02:56.178] <TB0> INFO: Pixel decoding errors: 0
[12:02:56.178] <TB0> INFO: pixel data incomplete: 0
[12:02:56.178] <TB0> INFO: pixel address: 0
[12:02:56.178] <TB0> INFO: pulse height fill bit: 0
[12:02:56.179] <TB0> INFO: buffer corruption: 0
[12:02:56.190] <TB0> INFO: ######################################################################
[12:02:56.190] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:02:56.191] <TB0> INFO: ######################################################################
[12:02:56.193] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:02:56.204] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:02:56.204] <TB0> INFO: run 1 of 1
[12:02:56.468] <TB0> INFO: Expecting 3120000 events.
[12:03:38.032] <TB0> INFO: 868005 events read in total (41007ms).
[12:04:18.230] <TB0> INFO: 1720395 events read in total (81205ms).
[12:04:59.267] <TB0> INFO: 2585405 events read in total (122243ms).
[12:05:24.485] <TB0> INFO: 3120000 events read in total (147460ms).
[12:05:24.534] <TB0> INFO: Test took 148331ms.
[12:05:47.995] <TB0> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[12:05:47.995] <TB0> INFO: number of dead bumps (per ROC): 23 7 15 10 3 3 4 8 0 1 0 0 3 2 2 14
[12:05:47.995] <TB0> INFO: separation cut (per ROC): 83 100 79 78 99 93 86 70 87 94 76 78 73 99 89 75
[12:05:47.995] <TB0> INFO: Decoding statistics:
[12:05:47.995] <TB0> INFO: General information:
[12:05:47.995] <TB0> INFO: 16bit words read: 0
[12:05:47.995] <TB0> INFO: valid events total: 0
[12:05:47.995] <TB0> INFO: empty events: 0
[12:05:47.995] <TB0> INFO: valid events with pixels: 0
[12:05:47.995] <TB0> INFO: valid pixel hits: 0
[12:05:47.995] <TB0> INFO: Event errors: 0
[12:05:47.995] <TB0> INFO: start marker: 0
[12:05:47.995] <TB0> INFO: stop marker: 0
[12:05:47.995] <TB0> INFO: overflow: 0
[12:05:47.995] <TB0> INFO: invalid 5bit words: 0
[12:05:47.995] <TB0> INFO: invalid XOR eye diagram: 0
[12:05:47.995] <TB0> INFO: frame (failed synchr.): 0
[12:05:47.995] <TB0> INFO: idle data (no TBM trl): 0
[12:05:47.995] <TB0> INFO: no data (only TBM hdr): 0
[12:05:47.995] <TB0> INFO: TBM errors: 0
[12:05:47.995] <TB0> INFO: flawed TBM headers: 0
[12:05:47.995] <TB0> INFO: flawed TBM trailers: 0
[12:05:47.995] <TB0> INFO: event ID mismatches: 0
[12:05:47.995] <TB0> INFO: ROC errors: 0
[12:05:47.995] <TB0> INFO: missing ROC header(s): 0
[12:05:47.995] <TB0> INFO: misplaced readback start: 0
[12:05:47.995] <TB0> INFO: Pixel decoding errors: 0
[12:05:47.995] <TB0> INFO: pixel data incomplete: 0
[12:05:47.995] <TB0> INFO: pixel address: 0
[12:05:47.995] <TB0> INFO: pulse height fill bit: 0
[12:05:47.995] <TB0> INFO: buffer corruption: 0
[12:05:48.069] <TB0> INFO: ######################################################################
[12:05:48.069] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:05:48.069] <TB0> INFO: ######################################################################
[12:05:48.070] <TB0> INFO: ----------------------------------------------------------------------
[12:05:48.070] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:05:48.070] <TB0> INFO: ----------------------------------------------------------------------
[12:05:48.070] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:05:48.078] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[12:05:48.078] <TB0> INFO: run 1 of 1
[12:05:48.337] <TB0> INFO: Expecting 26208000 events.
[12:06:23.167] <TB0> INFO: 907100 events read in total (34274ms).
[12:06:56.253] <TB0> INFO: 1801350 events read in total (67360ms).
[12:07:29.167] <TB0> INFO: 2693600 events read in total (100274ms).
[12:08:02.456] <TB0> INFO: 3583800 events read in total (133563ms).
[12:08:35.651] <TB0> INFO: 4472750 events read in total (166758ms).
[12:09:08.608] <TB0> INFO: 5361000 events read in total (199715ms).
[12:09:41.860] <TB0> INFO: 6252650 events read in total (232967ms).
[12:10:14.633] <TB0> INFO: 7141600 events read in total (265740ms).
[12:10:47.570] <TB0> INFO: 8027700 events read in total (298677ms).
[12:11:20.750] <TB0> INFO: 8915550 events read in total (331857ms).
[12:11:53.590] <TB0> INFO: 9804150 events read in total (364697ms).
[12:12:26.779] <TB0> INFO: 10692350 events read in total (397886ms).
[12:12:59.951] <TB0> INFO: 11578300 events read in total (431058ms).
[12:13:33.302] <TB0> INFO: 12465150 events read in total (464409ms).
[12:14:05.830] <TB0> INFO: 13347400 events read in total (496937ms).
[12:14:38.824] <TB0> INFO: 14224900 events read in total (529931ms).
[12:15:11.895] <TB0> INFO: 15098950 events read in total (563002ms).
[12:15:45.233] <TB0> INFO: 15971800 events read in total (596340ms).
[12:16:18.107] <TB0> INFO: 16844750 events read in total (629214ms).
[12:16:51.037] <TB0> INFO: 17718750 events read in total (662144ms).
[12:17:24.110] <TB0> INFO: 18589850 events read in total (695217ms).
[12:17:57.316] <TB0> INFO: 19462350 events read in total (728423ms).
[12:18:30.034] <TB0> INFO: 20334350 events read in total (761141ms).
[12:19:02.832] <TB0> INFO: 21205550 events read in total (793939ms).
[12:19:35.641] <TB0> INFO: 22076850 events read in total (826748ms).
[12:20:08.419] <TB0> INFO: 22948950 events read in total (859526ms).
[12:20:41.322] <TB0> INFO: 23823250 events read in total (892429ms).
[12:21:14.216] <TB0> INFO: 24694900 events read in total (925323ms).
[12:21:47.401] <TB0> INFO: 25567650 events read in total (958508ms).
[12:22:11.212] <TB0> INFO: 26208000 events read in total (982319ms).
[12:22:11.250] <TB0> INFO: Test took 983172ms.
[12:22:11.492] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:13.069] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:14.560] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:16.073] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:17.546] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:19.018] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:20.484] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:22.170] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:23.669] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:25.125] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:26.542] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:27.920] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:29.330] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:30.716] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:32.066] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:33.449] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:22:34.985] <TB0> INFO: PixTestScurves::scurves() done
[12:22:34.985] <TB0> INFO: Vcal mean: 93.78 101.55 82.46 81.75 101.45 91.08 85.62 78.43 92.70 96.33 84.44 78.77 83.36 98.95 91.96 82.74
[12:22:34.985] <TB0> INFO: Vcal RMS: 7.43 7.20 4.67 4.44 6.31 5.99 5.13 4.05 5.47 5.83 5.08 3.84 4.87 5.73 5.64 5.01
[12:22:34.985] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1006 seconds
[12:22:34.985] <TB0> INFO: Decoding statistics:
[12:22:34.985] <TB0> INFO: General information:
[12:22:34.985] <TB0> INFO: 16bit words read: 0
[12:22:34.985] <TB0> INFO: valid events total: 0
[12:22:34.985] <TB0> INFO: empty events: 0
[12:22:34.985] <TB0> INFO: valid events with pixels: 0
[12:22:34.985] <TB0> INFO: valid pixel hits: 0
[12:22:34.985] <TB0> INFO: Event errors: 0
[12:22:34.985] <TB0> INFO: start marker: 0
[12:22:34.985] <TB0> INFO: stop marker: 0
[12:22:34.985] <TB0> INFO: overflow: 0
[12:22:34.985] <TB0> INFO: invalid 5bit words: 0
[12:22:34.985] <TB0> INFO: invalid XOR eye diagram: 0
[12:22:34.985] <TB0> INFO: frame (failed synchr.): 0
[12:22:34.985] <TB0> INFO: idle data (no TBM trl): 0
[12:22:34.985] <TB0> INFO: no data (only TBM hdr): 0
[12:22:34.985] <TB0> INFO: TBM errors: 0
[12:22:34.985] <TB0> INFO: flawed TBM headers: 0
[12:22:34.985] <TB0> INFO: flawed TBM trailers: 0
[12:22:34.985] <TB0> INFO: event ID mismatches: 0
[12:22:34.985] <TB0> INFO: ROC errors: 0
[12:22:34.985] <TB0> INFO: missing ROC header(s): 0
[12:22:34.985] <TB0> INFO: misplaced readback start: 0
[12:22:34.985] <TB0> INFO: Pixel decoding errors: 0
[12:22:34.985] <TB0> INFO: pixel data incomplete: 0
[12:22:34.985] <TB0> INFO: pixel address: 0
[12:22:34.985] <TB0> INFO: pulse height fill bit: 0
[12:22:34.985] <TB0> INFO: buffer corruption: 0
[12:22:35.061] <TB0> INFO: ######################################################################
[12:22:35.061] <TB0> INFO: PixTestTrim::doTest()
[12:22:35.061] <TB0> INFO: ######################################################################
[12:22:35.063] <TB0> INFO: ----------------------------------------------------------------------
[12:22:35.063] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[12:22:35.063] <TB0> INFO: ----------------------------------------------------------------------
[12:22:35.142] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[12:22:35.142] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:22:35.151] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:22:35.151] <TB0> INFO: run 1 of 1
[12:22:35.417] <TB0> INFO: Expecting 6281600 events.
[12:23:16.091] <TB0> INFO: 1086890 events read in total (40117ms).
[12:23:55.539] <TB0> INFO: 2168690 events read in total (79565ms).
[12:24:34.334] <TB0> INFO: 3244700 events read in total (118360ms).
[12:25:14.203] <TB0> INFO: 4328340 events read in total (158229ms).
[12:25:53.283] <TB0> INFO: 5417000 events read in total (197309ms).
[12:26:25.086] <TB0> INFO: 6281600 events read in total (229112ms).
[12:26:25.120] <TB0> INFO: Test took 229969ms.
[12:26:45.992] <TB0> INFO: ROC 0 VthrComp = 91
[12:26:45.992] <TB0> INFO: ROC 1 VthrComp = 97
[12:26:45.992] <TB0> INFO: ROC 2 VthrComp = 87
[12:26:45.992] <TB0> INFO: ROC 3 VthrComp = 85
[12:26:45.992] <TB0> INFO: ROC 4 VthrComp = 100
[12:26:45.992] <TB0> INFO: ROC 5 VthrComp = 95
[12:26:45.992] <TB0> INFO: ROC 6 VthrComp = 90
[12:26:45.992] <TB0> INFO: ROC 7 VthrComp = 82
[12:26:45.993] <TB0> INFO: ROC 8 VthrComp = 95
[12:26:45.993] <TB0> INFO: ROC 9 VthrComp = 97
[12:26:45.993] <TB0> INFO: ROC 10 VthrComp = 87
[12:26:45.993] <TB0> INFO: ROC 11 VthrComp = 84
[12:26:45.993] <TB0> INFO: ROC 12 VthrComp = 86
[12:26:45.993] <TB0> INFO: ROC 13 VthrComp = 101
[12:26:45.993] <TB0> INFO: ROC 14 VthrComp = 92
[12:26:45.993] <TB0> INFO: ROC 15 VthrComp = 86
[12:26:45.993] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[12:26:45.993] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:26:46.005] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:26:46.005] <TB0> INFO: run 1 of 1
[12:26:46.298] <TB0> INFO: Expecting 6281600 events.
[12:27:22.061] <TB0> INFO: 756000 events read in total (35193ms).
[12:27:57.296] <TB0> INFO: 1510510 events read in total (70428ms).
[12:28:32.570] <TB0> INFO: 2264860 events read in total (105702ms).
[12:29:07.481] <TB0> INFO: 3020060 events read in total (140613ms).
[12:29:42.508] <TB0> INFO: 3769650 events read in total (175640ms).
[12:30:17.962] <TB0> INFO: 4515680 events read in total (211094ms).
[12:30:52.553] <TB0> INFO: 5259890 events read in total (245685ms).
[12:31:27.051] <TB0> INFO: 6003940 events read in total (280183ms).
[12:31:40.396] <TB0> INFO: 6281600 events read in total (293528ms).
[12:31:40.436] <TB0> INFO: Test took 294431ms.
[12:32:04.543] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 66.5447 for pixel 2/78 mean/min/max = 48.5604/30.3816/66.7392
[12:32:04.543] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 66.9695 for pixel 0/15 mean/min/max = 49.0783/30.9022/67.2544
[12:32:04.543] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 56.644 for pixel 51/76 mean/min/max = 44.0215/31.3671/56.676
[12:32:04.544] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 57.1143 for pixel 5/11 mean/min/max = 44.6683/32.1948/57.1419
[12:32:04.544] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 64.6944 for pixel 0/1 mean/min/max = 48.21/31.6495/64.7705
[12:32:04.545] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 59.9449 for pixel 0/65 mean/min/max = 45.7335/31.4856/59.9813
[12:32:04.545] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 56.9126 for pixel 51/78 mean/min/max = 44.8905/32.8351/56.946
[12:32:04.545] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 56.5844 for pixel 51/75 mean/min/max = 44.5433/32.4888/56.5979
[12:32:04.546] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 58.7511 for pixel 3/66 mean/min/max = 45.607/32.2864/58.9277
[12:32:04.546] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 58.6232 for pixel 51/5 mean/min/max = 45.3855/31.8889/58.8822
[12:32:04.546] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 58.5682 for pixel 0/78 mean/min/max = 45.1117/31.6331/58.5903
[12:32:04.547] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 54.8543 for pixel 48/1 mean/min/max = 43.9641/32.3814/55.5468
[12:32:04.547] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 58.7844 for pixel 5/3 mean/min/max = 45.5007/32.1806/58.8209
[12:32:04.547] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.3744 for pixel 3/60 mean/min/max = 46.6022/32.3422/60.8623
[12:32:04.548] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 59.7792 for pixel 51/78 mean/min/max = 46.1982/32.309/60.0874
[12:32:04.548] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 58.388 for pixel 31/79 mean/min/max = 45.1089/31.6057/58.6121
[12:32:04.549] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:32:04.637] <TB0> INFO: Expecting 514560 events.
[12:32:17.676] <TB0> INFO: 514560 events read in total (12483ms).
[12:32:17.683] <TB0> INFO: Expecting 514560 events.
[12:32:30.310] <TB0> INFO: 514560 events read in total (12218ms).
[12:32:30.317] <TB0> INFO: Expecting 514560 events.
[12:32:43.068] <TB0> INFO: 514560 events read in total (12328ms).
[12:32:43.076] <TB0> INFO: Expecting 514560 events.
[12:32:55.838] <TB0> INFO: 514560 events read in total (12346ms).
[12:32:55.849] <TB0> INFO: Expecting 514560 events.
[12:33:08.691] <TB0> INFO: 514560 events read in total (12425ms).
[12:33:08.704] <TB0> INFO: Expecting 514560 events.
[12:33:21.497] <TB0> INFO: 514560 events read in total (12373ms).
[12:33:21.512] <TB0> INFO: Expecting 514560 events.
[12:33:34.261] <TB0> INFO: 514560 events read in total (12343ms).
[12:33:34.275] <TB0> INFO: Expecting 514560 events.
[12:33:47.034] <TB0> INFO: 514560 events read in total (12342ms).
[12:33:47.054] <TB0> INFO: Expecting 514560 events.
[12:33:59.911] <TB0> INFO: 514560 events read in total (12451ms).
[12:33:59.933] <TB0> INFO: Expecting 514560 events.
[12:34:12.668] <TB0> INFO: 514560 events read in total (12331ms).
[12:34:12.689] <TB0> INFO: Expecting 514560 events.
[12:34:25.359] <TB0> INFO: 514560 events read in total (12262ms).
[12:34:25.380] <TB0> INFO: Expecting 514560 events.
[12:34:38.098] <TB0> INFO: 514560 events read in total (12316ms).
[12:34:38.121] <TB0> INFO: Expecting 514560 events.
[12:34:50.878] <TB0> INFO: 514560 events read in total (12355ms).
[12:34:50.902] <TB0> INFO: Expecting 514560 events.
[12:35:03.655] <TB0> INFO: 514560 events read in total (12351ms).
[12:35:03.685] <TB0> INFO: Expecting 514560 events.
[12:35:16.568] <TB0> INFO: 514560 events read in total (12481ms).
[12:35:16.597] <TB0> INFO: Expecting 514560 events.
[12:35:29.357] <TB0> INFO: 514560 events read in total (12359ms).
[12:35:29.389] <TB0> INFO: Test took 204840ms.
[12:35:30.280] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:35:30.289] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:35:30.289] <TB0> INFO: run 1 of 1
[12:35:30.552] <TB0> INFO: Expecting 6281600 events.
[12:36:05.879] <TB0> INFO: 742350 events read in total (34771ms).
[12:36:41.011] <TB0> INFO: 1483540 events read in total (69903ms).
[12:37:16.161] <TB0> INFO: 2224610 events read in total (105053ms).
[12:37:51.199] <TB0> INFO: 2966100 events read in total (140091ms).
[12:38:25.984] <TB0> INFO: 3701860 events read in total (174876ms).
[12:39:00.695] <TB0> INFO: 4433150 events read in total (209587ms).
[12:39:35.461] <TB0> INFO: 5162530 events read in total (244353ms).
[12:40:09.770] <TB0> INFO: 5890230 events read in total (278662ms).
[12:40:28.660] <TB0> INFO: 6281600 events read in total (297552ms).
[12:40:28.721] <TB0> INFO: Test took 298432ms.
[12:40:53.151] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.108671 .. 255.000000
[12:40:53.272] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[12:40:53.283] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:40:53.283] <TB0> INFO: run 1 of 1
[12:40:53.568] <TB0> INFO: Expecting 10649600 events.
[12:41:29.054] <TB0> INFO: 711600 events read in total (34930ms).
[12:42:03.501] <TB0> INFO: 1423320 events read in total (69377ms).
[12:42:37.598] <TB0> INFO: 2135700 events read in total (103474ms).
[12:43:11.849] <TB0> INFO: 2848020 events read in total (137725ms).
[12:43:46.030] <TB0> INFO: 3560300 events read in total (171906ms).
[12:44:20.306] <TB0> INFO: 4272630 events read in total (206182ms).
[12:44:54.538] <TB0> INFO: 4985300 events read in total (240414ms).
[12:45:28.904] <TB0> INFO: 5697730 events read in total (274780ms).
[12:46:03.036] <TB0> INFO: 6409670 events read in total (308912ms).
[12:46:37.647] <TB0> INFO: 7121000 events read in total (343523ms).
[12:47:11.891] <TB0> INFO: 7832440 events read in total (377767ms).
[12:47:45.918] <TB0> INFO: 8543000 events read in total (411794ms).
[12:48:20.541] <TB0> INFO: 9253520 events read in total (446417ms).
[12:48:54.887] <TB0> INFO: 9964000 events read in total (480763ms).
[12:49:28.207] <TB0> INFO: 10649600 events read in total (514083ms).
[12:49:28.299] <TB0> INFO: Test took 515016ms.
[12:49:58.994] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 16.698189 .. 45.833684
[12:49:59.070] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[12:49:59.079] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:49:59.079] <TB0> INFO: run 1 of 1
[12:49:59.343] <TB0> INFO: Expecting 2080000 events.
[12:50:38.290] <TB0> INFO: 931470 events read in total (38391ms).
[12:51:15.970] <TB0> INFO: 1861150 events read in total (76072ms).
[12:51:25.278] <TB0> INFO: 2080000 events read in total (85380ms).
[12:51:25.298] <TB0> INFO: Test took 86220ms.
[12:51:38.593] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 4.500000 .. 42.485272
[12:51:38.699] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 4 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:51:38.708] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:51:38.708] <TB0> INFO: run 1 of 1
[12:51:38.994] <TB0> INFO: Expecting 2038400 events.
[12:52:17.576] <TB0> INFO: 970560 events read in total (38026ms).
[12:52:55.528] <TB0> INFO: 1939870 events read in total (75978ms).
[12:52:59.749] <TB0> INFO: 2038400 events read in total (80200ms).
[12:52:59.763] <TB0> INFO: Test took 81055ms.
[12:53:12.870] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 4.500000 .. 42.046358
[12:53:12.945] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 4 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:53:12.954] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:53:12.954] <TB0> INFO: run 1 of 1
[12:53:13.213] <TB0> INFO: Expecting 2038400 events.
[12:53:52.029] <TB0> INFO: 970670 events read in total (38260ms).
[12:54:30.111] <TB0> INFO: 1941290 events read in total (76342ms).
[12:54:34.367] <TB0> INFO: 2038400 events read in total (80598ms).
[12:54:34.379] <TB0> INFO: Test took 81425ms.
[12:54:48.059] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[12:54:48.059] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[12:54:48.068] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:54:48.068] <TB0> INFO: run 1 of 1
[12:54:48.335] <TB0> INFO: Expecting 1705600 events.
[12:55:25.996] <TB0> INFO: 878800 events read in total (37105ms).
[12:56:00.982] <TB0> INFO: 1705600 events read in total (72091ms).
[12:56:00.997] <TB0> INFO: Test took 72930ms.
[12:56:15.150] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C0.dat
[12:56:15.150] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C1.dat
[12:56:15.150] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C2.dat
[12:56:15.150] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C3.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C4.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C5.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C6.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C7.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C8.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C9.dat
[12:56:15.151] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C10.dat
[12:56:15.152] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C11.dat
[12:56:15.152] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C12.dat
[12:56:15.152] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C13.dat
[12:56:15.152] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C14.dat
[12:56:15.152] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C15.dat
[12:56:15.152] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C0.dat
[12:56:15.158] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C1.dat
[12:56:15.164] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C2.dat
[12:56:15.170] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C3.dat
[12:56:15.176] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C4.dat
[12:56:15.182] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C5.dat
[12:56:15.188] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C6.dat
[12:56:15.194] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C7.dat
[12:56:15.201] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C8.dat
[12:56:15.207] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C9.dat
[12:56:15.213] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C10.dat
[12:56:15.221] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C11.dat
[12:56:15.230] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C12.dat
[12:56:15.239] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C13.dat
[12:56:15.247] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C14.dat
[12:56:15.254] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//trimParameters35_C15.dat
[12:56:15.260] <TB0> INFO: PixTestTrim::trimTest() done
[12:56:15.260] <TB0> INFO: vtrim: 105 93 85 94 109 88 84 89 89 97 90 83 100 105 102 90
[12:56:15.260] <TB0> INFO: vthrcomp: 91 97 87 85 100 95 90 82 95 97 87 84 86 101 92 86
[12:56:15.260] <TB0> INFO: vcal mean: 34.99 35.01 34.95 34.94 34.93 34.96 34.98 35.00 35.00 34.95 34.97 34.95 34.92 34.97 35.08 34.95
[12:56:15.260] <TB0> INFO: vcal RMS: 1.02 1.00 0.82 0.86 0.96 0.88 0.82 0.79 0.88 0.90 0.88 0.80 0.90 0.89 0.88 0.96
[12:56:15.260] <TB0> INFO: bits mean: 9.02 8.68 9.81 10.13 9.01 9.20 9.23 9.47 9.62 9.36 9.48 9.82 9.64 9.19 9.26 9.43
[12:56:15.260] <TB0> INFO: bits RMS: 2.87 2.95 2.73 2.48 2.75 2.84 2.78 2.69 2.62 2.83 2.81 2.57 2.60 2.73 2.70 2.85
[12:56:15.267] <TB0> INFO: ----------------------------------------------------------------------
[12:56:15.267] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[12:56:15.267] <TB0> INFO: ----------------------------------------------------------------------
[12:56:15.269] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[12:56:15.280] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:56:15.280] <TB0> INFO: run 1 of 1
[12:56:15.616] <TB0> INFO: Expecting 4160000 events.
[12:56:58.058] <TB0> INFO: 935265 events read in total (41885ms).
[12:57:39.930] <TB0> INFO: 1864875 events read in total (83757ms).
[12:58:21.279] <TB0> INFO: 2785800 events read in total (125106ms).
[12:59:02.994] <TB0> INFO: 3704345 events read in total (166821ms).
[12:59:23.496] <TB0> INFO: 4160000 events read in total (187323ms).
[12:59:23.539] <TB0> INFO: Test took 188259ms.
[12:59:53.524] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[12:59:53.535] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:59:53.535] <TB0> INFO: run 1 of 1
[12:59:53.843] <TB0> INFO: Expecting 4160000 events.
[13:00:35.574] <TB0> INFO: 903855 events read in total (41175ms).
[13:01:16.940] <TB0> INFO: 1803475 events read in total (82541ms).
[13:01:57.593] <TB0> INFO: 2695795 events read in total (123194ms).
[13:02:38.538] <TB0> INFO: 3584990 events read in total (164139ms).
[13:03:05.033] <TB0> INFO: 4160000 events read in total (190634ms).
[13:03:05.071] <TB0> INFO: Test took 191537ms.
[13:03:35.318] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 183 (-1/-1) hits flags = 528 (plus default)
[13:03:35.328] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:03:35.328] <TB0> INFO: run 1 of 1
[13:03:35.619] <TB0> INFO: Expecting 3827200 events.
[13:04:18.082] <TB0> INFO: 932525 events read in total (41907ms).
[13:04:59.441] <TB0> INFO: 1859920 events read in total (83266ms).
[13:05:40.629] <TB0> INFO: 2776795 events read in total (124455ms).
[13:06:21.794] <TB0> INFO: 3693285 events read in total (165619ms).
[13:06:27.990] <TB0> INFO: 3827200 events read in total (171815ms).
[13:06:28.023] <TB0> INFO: Test took 172695ms.
[13:06:55.260] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 182 (-1/-1) hits flags = 528 (plus default)
[13:06:55.269] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:06:55.269] <TB0> INFO: run 1 of 1
[13:06:55.541] <TB0> INFO: Expecting 3806400 events.
[13:07:38.212] <TB0> INFO: 933955 events read in total (42115ms).
[13:08:19.777] <TB0> INFO: 1862545 events read in total (83681ms).
[13:09:00.824] <TB0> INFO: 2780565 events read in total (124728ms).
[13:09:41.862] <TB0> INFO: 3697490 events read in total (165765ms).
[13:09:47.044] <TB0> INFO: 3806400 events read in total (170947ms).
[13:09:47.077] <TB0> INFO: Test took 171808ms.
[13:10:15.831] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 184 (-1/-1) hits flags = 528 (plus default)
[13:10:15.839] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:10:15.839] <TB0> INFO: run 1 of 1
[13:10:16.104] <TB0> INFO: Expecting 3848000 events.
[13:10:58.462] <TB0> INFO: 929360 events read in total (41798ms).
[13:11:40.188] <TB0> INFO: 1853605 events read in total (83524ms).
[13:12:21.775] <TB0> INFO: 2767565 events read in total (125111ms).
[13:13:02.951] <TB0> INFO: 3680025 events read in total (166287ms).
[13:13:10.751] <TB0> INFO: 3848000 events read in total (174087ms).
[13:13:10.789] <TB0> INFO: Test took 174949ms.
[13:13:37.481] <TB0> INFO: PixTestTrim::trimBitTest() done
[13:13:37.482] <TB0> INFO: PixTestTrim::doTest() done, duration: 3062 seconds
[13:13:37.482] <TB0> INFO: Decoding statistics:
[13:13:37.482] <TB0> INFO: General information:
[13:13:37.482] <TB0> INFO: 16bit words read: 0
[13:13:37.482] <TB0> INFO: valid events total: 0
[13:13:37.482] <TB0> INFO: empty events: 0
[13:13:37.482] <TB0> INFO: valid events with pixels: 0
[13:13:37.482] <TB0> INFO: valid pixel hits: 0
[13:13:37.482] <TB0> INFO: Event errors: 0
[13:13:37.482] <TB0> INFO: start marker: 0
[13:13:37.482] <TB0> INFO: stop marker: 0
[13:13:37.482] <TB0> INFO: overflow: 0
[13:13:37.482] <TB0> INFO: invalid 5bit words: 0
[13:13:37.482] <TB0> INFO: invalid XOR eye diagram: 0
[13:13:37.482] <TB0> INFO: frame (failed synchr.): 0
[13:13:37.482] <TB0> INFO: idle data (no TBM trl): 0
[13:13:37.482] <TB0> INFO: no data (only TBM hdr): 0
[13:13:37.482] <TB0> INFO: TBM errors: 0
[13:13:37.483] <TB0> INFO: flawed TBM headers: 0
[13:13:37.483] <TB0> INFO: flawed TBM trailers: 0
[13:13:37.483] <TB0> INFO: event ID mismatches: 0
[13:13:37.483] <TB0> INFO: ROC errors: 0
[13:13:37.483] <TB0> INFO: missing ROC header(s): 0
[13:13:37.483] <TB0> INFO: misplaced readback start: 0
[13:13:37.483] <TB0> INFO: Pixel decoding errors: 0
[13:13:37.483] <TB0> INFO: pixel data incomplete: 0
[13:13:37.483] <TB0> INFO: pixel address: 0
[13:13:37.483] <TB0> INFO: pulse height fill bit: 0
[13:13:37.483] <TB0> INFO: buffer corruption: 0
[13:13:38.203] <TB0> INFO: ######################################################################
[13:13:38.203] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[13:13:38.203] <TB0> INFO: ######################################################################
[13:13:38.465] <TB0> INFO: Expecting 41600 events.
[13:13:42.250] <TB0> INFO: 41600 events read in total (3229ms).
[13:13:42.250] <TB0> INFO: Test took 4046ms.
[13:13:42.715] <TB0> INFO: Expecting 41600 events.
[13:13:46.547] <TB0> INFO: 41600 events read in total (3276ms).
[13:13:46.548] <TB0> INFO: Test took 4096ms.
[13:13:46.845] <TB0> INFO: Expecting 41600 events.
[13:13:50.679] <TB0> INFO: 41600 events read in total (3278ms).
[13:13:50.679] <TB0> INFO: Test took 4110ms.
[13:13:50.935] <TB0> INFO: Expecting 2560 events.
[13:13:51.788] <TB0> INFO: 2560 events read in total (297ms).
[13:13:51.788] <TB0> INFO: Test took 1095ms.
[13:13:52.093] <TB0> INFO: Expecting 2560 events.
[13:13:52.946] <TB0> INFO: 2560 events read in total (297ms).
[13:13:52.946] <TB0> INFO: Test took 1157ms.
[13:13:53.251] <TB0> INFO: Expecting 2560 events.
[13:13:54.104] <TB0> INFO: 2560 events read in total (297ms).
[13:13:54.104] <TB0> INFO: Test took 1158ms.
[13:13:54.409] <TB0> INFO: Expecting 2560 events.
[13:13:55.263] <TB0> INFO: 2560 events read in total (298ms).
[13:13:55.263] <TB0> INFO: Test took 1159ms.
[13:13:55.568] <TB0> INFO: Expecting 2560 events.
[13:13:56.421] <TB0> INFO: 2560 events read in total (297ms).
[13:13:56.421] <TB0> INFO: Test took 1148ms.
[13:13:56.726] <TB0> INFO: Expecting 2560 events.
[13:13:57.579] <TB0> INFO: 2560 events read in total (297ms).
[13:13:57.579] <TB0> INFO: Test took 1157ms.
[13:13:57.884] <TB0> INFO: Expecting 2560 events.
[13:13:58.739] <TB0> INFO: 2560 events read in total (299ms).
[13:13:58.739] <TB0> INFO: Test took 1160ms.
[13:13:59.044] <TB0> INFO: Expecting 2560 events.
[13:13:59.897] <TB0> INFO: 2560 events read in total (297ms).
[13:13:59.897] <TB0> INFO: Test took 1158ms.
[13:14:00.202] <TB0> INFO: Expecting 2560 events.
[13:14:01.058] <TB0> INFO: 2560 events read in total (300ms).
[13:14:01.059] <TB0> INFO: Test took 1161ms.
[13:14:01.363] <TB0> INFO: Expecting 2560 events.
[13:14:02.218] <TB0> INFO: 2560 events read in total (299ms).
[13:14:02.219] <TB0> INFO: Test took 1159ms.
[13:14:02.523] <TB0> INFO: Expecting 2560 events.
[13:14:03.378] <TB0> INFO: 2560 events read in total (298ms).
[13:14:03.378] <TB0> INFO: Test took 1159ms.
[13:14:03.683] <TB0> INFO: Expecting 2560 events.
[13:14:04.536] <TB0> INFO: 2560 events read in total (297ms).
[13:14:04.536] <TB0> INFO: Test took 1156ms.
[13:14:04.841] <TB0> INFO: Expecting 2560 events.
[13:14:05.696] <TB0> INFO: 2560 events read in total (299ms).
[13:14:05.696] <TB0> INFO: Test took 1159ms.
[13:14:06.001] <TB0> INFO: Expecting 2560 events.
[13:14:06.856] <TB0> INFO: 2560 events read in total (299ms).
[13:14:06.856] <TB0> INFO: Test took 1160ms.
[13:14:07.161] <TB0> INFO: Expecting 2560 events.
[13:14:08.014] <TB0> INFO: 2560 events read in total (297ms).
[13:14:08.014] <TB0> INFO: Test took 1157ms.
[13:14:08.319] <TB0> INFO: Expecting 2560 events.
[13:14:09.172] <TB0> INFO: 2560 events read in total (297ms).
[13:14:09.172] <TB0> INFO: Test took 1158ms.
[13:14:09.179] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:14:09.478] <TB0> INFO: Expecting 655360 events.
[13:14:26.217] <TB0> INFO: 655360 events read in total (16183ms).
[13:14:26.226] <TB0> INFO: Expecting 655360 events.
[13:14:42.986] <TB0> INFO: 655360 events read in total (16357ms).
[13:14:42.998] <TB0> INFO: Expecting 655360 events.
[13:14:59.772] <TB0> INFO: 655360 events read in total (16372ms).
[13:14:59.788] <TB0> INFO: Expecting 655360 events.
[13:15:16.577] <TB0> INFO: 655360 events read in total (16387ms).
[13:15:16.595] <TB0> INFO: Expecting 655360 events.
[13:15:33.295] <TB0> INFO: 655360 events read in total (16298ms).
[13:15:33.317] <TB0> INFO: Expecting 655360 events.
[13:15:50.072] <TB0> INFO: 655360 events read in total (16354ms).
[13:15:50.099] <TB0> INFO: Expecting 655360 events.
[13:16:06.888] <TB0> INFO: 655360 events read in total (16388ms).
[13:16:06.917] <TB0> INFO: Expecting 655360 events.
[13:16:23.694] <TB0> INFO: 655360 events read in total (16375ms).
[13:16:23.727] <TB0> INFO: Expecting 655360 events.
[13:16:40.549] <TB0> INFO: 655360 events read in total (16420ms).
[13:16:40.588] <TB0> INFO: Expecting 655360 events.
[13:16:57.297] <TB0> INFO: 655360 events read in total (16307ms).
[13:16:57.336] <TB0> INFO: Expecting 655360 events.
[13:17:14.141] <TB0> INFO: 655360 events read in total (16404ms).
[13:17:14.184] <TB0> INFO: Expecting 655360 events.
[13:17:31.022] <TB0> INFO: 655360 events read in total (16436ms).
[13:17:31.072] <TB0> INFO: Expecting 655360 events.
[13:17:47.717] <TB0> INFO: 655360 events read in total (16243ms).
[13:17:47.767] <TB0> INFO: Expecting 655360 events.
[13:18:04.414] <TB0> INFO: 655360 events read in total (16246ms).
[13:18:04.472] <TB0> INFO: Expecting 655360 events.
[13:18:21.257] <TB0> INFO: 655360 events read in total (16383ms).
[13:18:21.312] <TB0> INFO: Expecting 655360 events.
[13:18:38.053] <TB0> INFO: 655360 events read in total (16339ms).
[13:18:38.116] <TB0> INFO: Test took 268937ms.
[13:18:38.195] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:18:38.426] <TB0> INFO: Expecting 655360 events.
[13:18:55.294] <TB0> INFO: 655360 events read in total (16311ms).
[13:18:55.304] <TB0> INFO: Expecting 655360 events.
[13:19:11.922] <TB0> INFO: 655360 events read in total (16216ms).
[13:19:11.935] <TB0> INFO: Expecting 655360 events.
[13:19:28.739] <TB0> INFO: 655360 events read in total (16403ms).
[13:19:28.754] <TB0> INFO: Expecting 655360 events.
[13:19:45.507] <TB0> INFO: 655360 events read in total (16351ms).
[13:19:45.528] <TB0> INFO: Expecting 655360 events.
[13:20:02.224] <TB0> INFO: 655360 events read in total (16294ms).
[13:20:02.246] <TB0> INFO: Expecting 655360 events.
[13:20:19.064] <TB0> INFO: 655360 events read in total (16416ms).
[13:20:19.089] <TB0> INFO: Expecting 655360 events.
[13:20:35.829] <TB0> INFO: 655360 events read in total (16338ms).
[13:20:35.860] <TB0> INFO: Expecting 655360 events.
[13:20:52.369] <TB0> INFO: 655360 events read in total (16108ms).
[13:20:52.405] <TB0> INFO: Expecting 655360 events.
[13:21:08.978] <TB0> INFO: 655360 events read in total (16172ms).
[13:21:09.014] <TB0> INFO: Expecting 655360 events.
[13:21:25.686] <TB0> INFO: 655360 events read in total (16271ms).
[13:21:25.732] <TB0> INFO: Expecting 655360 events.
[13:21:42.464] <TB0> INFO: 655360 events read in total (16331ms).
[13:21:42.506] <TB0> INFO: Expecting 655360 events.
[13:21:59.197] <TB0> INFO: 655360 events read in total (16289ms).
[13:21:59.242] <TB0> INFO: Expecting 655360 events.
[13:22:15.946] <TB0> INFO: 655360 events read in total (16302ms).
[13:22:15.996] <TB0> INFO: Expecting 655360 events.
[13:22:32.795] <TB0> INFO: 655360 events read in total (16398ms).
[13:22:32.853] <TB0> INFO: Expecting 655360 events.
[13:22:49.640] <TB0> INFO: 655360 events read in total (16386ms).
[13:22:49.697] <TB0> INFO: Expecting 655360 events.
[13:23:06.454] <TB0> INFO: 655360 events read in total (16355ms).
[13:23:06.513] <TB0> INFO: Test took 268318ms.
[13:23:06.704] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.711] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.719] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.727] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.735] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:23:06.742] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[13:23:06.749] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[13:23:06.756] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.764] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.773] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.780] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.786] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.795] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.803] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.811] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:23:06.819] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.826] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.832] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.839] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.846] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:23:06.883] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:23:06.884] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:23:07.155] <TB0> INFO: Expecting 41600 events.
[13:23:10.631] <TB0> INFO: 41600 events read in total (2920ms).
[13:23:10.632] <TB0> INFO: Test took 3745ms.
[13:23:11.082] <TB0> INFO: Expecting 41600 events.
[13:23:14.574] <TB0> INFO: 41600 events read in total (2936ms).
[13:23:14.574] <TB0> INFO: Test took 3764ms.
[13:23:15.012] <TB0> INFO: Expecting 41600 events.
[13:23:18.485] <TB0> INFO: 41600 events read in total (2917ms).
[13:23:18.486] <TB0> INFO: Test took 3737ms.
[13:23:18.668] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:18.755] <TB0> INFO: Expecting 2560 events.
[13:23:19.609] <TB0> INFO: 2560 events read in total (297ms).
[13:23:19.609] <TB0> INFO: Test took 941ms.
[13:23:19.611] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:19.915] <TB0> INFO: Expecting 2560 events.
[13:23:20.774] <TB0> INFO: 2560 events read in total (302ms).
[13:23:20.774] <TB0> INFO: Test took 1163ms.
[13:23:20.776] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:21.080] <TB0> INFO: Expecting 2560 events.
[13:23:21.932] <TB0> INFO: 2560 events read in total (296ms).
[13:23:21.933] <TB0> INFO: Test took 1157ms.
[13:23:21.935] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:22.238] <TB0> INFO: Expecting 2560 events.
[13:23:23.092] <TB0> INFO: 2560 events read in total (298ms).
[13:23:23.092] <TB0> INFO: Test took 1157ms.
[13:23:23.094] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:23.397] <TB0> INFO: Expecting 2560 events.
[13:23:24.250] <TB0> INFO: 2560 events read in total (297ms).
[13:23:24.251] <TB0> INFO: Test took 1157ms.
[13:23:24.252] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:24.556] <TB0> INFO: Expecting 2560 events.
[13:23:25.414] <TB0> INFO: 2560 events read in total (302ms).
[13:23:25.414] <TB0> INFO: Test took 1162ms.
[13:23:25.417] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:25.720] <TB0> INFO: Expecting 2560 events.
[13:23:26.575] <TB0> INFO: 2560 events read in total (299ms).
[13:23:26.575] <TB0> INFO: Test took 1158ms.
[13:23:26.577] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:26.880] <TB0> INFO: Expecting 2560 events.
[13:23:27.738] <TB0> INFO: 2560 events read in total (302ms).
[13:23:27.738] <TB0> INFO: Test took 1161ms.
[13:23:27.741] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:28.044] <TB0> INFO: Expecting 2560 events.
[13:23:28.898] <TB0> INFO: 2560 events read in total (299ms).
[13:23:28.899] <TB0> INFO: Test took 1158ms.
[13:23:28.901] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:29.205] <TB0> INFO: Expecting 2560 events.
[13:23:30.062] <TB0> INFO: 2560 events read in total (301ms).
[13:23:30.062] <TB0> INFO: Test took 1161ms.
[13:23:30.064] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:30.368] <TB0> INFO: Expecting 2560 events.
[13:23:31.227] <TB0> INFO: 2560 events read in total (303ms).
[13:23:31.228] <TB0> INFO: Test took 1164ms.
[13:23:31.230] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:31.534] <TB0> INFO: Expecting 2560 events.
[13:23:32.389] <TB0> INFO: 2560 events read in total (299ms).
[13:23:32.390] <TB0> INFO: Test took 1161ms.
[13:23:32.392] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:32.695] <TB0> INFO: Expecting 2560 events.
[13:23:33.550] <TB0> INFO: 2560 events read in total (299ms).
[13:23:33.550] <TB0> INFO: Test took 1158ms.
[13:23:33.552] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:33.856] <TB0> INFO: Expecting 2560 events.
[13:23:34.712] <TB0> INFO: 2560 events read in total (300ms).
[13:23:34.713] <TB0> INFO: Test took 1161ms.
[13:23:34.715] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:35.019] <TB0> INFO: Expecting 2560 events.
[13:23:35.878] <TB0> INFO: 2560 events read in total (303ms).
[13:23:35.878] <TB0> INFO: Test took 1164ms.
[13:23:35.881] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:36.183] <TB0> INFO: Expecting 2560 events.
[13:23:37.038] <TB0> INFO: 2560 events read in total (299ms).
[13:23:37.038] <TB0> INFO: Test took 1158ms.
[13:23:37.041] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:37.344] <TB0> INFO: Expecting 2560 events.
[13:23:38.197] <TB0> INFO: 2560 events read in total (297ms).
[13:23:38.197] <TB0> INFO: Test took 1156ms.
[13:23:38.199] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:38.503] <TB0> INFO: Expecting 2560 events.
[13:23:39.356] <TB0> INFO: 2560 events read in total (297ms).
[13:23:39.356] <TB0> INFO: Test took 1157ms.
[13:23:39.358] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:39.662] <TB0> INFO: Expecting 2560 events.
[13:23:40.515] <TB0> INFO: 2560 events read in total (297ms).
[13:23:40.515] <TB0> INFO: Test took 1158ms.
[13:23:40.517] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:40.820] <TB0> INFO: Expecting 2560 events.
[13:23:41.674] <TB0> INFO: 2560 events read in total (297ms).
[13:23:41.674] <TB0> INFO: Test took 1157ms.
[13:23:41.677] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:41.979] <TB0> INFO: Expecting 2560 events.
[13:23:42.832] <TB0> INFO: 2560 events read in total (297ms).
[13:23:42.833] <TB0> INFO: Test took 1156ms.
[13:23:42.835] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:43.138] <TB0> INFO: Expecting 2560 events.
[13:23:43.992] <TB0> INFO: 2560 events read in total (298ms).
[13:23:43.992] <TB0> INFO: Test took 1157ms.
[13:23:43.995] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:44.298] <TB0> INFO: Expecting 2560 events.
[13:23:45.156] <TB0> INFO: 2560 events read in total (302ms).
[13:23:45.156] <TB0> INFO: Test took 1161ms.
[13:23:45.159] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:45.462] <TB0> INFO: Expecting 2560 events.
[13:23:46.316] <TB0> INFO: 2560 events read in total (298ms).
[13:23:46.316] <TB0> INFO: Test took 1157ms.
[13:23:46.319] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:46.621] <TB0> INFO: Expecting 2560 events.
[13:23:47.479] <TB0> INFO: 2560 events read in total (302ms).
[13:23:47.480] <TB0> INFO: Test took 1161ms.
[13:23:47.483] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:47.786] <TB0> INFO: Expecting 2560 events.
[13:23:48.640] <TB0> INFO: 2560 events read in total (298ms).
[13:23:48.641] <TB0> INFO: Test took 1159ms.
[13:23:48.643] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:48.946] <TB0> INFO: Expecting 2560 events.
[13:23:49.804] <TB0> INFO: 2560 events read in total (302ms).
[13:23:49.804] <TB0> INFO: Test took 1161ms.
[13:23:49.807] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:50.114] <TB0> INFO: Expecting 2560 events.
[13:23:50.967] <TB0> INFO: 2560 events read in total (297ms).
[13:23:50.968] <TB0> INFO: Test took 1161ms.
[13:23:50.971] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:51.273] <TB0> INFO: Expecting 2560 events.
[13:23:52.127] <TB0> INFO: 2560 events read in total (298ms).
[13:23:52.127] <TB0> INFO: Test took 1156ms.
[13:23:52.130] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:52.432] <TB0> INFO: Expecting 2560 events.
[13:23:53.290] <TB0> INFO: 2560 events read in total (302ms).
[13:23:53.291] <TB0> INFO: Test took 1161ms.
[13:23:53.293] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:53.597] <TB0> INFO: Expecting 2560 events.
[13:23:54.454] <TB0> INFO: 2560 events read in total (301ms).
[13:23:54.454] <TB0> INFO: Test took 1162ms.
[13:23:54.456] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:23:54.759] <TB0> INFO: Expecting 2560 events.
[13:23:55.618] <TB0> INFO: 2560 events read in total (302ms).
[13:23:55.618] <TB0> INFO: Test took 1162ms.
[13:23:56.079] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[13:23:56.079] <TB0> INFO: PH scale (per ROC): 83 78 80 80 69 80 90 75 79 80 80 84 75 78 74 95
[13:23:56.079] <TB0> INFO: PH offset (per ROC): 173 180 160 172 183 165 157 150 165 170 158 156 159 165 175 144
[13:23:56.084] <TB0> INFO: Decoding statistics:
[13:23:56.084] <TB0> INFO: General information:
[13:23:56.084] <TB0> INFO: 16bit words read: 91924
[13:23:56.084] <TB0> INFO: valid events total: 10240
[13:23:56.084] <TB0> INFO: empty events: 7739
[13:23:56.084] <TB0> INFO: valid events with pixels: 2501
[13:23:56.084] <TB0> INFO: valid pixel hits: 2501
[13:23:56.084] <TB0> INFO: Event errors: 0
[13:23:56.084] <TB0> INFO: start marker: 0
[13:23:56.084] <TB0> INFO: stop marker: 0
[13:23:56.084] <TB0> INFO: overflow: 0
[13:23:56.085] <TB0> INFO: invalid 5bit words: 0
[13:23:56.085] <TB0> INFO: invalid XOR eye diagram: 0
[13:23:56.085] <TB0> INFO: frame (failed synchr.): 0
[13:23:56.085] <TB0> INFO: idle data (no TBM trl): 0
[13:23:56.085] <TB0> INFO: no data (only TBM hdr): 0
[13:23:56.085] <TB0> INFO: TBM errors: 0
[13:23:56.085] <TB0> INFO: flawed TBM headers: 0
[13:23:56.085] <TB0> INFO: flawed TBM trailers: 0
[13:23:56.085] <TB0> INFO: event ID mismatches: 0
[13:23:56.085] <TB0> INFO: ROC errors: 0
[13:23:56.085] <TB0> INFO: missing ROC header(s): 0
[13:23:56.085] <TB0> INFO: misplaced readback start: 0
[13:23:56.085] <TB0> INFO: Pixel decoding errors: 0
[13:23:56.085] <TB0> INFO: pixel data incomplete: 0
[13:23:56.085] <TB0> INFO: pixel address: 0
[13:23:56.085] <TB0> INFO: pulse height fill bit: 0
[13:23:56.085] <TB0> INFO: buffer corruption: 0
[13:23:56.272] <TB0> INFO: ######################################################################
[13:23:56.272] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[13:23:56.272] <TB0> INFO: ######################################################################
[13:23:56.283] <TB0> INFO: scanning low vcal = 10
[13:23:56.556] <TB0> INFO: Expecting 41600 events.
[13:24:00.106] <TB0> INFO: 41600 events read in total (2994ms).
[13:24:00.107] <TB0> INFO: Test took 3824ms.
[13:24:00.109] <TB0> INFO: scanning low vcal = 20
[13:24:00.412] <TB0> INFO: Expecting 41600 events.
[13:24:03.972] <TB0> INFO: 41600 events read in total (3004ms).
[13:24:03.972] <TB0> INFO: Test took 3863ms.
[13:24:03.974] <TB0> INFO: scanning low vcal = 30
[13:24:04.278] <TB0> INFO: Expecting 41600 events.
[13:24:07.820] <TB0> INFO: 41600 events read in total (2985ms).
[13:24:07.821] <TB0> INFO: Test took 3847ms.
[13:24:07.823] <TB0> INFO: scanning low vcal = 40
[13:24:08.119] <TB0> INFO: Expecting 41600 events.
[13:24:12.238] <TB0> INFO: 41600 events read in total (3563ms).
[13:24:12.240] <TB0> INFO: Test took 4417ms.
[13:24:12.242] <TB0> INFO: scanning low vcal = 50
[13:24:12.523] <TB0> INFO: Expecting 41600 events.
[13:24:16.726] <TB0> INFO: 41600 events read in total (3647ms).
[13:24:16.726] <TB0> INFO: Test took 4484ms.
[13:24:16.729] <TB0> INFO: scanning low vcal = 60
[13:24:16.989] <TB0> INFO: Expecting 41600 events.
[13:24:21.180] <TB0> INFO: 41600 events read in total (3634ms).
[13:24:21.181] <TB0> INFO: Test took 4452ms.
[13:24:21.183] <TB0> INFO: scanning low vcal = 70
[13:24:21.449] <TB0> INFO: Expecting 41600 events.
[13:24:25.627] <TB0> INFO: 41600 events read in total (3622ms).
[13:24:25.628] <TB0> INFO: Test took 4445ms.
[13:24:25.630] <TB0> INFO: scanning low vcal = 80
[13:24:25.898] <TB0> INFO: Expecting 41600 events.
[13:24:30.060] <TB0> INFO: 41600 events read in total (3605ms).
[13:24:30.060] <TB0> INFO: Test took 4430ms.
[13:24:30.063] <TB0> INFO: scanning low vcal = 90
[13:24:30.322] <TB0> INFO: Expecting 41600 events.
[13:24:34.482] <TB0> INFO: 41600 events read in total (3604ms).
[13:24:34.482] <TB0> INFO: Test took 4419ms.
[13:24:34.485] <TB0> INFO: scanning low vcal = 100
[13:24:34.745] <TB0> INFO: Expecting 41600 events.
[13:24:38.904] <TB0> INFO: 41600 events read in total (3603ms).
[13:24:38.905] <TB0> INFO: Test took 4420ms.
[13:24:38.907] <TB0> INFO: scanning low vcal = 110
[13:24:39.170] <TB0> INFO: Expecting 41600 events.
[13:24:43.330] <TB0> INFO: 41600 events read in total (3604ms).
[13:24:43.330] <TB0> INFO: Test took 4423ms.
[13:24:43.333] <TB0> INFO: scanning low vcal = 120
[13:24:43.592] <TB0> INFO: Expecting 41600 events.
[13:24:47.754] <TB0> INFO: 41600 events read in total (3606ms).
[13:24:47.754] <TB0> INFO: Test took 4421ms.
[13:24:47.757] <TB0> INFO: scanning low vcal = 130
[13:24:48.024] <TB0> INFO: Expecting 41600 events.
[13:24:52.202] <TB0> INFO: 41600 events read in total (3622ms).
[13:24:52.202] <TB0> INFO: Test took 4445ms.
[13:24:52.205] <TB0> INFO: scanning low vcal = 140
[13:24:52.470] <TB0> INFO: Expecting 41600 events.
[13:24:56.679] <TB0> INFO: 41600 events read in total (3653ms).
[13:24:56.680] <TB0> INFO: Test took 4475ms.
[13:24:56.682] <TB0> INFO: scanning low vcal = 150
[13:24:56.951] <TB0> INFO: Expecting 41600 events.
[13:25:01.182] <TB0> INFO: 41600 events read in total (3674ms).
[13:25:01.182] <TB0> INFO: Test took 4499ms.
[13:25:01.185] <TB0> INFO: scanning low vcal = 160
[13:25:01.448] <TB0> INFO: Expecting 41600 events.
[13:25:05.673] <TB0> INFO: 41600 events read in total (3669ms).
[13:25:05.674] <TB0> INFO: Test took 4489ms.
[13:25:05.676] <TB0> INFO: scanning low vcal = 170
[13:25:05.952] <TB0> INFO: Expecting 41600 events.
[13:25:10.160] <TB0> INFO: 41600 events read in total (3652ms).
[13:25:10.161] <TB0> INFO: Test took 4485ms.
[13:25:10.165] <TB0> INFO: scanning low vcal = 180
[13:25:10.434] <TB0> INFO: Expecting 41600 events.
[13:25:14.640] <TB0> INFO: 41600 events read in total (3650ms).
[13:25:14.641] <TB0> INFO: Test took 4476ms.
[13:25:14.643] <TB0> INFO: scanning low vcal = 190
[13:25:14.906] <TB0> INFO: Expecting 41600 events.
[13:25:19.123] <TB0> INFO: 41600 events read in total (3661ms).
[13:25:19.125] <TB0> INFO: Test took 4482ms.
[13:25:19.127] <TB0> INFO: scanning low vcal = 200
[13:25:19.395] <TB0> INFO: Expecting 41600 events.
[13:25:23.599] <TB0> INFO: 41600 events read in total (3648ms).
[13:25:23.599] <TB0> INFO: Test took 4472ms.
[13:25:23.602] <TB0> INFO: scanning low vcal = 210
[13:25:23.862] <TB0> INFO: Expecting 41600 events.
[13:25:28.053] <TB0> INFO: 41600 events read in total (3635ms).
[13:25:28.053] <TB0> INFO: Test took 4451ms.
[13:25:28.056] <TB0> INFO: scanning low vcal = 220
[13:25:28.315] <TB0> INFO: Expecting 41600 events.
[13:25:32.538] <TB0> INFO: 41600 events read in total (3667ms).
[13:25:32.538] <TB0> INFO: Test took 4482ms.
[13:25:32.541] <TB0> INFO: scanning low vcal = 230
[13:25:32.807] <TB0> INFO: Expecting 41600 events.
[13:25:37.042] <TB0> INFO: 41600 events read in total (3679ms).
[13:25:37.042] <TB0> INFO: Test took 4501ms.
[13:25:37.045] <TB0> INFO: scanning low vcal = 240
[13:25:37.318] <TB0> INFO: Expecting 41600 events.
[13:25:41.525] <TB0> INFO: 41600 events read in total (3651ms).
[13:25:41.526] <TB0> INFO: Test took 4481ms.
[13:25:41.528] <TB0> INFO: scanning low vcal = 250
[13:25:41.798] <TB0> INFO: Expecting 41600 events.
[13:25:45.999] <TB0> INFO: 41600 events read in total (3645ms).
[13:25:46.000] <TB0> INFO: Test took 4472ms.
[13:25:46.003] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[13:25:46.275] <TB0> INFO: Expecting 41600 events.
[13:25:50.489] <TB0> INFO: 41600 events read in total (3658ms).
[13:25:50.490] <TB0> INFO: Test took 4486ms.
[13:25:50.492] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[13:25:50.762] <TB0> INFO: Expecting 41600 events.
[13:25:54.942] <TB0> INFO: 41600 events read in total (3624ms).
[13:25:54.942] <TB0> INFO: Test took 4450ms.
[13:25:54.945] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[13:25:55.230] <TB0> INFO: Expecting 41600 events.
[13:25:59.393] <TB0> INFO: 41600 events read in total (3607ms).
[13:25:59.394] <TB0> INFO: Test took 4449ms.
[13:25:59.396] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[13:25:59.660] <TB0> INFO: Expecting 41600 events.
[13:26:03.838] <TB0> INFO: 41600 events read in total (3622ms).
[13:26:03.839] <TB0> INFO: Test took 4443ms.
[13:26:03.841] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[13:26:04.129] <TB0> INFO: Expecting 41600 events.
[13:26:08.307] <TB0> INFO: 41600 events read in total (3622ms).
[13:26:08.308] <TB0> INFO: Test took 4466ms.
[13:26:08.828] <TB0> INFO: PixTestGainPedestal::measure() done
[13:26:41.391] <TB0> INFO: PixTestGainPedestal::fit() done
[13:26:41.391] <TB0> INFO: non-linearity mean: 0.958 0.959 0.950 0.959 0.952 0.951 0.955 0.955 0.953 0.957 0.957 0.954 0.961 0.955 0.951 0.955
[13:26:41.391] <TB0> INFO: non-linearity RMS: 0.005 0.007 0.006 0.006 0.007 0.005 0.006 0.006 0.006 0.006 0.005 0.006 0.006 0.006 0.006 0.006
[13:26:41.391] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[13:26:41.409] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[13:26:41.427] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[13:26:41.445] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[13:26:41.462] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[13:26:41.480] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[13:26:41.497] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[13:26:41.515] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[13:26:41.533] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[13:26:41.551] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[13:26:41.568] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[13:26:41.586] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[13:26:41.604] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[13:26:41.623] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[13:26:41.641] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[13:26:41.659] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[13:26:41.676] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[13:26:41.676] <TB0> INFO: Decoding statistics:
[13:26:41.676] <TB0> INFO: General information:
[13:26:41.676] <TB0> INFO: 16bit words read: 2662400
[13:26:41.676] <TB0> INFO: valid events total: 166400
[13:26:41.676] <TB0> INFO: empty events: 0
[13:26:41.676] <TB0> INFO: valid events with pixels: 166400
[13:26:41.676] <TB0> INFO: valid pixel hits: 665571
[13:26:41.676] <TB0> INFO: Event errors: 0
[13:26:41.676] <TB0> INFO: start marker: 0
[13:26:41.676] <TB0> INFO: stop marker: 0
[13:26:41.677] <TB0> INFO: overflow: 0
[13:26:41.677] <TB0> INFO: invalid 5bit words: 0
[13:26:41.677] <TB0> INFO: invalid XOR eye diagram: 0
[13:26:41.677] <TB0> INFO: frame (failed synchr.): 0
[13:26:41.677] <TB0> INFO: idle data (no TBM trl): 0
[13:26:41.677] <TB0> INFO: no data (only TBM hdr): 0
[13:26:41.677] <TB0> INFO: TBM errors: 0
[13:26:41.677] <TB0> INFO: flawed TBM headers: 0
[13:26:41.677] <TB0> INFO: flawed TBM trailers: 0
[13:26:41.677] <TB0> INFO: event ID mismatches: 0
[13:26:41.677] <TB0> INFO: ROC errors: 0
[13:26:41.677] <TB0> INFO: missing ROC header(s): 0
[13:26:41.677] <TB0> INFO: misplaced readback start: 0
[13:26:41.677] <TB0> INFO: Pixel decoding errors: 0
[13:26:41.677] <TB0> INFO: pixel data incomplete: 0
[13:26:41.677] <TB0> INFO: pixel address: 0
[13:26:41.677] <TB0> INFO: pulse height fill bit: 0
[13:26:41.677] <TB0> INFO: buffer corruption: 0
[13:26:41.684] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C15.dat
[13:26:41.685] <TB0> INFO: ######################################################################
[13:26:41.685] <TB0> INFO: PixTestReadback::doTest()
[13:26:41.685] <TB0> INFO: ######################################################################
[13:26:41.685] <TB0> INFO: ----------------------------------------------------------------------
[13:26:41.685] <TB0> INFO: PixTestReadback::CalibrateVd()
[13:26:41.685] <TB0> INFO: ----------------------------------------------------------------------
[13:26:51.178] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C0.dat
[13:26:51.178] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C1.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C2.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C3.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C4.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C5.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C6.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C7.dat
[13:26:51.179] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C8.dat
[13:26:51.180] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C9.dat
[13:26:51.180] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C10.dat
[13:26:51.180] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C11.dat
[13:26:51.180] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C12.dat
[13:26:51.180] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C13.dat
[13:26:51.181] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C14.dat
[13:26:51.181] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C15.dat
[13:26:51.218] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:26:51.218] <TB0> INFO: ----------------------------------------------------------------------
[13:26:51.218] <TB0> INFO: PixTestReadback::CalibrateVa()
[13:26:51.218] <TB0> INFO: ----------------------------------------------------------------------
[13:27:00.701] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C0.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C1.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C2.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C3.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C4.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C5.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C6.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C7.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C8.dat
[13:27:00.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C9.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C10.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C11.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C12.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C13.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C14.dat
[13:27:00.722] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C15.dat
[13:27:00.751] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:27:00.751] <TB0> INFO: ----------------------------------------------------------------------
[13:27:00.751] <TB0> INFO: PixTestReadback::readbackVbg()
[13:27:00.751] <TB0> INFO: ----------------------------------------------------------------------
[13:27:08.042] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:27:08.042] <TB0> INFO: ----------------------------------------------------------------------
[13:27:08.042] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[13:27:08.042] <TB0> INFO: ----------------------------------------------------------------------
[13:27:08.042] <TB0> INFO: Vbg will be calibrated using Vd calibration
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 163.3calibrated Vbg = 1.20093 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 170.1calibrated Vbg = 1.19933 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 149.3calibrated Vbg = 1.20969 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 161.7calibrated Vbg = 1.22147 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 160calibrated Vbg = 1.21761 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 161calibrated Vbg = 1.22711 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 143.7calibrated Vbg = 1.22408 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 148.9calibrated Vbg = 1.2256 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 144.9calibrated Vbg = 1.22233 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 150.2calibrated Vbg = 1.22297 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 162.9calibrated Vbg = 1.21765 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 158.9calibrated Vbg = 1.21345 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 148.8calibrated Vbg = 1.20422 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 153.2calibrated Vbg = 1.20755 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 159.4calibrated Vbg = 1.21562 :::*/*/*/*/
[13:27:08.042] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 156.4calibrated Vbg = 1.21276 :::*/*/*/*/
[13:27:08.044] <TB0> INFO: ----------------------------------------------------------------------
[13:27:08.044] <TB0> INFO: PixTestReadback::CalibrateIa()
[13:27:08.044] <TB0> INFO: ----------------------------------------------------------------------
[13:29:43.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C0.dat
[13:29:43.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C1.dat
[13:29:43.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C2.dat
[13:29:43.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C3.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C4.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C5.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C6.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C7.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C8.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C9.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C10.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C11.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C12.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C13.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C14.dat
[13:29:43.411] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2233_FullQualification_2016-05-11_11h13m_1462957992//002_FulltestPxar_m20//readbackCal_C15.dat
[13:29:43.439] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:29:43.441] <TB0> INFO: PixTestReadback::doTest() done
[13:29:43.441] <TB0> INFO: Decoding statistics:
[13:29:43.441] <TB0> INFO: General information:
[13:29:43.441] <TB0> INFO: 16bit words read: 1024
[13:29:43.441] <TB0> INFO: valid events total: 128
[13:29:43.441] <TB0> INFO: empty events: 128
[13:29:43.441] <TB0> INFO: valid events with pixels: 0
[13:29:43.441] <TB0> INFO: valid pixel hits: 0
[13:29:43.441] <TB0> INFO: Event errors: 0
[13:29:43.441] <TB0> INFO: start marker: 0
[13:29:43.441] <TB0> INFO: stop marker: 0
[13:29:43.441] <TB0> INFO: overflow: 0
[13:29:43.441] <TB0> INFO: invalid 5bit words: 0
[13:29:43.441] <TB0> INFO: invalid XOR eye diagram: 0
[13:29:43.441] <TB0> INFO: frame (failed synchr.): 0
[13:29:43.441] <TB0> INFO: idle data (no TBM trl): 0
[13:29:43.441] <TB0> INFO: no data (only TBM hdr): 0
[13:29:43.441] <TB0> INFO: TBM errors: 0
[13:29:43.441] <TB0> INFO: flawed TBM headers: 0
[13:29:43.441] <TB0> INFO: flawed TBM trailers: 0
[13:29:43.441] <TB0> INFO: event ID mismatches: 0
[13:29:43.441] <TB0> INFO: ROC errors: 0
[13:29:43.441] <TB0> INFO: missing ROC header(s): 0
[13:29:43.441] <TB0> INFO: misplaced readback start: 0
[13:29:43.441] <TB0> INFO: Pixel decoding errors: 0
[13:29:43.441] <TB0> INFO: pixel data incomplete: 0
[13:29:43.441] <TB0> INFO: pixel address: 0
[13:29:43.441] <TB0> INFO: pulse height fill bit: 0
[13:29:43.441] <TB0> INFO: buffer corruption: 0
[13:29:43.463] <TB0> INFO: Decoding statistics:
[13:29:43.463] <TB0> INFO: General information:
[13:29:43.463] <TB0> INFO: 16bit words read: 2755348
[13:29:43.463] <TB0> INFO: valid events total: 176768
[13:29:43.463] <TB0> INFO: empty events: 7867
[13:29:43.463] <TB0> INFO: valid events with pixels: 168901
[13:29:43.463] <TB0> INFO: valid pixel hits: 668072
[13:29:43.463] <TB0> INFO: Event errors: 0
[13:29:43.463] <TB0> INFO: start marker: 0
[13:29:43.463] <TB0> INFO: stop marker: 0
[13:29:43.463] <TB0> INFO: overflow: 0
[13:29:43.463] <TB0> INFO: invalid 5bit words: 0
[13:29:43.463] <TB0> INFO: invalid XOR eye diagram: 0
[13:29:43.463] <TB0> INFO: frame (failed synchr.): 0
[13:29:43.463] <TB0> INFO: idle data (no TBM trl): 0
[13:29:43.463] <TB0> INFO: no data (only TBM hdr): 0
[13:29:43.463] <TB0> INFO: TBM errors: 0
[13:29:43.463] <TB0> INFO: flawed TBM headers: 0
[13:29:43.463] <TB0> INFO: flawed TBM trailers: 0
[13:29:43.463] <TB0> INFO: event ID mismatches: 0
[13:29:43.463] <TB0> INFO: ROC errors: 0
[13:29:43.463] <TB0> INFO: missing ROC header(s): 0
[13:29:43.463] <TB0> INFO: misplaced readback start: 0
[13:29:43.463] <TB0> INFO: Pixel decoding errors: 0
[13:29:43.463] <TB0> INFO: pixel data incomplete: 0
[13:29:43.463] <TB0> INFO: pixel address: 0
[13:29:43.463] <TB0> INFO: pulse height fill bit: 0
[13:29:43.463] <TB0> INFO: buffer corruption: 0
[13:29:43.463] <TB0> INFO: enter test to run
[13:29:43.463] <TB0> INFO: test: exit no parameter change
[13:29:43.590] <TB0> QUIET: Connection to board 73 closed.
[13:29:43.670] <TB0> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master