Test Date: 2016-05-12 23:28
Analysis date: 2016-05-26 18:19
Logfile
LogfileView
[01:02:56.456] <TB0> INFO: *** Welcome to pxar ***
[01:02:56.456] <TB0> INFO: *** Today: 2016/05/13
[01:02:56.961] <TB0> INFO: *** Version: 9751-dirty
[01:02:56.961] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C15.dat
[01:02:56.962] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//tbmParameters_C0b.dat
[01:02:56.962] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//defaultMaskFile.dat
[01:02:56.962] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters_C15.dat
[01:02:57.027] <TB0> INFO: clk: 4
[01:02:57.027] <TB0> INFO: ctr: 4
[01:02:57.027] <TB0> INFO: sda: 19
[01:02:57.027] <TB0> INFO: tin: 9
[01:02:57.027] <TB0> INFO: level: 15
[01:02:57.027] <TB0> INFO: triggerdelay: 0
[01:02:57.027] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[01:02:57.027] <TB0> INFO: Log level: INFO
[01:02:57.034] <TB0> INFO: Found DTB DTB_WS6AYH
[01:02:57.046] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[01:02:57.048] <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:
------------------------------------------------------
[01:02:57.049] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[01:02:58.575] <TB0> INFO: DUT info:
[01:02:58.575] <TB0> INFO: The DUT currently contains the following objects:
[01:02:58.575] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[01:02:58.575] <TB0> INFO: TBM Core alpha (0): 7 registers set
[01:02:58.575] <TB0> INFO: TBM Core beta (1): 7 registers set
[01:02:58.575] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[01:02:58.575] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.575] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[01:02:58.976] <TB0> INFO: enter 'restricted' command line mode
[01:02:58.976] <TB0> INFO: enter test to run
[01:02:58.976] <TB0> INFO: test: pretest no parameter change
[01:02:58.976] <TB0> INFO: running: pretest
[01:02:58.980] <TB0> INFO: ----------------------------------------------------------------------
[01:02:58.980] <TB0> INFO: PixTestPretest::programROC()
[01:02:58.980] <TB0> INFO: ----------------------------------------------------------------------
[01:03:16.994] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[01:03:16.994] <TB0> INFO: IA differences per ROC: 18.5 21.7 17.7 17.7 20.9 19.3 18.5 18.5 19.3 20.1 20.1 17.7 19.3 18.5 17.7 19.3
[01:03:17.098] <TB0> INFO: enter test to run
[01:03:17.098] <TB0> INFO: test: pretest no parameter change
[01:03:17.098] <TB0> INFO: running: pretest
[01:03:17.099] <TB0> INFO: ----------------------------------------------------------------------
[01:03:17.099] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[01:03:17.099] <TB0> INFO: ----------------------------------------------------------------------
[01:03:38.368] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 381 mA = 23.8125 mA/ROC
[01:03:38.368] <TB0> INFO: i(loss) [mA/ROC]: 20.1 19.2 19.2 18.4 19.2 18.4 17.6 19.2 18.4 19.2 18.4 18.4 17.6 19.2 19.2 18.4
[01:03:38.405] <TB0> INFO: enter test to run
[01:03:38.405] <TB0> INFO: test: pretest no parameter change
[01:03:38.405] <TB0> INFO: running: pretest
[01:03:38.405] <TB0> INFO: ----------------------------------------------------------------------
[01:03:38.405] <TB0> INFO: PixTestPretest::findTiming()
[01:03:38.405] <TB0> INFO: ----------------------------------------------------------------------
[01:03:38.405] <TB0> INFO: PixTestCmd::init()
[01:03:39.365] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!

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

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

