[16:55:10.294] <TB1> INFO: *** Welcome to pxar ***
[16:55:10.294] <TB1> INFO: *** Today: 2016/05/10
[16:55:10.395] <TB1> INFO: *** Version: 9751-dirty
[16:55:10.395] <TB1> INFO: readRocDacs: /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C15.dat
[16:55:10.395] <TB1> INFO: readTbmDacs: /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//tbmParameters_C0b.dat
[16:55:10.396] <TB1> INFO: readMaskFile: /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//defaultMaskFile.dat
[16:55:10.396] <TB1> INFO: readTrimFile: /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters_C15.dat
[16:55:10.464] <TB1> INFO: clk: 4
[16:55:10.464] <TB1> INFO: ctr: 4
[16:55:10.464] <TB1> INFO: sda: 19
[16:55:10.464] <TB1> INFO: tin: 9
[16:55:10.464] <TB1> INFO: level: 15
[16:55:10.464] <TB1> INFO: triggerdelay: 0
[16:55:10.464] <TB1> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[16:55:10.464] <TB1> INFO: Log level: INFO
[16:55:10.471] <TB1> INFO: Found DTB DTB_WXBYFL
[16:55:10.480] <TB1> QUIET: Connection to board DTB_WXBYFL opened.
[16:55:10.482] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 153
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXBYFL
MAC address: 40D855118099
Hostname: pixelDTB153
Comment:
------------------------------------------------------
[16:55:10.483] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:55:12.027] <TB1> INFO: DUT info:
[16:55:12.027] <TB1> INFO: The DUT currently contains the following objects:
[16:55:12.027] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:55:12.027] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:55:12.027] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:55:12.027] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:55:12.027] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.027] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.028] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:55:12.429] <TB1> INFO: enter 'restricted' command line mode
[16:55:12.429] <TB1> INFO: enter test to run
[16:55:12.430] <TB1> INFO: test: pretest no parameter change
[16:55:12.430] <TB1> INFO: running: pretest
[16:55:12.439] <TB1> INFO: ----------------------------------------------------------------------
[16:55:12.440] <TB1> INFO: PixTestPretest::programROC()
[16:55:12.440] <TB1> INFO: ----------------------------------------------------------------------
[16:55:30.455] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[16:55:30.455] <TB1> INFO: IA differences per ROC: 17.7 18.5 18.5 17.7 18.5 16.9 18.5 19.3 18.5 18.5 17.7 18.5 17.7 19.3 18.5 18.5
[16:55:30.550] <TB1> INFO: enter test to run
[16:55:30.551] <TB1> INFO: test: pretest no parameter change
[16:55:30.551] <TB1> INFO: running: pretest
[16:55:30.552] <TB1> INFO: ----------------------------------------------------------------------
[16:55:30.552] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[16:55:30.552] <TB1> INFO: ----------------------------------------------------------------------
[16:55:51.816] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 396.3 mA = 24.7688 mA/ROC
[16:55:51.816] <TB1> INFO: i(loss) [mA/ROC]: 20.1 19.3 20.1 20.1 20.1 20.1 20.1 20.1 20.1 19.3 20.1 20.1 19.3 20.1 19.3 19.3
[16:55:51.842] <TB1> INFO: enter test to run
[16:55:51.842] <TB1> INFO: test: pretest no parameter change
[16:55:51.842] <TB1> INFO: running: pretest
[16:55:51.842] <TB1> INFO: ----------------------------------------------------------------------
[16:55:51.842] <TB1> INFO: PixTestPretest::findTiming()
[16:55:51.842] <TB1> INFO: ----------------------------------------------------------------------
[16:55:51.842] <TB1> INFO: PixTestCmd::init()

[16:57:21.354] <TB1> INFO: TBM phases: 160MHz: 0, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[16:57:21.354] <TB1> INFO: (success/tries = 100/100), width = 4
[16:57:21.355] <TB1> INFO: enter test to run
[16:57:21.355] <TB1> INFO: test: pretest no parameter change
[16:57:21.355] <TB1> INFO: running: pretest
[16:57:21.356] <TB1> INFO: ----------------------------------------------------------------------
[16:57:21.356] <TB1> INFO: PixTestPretest::findWorkingPixel()
[16:57:21.356] <TB1> INFO: ----------------------------------------------------------------------
[16:57:21.451] <TB1> INFO: Expecting 231680 events.


