[12:49:17.276] <TB0> INFO: *** Welcome to pxar ***
[12:49:17.276] <TB0> INFO: *** Today: 2016/02/23
[12:49:17.823] <TB0> INFO: *** Version: 9751-dirty
[12:49:17.823] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C15.dat
[12:49:17.824] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:49:17.824] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//defaultMaskFile.dat
[12:49:17.824] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters_C15.dat
[12:49:17.888] <TB0> INFO: clk: 4
[12:49:17.888] <TB0> INFO: ctr: 4
[12:49:17.888] <TB0> INFO: sda: 19
[12:49:17.888] <TB0> INFO: tin: 9
[12:49:17.888] <TB0> INFO: level: 15
[12:49:17.888] <TB0> INFO: triggerdelay: 0
[12:49:17.888] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[12:49:17.888] <TB0> INFO: Log level: INFO
[12:49:17.895] <TB0> INFO: Found DTB DTB_WS6AYH
[12:49:17.907] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[12:49:17.909] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[12:49:17.910] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[12:49:19.436] <TB0> INFO: DUT info:
[12:49:19.436] <TB0> INFO: The DUT currently contains the following objects:
[12:49:19.436] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[12:49:19.436] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:49:19.436] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:49:19.436] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:49:19.436] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.436] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:49:19.837] <TB0> INFO: enter 'restricted' command line mode
[12:49:19.837] <TB0> INFO: enter test to run
[12:49:19.837] <TB0> INFO: test: pretest no parameter change
[12:49:19.837] <TB0> INFO: running: pretest
[12:49:19.841] <TB0> INFO: ----------------------------------------------------------------------
[12:49:19.841] <TB0> INFO: PixTestPretest::programROC()
[12:49:19.841] <TB0> INFO: ----------------------------------------------------------------------
[12:49:37.857] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:49:37.857] <TB0> INFO: IA differences per ROC: 20.1 20.9 20.1 17.7 18.5 18.5 20.1 19.3 19.3 20.9 20.9 18.5 20.9 17.7 17.7 19.3
[12:49:38.075] <TB0> INFO: enter test to run
[12:49:38.075] <TB0> INFO: test: pretest no parameter change
[12:49:38.075] <TB0> INFO: running: pretest
[12:49:38.077] <TB0> INFO: ----------------------------------------------------------------------
[12:49:38.077] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:49:38.077] <TB0> INFO: ----------------------------------------------------------------------
[12:49:45.072] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 392.3 mA = 24.5187 mA/ROC
[12:49:45.072] <TB0> INFO: i(loss) [mA/ROC]: 20.1 20.1 19.3 19.3 20.1 19.3 19.3 20.1 19.3 19.3 20.1 20.1 20.1 20.1 19.3 18.5
[12:49:45.108] <TB0> INFO: enter test to run
[12:49:45.108] <TB0> INFO: test: pretest no parameter change
[12:49:45.108] <TB0> INFO: running: pretest
[12:49:45.108] <TB0> INFO: ----------------------------------------------------------------------
[12:49:45.108] <TB0> INFO: PixTestPretest::findTiming()
[12:49:45.108] <TB0> INFO: ----------------------------------------------------------------------
[12:49:45.108] <TB0> INFO: PixTestCmd::init()
[12:49:46.069] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!
[12:51:14.455] <TB0> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[12:51:14.455] <TB0> INFO: (success/tries = 100/100), width = 4
[12:51:14.456] <TB0> INFO: enter test to run
[12:51:14.456] <TB0> INFO: test: pretest no parameter change
[12:51:14.456] <TB0> INFO: running: pretest
[12:51:14.457] <TB0> INFO: ----------------------------------------------------------------------
[12:51:14.458] <TB0> INFO: PixTestPretest::findWorkingPixel()
[12:51:14.458] <TB0> INFO: ----------------------------------------------------------------------
[12:51:14.550] <TB0> INFO: Expecting 231680 events.
[12:51:20.324] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[12:51:20.408] <TB0> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[12:51:24.675] <TB0> INFO: 231680 events read in total (9569ms).
[12:51:24.679] <TB0> INFO: Test took 10217ms.
[12:51:24.903] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:51:24.976] <TB0> INFO: enter test to run
[12:51:24.976] <TB0> INFO: test: pretest no parameter change
[12:51:24.976] <TB0> INFO: running: pretest
[12:51:24.977] <TB0> INFO: ----------------------------------------------------------------------
[12:51:24.977] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[12:51:24.977] <TB0> INFO: ----------------------------------------------------------------------
[12:51:25.069] <TB0> INFO: Expecting 231680 events.
[12:51:35.333] <TB0> INFO: 231680 events read in total (9709ms).
[12:51:35.338] <TB0> INFO: Test took 10357ms.
[12:51:35.602] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[12:51:35.602] <TB0> INFO: CalDel: 141 154 135 143 152 114 146 155 147 155 155 142 152 149 131 161
[12:51:35.602] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[12:51:35.644] <TB0> INFO: enter test to run
[12:51:35.644] <TB0> INFO: test: pretest no parameter change
[12:51:35.644] <TB0> INFO: running: pretest
[12:51:35.644] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C0.dat
[12:51:35.644] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C1.dat
[12:51:35.644] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C2.dat
[12:51:35.644] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C3.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C4.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C5.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C6.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C7.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C8.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C9.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C10.dat
[12:51:35.645] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C11.dat
[12:51:35.646] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C12.dat
[12:51:35.646] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C13.dat
[12:51:35.646] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C14.dat
[12:51:35.646] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters_C15.dat
[12:51:35.646] <TB0> INFO: enter test to run
[12:51:35.646] <TB0> INFO: test: fulltest no parameter change
[12:51:35.646] <TB0> INFO: running: fulltest
[12:51:35.646] <TB0> INFO: ######################################################################
[12:51:35.646] <TB0> INFO: PixTestFullTest::doTest()
[12:51:35.646] <TB0> INFO: ######################################################################
[12:51:35.647] <TB0> INFO: ######################################################################
[12:51:35.647] <TB0> INFO: PixTestAlive::doTest()
[12:51:35.647] <TB0> INFO: ######################################################################
[12:51:35.649] <TB0> INFO: ----------------------------------------------------------------------
[12:51:35.649] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:51:35.649] <TB0> INFO: ----------------------------------------------------------------------
[12:51:35.914] <TB0> INFO: Expecting 41600 events.
[12:51:39.712] <TB0> INFO: 41600 events read in total (3242ms).
[12:51:39.712] <TB0> INFO: Test took 4062ms.
[12:51:39.940] <TB0> INFO: PixTestAlive::aliveTest() done
[12:51:39.940] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1
[12:51:39.942] <TB0> INFO: ----------------------------------------------------------------------
[12:51:39.942] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:51:39.942] <TB0> INFO: ----------------------------------------------------------------------
[12:51:40.235] <TB0> INFO: Expecting 41600 events.
[12:51:43.207] <TB0> INFO: 41600 events read in total (2416ms).
[12:51:43.207] <TB0> INFO: Test took 3263ms.
[12:51:43.208] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:51:43.451] <TB0> INFO: PixTestAlive::maskTest() done
[12:51:43.451] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:51:43.453] <TB0> INFO: ----------------------------------------------------------------------
[12:51:43.453] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:51:43.453] <TB0> INFO: ----------------------------------------------------------------------
[12:51:43.725] <TB0> INFO: Expecting 41600 events.
[12:51:47.490] <TB0> INFO: 41600 events read in total (3209ms).
[12:51:47.491] <TB0> INFO: Test took 4037ms.
[12:51:47.721] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[12:51:47.721] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:51:47.721] <TB0> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[12:51:47.721] <TB0> INFO: Decoding statistics:
[12:51:47.721] <TB0> INFO: General information:
[12:51:47.721] <TB0> INFO: 16bit words read: 0
[12:51:47.721] <TB0> INFO: valid events total: 0
[12:51:47.721] <TB0> INFO: empty events: 0
[12:51:47.721] <TB0> INFO: valid events with pixels: 0
[12:51:47.721] <TB0> INFO: valid pixel hits: 0
[12:51:47.721] <TB0> INFO: Event errors: 0
[12:51:47.721] <TB0> INFO: start marker: 0
[12:51:47.721] <TB0> INFO: stop marker: 0
[12:51:47.721] <TB0> INFO: overflow: 0
[12:51:47.721] <TB0> INFO: invalid 5bit words: 0
[12:51:47.721] <TB0> INFO: invalid XOR eye diagram: 0
[12:51:47.721] <TB0> INFO: frame (failed synchr.): 0
[12:51:47.721] <TB0> INFO: idle data (no TBM trl): 0
[12:51:47.721] <TB0> INFO: no data (only TBM hdr): 0
[12:51:47.721] <TB0> INFO: TBM errors: 0
[12:51:47.722] <TB0> INFO: flawed TBM headers: 0
[12:51:47.722] <TB0> INFO: flawed TBM trailers: 0
[12:51:47.722] <TB0> INFO: event ID mismatches: 0
[12:51:47.722] <TB0> INFO: ROC errors: 0
[12:51:47.722] <TB0> INFO: missing ROC header(s): 0
[12:51:47.722] <TB0> INFO: misplaced readback start: 0
[12:51:47.722] <TB0> INFO: Pixel decoding errors: 0
[12:51:47.722] <TB0> INFO: pixel data incomplete: 0
[12:51:47.722] <TB0> INFO: pixel address: 0
[12:51:47.722] <TB0> INFO: pulse height fill bit: 0
[12:51:47.722] <TB0> INFO: buffer corruption: 0
[12:51:47.737] <TB0> INFO: ######################################################################
[12:51:47.738] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:51:47.738] <TB0> INFO: ######################################################################
[12:51:47.740] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:51:47.753] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:51:47.753] <TB0> INFO: run 1 of 1
[12:51:48.038] <TB0> INFO: Expecting 3120000 events.
[12:52:29.105] <TB0> INFO: 860450 events read in total (40511ms).
[12:53:09.856] <TB0> INFO: 1717300 events read in total (81263ms).
[12:53:50.560] <TB0> INFO: 2586470 events read in total (121967ms).
[12:54:15.533] <TB0> INFO: 3120000 events read in total (146939ms).
[12:54:15.584] <TB0> INFO: Test took 147831ms.
[12:54:39.520] <TB0> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[12:54:39.520] <TB0> INFO: number of dead bumps (per ROC): 5 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:54:39.520] <TB0> INFO: separation cut (per ROC): 92 98 102 76 86 103 75 83 100 99 97 88 109 105 100 75
[12:54:39.520] <TB0> INFO: Decoding statistics:
[12:54:39.520] <TB0> INFO: General information:
[12:54:39.520] <TB0> INFO: 16bit words read: 0
[12:54:39.520] <TB0> INFO: valid events total: 0
[12:54:39.520] <TB0> INFO: empty events: 0
[12:54:39.520] <TB0> INFO: valid events with pixels: 0
[12:54:39.520] <TB0> INFO: valid pixel hits: 0
[12:54:39.520] <TB0> INFO: Event errors: 0
[12:54:39.520] <TB0> INFO: start marker: 0
[12:54:39.520] <TB0> INFO: stop marker: 0
[12:54:39.520] <TB0> INFO: overflow: 0
[12:54:39.520] <TB0> INFO: invalid 5bit words: 0
[12:54:39.520] <TB0> INFO: invalid XOR eye diagram: 0
[12:54:39.520] <TB0> INFO: frame (failed synchr.): 0
[12:54:39.520] <TB0> INFO: idle data (no TBM trl): 0
[12:54:39.520] <TB0> INFO: no data (only TBM hdr): 0
[12:54:39.520] <TB0> INFO: TBM errors: 0
[12:54:39.520] <TB0> INFO: flawed TBM headers: 0
[12:54:39.520] <TB0> INFO: flawed TBM trailers: 0
[12:54:39.520] <TB0> INFO: event ID mismatches: 0
[12:54:39.520] <TB0> INFO: ROC errors: 0
[12:54:39.520] <TB0> INFO: missing ROC header(s): 0
[12:54:39.520] <TB0> INFO: misplaced readback start: 0
[12:54:39.520] <TB0> INFO: Pixel decoding errors: 0
[12:54:39.520] <TB0> INFO: pixel data incomplete: 0
[12:54:39.520] <TB0> INFO: pixel address: 0
[12:54:39.520] <TB0> INFO: pulse height fill bit: 0
[12:54:39.520] <TB0> INFO: buffer corruption: 0
[12:54:39.591] <TB0> INFO: ######################################################################
[12:54:39.591] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:54:39.591] <TB0> INFO: ######################################################################
[12:54:39.591] <TB0> INFO: ----------------------------------------------------------------------
[12:54:39.591] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:54:39.591] <TB0> INFO: ----------------------------------------------------------------------
[12:54:39.591] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:54:39.601] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[12:54:39.601] <TB0> INFO: run 1 of 1
[12:54:39.871] <TB0> INFO: Expecting 26208000 events.
[12:55:15.257] <TB0> INFO: 893200 events read in total (34830ms).
[12:55:48.095] <TB0> INFO: 1774300 events read in total (67668ms).
[12:56:20.944] <TB0> INFO: 2652000 events read in total (100517ms).
[12:56:53.908] <TB0> INFO: 3529200 events read in total (133481ms).
[12:57:26.309] <TB0> INFO: 4402700 events read in total (165882ms).
[12:57:59.024] <TB0> INFO: 5277950 events read in total (198597ms).
[12:58:31.620] <TB0> INFO: 6154700 events read in total (231193ms).
[12:59:04.598] <TB0> INFO: 7028100 events read in total (264171ms).
[12:59:37.535] <TB0> INFO: 7899950 events read in total (297108ms).
[13:00:10.179] <TB0> INFO: 8774250 events read in total (329752ms).
[13:00:42.531] <TB0> INFO: 9649000 events read in total (362104ms).
[13:01:15.258] <TB0> INFO: 10519500 events read in total (394831ms).
[13:01:48.467] <TB0> INFO: 11390550 events read in total (428040ms).
[13:02:21.093] <TB0> INFO: 12263350 events read in total (460666ms).
[13:02:54.150] <TB0> INFO: 13132950 events read in total (493723ms).
[13:03:26.717] <TB0> INFO: 13992150 events read in total (526290ms).
[13:03:59.247] <TB0> INFO: 14853750 events read in total (558820ms).
[13:04:32.213] <TB0> INFO: 15716200 events read in total (591786ms).
[13:05:05.369] <TB0> INFO: 16573800 events read in total (624942ms).
[13:05:38.473] <TB0> INFO: 17433050 events read in total (658046ms).
[13:06:11.019] <TB0> INFO: 18293450 events read in total (690592ms).
[13:06:43.754] <TB0> INFO: 19150700 events read in total (723327ms).
[13:07:16.600] <TB0> INFO: 20007850 events read in total (756173ms).
[13:07:49.261] <TB0> INFO: 20865300 events read in total (788834ms).
[13:08:21.939] <TB0> INFO: 21723750 events read in total (821512ms).
[13:08:55.427] <TB0> INFO: 22578150 events read in total (855000ms).
[13:09:28.999] <TB0> INFO: 23436900 events read in total (888572ms).
[13:10:01.974] <TB0> INFO: 24296850 events read in total (921547ms).
[13:10:34.477] <TB0> INFO: 25155100 events read in total (954050ms).
[13:11:07.072] <TB0> INFO: 26026750 events read in total (986645ms).
[13:11:14.146] <TB0> INFO: 26208000 events read in total (993719ms).
[13:11:14.175] <TB0> INFO: Test took 994574ms.
[13:11:14.411] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:15.785] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:17.195] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:18.684] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:20.171] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:21.536] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:22.964] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:24.655] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:26.044] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:27.613] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:29.069] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:30.603] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:32.046] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:33.501] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:34.949] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:36.451] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:11:37.967] <TB0> INFO: PixTestScurves::scurves() done
[13:11:37.967] <TB0> INFO: Vcal mean: 83.62 84.87 88.78 82.19 89.61 101.47 76.51 83.55 95.74 84.72 93.03 81.39 102.15 94.40 93.57 75.15
[13:11:37.967] <TB0> INFO: Vcal RMS: 5.07 5.39 5.27 4.91 5.52 5.50 4.14 4.57 6.10 5.55 5.33 4.70 6.22 5.69 5.31 4.48
[13:11:37.967] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1018 seconds
[13:11:37.967] <TB0> INFO: Decoding statistics:
[13:11:37.967] <TB0> INFO: General information:
[13:11:37.967] <TB0> INFO: 16bit words read: 0
[13:11:37.967] <TB0> INFO: valid events total: 0
[13:11:37.967] <TB0> INFO: empty events: 0
[13:11:37.967] <TB0> INFO: valid events with pixels: 0
[13:11:37.967] <TB0> INFO: valid pixel hits: 0
[13:11:37.967] <TB0> INFO: Event errors: 0
[13:11:37.967] <TB0> INFO: start marker: 0
[13:11:37.967] <TB0> INFO: stop marker: 0
[13:11:37.967] <TB0> INFO: overflow: 0
[13:11:37.967] <TB0> INFO: invalid 5bit words: 0
[13:11:37.967] <TB0> INFO: invalid XOR eye diagram: 0
[13:11:37.967] <TB0> INFO: frame (failed synchr.): 0
[13:11:37.967] <TB0> INFO: idle data (no TBM trl): 0
[13:11:37.967] <TB0> INFO: no data (only TBM hdr): 0
[13:11:37.967] <TB0> INFO: TBM errors: 0
[13:11:37.967] <TB0> INFO: flawed TBM headers: 0
[13:11:37.967] <TB0> INFO: flawed TBM trailers: 0
[13:11:37.967] <TB0> INFO: event ID mismatches: 0
[13:11:37.967] <TB0> INFO: ROC errors: 0
[13:11:37.967] <TB0> INFO: missing ROC header(s): 0
[13:11:37.967] <TB0> INFO: misplaced readback start: 0
[13:11:37.967] <TB0> INFO: Pixel decoding errors: 0
[13:11:37.968] <TB0> INFO: pixel data incomplete: 0
[13:11:37.968] <TB0> INFO: pixel address: 0
[13:11:37.968] <TB0> INFO: pulse height fill bit: 0
[13:11:37.968] <TB0> INFO: buffer corruption: 0
[13:11:38.040] <TB0> INFO: ######################################################################
[13:11:38.040] <TB0> INFO: PixTestTrim::doTest()
[13:11:38.040] <TB0> INFO: ######################################################################
[13:11:38.041] <TB0> INFO: ----------------------------------------------------------------------
[13:11:38.041] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[13:11:38.041] <TB0> INFO: ----------------------------------------------------------------------
[13:11:38.129] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[13:11:38.129] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:11:38.139] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:11:38.139] <TB0> INFO: run 1 of 1
[13:11:38.402] <TB0> INFO: Expecting 6281600 events.
[13:12:18.241] <TB0> INFO: 1071820 events read in total (39280ms).
[13:12:57.337] <TB0> INFO: 2138110 events read in total (78376ms).
[13:13:36.342] <TB0> INFO: 3197870 events read in total (117381ms).
[13:14:15.283] <TB0> INFO: 4263830 events read in total (156322ms).
[13:14:54.056] <TB0> INFO: 5333450 events read in total (195095ms).
[13:15:28.262] <TB0> INFO: 6281600 events read in total (229301ms).
[13:15:28.295] <TB0> INFO: Test took 230157ms.
[13:15:47.822] <TB0> INFO: ROC 0 VthrComp = 91
[13:15:47.822] <TB0> INFO: ROC 1 VthrComp = 92
[13:15:47.822] <TB0> INFO: ROC 2 VthrComp = 98
[13:15:47.822] <TB0> INFO: ROC 3 VthrComp = 84
[13:15:47.822] <TB0> INFO: ROC 4 VthrComp = 93
[13:15:47.823] <TB0> INFO: ROC 5 VthrComp = 103
[13:15:47.823] <TB0> INFO: ROC 6 VthrComp = 82
[13:15:47.823] <TB0> INFO: ROC 7 VthrComp = 87
[13:15:47.823] <TB0> INFO: ROC 8 VthrComp = 94
[13:15:47.823] <TB0> INFO: ROC 9 VthrComp = 86
[13:15:47.823] <TB0> INFO: ROC 10 VthrComp = 97
[13:15:47.823] <TB0> INFO: ROC 11 VthrComp = 84
[13:15:47.823] <TB0> INFO: ROC 12 VthrComp = 100
[13:15:47.823] <TB0> INFO: ROC 13 VthrComp = 94
[13:15:47.823] <TB0> INFO: ROC 14 VthrComp = 94
[13:15:47.823] <TB0> INFO: ROC 15 VthrComp = 77
[13:15:47.824] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:15:47.824] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:15:47.834] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:15:47.834] <TB0> INFO: run 1 of 1
[13:15:48.116] <TB0> INFO: Expecting 6281600 events.
[13:16:23.439] <TB0> INFO: 756220 events read in total (34766ms).
[13:16:58.040] <TB0> INFO: 1510120 events read in total (69367ms).
[13:17:32.606] <TB0> INFO: 2264130 events read in total (103933ms).
[13:18:07.617] <TB0> INFO: 3018390 events read in total (138944ms).
[13:18:42.078] <TB0> INFO: 3767430 events read in total (173405ms).
[13:19:16.681] <TB0> INFO: 4513100 events read in total (208008ms).
[13:19:51.214] <TB0> INFO: 5256980 events read in total (242541ms).
[13:20:25.816] <TB0> INFO: 6000620 events read in total (277143ms).
[13:20:39.295] <TB0> INFO: 6281600 events read in total (290622ms).
[13:20:39.346] <TB0> INFO: Test took 291512ms.
[13:21:04.335] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 57.7945 for pixel 17/78 mean/min/max = 45.1563/32.3157/57.9969
[13:21:04.335] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 59.1135 for pixel 24/74 mean/min/max = 45.8344/32.1676/59.5012
[13:21:04.335] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 56.2283 for pixel 51/66 mean/min/max = 43.76/31.2552/56.2647
[13:21:04.335] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 59.0555 for pixel 9/79 mean/min/max = 45.5944/32.1162/59.0725
[13:21:04.336] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 59.3885 for pixel 1/79 mean/min/max = 45.7553/32.0561/59.4544
[13:21:04.336] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 59.3275 for pixel 51/17 mean/min/max = 46.1113/32.6852/59.5374
[13:21:04.336] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 56.8796 for pixel 8/1 mean/min/max = 44.9667/32.9818/56.9516
[13:21:04.337] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 56.9144 for pixel 3/10 mean/min/max = 44.7552/32.3536/57.1569
[13:21:04.337] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 61.0563 for pixel 23/3 mean/min/max = 46.072/30.9515/61.1924
[13:21:04.337] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 60.8018 for pixel 0/76 mean/min/max = 46.2581/31.5805/60.9357
[13:21:04.337] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 58.3573 for pixel 51/0 mean/min/max = 45.1911/31.9819/58.4002
[13:21:04.338] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 58.692 for pixel 16/18 mean/min/max = 45.3234/31.855/58.7917
[13:21:04.338] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 61.9196 for pixel 5/79 mean/min/max = 46.9551/31.8175/62.0927
[13:21:04.338] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.9473 for pixel 16/74 mean/min/max = 46.5108/32.0723/60.9493
[13:21:04.339] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 58.2424 for pixel 51/37 mean/min/max = 45.2608/32.1666/58.355
[13:21:04.339] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 58.6891 for pixel 46/3 mean/min/max = 47.1628/35.6254/58.7001
[13:21:04.339] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:21:04.428] <TB0> INFO: Expecting 514560 events.
[13:21:17.310] <TB0> INFO: 514560 events read in total (12326ms).
[13:21:17.316] <TB0> INFO: Expecting 514560 events.
[13:21:29.968] <TB0> INFO: 514560 events read in total (12237ms).
[13:21:29.976] <TB0> INFO: Expecting 514560 events.
[13:21:42.600] <TB0> INFO: 514560 events read in total (12208ms).
[13:21:42.610] <TB0> INFO: Expecting 514560 events.
[13:21:55.320] <TB0> INFO: 514560 events read in total (12296ms).
[13:21:55.330] <TB0> INFO: Expecting 514560 events.
[13:22:08.175] <TB0> INFO: 514560 events read in total (12431ms).
[13:22:08.187] <TB0> INFO: Expecting 514560 events.
[13:22:21.056] <TB0> INFO: 514560 events read in total (12452ms).
[13:22:21.071] <TB0> INFO: Expecting 514560 events.
[13:22:34.044] <TB0> INFO: 514560 events read in total (12560ms).
[13:22:34.062] <TB0> INFO: Expecting 514560 events.
[13:22:46.889] <TB0> INFO: 514560 events read in total (12423ms).
[13:22:46.909] <TB0> INFO: Expecting 514560 events.
[13:22:59.781] <TB0> INFO: 514560 events read in total (12465ms).
[13:22:59.801] <TB0> INFO: Expecting 514560 events.
[13:23:12.673] <TB0> INFO: 514560 events read in total (12467ms).
[13:23:12.699] <TB0> INFO: Expecting 514560 events.
[13:23:25.587] <TB0> INFO: 514560 events read in total (12487ms).
[13:23:25.612] <TB0> INFO: Expecting 514560 events.
[13:23:38.736] <TB0> INFO: 514560 events read in total (12722ms).
[13:23:38.763] <TB0> INFO: Expecting 514560 events.
[13:23:51.659] <TB0> INFO: 514560 events read in total (12495ms).
[13:23:51.688] <TB0> INFO: Expecting 514560 events.
[13:24:04.697] <TB0> INFO: 514560 events read in total (12607ms).
[13:24:04.730] <TB0> INFO: Expecting 514560 events.
[13:24:17.529] <TB0> INFO: 514560 events read in total (12397ms).
[13:24:17.558] <TB0> INFO: Expecting 514560 events.
[13:24:30.404] <TB0> INFO: 514560 events read in total (12444ms).
[13:24:30.436] <TB0> INFO: Test took 206097ms.
[13:24:31.352] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:24:31.361] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:24:31.361] <TB0> INFO: run 1 of 1
[13:24:31.630] <TB0> INFO: Expecting 6281600 events.
[13:25:06.759] <TB0> INFO: 743350 events read in total (34572ms).
[13:25:41.548] <TB0> INFO: 1485330 events read in total (69361ms).
[13:26:16.164] <TB0> INFO: 2227190 events read in total (103977ms).
[13:26:51.101] <TB0> INFO: 2970120 events read in total (138914ms).
[13:27:25.598] <TB0> INFO: 3706960 events read in total (173411ms).
[13:28:00.069] <TB0> INFO: 4440220 events read in total (207882ms).
[13:28:33.940] <TB0> INFO: 5171700 events read in total (241753ms).
[13:29:08.289] <TB0> INFO: 5902280 events read in total (276102ms).
[13:29:26.045] <TB0> INFO: 6281600 events read in total (293858ms).
[13:29:26.098] <TB0> INFO: Test took 294737ms.
[13:29:50.508] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.025485 .. 255.000000
[13:29:50.585] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[13:29:50.594] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:29:50.594] <TB0> INFO: run 1 of 1
[13:29:50.858] <TB0> INFO: Expecting 10649600 events.
[13:30:25.782] <TB0> INFO: 712490 events read in total (34368ms).
[13:31:00.362] <TB0> INFO: 1424740 events read in total (68948ms).
[13:31:34.155] <TB0> INFO: 2137130 events read in total (102741ms).
[13:32:08.058] <TB0> INFO: 2849800 events read in total (136644ms).
[13:32:42.398] <TB0> INFO: 3562420 events read in total (170984ms).
[13:33:16.785] <TB0> INFO: 4275030 events read in total (205371ms).
[13:33:50.878] <TB0> INFO: 4987860 events read in total (239464ms).
[13:34:25.127] <TB0> INFO: 5700190 events read in total (273713ms).
[13:34:59.737] <TB0> INFO: 6412510 events read in total (308323ms).
[13:35:33.986] <TB0> INFO: 7124040 events read in total (342572ms).
[13:36:08.055] <TB0> INFO: 7835380 events read in total (376641ms).
[13:36:42.414] <TB0> INFO: 8546480 events read in total (411000ms).
[13:37:16.277] <TB0> INFO: 9257560 events read in total (444863ms).
[13:37:50.226] <TB0> INFO: 9968270 events read in total (478812ms).
[13:38:23.369] <TB0> INFO: 10649600 events read in total (511955ms).
[13:38:23.474] <TB0> INFO: Test took 512881ms.
[13:38:55.686] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 12.989980 .. 47.556362
[13:38:55.762] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 2 .. 57 (-1/-1) hits flags = 528 (plus default)
[13:38:55.772] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:38:55.772] <TB0> INFO: run 1 of 1
[13:38:56.033] <TB0> INFO: Expecting 2329600 events.
[13:39:37.108] <TB0> INFO: 939550 events read in total (40519ms).
[13:40:14.935] <TB0> INFO: 1877780 events read in total (78346ms).
[13:40:33.412] <TB0> INFO: 2329600 events read in total (96823ms).
[13:40:33.427] <TB0> INFO: Test took 97655ms.
[13:40:47.345] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 18.533044 .. 46.692032
[13:40:47.431] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 8 .. 56 (-1/-1) hits flags = 528 (plus default)
[13:40:47.444] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:40:47.444] <TB0> INFO: run 1 of 1
[13:40:47.741] <TB0> INFO: Expecting 2038400 events.
[13:41:25.540] <TB0> INFO: 917010 events read in total (37242ms).
[13:42:02.969] <TB0> INFO: 1832430 events read in total (74671ms).
[13:42:11.884] <TB0> INFO: 2038400 events read in total (83586ms).
[13:42:11.901] <TB0> INFO: Test took 84457ms.
[13:42:25.160] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 21.176945 .. 46.692032
[13:42:25.238] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 11 .. 56 (-1/-1) hits flags = 528 (plus default)
[13:42:25.248] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:42:25.248] <TB0> INFO: run 1 of 1
[13:42:25.508] <TB0> INFO: Expecting 1913600 events.
[13:43:03.719] <TB0> INFO: 898850 events read in total (37654ms).
[13:43:40.671] <TB0> INFO: 1797340 events read in total (74607ms).
[13:43:45.848] <TB0> INFO: 1913600 events read in total (79784ms).
[13:43:45.865] <TB0> INFO: Test took 80618ms.
[13:44:00.253] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[13:44:00.253] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:44:00.262] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:44:00.262] <TB0> INFO: run 1 of 1
[13:44:00.525] <TB0> INFO: Expecting 1705600 events.
[13:44:38.548] <TB0> INFO: 879680 events read in total (37466ms).
[13:45:13.897] <TB0> INFO: 1705600 events read in total (72815ms).
[13:45:13.913] <TB0> INFO: Test took 73651ms.
[13:45:28.413] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:45:28.413] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:45:28.413] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:45:28.413] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:45:28.414] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:45:28.414] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:45:28.414] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:45:28.414] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:45:28.414] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:45:28.415] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:45:28.416] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:45:28.416] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C0.dat
[13:45:28.425] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C1.dat
[13:45:28.434] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C2.dat
[13:45:28.443] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C3.dat
[13:45:28.450] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C4.dat
[13:45:28.458] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C5.dat
[13:45:28.467] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C6.dat
[13:45:28.477] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C7.dat
[13:45:28.486] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C8.dat
[13:45:28.495] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C9.dat
[13:45:28.504] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C10.dat
[13:45:28.512] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C11.dat
[13:45:28.522] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C12.dat
[13:45:28.531] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C13.dat
[13:45:28.539] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C14.dat
[13:45:28.548] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//trimParameters35_C15.dat
[13:45:28.557] <TB0> INFO: PixTestTrim::trimTest() done
[13:45:28.557] <TB0> INFO: vtrim: 110 105 95 95 93 98 88 89 104 97 92 105 99 95 78 91
[13:45:28.557] <TB0> INFO: vthrcomp: 91 92 98 84 93 103 82 87 94 86 97 84 100 94 94 77
[13:45:28.557] <TB0> INFO: vcal mean: 34.98 34.99 35.00 34.98 34.96 34.96 34.99 34.98 34.96 34.99 35.01 34.98 34.99 34.96 34.98 34.98
[13:45:28.557] <TB0> INFO: vcal RMS: 0.81 0.85 0.78 0.87 0.96 0.87 0.78 0.78 1.09 1.01 0.84 0.84 0.86 0.88 0.84 0.96
[13:45:28.557] <TB0> INFO: bits mean: 9.55 9.45 9.58 9.19 8.97 8.79 9.38 9.33 9.62 8.83 8.92 9.64 8.88 9.54 9.01 8.58
[13:45:28.557] <TB0> INFO: bits RMS: 2.66 2.66 2.89 2.82 2.89 2.85 2.70 2.77 2.68 3.01 3.00 2.67 2.87 2.58 2.89 2.48
[13:45:28.563] <TB0> INFO: ----------------------------------------------------------------------
[13:45:28.563] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[13:45:28.563] <TB0> INFO: ----------------------------------------------------------------------
[13:45:28.565] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[13:45:28.575] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:45:28.575] <TB0> INFO: run 1 of 1
[13:45:28.866] <TB0> INFO: Expecting 4160000 events.
[13:46:10.704] <TB0> INFO: 920720 events read in total (41282ms).
[13:46:51.866] <TB0> INFO: 1835660 events read in total (82444ms).
[13:47:32.859] <TB0> INFO: 2743215 events read in total (123438ms).
[13:48:13.732] <TB0> INFO: 3647750 events read in total (164310ms).
[13:48:36.973] <TB0> INFO: 4160000 events read in total (187551ms).
[13:48:37.011] <TB0> INFO: Test took 188437ms.
[13:49:07.023] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 177 (-1/-1) hits flags = 528 (plus default)
[13:49:07.032] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:49:07.032] <TB0> INFO: run 1 of 1
[13:49:07.306] <TB0> INFO: Expecting 3702400 events.
[13:49:49.372] <TB0> INFO: 932590 events read in total (41510ms).
[13:50:30.707] <TB0> INFO: 1858065 events read in total (82846ms).
[13:51:12.152] <TB0> INFO: 2772710 events read in total (124290ms).
[13:51:53.657] <TB0> INFO: 3688920 events read in total (165795ms).
[13:51:54.636] <TB0> INFO: 3702400 events read in total (166774ms).
[13:51:54.674] <TB0> INFO: Test took 167642ms.
[13:52:23.183] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 164 (-1/-1) hits flags = 528 (plus default)
[13:52:23.195] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:52:23.195] <TB0> INFO: run 1 of 1
[13:52:23.514] <TB0> INFO: Expecting 3432000 events.
[13:53:06.503] <TB0> INFO: 962160 events read in total (42433ms).
[13:53:49.059] <TB0> INFO: 1914635 events read in total (84989ms).
[13:54:31.097] <TB0> INFO: 2856605 events read in total (127027ms).
[13:54:56.728] <TB0> INFO: 3432000 events read in total (152658ms).
[13:54:56.761] <TB0> INFO: Test took 153566ms.
[13:55:23.610] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 164 (-1/-1) hits flags = 528 (plus default)
[13:55:23.620] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:55:23.620] <TB0> INFO: run 1 of 1
[13:55:23.883] <TB0> INFO: Expecting 3432000 events.
[13:56:07.071] <TB0> INFO: 961350 events read in total (42632ms).
[13:56:49.276] <TB0> INFO: 1913020 events read in total (84837ms).
[13:57:31.320] <TB0> INFO: 2854355 events read in total (126882ms).
[13:57:57.139] <TB0> INFO: 3432000 events read in total (152700ms).
[13:57:57.181] <TB0> INFO: Test took 153561ms.
[13:58:23.072] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 163 (-1/-1) hits flags = 528 (plus default)
[13:58:23.082] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:58:23.082] <TB0> INFO: run 1 of 1
[13:58:23.353] <TB0> INFO: Expecting 3411200 events.
[13:59:06.382] <TB0> INFO: 963370 events read in total (42473ms).
[13:59:48.368] <TB0> INFO: 1916875 events read in total (84459ms).
[14:00:29.815] <TB0> INFO: 2859685 events read in total (125907ms).
[14:00:54.668] <TB0> INFO: 3411200 events read in total (150759ms).
[14:00:54.716] <TB0> INFO: Test took 151634ms.
[14:01:21.534] <TB0> INFO: PixTestTrim::trimBitTest() done
[14:01:21.535] <TB0> INFO: PixTestTrim::doTest() done, duration: 2983 seconds
[14:01:21.535] <TB0> INFO: Decoding statistics:
[14:01:21.535] <TB0> INFO: General information:
[14:01:21.535] <TB0> INFO: 16bit words read: 0
[14:01:21.535] <TB0> INFO: valid events total: 0
[14:01:21.535] <TB0> INFO: empty events: 0
[14:01:21.535] <TB0> INFO: valid events with pixels: 0
[14:01:21.535] <TB0> INFO: valid pixel hits: 0
[14:01:21.535] <TB0> INFO: Event errors: 0
[14:01:21.535] <TB0> INFO: start marker: 0
[14:01:21.535] <TB0> INFO: stop marker: 0
[14:01:21.535] <TB0> INFO: overflow: 0
[14:01:21.535] <TB0> INFO: invalid 5bit words: 0
[14:01:21.535] <TB0> INFO: invalid XOR eye diagram: 0
[14:01:21.535] <TB0> INFO: frame (failed synchr.): 0
[14:01:21.535] <TB0> INFO: idle data (no TBM trl): 0
[14:01:21.535] <TB0> INFO: no data (only TBM hdr): 0
[14:01:21.535] <TB0> INFO: TBM errors: 0
[14:01:21.535] <TB0> INFO: flawed TBM headers: 0
[14:01:21.535] <TB0> INFO: flawed TBM trailers: 0
[14:01:21.535] <TB0> INFO: event ID mismatches: 0
[14:01:21.535] <TB0> INFO: ROC errors: 0
[14:01:21.535] <TB0> INFO: missing ROC header(s): 0
[14:01:21.535] <TB0> INFO: misplaced readback start: 0
[14:01:21.535] <TB0> INFO: Pixel decoding errors: 0
[14:01:21.535] <TB0> INFO: pixel data incomplete: 0
[14:01:21.535] <TB0> INFO: pixel address: 0
[14:01:21.535] <TB0> INFO: pulse height fill bit: 0
[14:01:21.535] <TB0> INFO: buffer corruption: 0
[14:01:22.226] <TB0> INFO: ######################################################################
[14:01:22.226] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[14:01:22.226] <TB0> INFO: ######################################################################
[14:01:22.507] <TB0> INFO: Expecting 41600 events.
[14:01:26.289] <TB0> INFO: 41600 events read in total (3226ms).
[14:01:26.289] <TB0> INFO: Test took 4060ms.
[14:01:26.757] <TB0> INFO: Expecting 41600 events.
[14:01:30.519] <TB0> INFO: 41600 events read in total (3206ms).
[14:01:30.519] <TB0> INFO: Test took 4024ms.
[14:01:30.800] <TB0> INFO: Expecting 41600 events.
[14:01:34.556] <TB0> INFO: 41600 events read in total (3200ms).
[14:01:34.559] <TB0> INFO: Test took 4019ms.
[14:01:34.815] <TB0> INFO: Expecting 2560 events.
[14:01:35.668] <TB0> INFO: 2560 events read in total (297ms).
[14:01:35.668] <TB0> INFO: Test took 1095ms.
[14:01:35.973] <TB0> INFO: Expecting 2560 events.
[14:01:36.828] <TB0> INFO: 2560 events read in total (299ms).
[14:01:36.828] <TB0> INFO: Test took 1160ms.
[14:01:37.133] <TB0> INFO: Expecting 2560 events.
[14:01:37.988] <TB0> INFO: 2560 events read in total (299ms).
[14:01:37.988] <TB0> INFO: Test took 1159ms.
[14:01:38.293] <TB0> INFO: Expecting 2560 events.
[14:01:39.148] <TB0> INFO: 2560 events read in total (299ms).
[14:01:39.148] <TB0> INFO: Test took 1159ms.
[14:01:39.453] <TB0> INFO: Expecting 2560 events.
[14:01:40.308] <TB0> INFO: 2560 events read in total (299ms).
[14:01:40.308] <TB0> INFO: Test took 1160ms.
[14:01:40.613] <TB0> INFO: Expecting 2560 events.
[14:01:41.466] <TB0> INFO: 2560 events read in total (297ms).
[14:01:41.466] <TB0> INFO: Test took 1158ms.
[14:01:41.771] <TB0> INFO: Expecting 2560 events.
[14:01:42.624] <TB0> INFO: 2560 events read in total (297ms).
[14:01:42.624] <TB0> INFO: Test took 1158ms.
[14:01:42.929] <TB0> INFO: Expecting 2560 events.
[14:01:43.781] <TB0> INFO: 2560 events read in total (296ms).
[14:01:43.781] <TB0> INFO: Test took 1157ms.
[14:01:44.086] <TB0> INFO: Expecting 2560 events.
[14:01:44.940] <TB0> INFO: 2560 events read in total (297ms).
[14:01:44.940] <TB0> INFO: Test took 1158ms.
[14:01:45.245] <TB0> INFO: Expecting 2560 events.
[14:01:46.098] <TB0> INFO: 2560 events read in total (297ms).
[14:01:46.098] <TB0> INFO: Test took 1157ms.
[14:01:46.403] <TB0> INFO: Expecting 2560 events.
[14:01:47.256] <TB0> INFO: 2560 events read in total (296ms).
[14:01:47.256] <TB0> INFO: Test took 1157ms.
[14:01:47.561] <TB0> INFO: Expecting 2560 events.
[14:01:48.414] <TB0> INFO: 2560 events read in total (296ms).
[14:01:48.414] <TB0> INFO: Test took 1157ms.
[14:01:48.719] <TB0> INFO: Expecting 2560 events.
[14:01:49.573] <TB0> INFO: 2560 events read in total (298ms).
[14:01:49.573] <TB0> INFO: Test took 1158ms.
[14:01:49.878] <TB0> INFO: Expecting 2560 events.
[14:01:50.731] <TB0> INFO: 2560 events read in total (297ms).
[14:01:50.731] <TB0> INFO: Test took 1158ms.
[14:01:51.037] <TB0> INFO: Expecting 2560 events.
[14:01:51.890] <TB0> INFO: 2560 events read in total (297ms).
[14:01:51.890] <TB0> INFO: Test took 1158ms.
[14:01:52.195] <TB0> INFO: Expecting 2560 events.
[14:01:53.048] <TB0> INFO: 2560 events read in total (297ms).
[14:01:53.048] <TB0> INFO: Test took 1157ms.
[14:01:53.050] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:01:53.354] <TB0> INFO: Expecting 655360 events.
[14:02:10.438] <TB0> INFO: 655360 events read in total (16528ms).
[14:02:10.446] <TB0> INFO: Expecting 655360 events.
[14:02:27.162] <TB0> INFO: 655360 events read in total (16314ms).
[14:02:27.174] <TB0> INFO: Expecting 655360 events.
[14:02:43.878] <TB0> INFO: 655360 events read in total (16302ms).
[14:02:43.893] <TB0> INFO: Expecting 655360 events.
[14:03:00.755] <TB0> INFO: 655360 events read in total (16460ms).
[14:03:00.774] <TB0> INFO: Expecting 655360 events.
[14:03:17.463] <TB0> INFO: 655360 events read in total (16288ms).
[14:03:17.485] <TB0> INFO: Expecting 655360 events.
[14:03:34.304] <TB0> INFO: 655360 events read in total (16417ms).
[14:03:34.332] <TB0> INFO: Expecting 655360 events.
[14:03:50.919] <TB0> INFO: 655360 events read in total (16185ms).
[14:03:50.962] <TB0> INFO: Expecting 655360 events.
[14:04:07.511] <TB0> INFO: 655360 events read in total (16147ms).
[14:04:07.551] <TB0> INFO: Expecting 655360 events.
[14:04:24.331] <TB0> INFO: 655360 events read in total (16378ms).
[14:04:24.373] <TB0> INFO: Expecting 655360 events.
[14:04:41.270] <TB0> INFO: 655360 events read in total (16496ms).
[14:04:41.315] <TB0> INFO: Expecting 655360 events.
[14:04:58.048] <TB0> INFO: 655360 events read in total (16331ms).
[14:04:58.098] <TB0> INFO: Expecting 655360 events.
[14:05:14.907] <TB0> INFO: 655360 events read in total (16408ms).
[14:05:14.982] <TB0> INFO: Expecting 655360 events.
[14:05:31.772] <TB0> INFO: 655360 events read in total (16388ms).
[14:05:31.827] <TB0> INFO: Expecting 655360 events.
[14:05:48.691] <TB0> INFO: 655360 events read in total (16462ms).
[14:05:48.752] <TB0> INFO: Expecting 655360 events.
[14:06:05.515] <TB0> INFO: 655360 events read in total (16361ms).
[14:06:05.576] <TB0> INFO: Expecting 655360 events.
[14:06:22.355] <TB0> INFO: 655360 events read in total (16377ms).
[14:06:22.424] <TB0> INFO: Test took 269374ms.
[14:06:22.516] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:06:22.745] <TB0> INFO: Expecting 655360 events.
[14:06:39.613] <TB0> INFO: 655360 events read in total (16311ms).
[14:06:39.622] <TB0> INFO: Expecting 655360 events.
[14:06:56.362] <TB0> INFO: 655360 events read in total (16338ms).
[14:06:56.375] <TB0> INFO: Expecting 655360 events.
[14:07:13.166] <TB0> INFO: 655360 events read in total (16389ms).
[14:07:13.182] <TB0> INFO: Expecting 655360 events.
[14:07:29.787] <TB0> INFO: 655360 events read in total (16205ms).
[14:07:29.807] <TB0> INFO: Expecting 655360 events.
[14:07:46.619] <TB0> INFO: 655360 events read in total (16410ms).
[14:07:46.646] <TB0> INFO: Expecting 655360 events.
[14:08:03.411] <TB0> INFO: 655360 events read in total (16363ms).
[14:08:03.441] <TB0> INFO: Expecting 655360 events.
[14:08:20.076] <TB0> INFO: 655360 events read in total (16233ms).
[14:08:20.107] <TB0> INFO: Expecting 655360 events.
[14:08:36.611] <TB0> INFO: 655360 events read in total (16102ms).
[14:08:36.646] <TB0> INFO: Expecting 655360 events.
[14:08:53.197] <TB0> INFO: 655360 events read in total (16149ms).
[14:08:53.237] <TB0> INFO: Expecting 655360 events.
[14:09:09.921] <TB0> INFO: 655360 events read in total (16282ms).
[14:09:09.968] <TB0> INFO: Expecting 655360 events.
[14:09:26.585] <TB0> INFO: 655360 events read in total (16215ms).
[14:09:26.639] <TB0> INFO: Expecting 655360 events.
[14:09:43.219] <TB0> INFO: 655360 events read in total (16178ms).
[14:09:43.282] <TB0> INFO: Expecting 655360 events.
[14:09:59.978] <TB0> INFO: 655360 events read in total (16294ms).
[14:10:00.030] <TB0> INFO: Expecting 655360 events.
[14:10:16.801] <TB0> INFO: 655360 events read in total (16369ms).
[14:10:16.857] <TB0> INFO: Expecting 655360 events.
[14:10:33.582] <TB0> INFO: 655360 events read in total (16323ms).
[14:10:33.638] <TB0> INFO: Expecting 655360 events.
[14:10:50.377] <TB0> INFO: 655360 events read in total (16338ms).
[14:10:50.443] <TB0> INFO: Test took 267927ms.
[14:10:50.636] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.642] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.649] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.656] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.662] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.669] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.675] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.682] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.688] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.695] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.702] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.708] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.715] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.721] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.728] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.734] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[14:10:50.770] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C0.dat
[14:10:50.770] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C1.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C2.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C3.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C4.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C5.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C6.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C7.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C8.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C9.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C10.dat
[14:10:50.771] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C11.dat
[14:10:50.772] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C12.dat
[14:10:50.772] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C13.dat
[14:10:50.772] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C14.dat
[14:10:50.772] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//dacParameters35_C15.dat
[14:10:51.053] <TB0> INFO: Expecting 41600 events.
[14:10:54.566] <TB0> INFO: 41600 events read in total (2956ms).
[14:10:54.567] <TB0> INFO: Test took 3792ms.
[14:10:55.042] <TB0> INFO: Expecting 41600 events.
[14:10:58.549] <TB0> INFO: 41600 events read in total (2951ms).
[14:10:58.549] <TB0> INFO: Test took 3803ms.
[14:10:59.001] <TB0> INFO: Expecting 41600 events.
[14:11:02.475] <TB0> INFO: 41600 events read in total (2918ms).
[14:11:02.476] <TB0> INFO: Test took 3748ms.
[14:11:02.658] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:02.746] <TB0> INFO: Expecting 2560 events.
[14:11:03.599] <TB0> INFO: 2560 events read in total (297ms).
[14:11:03.600] <TB0> INFO: Test took 942ms.
[14:11:03.602] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:03.905] <TB0> INFO: Expecting 2560 events.
[14:11:04.758] <TB0> INFO: 2560 events read in total (297ms).
[14:11:04.759] <TB0> INFO: Test took 1157ms.
[14:11:04.761] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:05.064] <TB0> INFO: Expecting 2560 events.
[14:11:05.918] <TB0> INFO: 2560 events read in total (298ms).
[14:11:05.918] <TB0> INFO: Test took 1157ms.
[14:11:05.920] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:06.224] <TB0> INFO: Expecting 2560 events.
[14:11:07.081] <TB0> INFO: 2560 events read in total (301ms).
[14:11:07.082] <TB0> INFO: Test took 1162ms.
[14:11:07.084] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:07.387] <TB0> INFO: Expecting 2560 events.
[14:11:08.244] <TB0> INFO: 2560 events read in total (301ms).
[14:11:08.244] <TB0> INFO: Test took 1160ms.
[14:11:08.246] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:08.550] <TB0> INFO: Expecting 2560 events.
[14:11:09.408] <TB0> INFO: 2560 events read in total (302ms).
[14:11:09.408] <TB0> INFO: Test took 1162ms.
[14:11:09.410] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:09.715] <TB0> INFO: Expecting 2560 events.
[14:11:10.573] <TB0> INFO: 2560 events read in total (302ms).
[14:11:10.573] <TB0> INFO: Test took 1163ms.
[14:11:10.576] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:10.879] <TB0> INFO: Expecting 2560 events.
[14:11:11.734] <TB0> INFO: 2560 events read in total (299ms).
[14:11:11.735] <TB0> INFO: Test took 1159ms.
[14:11:11.736] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:12.041] <TB0> INFO: Expecting 2560 events.
[14:11:12.898] <TB0> INFO: 2560 events read in total (301ms).
[14:11:12.898] <TB0> INFO: Test took 1162ms.
[14:11:12.900] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:13.204] <TB0> INFO: Expecting 2560 events.
[14:11:14.057] <TB0> INFO: 2560 events read in total (297ms).
[14:11:14.057] <TB0> INFO: Test took 1157ms.
[14:11:14.059] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:14.363] <TB0> INFO: Expecting 2560 events.
[14:11:15.217] <TB0> INFO: 2560 events read in total (298ms).
[14:11:15.218] <TB0> INFO: Test took 1159ms.
[14:11:15.220] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:15.523] <TB0> INFO: Expecting 2560 events.
[14:11:16.381] <TB0> INFO: 2560 events read in total (302ms).
[14:11:16.382] <TB0> INFO: Test took 1162ms.
[14:11:16.384] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:16.687] <TB0> INFO: Expecting 2560 events.
[14:11:17.540] <TB0> INFO: 2560 events read in total (297ms).
[14:11:17.540] <TB0> INFO: Test took 1156ms.
[14:11:17.542] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:17.846] <TB0> INFO: Expecting 2560 events.
[14:11:18.699] <TB0> INFO: 2560 events read in total (297ms).
[14:11:18.699] <TB0> INFO: Test took 1158ms.
[14:11:18.701] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:19.005] <TB0> INFO: Expecting 2560 events.
[14:11:19.859] <TB0> INFO: 2560 events read in total (298ms).
[14:11:19.859] <TB0> INFO: Test took 1158ms.
[14:11:19.861] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:20.165] <TB0> INFO: Expecting 2560 events.
[14:11:21.019] <TB0> INFO: 2560 events read in total (298ms).
[14:11:21.019] <TB0> INFO: Test took 1158ms.
[14:11:21.022] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:21.325] <TB0> INFO: Expecting 2560 events.
[14:11:22.178] <TB0> INFO: 2560 events read in total (297ms).
[14:11:22.178] <TB0> INFO: Test took 1156ms.
[14:11:22.180] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:22.484] <TB0> INFO: Expecting 2560 events.
[14:11:23.342] <TB0> INFO: 2560 events read in total (302ms).
[14:11:23.343] <TB0> INFO: Test took 1163ms.
[14:11:23.345] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:23.649] <TB0> INFO: Expecting 2560 events.
[14:11:24.506] <TB0> INFO: 2560 events read in total (301ms).
[14:11:24.506] <TB0> INFO: Test took 1162ms.
[14:11:24.508] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:24.811] <TB0> INFO: Expecting 2560 events.
[14:11:25.668] <TB0> INFO: 2560 events read in total (301ms).
[14:11:25.669] <TB0> INFO: Test took 1161ms.
[14:11:25.671] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:25.975] <TB0> INFO: Expecting 2560 events.
[14:11:26.832] <TB0> INFO: 2560 events read in total (301ms).
[14:11:26.833] <TB0> INFO: Test took 1162ms.
[14:11:26.835] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:27.138] <TB0> INFO: Expecting 2560 events.
[14:11:27.997] <TB0> INFO: 2560 events read in total (303ms).
[14:11:27.998] <TB0> INFO: Test took 1163ms.
[14:11:28.000] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:28.303] <TB0> INFO: Expecting 2560 events.
[14:11:29.161] <TB0> INFO: 2560 events read in total (301ms).
[14:11:29.161] <TB0> INFO: Test took 1161ms.
[14:11:29.164] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:29.467] <TB0> INFO: Expecting 2560 events.
[14:11:30.326] <TB0> INFO: 2560 events read in total (303ms).
[14:11:30.326] <TB0> INFO: Test took 1162ms.
[14:11:30.329] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:30.632] <TB0> INFO: Expecting 2560 events.
[14:11:31.489] <TB0> INFO: 2560 events read in total (301ms).
[14:11:31.489] <TB0> INFO: Test took 1160ms.
[14:11:31.490] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:31.798] <TB0> INFO: Expecting 2560 events.
[14:11:32.657] <TB0> INFO: 2560 events read in total (303ms).
[14:11:32.658] <TB0> INFO: Test took 1168ms.
[14:11:32.661] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:32.962] <TB0> INFO: Expecting 2560 events.
[14:11:33.820] <TB0> INFO: 2560 events read in total (301ms).
[14:11:33.820] <TB0> INFO: Test took 1160ms.
[14:11:33.823] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:34.126] <TB0> INFO: Expecting 2560 events.
[14:11:34.982] <TB0> INFO: 2560 events read in total (300ms).
[14:11:34.983] <TB0> INFO: Test took 1161ms.
[14:11:34.986] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:35.288] <TB0> INFO: Expecting 2560 events.
[14:11:36.148] <TB0> INFO: 2560 events read in total (303ms).
[14:11:36.148] <TB0> INFO: Test took 1163ms.
[14:11:36.151] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:36.453] <TB0> INFO: Expecting 2560 events.
[14:11:37.307] <TB0> INFO: 2560 events read in total (298ms).
[14:11:37.307] <TB0> INFO: Test took 1157ms.
[14:11:37.309] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:37.612] <TB0> INFO: Expecting 2560 events.
[14:11:38.468] <TB0> INFO: 2560 events read in total (299ms).
[14:11:38.469] <TB0> INFO: Test took 1160ms.
[14:11:38.470] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:11:38.775] <TB0> INFO: Expecting 2560 events.
[14:11:39.629] <TB0> INFO: 2560 events read in total (298ms).
[14:11:39.629] <TB0> INFO: Test took 1159ms.
[14:11:40.084] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[14:11:40.084] <TB0> INFO: PH scale (per ROC): 83 79 93 83 78 81 91 85 81 75 80 86 73 78 78 84
[14:11:40.084] <TB0> INFO: PH offset (per ROC): 169 172 167 155 172 170 143 148 156 174 158 156 170 162 160 144
[14:11:40.088] <TB0> INFO: Decoding statistics:
[14:11:40.088] <TB0> INFO: General information:
[14:11:40.088] <TB0> INFO: 16bit words read: 91924
[14:11:40.088] <TB0> INFO: valid events total: 10240
[14:11:40.088] <TB0> INFO: empty events: 7739
[14:11:40.088] <TB0> INFO: valid events with pixels: 2501
[14:11:40.088] <TB0> INFO: valid pixel hits: 2501
[14:11:40.088] <TB0> INFO: Event errors: 0
[14:11:40.088] <TB0> INFO: start marker: 0
[14:11:40.088] <TB0> INFO: stop marker: 0
[14:11:40.088] <TB0> INFO: overflow: 0
[14:11:40.088] <TB0> INFO: invalid 5bit words: 0
[14:11:40.088] <TB0> INFO: invalid XOR eye diagram: 0
[14:11:40.088] <TB0> INFO: frame (failed synchr.): 0
[14:11:40.088] <TB0> INFO: idle data (no TBM trl): 0
[14:11:40.088] <TB0> INFO: no data (only TBM hdr): 0
[14:11:40.088] <TB0> INFO: TBM errors: 0
[14:11:40.088] <TB0> INFO: flawed TBM headers: 0
[14:11:40.088] <TB0> INFO: flawed TBM trailers: 0
[14:11:40.088] <TB0> INFO: event ID mismatches: 0
[14:11:40.088] <TB0> INFO: ROC errors: 0
[14:11:40.088] <TB0> INFO: missing ROC header(s): 0
[14:11:40.088] <TB0> INFO: misplaced readback start: 0
[14:11:40.088] <TB0> INFO: Pixel decoding errors: 0
[14:11:40.088] <TB0> INFO: pixel data incomplete: 0
[14:11:40.088] <TB0> INFO: pixel address: 0
[14:11:40.088] <TB0> INFO: pulse height fill bit: 0
[14:11:40.088] <TB0> INFO: buffer corruption: 0
[14:11:40.287] <TB0> INFO: ######################################################################
[14:11:40.287] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[14:11:40.287] <TB0> INFO: ######################################################################
[14:11:40.297] <TB0> INFO: scanning low vcal = 10
[14:11:40.568] <TB0> INFO: Expecting 41600 events.
[14:11:44.109] <TB0> INFO: 41600 events read in total (2985ms).
[14:11:44.109] <TB0> INFO: Test took 3812ms.
[14:11:44.111] <TB0> INFO: scanning low vcal = 20
[14:11:44.413] <TB0> INFO: Expecting 41600 events.
[14:11:47.963] <TB0> INFO: 41600 events read in total (2994ms).
[14:11:47.964] <TB0> INFO: Test took 3853ms.
[14:11:47.966] <TB0> INFO: scanning low vcal = 30
[14:11:48.269] <TB0> INFO: Expecting 41600 events.
[14:11:51.830] <TB0> INFO: 41600 events read in total (3005ms).
[14:11:51.831] <TB0> INFO: Test took 3865ms.
[14:11:51.833] <TB0> INFO: scanning low vcal = 40
[14:11:52.130] <TB0> INFO: Expecting 41600 events.
[14:11:56.312] <TB0> INFO: 41600 events read in total (3626ms).
[14:11:56.313] <TB0> INFO: Test took 4480ms.
[14:11:56.316] <TB0> INFO: scanning low vcal = 50
[14:11:56.583] <TB0> INFO: Expecting 41600 events.
[14:12:00.860] <TB0> INFO: 41600 events read in total (3721ms).
[14:12:00.860] <TB0> INFO: Test took 4544ms.
[14:12:00.863] <TB0> INFO: scanning low vcal = 60
[14:12:01.140] <TB0> INFO: Expecting 41600 events.
[14:12:05.375] <TB0> INFO: 41600 events read in total (3679ms).
[14:12:05.376] <TB0> INFO: Test took 4513ms.
[14:12:05.379] <TB0> INFO: scanning low vcal = 70
[14:12:05.643] <TB0> INFO: Expecting 41600 events.
[14:12:09.856] <TB0> INFO: 41600 events read in total (3656ms).
[14:12:09.856] <TB0> INFO: Test took 4477ms.
[14:12:09.859] <TB0> INFO: scanning low vcal = 80
[14:12:10.126] <TB0> INFO: Expecting 41600 events.
[14:12:14.323] <TB0> INFO: 41600 events read in total (3641ms).
[14:12:14.323] <TB0> INFO: Test took 4464ms.
[14:12:14.326] <TB0> INFO: scanning low vcal = 90
[14:12:14.597] <TB0> INFO: Expecting 41600 events.
[14:12:18.802] <TB0> INFO: 41600 events read in total (3648ms).
[14:12:18.803] <TB0> INFO: Test took 4477ms.
[14:12:18.806] <TB0> INFO: scanning low vcal = 100
[14:12:19.066] <TB0> INFO: Expecting 41600 events.
[14:12:23.264] <TB0> INFO: 41600 events read in total (3642ms).
[14:12:23.265] <TB0> INFO: Test took 4459ms.
[14:12:23.267] <TB0> INFO: scanning low vcal = 110
[14:12:23.547] <TB0> INFO: Expecting 41600 events.
[14:12:27.745] <TB0> INFO: 41600 events read in total (3641ms).
[14:12:27.745] <TB0> INFO: Test took 4478ms.
[14:12:27.748] <TB0> INFO: scanning low vcal = 120
[14:12:28.013] <TB0> INFO: Expecting 41600 events.
[14:12:32.216] <TB0> INFO: 41600 events read in total (3647ms).
[14:12:32.216] <TB0> INFO: Test took 4468ms.
[14:12:32.219] <TB0> INFO: scanning low vcal = 130
[14:12:32.478] <TB0> INFO: Expecting 41600 events.
[14:12:36.711] <TB0> INFO: 41600 events read in total (3677ms).
[14:12:36.712] <TB0> INFO: Test took 4493ms.
[14:12:36.714] <TB0> INFO: scanning low vcal = 140
[14:12:36.977] <TB0> INFO: Expecting 41600 events.
[14:12:41.186] <TB0> INFO: 41600 events read in total (3653ms).
[14:12:41.187] <TB0> INFO: Test took 4473ms.
[14:12:41.190] <TB0> INFO: scanning low vcal = 150
[14:12:41.465] <TB0> INFO: Expecting 41600 events.
[14:12:45.670] <TB0> INFO: 41600 events read in total (3649ms).
[14:12:45.671] <TB0> INFO: Test took 4481ms.
[14:12:45.673] <TB0> INFO: scanning low vcal = 160
[14:12:45.938] <TB0> INFO: Expecting 41600 events.
[14:12:50.160] <TB0> INFO: 41600 events read in total (3666ms).
[14:12:50.161] <TB0> INFO: Test took 4487ms.
[14:12:50.164] <TB0> INFO: scanning low vcal = 170
[14:12:50.458] <TB0> INFO: Expecting 41600 events.
[14:12:54.691] <TB0> INFO: 41600 events read in total (3677ms).
[14:12:54.691] <TB0> INFO: Test took 4527ms.
[14:12:54.696] <TB0> INFO: scanning low vcal = 180
[14:12:54.969] <TB0> INFO: Expecting 41600 events.
[14:12:59.151] <TB0> INFO: 41600 events read in total (3626ms).
[14:12:59.151] <TB0> INFO: Test took 4455ms.
[14:12:59.153] <TB0> INFO: scanning low vcal = 190
[14:12:59.416] <TB0> INFO: Expecting 41600 events.
[14:13:03.630] <TB0> INFO: 41600 events read in total (3658ms).
[14:13:03.631] <TB0> INFO: Test took 4477ms.
[14:13:03.634] <TB0> INFO: scanning low vcal = 200
[14:13:03.913] <TB0> INFO: Expecting 41600 events.
[14:13:08.121] <TB0> INFO: 41600 events read in total (3652ms).
[14:13:08.122] <TB0> INFO: Test took 4488ms.
[14:13:08.125] <TB0> INFO: scanning low vcal = 210
[14:13:08.413] <TB0> INFO: Expecting 41600 events.
[14:13:12.634] <TB0> INFO: 41600 events read in total (3665ms).
[14:13:12.635] <TB0> INFO: Test took 4510ms.
[14:13:12.637] <TB0> INFO: scanning low vcal = 220
[14:13:12.900] <TB0> INFO: Expecting 41600 events.
[14:13:17.108] <TB0> INFO: 41600 events read in total (3652ms).
[14:13:17.109] <TB0> INFO: Test took 4472ms.
[14:13:17.111] <TB0> INFO: scanning low vcal = 230
[14:13:17.380] <TB0> INFO: Expecting 41600 events.
[14:13:21.578] <TB0> INFO: 41600 events read in total (3642ms).
[14:13:21.578] <TB0> INFO: Test took 4467ms.
[14:13:21.581] <TB0> INFO: scanning low vcal = 240
[14:13:21.843] <TB0> INFO: Expecting 41600 events.
[14:13:26.086] <TB0> INFO: 41600 events read in total (3687ms).
[14:13:26.086] <TB0> INFO: Test took 4505ms.
[14:13:26.088] <TB0> INFO: scanning low vcal = 250
[14:13:26.349] <TB0> INFO: Expecting 41600 events.
[14:13:30.547] <TB0> INFO: 41600 events read in total (3642ms).
[14:13:30.547] <TB0> INFO: Test took 4459ms.
[14:13:30.551] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[14:13:30.818] <TB0> INFO: Expecting 41600 events.
[14:13:35.024] <TB0> INFO: 41600 events read in total (3650ms).
[14:13:35.024] <TB0> INFO: Test took 4473ms.
[14:13:35.027] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[14:13:35.293] <TB0> INFO: Expecting 41600 events.
[14:13:39.503] <TB0> INFO: 41600 events read in total (3654ms).
[14:13:39.504] <TB0> INFO: Test took 4477ms.
[14:13:39.507] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[14:13:39.772] <TB0> INFO: Expecting 41600 events.
[14:13:44.011] <TB0> INFO: 41600 events read in total (3683ms).
[14:13:44.012] <TB0> INFO: Test took 4505ms.
[14:13:44.014] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[14:13:44.282] <TB0> INFO: Expecting 41600 events.
[14:13:48.530] <TB0> INFO: 41600 events read in total (3692ms).
[14:13:48.531] <TB0> INFO: Test took 4517ms.
[14:13:48.533] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[14:13:48.809] <TB0> INFO: Expecting 41600 events.
[14:13:53.057] <TB0> INFO: 41600 events read in total (3691ms).
[14:13:53.058] <TB0> INFO: Test took 4525ms.
[14:13:53.577] <TB0> INFO: PixTestGainPedestal::measure() done
[14:14:25.698] <TB0> INFO: PixTestGainPedestal::fit() done
[14:14:25.698] <TB0> INFO: non-linearity mean: 0.953 0.947 0.949 0.956 0.955 0.957 0.956 0.953 0.956 0.955 0.956 0.955 0.957 0.958 0.956 0.963
[14:14:25.698] <TB0> INFO: non-linearity RMS: 0.006 0.006 0.006 0.007 0.005 0.006 0.005 0.006 0.005 0.007 0.005 0.005 0.005 0.005 0.006 0.005
[14:14:25.698] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[14:14:25.719] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[14:14:25.740] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[14:14:25.760] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[14:14:25.781] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[14:14:25.802] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[14:14:25.822] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[14:14:25.843] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[14:14:25.864] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[14:14:25.885] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[14:14:25.906] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[14:14:25.927] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[14:14:25.948] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[14:14:25.969] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[14:14:25.989] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[14:14:26.010] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[14:14:26.030] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[14:14:26.030] <TB0> INFO: Decoding statistics:
[14:14:26.030] <TB0> INFO: General information:
[14:14:26.030] <TB0> INFO: 16bit words read: 2662400
[14:14:26.030] <TB0> INFO: valid events total: 166400
[14:14:26.030] <TB0> INFO: empty events: 0
[14:14:26.030] <TB0> INFO: valid events with pixels: 166400
[14:14:26.030] <TB0> INFO: valid pixel hits: 665560
[14:14:26.030] <TB0> INFO: Event errors: 0
[14:14:26.030] <TB0> INFO: start marker: 0
[14:14:26.030] <TB0> INFO: stop marker: 0
[14:14:26.030] <TB0> INFO: overflow: 0
[14:14:26.030] <TB0> INFO: invalid 5bit words: 0
[14:14:26.030] <TB0> INFO: invalid XOR eye diagram: 0
[14:14:26.031] <TB0> INFO: frame (failed synchr.): 0
[14:14:26.031] <TB0> INFO: idle data (no TBM trl): 0
[14:14:26.031] <TB0> INFO: no data (only TBM hdr): 0
[14:14:26.031] <TB0> INFO: TBM errors: 0
[14:14:26.031] <TB0> INFO: flawed TBM headers: 0
[14:14:26.031] <TB0> INFO: flawed TBM trailers: 0
[14:14:26.031] <TB0> INFO: event ID mismatches: 0
[14:14:26.031] <TB0> INFO: ROC errors: 0
[14:14:26.031] <TB0> INFO: missing ROC header(s): 0
[14:14:26.031] <TB0> INFO: misplaced readback start: 0
[14:14:26.031] <TB0> INFO: Pixel decoding errors: 0
[14:14:26.031] <TB0> INFO: pixel data incomplete: 0
[14:14:26.031] <TB0> INFO: pixel address: 0
[14:14:26.031] <TB0> INFO: pulse height fill bit: 0
[14:14:26.031] <TB0> INFO: buffer corruption: 0
[14:14:26.039] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C15.dat
[14:14:26.040] <TB0> INFO: ######################################################################
[14:14:26.040] <TB0> INFO: PixTestReadback::doTest()
[14:14:26.040] <TB0> INFO: ######################################################################
[14:14:26.040] <TB0> INFO: ----------------------------------------------------------------------
[14:14:26.040] <TB0> INFO: PixTestReadback::CalibrateVd()
[14:14:26.040] <TB0> INFO: ----------------------------------------------------------------------
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C0.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C1.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C2.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C3.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C4.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C5.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C6.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C7.dat
[14:14:35.490] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C8.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C9.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C10.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C11.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C12.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C13.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C14.dat
[14:14:35.491] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C15.dat
[14:14:35.518] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[14:14:35.518] <TB0> INFO: ----------------------------------------------------------------------
[14:14:35.518] <TB0> INFO: PixTestReadback::CalibrateVa()
[14:14:35.518] <TB0> INFO: ----------------------------------------------------------------------
[14:14:44.984] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C0.dat
[14:14:44.984] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C1.dat
[14:14:44.984] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C2.dat
[14:14:44.984] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C3.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C4.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C5.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C6.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C7.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C8.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C9.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C10.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C11.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C12.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C13.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C14.dat
[14:14:44.985] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C15.dat
[14:14:45.013] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[14:14:45.013] <TB0> INFO: ----------------------------------------------------------------------
[14:14:45.013] <TB0> INFO: PixTestReadback::readbackVbg()
[14:14:45.013] <TB0> INFO: ----------------------------------------------------------------------
[14:14:52.296] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[14:14:52.296] <TB0> INFO: ----------------------------------------------------------------------
[14:14:52.296] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[14:14:52.296] <TB0> INFO: ----------------------------------------------------------------------
[14:14:52.296] <TB0> INFO: Vbg will be calibrated using Vd calibration
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 153.5calibrated Vbg = 1.20112 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 156.6calibrated Vbg = 1.20561 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 162.2calibrated Vbg = 1.20687 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 158.1calibrated Vbg = 1.20751 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 154.9calibrated Vbg = 1.21431 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 150.6calibrated Vbg = 1.21437 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 148.1calibrated Vbg = 1.21401 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 153.7calibrated Vbg = 1.21454 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 157.4calibrated Vbg = 1.21488 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 154.3calibrated Vbg = 1.22492 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 157calibrated Vbg = 1.21113 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.7calibrated Vbg = 1.21254 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 158.9calibrated Vbg = 1.20892 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 161.7calibrated Vbg = 1.21183 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 152.7calibrated Vbg = 1.20559 :::*/*/*/*/
[14:14:52.296] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 149.9calibrated Vbg = 1.21628 :::*/*/*/*/
[14:14:52.298] <TB0> INFO: ----------------------------------------------------------------------
[14:14:52.298] <TB0> INFO: PixTestReadback::CalibrateIa()
[14:14:52.298] <TB0> INFO: ----------------------------------------------------------------------
[14:17:27.582] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C0.dat
[14:17:27.583] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C1.dat
[14:17:27.583] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C2.dat
[14:17:27.583] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C3.dat
[14:17:27.583] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C4.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C5.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C6.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C7.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C8.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C9.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C10.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C11.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C12.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C13.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C14.dat
[14:17:27.584] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2161_FullQualification_2016-02-23_10h05m_1456218359//002_FulltestPxar_m20//readbackCal_C15.dat
[14:17:27.610] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[14:17:27.611] <TB0> INFO: PixTestReadback::doTest() done
[14:17:27.611] <TB0> INFO: Decoding statistics:
[14:17:27.612] <TB0> INFO: General information:
[14:17:27.612] <TB0> INFO: 16bit words read: 1024
[14:17:27.612] <TB0> INFO: valid events total: 128
[14:17:27.612] <TB0> INFO: empty events: 128
[14:17:27.612] <TB0> INFO: valid events with pixels: 0
[14:17:27.612] <TB0> INFO: valid pixel hits: 0
[14:17:27.612] <TB0> INFO: Event errors: 0
[14:17:27.612] <TB0> INFO: start marker: 0
[14:17:27.612] <TB0> INFO: stop marker: 0
[14:17:27.612] <TB0> INFO: overflow: 0
[14:17:27.612] <TB0> INFO: invalid 5bit words: 0
[14:17:27.612] <TB0> INFO: invalid XOR eye diagram: 0
[14:17:27.612] <TB0> INFO: frame (failed synchr.): 0
[14:17:27.612] <TB0> INFO: idle data (no TBM trl): 0
[14:17:27.612] <TB0> INFO: no data (only TBM hdr): 0
[14:17:27.612] <TB0> INFO: TBM errors: 0
[14:17:27.612] <TB0> INFO: flawed TBM headers: 0
[14:17:27.612] <TB0> INFO: flawed TBM trailers: 0
[14:17:27.612] <TB0> INFO: event ID mismatches: 0
[14:17:27.612] <TB0> INFO: ROC errors: 0
[14:17:27.612] <TB0> INFO: missing ROC header(s): 0
[14:17:27.612] <TB0> INFO: misplaced readback start: 0
[14:17:27.612] <TB0> INFO: Pixel decoding errors: 0
[14:17:27.612] <TB0> INFO: pixel data incomplete: 0
[14:17:27.612] <TB0> INFO: pixel address: 0
[14:17:27.612] <TB0> INFO: pulse height fill bit: 0
[14:17:27.612] <TB0> INFO: buffer corruption: 0
[14:17:27.633] <TB0> INFO: Decoding statistics:
[14:17:27.633] <TB0> INFO: General information:
[14:17:27.633] <TB0> INFO: 16bit words read: 2755348
[14:17:27.633] <TB0> INFO: valid events total: 176768
[14:17:27.633] <TB0> INFO: empty events: 7867
[14:17:27.633] <TB0> INFO: valid events with pixels: 168901
[14:17:27.633] <TB0> INFO: valid pixel hits: 668061
[14:17:27.633] <TB0> INFO: Event errors: 0
[14:17:27.633] <TB0> INFO: start marker: 0
[14:17:27.633] <TB0> INFO: stop marker: 0
[14:17:27.633] <TB0> INFO: overflow: 0
[14:17:27.633] <TB0> INFO: invalid 5bit words: 0
[14:17:27.633] <TB0> INFO: invalid XOR eye diagram: 0
[14:17:27.633] <TB0> INFO: frame (failed synchr.): 0
[14:17:27.633] <TB0> INFO: idle data (no TBM trl): 0
[14:17:27.633] <TB0> INFO: no data (only TBM hdr): 0
[14:17:27.633] <TB0> INFO: TBM errors: 0
[14:17:27.633] <TB0> INFO: flawed TBM headers: 0
[14:17:27.633] <TB0> INFO: flawed TBM trailers: 0
[14:17:27.633] <TB0> INFO: event ID mismatches: 0
[14:17:27.633] <TB0> INFO: ROC errors: 0
[14:17:27.633] <TB0> INFO: missing ROC header(s): 0
[14:17:27.633] <TB0> INFO: misplaced readback start: 0
[14:17:27.633] <TB0> INFO: Pixel decoding errors: 0
[14:17:27.633] <TB0> INFO: pixel data incomplete: 0
[14:17:27.633] <TB0> INFO: pixel address: 0
[14:17:27.633] <TB0> INFO: pulse height fill bit: 0
[14:17:27.633] <TB0> INFO: buffer corruption: 0
[14:17:27.633] <TB0> INFO: enter test to run
[14:17:27.633] <TB0> INFO: test: exit no parameter change
[14:17:27.793] <TB0> QUIET: Connection to board 73 closed.
[14:17:27.873] <TB0> INFO: pXar: this is the end, my friend