[01:05:17.392] <TB0> INFO: 231680 events read in total (9582ms).
[01:05:17.395] <TB0> INFO: Test took 10230ms.
[01:05:17.635] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[01:05:17.706] <TB0> INFO: enter test to run
[01:05:17.706] <TB0> INFO: test: pretest no parameter change
[01:05:17.706] <TB0> INFO: running: pretest
[01:05:17.708] <TB0> INFO: ----------------------------------------------------------------------
[01:05:17.708] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[01:05:17.708] <TB0> INFO: ----------------------------------------------------------------------
[01:05:17.799] <TB0> INFO: Expecting 231680 events.
[01:05:28.034] <TB0> INFO: 231680 events read in total (9679ms).
[01:05:28.037] <TB0> INFO: Test took 10326ms.
[01:05:28.300] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[01:05:28.300] <TB0> INFO: CalDel: 157 137 135 149 143 143 148 144 143 141 144 143 158 145 132 124
[01:05:28.300] <TB0> INFO: VthrComp: 51 51 51 51 52 51 51 51 51 51 51 51 51 51 51 51
[01:05:28.338] <TB0> INFO: enter test to run
[01:05:28.338] <TB0> INFO: test: pretest no parameter change
[01:05:28.338] <TB0> INFO: running: pretest
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C0.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C1.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C2.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C3.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C4.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C5.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C6.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C7.dat
[01:05:28.338] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C8.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C9.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C10.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C11.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C12.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C13.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C14.dat
[01:05:28.339] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters_C15.dat
[01:05:28.340] <TB0> INFO: enter test to run
[01:05:28.340] <TB0> INFO: test: fulltest no parameter change
[01:05:28.340] <TB0> INFO: running: fulltest
[01:05:28.340] <TB0> INFO: ######################################################################
[01:05:28.340] <TB0> INFO: PixTestFullTest::doTest()
[01:05:28.340] <TB0> INFO: ######################################################################
[01:05:28.341] <TB0> INFO: ######################################################################
[01:05:28.341] <TB0> INFO: PixTestAlive::doTest()
[01:05:28.341] <TB0> INFO: ######################################################################
[01:05:28.342] <TB0> INFO: ----------------------------------------------------------------------
[01:05:28.342] <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)
[01:05:28.342] <TB0> INFO: ----------------------------------------------------------------------
[01:05:28.606] <TB0> INFO: Expecting 41600 events.
[01:05:32.422] <TB0> INFO: 41600 events read in total (3260ms).
[01:05:32.422] <TB0> INFO: Test took 4078ms.
[01:05:32.645] <TB0> INFO: PixTestAlive::aliveTest() done
[01:05:32.645] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[01:05:32.647] <TB0> INFO: ----------------------------------------------------------------------
[01:05:32.647] <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)
[01:05:32.647] <TB0> INFO: ----------------------------------------------------------------------
[01:05:32.922] <TB0> INFO: Expecting 41600 events.
[01:05:35.878] <TB0> INFO: 41600 events read in total (2399ms).
[01:05:35.879] <TB0> INFO: Test took 3231ms.
[01:05:35.879] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[01:05:36.124] <TB0> INFO: PixTestAlive::maskTest() done
[01:05:36.124] <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
[01:05:36.125] <TB0> INFO: ----------------------------------------------------------------------
[01:05:36.125] <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)
[01:05:36.125] <TB0> INFO: ----------------------------------------------------------------------
[01:05:36.391] <TB0> INFO: Expecting 41600 events.
[01:05:40.172] <TB0> INFO: 41600 events read in total (3225ms).
[01:05:40.173] <TB0> INFO: Test took 4046ms.
[01:05:40.404] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[01:05:40.404] <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
[01:05:40.404] <TB0> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[01:05:40.404] <TB0> INFO: Decoding statistics:
[01:05:40.404] <TB0> INFO: General information:
[01:05:40.404] <TB0> INFO: 16bit words read: 0
[01:05:40.404] <TB0> INFO: valid events total: 0
[01:05:40.404] <TB0> INFO: empty events: 0
[01:05:40.404] <TB0> INFO: valid events with pixels: 0
[01:05:40.404] <TB0> INFO: valid pixel hits: 0
[01:05:40.404] <TB0> INFO: Event errors: 0
[01:05:40.404] <TB0> INFO: start marker: 0
[01:05:40.404] <TB0> INFO: stop marker: 0
[01:05:40.404] <TB0> INFO: overflow: 0
[01:05:40.404] <TB0> INFO: invalid 5bit words: 0
[01:05:40.404] <TB0> INFO: invalid XOR eye diagram: 0
[01:05:40.404] <TB0> INFO: frame (failed synchr.): 0
[01:05:40.404] <TB0> INFO: idle data (no TBM trl): 0
[01:05:40.404] <TB0> INFO: no data (only TBM hdr): 0
[01:05:40.404] <TB0> INFO: TBM errors: 0
[01:05:40.404] <TB0> INFO: flawed TBM headers: 0
[01:05:40.404] <TB0> INFO: flawed TBM trailers: 0
[01:05:40.404] <TB0> INFO: event ID mismatches: 0
[01:05:40.404] <TB0> INFO: ROC errors: 0
[01:05:40.404] <TB0> INFO: missing ROC header(s): 0
[01:05:40.404] <TB0> INFO: misplaced readback start: 0
[01:05:40.404] <TB0> INFO: Pixel decoding errors: 0
[01:05:40.404] <TB0> INFO: pixel data incomplete: 0
[01:05:40.404] <TB0> INFO: pixel address: 0
[01:05:40.404] <TB0> INFO: pulse height fill bit: 0
[01:05:40.404] <TB0> INFO: buffer corruption: 0
[01:05:40.412] <TB0> INFO: ######################################################################
[01:05:40.412] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[01:05:40.412] <TB0> INFO: ######################################################################
[01:05:40.414] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[01:05:40.427] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[01:05:40.427] <TB0> INFO: run 1 of 1
[01:05:40.703] <TB0> INFO: Expecting 3120000 events.
[01:06:22.035] <TB0> INFO: 876305 events read in total (40776ms).
[01:07:02.459] <TB0> INFO: 1748605 events read in total (81200ms).
[01:07:43.409] <TB0> INFO: 2637525 events read in total (122151ms).
[01:08:05.917] <TB0> INFO: 3120000 events read in total (144658ms).
[01:08:05.976] <TB0> INFO: Test took 145549ms.
[01:08:29.900] <TB0> INFO: PixTestBBMap::doTest() done, duration: 169 seconds
[01:08:29.901] <TB0> INFO: number of dead bumps (per ROC): 8 0 0 0 0 1 0 0 1 0 0 1 0 0 0 11
[01:08:29.901] <TB0> INFO: separation cut (per ROC): 87 108 114 87 105 100 66 103 98 99 92 91 93 103 104 76
[01:08:29.901] <TB0> INFO: Decoding statistics:
[01:08:29.901] <TB0> INFO: General information:
[01:08:29.901] <TB0> INFO: 16bit words read: 0
[01:08:29.901] <TB0> INFO: valid events total: 0
[01:08:29.901] <TB0> INFO: empty events: 0
[01:08:29.901] <TB0> INFO: valid events with pixels: 0
[01:08:29.901] <TB0> INFO: valid pixel hits: 0
[01:08:29.901] <TB0> INFO: Event errors: 0
[01:08:29.901] <TB0> INFO: start marker: 0
[01:08:29.901] <TB0> INFO: stop marker: 0
[01:08:29.901] <TB0> INFO: overflow: 0
[01:08:29.901] <TB0> INFO: invalid 5bit words: 0
[01:08:29.901] <TB0> INFO: invalid XOR eye diagram: 0
[01:08:29.901] <TB0> INFO: frame (failed synchr.): 0
[01:08:29.901] <TB0> INFO: idle data (no TBM trl): 0
[01:08:29.901] <TB0> INFO: no data (only TBM hdr): 0
[01:08:29.901] <TB0> INFO: TBM errors: 0
[01:08:29.901] <TB0> INFO: flawed TBM headers: 0
[01:08:29.901] <TB0> INFO: flawed TBM trailers: 0
[01:08:29.901] <TB0> INFO: event ID mismatches: 0
[01:08:29.901] <TB0> INFO: ROC errors: 0
[01:08:29.901] <TB0> INFO: missing ROC header(s): 0
[01:08:29.901] <TB0> INFO: misplaced readback start: 0
[01:08:29.901] <TB0> INFO: Pixel decoding errors: 0
[01:08:29.901] <TB0> INFO: pixel data incomplete: 0
[01:08:29.901] <TB0> INFO: pixel address: 0
[01:08:29.901] <TB0> INFO: pulse height fill bit: 0
[01:08:29.901] <TB0> INFO: buffer corruption: 0
[01:08:30.008] <TB0> INFO: ######################################################################
[01:08:30.008] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[01:08:30.008] <TB0> INFO: ######################################################################
[01:08:30.009] <TB0> INFO: ----------------------------------------------------------------------
[01:08:30.009] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[01:08:30.009] <TB0> INFO: ----------------------------------------------------------------------
[01:08:30.009] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[01:08:30.020] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[01:08:30.020] <TB0> INFO: run 1 of 1
[01:08:30.320] <TB0> INFO: Expecting 26208000 events.
[01:09:03.916] <TB0> INFO: 889550 events read in total (33040ms).
[01:09:36.641] <TB0> INFO: 1764750 events read in total (65765ms).
[01:10:08.879] <TB0> INFO: 2639850 events read in total (98003ms).
[01:10:41.261] <TB0> INFO: 3513500 events read in total (130385ms).
[01:11:13.915] <TB0> INFO: 4386250 events read in total (163039ms).
[01:11:46.343] <TB0> INFO: 5257800 events read in total (195467ms).
[01:12:18.869] <TB0> INFO: 6130900 events read in total (227993ms).
[01:12:51.652] <TB0> INFO: 7001150 events read in total (260776ms).
[01:13:24.293] <TB0> INFO: 7872800 events read in total (293417ms).
[01:13:56.744] <TB0> INFO: 8743800 events read in total (325868ms).
[01:14:28.973] <TB0> INFO: 9617400 events read in total (358097ms).
[01:15:01.664] <TB0> INFO: 10484600 events read in total (390788ms).
[01:15:34.050] <TB0> INFO: 11355200 events read in total (423174ms).
[01:16:06.834] <TB0> INFO: 12226650 events read in total (455958ms).
[01:16:39.106] <TB0> INFO: 13094100 events read in total (488230ms).
[01:17:11.710] <TB0> INFO: 13953100 events read in total (520834ms).
[01:17:44.134] <TB0> INFO: 14814800 events read in total (553258ms).
[01:18:16.835] <TB0> INFO: 15674050 events read in total (585959ms).
[01:18:48.968] <TB0> INFO: 16529200 events read in total (618092ms).
[01:19:21.630] <TB0> INFO: 17386900 events read in total (650754ms).
[01:19:53.953] <TB0> INFO: 18244800 events read in total (683077ms).
[01:20:26.543] <TB0> INFO: 19099750 events read in total (715667ms).
[01:20:59.116] <TB0> INFO: 19955700 events read in total (748240ms).
[01:21:31.330] <TB0> INFO: 20814200 events read in total (780454ms).
[01:22:03.790] <TB0> INFO: 21671850 events read in total (812914ms).
[01:22:36.394] <TB0> INFO: 22526900 events read in total (845518ms).
[01:23:09.098] <TB0> INFO: 23386450 events read in total (878222ms).
[01:23:41.274] <TB0> INFO: 24246250 events read in total (910398ms).
[01:24:13.565] <TB0> INFO: 25106250 events read in total (942689ms).
[01:24:46.147] <TB0> INFO: 25978750 events read in total (975271ms).
[01:24:54.789] <TB0> INFO: 26208000 events read in total (983913ms).
[01:24:54.820] <TB0> INFO: Test took 984800ms.
[01:24:55.083] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:24:56.478] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:24:57.867] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:24:59.258] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:00.685] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:02.024] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:03.372] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:04.800] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:06.142] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:07.534] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:08.934] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:10.321] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:11.991] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:13.808] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:15.543] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:17.090] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[01:25:19.019] <TB0> INFO: PixTestScurves::scurves() done
[01:25:19.019] <TB0> INFO: Vcal mean: 87.43 87.61 88.47 77.69 101.97 97.60 67.66 101.50 95.34 95.46 89.83 77.09 85.92 97.71 98.56 89.80
[01:25:19.019] <TB0> INFO: Vcal RMS: 5.33 5.46 5.55 4.26 6.24 6.51 4.99 5.94 6.04 6.17 5.82 5.14 5.60 5.59 6.07 5.45
[01:25:19.019] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1009 seconds
[01:25:19.019] <TB0> INFO: Decoding statistics:
[01:25:19.019] <TB0> INFO: General information:
[01:25:19.019] <TB0> INFO: 16bit words read: 0
[01:25:19.019] <TB0> INFO: valid events total: 0
[01:25:19.019] <TB0> INFO: empty events: 0
[01:25:19.019] <TB0> INFO: valid events with pixels: 0
[01:25:19.019] <TB0> INFO: valid pixel hits: 0
[01:25:19.019] <TB0> INFO: Event errors: 0
[01:25:19.019] <TB0> INFO: start marker: 0
[01:25:19.019] <TB0> INFO: stop marker: 0
[01:25:19.019] <TB0> INFO: overflow: 0
[01:25:19.019] <TB0> INFO: invalid 5bit words: 0
[01:25:19.019] <TB0> INFO: invalid XOR eye diagram: 0
[01:25:19.019] <TB0> INFO: frame (failed synchr.): 0
[01:25:19.019] <TB0> INFO: idle data (no TBM trl): 0
[01:25:19.019] <TB0> INFO: no data (only TBM hdr): 0
[01:25:19.020] <TB0> INFO: TBM errors: 0
[01:25:19.020] <TB0> INFO: flawed TBM headers: 0
[01:25:19.020] <TB0> INFO: flawed TBM trailers: 0
[01:25:19.020] <TB0> INFO: event ID mismatches: 0
[01:25:19.020] <TB0> INFO: ROC errors: 0
[01:25:19.020] <TB0> INFO: missing ROC header(s): 0
[01:25:19.020] <TB0> INFO: misplaced readback start: 0
[01:25:19.020] <TB0> INFO: Pixel decoding errors: 0
[01:25:19.020] <TB0> INFO: pixel data incomplete: 0
[01:25:19.020] <TB0> INFO: pixel address: 0
[01:25:19.020] <TB0> INFO: pulse height fill bit: 0
[01:25:19.020] <TB0> INFO: buffer corruption: 0
[01:25:19.098] <TB0> INFO: ######################################################################
[01:25:19.098] <TB0> INFO: PixTestTrim::doTest()
[01:25:19.098] <TB0> INFO: ######################################################################
[01:25:19.099] <TB0> INFO: ----------------------------------------------------------------------
[01:25:19.099] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[01:25:19.099] <TB0> INFO: ----------------------------------------------------------------------
[01:25:19.193] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[01:25:19.193] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[01:25:19.205] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:25:19.205] <TB0> INFO: run 1 of 1
[01:25:19.499] <TB0> INFO: Expecting 6281600 events.
[01:25:59.209] <TB0> INFO: 1089900 events read in total (39154ms).
[01:26:38.596] <TB0> INFO: 2173640 events read in total (78542ms).
[01:27:17.212] <TB0> INFO: 3249690 events read in total (117157ms).
[01:27:56.430] <TB0> INFO: 4333230 events read in total (156375ms).
[01:28:35.641] <TB0> INFO: 5420230 events read in total (195586ms).
[01:29:06.906] <TB0> INFO: 6281600 events read in total (226851ms).
[01:29:06.944] <TB0> INFO: Test took 227739ms.
[01:29:25.891] <TB0> INFO: ROC 0 VthrComp = 93
[01:29:25.891] <TB0> INFO: ROC 1 VthrComp = 92
[01:29:25.891] <TB0> INFO: ROC 2 VthrComp = 92
[01:29:25.891] <TB0> INFO: ROC 3 VthrComp = 78
[01:29:25.891] <TB0> INFO: ROC 4 VthrComp = 99
[01:29:25.891] <TB0> INFO: ROC 5 VthrComp = 91
[01:29:25.891] <TB0> INFO: ROC 6 VthrComp = 71
[01:29:25.891] <TB0> INFO: ROC 7 VthrComp = 100
[01:29:25.891] <TB0> INFO: ROC 8 VthrComp = 91
[01:29:25.891] <TB0> INFO: ROC 9 VthrComp = 93
[01:29:25.892] <TB0> INFO: ROC 10 VthrComp = 88
[01:29:25.892] <TB0> INFO: ROC 11 VthrComp = 80
[01:29:25.892] <TB0> INFO: ROC 12 VthrComp = 85
[01:29:25.892] <TB0> INFO: ROC 13 VthrComp = 96
[01:29:25.892] <TB0> INFO: ROC 14 VthrComp = 99
[01:29:25.892] <TB0> INFO: ROC 15 VthrComp = 90
[01:29:25.892] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[01:29:25.892] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[01:29:25.900] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:29:25.900] <TB0> INFO: run 1 of 1
[01:29:26.165] <TB0> INFO: Expecting 6281600 events.
[01:30:01.158] <TB0> INFO: 757470 events read in total (34436ms).
[01:30:35.712] <TB0> INFO: 1512940 events read in total (68990ms).
[01:31:10.409] <TB0> INFO: 2269080 events read in total (103687ms).
[01:31:45.322] <TB0> INFO: 3025660 events read in total (138600ms).
[01:32:20.057] <TB0> INFO: 3777100 events read in total (173335ms).
[01:32:54.800] <TB0> INFO: 4524860 events read in total (208078ms).
[01:33:30.021] <TB0> INFO: 5271310 events read in total (243299ms).
[01:34:04.749] <TB0> INFO: 6017060 events read in total (278027ms).
[01:34:17.254] <TB0> INFO: 6281600 events read in total (290532ms).
[01:34:17.293] <TB0> INFO: Test took 291393ms.
[01:34:42.923] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 58.5481 for pixel 20/79 mean/min/max = 45.3271/32.0241/58.63
[01:34:42.923] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 57.8319 for pixel 42/70 mean/min/max = 45.4071/32.797/58.0171
[01:34:42.923] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 58.6803 for pixel 50/75 mean/min/max = 45.3628/32.0334/58.6921
[01:34:42.924] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 59.0799 for pixel 51/3 mean/min/max = 47.0747/35.0656/59.0838
[01:34:42.924] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 63.2828 for pixel 18/58 mean/min/max = 47.229/31.078/63.3799
[01:34:42.924] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 63.8826 for pixel 12/1 mean/min/max = 47.4305/30.9328/63.9282
[01:34:42.924] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 57.3401 for pixel 14/43 mean/min/max = 45.0694/32.6667/57.472
[01:34:42.925] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 61.1025 for pixel 41/79 mean/min/max = 46.3351/31.5595/61.1108
[01:34:42.925] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 64.5989 for pixel 17/74 mean/min/max = 48.3066/31.7529/64.8602
[01:34:42.925] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 61.8762 for pixel 0/10 mean/min/max = 46.809/31.7381/61.8798
[01:34:42.925] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 61.8924 for pixel 16/79 mean/min/max = 47.4463/32.8491/62.0434
[01:34:42.926] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 60.2592 for pixel 3/21 mean/min/max = 45.9415/31.4699/60.413
[01:34:42.926] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 60.7602 for pixel 13/79 mean/min/max = 46.4654/32.1693/60.7616
[01:34:42.926] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.1157 for pixel 23/7 mean/min/max = 46.1737/32.12/60.2273
[01:34:42.926] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 60.832 for pixel 10/6 mean/min/max = 45.9923/31.1203/60.8643
[01:34:42.927] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 59.6297 for pixel 44/0 mean/min/max = 46.2198/32.6266/59.813
[01:34:42.927] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[01:34:43.015] <TB0> INFO: Expecting 514560 events.
[01:34:55.946] <TB0> INFO: 514560 events read in total (12375ms).
[01:34:55.952] <TB0> INFO: Expecting 514560 events.
[01:35:08.778] <TB0> INFO: 514560 events read in total (12417ms).
[01:35:08.786] <TB0> INFO: Expecting 514560 events.
[01:35:21.448] <TB0> INFO: 514560 events read in total (12246ms).
[01:35:21.456] <TB0> INFO: Expecting 514560 events.
[01:35:34.161] <TB0> INFO: 514560 events read in total (12287ms).
[01:35:34.171] <TB0> INFO: Expecting 514560 events.
[01:35:46.971] <TB0> INFO: 514560 events read in total (12380ms).
[01:35:46.983] <TB0> INFO: Expecting 514560 events.
[01:35:59.865] <TB0> INFO: 514560 events read in total (12472ms).
[01:35:59.880] <TB0> INFO: Expecting 514560 events.
[01:36:12.634] <TB0> INFO: 514560 events read in total (12337ms).
[01:36:12.649] <TB0> INFO: Expecting 514560 events.
[01:36:25.395] <TB0> INFO: 514560 events read in total (12328ms).
[01:36:25.412] <TB0> INFO: Expecting 514560 events.
[01:36:38.273] <TB0> INFO: 514560 events read in total (12447ms).
[01:36:38.291] <TB0> INFO: Expecting 514560 events.
[01:36:51.099] <TB0> INFO: 514560 events read in total (12400ms).
[01:36:51.121] <TB0> INFO: Expecting 514560 events.
[01:37:03.981] <TB0> INFO: 514560 events read in total (12458ms).
[01:37:04.002] <TB0> INFO: Expecting 514560 events.
[01:37:16.771] <TB0> INFO: 514560 events read in total (12359ms).
[01:37:16.795] <TB0> INFO: Expecting 514560 events.
[01:37:29.441] <TB0> INFO: 514560 events read in total (12242ms).
[01:37:29.471] <TB0> INFO: Expecting 514560 events.
[01:37:42.285] <TB0> INFO: 514560 events read in total (12413ms).
[01:37:42.313] <TB0> INFO: Expecting 514560 events.
[01:37:55.120] <TB0> INFO: 514560 events read in total (12405ms).
[01:37:55.149] <TB0> INFO: Expecting 514560 events.
[01:38:07.954] <TB0> INFO: 514560 events read in total (12404ms).
[01:38:07.984] <TB0> INFO: Test took 205057ms.
[01:38:08.819] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[01:38:08.827] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:38:08.827] <TB0> INFO: run 1 of 1
[01:38:09.098] <TB0> INFO: Expecting 6281600 events.
[01:38:44.668] <TB0> INFO: 741750 events read in total (35014ms).
[01:39:19.265] <TB0> INFO: 1481730 events read in total (69611ms).
[01:39:53.831] <TB0> INFO: 2222500 events read in total (104177ms).
[01:40:28.371] <TB0> INFO: 2963600 events read in total (138717ms).
[01:41:02.821] <TB0> INFO: 3699000 events read in total (173167ms).
[01:41:37.431] <TB0> INFO: 4429920 events read in total (207777ms).
[01:42:11.844] <TB0> INFO: 5159020 events read in total (242190ms).
[01:42:46.139] <TB0> INFO: 5887440 events read in total (276485ms).
[01:43:04.907] <TB0> INFO: 6281600 events read in total (295253ms).
[01:43:04.965] <TB0> INFO: Test took 296137ms.
[01:43:30.779] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.113551 .. 255.000000
[01:43:30.854] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[01:43:30.862] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:43:30.862] <TB0> INFO: run 1 of 1
[01:43:31.126] <TB0> INFO: Expecting 10649600 events.
[01:44:06.259] <TB0> INFO: 712230 events read in total (34577ms).
[01:44:40.206] <TB0> INFO: 1424780 events read in total (68524ms).
[01:45:14.240] <TB0> INFO: 2137260 events read in total (102558ms).
[01:45:48.527] <TB0> INFO: 2849890 events read in total (136845ms).
[01:46:22.455] <TB0> INFO: 3562440 events read in total (170773ms).
[01:46:57.209] <TB0> INFO: 4275020 events read in total (205527ms).
[01:47:31.312] <TB0> INFO: 4987890 events read in total (239630ms).
[01:48:05.366] <TB0> INFO: 5700280 events read in total (273684ms).
[01:48:39.514] <TB0> INFO: 6412300 events read in total (307832ms).
[01:49:14.260] <TB0> INFO: 7123900 events read in total (342578ms).
[01:49:48.648] <TB0> INFO: 7835390 events read in total (376966ms).
[01:50:23.067] <TB0> INFO: 8546450 events read in total (411385ms).
[01:50:57.347] <TB0> INFO: 9257220 events read in total (445665ms).
[01:51:31.563] <TB0> INFO: 9967850 events read in total (479881ms).
[01:52:04.861] <TB0> INFO: 10649600 events read in total (513179ms).
[01:52:04.981] <TB0> INFO: Test took 514120ms.
[01:52:35.736] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 15.184585 .. 49.191502
[01:52:35.811] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 59 (-1/-1) hits flags = 528 (plus default)
[01:52:35.819] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:52:35.819] <TB0> INFO: run 1 of 1
[01:52:36.086] <TB0> INFO: Expecting 2288000 events.
[01:53:14.711] <TB0> INFO: 909750 events read in total (38069ms).
[01:53:51.950] <TB0> INFO: 1818710 events read in total (75308ms).
[01:54:11.485] <TB0> INFO: 2288000 events read in total (94844ms).
[01:54:11.509] <TB0> INFO: Test took 95691ms.
[01:54:25.720] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 19.847952 .. 46.706662
[01:54:25.796] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 9 .. 56 (-1/-1) hits flags = 528 (plus default)
[01:54:25.805] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:54:25.805] <TB0> INFO: run 1 of 1
[01:54:26.078] <TB0> INFO: Expecting 1996800 events.
[01:55:03.602] <TB0> INFO: 910290 events read in total (36968ms).
[01:55:40.861] <TB0> INFO: 1819500 events read in total (74227ms).
[01:55:48.445] <TB0> INFO: 1996800 events read in total (81812ms).
[01:55:48.462] <TB0> INFO: Test took 82658ms.
[01:56:02.554] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 2.891168 .. 46.706662
[01:56:02.647] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 2 .. 56 (-1/-1) hits flags = 528 (plus default)
[01:56:02.657] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:56:02.657] <TB0> INFO: run 1 of 1
[01:56:02.943] <TB0> INFO: Expecting 2288000 events.
[01:56:41.216] <TB0> INFO: 948380 events read in total (37716ms).
[01:57:18.986] <TB0> INFO: 1896900 events read in total (75486ms).
[01:57:34.754] <TB0> INFO: 2288000 events read in total (91254ms).
[01:57:34.770] <TB0> INFO: Test took 92113ms.
[01:57:49.404] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[01:57:49.404] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[01:57:49.412] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[01:57:49.412] <TB0> INFO: run 1 of 1
[01:57:49.676] <TB0> INFO: Expecting 1705600 events.
[01:58:27.375] <TB0> INFO: 878720 events read in total (37143ms).
[01:59:02.047] <TB0> INFO: 1705600 events read in total (71815ms).
[01:59:02.081] <TB0> INFO: Test took 72669ms.
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C0.dat
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C1.dat
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C2.dat
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C3.dat
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C4.dat
[01:59:16.583] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C5.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C6.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C7.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C8.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C9.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C10.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C11.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C12.dat
[01:59:16.584] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C13.dat
[01:59:16.585] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C14.dat
[01:59:16.585] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C15.dat
[01:59:16.585] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C0.dat
[01:59:16.592] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C1.dat
[01:59:16.599] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C2.dat
[01:59:16.606] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C3.dat
[01:59:16.613] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C4.dat
[01:59:16.621] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C5.dat
[01:59:16.632] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C6.dat
[01:59:16.639] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C7.dat
[01:59:16.647] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C8.dat
[01:59:16.654] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C9.dat
[01:59:16.661] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C10.dat
[01:59:16.668] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C11.dat
[01:59:16.675] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C12.dat
[01:59:16.682] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C13.dat
[01:59:16.689] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C14.dat
[01:59:16.700] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//trimParameters35_C15.dat
[01:59:16.712] <TB0> INFO: PixTestTrim::trimTest() done
[01:59:16.712] <TB0> INFO: vtrim: 85 91 87 78 104 104 83 86 112 91 96 93 89 93 100 98
[01:59:16.712] <TB0> INFO: vthrcomp: 93 92 92 78 99 91 71 100 91 93 88 80 85 96 99 90
[01:59:16.712] <TB0> INFO: vcal mean: 35.01 35.02 34.98 34.94 34.96 34.96 34.98 34.99 34.98 34.99 34.99 34.90 34.95 35.00 34.95 34.98
[01:59:16.712] <TB0> INFO: vcal RMS: 0.83 0.79 0.94 0.82 1.05 1.03 0.82 0.93 1.01 0.89 0.88 0.89 0.88 0.89 0.92 0.89
[01:59:16.712] <TB0> INFO: bits mean: 9.32 9.26 9.46 7.56 9.61 9.41 9.68 9.04 9.40 8.71 8.70 9.61 9.49 9.49 9.63 9.29
[01:59:16.712] <TB0> INFO: bits RMS: 2.81 2.72 2.73 2.85 2.61 2.73 2.57 2.90 2.56 3.00 2.77 2.68 2.62 2.66 2.69 2.63
[01:59:16.719] <TB0> INFO: ----------------------------------------------------------------------
[01:59:16.719] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[01:59:16.719] <TB0> INFO: ----------------------------------------------------------------------
[01:59:16.722] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[01:59:16.737] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[01:59:16.737] <TB0> INFO: run 1 of 1
[01:59:17.027] <TB0> INFO: Expecting 4160000 events.
[01:59:58.255] <TB0> INFO: 920905 events read in total (40673ms).
[02:00:39.411] <TB0> INFO: 1836860 events read in total (81829ms).
[02:01:20.070] <TB0> INFO: 2746050 events read in total (122487ms).
[02:02:00.880] <TB0> INFO: 3653445 events read in total (163297ms).
[02:02:23.770] <TB0> INFO: 4160000 events read in total (186188ms).
[02:02:23.815] <TB0> INFO: Test took 187078ms.
[02:02:55.132] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 179 (-1/-1) hits flags = 528 (plus default)
[02:02:55.140] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[02:02:55.140] <TB0> INFO: run 1 of 1
[02:02:55.422] <TB0> INFO: Expecting 3744000 events.
[02:03:37.275] <TB0> INFO: 926645 events read in total (41296ms).
[02:04:18.481] <TB0> INFO: 1847630 events read in total (82502ms).
[02:04:59.509] <TB0> INFO: 2759700 events read in total (123530ms).
[02:05:40.539] <TB0> INFO: 3673350 events read in total (164560ms).
[02:05:44.120] <TB0> INFO: 3744000 events read in total (168141ms).
[02:05:44.162] <TB0> INFO: Test took 169023ms.
[02:06:13.192] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 166 (-1/-1) hits flags = 528 (plus default)
[02:06:13.200] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[02:06:13.200] <TB0> INFO: run 1 of 1
[02:06:13.464] <TB0> INFO: Expecting 3473600 events.
[02:06:56.043] <TB0> INFO: 955140 events read in total (42023ms).
[02:07:37.787] <TB0> INFO: 1902465 events read in total (83767ms).
[02:08:19.639] <TB0> INFO: 2840620 events read in total (125619ms).
[02:08:48.150] <TB0> INFO: 3473600 events read in total (154130ms).
[02:08:48.186] <TB0> INFO: Test took 154986ms.
[02:09:14.634] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 164 (-1/-1) hits flags = 528 (plus default)
[02:09:14.643] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[02:09:14.643] <TB0> INFO: run 1 of 1
[02:09:14.937] <TB0> INFO: Expecting 3432000 events.
[02:09:57.574] <TB0> INFO: 959320 events read in total (42081ms).
[02:10:39.154] <TB0> INFO: 1910565 events read in total (83661ms).
[02:11:21.069] <TB0> INFO: 2852700 events read in total (125576ms).
[02:11:46.513] <TB0> INFO: 3432000 events read in total (151020ms).
[02:11:46.549] <TB0> INFO: Test took 151906ms.
[02:12:12.448] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 166 (-1/-1) hits flags = 528 (plus default)
[02:12:12.460] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[02:12:12.460] <TB0> INFO: run 1 of 1
[02:12:12.749] <TB0> INFO: Expecting 3473600 events.
[02:12:55.051] <TB0> INFO: 953735 events read in total (41746ms).
[02:13:36.514] <TB0> INFO: 1899585 events read in total (83209ms).
[02:14:17.646] <TB0> INFO: 2836305 events read in total (124342ms).
[02:14:45.504] <TB0> INFO: 3473600 events read in total (152199ms).
[02:14:45.548] <TB0> INFO: Test took 153088ms.
[02:15:11.461] <TB0> INFO: PixTestTrim::trimBitTest() done
[02:15:11.462] <TB0> INFO: PixTestTrim::doTest() done, duration: 2992 seconds
[02:15:11.462] <TB0> INFO: Decoding statistics:
[02:15:11.462] <TB0> INFO: General information:
[02:15:11.462] <TB0> INFO: 16bit words read: 0
[02:15:11.463] <TB0> INFO: valid events total: 0
[02:15:11.463] <TB0> INFO: empty events: 0
[02:15:11.463] <TB0> INFO: valid events with pixels: 0
[02:15:11.463] <TB0> INFO: valid pixel hits: 0
[02:15:11.463] <TB0> INFO: Event errors: 0
[02:15:11.463] <TB0> INFO: start marker: 0
[02:15:11.463] <TB0> INFO: stop marker: 0
[02:15:11.463] <TB0> INFO: overflow: 0
[02:15:11.463] <TB0> INFO: invalid 5bit words: 0
[02:15:11.463] <TB0> INFO: invalid XOR eye diagram: 0
[02:15:11.463] <TB0> INFO: frame (failed synchr.): 0
[02:15:11.463] <TB0> INFO: idle data (no TBM trl): 0
[02:15:11.463] <TB0> INFO: no data (only TBM hdr): 0
[02:15:11.463] <TB0> INFO: TBM errors: 0
[02:15:11.463] <TB0> INFO: flawed TBM headers: 0
[02:15:11.463] <TB0> INFO: flawed TBM trailers: 0
[02:15:11.463] <TB0> INFO: event ID mismatches: 0
[02:15:11.463] <TB0> INFO: ROC errors: 0
[02:15:11.463] <TB0> INFO: missing ROC header(s): 0
[02:15:11.463] <TB0> INFO: misplaced readback start: 0
[02:15:11.463] <TB0> INFO: Pixel decoding errors: 0
[02:15:11.463] <TB0> INFO: pixel data incomplete: 0
[02:15:11.463] <TB0> INFO: pixel address: 0
[02:15:11.463] <TB0> INFO: pulse height fill bit: 0
[02:15:11.463] <TB0> INFO: buffer corruption: 0
[02:15:12.238] <TB0> INFO: ######################################################################
[02:15:12.238] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[02:15:12.238] <TB0> INFO: ######################################################################
[02:15:12.536] <TB0> INFO: Expecting 41600 events.
[02:15:16.274] <TB0> INFO: 41600 events read in total (3182ms).
[02:15:16.275] <TB0> INFO: Test took 4036ms.
[02:15:16.739] <TB0> INFO: Expecting 41600 events.
[02:15:20.565] <TB0> INFO: 41600 events read in total (3269ms).
[02:15:20.566] <TB0> INFO: Test took 4088ms.
[02:15:20.923] <TB0> INFO: Expecting 41600 events.
[02:15:24.714] <TB0> INFO: 41600 events read in total (3235ms).
[02:15:24.715] <TB0> INFO: Test took 4121ms.
[02:15:24.971] <TB0> INFO: Expecting 2560 events.
[02:15:25.825] <TB0> INFO: 2560 events read in total (298ms).
[02:15:25.825] <TB0> INFO: Test took 1096ms.
[02:15:26.130] <TB0> INFO: Expecting 2560 events.
[02:15:26.985] <TB0> INFO: 2560 events read in total (298ms).
[02:15:26.986] <TB0> INFO: Test took 1160ms.
[02:15:27.291] <TB0> INFO: Expecting 2560 events.
[02:15:28.145] <TB0> INFO: 2560 events read in total (298ms).
[02:15:28.146] <TB0> INFO: Test took 1160ms.
[02:15:28.450] <TB0> INFO: Expecting 2560 events.
[02:15:29.305] <TB0> INFO: 2560 events read in total (298ms).
[02:15:29.306] <TB0> INFO: Test took 1160ms.
[02:15:29.610] <TB0> INFO: Expecting 2560 events.
[02:15:30.464] <TB0> INFO: 2560 events read in total (297ms).
[02:15:30.464] <TB0> INFO: Test took 1158ms.
[02:15:30.769] <TB0> INFO: Expecting 2560 events.
[02:15:31.621] <TB0> INFO: 2560 events read in total (296ms).
[02:15:31.621] <TB0> INFO: Test took 1157ms.
[02:15:31.927] <TB0> INFO: Expecting 2560 events.
[02:15:32.779] <TB0> INFO: 2560 events read in total (296ms).
[02:15:32.779] <TB0> INFO: Test took 1157ms.
[02:15:33.084] <TB0> INFO: Expecting 2560 events.
[02:15:33.938] <TB0> INFO: 2560 events read in total (298ms).
[02:15:33.938] <TB0> INFO: Test took 1158ms.
[02:15:34.243] <TB0> INFO: Expecting 2560 events.
[02:15:35.096] <TB0> INFO: 2560 events read in total (297ms).
[02:15:35.096] <TB0> INFO: Test took 1158ms.
[02:15:35.401] <TB0> INFO: Expecting 2560 events.
[02:15:36.254] <TB0> INFO: 2560 events read in total (297ms).
[02:15:36.254] <TB0> INFO: Test took 1157ms.
[02:15:36.559] <TB0> INFO: Expecting 2560 events.
[02:15:37.412] <TB0> INFO: 2560 events read in total (297ms).
[02:15:37.412] <TB0> INFO: Test took 1157ms.
[02:15:37.717] <TB0> INFO: Expecting 2560 events.
[02:15:38.571] <TB0> INFO: 2560 events read in total (298ms).
[02:15:38.571] <TB0> INFO: Test took 1158ms.
[02:15:38.876] <TB0> INFO: Expecting 2560 events.
[02:15:39.729] <TB0> INFO: 2560 events read in total (297ms).
[02:15:39.729] <TB0> INFO: Test took 1158ms.
[02:15:40.034] <TB0> INFO: Expecting 2560 events.
[02:15:40.887] <TB0> INFO: 2560 events read in total (297ms).
[02:15:40.887] <TB0> INFO: Test took 1158ms.
[02:15:41.192] <TB0> INFO: Expecting 2560 events.
[02:15:42.045] <TB0> INFO: 2560 events read in total (297ms).
[02:15:42.045] <TB0> INFO: Test took 1158ms.
[02:15:42.349] <TB0> INFO: Expecting 2560 events.
[02:15:43.203] <TB0> INFO: 2560 events read in total (297ms).
[02:15:43.203] <TB0> INFO: Test took 1158ms.
[02:15:43.206] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:15:43.509] <TB0> INFO: Expecting 655360 events.
[02:16:00.460] <TB0> INFO: 655360 events read in total (16395ms).
[02:16:00.470] <TB0> INFO: Expecting 655360 events.
[02:16:17.320] <TB0> INFO: 655360 events read in total (16448ms).
[02:16:17.332] <TB0> INFO: Expecting 655360 events.
[02:16:33.915] <TB0> INFO: 655360 events read in total (16181ms).
[02:16:33.931] <TB0> INFO: Expecting 655360 events.
[02:16:50.641] <TB0> INFO: 655360 events read in total (16309ms).
[02:16:50.660] <TB0> INFO: Expecting 655360 events.
[02:17:07.390] <TB0> INFO: 655360 events read in total (16328ms).
[02:17:07.412] <TB0> INFO: Expecting 655360 events.
[02:17:23.969] <TB0> INFO: 655360 events read in total (16155ms).
[02:17:23.995] <TB0> INFO: Expecting 655360 events.
[02:17:40.688] <TB0> INFO: 655360 events read in total (16292ms).
[02:17:40.717] <TB0> INFO: Expecting 655360 events.
[02:17:57.420] <TB0> INFO: 655360 events read in total (16301ms).
[02:17:57.453] <TB0> INFO: Expecting 655360 events.
[02:18:14.163] <TB0> INFO: 655360 events read in total (16308ms).
[02:18:14.201] <TB0> INFO: Expecting 655360 events.
[02:18:30.854] <TB0> INFO: 655360 events read in total (16251ms).
[02:18:30.896] <TB0> INFO: Expecting 655360 events.
[02:18:47.684] <TB0> INFO: 655360 events read in total (16386ms).
[02:18:47.733] <TB0> INFO: Expecting 655360 events.
[02:19:04.485] <TB0> INFO: 655360 events read in total (16350ms).
[02:19:04.531] <TB0> INFO: Expecting 655360 events.
[02:19:21.244] <TB0> INFO: 655360 events read in total (16312ms).
[02:19:21.305] <TB0> INFO: Expecting 655360 events.
[02:19:37.996] <TB0> INFO: 655360 events read in total (16289ms).
[02:19:38.055] <TB0> INFO: Expecting 655360 events.
[02:19:54.706] <TB0> INFO: 655360 events read in total (16249ms).
[02:19:54.787] <TB0> INFO: Expecting 655360 events.
[02:20:11.420] <TB0> INFO: 655360 events read in total (16231ms).
[02:20:11.500] <TB0> INFO: Test took 268294ms.
[02:20:11.578] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:20:11.808] <TB0> INFO: Expecting 655360 events.
[02:20:28.677] <TB0> INFO: 655360 events read in total (16313ms).
[02:20:28.687] <TB0> INFO: Expecting 655360 events.
[02:20:45.218] <TB0> INFO: 655360 events read in total (16129ms).
[02:20:45.230] <TB0> INFO: Expecting 655360 events.
[02:21:01.939] <TB0> INFO: 655360 events read in total (16307ms).
[02:21:01.955] <TB0> INFO: Expecting 655360 events.
[02:21:18.606] <TB0> INFO: 655360 events read in total (16249ms).
[02:21:18.625] <TB0> INFO: Expecting 655360 events.
[02:21:35.271] <TB0> INFO: 655360 events read in total (16244ms).
[02:21:35.293] <TB0> INFO: Expecting 655360 events.
[02:21:52.050] <TB0> INFO: 655360 events read in total (16355ms).
[02:21:52.076] <TB0> INFO: Expecting 655360 events.
[02:22:08.709] <TB0> INFO: 655360 events read in total (16231ms).
[02:22:08.740] <TB0> INFO: Expecting 655360 events.
[02:22:25.340] <TB0> INFO: 655360 events read in total (16198ms).
[02:22:25.373] <TB0> INFO: Expecting 655360 events.
[02:22:42.093] <TB0> INFO: 655360 events read in total (16319ms).
[02:22:42.137] <TB0> INFO: Expecting 655360 events.
[02:22:58.812] <TB0> INFO: 655360 events read in total (16273ms).
[02:22:58.852] <TB0> INFO: Expecting 655360 events.
[02:23:15.639] <TB0> INFO: 655360 events read in total (16385ms).
[02:23:15.687] <TB0> INFO: Expecting 655360 events.
[02:23:32.302] <TB0> INFO: 655360 events read in total (16214ms).
[02:23:32.348] <TB0> INFO: Expecting 655360 events.
[02:23:48.904] <TB0> INFO: 655360 events read in total (16154ms).
[02:23:48.969] <TB0> INFO: Expecting 655360 events.
[02:24:05.710] <TB0> INFO: 655360 events read in total (16339ms).
[02:24:05.768] <TB0> INFO: Expecting 655360 events.
[02:24:22.507] <TB0> INFO: 655360 events read in total (16337ms).
[02:24:22.566] <TB0> INFO: Expecting 655360 events.
[02:24:39.397] <TB0> INFO: 655360 events read in total (16429ms).
[02:24:39.460] <TB0> INFO: Test took 267882ms.
[02:24:39.650] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.657] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.664] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.671] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.677] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.684] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.691] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.698] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.705] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.712] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.718] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.725] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.732] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.739] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.746] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.753] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[02:24:39.760] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[02:24:39.767] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[02:24:39.774] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[02:24:39.780] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[02:24:39.814] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C0.dat
[02:24:39.814] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C1.dat
[02:24:39.814] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C2.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C3.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C4.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C5.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C6.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C7.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C8.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C9.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C10.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C11.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C12.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C13.dat
[02:24:39.815] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C14.dat
[02:24:39.816] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//dacParameters35_C15.dat
[02:24:40.080] <TB0> INFO: Expecting 41600 events.
[02:24:43.561] <TB0> INFO: 41600 events read in total (2925ms).
[02:24:43.562] <TB0> INFO: Test took 3744ms.
[02:24:44.009] <TB0> INFO: Expecting 41600 events.
[02:24:47.471] <TB0> INFO: 41600 events read in total (2906ms).
[02:24:47.472] <TB0> INFO: Test took 3729ms.
[02:24:47.920] <TB0> INFO: Expecting 41600 events.
[02:24:51.401] <TB0> INFO: 41600 events read in total (2925ms).
[02:24:51.401] <TB0> INFO: Test took 3752ms.
[02:24:51.584] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:51.672] <TB0> INFO: Expecting 2560 events.
[02:24:52.525] <TB0> INFO: 2560 events read in total (297ms).
[02:24:52.525] <TB0> INFO: Test took 941ms.
[02:24:52.527] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:52.831] <TB0> INFO: Expecting 2560 events.
[02:24:53.685] <TB0> INFO: 2560 events read in total (298ms).
[02:24:53.685] <TB0> INFO: Test took 1158ms.
[02:24:53.688] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:53.990] <TB0> INFO: Expecting 2560 events.
[02:24:54.843] <TB0> INFO: 2560 events read in total (297ms).
[02:24:54.849] <TB0> INFO: Test took 1161ms.
[02:24:54.850] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:55.149] <TB0> INFO: Expecting 2560 events.
[02:24:56.005] <TB0> INFO: 2560 events read in total (300ms).
[02:24:56.006] <TB0> INFO: Test took 1156ms.
[02:24:56.008] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:56.311] <TB0> INFO: Expecting 2560 events.
[02:24:57.167] <TB0> INFO: 2560 events read in total (300ms).
[02:24:57.167] <TB0> INFO: Test took 1159ms.
[02:24:57.169] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:57.473] <TB0> INFO: Expecting 2560 events.
[02:24:58.328] <TB0> INFO: 2560 events read in total (298ms).
[02:24:58.328] <TB0> INFO: Test took 1159ms.
[02:24:58.330] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:58.634] <TB0> INFO: Expecting 2560 events.
[02:24:59.489] <TB0> INFO: 2560 events read in total (299ms).
[02:24:59.489] <TB0> INFO: Test took 1159ms.
[02:24:59.491] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:24:59.794] <TB0> INFO: Expecting 2560 events.
[02:25:00.647] <TB0> INFO: 2560 events read in total (297ms).
[02:25:00.647] <TB0> INFO: Test took 1156ms.
[02:25:00.649] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:00.954] <TB0> INFO: Expecting 2560 events.
[02:25:01.808] <TB0> INFO: 2560 events read in total (298ms).
[02:25:01.809] <TB0> INFO: Test took 1160ms.
[02:25:01.810] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:02.114] <TB0> INFO: Expecting 2560 events.
[02:25:02.969] <TB0> INFO: 2560 events read in total (299ms).
[02:25:02.970] <TB0> INFO: Test took 1160ms.
[02:25:02.972] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:03.275] <TB0> INFO: Expecting 2560 events.
[02:25:04.128] <TB0> INFO: 2560 events read in total (297ms).
[02:25:04.128] <TB0> INFO: Test took 1156ms.
[02:25:04.130] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:04.434] <TB0> INFO: Expecting 2560 events.
[02:25:05.286] <TB0> INFO: 2560 events read in total (296ms).
[02:25:05.287] <TB0> INFO: Test took 1157ms.
[02:25:05.289] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:05.591] <TB0> INFO: Expecting 2560 events.
[02:25:06.445] <TB0> INFO: 2560 events read in total (298ms).
[02:25:06.445] <TB0> INFO: Test took 1156ms.
[02:25:06.447] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:06.751] <TB0> INFO: Expecting 2560 events.
[02:25:07.605] <TB0> INFO: 2560 events read in total (298ms).
[02:25:07.605] <TB0> INFO: Test took 1158ms.
[02:25:07.606] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:07.910] <TB0> INFO: Expecting 2560 events.
[02:25:08.768] <TB0> INFO: 2560 events read in total (302ms).
[02:25:08.768] <TB0> INFO: Test took 1162ms.
[02:25:08.771] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:09.073] <TB0> INFO: Expecting 2560 events.
[02:25:09.931] <TB0> INFO: 2560 events read in total (301ms).
[02:25:09.931] <TB0> INFO: Test took 1160ms.
[02:25:09.933] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:10.237] <TB0> INFO: Expecting 2560 events.
[02:25:11.091] <TB0> INFO: 2560 events read in total (298ms).
[02:25:11.091] <TB0> INFO: Test took 1159ms.
[02:25:11.093] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:11.397] <TB0> INFO: Expecting 2560 events.
[02:25:12.252] <TB0> INFO: 2560 events read in total (299ms).
[02:25:12.252] <TB0> INFO: Test took 1159ms.
[02:25:12.255] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:12.557] <TB0> INFO: Expecting 2560 events.
[02:25:13.410] <TB0> INFO: 2560 events read in total (297ms).
[02:25:13.410] <TB0> INFO: Test took 1156ms.
[02:25:13.412] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:13.717] <TB0> INFO: Expecting 2560 events.
[02:25:14.574] <TB0> INFO: 2560 events read in total (301ms).
[02:25:14.574] <TB0> INFO: Test took 1162ms.
[02:25:14.577] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:14.880] <TB0> INFO: Expecting 2560 events.
[02:25:15.734] <TB0> INFO: 2560 events read in total (298ms).
[02:25:15.734] <TB0> INFO: Test took 1157ms.
[02:25:15.736] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:16.041] <TB0> INFO: Expecting 2560 events.
[02:25:16.898] <TB0> INFO: 2560 events read in total (301ms).
[02:25:16.898] <TB0> INFO: Test took 1162ms.
[02:25:16.901] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:17.203] <TB0> INFO: Expecting 2560 events.
[02:25:18.059] <TB0> INFO: 2560 events read in total (300ms).
[02:25:18.059] <TB0> INFO: Test took 1159ms.
[02:25:18.062] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:18.365] <TB0> INFO: Expecting 2560 events.
[02:25:19.224] <TB0> INFO: 2560 events read in total (303ms).
[02:25:19.224] <TB0> INFO: Test took 1162ms.
[02:25:19.226] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:19.530] <TB0> INFO: Expecting 2560 events.
[02:25:20.383] <TB0> INFO: 2560 events read in total (297ms).
[02:25:20.384] <TB0> INFO: Test took 1158ms.
[02:25:20.386] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:20.689] <TB0> INFO: Expecting 2560 events.
[02:25:21.543] <TB0> INFO: 2560 events read in total (297ms).
[02:25:21.543] <TB0> INFO: Test took 1157ms.
[02:25:21.545] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:21.849] <TB0> INFO: Expecting 2560 events.
[02:25:22.707] <TB0> INFO: 2560 events read in total (301ms).
[02:25:22.707] <TB0> INFO: Test took 1162ms.
[02:25:22.709] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:23.014] <TB0> INFO: Expecting 2560 events.
[02:25:23.874] <TB0> INFO: 2560 events read in total (304ms).
[02:25:23.874] <TB0> INFO: Test took 1165ms.
[02:25:23.877] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:24.179] <TB0> INFO: Expecting 2560 events.
[02:25:25.037] <TB0> INFO: 2560 events read in total (302ms).
[02:25:25.037] <TB0> INFO: Test took 1160ms.
[02:25:25.039] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:25.342] <TB0> INFO: Expecting 2560 events.
[02:25:26.196] <TB0> INFO: 2560 events read in total (298ms).
[02:25:26.196] <TB0> INFO: Test took 1157ms.
[02:25:26.199] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:26.502] <TB0> INFO: Expecting 2560 events.
[02:25:27.361] <TB0> INFO: 2560 events read in total (303ms).
[02:25:27.361] <TB0> INFO: Test took 1163ms.
[02:25:27.364] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[02:25:27.667] <TB0> INFO: Expecting 2560 events.
[02:25:28.525] <TB0> INFO: 2560 events read in total (302ms).
[02:25:28.525] <TB0> INFO: Test took 1161ms.
[02:25:28.985] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 616 seconds
[02:25:28.985] <TB0> INFO: PH scale (per ROC): 86 83 82 74 71 71 78 70 74 78 75 81 82 79 80 80
[02:25:28.985] <TB0> INFO: PH offset (per ROC): 156 151 164 154 169 173 147 173 173 172 170 159 163 170 163 150
[02:25:28.991] <TB0> INFO: Decoding statistics:
[02:25:28.991] <TB0> INFO: General information:
[02:25:28.991] <TB0> INFO: 16bit words read: 91916
[02:25:28.991] <TB0> INFO: valid events total: 10240
[02:25:28.991] <TB0> INFO: empty events: 7741
[02:25:28.991] <TB0> INFO: valid events with pixels: 2499
[02:25:28.991] <TB0> INFO: valid pixel hits: 2499
[02:25:28.991] <TB0> INFO: Event errors: 0
[02:25:28.991] <TB0> INFO: start marker: 0
[02:25:28.991] <TB0> INFO: stop marker: 0
[02:25:28.991] <TB0> INFO: overflow: 0
[02:25:28.991] <TB0> INFO: invalid 5bit words: 0
[02:25:28.991] <TB0> INFO: invalid XOR eye diagram: 0
[02:25:28.991] <TB0> INFO: frame (failed synchr.): 0
[02:25:28.991] <TB0> INFO: idle data (no TBM trl): 0
[02:25:28.991] <TB0> INFO: no data (only TBM hdr): 0
[02:25:28.992] <TB0> INFO: TBM errors: 0
[02:25:28.992] <TB0> INFO: flawed TBM headers: 0
[02:25:28.992] <TB0> INFO: flawed TBM trailers: 0
[02:25:28.992] <TB0> INFO: event ID mismatches: 0
[02:25:28.992] <TB0> INFO: ROC errors: 0
[02:25:28.992] <TB0> INFO: missing ROC header(s): 0
[02:25:28.992] <TB0> INFO: misplaced readback start: 0
[02:25:28.992] <TB0> INFO: Pixel decoding errors: 0
[02:25:28.992] <TB0> INFO: pixel data incomplete: 0
[02:25:28.992] <TB0> INFO: pixel address: 0
[02:25:28.992] <TB0> INFO: pulse height fill bit: 0
[02:25:28.992] <TB0> INFO: buffer corruption: 0
[02:25:29.200] <TB0> INFO: ######################################################################
[02:25:29.200] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[02:25:29.200] <TB0> INFO: ######################################################################
[02:25:29.210] <TB0> INFO: scanning low vcal = 10
[02:25:29.494] <TB0> INFO: Expecting 41600 events.
[02:25:33.048] <TB0> INFO: 41600 events read in total (2998ms).
[02:25:33.048] <TB0> INFO: Test took 3837ms.
[02:25:33.050] <TB0> INFO: scanning low vcal = 20
[02:25:33.354] <TB0> INFO: Expecting 41600 events.
[02:25:36.921] <TB0> INFO: 41600 events read in total (3010ms).
[02:25:36.921] <TB0> INFO: Test took 3871ms.
[02:25:36.923] <TB0> INFO: scanning low vcal = 30
[02:25:37.226] <TB0> INFO: Expecting 41600 events.
[02:25:40.790] <TB0> INFO: 41600 events read in total (3008ms).
[02:25:40.790] <TB0> INFO: Test took 3867ms.
[02:25:40.792] <TB0> INFO: scanning low vcal = 40
[02:25:41.090] <TB0> INFO: Expecting 41600 events.
[02:25:45.280] <TB0> INFO: 41600 events read in total (3633ms).
[02:25:45.280] <TB0> INFO: Test took 4488ms.
[02:25:45.283] <TB0> INFO: scanning low vcal = 50
[02:25:45.547] <TB0> INFO: Expecting 41600 events.
[02:25:49.763] <TB0> INFO: 41600 events read in total (3660ms).
[02:25:49.764] <TB0> INFO: Test took 4481ms.
[02:25:49.767] <TB0> INFO: scanning low vcal = 60
[02:25:50.028] <TB0> INFO: Expecting 41600 events.
[02:25:54.245] <TB0> INFO: 41600 events read in total (3662ms).
[02:25:54.246] <TB0> INFO: Test took 4479ms.
[02:25:54.249] <TB0> INFO: scanning low vcal = 70
[02:25:54.512] <TB0> INFO: Expecting 41600 events.
[02:25:58.732] <TB0> INFO: 41600 events read in total (3664ms).
[02:25:58.733] <TB0> INFO: Test took 4484ms.
[02:25:58.735] <TB0> INFO: scanning low vcal = 80
[02:25:58.999] <TB0> INFO: Expecting 41600 events.
[02:26:03.255] <TB0> INFO: 41600 events read in total (3699ms).
[02:26:03.256] <TB0> INFO: Test took 4521ms.
[02:26:03.259] <TB0> INFO: scanning low vcal = 90
[02:26:03.518] <TB0> INFO: Expecting 41600 events.
[02:26:07.709] <TB0> INFO: 41600 events read in total (3635ms).
[02:26:07.710] <TB0> INFO: Test took 4451ms.
[02:26:07.713] <TB0> INFO: scanning low vcal = 100
[02:26:07.986] <TB0> INFO: Expecting 41600 events.
[02:26:12.241] <TB0> INFO: 41600 events read in total (3698ms).
[02:26:12.242] <TB0> INFO: Test took 4529ms.
[02:26:12.244] <TB0> INFO: scanning low vcal = 110
[02:26:12.507] <TB0> INFO: Expecting 41600 events.
[02:26:16.722] <TB0> INFO: 41600 events read in total (3658ms).
[02:26:16.722] <TB0> INFO: Test took 4478ms.
[02:26:16.725] <TB0> INFO: scanning low vcal = 120
[02:26:16.988] <TB0> INFO: Expecting 41600 events.
[02:26:21.209] <TB0> INFO: 41600 events read in total (3665ms).
[02:26:21.209] <TB0> INFO: Test took 4484ms.
[02:26:21.212] <TB0> INFO: scanning low vcal = 130
[02:26:21.473] <TB0> INFO: Expecting 41600 events.
[02:26:25.721] <TB0> INFO: 41600 events read in total (3691ms).
[02:26:25.722] <TB0> INFO: Test took 4510ms.
[02:26:25.724] <TB0> INFO: scanning low vcal = 140
[02:26:25.992] <TB0> INFO: Expecting 41600 events.
[02:26:30.205] <TB0> INFO: 41600 events read in total (3657ms).
[02:26:30.205] <TB0> INFO: Test took 4480ms.
[02:26:30.208] <TB0> INFO: scanning low vcal = 150
[02:26:30.472] <TB0> INFO: Expecting 41600 events.
[02:26:34.670] <TB0> INFO: 41600 events read in total (3641ms).
[02:26:34.671] <TB0> INFO: Test took 4463ms.
[02:26:34.675] <TB0> INFO: scanning low vcal = 160
[02:26:34.934] <TB0> INFO: Expecting 41600 events.
[02:26:39.169] <TB0> INFO: 41600 events read in total (3679ms).
[02:26:39.169] <TB0> INFO: Test took 4494ms.
[02:26:39.172] <TB0> INFO: scanning low vcal = 170
[02:26:39.440] <TB0> INFO: Expecting 41600 events.
[02:26:43.709] <TB0> INFO: 41600 events read in total (3713ms).
[02:26:43.710] <TB0> INFO: Test took 4538ms.
[02:26:43.714] <TB0> INFO: scanning low vcal = 180
[02:26:43.977] <TB0> INFO: Expecting 41600 events.
[02:26:48.196] <TB0> INFO: 41600 events read in total (3663ms).
[02:26:48.196] <TB0> INFO: Test took 4482ms.
[02:26:48.199] <TB0> INFO: scanning low vcal = 190
[02:26:48.462] <TB0> INFO: Expecting 41600 events.
[02:26:52.676] <TB0> INFO: 41600 events read in total (3658ms).
[02:26:52.676] <TB0> INFO: Test took 4477ms.
[02:26:52.678] <TB0> INFO: scanning low vcal = 200
[02:26:52.948] <TB0> INFO: Expecting 41600 events.
[02:26:57.222] <TB0> INFO: 41600 events read in total (3718ms).
[02:26:57.223] <TB0> INFO: Test took 4545ms.
[02:26:57.226] <TB0> INFO: scanning low vcal = 210
[02:26:57.504] <TB0> INFO: Expecting 41600 events.
[02:27:01.703] <TB0> INFO: 41600 events read in total (3642ms).
[02:27:01.706] <TB0> INFO: Test took 4480ms.
[02:27:01.709] <TB0> INFO: scanning low vcal = 220
[02:27:01.976] <TB0> INFO: Expecting 41600 events.
[02:27:06.190] <TB0> INFO: 41600 events read in total (3657ms).
[02:27:06.191] <TB0> INFO: Test took 4482ms.
[02:27:06.193] <TB0> INFO: scanning low vcal = 230
[02:27:06.459] <TB0> INFO: Expecting 41600 events.
[02:27:10.621] <TB0> INFO: 41600 events read in total (3606ms).
[02:27:10.621] <TB0> INFO: Test took 4428ms.
[02:27:10.623] <TB0> INFO: scanning low vcal = 240
[02:27:10.889] <TB0> INFO: Expecting 41600 events.
[02:27:15.147] <TB0> INFO: 41600 events read in total (3702ms).
[02:27:15.148] <TB0> INFO: Test took 4524ms.
[02:27:15.151] <TB0> INFO: scanning low vcal = 250
[02:27:15.453] <TB0> INFO: Expecting 41600 events.
[02:27:19.674] <TB0> INFO: 41600 events read in total (3665ms).
[02:27:19.675] <TB0> INFO: Test took 4524ms.
[02:27:19.679] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[02:27:19.988] <TB0> INFO: Expecting 41600 events.
[02:27:24.213] <TB0> INFO: 41600 events read in total (3668ms).
[02:27:24.213] <TB0> INFO: Test took 4534ms.
[02:27:24.215] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[02:27:24.476] <TB0> INFO: Expecting 41600 events.
[02:27:28.668] <TB0> INFO: 41600 events read in total (3636ms).
[02:27:28.669] <TB0> INFO: Test took 4453ms.
[02:27:28.672] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[02:27:29.017] <TB0> INFO: Expecting 41600 events.
[02:27:33.222] <TB0> INFO: 41600 events read in total (3649ms).
[02:27:33.222] <TB0> INFO: Test took 4550ms.
[02:27:33.225] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[02:27:33.492] <TB0> INFO: Expecting 41600 events.
[02:27:37.662] <TB0> INFO: 41600 events read in total (3614ms).
[02:27:37.662] <TB0> INFO: Test took 4437ms.
[02:27:37.665] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[02:27:37.924] <TB0> INFO: Expecting 41600 events.
[02:27:42.093] <TB0> INFO: 41600 events read in total (3613ms).
[02:27:42.093] <TB0> INFO: Test took 4428ms.
[02:27:42.558] <TB0> INFO: PixTestGainPedestal::measure() done
[02:28:16.676] <TB0> INFO: PixTestGainPedestal::fit() done
[02:28:16.676] <TB0> INFO: non-linearity mean: 0.962 0.958 0.956 0.956 0.961 0.956 0.951 0.955 0.957 0.956 0.953 0.958 0.955 0.958 0.952 0.964
[02:28:16.676] <TB0> INFO: non-linearity RMS: 0.005 0.005 0.006 0.006 0.006 0.005 0.006 0.006 0.007 0.005 0.005 0.005 0.007 0.006 0.006 0.005
[02:28:16.676] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[02:28:16.694] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[02:28:16.712] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[02:28:16.731] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[02:28:16.749] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[02:28:16.767] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[02:28:16.785] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[02:28:16.803] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[02:28:16.821] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[02:28:16.839] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[02:28:16.858] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[02:28:16.875] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[02:28:16.894] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[02:28:16.912] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[02:28:16.930] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[02:28:16.948] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[02:28:16.966] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 167 seconds
[02:28:16.966] <TB0> INFO: Decoding statistics:
[02:28:16.966] <TB0> INFO: General information:
[02:28:16.966] <TB0> INFO: 16bit words read: 2662400
[02:28:16.966] <TB0> INFO: valid events total: 166400
[02:28:16.966] <TB0> INFO: empty events: 0
[02:28:16.966] <TB0> INFO: valid events with pixels: 166400
[02:28:16.966] <TB0> INFO: valid pixel hits: 665566
[02:28:16.966] <TB0> INFO: Event errors: 0
[02:28:16.966] <TB0> INFO: start marker: 0
[02:28:16.966] <TB0> INFO: stop marker: 0
[02:28:16.966] <TB0> INFO: overflow: 0
[02:28:16.966] <TB0> INFO: invalid 5bit words: 0
[02:28:16.966] <TB0> INFO: invalid XOR eye diagram: 0
[02:28:16.966] <TB0> INFO: frame (failed synchr.): 0
[02:28:16.966] <TB0> INFO: idle data (no TBM trl): 0
[02:28:16.966] <TB0> INFO: no data (only TBM hdr): 0
[02:28:16.966] <TB0> INFO: TBM errors: 0
[02:28:16.966] <TB0> INFO: flawed TBM headers: 0
[02:28:16.966] <TB0> INFO: flawed TBM trailers: 0
[02:28:16.966] <TB0> INFO: event ID mismatches: 0
[02:28:16.966] <TB0> INFO: ROC errors: 0
[02:28:16.966] <TB0> INFO: missing ROC header(s): 0
[02:28:16.966] <TB0> INFO: misplaced readback start: 0
[02:28:16.966] <TB0> INFO: Pixel decoding errors: 0
[02:28:16.966] <TB0> INFO: pixel data incomplete: 0
[02:28:16.966] <TB0> INFO: pixel address: 0
[02:28:16.966] <TB0> INFO: pulse height fill bit: 0
[02:28:16.966] <TB0> INFO: buffer corruption: 0
[02:28:16.974] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C15.dat
[02:28:16.975] <TB0> INFO: ######################################################################
[02:28:16.975] <TB0> INFO: PixTestReadback::doTest()
[02:28:16.975] <TB0> INFO: ######################################################################
[02:28:16.975] <TB0> INFO: ----------------------------------------------------------------------
[02:28:16.975] <TB0> INFO: PixTestReadback::CalibrateVd()
[02:28:16.975] <TB0> INFO: ----------------------------------------------------------------------
[02:28:26.432] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C0.dat
[02:28:26.432] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C1.dat
[02:28:26.432] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C2.dat
[02:28:26.432] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C3.dat
[02:28:26.432] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C4.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C5.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C6.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C7.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C8.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C9.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C10.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C11.dat
[02:28:26.433] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C12.dat
[02:28:26.434] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C13.dat
[02:28:26.434] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C14.dat
[02:28:26.434] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C15.dat
[02:28:26.458] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[02:28:26.458] <TB0> INFO: ----------------------------------------------------------------------
[02:28:26.458] <TB0> INFO: PixTestReadback::CalibrateVa()
[02:28:26.458] <TB0> INFO: ----------------------------------------------------------------------
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C0.dat
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C1.dat
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C2.dat
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C3.dat
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C4.dat
[02:28:35.918] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C5.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C6.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C7.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C8.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C9.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C10.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C11.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C12.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C13.dat
[02:28:35.919] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C14.dat
[02:28:35.920] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C15.dat
[02:28:35.948] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[02:28:35.948] <TB0> INFO: ----------------------------------------------------------------------
[02:28:35.948] <TB0> INFO: PixTestReadback::readbackVbg()
[02:28:35.948] <TB0> INFO: ----------------------------------------------------------------------
[02:28:43.235] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[02:28:43.235] <TB0> INFO: ----------------------------------------------------------------------
[02:28:43.235] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[02:28:43.235] <TB0> INFO: ----------------------------------------------------------------------
[02:28:43.235] <TB0> INFO: Vbg will be calibrated using Vd calibration
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 159.5calibrated Vbg = 1.19961 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 152.6calibrated Vbg = 1.20295 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.8calibrated Vbg = 1.21378 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 143calibrated Vbg = 1.22369 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 160.3calibrated Vbg = 1.22295 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 161.3calibrated Vbg = 1.22734 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 142.9calibrated Vbg = 1.22428 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 158calibrated Vbg = 1.22864 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 152calibrated Vbg = 1.22727 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 157.4calibrated Vbg = 1.22766 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 162.3calibrated Vbg = 1.22427 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.8calibrated Vbg = 1.22093 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 150.8calibrated Vbg = 1.21712 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 156.2calibrated Vbg = 1.21895 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 157.5calibrated Vbg = 1.21281 :::*/*/*/*/
[02:28:43.235] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 159.2calibrated Vbg = 1.22757 :::*/*/*/*/
[02:28:43.237] <TB0> INFO: ----------------------------------------------------------------------
[02:28:43.237] <TB0> INFO: PixTestReadback::CalibrateIa()
[02:28:43.237] <TB0> INFO: ----------------------------------------------------------------------
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C0.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C1.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C2.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C3.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C4.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C5.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C6.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C7.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C8.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C9.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C10.dat
[02:31:18.692] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C11.dat
[02:31:18.693] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C12.dat
[02:31:18.693] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C13.dat
[02:31:18.693] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C14.dat
[02:31:18.693] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2237_FullQualification_2016-05-12_23h28m_1463088531//002_FulltestPxar_m20//readbackCal_C15.dat
[02:31:18.720] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[02:31:18.722] <TB0> INFO: PixTestReadback::doTest() done
[02:31:18.722] <TB0> INFO: Decoding statistics:
[02:31:18.722] <TB0> INFO: General information:
[02:31:18.722] <TB0> INFO: 16bit words read: 1024
[02:31:18.722] <TB0> INFO: valid events total: 128
[02:31:18.722] <TB0> INFO: empty events: 128
[02:31:18.722] <TB0> INFO: valid events with pixels: 0
[02:31:18.722] <TB0> INFO: valid pixel hits: 0
[02:31:18.722] <TB0> INFO: Event errors: 0
[02:31:18.722] <TB0> INFO: start marker: 0
[02:31:18.722] <TB0> INFO: stop marker: 0
[02:31:18.722] <TB0> INFO: overflow: 0
[02:31:18.722] <TB0> INFO: invalid 5bit words: 0
[02:31:18.722] <TB0> INFO: invalid XOR eye diagram: 0
[02:31:18.722] <TB0> INFO: frame (failed synchr.): 0
[02:31:18.722] <TB0> INFO: idle data (no TBM trl): 0
[02:31:18.722] <TB0> INFO: no data (only TBM hdr): 0
[02:31:18.722] <TB0> INFO: TBM errors: 0
[02:31:18.722] <TB0> INFO: flawed TBM headers: 0
[02:31:18.722] <TB0> INFO: flawed TBM trailers: 0
[02:31:18.722] <TB0> INFO: event ID mismatches: 0
[02:31:18.722] <TB0> INFO: ROC errors: 0
[02:31:18.722] <TB0> INFO: missing ROC header(s): 0
[02:31:18.722] <TB0> INFO: misplaced readback start: 0
[02:31:18.722] <TB0> INFO: Pixel decoding errors: 0
[02:31:18.722] <TB0> INFO: pixel data incomplete: 0
[02:31:18.722] <TB0> INFO: pixel address: 0
[02:31:18.722] <TB0> INFO: pulse height fill bit: 0
[02:31:18.722] <TB0> INFO: buffer corruption: 0
[02:31:18.743] <TB0> INFO: Decoding statistics:
[02:31:18.743] <TB0> INFO: General information:
[02:31:18.743] <TB0> INFO: 16bit words read: 2755340
[02:31:18.743] <TB0> INFO: valid events total: 176768
[02:31:18.743] <TB0> INFO: empty events: 7869
[02:31:18.743] <TB0> INFO: valid events with pixels: 168899
[02:31:18.743] <TB0> INFO: valid pixel hits: 668065
[02:31:18.743] <TB0> INFO: Event errors: 0
[02:31:18.743] <TB0> INFO: start marker: 0
[02:31:18.743] <TB0> INFO: stop marker: 0
[02:31:18.743] <TB0> INFO: overflow: 0
[02:31:18.743] <TB0> INFO: invalid 5bit words: 0
[02:31:18.743] <TB0> INFO: invalid XOR eye diagram: 0
[02:31:18.743] <TB0> INFO: frame (failed synchr.): 0
[02:31:18.743] <TB0> INFO: idle data (no TBM trl): 0
[02:31:18.743] <TB0> INFO: no data (only TBM hdr): 0
[02:31:18.743] <TB0> INFO: TBM errors: 0
[02:31:18.743] <TB0> INFO: flawed TBM headers: 0
[02:31:18.743] <TB0> INFO: flawed TBM trailers: 0
[02:31:18.743] <TB0> INFO: event ID mismatches: 0
[02:31:18.743] <TB0> INFO: ROC errors: 0
[02:31:18.743] <TB0> INFO: missing ROC header(s): 0
[02:31:18.743] <TB0> INFO: misplaced readback start: 0
[02:31:18.743] <TB0> INFO: Pixel decoding errors: 0
[02:31:18.743] <TB0> INFO: pixel data incomplete: 0
[02:31:18.743] <TB0> INFO: pixel address: 0
[02:31:18.743] <TB0> INFO: pulse height fill bit: 0
[02:31:18.743] <TB0> INFO: buffer corruption: 0
[02:31:18.743] <TB0> INFO: enter test to run
[02:31:18.743] <TB0> INFO: test: exit no parameter change
[02:31:18.877] <TB0> QUIET: Connection to board 73 closed.
[02:31:18.957] <TB0> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master