[16:57:31.722] <TB1> INFO: 231680 events read in total (9715ms).
[16:57:31.726] <TB1> INFO: Test took 10364ms.
[16:57:31.966] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[16:57:32.051] <TB1> INFO: enter test to run
[16:57:32.051] <TB1> INFO: test: pretest no parameter change
[16:57:32.051] <TB1> INFO: running: pretest
[16:57:32.052] <TB1> INFO: ----------------------------------------------------------------------
[16:57:32.052] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[16:57:32.052] <TB1> INFO: ----------------------------------------------------------------------
[16:57:32.144] <TB1> INFO: Expecting 231680 events.
[16:57:42.334] <TB1> INFO: 231680 events read in total (9634ms).
[16:57:42.338] <TB1> INFO: Test took 10282ms.
[16:57:42.590] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[16:57:42.590] <TB1> INFO: CalDel: 150 139 126 128 114 131 131 143 120 138 129 123 138 142 132 122
[16:57:42.590] <TB1> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[16:57:42.628] <TB1> INFO: enter test to run
[16:57:42.628] <TB1> INFO: test: pretest no parameter change
[16:57:42.628] <TB1> INFO: running: pretest
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C0.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C1.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C2.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C3.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C4.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C5.dat
[16:57:42.628] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C6.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C7.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C8.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C9.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C10.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C11.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C12.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C13.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C14.dat
[16:57:42.629] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters_C15.dat
[16:57:42.629] <TB1> INFO: enter test to run
[16:57:42.629] <TB1> INFO: test: fulltest no parameter change
[16:57:42.629] <TB1> INFO: running: fulltest
[16:57:42.630] <TB1> INFO: ######################################################################
[16:57:42.630] <TB1> INFO: PixTestFullTest::doTest()
[16:57:42.630] <TB1> INFO: ######################################################################
[16:57:42.631] <TB1> INFO: ######################################################################
[16:57:42.631] <TB1> INFO: PixTestAlive::doTest()
[16:57:42.631] <TB1> INFO: ######################################################################
[16:57:42.632] <TB1> INFO: ----------------------------------------------------------------------
[16:57:42.632] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:57:42.632] <TB1> INFO: ----------------------------------------------------------------------
[16:57:42.894] <TB1> INFO: Expecting 41600 events.
[16:57:46.732] <TB1> INFO: 41600 events read in total (3281ms).
[16:57:46.732] <TB1> INFO: Test took 4099ms.
[16:57:46.965] <TB1> INFO: PixTestAlive::aliveTest() done
[16:57:46.965] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:57:46.966] <TB1> INFO: ----------------------------------------------------------------------
[16:57:46.967] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:57:46.967] <TB1> INFO: ----------------------------------------------------------------------
[16:57:47.266] <TB1> INFO: Expecting 41600 events.
[16:57:50.228] <TB1> INFO: 41600 events read in total (2406ms).
[16:57:50.228] <TB1> INFO: Test took 3260ms.
[16:57:50.229] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:57:50.473] <TB1> INFO: PixTestAlive::maskTest() done
[16:57:50.473] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:57:50.474] <TB1> INFO: ----------------------------------------------------------------------
[16:57:50.474] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:57:50.474] <TB1> INFO: ----------------------------------------------------------------------
[16:57:50.735] <TB1> INFO: Expecting 41600 events.
[16:57:54.585] <TB1> INFO: 41600 events read in total (3294ms).
[16:57:54.585] <TB1> INFO: Test took 4110ms.
[16:57:54.815] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:57:54.815] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:57:54.815] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[16:57:54.815] <TB1> INFO: Decoding statistics:
[16:57:54.815] <TB1> INFO: General information:
[16:57:54.815] <TB1> INFO: 16bit words read: 0
[16:57:54.815] <TB1> INFO: valid events total: 0
[16:57:54.815] <TB1> INFO: empty events: 0
[16:57:54.815] <TB1> INFO: valid events with pixels: 0
[16:57:54.815] <TB1> INFO: valid pixel hits: 0
[16:57:54.815] <TB1> INFO: Event errors: 0
[16:57:54.815] <TB1> INFO: start marker: 0
[16:57:54.815] <TB1> INFO: stop marker: 0
[16:57:54.815] <TB1> INFO: overflow: 0
[16:57:54.815] <TB1> INFO: invalid 5bit words: 0
[16:57:54.815] <TB1> INFO: invalid XOR eye diagram: 0
[16:57:54.815] <TB1> INFO: frame (failed synchr.): 0
[16:57:54.815] <TB1> INFO: idle data (no TBM trl): 0
[16:57:54.815] <TB1> INFO: no data (only TBM hdr): 0
[16:57:54.815] <TB1> INFO: TBM errors: 0
[16:57:54.815] <TB1> INFO: flawed TBM headers: 0
[16:57:54.815] <TB1> INFO: flawed TBM trailers: 0
[16:57:54.815] <TB1> INFO: event ID mismatches: 0
[16:57:54.815] <TB1> INFO: ROC errors: 0
[16:57:54.815] <TB1> INFO: missing ROC header(s): 0
[16:57:54.815] <TB1> INFO: misplaced readback start: 0
[16:57:54.815] <TB1> INFO: Pixel decoding errors: 0
[16:57:54.815] <TB1> INFO: pixel data incomplete: 0
[16:57:54.815] <TB1> INFO: pixel address: 0
[16:57:54.815] <TB1> INFO: pulse height fill bit: 0
[16:57:54.815] <TB1> INFO: buffer corruption: 0
[16:57:54.829] <TB1> INFO: ######################################################################
[16:57:54.829] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[16:57:54.829] <TB1> INFO: ######################################################################
[16:57:54.831] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[16:57:54.842] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[16:57:54.842] <TB1> INFO: run 1 of 1
[16:57:55.113] <TB1> INFO: Expecting 3120000 events.
[16:58:37.205] <TB1> INFO: 880355 events read in total (41536ms).
[16:59:18.118] <TB1> INFO: 1749840 events read in total (82450ms).
[16:59:59.610] <TB1> INFO: 2626860 events read in total (123943ms).
[17:00:22.581] <TB1> INFO: 3120000 events read in total (146912ms).
[17:00:22.631] <TB1> INFO: Test took 147789ms.
[17:00:46.204] <TB1> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[17:00:46.204] <TB1> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[17:00:46.204] <TB1> INFO: separation cut (per ROC): 90 106 103 106 106 90 90 95 107 98 88 91 104 105 99 106
[17:00:46.204] <TB1> INFO: Decoding statistics:
[17:00:46.204] <TB1> INFO: General information:
[17:00:46.204] <TB1> INFO: 16bit words read: 0
[17:00:46.204] <TB1> INFO: valid events total: 0
[17:00:46.204] <TB1> INFO: empty events: 0
[17:00:46.204] <TB1> INFO: valid events with pixels: 0
[17:00:46.204] <TB1> INFO: valid pixel hits: 0
[17:00:46.204] <TB1> INFO: Event errors: 0
[17:00:46.204] <TB1> INFO: start marker: 0
[17:00:46.204] <TB1> INFO: stop marker: 0
[17:00:46.204] <TB1> INFO: overflow: 0
[17:00:46.204] <TB1> INFO: invalid 5bit words: 0
[17:00:46.204] <TB1> INFO: invalid XOR eye diagram: 0
[17:00:46.204] <TB1> INFO: frame (failed synchr.): 0
[17:00:46.204] <TB1> INFO: idle data (no TBM trl): 0
[17:00:46.204] <TB1> INFO: no data (only TBM hdr): 0
[17:00:46.204] <TB1> INFO: TBM errors: 0
[17:00:46.204] <TB1> INFO: flawed TBM headers: 0
[17:00:46.204] <TB1> INFO: flawed TBM trailers: 0
[17:00:46.204] <TB1> INFO: event ID mismatches: 0
[17:00:46.204] <TB1> INFO: ROC errors: 0
[17:00:46.204] <TB1> INFO: missing ROC header(s): 0
[17:00:46.204] <TB1> INFO: misplaced readback start: 0
[17:00:46.204] <TB1> INFO: Pixel decoding errors: 0
[17:00:46.204] <TB1> INFO: pixel data incomplete: 0
[17:00:46.204] <TB1> INFO: pixel address: 0
[17:00:46.204] <TB1> INFO: pulse height fill bit: 0
[17:00:46.204] <TB1> INFO: buffer corruption: 0
[17:00:46.308] <TB1> INFO: ######################################################################
[17:00:46.308] <TB1> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[17:00:46.308] <TB1> INFO: ######################################################################
[17:00:46.309] <TB1> INFO: ----------------------------------------------------------------------
[17:00:46.309] <TB1> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[17:00:46.309] <TB1> INFO: ----------------------------------------------------------------------
[17:00:46.309] <TB1> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[17:00:46.320] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[17:00:46.320] <TB1> INFO: run 1 of 1
[17:00:46.663] <TB1> INFO: Expecting 26208000 events.
[17:01:21.536] <TB1> INFO: 979450 events read in total (34314ms).
[17:01:55.249] <TB1> INFO: 1937200 events read in total (68027ms).
[17:02:29.013] <TB1> INFO: 2895000 events read in total (101791ms).
[17:03:02.614] <TB1> INFO: 3851050 events read in total (135392ms).
[17:03:36.723] <TB1> INFO: 4806350 events read in total (169501ms).
[17:04:10.318] <TB1> INFO: 5760050 events read in total (203096ms).
[17:04:43.977] <TB1> INFO: 6714050 events read in total (236755ms).
[17:05:17.973] <TB1> INFO: 7664550 events read in total (270751ms).
[17:05:52.154] <TB1> INFO: 8612500 events read in total (304932ms).
[17:06:26.256] <TB1> INFO: 9562350 events read in total (339034ms).
[17:06:59.925] <TB1> INFO: 10507300 events read in total (372703ms).
[17:07:33.652] <TB1> INFO: 11452750 events read in total (406430ms).
[17:08:07.557] <TB1> INFO: 12400050 events read in total (440335ms).
[17:08:41.192] <TB1> INFO: 13340950 events read in total (473970ms).
[17:09:14.902] <TB1> INFO: 14273800 events read in total (507680ms).
[17:09:48.897] <TB1> INFO: 15206950 events read in total (541675ms).
[17:10:22.248] <TB1> INFO: 16136600 events read in total (575026ms).
[17:10:55.720] <TB1> INFO: 17064800 events read in total (608498ms).
[17:11:29.642] <TB1> INFO: 17992750 events read in total (642420ms).
[17:12:03.354] <TB1> INFO: 18922900 events read in total (676132ms).
[17:12:36.927] <TB1> INFO: 19849950 events read in total (709705ms).
[17:13:11.046] <TB1> INFO: 20777000 events read in total (743824ms).
[17:13:44.709] <TB1> INFO: 21705300 events read in total (777487ms).
[17:14:18.388] <TB1> INFO: 22629950 events read in total (811166ms).
[17:14:51.890] <TB1> INFO: 23560250 events read in total (844668ms).
[17:15:25.088] <TB1> INFO: 24489800 events read in total (877866ms).
[17:15:58.863] <TB1> INFO: 25420850 events read in total (911641ms).
[17:16:26.831] <TB1> INFO: 26208000 events read in total (939609ms).
[17:16:26.858] <TB1> INFO: Test took 940538ms.
[17:16:27.078] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:28.476] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:29.972] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:31.401] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:32.869] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:34.315] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:35.779] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:37.281] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:38.705] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:40.114] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:41.551] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:42.952] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:44.326] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:45.666] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:46.991] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:48.355] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[17:16:49.753] <TB1> INFO: PixTestScurves::scurves() done
[17:16:49.753] <TB1> INFO: Vcal mean: 102.13 104.23 106.16 101.25 103.51 95.98 92.60 104.03 103.28 109.75 91.30 94.31 103.14 112.16 103.11 105.20
[17:16:49.753] <TB1> INFO: Vcal RMS: 5.34 5.43 5.42 6.00 5.41 5.09 5.45 4.92 5.98 5.78 4.76 4.78 5.56 5.05 5.24 5.59
[17:16:49.753] <TB1> INFO: PixTestScurves::fullTest() done, duration: 963 seconds
[17:16:49.753] <TB1> INFO: Decoding statistics:
[17:16:49.753] <TB1> INFO: General information:
[17:16:49.753] <TB1> INFO: 16bit words read: 0
[17:16:49.753] <TB1> INFO: valid events total: 0
[17:16:49.753] <TB1> INFO: empty events: 0
[17:16:49.753] <TB1> INFO: valid events with pixels: 0
[17:16:49.753] <TB1> INFO: valid pixel hits: 0
[17:16:49.753] <TB1> INFO: Event errors: 0
[17:16:49.753] <TB1> INFO: start marker: 0
[17:16:49.753] <TB1> INFO: stop marker: 0
[17:16:49.753] <TB1> INFO: overflow: 0
[17:16:49.753] <TB1> INFO: invalid 5bit words: 0
[17:16:49.753] <TB1> INFO: invalid XOR eye diagram: 0
[17:16:49.753] <TB1> INFO: frame (failed synchr.): 0
[17:16:49.753] <TB1> INFO: idle data (no TBM trl): 0
[17:16:49.753] <TB1> INFO: no data (only TBM hdr): 0
[17:16:49.753] <TB1> INFO: TBM errors: 0
[17:16:49.753] <TB1> INFO: flawed TBM headers: 0
[17:16:49.753] <TB1> INFO: flawed TBM trailers: 0
[17:16:49.753] <TB1> INFO: event ID mismatches: 0
[17:16:49.753] <TB1> INFO: ROC errors: 0
[17:16:49.753] <TB1> INFO: missing ROC header(s): 0
[17:16:49.753] <TB1> INFO: misplaced readback start: 0
[17:16:49.753] <TB1> INFO: Pixel decoding errors: 0
[17:16:49.753] <TB1> INFO: pixel data incomplete: 0
[17:16:49.753] <TB1> INFO: pixel address: 0
[17:16:49.753] <TB1> INFO: pulse height fill bit: 0
[17:16:49.753] <TB1> INFO: buffer corruption: 0
[17:16:49.823] <TB1> INFO: ######################################################################
[17:16:49.823] <TB1> INFO: PixTestTrim::doTest()
[17:16:49.823] <TB1> INFO: ######################################################################
[17:16:49.824] <TB1> INFO: ----------------------------------------------------------------------
[17:16:49.824] <TB1> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[17:16:49.824] <TB1> INFO: ----------------------------------------------------------------------
[17:16:49.902] <TB1> INFO: ---> VthrComp thr map (minimal VthrComp)
[17:16:49.902] <TB1> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[17:16:49.910] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:16:49.910] <TB1> INFO: run 1 of 1
[17:16:50.170] <TB1> INFO: Expecting 6281600 events.
[17:17:30.759] <TB1> INFO: 1085200 events read in total (40032ms).
[17:18:09.792] <TB1> INFO: 2164330 events read in total (79065ms).
[17:18:49.330] <TB1> INFO: 3237330 events read in total (118603ms).
[17:19:28.493] <TB1> INFO: 4314880 events read in total (157766ms).
[17:20:08.001] <TB1> INFO: 5394530 events read in total (197274ms).
[17:20:40.517] <TB1> INFO: 6281600 events read in total (229790ms).
[17:20:40.557] <TB1> INFO: Test took 230646ms.
[17:21:02.482] <TB1> INFO: ROC 0 VthrComp = 97
[17:21:02.482] <TB1> INFO: ROC 1 VthrComp = 103
[17:21:02.483] <TB1> INFO: ROC 2 VthrComp = 104
[17:21:02.483] <TB1> INFO: ROC 3 VthrComp = 100
[17:21:02.483] <TB1> INFO: ROC 4 VthrComp = 105
[17:21:02.483] <TB1> INFO: ROC 5 VthrComp = 98
[17:21:02.483] <TB1> INFO: ROC 6 VthrComp = 94
[17:21:02.483] <TB1> INFO: ROC 7 VthrComp = 103
[17:21:02.483] <TB1> INFO: ROC 8 VthrComp = 102
[17:21:02.483] <TB1> INFO: ROC 9 VthrComp = 99
[17:21:02.483] <TB1> INFO: ROC 10 VthrComp = 91
[17:21:02.484] <TB1> INFO: ROC 11 VthrComp = 96
[17:21:02.484] <TB1> INFO: ROC 12 VthrComp = 101
[17:21:02.484] <TB1> INFO: ROC 13 VthrComp = 108
[17:21:02.484] <TB1> INFO: ROC 14 VthrComp = 102
[17:21:02.484] <TB1> INFO: ROC 15 VthrComp = 103
[17:21:02.484] <TB1> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[17:21:02.484] <TB1> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[17:21:02.495] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:21:02.495] <TB1> INFO: run 1 of 1
[17:21:02.770] <TB1> INFO: Expecting 6281600 events.
[17:21:38.518] <TB1> INFO: 758810 events read in total (35191ms).
[17:22:13.254] <TB1> INFO: 1515660 events read in total (69927ms).
[17:22:48.330] <TB1> INFO: 2272060 events read in total (105003ms).
[17:23:23.579] <TB1> INFO: 3028930 events read in total (140252ms).
[17:23:58.522] <TB1> INFO: 3780150 events read in total (175195ms).
[17:24:33.123] <TB1> INFO: 4527460 events read in total (209796ms).
[17:25:28.190] <TB1> INFO: 5272630 events read in total (264863ms).
[17:26:03.913] <TB1> INFO: 6018240 events read in total (300586ms).
[17:26:17.014] <TB1> INFO: 6281600 events read in total (313687ms).
[17:26:17.081] <TB1> INFO: Test took 314585ms.
[17:26:40.915] <TB1> INFO: roc 0 with ID = 0 has maximal Vcal 59.763 for pixel 18/20 mean/min/max = 46.5755/33.2804/59.8706
[17:26:40.915] <TB1> INFO: roc 1 with ID = 1 has maximal Vcal 59.6886 for pixel 5/0 mean/min/max = 46.3482/32.9425/59.7539
[17:26:40.916] <TB1> INFO: roc 2 with ID = 2 has maximal Vcal 60.7461 for pixel 25/75 mean/min/max = 47.6962/34.6008/60.7917
[17:26:40.927] <TB1> INFO: roc 3 with ID = 3 has maximal Vcal 59.7697 for pixel 21/72 mean/min/max = 45.7241/31.571/59.8773
[17:26:40.927] <TB1> INFO: roc 4 with ID = 4 has maximal Vcal 60.3897 for pixel 32/79 mean/min/max = 47.0822/33.759/60.4055
[17:26:40.928] <TB1> INFO: roc 5 with ID = 5 has maximal Vcal 56.3803 for pixel 16/46 mean/min/max = 43.9/31.3808/56.4192
[17:26:40.928] <TB1> INFO: roc 6 with ID = 6 has maximal Vcal 59.1985 for pixel 0/48 mean/min/max = 45.8703/32.5339/59.2066
[17:26:40.928] <TB1> INFO: roc 7 with ID = 7 has maximal Vcal 57.9798 for pixel 24/9 mean/min/max = 45.5819/33.031/58.1329
[17:26:40.929] <TB1> INFO: roc 8 with ID = 8 has maximal Vcal 60.6211 for pixel 25/74 mean/min/max = 46.4993/32.356/60.6425
[17:26:40.929] <TB1> INFO: roc 9 with ID = 9 has maximal Vcal 64.7 for pixel 0/36 mean/min/max = 48.6328/32.3118/64.9539
[17:26:40.929] <TB1> INFO: roc 10 with ID = 10 has maximal Vcal 57.392 for pixel 17/71 mean/min/max = 45.7728/34.128/57.4176
[17:26:40.930] <TB1> INFO: roc 11 with ID = 11 has maximal Vcal 56.7482 for pixel 10/66 mean/min/max = 44.9845/33.1806/56.7885
[17:26:40.930] <TB1> INFO: roc 12 with ID = 12 has maximal Vcal 58.2461 for pixel 0/9 mean/min/max = 45.0355/31.7853/58.2858
[17:26:40.930] <TB1> INFO: roc 13 with ID = 13 has maximal Vcal 61.3457 for pixel 37/79 mean/min/max = 48.283/35.1753/61.3908
[17:26:40.931] <TB1> INFO: roc 14 with ID = 14 has maximal Vcal 60.1329 for pixel 0/24 mean/min/max = 46.6684/33.1321/60.2047
[17:26:40.931] <TB1> INFO: roc 15 with ID = 15 has maximal Vcal 60.8906 for pixel 10/0 mean/min/max = 46.9492/32.9597/60.9388
[17:26:40.931] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:26:41.019] <TB1> INFO: Expecting 514560 events.
[17:26:54.121] <TB1> INFO: 514560 events read in total (12504ms).
[17:26:54.126] <TB1> INFO: Expecting 514560 events.
[17:27:06.858] <TB1> INFO: 514560 events read in total (12318ms).
[17:27:06.864] <TB1> INFO: Expecting 514560 events.
[17:27:19.693] <TB1> INFO: 514560 events read in total (12408ms).
[17:27:19.702] <TB1> INFO: Expecting 514560 events.
[17:27:32.513] <TB1> INFO: 514560 events read in total (12397ms).
[17:27:32.524] <TB1> INFO: Expecting 514560 events.
[17:27:45.431] <TB1> INFO: 514560 events read in total (12492ms).
[17:27:45.447] <TB1> INFO: Expecting 514560 events.
[17:27:58.343] <TB1> INFO: 514560 events read in total (12494ms).
[17:27:58.358] <TB1> INFO: Expecting 514560 events.
[17:28:11.064] <TB1> INFO: 514560 events read in total (12292ms).
[17:28:11.080] <TB1> INFO: Expecting 514560 events.
[17:28:23.922] <TB1> INFO: 514560 events read in total (12426ms).
[17:28:23.940] <TB1> INFO: Expecting 514560 events.
[17:28:36.780] <TB1> INFO: 514560 events read in total (12430ms).
[17:28:36.803] <TB1> INFO: Expecting 514560 events.
[17:28:49.593] <TB1> INFO: 514560 events read in total (12389ms).
[17:28:49.621] <TB1> INFO: Expecting 514560 events.
[17:29:02.394] <TB1> INFO: 514560 events read in total (12371ms).
[17:29:02.418] <TB1> INFO: Expecting 514560 events.
[17:29:15.267] <TB1> INFO: 514560 events read in total (12445ms).
[17:29:15.299] <TB1> INFO: Expecting 514560 events.
[17:29:27.921] <TB1> INFO: 514560 events read in total (12220ms).
[17:29:27.967] <TB1> INFO: Expecting 514560 events.
[17:29:40.712] <TB1> INFO: 514560 events read in total (12344ms).
[17:29:40.748] <TB1> INFO: Expecting 514560 events.
[17:29:53.482] <TB1> INFO: 514560 events read in total (12332ms).
[17:29:53.513] <TB1> INFO: Expecting 514560 events.
[17:30:06.503] <TB1> INFO: 514560 events read in total (12587ms).
[17:30:06.540] <TB1> INFO: Test took 205609ms.
[17:30:07.638] <TB1> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[17:30:07.646] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:30:07.646] <TB1> INFO: run 1 of 1
[17:30:07.935] <TB1> INFO: Expecting 6281600 events.
[17:30:43.303] <TB1> INFO: 743350 events read in total (34812ms).
[17:31:18.355] <TB1> INFO: 1485350 events read in total (69864ms).
[17:31:53.559] <TB1> INFO: 2226850 events read in total (105068ms).
[17:32:27.633] <TB1> INFO: 2968840 events read in total (139142ms).
[17:33:02.696] <TB1> INFO: 3704760 events read in total (174205ms).
[17:33:37.169] <TB1> INFO: 4436290 events read in total (208678ms).
[17:34:11.788] <TB1> INFO: 5165530 events read in total (243297ms).
[17:34:46.021] <TB1> INFO: 5894460 events read in total (277530ms).
[17:35:04.260] <TB1> INFO: 6281600 events read in total (295769ms).
[17:35:04.304] <TB1> INFO: Test took 296658ms.
[17:35:29.389] <TB1> INFO: ---> TrimStepCorr4 extremal thresholds: 0.098748 .. 255.000000
[17:35:29.535] <TB1> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[17:35:29.544] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:35:29.544] <TB1> INFO: run 1 of 1
[17:35:29.839] <TB1> INFO: Expecting 10649600 events.
[17:36:04.399] <TB1> INFO: 712400 events read in total (34003ms).
[17:36:38.702] <TB1> INFO: 1424870 events read in total (68306ms).
[17:37:13.202] <TB1> INFO: 2137810 events read in total (102806ms).
[17:37:47.465] <TB1> INFO: 2850430 events read in total (137069ms).
[17:38:22.113] <TB1> INFO: 3562990 events read in total (171717ms).
[17:38:56.211] <TB1> INFO: 4275830 events read in total (205815ms).
[17:39:30.522] <TB1> INFO: 4988390 events read in total (240126ms).
[17:40:04.932] <TB1> INFO: 5701610 events read in total (274536ms).
[17:40:39.085] <TB1> INFO: 6414000 events read in total (308689ms).
[17:41:13.408] <TB1> INFO: 7125710 events read in total (343012ms).
[17:41:47.281] <TB1> INFO: 7837360 events read in total (376885ms).
[17:42:21.990] <TB1> INFO: 8548480 events read in total (411594ms).
[17:42:56.041] <TB1> INFO: 9259400 events read in total (445645ms).
[17:43:30.495] <TB1> INFO: 9970530 events read in total (480099ms).
[17:44:02.906] <TB1> INFO: 10649600 events read in total (512510ms).
[17:44:02.988] <TB1> INFO: Test took 513445ms.
[17:44:31.430] <TB1> INFO: ---> TrimStepCorr2 extremal thresholds: 16.044334 .. 45.764902
[17:44:31.505] <TB1> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:44:31.513] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:44:31.513] <TB1> INFO: run 1 of 1
[17:44:31.781] <TB1> INFO: Expecting 2080000 events.
[17:45:10.236] <TB1> INFO: 932640 events read in total (37896ms).
[17:45:47.843] <TB1> INFO: 1863010 events read in total (75503ms).
[17:45:56.915] <TB1> INFO: 2080000 events read in total (84576ms).
[17:45:56.935] <TB1> INFO: Test took 85423ms.
[17:46:10.222] <TB1> INFO: ---> TrimStepCorr1a extremal thresholds: 4.500000 .. 42.710166
[17:46:10.319] <TB1> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 4 .. 52 (-1/-1) hits flags = 528 (plus default)
[17:46:10.329] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:46:10.329] <TB1> INFO: run 1 of 1
[17:46:10.609] <TB1> INFO: Expecting 2038400 events.
[17:46:49.927] <TB1> INFO: 971010 events read in total (38762ms).
[17:47:28.233] <TB1> INFO: 1940880 events read in total (77068ms).
[17:47:32.467] <TB1> INFO: 2038400 events read in total (81303ms).
[17:47:32.486] <TB1> INFO: Test took 82157ms.
[17:47:45.105] <TB1> INFO: ---> TrimStepCorr1b extremal thresholds: 4.500000 .. 42.710166
[17:47:45.208] <TB1> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 4 .. 52 (-1/-1) hits flags = 528 (plus default)
[17:47:45.217] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:47:45.218] <TB1> INFO: run 1 of 1
[17:47:45.513] <TB1> INFO: Expecting 2038400 events.
[17:48:24.488] <TB1> INFO: 970800 events read in total (38419ms).
[17:49:02.706] <TB1> INFO: 1941830 events read in total (76637ms).
[17:49:06.805] <TB1> INFO: 2038400 events read in total (80737ms).
[17:49:06.821] <TB1> INFO: Test took 81604ms.
[17:49:20.443] <TB1> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[17:49:20.443] <TB1> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:49:20.451] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[17:49:20.451] <TB1> INFO: run 1 of 1
[17:49:20.712] <TB1> INFO: Expecting 1705600 events.
[17:49:58.801] <TB1> INFO: 878880 events read in total (37532ms).
[17:50:33.337] <TB1> INFO: 1705600 events read in total (72068ms).
[17:50:33.365] <TB1> INFO: Test took 72915ms.
[17:50:46.856] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C0.dat
[17:50:46.856] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C1.dat
[17:50:46.856] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C2.dat
[17:50:46.856] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C3.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C4.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C5.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C6.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C7.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C8.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C9.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C10.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C11.dat
[17:50:46.857] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C12.dat
[17:50:46.858] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C13.dat
[17:50:46.858] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C14.dat
[17:50:46.858] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C15.dat
[17:50:46.858] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C0.dat
[17:50:46.864] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C1.dat
[17:50:46.870] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C2.dat
[17:50:46.876] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C3.dat
[17:50:46.882] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C4.dat
[17:50:46.889] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C5.dat
[17:50:46.894] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C6.dat
[17:50:46.901] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C7.dat
[17:50:46.907] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C8.dat
[17:50:46.913] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C9.dat
[17:50:46.919] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C10.dat
[17:50:46.925] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C11.dat
[17:50:46.931] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C12.dat
[17:50:46.937] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C13.dat
[17:50:46.943] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C14.dat
[17:50:46.952] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//trimParameters35_C15.dat
[17:50:46.961] <TB1> INFO: PixTestTrim::trimTest() done
[17:50:46.961] <TB1> INFO: vtrim: 97 98 123 114 113 98 101 108 108 107 100 101 93 96 94 114
[17:50:46.961] <TB1> INFO: vthrcomp: 97 103 104 100 105 98 94 103 102 99 91 96 101 108 102 103
[17:50:46.961] <TB1> INFO: vcal mean: 35.03 35.00 35.00 34.98 34.99 34.96 34.99 35.00 34.97 35.03 35.01 35.00 34.97 35.04 35.04 34.98
[17:50:46.961] <TB1> INFO: vcal RMS: 0.91 0.88 0.89 0.89 0.85 0.89 0.84 0.86 0.91 0.96 0.82 0.85 1.02 0.88 0.87 0.86
[17:50:46.961] <TB1> INFO: bits mean: 9.15 9.39 8.93 9.81 9.02 10.26 9.11 9.31 9.14 8.47 9.05 9.59 9.65 7.87 8.68 9.03
[17:50:46.961] <TB1> INFO: bits RMS: 2.63 2.59 2.46 2.62 2.58 2.55 2.80 2.63 2.73 2.87 2.60 2.58 2.74 2.68 2.86 2.70
[17:50:46.968] <TB1> INFO: ----------------------------------------------------------------------
[17:50:46.968] <TB1> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[17:50:46.968] <TB1> INFO: ----------------------------------------------------------------------
[17:50:46.987] <TB1> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[17:50:46.997] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[17:50:46.997] <TB1> INFO: run 1 of 1
[17:50:47.298] <TB1> INFO: Expecting 4160000 events.
[17:51:30.364] <TB1> INFO: 985340 events read in total (42509ms).
[17:52:12.482] <TB1> INFO: 1959200 events read in total (84627ms).
[17:52:54.406] <TB1> INFO: 2921925 events read in total (126551ms).
[17:53:36.081] <TB1> INFO: 3882970 events read in total (168226ms).
[17:53:48.855] <TB1> INFO: 4160000 events read in total (181000ms).
[17:53:48.895] <TB1> INFO: Test took 181898ms.
[17:54:17.608] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)
[17:54:17.616] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[17:54:17.621] <TB1> INFO: run 1 of 1
[17:54:17.881] <TB1> INFO: Expecting 3868800 events.
[17:55:01.396] <TB1> INFO: 979375 events read in total (42959ms).
[17:55:43.422] <TB1> INFO: 1948190 events read in total (84985ms).
[17:56:26.147] <TB1> INFO: 2905750 events read in total (127710ms).
[17:57:08.426] <TB1> INFO: 3866130 events read in total (169989ms).
[17:57:08.921] <TB1> INFO: 3868800 events read in total (170484ms).
[17:57:08.955] <TB1> INFO: Test took 171334ms.
[17:57:37.212] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 173 (-1/-1) hits flags = 528 (plus default)
[17:57:37.220] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[17:57:37.220] <TB1> INFO: run 1 of 1
[17:57:37.480] <TB1> INFO: Expecting 3619200 events.
[17:58:21.936] <TB1> INFO: 1011670 events read in total (43900ms).
[17:59:04.236] <TB1> INFO: 2009595 events read in total (86200ms).
[17:59:46.881] <TB1> INFO: 2996925 events read in total (128846ms).
[18:00:13.712] <TB1> INFO: 3619200 events read in total (155676ms).
[18:00:13.746] <TB1> INFO: Test took 156526ms.
[18:00:41.330] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 172 (-1/-1) hits flags = 528 (plus default)
[18:00:41.340] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[18:00:41.340] <TB1> INFO: run 1 of 1
[18:00:41.620] <TB1> INFO: Expecting 3598400 events.
[18:01:25.838] <TB1> INFO: 1014440 events read in total (43662ms).
[18:02:08.673] <TB1> INFO: 2014960 events read in total (86497ms).
[18:02:51.524] <TB1> INFO: 3004630 events read in total (129348ms).
[18:03:17.349] <TB1> INFO: 3598400 events read in total (155173ms).
[18:03:17.385] <TB1> INFO: Test took 156045ms.
[18:03:42.899] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 175 (-1/-1) hits flags = 528 (plus default)
[18:03:42.906] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[18:03:42.907] <TB1> INFO: run 1 of 1
[18:03:43.165] <TB1> INFO: Expecting 3660800 events.
[18:04:26.353] <TB1> INFO: 1005625 events read in total (42632ms).
[18:05:09.365] <TB1> INFO: 1997555 events read in total (85644ms).
[18:05:52.216] <TB1> INFO: 2978795 events read in total (128495ms).
[18:06:21.975] <TB1> INFO: 3660800 events read in total (158254ms).
[18:06:22.008] <TB1> INFO: Test took 159101ms.
[18:06:48.668] <TB1> INFO: PixTestTrim::trimBitTest() done
[18:06:48.669] <TB1> INFO: PixTestTrim::doTest() done, duration: 2998 seconds
[18:06:48.669] <TB1> INFO: Decoding statistics:
[18:06:48.669] <TB1> INFO: General information:
[18:06:48.669] <TB1> INFO: 16bit words read: 0
[18:06:48.669] <TB1> INFO: valid events total: 0
[18:06:48.669] <TB1> INFO: empty events: 0
[18:06:48.669] <TB1> INFO: valid events with pixels: 0
[18:06:48.669] <TB1> INFO: valid pixel hits: 0
[18:06:48.669] <TB1> INFO: Event errors: 0
[18:06:48.669] <TB1> INFO: start marker: 0
[18:06:48.669] <TB1> INFO: stop marker: 0
[18:06:48.669] <TB1> INFO: overflow: 0
[18:06:48.669] <TB1> INFO: invalid 5bit words: 0
[18:06:48.669] <TB1> INFO: invalid XOR eye diagram: 0
[18:06:48.669] <TB1> INFO: frame (failed synchr.): 0
[18:06:48.669] <TB1> INFO: idle data (no TBM trl): 0
[18:06:48.669] <TB1> INFO: no data (only TBM hdr): 0
[18:06:48.669] <TB1> INFO: TBM errors: 0
[18:06:48.669] <TB1> INFO: flawed TBM headers: 0
[18:06:48.669] <TB1> INFO: flawed TBM trailers: 0
[18:06:48.669] <TB1> INFO: event ID mismatches: 0
[18:06:48.669] <TB1> INFO: ROC errors: 0
[18:06:48.669] <TB1> INFO: missing ROC header(s): 0
[18:06:48.669] <TB1> INFO: misplaced readback start: 0
[18:06:48.669] <TB1> INFO: Pixel decoding errors: 0
[18:06:48.669] <TB1> INFO: pixel data incomplete: 0
[18:06:48.669] <TB1> INFO: pixel address: 0
[18:06:48.669] <TB1> INFO: pulse height fill bit: 0
[18:06:48.669] <TB1> INFO: buffer corruption: 0
[18:06:49.687] <TB1> INFO: ######################################################################
[18:06:49.687] <TB1> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[18:06:49.687] <TB1> INFO: ######################################################################
[18:06:50.045] <TB1> INFO: Expecting 41600 events.
[18:06:53.846] <TB1> INFO: 41600 events read in total (3245ms).
[18:06:53.847] <TB1> INFO: Test took 4088ms.
[18:06:54.319] <TB1> INFO: Expecting 41600 events.
[18:06:58.210] <TB1> INFO: 41600 events read in total (3335ms).
[18:06:58.211] <TB1> INFO: Test took 4161ms.
[18:06:58.517] <TB1> INFO: Expecting 41600 events.
[18:07:02.453] <TB1> INFO: 41600 events read in total (3380ms).
[18:07:02.453] <TB1> INFO: Test took 4199ms.
[18:07:02.709] <TB1> INFO: Expecting 2560 events.
[18:07:03.561] <TB1> INFO: 2560 events read in total (296ms).
[18:07:03.561] <TB1> INFO: Test took 1094ms.
[18:07:03.866] <TB1> INFO: Expecting 2560 events.
[18:07:04.718] <TB1> INFO: 2560 events read in total (296ms).
[18:07:04.718] <TB1> INFO: Test took 1157ms.
[18:07:05.023] <TB1> INFO: Expecting 2560 events.
[18:07:05.876] <TB1> INFO: 2560 events read in total (297ms).
[18:07:05.876] <TB1> INFO: Test took 1157ms.
[18:07:06.181] <TB1> INFO: Expecting 2560 events.
[18:07:07.035] <TB1> INFO: 2560 events read in total (298ms).
[18:07:07.035] <TB1> INFO: Test took 1158ms.
[18:07:07.340] <TB1> INFO: Expecting 2560 events.
[18:07:08.195] <TB1> INFO: 2560 events read in total (299ms).
[18:07:08.195] <TB1> INFO: Test took 1159ms.
[18:07:08.500] <TB1> INFO: Expecting 2560 events.
[18:07:09.355] <TB1> INFO: 2560 events read in total (299ms).
[18:07:09.355] <TB1> INFO: Test took 1160ms.
[18:07:09.660] <TB1> INFO: Expecting 2560 events.
[18:07:10.512] <TB1> INFO: 2560 events read in total (296ms).
[18:07:10.513] <TB1> INFO: Test took 1157ms.
[18:07:10.818] <TB1> INFO: Expecting 2560 events.
[18:07:11.670] <TB1> INFO: 2560 events read in total (296ms).
[18:07:11.670] <TB1> INFO: Test took 1157ms.
[18:07:11.975] <TB1> INFO: Expecting 2560 events.
[18:07:12.826] <TB1> INFO: 2560 events read in total (295ms).
[18:07:12.827] <TB1> INFO: Test took 1157ms.
[18:07:13.131] <TB1> INFO: Expecting 2560 events.
[18:07:13.984] <TB1> INFO: 2560 events read in total (297ms).
[18:07:13.984] <TB1> INFO: Test took 1157ms.
[18:07:14.289] <TB1> INFO: Expecting 2560 events.
[18:07:15.144] <TB1> INFO: 2560 events read in total (299ms).
[18:07:15.144] <TB1> INFO: Test took 1160ms.
[18:07:15.449] <TB1> INFO: Expecting 2560 events.
[18:07:16.304] <TB1> INFO: 2560 events read in total (299ms).
[18:07:16.304] <TB1> INFO: Test took 1160ms.
[18:07:16.609] <TB1> INFO: Expecting 2560 events.
[18:07:17.462] <TB1> INFO: 2560 events read in total (298ms).
[18:07:17.463] <TB1> INFO: Test took 1159ms.
[18:07:17.768] <TB1> INFO: Expecting 2560 events.
[18:07:18.622] <TB1> INFO: 2560 events read in total (298ms).
[18:07:18.623] <TB1> INFO: Test took 1160ms.
[18:07:18.928] <TB1> INFO: Expecting 2560 events.
[18:07:19.782] <TB1> INFO: 2560 events read in total (298ms).
[18:07:19.783] <TB1> INFO: Test took 1160ms.
[18:07:20.088] <TB1> INFO: Expecting 2560 events.
[18:07:20.942] <TB1> INFO: 2560 events read in total (298ms).
[18:07:20.942] <TB1> INFO: Test took 1159ms.
[18:07:20.945] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:07:21.248] <TB1> INFO: Expecting 655360 events.
[18:07:37.974] <TB1> INFO: 655360 events read in total (16169ms).
[18:07:37.982] <TB1> INFO: Expecting 655360 events.
[18:07:54.557] <TB1> INFO: 655360 events read in total (16173ms).
[18:07:54.569] <TB1> INFO: Expecting 655360 events.
[18:08:10.995] <TB1> INFO: 655360 events read in total (16024ms).
[18:08:11.010] <TB1> INFO: Expecting 655360 events.
[18:08:27.517] <TB1> INFO: 655360 events read in total (16105ms).
[18:08:27.536] <TB1> INFO: Expecting 655360 events.
[18:08:44.210] <TB1> INFO: 655360 events read in total (16272ms).
[18:08:44.239] <TB1> INFO: Expecting 655360 events.
[18:09:01.099] <TB1> INFO: 655360 events read in total (16459ms).
[18:09:01.125] <TB1> INFO: Expecting 655360 events.
[18:09:17.848] <TB1> INFO: 655360 events read in total (16321ms).
[18:09:17.879] <TB1> INFO: Expecting 655360 events.
[18:09:34.707] <TB1> INFO: 655360 events read in total (16426ms).
[18:09:34.739] <TB1> INFO: Expecting 655360 events.
[18:09:51.573] <TB1> INFO: 655360 events read in total (16432ms).
[18:09:51.610] <TB1> INFO: Expecting 655360 events.
[18:10:08.396] <TB1> INFO: 655360 events read in total (16384ms).
[18:10:08.443] <TB1> INFO: Expecting 655360 events.
[18:10:25.226] <TB1> INFO: 655360 events read in total (16381ms).
[18:10:25.272] <TB1> INFO: Expecting 655360 events.
[18:10:42.120] <TB1> INFO: 655360 events read in total (16446ms).
[18:10:42.168] <TB1> INFO: Expecting 655360 events.
[18:10:59.009] <TB1> INFO: 655360 events read in total (16439ms).
[18:10:59.067] <TB1> INFO: Expecting 655360 events.
[18:11:16.039] <TB1> INFO: 655360 events read in total (16570ms).
[18:11:16.107] <TB1> INFO: Expecting 655360 events.
[18:11:32.826] <TB1> INFO: 655360 events read in total (16317ms).
[18:11:32.886] <TB1> INFO: Expecting 655360 events.
[18:11:49.550] <TB1> INFO: 655360 events read in total (16263ms).
[18:11:49.614] <TB1> INFO: Test took 268669ms.
[18:11:49.694] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:11:49.924] <TB1> INFO: Expecting 655360 events.
[18:12:06.830] <TB1> INFO: 655360 events read in total (16350ms).
[18:12:06.841] <TB1> INFO: Expecting 655360 events.
[18:12:23.692] <TB1> INFO: 655360 events read in total (16449ms).
[18:12:23.704] <TB1> INFO: Expecting 655360 events.
[18:12:40.112] <TB1> INFO: 655360 events read in total (16006ms).
[18:12:40.128] <TB1> INFO: Expecting 655360 events.
[18:12:56.830] <TB1> INFO: 655360 events read in total (16300ms).
[18:12:56.848] <TB1> INFO: Expecting 655360 events.
[18:13:13.645] <TB1> INFO: 655360 events read in total (16395ms).
[18:13:13.667] <TB1> INFO: Expecting 655360 events.
[18:13:30.287] <TB1> INFO: 655360 events read in total (16219ms).
[18:13:30.315] <TB1> INFO: Expecting 655360 events.
[18:13:47.111] <TB1> INFO: 655360 events read in total (16395ms).
[18:13:47.142] <TB1> INFO: Expecting 655360 events.
[18:14:03.893] <TB1> INFO: 655360 events read in total (16349ms).
[18:14:03.925] <TB1> INFO: Expecting 655360 events.
[18:14:20.585] <TB1> INFO: 655360 events read in total (16258ms).
[18:14:20.623] <TB1> INFO: Expecting 655360 events.
[18:14:37.098] <TB1> INFO: 655360 events read in total (16073ms).
[18:14:37.146] <TB1> INFO: Expecting 655360 events.
[18:14:53.891] <TB1> INFO: 655360 events read in total (16343ms).
[18:14:53.937] <TB1> INFO: Expecting 655360 events.
[18:15:10.619] <TB1> INFO: 655360 events read in total (16280ms).
[18:15:10.677] <TB1> INFO: Expecting 655360 events.
[18:15:27.319] <TB1> INFO: 655360 events read in total (16240ms).
[18:15:27.368] <TB1> INFO: Expecting 655360 events.
[18:15:44.126] <TB1> INFO: 655360 events read in total (16356ms).
[18:15:44.180] <TB1> INFO: Expecting 655360 events.
[18:16:00.872] <TB1> INFO: 655360 events read in total (16290ms).
[18:16:00.929] <TB1> INFO: Expecting 655360 events.
[18:16:17.683] <TB1> INFO: 655360 events read in total (16352ms).
[18:16:17.743] <TB1> INFO: Test took 268050ms.
[18:16:17.978] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:17.985] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:17.991] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.001] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.010] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.017] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.023] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.030] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.036] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.043] <TB1> INFO: safety margin for low PH: adding 1, margin is now 21
[18:16:18.050] <TB1> INFO: safety margin for low PH: adding 2, margin is now 22
[18:16:18.056] <TB1> INFO: safety margin for low PH: adding 3, margin is now 23
[18:16:18.063] <TB1> INFO: safety margin for low PH: adding 4, margin is now 24
[18:16:18.070] <TB1> INFO: safety margin for low PH: adding 5, margin is now 25
[18:16:18.077] <TB1> INFO: safety margin for low PH: adding 6, margin is now 26
[18:16:18.083] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.090] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.097] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.103] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.110] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.116] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.126] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[18:16:18.158] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C0.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C1.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C2.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C3.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C4.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C5.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C6.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C7.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C8.dat
[18:16:18.159] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C9.dat
[18:16:18.160] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C10.dat
[18:16:18.160] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C11.dat
[18:16:18.165] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C12.dat
[18:16:18.165] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C13.dat
[18:16:18.165] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C14.dat
[18:16:18.165] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//dacParameters35_C15.dat
[18:16:18.435] <TB1> INFO: Expecting 41600 events.
[18:16:21.923] <TB1> INFO: 41600 events read in total (2932ms).
[18:16:21.924] <TB1> INFO: Test took 3757ms.
[18:16:22.383] <TB1> INFO: Expecting 41600 events.
[18:16:25.862] <TB1> INFO: 41600 events read in total (2923ms).
[18:16:25.863] <TB1> INFO: Test took 3760ms.
[18:16:26.328] <TB1> INFO: Expecting 41600 events.
[18:16:29.822] <TB1> INFO: 41600 events read in total (2938ms).
[18:16:29.823] <TB1> INFO: Test took 3780ms.
[18:16:30.006] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:30.095] <TB1> INFO: Expecting 2560 events.
[18:16:30.949] <TB1> INFO: 2560 events read in total (298ms).
[18:16:30.949] <TB1> INFO: Test took 943ms.
[18:16:30.951] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:31.255] <TB1> INFO: Expecting 2560 events.
[18:16:32.110] <TB1> INFO: 2560 events read in total (298ms).
[18:16:32.110] <TB1> INFO: Test took 1159ms.
[18:16:32.112] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:32.415] <TB1> INFO: Expecting 2560 events.
[18:16:33.269] <TB1> INFO: 2560 events read in total (297ms).
[18:16:33.269] <TB1> INFO: Test took 1157ms.
[18:16:33.272] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:33.574] <TB1> INFO: Expecting 2560 events.
[18:16:34.428] <TB1> INFO: 2560 events read in total (297ms).
[18:16:34.428] <TB1> INFO: Test took 1156ms.
[18:16:34.430] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:34.733] <TB1> INFO: Expecting 2560 events.
[18:16:35.587] <TB1> INFO: 2560 events read in total (297ms).
[18:16:35.588] <TB1> INFO: Test took 1158ms.
[18:16:35.589] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:35.893] <TB1> INFO: Expecting 2560 events.
[18:16:36.747] <TB1> INFO: 2560 events read in total (298ms).
[18:16:36.747] <TB1> INFO: Test took 1158ms.
[18:16:36.749] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:37.052] <TB1> INFO: Expecting 2560 events.
[18:16:37.908] <TB1> INFO: 2560 events read in total (299ms).
[18:16:37.908] <TB1> INFO: Test took 1159ms.
[18:16:37.910] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:38.213] <TB1> INFO: Expecting 2560 events.
[18:16:39.070] <TB1> INFO: 2560 events read in total (301ms).
[18:16:39.070] <TB1> INFO: Test took 1161ms.
[18:16:39.073] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:39.375] <TB1> INFO: Expecting 2560 events.
[18:16:40.228] <TB1> INFO: 2560 events read in total (297ms).
[18:16:40.228] <TB1> INFO: Test took 1155ms.
[18:16:40.230] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:40.534] <TB1> INFO: Expecting 2560 events.
[18:16:41.389] <TB1> INFO: 2560 events read in total (299ms).
[18:16:41.390] <TB1> INFO: Test took 1160ms.
[18:16:41.391] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:41.695] <TB1> INFO: Expecting 2560 events.
[18:16:42.549] <TB1> INFO: 2560 events read in total (298ms).
[18:16:42.549] <TB1> INFO: Test took 1158ms.
[18:16:42.551] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:42.855] <TB1> INFO: Expecting 2560 events.
[18:16:43.708] <TB1> INFO: 2560 events read in total (297ms).
[18:16:43.708] <TB1> INFO: Test took 1157ms.
[18:16:43.711] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:44.013] <TB1> INFO: Expecting 2560 events.
[18:16:44.865] <TB1> INFO: 2560 events read in total (296ms).
[18:16:44.865] <TB1> INFO: Test took 1155ms.
[18:16:44.867] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:45.170] <TB1> INFO: Expecting 2560 events.
[18:16:46.025] <TB1> INFO: 2560 events read in total (299ms).
[18:16:46.025] <TB1> INFO: Test took 1158ms.
[18:16:46.028] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:46.331] <TB1> INFO: Expecting 2560 events.
[18:16:47.190] <TB1> INFO: 2560 events read in total (303ms).
[18:16:47.191] <TB1> INFO: Test took 1163ms.
[18:16:47.194] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:47.497] <TB1> INFO: Expecting 2560 events.
[18:16:48.354] <TB1> INFO: 2560 events read in total (301ms).
[18:16:48.355] <TB1> INFO: Test took 1162ms.
[18:16:48.358] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:48.660] <TB1> INFO: Expecting 2560 events.
[18:16:49.516] <TB1> INFO: 2560 events read in total (299ms).
[18:16:49.516] <TB1> INFO: Test took 1159ms.
[18:16:49.519] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:49.821] <TB1> INFO: Expecting 2560 events.
[18:16:50.678] <TB1> INFO: 2560 events read in total (301ms).
[18:16:50.679] <TB1> INFO: Test took 1161ms.
[18:16:50.680] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:50.985] <TB1> INFO: Expecting 2560 events.
[18:16:51.839] <TB1> INFO: 2560 events read in total (298ms).
[18:16:51.839] <TB1> INFO: Test took 1159ms.
[18:16:51.841] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:52.145] <TB1> INFO: Expecting 2560 events.
[18:16:52.997] <TB1> INFO: 2560 events read in total (296ms).
[18:16:52.998] <TB1> INFO: Test took 1157ms.
[18:16:53.000] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:53.303] <TB1> INFO: Expecting 2560 events.
[18:16:54.156] <TB1> INFO: 2560 events read in total (297ms).
[18:16:54.156] <TB1> INFO: Test took 1157ms.
[18:16:54.159] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:54.461] <TB1> INFO: Expecting 2560 events.
[18:16:55.314] <TB1> INFO: 2560 events read in total (297ms).
[18:16:55.315] <TB1> INFO: Test took 1156ms.
[18:16:55.316] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:55.620] <TB1> INFO: Expecting 2560 events.
[18:16:56.478] <TB1> INFO: 2560 events read in total (302ms).
[18:16:56.478] <TB1> INFO: Test took 1162ms.
[18:16:56.480] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:56.783] <TB1> INFO: Expecting 2560 events.
[18:16:57.636] <TB1> INFO: 2560 events read in total (297ms).
[18:16:57.636] <TB1> INFO: Test took 1156ms.
[18:16:57.638] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:57.942] <TB1> INFO: Expecting 2560 events.
[18:16:58.797] <TB1> INFO: 2560 events read in total (298ms).
[18:16:58.803] <TB1> INFO: Test took 1165ms.
[18:16:58.805] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:16:59.102] <TB1> INFO: Expecting 2560 events.
[18:16:59.959] <TB1> INFO: 2560 events read in total (301ms).
[18:16:59.959] <TB1> INFO: Test took 1154ms.
[18:16:59.962] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:00.265] <TB1> INFO: Expecting 2560 events.
[18:17:01.121] <TB1> INFO: 2560 events read in total (300ms).
[18:17:01.121] <TB1> INFO: Test took 1159ms.
[18:17:01.123] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:01.426] <TB1> INFO: Expecting 2560 events.
[18:17:02.284] <TB1> INFO: 2560 events read in total (302ms).
[18:17:02.285] <TB1> INFO: Test took 1163ms.
[18:17:02.288] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:02.590] <TB1> INFO: Expecting 2560 events.
[18:17:03.447] <TB1> INFO: 2560 events read in total (301ms).
[18:17:03.447] <TB1> INFO: Test took 1160ms.
[18:17:03.449] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:03.752] <TB1> INFO: Expecting 2560 events.
[18:17:04.606] <TB1> INFO: 2560 events read in total (298ms).
[18:17:04.606] <TB1> INFO: Test took 1157ms.
[18:17:04.609] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:04.912] <TB1> INFO: Expecting 2560 events.
[18:17:05.768] <TB1> INFO: 2560 events read in total (300ms).
[18:17:05.768] <TB1> INFO: Test took 1159ms.
[18:17:05.770] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:06.074] <TB1> INFO: Expecting 2560 events.
[18:17:06.927] <TB1> INFO: 2560 events read in total (297ms).
[18:17:06.927] <TB1> INFO: Test took 1157ms.
[18:17:07.381] <TB1> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[18:17:07.381] <TB1> INFO: PH scale (per ROC): 70 63 72 72 78 75 69 71 70 74 76 74 70 70 76 67
[18:17:07.381] <TB1> INFO: PH offset (per ROC): 179 181 196 184 188 182 186 172 176 188 186 186 188 182 195 179
[18:17:07.385] <TB1> INFO: Decoding statistics:
[18:17:07.385] <TB1> INFO: General information:
[18:17:07.385] <TB1> INFO: 16bit words read: 91940
[18:17:07.385] <TB1> INFO: valid events total: 10240
[18:17:07.385] <TB1> INFO: empty events: 7735
[18:17:07.385] <TB1> INFO: valid events with pixels: 2505
[18:17:07.385] <TB1> INFO: valid pixel hits: 2505
[18:17:07.385] <TB1> INFO: Event errors: 0
[18:17:07.385] <TB1> INFO: start marker: 0
[18:17:07.385] <TB1> INFO: stop marker: 0
[18:17:07.385] <TB1> INFO: overflow: 0
[18:17:07.385] <TB1> INFO: invalid 5bit words: 0
[18:17:07.385] <TB1> INFO: invalid XOR eye diagram: 0
[18:17:07.385] <TB1> INFO: frame (failed synchr.): 0
[18:17:07.385] <TB1> INFO: idle data (no TBM trl): 0
[18:17:07.385] <TB1> INFO: no data (only TBM hdr): 0
[18:17:07.385] <TB1> INFO: TBM errors: 0
[18:17:07.385] <TB1> INFO: flawed TBM headers: 0
[18:17:07.385] <TB1> INFO: flawed TBM trailers: 0
[18:17:07.385] <TB1> INFO: event ID mismatches: 0
[18:17:07.385] <TB1> INFO: ROC errors: 0
[18:17:07.385] <TB1> INFO: missing ROC header(s): 0
[18:17:07.385] <TB1> INFO: misplaced readback start: 0
[18:17:07.385] <TB1> INFO: Pixel decoding errors: 0
[18:17:07.385] <TB1> INFO: pixel data incomplete: 0
[18:17:07.385] <TB1> INFO: pixel address: 0
[18:17:07.385] <TB1> INFO: pulse height fill bit: 0
[18:17:07.385] <TB1> INFO: buffer corruption: 0
[18:17:07.558] <TB1> INFO: ######################################################################
[18:17:07.558] <TB1> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[18:17:07.558] <TB1> INFO: ######################################################################
[18:17:07.567] <TB1> INFO: scanning low vcal = 10
[18:17:07.830] <TB1> INFO: Expecting 41600 events.
[18:17:11.377] <TB1> INFO: 41600 events read in total (2990ms).
[18:17:11.377] <TB1> INFO: Test took 3810ms.
[18:17:11.379] <TB1> INFO: scanning low vcal = 20
[18:17:11.683] <TB1> INFO: Expecting 41600 events.
[18:17:15.248] <TB1> INFO: 41600 events read in total (3009ms).
[18:17:15.248] <TB1> INFO: Test took 3869ms.
[18:17:15.250] <TB1> INFO: scanning low vcal = 30
[18:17:15.554] <TB1> INFO: Expecting 41600 events.
[18:17:19.150] <TB1> INFO: 41600 events read in total (3040ms).
[18:17:19.151] <TB1> INFO: Test took 3901ms.
[18:17:19.153] <TB1> INFO: scanning low vcal = 40
[18:17:19.439] <TB1> INFO: Expecting 41600 events.
[18:17:23.579] <TB1> INFO: 41600 events read in total (3584ms).
[18:17:23.580] <TB1> INFO: Test took 4427ms.
[18:17:23.582] <TB1> INFO: scanning low vcal = 50
[18:17:23.841] <TB1> INFO: Expecting 41600 events.
[18:17:28.028] <TB1> INFO: 41600 events read in total (3631ms).
[18:17:28.028] <TB1> INFO: Test took 4445ms.
[18:17:28.031] <TB1> INFO: scanning low vcal = 60
[18:17:28.333] <TB1> INFO: Expecting 41600 events.
[18:17:32.512] <TB1> INFO: 41600 events read in total (3623ms).
[18:17:32.513] <TB1> INFO: Test took 4482ms.
[18:17:32.515] <TB1> INFO: scanning low vcal = 70
[18:17:32.774] <TB1> INFO: Expecting 41600 events.
[18:17:37.021] <TB1> INFO: 41600 events read in total (3691ms).
[18:17:37.022] <TB1> INFO: Test took 4507ms.
[18:17:37.024] <TB1> INFO: scanning low vcal = 80
[18:17:37.326] <TB1> INFO: Expecting 41600 events.
[18:17:41.550] <TB1> INFO: 41600 events read in total (3667ms).
[18:17:41.550] <TB1> INFO: Test took 4525ms.
[18:17:41.553] <TB1> INFO: scanning low vcal = 90
[18:17:41.819] <TB1> INFO: Expecting 41600 events.
[18:17:46.021] <TB1> INFO: 41600 events read in total (3646ms).
[18:17:46.022] <TB1> INFO: Test took 4469ms.
[18:17:46.024] <TB1> INFO: scanning low vcal = 100
[18:17:46.285] <TB1> INFO: Expecting 41600 events.
[18:17:50.509] <TB1> INFO: 41600 events read in total (3667ms).
[18:17:50.510] <TB1> INFO: Test took 4485ms.
[18:17:50.513] <TB1> INFO: scanning low vcal = 110
[18:17:50.791] <TB1> INFO: Expecting 41600 events.
[18:17:54.972] <TB1> INFO: 41600 events read in total (3626ms).
[18:17:54.973] <TB1> INFO: Test took 4460ms.
[18:17:54.975] <TB1> INFO: scanning low vcal = 120
[18:17:55.234] <TB1> INFO: Expecting 41600 events.
[18:17:59.431] <TB1> INFO: 41600 events read in total (3640ms).
[18:17:59.431] <TB1> INFO: Test took 4455ms.
[18:17:59.434] <TB1> INFO: scanning low vcal = 130
[18:17:59.694] <TB1> INFO: Expecting 41600 events.
[18:18:03.960] <TB1> INFO: 41600 events read in total (3709ms).
[18:18:03.960] <TB1> INFO: Test took 4526ms.
[18:18:03.963] <TB1> INFO: scanning low vcal = 140
[18:18:04.243] <TB1> INFO: Expecting 41600 events.
[18:18:08.463] <TB1> INFO: 41600 events read in total (3664ms).
[18:18:08.463] <TB1> INFO: Test took 4500ms.
[18:18:08.466] <TB1> INFO: scanning low vcal = 150
[18:18:08.770] <TB1> INFO: Expecting 41600 events.
[18:18:13.022] <TB1> INFO: 41600 events read in total (3696ms).
[18:18:13.022] <TB1> INFO: Test took 4556ms.
[18:18:13.025] <TB1> INFO: scanning low vcal = 160
[18:18:13.299] <TB1> INFO: Expecting 41600 events.
[18:18:17.551] <TB1> INFO: 41600 events read in total (3695ms).
[18:18:17.552] <TB1> INFO: Test took 4527ms.
[18:18:17.554] <TB1> INFO: scanning low vcal = 170
[18:18:17.818] <TB1> INFO: Expecting 41600 events.
[18:18:22.024] <TB1> INFO: 41600 events read in total (3650ms).
[18:18:22.024] <TB1> INFO: Test took 4470ms.
[18:18:22.028] <TB1> INFO: scanning low vcal = 180
[18:18:22.309] <TB1> INFO: Expecting 41600 events.
[18:18:26.515] <TB1> INFO: 41600 events read in total (3650ms).
[18:18:26.516] <TB1> INFO: Test took 4488ms.
[18:18:26.530] <TB1> INFO: scanning low vcal = 190
[18:18:26.790] <TB1> INFO: Expecting 41600 events.
[18:18:31.031] <TB1> INFO: 41600 events read in total (3684ms).
[18:18:31.032] <TB1> INFO: Test took 4502ms.
[18:18:31.034] <TB1> INFO: scanning low vcal = 200
[18:18:31.327] <TB1> INFO: Expecting 41600 events.
[18:18:35.593] <TB1> INFO: 41600 events read in total (3710ms).
[18:18:35.594] <TB1> INFO: Test took 4559ms.
[18:18:35.596] <TB1> INFO: scanning low vcal = 210
[18:18:35.856] <TB1> INFO: Expecting 41600 events.
[18:18:40.097] <TB1> INFO: 41600 events read in total (3685ms).
[18:18:40.098] <TB1> INFO: Test took 4501ms.
[18:18:40.100] <TB1> INFO: scanning low vcal = 220
[18:18:40.368] <TB1> INFO: Expecting 41600 events.
[18:18:44.606] <TB1> INFO: 41600 events read in total (3682ms).
[18:18:44.607] <TB1> INFO: Test took 4506ms.
[18:18:44.610] <TB1> INFO: scanning low vcal = 230
[18:18:44.869] <TB1> INFO: Expecting 41600 events.
[18:18:49.060] <TB1> INFO: 41600 events read in total (3635ms).
[18:18:49.060] <TB1> INFO: Test took 4450ms.
[18:18:49.063] <TB1> INFO: scanning low vcal = 240
[18:18:49.363] <TB1> INFO: Expecting 41600 events.
[18:18:53.573] <TB1> INFO: 41600 events read in total (3653ms).
[18:18:53.573] <TB1> INFO: Test took 4510ms.
[18:18:53.576] <TB1> INFO: scanning low vcal = 250
[18:18:53.837] <TB1> INFO: Expecting 41600 events.
[18:18:58.015] <TB1> INFO: 41600 events read in total (3621ms).
[18:18:58.015] <TB1> INFO: Test took 4439ms.
[18:18:58.019] <TB1> INFO: scanning high vcal = 30 (= 210 in low range)
[18:18:58.317] <TB1> INFO: Expecting 41600 events.
[18:19:02.563] <TB1> INFO: 41600 events read in total (3690ms).
[18:19:02.563] <TB1> INFO: Test took 4544ms.
[18:19:02.566] <TB1> INFO: scanning high vcal = 50 (= 350 in low range)
[18:19:02.825] <TB1> INFO: Expecting 41600 events.
[18:19:07.044] <TB1> INFO: 41600 events read in total (3662ms).
[18:19:07.044] <TB1> INFO: Test took 4478ms.
[18:19:07.047] <TB1> INFO: scanning high vcal = 70 (= 490 in low range)
[18:19:07.307] <TB1> INFO: Expecting 41600 events.
[18:19:11.552] <TB1> INFO: 41600 events read in total (3688ms).
[18:19:11.552] <TB1> INFO: Test took 4505ms.
[18:19:11.555] <TB1> INFO: scanning high vcal = 90 (= 630 in low range)
[18:19:11.846] <TB1> INFO: Expecting 41600 events.
[18:19:16.053] <TB1> INFO: 41600 events read in total (3651ms).
[18:19:16.054] <TB1> INFO: Test took 4499ms.
[18:19:16.056] <TB1> INFO: scanning high vcal = 200 (= 1400 in low range)
[18:19:16.325] <TB1> INFO: Expecting 41600 events.
[18:19:20.556] <TB1> INFO: 41600 events read in total (3675ms).
[18:19:20.557] <TB1> INFO: Test took 4500ms.
[18:19:21.064] <TB1> INFO: PixTestGainPedestal::measure() done
[18:19:57.876] <TB1> INFO: PixTestGainPedestal::fit() done
[18:19:57.876] <TB1> INFO: non-linearity mean: 0.962 0.957 0.952 0.948 0.954 0.955 0.957 0.961 0.961 0.960 0.947 0.960 0.951 0.958 0.959 0.962
[18:19:57.876] <TB1> INFO: non-linearity RMS: 0.007 0.007 0.008 0.009 0.007 0.008 0.006 0.006 0.005 0.008 0.008 0.006 0.008 0.007 0.007 0.006
[18:19:57.876] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[18:19:57.896] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[18:19:57.915] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[18:19:57.934] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[18:19:57.956] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[18:19:57.975] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[18:19:57.995] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[18:19:58.016] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[18:19:58.043] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[18:19:58.064] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[18:19:58.084] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[18:19:58.105] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[18:19:58.126] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[18:19:58.152] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[18:19:58.173] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[18:19:58.193] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[18:19:58.214] <TB1> INFO: PixTestGainPedestal::fullTest() done, duration: 170 seconds
[18:19:58.214] <TB1> INFO: Decoding statistics:
[18:19:58.214] <TB1> INFO: General information:
[18:19:58.214] <TB1> INFO: 16bit words read: 2662400
[18:19:58.214] <TB1> INFO: valid events total: 166400
[18:19:58.214] <TB1> INFO: empty events: 0
[18:19:58.214] <TB1> INFO: valid events with pixels: 166400
[18:19:58.214] <TB1> INFO: valid pixel hits: 665582
[18:19:58.214] <TB1> INFO: Event errors: 0
[18:19:58.214] <TB1> INFO: start marker: 0
[18:19:58.214] <TB1> INFO: stop marker: 0
[18:19:58.214] <TB1> INFO: overflow: 0
[18:19:58.214] <TB1> INFO: invalid 5bit words: 0
[18:19:58.214] <TB1> INFO: invalid XOR eye diagram: 0
[18:19:58.214] <TB1> INFO: frame (failed synchr.): 0
[18:19:58.214] <TB1> INFO: idle data (no TBM trl): 0
[18:19:58.214] <TB1> INFO: no data (only TBM hdr): 0
[18:19:58.214] <TB1> INFO: TBM errors: 0
[18:19:58.214] <TB1> INFO: flawed TBM headers: 0
[18:19:58.214] <TB1> INFO: flawed TBM trailers: 0
[18:19:58.214] <TB1> INFO: event ID mismatches: 0
[18:19:58.214] <TB1> INFO: ROC errors: 0
[18:19:58.214] <TB1> INFO: missing ROC header(s): 0
[18:19:58.214] <TB1> INFO: misplaced readback start: 0
[18:19:58.214] <TB1> INFO: Pixel decoding errors: 0
[18:19:58.214] <TB1> INFO: pixel data incomplete: 0
[18:19:58.214] <TB1> INFO: pixel address: 0
[18:19:58.214] <TB1> INFO: pulse height fill bit: 0
[18:19:58.214] <TB1> INFO: buffer corruption: 0
[18:19:58.222] <TB1> INFO: readReadbackCal: /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C15.dat
[18:19:58.261] <TB1> INFO: ######################################################################
[18:19:58.261] <TB1> INFO: PixTestReadback::doTest()
[18:19:58.261] <TB1> INFO: ######################################################################
[18:19:58.261] <TB1> INFO: ----------------------------------------------------------------------
[18:19:58.261] <TB1> INFO: PixTestReadback::CalibrateVd()
[18:19:58.261] <TB1> INFO: ----------------------------------------------------------------------
[18:20:07.783] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C0.dat
[18:20:07.783] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C1.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C2.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C3.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C4.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C5.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C6.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C7.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C8.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C9.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C10.dat
[18:20:07.784] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C11.dat
[18:20:07.785] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C12.dat
[18:20:07.785] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C13.dat
[18:20:07.785] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C14.dat
[18:20:07.785] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C15.dat
[18:20:07.814] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[18:20:07.814] <TB1> INFO: ----------------------------------------------------------------------
[18:20:07.814] <TB1> INFO: PixTestReadback::CalibrateVa()
[18:20:07.814] <TB1> INFO: ----------------------------------------------------------------------
[18:20:18.313] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C0.dat
[18:20:18.313] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C1.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C2.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C3.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C4.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C5.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C6.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C7.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C8.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C9.dat
[18:20:18.314] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C10.dat
[18:20:18.315] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C11.dat
[18:20:18.315] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C12.dat
[18:20:18.315] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C13.dat
[18:20:18.315] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C14.dat
[18:20:18.315] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C15.dat
[18:20:18.344] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[18:20:18.344] <TB1> INFO: ----------------------------------------------------------------------
[18:20:18.344] <TB1> INFO: PixTestReadback::readbackVbg()
[18:20:18.344] <TB1> INFO: ----------------------------------------------------------------------
[18:20:25.635] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[18:20:25.635] <TB1> INFO: ----------------------------------------------------------------------
[18:20:25.635] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[18:20:25.635] <TB1> INFO: ----------------------------------------------------------------------
[18:20:25.635] <TB1> INFO: Vbg will be calibrated using Vd calibration
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 154.7calibrated Vbg = 1.20119 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 151.8calibrated Vbg = 1.20026 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 152.1calibrated Vbg = 1.20229 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 164calibrated Vbg = 1.21839 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 154.8calibrated Vbg = 1.21925 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 148.2calibrated Vbg = 1.22443 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 160.5calibrated Vbg = 1.22956 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 147.2calibrated Vbg = 1.22435 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 151.8calibrated Vbg = 1.22039 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 153calibrated Vbg = 1.22105 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 155.7calibrated Vbg = 1.21294 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 156.7calibrated Vbg = 1.21067 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.8calibrated Vbg = 1.20051 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 155.6calibrated Vbg = 1.19436 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 148.6calibrated Vbg = 1.20293 :::*/*/*/*/
[18:20:25.635] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.6calibrated Vbg = 1.20337 :::*/*/*/*/
[18:20:25.637] <TB1> INFO: ----------------------------------------------------------------------
[18:20:25.637] <TB1> INFO: PixTestReadback::CalibrateIa()
[18:20:25.637] <TB1> INFO: ----------------------------------------------------------------------
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C0.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C1.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C2.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C3.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C4.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C5.dat
[18:23:00.939] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C6.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C7.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C8.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C9.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C10.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C11.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C12.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C13.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C14.dat
[18:23:00.940] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2230_FullQualification_2016-05-10_13h53m_1462881200//004_FulltestPxar_p17//readbackCal_C15.dat
[18:23:00.963] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[18:23:00.974] <TB1> INFO: PixTestReadback::doTest() done
[18:23:00.974] <TB1> INFO: Decoding statistics:
[18:23:00.974] <TB1> INFO: General information:
[18:23:00.974] <TB1> INFO: 16bit words read: 1024
[18:23:00.974] <TB1> INFO: valid events total: 128
[18:23:00.974] <TB1> INFO: empty events: 128
[18:23:00.974] <TB1> INFO: valid events with pixels: 0
[18:23:00.974] <TB1> INFO: valid pixel hits: 0
[18:23:00.974] <TB1> INFO: Event errors: 0
[18:23:00.974] <TB1> INFO: start marker: 0
[18:23:00.974] <TB1> INFO: stop marker: 0
[18:23:00.974] <TB1> INFO: overflow: 0
[18:23:00.974] <TB1> INFO: invalid 5bit words: 0
[18:23:00.974] <TB1> INFO: invalid XOR eye diagram: 0
[18:23:00.974] <TB1> INFO: frame (failed synchr.): 0
[18:23:00.974] <TB1> INFO: idle data (no TBM trl): 0
[18:23:00.974] <TB1> INFO: no data (only TBM hdr): 0
[18:23:00.974] <TB1> INFO: TBM errors: 0
[18:23:00.974] <TB1> INFO: flawed TBM headers: 0
[18:23:00.974] <TB1> INFO: flawed TBM trailers: 0
[18:23:00.974] <TB1> INFO: event ID mismatches: 0
[18:23:00.974] <TB1> INFO: ROC errors: 0
[18:23:00.974] <TB1> INFO: missing ROC header(s): 0
[18:23:00.974] <TB1> INFO: misplaced readback start: 0
[18:23:00.974] <TB1> INFO: Pixel decoding errors: 0
[18:23:00.974] <TB1> INFO: pixel data incomplete: 0
[18:23:00.974] <TB1> INFO: pixel address: 0
[18:23:00.974] <TB1> INFO: pulse height fill bit: 0
[18:23:00.974] <TB1> INFO: buffer corruption: 0
[18:23:01.069] <TB1> INFO: Decoding statistics:
[18:23:01.069] <TB1> INFO: General information:
[18:23:01.070] <TB1> INFO: 16bit words read: 2755364
[18:23:01.070] <TB1> INFO: valid events total: 176768
[18:23:01.070] <TB1> INFO: empty events: 7863
[18:23:01.070] <TB1> INFO: valid events with pixels: 168905
[18:23:01.070] <TB1> INFO: valid pixel hits: 668087
[18:23:01.070] <TB1> INFO: Event errors: 0
[18:23:01.070] <TB1> INFO: start marker: 0
[18:23:01.070] <TB1> INFO: stop marker: 0
[18:23:01.070] <TB1> INFO: overflow: 0
[18:23:01.070] <TB1> INFO: invalid 5bit words: 0
[18:23:01.070] <TB1> INFO: invalid XOR eye diagram: 0
[18:23:01.070] <TB1> INFO: frame (failed synchr.): 0
[18:23:01.070] <TB1> INFO: idle data (no TBM trl): 0
[18:23:01.070] <TB1> INFO: no data (only TBM hdr): 0
[18:23:01.070] <TB1> INFO: TBM errors: 0
[18:23:01.070] <TB1> INFO: flawed TBM headers: 0
[18:23:01.070] <TB1> INFO: flawed TBM trailers: 0
[18:23:01.070] <TB1> INFO: event ID mismatches: 0
[18:23:01.070] <TB1> INFO: ROC errors: 0
[18:23:01.070] <TB1> INFO: missing ROC header(s): 0
[18:23:01.070] <TB1> INFO: misplaced readback start: 0
[18:23:01.070] <TB1> INFO: Pixel decoding errors: 0
[18:23:01.070] <TB1> INFO: pixel data incomplete: 0
[18:23:01.070] <TB1> INFO: pixel address: 0
[18:23:01.070] <TB1> INFO: pulse height fill bit: 0
[18:23:01.070] <TB1> INFO: buffer corruption: 0
[18:23:01.070] <TB1> INFO: enter test to run
[18:23:01.070] <TB1> INFO: test: exit no parameter change
[18:23:01.272] <TB1> QUIET: Connection to board 153 closed.
[18:23:01.352] <TB1> INFO: pXar: this is the end, my friend