[07:16:59.057] <TB1> INFO: *** Welcome to pxar ***
[07:16:59.057] <TB1> INFO: *** Today: 2016/04/13
[07:16:59.143] <TB1> INFO: *** Version: 9751-dirty
[07:16:59.143] <TB1> INFO: readRocDacs: /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C15.dat
[07:16:59.145] <TB1> INFO: readTbmDacs: /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//tbmParameters_C0b.dat
[07:16:59.145] <TB1> INFO: readMaskFile: /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//defaultMaskFile.dat
[07:16:59.145] <TB1> INFO: readTrimFile: /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters_C15.dat
[07:16:59.220] <TB1> INFO: clk: 4
[07:16:59.220] <TB1> INFO: ctr: 4
[07:16:59.220] <TB1> INFO: sda: 19
[07:16:59.220] <TB1> INFO: tin: 9
[07:16:59.220] <TB1> INFO: level: 15
[07:16:59.220] <TB1> INFO: triggerdelay: 0
[07:16:59.220] <TB1> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[07:16:59.220] <TB1> INFO: Log level: INFO
[07:16:59.227] <TB1> INFO: Found DTB DTB_WXBYFL
[07:16:59.237] <TB1> QUIET: Connection to board DTB_WXBYFL opened.
[07:16:59.239] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 153
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXBYFL
MAC address: 40D855118099
Hostname: pixelDTB153
Comment:
------------------------------------------------------
[07:16:59.241] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[07:17:00.775] <TB1> INFO: DUT info:
[07:17:00.775] <TB1> INFO: The DUT currently contains the following objects:
[07:17:00.775] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:17:00.775] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:17:00.775] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:17:00.775] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:17:00.775] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.775] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.776] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:00.776] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:17:01.176] <TB1> INFO: enter 'restricted' command line mode
[07:17:01.176] <TB1> INFO: enter test to run
[07:17:01.177] <TB1> INFO: test: pretest no parameter change
[07:17:01.177] <TB1> INFO: running: pretest
[07:17:01.183] <TB1> INFO: ----------------------------------------------------------------------
[07:17:01.183] <TB1> INFO: PixTestPretest::programROC()
[07:17:01.183] <TB1> INFO: ----------------------------------------------------------------------
[07:17:19.199] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[07:17:19.199] <TB1> INFO: IA differences per ROC: 19.3 17.7 19.3 19.3 17.7 19.3 20.9 20.9 20.1 19.3 16.9 20.1 19.3 19.3 18.5 17.7
[07:17:19.291] <TB1> INFO: enter test to run
[07:17:19.291] <TB1> INFO: test: pretest no parameter change
[07:17:19.291] <TB1> INFO: running: pretest
[07:17:19.292] <TB1> INFO: ----------------------------------------------------------------------
[07:17:19.292] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[07:17:19.292] <TB1> INFO: ----------------------------------------------------------------------
[07:17:25.382] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 381 mA = 23.8125 mA/ROC
[07:17:25.382] <TB1> INFO: i(loss) [mA/ROC]: 19.2 19.2 19.2 19.2 19.2 19.2 19.2 18.4 19.2 18.4 19.2 19.2 19.2 18.4 19.2 18.4
[07:17:25.411] <TB1> INFO: enter test to run
[07:17:25.411] <TB1> INFO: test: pretest no parameter change
[07:17:25.411] <TB1> INFO: running: pretest
[07:17:25.411] <TB1> INFO: ----------------------------------------------------------------------
[07:17:25.411] <TB1> INFO: PixTestPretest::findTiming()
[07:17:25.411] <TB1> INFO: ----------------------------------------------------------------------
[07:17:25.411] <TB1> INFO: PixTestCmd::init()
[07:17:26.384] <TB1> WARNING: Not unmasking DUT, not setting Calibrate bits!
[07:18:55.640] <TB1> INFO: TBM phases: 160MHz: 4, 400MHz: 6, TBM delays: ROC(0/1):3, header/trailer: 1, token: 0
[07:18:55.640] <TB1> INFO: (success/tries = 100/100), width = 4
[07:18:55.641] <TB1> INFO: enter test to run
[07:18:55.641] <TB1> INFO: test: pretest no parameter change
[07:18:55.641] <TB1> INFO: running: pretest
[07:18:55.643] <TB1> INFO: ----------------------------------------------------------------------
[07:18:55.643] <TB1> INFO: PixTestPretest::findWorkingPixel()
[07:18:55.643] <TB1> INFO: ----------------------------------------------------------------------
[07:18:55.732] <TB1> INFO: Expecting 231680 events.
[07:19:01.509] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[07:19:01.590] <TB1> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[07:19:05.820] <TB1> INFO: 231680 events read in total (9531ms).
[07:19:05.824] <TB1> INFO: Test took 10179ms.
[07:19:06.052] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[07:19:06.113] <TB1> INFO: enter test to run
[07:19:06.113] <TB1> INFO: test: pretest no parameter change
[07:19:06.113] <TB1> INFO: running: pretest
[07:19:06.114] <TB1> INFO: ----------------------------------------------------------------------
[07:19:06.114] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[07:19:06.114] <TB1> INFO: ----------------------------------------------------------------------
[07:19:06.206] <TB1> INFO: Expecting 231680 events.
[07:19:16.420] <TB1> INFO: 231680 events read in total (9658ms).
[07:19:16.424] <TB1> INFO: Test took 10306ms.
[07:19:16.658] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[07:19:16.658] <TB1> INFO: CalDel: 119 133 120 140 133 134 156 144 133 139 155 132 142 108 148 153
[07:19:16.658] <TB1> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[07:19:16.690] <TB1> INFO: enter test to run
[07:19:16.690] <TB1> INFO: test: pretest no parameter change
[07:19:16.690] <TB1> INFO: running: pretest
[07:19:16.691] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C0.dat
[07:19:16.691] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C1.dat
[07:19:16.691] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C2.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C3.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C4.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C5.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C6.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C7.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C8.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C9.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C10.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C11.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C12.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C13.dat
[07:19:16.692] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C14.dat
[07:19:16.693] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters_C15.dat
[07:19:16.693] <TB1> INFO: enter test to run
[07:19:16.693] <TB1> INFO: test: fulltest no parameter change
[07:19:16.693] <TB1> INFO: running: fulltest
[07:19:16.693] <TB1> INFO: ######################################################################
[07:19:16.693] <TB1> INFO: PixTestFullTest::doTest()
[07:19:16.693] <TB1> INFO: ######################################################################
[07:19:16.694] <TB1> INFO: ######################################################################
[07:19:16.694] <TB1> INFO: PixTestAlive::doTest()
[07:19:16.694] <TB1> INFO: ######################################################################
[07:19:16.695] <TB1> INFO: ----------------------------------------------------------------------
[07:19:16.695] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:19:16.695] <TB1> INFO: ----------------------------------------------------------------------
[07:19:16.955] <TB1> INFO: Expecting 41600 events.
[07:19:20.762] <TB1> INFO: 41600 events read in total (3250ms).
[07:19:20.763] <TB1> INFO: Test took 4067ms.
[07:19:20.993] <TB1> INFO: PixTestAlive::aliveTest() done
[07:19:20.993] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:19:20.995] <TB1> INFO: ----------------------------------------------------------------------
[07:19:20.995] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:19:20.995] <TB1> INFO: ----------------------------------------------------------------------
[07:19:21.276] <TB1> INFO: Expecting 41600 events.
[07:19:24.283] <TB1> INFO: 41600 events read in total (2450ms).
[07:19:24.283] <TB1> INFO: Test took 3287ms.
[07:19:24.284] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[07:19:24.530] <TB1> INFO: PixTestAlive::maskTest() done
[07:19:24.530] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:19:24.531] <TB1> INFO: ----------------------------------------------------------------------
[07:19:24.531] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:19:24.531] <TB1> INFO: ----------------------------------------------------------------------
[07:19:24.813] <TB1> INFO: Expecting 41600 events.
[07:19:28.545] <TB1> INFO: 41600 events read in total (3176ms).
[07:19:28.545] <TB1> INFO: Test took 4012ms.
[07:19:28.772] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[07:19:28.772] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:19:28.772] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[07:19:28.772] <TB1> INFO: Decoding statistics:
[07:19:28.772] <TB1> INFO: General information:
[07:19:28.772] <TB1> INFO: 16bit words read: 0
[07:19:28.772] <TB1> INFO: valid events total: 0
[07:19:28.772] <TB1> INFO: empty events: 0
[07:19:28.772] <TB1> INFO: valid events with pixels: 0
[07:19:28.772] <TB1> INFO: valid pixel hits: 0
[07:19:28.772] <TB1> INFO: Event errors: 0
[07:19:28.772] <TB1> INFO: start marker: 0
[07:19:28.772] <TB1> INFO: stop marker: 0
[07:19:28.772] <TB1> INFO: overflow: 0
[07:19:28.772] <TB1> INFO: invalid 5bit words: 0
[07:19:28.772] <TB1> INFO: invalid XOR eye diagram: 0
[07:19:28.772] <TB1> INFO: frame (failed synchr.): 0
[07:19:28.772] <TB1> INFO: idle data (no TBM trl): 0
[07:19:28.773] <TB1> INFO: no data (only TBM hdr): 0
[07:19:28.773] <TB1> INFO: TBM errors: 0
[07:19:28.773] <TB1> INFO: flawed TBM headers: 0
[07:19:28.773] <TB1> INFO: flawed TBM trailers: 0
[07:19:28.773] <TB1> INFO: event ID mismatches: 0
[07:19:28.773] <TB1> INFO: ROC errors: 0
[07:19:28.773] <TB1> INFO: missing ROC header(s): 0
[07:19:28.773] <TB1> INFO: misplaced readback start: 0
[07:19:28.773] <TB1> INFO: Pixel decoding errors: 0
[07:19:28.773] <TB1> INFO: pixel data incomplete: 0
[07:19:28.773] <TB1> INFO: pixel address: 0
[07:19:28.773] <TB1> INFO: pulse height fill bit: 0
[07:19:28.773] <TB1> INFO: buffer corruption: 0
[07:19:28.780] <TB1> INFO: ######################################################################
[07:19:28.780] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[07:19:28.780] <TB1> INFO: ######################################################################
[07:19:28.782] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[07:19:28.793] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[07:19:28.793] <TB1> INFO: run 1 of 1
[07:19:29.061] <TB1> INFO: Expecting 3120000 events.
[07:20:09.915] <TB1> INFO: 856185 events read in total (40297ms).
[07:20:52.039] <TB1> INFO: 1704030 events read in total (82421ms).
[07:21:33.605] <TB1> INFO: 2565580 events read in total (123987ms).
[07:21:59.239] <TB1> INFO: 3120000 events read in total (149621ms).
[07:21:59.280] <TB1> INFO: Test took 150487ms.
[07:22:22.123] <TB1> INFO: PixTestBBMap::doTest() done, duration: 173 seconds
[07:22:22.123] <TB1> INFO: number of dead bumps (per ROC): 2 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
[07:22:22.123] <TB1> INFO: separation cut (per ROC): 96 83 81 83 75 88 69 84 79 79 79 80 84 84 88 83
[07:22:22.123] <TB1> INFO: Decoding statistics:
[07:22:22.123] <TB1> INFO: General information:
[07:22:22.123] <TB1> INFO: 16bit words read: 0
[07:22:22.123] <TB1> INFO: valid events total: 0
[07:22:22.123] <TB1> INFO: empty events: 0
[07:22:22.123] <TB1> INFO: valid events with pixels: 0
[07:22:22.123] <TB1> INFO: valid pixel hits: 0
[07:22:22.123] <TB1> INFO: Event errors: 0
[07:22:22.123] <TB1> INFO: start marker: 0
[07:22:22.123] <TB1> INFO: stop marker: 0
[07:22:22.123] <TB1> INFO: overflow: 0
[07:22:22.123] <TB1> INFO: invalid 5bit words: 0
[07:22:22.123] <TB1> INFO: invalid XOR eye diagram: 0
[07:22:22.123] <TB1> INFO: frame (failed synchr.): 0
[07:22:22.123] <TB1> INFO: idle data (no TBM trl): 0
[07:22:22.123] <TB1> INFO: no data (only TBM hdr): 0
[07:22:22.123] <TB1> INFO: TBM errors: 0
[07:22:22.123] <TB1> INFO: flawed TBM headers: 0
[07:22:22.123] <TB1> INFO: flawed TBM trailers: 0
[07:22:22.123] <TB1> INFO: event ID mismatches: 0
[07:22:22.123] <TB1> INFO: ROC errors: 0
[07:22:22.123] <TB1> INFO: missing ROC header(s): 0
[07:22:22.123] <TB1> INFO: misplaced readback start: 0
[07:22:22.123] <TB1> INFO: Pixel decoding errors: 0
[07:22:22.123] <TB1> INFO: pixel data incomplete: 0
[07:22:22.123] <TB1> INFO: pixel address: 0
[07:22:22.123] <TB1> INFO: pulse height fill bit: 0
[07:22:22.123] <TB1> INFO: buffer corruption: 0
[07:22:22.204] <TB1> INFO: ######################################################################
[07:22:22.204] <TB1> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[07:22:22.204] <TB1> INFO: ######################################################################
[07:22:22.204] <TB1> INFO: ----------------------------------------------------------------------
[07:22:22.204] <TB1> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[07:22:22.204] <TB1> INFO: ----------------------------------------------------------------------
[07:22:22.204] <TB1> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[07:22:22.216] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:22:22.216] <TB1> INFO: run 1 of 1
[07:22:22.485] <TB1> INFO: Expecting 26208000 events.
[07:22:56.438] <TB1> INFO: 879550 events read in total (33397ms).
[07:23:31.012] <TB1> INFO: 1746600 events read in total (67971ms).
[07:24:03.195] <TB1> INFO: 2611900 events read in total (100154ms).
[07:24:35.780] <TB1> INFO: 3475500 events read in total (132739ms).
[07:25:09.377] <TB1> INFO: 4338900 events read in total (166336ms).
[07:25:43.542] <TB1> INFO: 5201300 events read in total (200501ms).
[07:26:17.791] <TB1> INFO: 6064300 events read in total (234750ms).
[07:26:51.550] <TB1> INFO: 6923000 events read in total (268509ms).
[07:27:25.623] <TB1> INFO: 7785150 events read in total (302582ms).
[07:27:59.926] <TB1> INFO: 8646750 events read in total (336885ms).
[07:28:33.944] <TB1> INFO: 9506950 events read in total (370903ms).
[07:29:06.965] <TB1> INFO: 10368250 events read in total (403924ms).
[07:29:39.813] <TB1> INFO: 11229900 events read in total (436772ms).
[07:30:12.791] <TB1> INFO: 12089450 events read in total (469750ms).
[07:30:45.826] <TB1> INFO: 12947150 events read in total (502785ms).
[07:31:17.772] <TB1> INFO: 13800350 events read in total (534731ms).
[07:31:49.900] <TB1> INFO: 14651250 events read in total (566859ms).
[07:32:22.373] <TB1> INFO: 15501150 events read in total (599332ms).
[07:32:55.277] <TB1> INFO: 16348150 events read in total (632236ms).
[07:33:27.887] <TB1> INFO: 17196400 events read in total (664846ms).
[07:34:01.187] <TB1> INFO: 18042150 events read in total (698146ms).
[07:34:35.830] <TB1> INFO: 18890900 events read in total (732789ms).
[07:35:09.727] <TB1> INFO: 19736250 events read in total (766686ms).
[07:35:42.588] <TB1> INFO: 20581000 events read in total (799547ms).
[07:36:15.512] <TB1> INFO: 21428700 events read in total (832471ms).
[07:36:47.309] <TB1> INFO: 22275100 events read in total (864268ms).
[07:37:19.566] <TB1> INFO: 23120250 events read in total (896525ms).
[07:37:54.926] <TB1> INFO: 23968700 events read in total (931885ms).
[07:38:28.083] <TB1> INFO: 24817550 events read in total (965042ms).
[07:39:00.100] <TB1> INFO: 25664350 events read in total (997059ms).
[07:39:20.430] <TB1> INFO: 26208000 events read in total (1017389ms).
[07:39:20.459] <TB1> INFO: Test took 1018242ms.
[07:39:20.706] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:22.418] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:23.812] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:25.180] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:26.551] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:27.960] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:29.329] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:30.746] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:32.097] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:33.465] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:34.856] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:36.226] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:37.605] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:38.966] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:40.353] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:41.722] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[07:39:43.144] <TB1> INFO: PixTestScurves::scurves() done
[07:39:43.144] <TB1> INFO: Vcal mean: 92.36 88.86 84.50 86.96 81.76 86.33 75.36 89.98 84.47 80.94 84.19 79.39 85.57 79.98 82.73 80.85
[07:39:43.144] <TB1> INFO: Vcal RMS: 5.86 5.62 5.14 4.95 4.28 5.07 4.35 5.20 4.82 4.14 5.11 4.63 5.09 5.02 4.77 4.55
[07:39:43.145] <TB1> INFO: PixTestScurves::fullTest() done, duration: 1040 seconds
[07:39:43.145] <TB1> INFO: Decoding statistics:
[07:39:43.145] <TB1> INFO: General information:
[07:39:43.145] <TB1> INFO: 16bit words read: 0
[07:39:43.145] <TB1> INFO: valid events total: 0
[07:39:43.145] <TB1> INFO: empty events: 0
[07:39:43.145] <TB1> INFO: valid events with pixels: 0
[07:39:43.145] <TB1> INFO: valid pixel hits: 0
[07:39:43.145] <TB1> INFO: Event errors: 0
[07:39:43.145] <TB1> INFO: start marker: 0
[07:39:43.145] <TB1> INFO: stop marker: 0
[07:39:43.145] <TB1> INFO: overflow: 0
[07:39:43.145] <TB1> INFO: invalid 5bit words: 0
[07:39:43.145] <TB1> INFO: invalid XOR eye diagram: 0
[07:39:43.145] <TB1> INFO: frame (failed synchr.): 0
[07:39:43.145] <TB1> INFO: idle data (no TBM trl): 0
[07:39:43.145] <TB1> INFO: no data (only TBM hdr): 0
[07:39:43.145] <TB1> INFO: TBM errors: 0
[07:39:43.145] <TB1> INFO: flawed TBM headers: 0
[07:39:43.145] <TB1> INFO: flawed TBM trailers: 0
[07:39:43.145] <TB1> INFO: event ID mismatches: 0
[07:39:43.145] <TB1> INFO: ROC errors: 0
[07:39:43.145] <TB1> INFO: missing ROC header(s): 0
[07:39:43.145] <TB1> INFO: misplaced readback start: 0
[07:39:43.145] <TB1> INFO: Pixel decoding errors: 0
[07:39:43.145] <TB1> INFO: pixel data incomplete: 0
[07:39:43.145] <TB1> INFO: pixel address: 0
[07:39:43.145] <TB1> INFO: pulse height fill bit: 0
[07:39:43.145] <TB1> INFO: buffer corruption: 0
[07:39:43.247] <TB1> INFO: ######################################################################
[07:39:43.247] <TB1> INFO: PixTestTrim::doTest()
[07:39:43.247] <TB1> INFO: ######################################################################
[07:39:43.248] <TB1> INFO: ----------------------------------------------------------------------
[07:39:43.248] <TB1> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[07:39:43.248] <TB1> INFO: ----------------------------------------------------------------------
[07:39:43.359] <TB1> INFO: ---> VthrComp thr map (minimal VthrComp)
[07:39:43.359] <TB1> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:39:43.370] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[07:39:43.370] <TB1> INFO: run 1 of 1
[07:39:43.635] <TB1> INFO: Expecting 6281600 events.
[07:40:24.636] <TB1> INFO: 1070400 events read in total (40445ms).
[07:41:03.913] <TB1> INFO: 2137370 events read in total (79722ms).
[07:41:43.109] <TB1> INFO: 3200020 events read in total (118918ms).
[07:42:21.641] <TB1> INFO: 4270880 events read in total (157450ms).
[07:43:00.197] <TB1> INFO: 5346370 events read in total (196006ms).
[07:43:35.146] <TB1> INFO: 6281600 events read in total (230955ms).
[07:43:35.174] <TB1> INFO: Test took 231804ms.
[07:43:53.745] <TB1> INFO: ROC 0 VthrComp = 96
[07:43:53.745] <TB1> INFO: ROC 1 VthrComp = 92
[07:43:53.745] <TB1> INFO: ROC 2 VthrComp = 89
[07:43:53.745] <TB1> INFO: ROC 3 VthrComp = 91
[07:43:53.745] <TB1> INFO: ROC 4 VthrComp = 87
[07:43:53.745] <TB1> INFO: ROC 5 VthrComp = 92
[07:43:53.745] <TB1> INFO: ROC 6 VthrComp = 79
[07:43:53.745] <TB1> INFO: ROC 7 VthrComp = 94
[07:43:53.746] <TB1> INFO: ROC 8 VthrComp = 86
[07:43:53.746] <TB1> INFO: ROC 9 VthrComp = 88
[07:43:53.746] <TB1> INFO: ROC 10 VthrComp = 85
[07:43:53.746] <TB1> INFO: ROC 11 VthrComp = 85
[07:43:53.746] <TB1> INFO: ROC 12 VthrComp = 90
[07:43:53.746] <TB1> INFO: ROC 13 VthrComp = 83
[07:43:53.746] <TB1> INFO: ROC 14 VthrComp = 85
[07:43:53.746] <TB1> INFO: ROC 15 VthrComp = 83
[07:43:53.746] <TB1> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[07:43:53.746] <TB1> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:43:53.754] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[07:43:53.754] <TB1> INFO: run 1 of 1
[07:43:54.043] <TB1> INFO: Expecting 6281600 events.
[07:44:30.593] <TB1> INFO: 755390 events read in total (35993ms).
[07:45:05.763] <TB1> INFO: 1509240 events read in total (71163ms).
[07:45:40.816] <TB1> INFO: 2263130 events read in total (106216ms).
[07:46:15.346] <TB1> INFO: 3017380 events read in total (140746ms).
[07:46:50.979] <TB1> INFO: 3766630 events read in total (176379ms).
[07:47:25.226] <TB1> INFO: 4512430 events read in total (210626ms).
[07:48:00.342] <TB1> INFO: 5256800 events read in total (245742ms).
[07:48:35.376] <TB1> INFO: 6001150 events read in total (280776ms).
[07:48:49.523] <TB1> INFO: 6281600 events read in total (294923ms).
[07:48:49.565] <TB1> INFO: Test took 295810ms.
[07:49:12.907] <TB1> INFO: roc 0 with ID = 0 has maximal Vcal 58.183 for pixel 0/36 mean/min/max = 45.0542/31.745/58.3634
[07:49:12.908] <TB1> INFO: roc 1 with ID = 1 has maximal Vcal 59.0679 for pixel 21/78 mean/min/max = 45.556/31.7878/59.3242
[07:49:12.908] <TB1> INFO: roc 2 with ID = 2 has maximal Vcal 59.367 for pixel 12/15 mean/min/max = 45.8698/32.3119/59.4278
[07:49:12.908] <TB1> INFO: roc 3 with ID = 3 has maximal Vcal 57.3948 for pixel 10/67 mean/min/max = 45.0709/32.6333/57.5085
[07:49:12.908] <TB1> INFO: roc 4 with ID = 4 has maximal Vcal 56.6872 for pixel 18/12 mean/min/max = 44.4804/32.2362/56.7246
[07:49:12.908] <TB1> INFO: roc 5 with ID = 5 has maximal Vcal 57.2602 for pixel 30/79 mean/min/max = 44.889/32.3861/57.3919
[07:49:12.909] <TB1> INFO: roc 6 with ID = 6 has maximal Vcal 58.0792 for pixel 51/79 mean/min/max = 46.5376/34.9109/58.1642
[07:49:12.909] <TB1> INFO: roc 7 with ID = 7 has maximal Vcal 58.1063 for pixel 25/1 mean/min/max = 45.0766/31.8432/58.3101
[07:49:12.909] <TB1> INFO: roc 8 with ID = 8 has maximal Vcal 58.2519 for pixel 19/1 mean/min/max = 45.4541/32.6559/58.2524
[07:49:12.909] <TB1> INFO: roc 9 with ID = 9 has maximal Vcal 57.1821 for pixel 1/3 mean/min/max = 45.5828/33.9489/57.2168
[07:49:12.910] <TB1> INFO: roc 10 with ID = 10 has maximal Vcal 59.3192 for pixel 23/58 mean/min/max = 45.8432/32.2396/59.4469
[07:49:12.910] <TB1> INFO: roc 11 with ID = 11 has maximal Vcal 58.4144 for pixel 20/1 mean/min/max = 45.0355/31.5841/58.4869
[07:49:12.910] <TB1> INFO: roc 12 with ID = 12 has maximal Vcal 57.6253 for pixel 51/30 mean/min/max = 45.4938/33.2755/57.712
[07:49:12.910] <TB1> INFO: roc 13 with ID = 13 has maximal Vcal 59.3671 for pixel 0/4 mean/min/max = 45.4643/31.3433/59.5854
[07:49:12.911] <TB1> INFO: roc 14 with ID = 14 has maximal Vcal 58.092 for pixel 11/6 mean/min/max = 45.5464/32.6217/58.4712
[07:49:12.911] <TB1> INFO: roc 15 with ID = 15 has maximal Vcal 58.4639 for pixel 41/1 mean/min/max = 45.2073/31.9499/58.4647
[07:49:12.911] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:49:12.999] <TB1> INFO: Expecting 514560 events.
[07:49:26.121] <TB1> INFO: 514560 events read in total (12565ms).
[07:49:26.126] <TB1> INFO: Expecting 514560 events.
[07:49:39.047] <TB1> INFO: 514560 events read in total (12501ms).
[07:49:39.054] <TB1> INFO: Expecting 514560 events.
[07:49:51.944] <TB1> INFO: 514560 events read in total (12471ms).
[07:49:51.957] <TB1> INFO: Expecting 514560 events.
[07:50:04.799] <TB1> INFO: 514560 events read in total (12430ms).
[07:50:04.812] <TB1> INFO: Expecting 514560 events.
[07:50:17.777] <TB1> INFO: 514560 events read in total (12563ms).
[07:50:17.794] <TB1> INFO: Expecting 514560 events.
[07:50:30.551] <TB1> INFO: 514560 events read in total (12356ms).
[07:50:30.565] <TB1> INFO: Expecting 514560 events.
[07:50:43.339] <TB1> INFO: 514560 events read in total (12359ms).
[07:50:43.356] <TB1> INFO: Expecting 514560 events.
[07:50:55.994] <TB1> INFO: 514560 events read in total (12223ms).
[07:50:56.012] <TB1> INFO: Expecting 514560 events.
[07:51:08.851] <TB1> INFO: 514560 events read in total (12427ms).
[07:51:08.871] <TB1> INFO: Expecting 514560 events.
[07:51:21.593] <TB1> INFO: 514560 events read in total (12313ms).
[07:51:21.615] <TB1> INFO: Expecting 514560 events.
[07:51:34.349] <TB1> INFO: 514560 events read in total (12329ms).
[07:51:34.372] <TB1> INFO: Expecting 514560 events.
[07:51:47.111] <TB1> INFO: 514560 events read in total (12328ms).
[07:51:47.147] <TB1> INFO: Expecting 514560 events.
[07:51:59.823] <TB1> INFO: 514560 events read in total (12274ms).
[07:51:59.850] <TB1> INFO: Expecting 514560 events.
[07:52:12.599] <TB1> INFO: 514560 events read in total (12345ms).
[07:52:12.629] <TB1> INFO: Expecting 514560 events.
[07:52:25.291] <TB1> INFO: 514560 events read in total (12260ms).
[07:52:25.326] <TB1> INFO: Expecting 514560 events.
[07:52:38.126] <TB1> INFO: 514560 events read in total (12398ms).
[07:52:38.171] <TB1> INFO: Test took 205260ms.
[07:52:39.288] <TB1> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[07:52:39.296] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[07:52:39.296] <TB1> INFO: run 1 of 1
[07:52:39.556] <TB1> INFO: Expecting 6281600 events.
[07:53:15.254] <TB1> INFO: 742580 events read in total (35142ms).
[07:53:52.004] <TB1> INFO: 1484000 events read in total (71892ms).
[07:54:27.720] <TB1> INFO: 2225540 events read in total (107608ms).
[07:55:02.813] <TB1> INFO: 2967430 events read in total (142701ms).
[07:55:38.761] <TB1> INFO: 3703770 events read in total (178649ms).
[07:56:14.330] <TB1> INFO: 4435890 events read in total (214218ms).
[07:56:48.964] <TB1> INFO: 5166100 events read in total (248852ms).
[07:57:24.256] <TB1> INFO: 5895810 events read in total (284144ms).
[07:57:43.655] <TB1> INFO: 6281600 events read in total (303543ms).
[07:57:43.699] <TB1> INFO: Test took 304403ms.
[07:58:07.448] <TB1> INFO: ---> TrimStepCorr4 extremal thresholds: 0.078282 .. 255.000000
[07:58:07.522] <TB1> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[07:58:07.530] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[07:58:07.530] <TB1> INFO: run 1 of 1
[07:58:07.789] <TB1> INFO: Expecting 10649600 events.
[07:58:42.667] <TB1> INFO: 712300 events read in total (34322ms).
[07:59:17.305] <TB1> INFO: 1424910 events read in total (68960ms).
[07:59:52.046] <TB1> INFO: 2137530 events read in total (103701ms).
[08:00:26.646] <TB1> INFO: 2850270 events read in total (138301ms).
[08:01:01.140] <TB1> INFO: 3562710 events read in total (172795ms).
[08:01:35.333] <TB1> INFO: 4275350 events read in total (206988ms).
[08:02:10.065] <TB1> INFO: 4987970 events read in total (241720ms).
[08:02:44.894] <TB1> INFO: 5700530 events read in total (276549ms).
[08:03:18.708] <TB1> INFO: 6412770 events read in total (310363ms).
[08:03:52.228] <TB1> INFO: 7124120 events read in total (343883ms).
[08:04:25.765] <TB1> INFO: 7835500 events read in total (377420ms).
[08:05:00.032] <TB1> INFO: 8546450 events read in total (411687ms).
[08:05:35.491] <TB1> INFO: 9257500 events read in total (447146ms).
[08:06:11.032] <TB1> INFO: 9968070 events read in total (482687ms).
[08:06:43.568] <TB1> INFO: 10649600 events read in total (515223ms).
[08:06:43.654] <TB1> INFO: Test took 516125ms.
[08:07:10.717] <TB1> INFO: ---> TrimStepCorr2 extremal thresholds: 15.943966 .. 46.619801
[08:07:10.792] <TB1> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 56 (-1/-1) hits flags = 528 (plus default)
[08:07:10.800] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[08:07:10.800] <TB1> INFO: run 1 of 1
[08:07:11.060] <TB1> INFO: Expecting 2163200 events.
[08:07:49.825] <TB1> INFO: 930450 events read in total (38207ms).
[08:08:27.014] <TB1> INFO: 1858860 events read in total (75396ms).
[08:08:40.175] <TB1> INFO: 2163200 events read in total (88557ms).
[08:08:40.191] <TB1> INFO: Test took 89392ms.
[08:08:53.832] <TB1> INFO: ---> TrimStepCorr1a extremal thresholds: 20.913500 .. 44.110921
[08:08:53.906] <TB1> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 10 .. 54 (-1/-1) hits flags = 528 (plus default)
[08:08:53.914] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[08:08:53.914] <TB1> INFO: run 1 of 1
[08:08:54.190] <TB1> INFO: Expecting 1872000 events.
[08:09:32.274] <TB1> INFO: 919090 events read in total (37528ms).
[08:10:10.584] <TB1> INFO: 1836650 events read in total (75838ms).
[08:10:12.405] <TB1> INFO: 1872000 events read in total (77659ms).
[08:10:12.420] <TB1> INFO: Test took 78505ms.
[08:10:25.007] <TB1> INFO: ---> TrimStepCorr1b extremal thresholds: 23.104986 .. 44.110921
[08:10:25.082] <TB1> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 13 .. 54 (-1/-1) hits flags = 528 (plus default)
[08:10:25.090] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[08:10:25.090] <TB1> INFO: run 1 of 1
[08:10:25.349] <TB1> INFO: Expecting 1747200 events.
[08:11:04.158] <TB1> INFO: 899210 events read in total (38253ms).
[08:11:39.081] <TB1> INFO: 1747200 events read in total (73176ms).
[08:11:39.091] <TB1> INFO: Test took 74001ms.
[08:11:52.101] <TB1> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[08:11:52.101] <TB1> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[08:11:52.109] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[08:11:52.109] <TB1> INFO: run 1 of 1
[08:11:52.365] <TB1> INFO: Expecting 1705600 events.
[08:12:30.211] <TB1> INFO: 879030 events read in total (37289ms).
[08:13:06.205] <TB1> INFO: 1705600 events read in total (73283ms).
[08:13:06.215] <TB1> INFO: Test took 74106ms.
[08:13:19.318] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C0.dat
[08:13:19.319] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C1.dat
[08:13:19.319] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C2.dat
[08:13:19.319] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C3.dat
[08:13:19.319] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C4.dat
[08:13:19.319] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C5.dat
[08:13:19.320] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C6.dat
[08:13:19.320] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C7.dat
[08:13:19.320] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C8.dat
[08:13:19.320] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C9.dat
[08:13:19.320] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C10.dat
[08:13:19.321] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C11.dat
[08:13:19.321] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C12.dat
[08:13:19.321] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C13.dat
[08:13:19.321] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C14.dat
[08:13:19.321] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C15.dat
[08:13:19.321] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C0.dat
[08:13:19.329] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C1.dat
[08:13:19.335] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C2.dat
[08:13:19.341] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C3.dat
[08:13:19.347] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C4.dat
[08:13:19.353] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C5.dat
[08:13:19.359] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C6.dat
[08:13:19.365] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C7.dat
[08:13:19.376] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C8.dat
[08:13:19.383] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C9.dat
[08:13:19.390] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C10.dat
[08:13:19.401] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C11.dat
[08:13:19.414] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C12.dat
[08:13:19.426] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C13.dat
[08:13:19.437] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C14.dat
[08:13:19.448] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//trimParameters35_C15.dat
[08:13:19.460] <TB1> INFO: PixTestTrim::trimTest() done
[08:13:19.460] <TB1> INFO: vtrim: 101 107 104 101 93 87 84 86 102 89 85 95 85 98 91 87
[08:13:19.460] <TB1> INFO: vthrcomp: 96 92 89 91 87 92 79 94 86 88 85 85 90 83 85 83
[08:13:19.460] <TB1> INFO: vcal mean: 35.06 34.97 34.95 34.99 34.96 34.96 35.01 34.96 34.99 34.99 34.98 34.97 35.00 34.99 34.98 34.95
[08:13:19.460] <TB1> INFO: vcal RMS: 0.87 1.08 0.86 0.83 0.85 0.83 0.78 0.87 0.86 0.79 0.88 0.81 0.82 0.89 0.84 0.99
[08:13:19.460] <TB1> INFO: bits mean: 9.49 9.52 9.08 9.48 10.11 9.14 8.17 9.67 9.66 9.12 9.75 9.48 8.80 9.35 9.47 9.55
[08:13:19.460] <TB1> INFO: bits RMS: 2.83 2.73 2.80 2.65 2.43 2.82 2.78 2.67 2.57 2.62 2.55 2.83 2.88 2.79 2.63 2.73
[08:13:19.467] <TB1> INFO: ----------------------------------------------------------------------
[08:13:19.467] <TB1> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[08:13:19.467] <TB1> INFO: ----------------------------------------------------------------------
[08:13:19.470] <TB1> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[08:13:19.481] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:13:19.481] <TB1> INFO: run 1 of 1
[08:13:19.787] <TB1> INFO: Expecting 4160000 events.
[08:14:03.733] <TB1> INFO: 914770 events read in total (43389ms).
[08:14:46.817] <TB1> INFO: 1823990 events read in total (86473ms).
[08:15:28.599] <TB1> INFO: 2725925 events read in total (128255ms).
[08:16:09.527] <TB1> INFO: 3624285 events read in total (169183ms).
[08:16:34.057] <TB1> INFO: 4160000 events read in total (193713ms).
[08:16:34.109] <TB1> INFO: Test took 194629ms.
[08:17:01.113] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 159 (-1/-1) hits flags = 528 (plus default)
[08:17:01.121] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:17:01.121] <TB1> INFO: run 1 of 1
[08:17:01.377] <TB1> INFO: Expecting 3328000 events.
[08:17:45.521] <TB1> INFO: 964410 events read in total (43588ms).
[08:18:28.355] <TB1> INFO: 1918605 events read in total (86422ms).
[08:19:10.881] <TB1> INFO: 2861315 events read in total (128948ms).
[08:19:31.684] <TB1> INFO: 3328000 events read in total (149751ms).
[08:19:31.713] <TB1> INFO: Test took 150592ms.
[08:19:55.524] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:19:55.532] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:19:55.532] <TB1> INFO: run 1 of 1
[08:19:55.791] <TB1> INFO: Expecting 3140800 events.
[08:20:39.847] <TB1> INFO: 989805 events read in total (43499ms).
[08:21:21.634] <TB1> INFO: 1966635 events read in total (85286ms).
[08:22:04.119] <TB1> INFO: 2933230 events read in total (127771ms).
[08:22:13.899] <TB1> INFO: 3140800 events read in total (137551ms).
[08:22:13.924] <TB1> INFO: Test took 138392ms.
[08:22:36.973] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 151 (-1/-1) hits flags = 528 (plus default)
[08:22:36.981] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:22:36.981] <TB1> INFO: run 1 of 1
[08:22:37.237] <TB1> INFO: Expecting 3161600 events.
[08:23:22.479] <TB1> INFO: 985885 events read in total (44685ms).
[08:24:04.924] <TB1> INFO: 1959140 events read in total (87130ms).
[08:24:47.441] <TB1> INFO: 2921910 events read in total (129648ms).
[08:24:58.020] <TB1> INFO: 3161600 events read in total (140226ms).
[08:24:58.047] <TB1> INFO: Test took 141065ms.
[08:25:23.133] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:25:23.141] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:25:23.141] <TB1> INFO: run 1 of 1
[08:25:23.432] <TB1> INFO: Expecting 3140800 events.
[08:26:06.771] <TB1> INFO: 988010 events read in total (42783ms).
[08:26:50.206] <TB1> INFO: 1962765 events read in total (86219ms).
[08:27:32.953] <TB1> INFO: 2927490 events read in total (128965ms).
[08:27:43.086] <TB1> INFO: 3140800 events read in total (139098ms).
[08:27:43.113] <TB1> INFO: Test took 139972ms.
[08:28:05.870] <TB1> INFO: PixTestTrim::trimBitTest() done
[08:28:05.871] <TB1> INFO: PixTestTrim::doTest() done, duration: 2902 seconds
[08:28:05.871] <TB1> INFO: Decoding statistics:
[08:28:05.871] <TB1> INFO: General information:
[08:28:05.871] <TB1> INFO: 16bit words read: 0
[08:28:05.871] <TB1> INFO: valid events total: 0
[08:28:05.871] <TB1> INFO: empty events: 0
[08:28:05.871] <TB1> INFO: valid events with pixels: 0
[08:28:05.871] <TB1> INFO: valid pixel hits: 0
[08:28:05.871] <TB1> INFO: Event errors: 0
[08:28:05.871] <TB1> INFO: start marker: 0
[08:28:05.871] <TB1> INFO: stop marker: 0
[08:28:05.871] <TB1> INFO: overflow: 0
[08:28:05.871] <TB1> INFO: invalid 5bit words: 0
[08:28:05.871] <TB1> INFO: invalid XOR eye diagram: 0
[08:28:05.871] <TB1> INFO: frame (failed synchr.): 0
[08:28:05.871] <TB1> INFO: idle data (no TBM trl): 0
[08:28:05.871] <TB1> INFO: no data (only TBM hdr): 0
[08:28:05.871] <TB1> INFO: TBM errors: 0
[08:28:05.871] <TB1> INFO: flawed TBM headers: 0
[08:28:05.871] <TB1> INFO: flawed TBM trailers: 0
[08:28:05.871] <TB1> INFO: event ID mismatches: 0
[08:28:05.871] <TB1> INFO: ROC errors: 0
[08:28:05.871] <TB1> INFO: missing ROC header(s): 0
[08:28:05.871] <TB1> INFO: misplaced readback start: 0
[08:28:05.871] <TB1> INFO: Pixel decoding errors: 0
[08:28:05.871] <TB1> INFO: pixel data incomplete: 0
[08:28:05.871] <TB1> INFO: pixel address: 0
[08:28:05.871] <TB1> INFO: pulse height fill bit: 0
[08:28:05.871] <TB1> INFO: buffer corruption: 0
[08:28:06.683] <TB1> INFO: ######################################################################
[08:28:06.683] <TB1> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[08:28:06.683] <TB1> INFO: ######################################################################
[08:28:06.958] <TB1> INFO: Expecting 41600 events.
[08:28:10.940] <TB1> INFO: 41600 events read in total (3426ms).
[08:28:10.941] <TB1> INFO: Test took 4257ms.
[08:28:11.410] <TB1> INFO: Expecting 41600 events.
[08:28:15.292] <TB1> INFO: 41600 events read in total (3326ms).
[08:28:15.293] <TB1> INFO: Test took 4148ms.
[08:28:15.573] <TB1> INFO: Expecting 41600 events.
[08:28:19.465] <TB1> INFO: 41600 events read in total (3332ms).
[08:28:19.465] <TB1> INFO: Test took 4151ms.
[08:28:19.725] <TB1> INFO: Expecting 2560 events.
[08:28:20.579] <TB1> INFO: 2560 events read in total (297ms).
[08:28:20.579] <TB1> INFO: Test took 1096ms.
[08:28:20.884] <TB1> INFO: Expecting 2560 events.
[08:28:21.739] <TB1> INFO: 2560 events read in total (299ms).
[08:28:21.739] <TB1> INFO: Test took 1157ms.
[08:28:22.044] <TB1> INFO: Expecting 2560 events.
[08:28:22.899] <TB1> INFO: 2560 events read in total (299ms).
[08:28:22.899] <TB1> INFO: Test took 1160ms.
[08:28:23.204] <TB1> INFO: Expecting 2560 events.
[08:28:24.056] <TB1> INFO: 2560 events read in total (296ms).
[08:28:24.056] <TB1> INFO: Test took 1157ms.
[08:28:24.361] <TB1> INFO: Expecting 2560 events.
[08:28:25.214] <TB1> INFO: 2560 events read in total (296ms).
[08:28:25.215] <TB1> INFO: Test took 1158ms.
[08:28:25.520] <TB1> INFO: Expecting 2560 events.
[08:28:26.376] <TB1> INFO: 2560 events read in total (300ms).
[08:28:26.376] <TB1> INFO: Test took 1161ms.
[08:28:26.681] <TB1> INFO: Expecting 2560 events.
[08:28:27.536] <TB1> INFO: 2560 events read in total (299ms).
[08:28:27.536] <TB1> INFO: Test took 1160ms.
[08:28:27.842] <TB1> INFO: Expecting 2560 events.
[08:28:28.694] <TB1> INFO: 2560 events read in total (296ms).
[08:28:28.694] <TB1> INFO: Test took 1157ms.
[08:28:28.999] <TB1> INFO: Expecting 2560 events.
[08:28:29.852] <TB1> INFO: 2560 events read in total (296ms).
[08:28:29.852] <TB1> INFO: Test took 1157ms.
[08:28:30.157] <TB1> INFO: Expecting 2560 events.
[08:28:31.010] <TB1> INFO: 2560 events read in total (297ms).
[08:28:31.010] <TB1> INFO: Test took 1158ms.
[08:28:31.315] <TB1> INFO: Expecting 2560 events.
[08:28:32.168] <TB1> INFO: 2560 events read in total (297ms).
[08:28:32.168] <TB1> INFO: Test took 1158ms.
[08:28:32.473] <TB1> INFO: Expecting 2560 events.
[08:28:33.328] <TB1> INFO: 2560 events read in total (298ms).
[08:28:33.329] <TB1> INFO: Test took 1160ms.
[08:28:33.634] <TB1> INFO: Expecting 2560 events.
[08:28:34.487] <TB1> INFO: 2560 events read in total (297ms).
[08:28:34.487] <TB1> INFO: Test took 1158ms.
[08:28:34.793] <TB1> INFO: Expecting 2560 events.
[08:28:35.645] <TB1> INFO: 2560 events read in total (296ms).
[08:28:35.646] <TB1> INFO: Test took 1158ms.
[08:28:35.951] <TB1> INFO: Expecting 2560 events.
[08:28:36.804] <TB1> INFO: 2560 events read in total (297ms).
[08:28:36.804] <TB1> INFO: Test took 1158ms.
[08:28:37.109] <TB1> INFO: Expecting 2560 events.
[08:28:37.964] <TB1> INFO: 2560 events read in total (299ms).
[08:28:37.964] <TB1> INFO: Test took 1160ms.
[08:28:37.967] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:28:38.270] <TB1> INFO: Expecting 655360 events.
[08:28:54.979] <TB1> INFO: 655360 events read in total (16153ms).
[08:28:54.989] <TB1> INFO: Expecting 655360 events.
[08:29:11.832] <TB1> INFO: 655360 events read in total (16441ms).
[08:29:11.846] <TB1> INFO: Expecting 655360 events.
[08:29:28.846] <TB1> INFO: 655360 events read in total (16598ms).
[08:29:28.862] <TB1> INFO: Expecting 655360 events.
[08:29:45.704] <TB1> INFO: 655360 events read in total (16440ms).
[08:29:45.725] <TB1> INFO: Expecting 655360 events.
[08:30:02.553] <TB1> INFO: 655360 events read in total (16427ms).
[08:30:02.577] <TB1> INFO: Expecting 655360 events.
[08:30:19.361] <TB1> INFO: 655360 events read in total (16382ms).
[08:30:19.394] <TB1> INFO: Expecting 655360 events.
[08:30:36.126] <TB1> INFO: 655360 events read in total (16330ms).
[08:30:36.155] <TB1> INFO: Expecting 655360 events.
[08:30:52.721] <TB1> INFO: 655360 events read in total (16164ms).
[08:30:52.756] <TB1> INFO: Expecting 655360 events.
[08:31:09.261] <TB1> INFO: 655360 events read in total (16103ms).
[08:31:09.301] <TB1> INFO: Expecting 655360 events.
[08:31:25.848] <TB1> INFO: 655360 events read in total (16145ms).
[08:31:25.900] <TB1> INFO: Expecting 655360 events.
[08:31:42.725] <TB1> INFO: 655360 events read in total (16423ms).
[08:31:42.787] <TB1> INFO: Expecting 655360 events.
[08:31:59.671] <TB1> INFO: 655360 events read in total (16482ms).
[08:31:59.728] <TB1> INFO: Expecting 655360 events.
[08:32:16.281] <TB1> INFO: 655360 events read in total (16152ms).
[08:32:16.335] <TB1> INFO: Expecting 655360 events.
[08:32:33.064] <TB1> INFO: 655360 events read in total (16327ms).
[08:32:33.136] <TB1> INFO: Expecting 655360 events.
[08:32:50.030] <TB1> INFO: 655360 events read in total (16492ms).
[08:32:50.089] <TB1> INFO: Expecting 655360 events.
[08:33:06.684] <TB1> INFO: 655360 events read in total (16193ms).
[08:33:06.752] <TB1> INFO: Test took 268785ms.
[08:33:06.857] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:33:07.085] <TB1> INFO: Expecting 655360 events.
[08:33:24.007] <TB1> INFO: 655360 events read in total (16366ms).
[08:33:24.019] <TB1> INFO: Expecting 655360 events.
[08:33:40.590] <TB1> INFO: 655360 events read in total (16169ms).
[08:33:40.609] <TB1> INFO: Expecting 655360 events.
[08:33:57.039] <TB1> INFO: 655360 events read in total (16029ms).
[08:33:57.055] <TB1> INFO: Expecting 655360 events.
[08:34:13.973] <TB1> INFO: 655360 events read in total (16516ms).
[08:34:13.994] <TB1> INFO: Expecting 655360 events.
[08:34:30.792] <TB1> INFO: 655360 events read in total (16396ms).
[08:34:30.821] <TB1> INFO: Expecting 655360 events.
[08:34:47.553] <TB1> INFO: 655360 events read in total (16331ms).
[08:34:47.591] <TB1> INFO: Expecting 655360 events.
[08:35:04.317] <TB1> INFO: 655360 events read in total (16324ms).
[08:35:04.347] <TB1> INFO: Expecting 655360 events.
[08:35:20.855] <TB1> INFO: 655360 events read in total (16106ms).
[08:35:20.891] <TB1> INFO: Expecting 655360 events.
[08:35:37.421] <TB1> INFO: 655360 events read in total (16129ms).
[08:35:37.470] <TB1> INFO: Expecting 655360 events.
[08:35:53.949] <TB1> INFO: 655360 events read in total (16077ms).
[08:35:54.002] <TB1> INFO: Expecting 655360 events.
[08:36:10.804] <TB1> INFO: 655360 events read in total (16400ms).
[08:36:10.847] <TB1> INFO: Expecting 655360 events.
[08:36:27.478] <TB1> INFO: 655360 events read in total (16229ms).
[08:36:27.528] <TB1> INFO: Expecting 655360 events.
[08:36:43.914] <TB1> INFO: 655360 events read in total (15984ms).
[08:36:43.972] <TB1> INFO: Expecting 655360 events.
[08:37:00.546] <TB1> INFO: 655360 events read in total (16173ms).
[08:37:00.601] <TB1> INFO: Expecting 655360 events.
[08:37:17.204] <TB1> INFO: 655360 events read in total (16201ms).
[08:37:17.261] <TB1> INFO: Expecting 655360 events.
[08:37:33.785] <TB1> INFO: 655360 events read in total (16122ms).
[08:37:33.850] <TB1> INFO: Test took 266993ms.
[08:37:34.034] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.041] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.052] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.062] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.069] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.076] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.087] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.097] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.107] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.117] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.124] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.131] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.141] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.151] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.162] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.169] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[08:37:34.205] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C0.dat
[08:37:34.205] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C1.dat
[08:37:34.205] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C2.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C3.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C4.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C5.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C6.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C7.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C8.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C9.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C10.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C11.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C12.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C13.dat
[08:37:34.206] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C14.dat
[08:37:34.207] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//dacParameters35_C15.dat
[08:37:34.470] <TB1> INFO: Expecting 41600 events.
[08:37:37.919] <TB1> INFO: 41600 events read in total (2893ms).
[08:37:37.920] <TB1> INFO: Test took 3711ms.
[08:37:38.357] <TB1> INFO: Expecting 41600 events.
[08:37:41.894] <TB1> INFO: 41600 events read in total (2981ms).
[08:37:41.895] <TB1> INFO: Test took 3798ms.
[08:37:42.378] <TB1> INFO: Expecting 41600 events.
[08:37:45.867] <TB1> INFO: 41600 events read in total (2932ms).
[08:37:45.868] <TB1> INFO: Test took 3791ms.
[08:37:46.057] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:46.145] <TB1> INFO: Expecting 2560 events.
[08:37:46.998] <TB1> INFO: 2560 events read in total (297ms).
[08:37:46.998] <TB1> INFO: Test took 941ms.
[08:37:47.000] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:47.304] <TB1> INFO: Expecting 2560 events.
[08:37:48.158] <TB1> INFO: 2560 events read in total (298ms).
[08:37:48.158] <TB1> INFO: Test took 1158ms.
[08:37:48.161] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:48.464] <TB1> INFO: Expecting 2560 events.
[08:37:49.319] <TB1> INFO: 2560 events read in total (299ms).
[08:37:49.320] <TB1> INFO: Test took 1159ms.
[08:37:49.323] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:49.625] <TB1> INFO: Expecting 2560 events.
[08:37:50.478] <TB1> INFO: 2560 events read in total (297ms).
[08:37:50.478] <TB1> INFO: Test took 1155ms.
[08:37:50.480] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:50.784] <TB1> INFO: Expecting 2560 events.
[08:37:51.640] <TB1> INFO: 2560 events read in total (300ms).
[08:37:51.640] <TB1> INFO: Test took 1160ms.
[08:37:51.643] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:51.945] <TB1> INFO: Expecting 2560 events.
[08:37:52.800] <TB1> INFO: 2560 events read in total (299ms).
[08:37:52.800] <TB1> INFO: Test took 1157ms.
[08:37:52.802] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:53.106] <TB1> INFO: Expecting 2560 events.
[08:37:53.961] <TB1> INFO: 2560 events read in total (299ms).
[08:37:53.961] <TB1> INFO: Test took 1159ms.
[08:37:53.963] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:54.267] <TB1> INFO: Expecting 2560 events.
[08:37:55.120] <TB1> INFO: 2560 events read in total (297ms).
[08:37:55.120] <TB1> INFO: Test took 1157ms.
[08:37:55.123] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:55.427] <TB1> INFO: Expecting 2560 events.
[08:37:56.284] <TB1> INFO: 2560 events read in total (301ms).
[08:37:56.284] <TB1> INFO: Test took 1161ms.
[08:37:56.287] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:56.590] <TB1> INFO: Expecting 2560 events.
[08:37:57.449] <TB1> INFO: 2560 events read in total (302ms).
[08:37:57.450] <TB1> INFO: Test took 1164ms.
[08:37:57.452] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:57.757] <TB1> INFO: Expecting 2560 events.
[08:37:58.618] <TB1> INFO: 2560 events read in total (305ms).
[08:37:58.618] <TB1> INFO: Test took 1166ms.
[08:37:58.620] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:37:58.925] <TB1> INFO: Expecting 2560 events.
[08:37:59.779] <TB1> INFO: 2560 events read in total (298ms).
[08:37:59.780] <TB1> INFO: Test took 1160ms.
[08:37:59.783] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:00.086] <TB1> INFO: Expecting 2560 events.
[08:38:00.938] <TB1> INFO: 2560 events read in total (296ms).
[08:38:00.938] <TB1> INFO: Test took 1155ms.
[08:38:00.940] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:01.244] <TB1> INFO: Expecting 2560 events.
[08:38:02.097] <TB1> INFO: 2560 events read in total (297ms).
[08:38:02.098] <TB1> INFO: Test took 1158ms.
[08:38:02.100] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:02.404] <TB1> INFO: Expecting 2560 events.
[08:38:03.258] <TB1> INFO: 2560 events read in total (298ms).
[08:38:03.258] <TB1> INFO: Test took 1158ms.
[08:38:03.259] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:03.564] <TB1> INFO: Expecting 2560 events.
[08:38:04.416] <TB1> INFO: 2560 events read in total (296ms).
[08:38:04.417] <TB1> INFO: Test took 1158ms.
[08:38:04.423] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:04.723] <TB1> INFO: Expecting 2560 events.
[08:38:05.575] <TB1> INFO: 2560 events read in total (296ms).
[08:38:05.576] <TB1> INFO: Test took 1153ms.
[08:38:05.579] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:05.881] <TB1> INFO: Expecting 2560 events.
[08:38:06.734] <TB1> INFO: 2560 events read in total (297ms).
[08:38:06.734] <TB1> INFO: Test took 1155ms.
[08:38:06.737] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:07.040] <TB1> INFO: Expecting 2560 events.
[08:38:07.896] <TB1> INFO: 2560 events read in total (300ms).
[08:38:07.896] <TB1> INFO: Test took 1159ms.
[08:38:07.898] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:08.202] <TB1> INFO: Expecting 2560 events.
[08:38:09.055] <TB1> INFO: 2560 events read in total (297ms).
[08:38:09.055] <TB1> INFO: Test took 1157ms.
[08:38:09.058] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:09.361] <TB1> INFO: Expecting 2560 events.
[08:38:10.216] <TB1> INFO: 2560 events read in total (299ms).
[08:38:10.216] <TB1> INFO: Test took 1158ms.
[08:38:10.218] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:10.521] <TB1> INFO: Expecting 2560 events.
[08:38:11.375] <TB1> INFO: 2560 events read in total (297ms).
[08:38:11.375] <TB1> INFO: Test took 1157ms.
[08:38:11.377] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:11.681] <TB1> INFO: Expecting 2560 events.
[08:38:12.536] <TB1> INFO: 2560 events read in total (299ms).
[08:38:12.537] <TB1> INFO: Test took 1160ms.
[08:38:12.540] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:12.843] <TB1> INFO: Expecting 2560 events.
[08:38:13.699] <TB1> INFO: 2560 events read in total (300ms).
[08:38:13.700] <TB1> INFO: Test took 1160ms.
[08:38:13.703] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:14.006] <TB1> INFO: Expecting 2560 events.
[08:38:14.865] <TB1> INFO: 2560 events read in total (303ms).
[08:38:14.865] <TB1> INFO: Test took 1162ms.
[08:38:14.869] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:15.171] <TB1> INFO: Expecting 2560 events.
[08:38:16.026] <TB1> INFO: 2560 events read in total (298ms).
[08:38:16.026] <TB1> INFO: Test took 1157ms.
[08:38:16.030] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:16.333] <TB1> INFO: Expecting 2560 events.
[08:38:17.188] <TB1> INFO: 2560 events read in total (299ms).
[08:38:17.189] <TB1> INFO: Test took 1160ms.
[08:38:17.191] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:17.494] <TB1> INFO: Expecting 2560 events.
[08:38:18.351] <TB1> INFO: 2560 events read in total (300ms).
[08:38:18.351] <TB1> INFO: Test took 1160ms.
[08:38:18.353] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:18.656] <TB1> INFO: Expecting 2560 events.
[08:38:19.509] <TB1> INFO: 2560 events read in total (296ms).
[08:38:19.510] <TB1> INFO: Test took 1157ms.
[08:38:19.512] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:19.816] <TB1> INFO: Expecting 2560 events.
[08:38:20.670] <TB1> INFO: 2560 events read in total (298ms).
[08:38:20.670] <TB1> INFO: Test took 1158ms.
[08:38:20.672] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:20.976] <TB1> INFO: Expecting 2560 events.
[08:38:21.828] <TB1> INFO: 2560 events read in total (296ms).
[08:38:21.828] <TB1> INFO: Test took 1156ms.
[08:38:21.830] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:38:22.134] <TB1> INFO: Expecting 2560 events.
[08:38:22.988] <TB1> INFO: 2560 events read in total (298ms).
[08:38:22.988] <TB1> INFO: Test took 1158ms.
[08:38:23.450] <TB1> INFO: PixTestPhOptimization::doTest() done, duration: 616 seconds
[08:38:23.451] <TB1> INFO: PH scale (per ROC): 85 84 75 81 90 84 97 77 74 85 84 88 83 84 81 80
[08:38:23.451] <TB1> INFO: PH offset (per ROC): 176 161 170 161 145 141 149 152 160 154 171 158 171 153 150 160
[08:38:23.456] <TB1> INFO: Decoding statistics:
[08:38:23.456] <TB1> INFO: General information:
[08:38:23.456] <TB1> INFO: 16bit words read: 91932
[08:38:23.456] <TB1> INFO: valid events total: 10240
[08:38:23.456] <TB1> INFO: empty events: 7737
[08:38:23.456] <TB1> INFO: valid events with pixels: 2503
[08:38:23.456] <TB1> INFO: valid pixel hits: 2503
[08:38:23.456] <TB1> INFO: Event errors: 0
[08:38:23.456] <TB1> INFO: start marker: 0
[08:38:23.457] <TB1> INFO: stop marker: 0
[08:38:23.457] <TB1> INFO: overflow: 0
[08:38:23.457] <TB1> INFO: invalid 5bit words: 0
[08:38:23.457] <TB1> INFO: invalid XOR eye diagram: 0
[08:38:23.457] <TB1> INFO: frame (failed synchr.): 0
[08:38:23.457] <TB1> INFO: idle data (no TBM trl): 0
[08:38:23.457] <TB1> INFO: no data (only TBM hdr): 0
[08:38:23.457] <TB1> INFO: TBM errors: 0
[08:38:23.457] <TB1> INFO: flawed TBM headers: 0
[08:38:23.457] <TB1> INFO: flawed TBM trailers: 0
[08:38:23.457] <TB1> INFO: event ID mismatches: 0
[08:38:23.457] <TB1> INFO: ROC errors: 0
[08:38:23.457] <TB1> INFO: missing ROC header(s): 0
[08:38:23.457] <TB1> INFO: misplaced readback start: 0
[08:38:23.457] <TB1> INFO: Pixel decoding errors: 0
[08:38:23.457] <TB1> INFO: pixel data incomplete: 0
[08:38:23.457] <TB1> INFO: pixel address: 0
[08:38:23.457] <TB1> INFO: pulse height fill bit: 0
[08:38:23.457] <TB1> INFO: buffer corruption: 0
[08:38:23.642] <TB1> INFO: ######################################################################
[08:38:23.642] <TB1> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[08:38:23.642] <TB1> INFO: ######################################################################
[08:38:23.651] <TB1> INFO: scanning low vcal = 10
[08:38:23.920] <TB1> INFO: Expecting 41600 events.
[08:38:27.456] <TB1> INFO: 41600 events read in total (2979ms).
[08:38:27.456] <TB1> INFO: Test took 3805ms.
[08:38:27.457] <TB1> INFO: scanning low vcal = 20
[08:38:27.761] <TB1> INFO: Expecting 41600 events.
[08:38:31.308] <TB1> INFO: 41600 events read in total (2991ms).
[08:38:31.309] <TB1> INFO: Test took 3852ms.
[08:38:31.311] <TB1> INFO: scanning low vcal = 30
[08:38:31.613] <TB1> INFO: Expecting 41600 events.
[08:38:35.170] <TB1> INFO: 41600 events read in total (3000ms).
[08:38:35.170] <TB1> INFO: Test took 3859ms.
[08:38:35.172] <TB1> INFO: scanning low vcal = 40
[08:38:35.465] <TB1> INFO: Expecting 41600 events.
[08:38:39.603] <TB1> INFO: 41600 events read in total (3581ms).
[08:38:39.603] <TB1> INFO: Test took 4432ms.
[08:38:39.606] <TB1> INFO: scanning low vcal = 50
[08:38:39.865] <TB1> INFO: Expecting 41600 events.
[08:38:44.062] <TB1> INFO: 41600 events read in total (3641ms).
[08:38:44.063] <TB1> INFO: Test took 4457ms.
[08:38:44.065] <TB1> INFO: scanning low vcal = 60
[08:38:44.322] <TB1> INFO: Expecting 41600 events.
[08:38:48.511] <TB1> INFO: 41600 events read in total (3632ms).
[08:38:48.512] <TB1> INFO: Test took 4447ms.
[08:38:48.514] <TB1> INFO: scanning low vcal = 70
[08:38:48.797] <TB1> INFO: Expecting 41600 events.
[08:38:53.004] <TB1> INFO: 41600 events read in total (3651ms).
[08:38:53.005] <TB1> INFO: Test took 4491ms.
[08:38:53.007] <TB1> INFO: scanning low vcal = 80
[08:38:53.291] <TB1> INFO: Expecting 41600 events.
[08:38:57.495] <TB1> INFO: 41600 events read in total (3648ms).
[08:38:57.495] <TB1> INFO: Test took 4488ms.
[08:38:57.498] <TB1> INFO: scanning low vcal = 90
[08:38:57.764] <TB1> INFO: Expecting 41600 events.
[08:39:01.974] <TB1> INFO: 41600 events read in total (3653ms).
[08:39:01.975] <TB1> INFO: Test took 4477ms.
[08:39:01.978] <TB1> INFO: scanning low vcal = 100
[08:39:02.239] <TB1> INFO: Expecting 41600 events.
[08:39:06.424] <TB1> INFO: 41600 events read in total (3629ms).
[08:39:06.425] <TB1> INFO: Test took 4447ms.
[08:39:06.427] <TB1> INFO: scanning low vcal = 110
[08:39:06.686] <TB1> INFO: Expecting 41600 events.
[08:39:10.883] <TB1> INFO: 41600 events read in total (3641ms).
[08:39:10.883] <TB1> INFO: Test took 4456ms.
[08:39:10.886] <TB1> INFO: scanning low vcal = 120
[08:39:11.144] <TB1> INFO: Expecting 41600 events.
[08:39:15.321] <TB1> INFO: 41600 events read in total (3620ms).
[08:39:15.322] <TB1> INFO: Test took 4436ms.
[08:39:15.324] <TB1> INFO: scanning low vcal = 130
[08:39:15.582] <TB1> INFO: Expecting 41600 events.
[08:39:19.783] <TB1> INFO: 41600 events read in total (3645ms).
[08:39:19.783] <TB1> INFO: Test took 4459ms.
[08:39:19.786] <TB1> INFO: scanning low vcal = 140
[08:39:20.046] <TB1> INFO: Expecting 41600 events.
[08:39:24.280] <TB1> INFO: 41600 events read in total (3678ms).
[08:39:24.280] <TB1> INFO: Test took 4494ms.
[08:39:24.283] <TB1> INFO: scanning low vcal = 150
[08:39:24.549] <TB1> INFO: Expecting 41600 events.
[08:39:28.764] <TB1> INFO: 41600 events read in total (3658ms).
[08:39:28.765] <TB1> INFO: Test took 4482ms.
[08:39:28.768] <TB1> INFO: scanning low vcal = 160
[08:39:29.047] <TB1> INFO: Expecting 41600 events.
[08:39:33.307] <TB1> INFO: 41600 events read in total (3704ms).
[08:39:33.308] <TB1> INFO: Test took 4540ms.
[08:39:33.311] <TB1> INFO: scanning low vcal = 170
[08:39:33.570] <TB1> INFO: Expecting 41600 events.
[08:39:37.847] <TB1> INFO: 41600 events read in total (3720ms).
[08:39:37.848] <TB1> INFO: Test took 4537ms.
[08:39:37.852] <TB1> INFO: scanning low vcal = 180
[08:39:38.139] <TB1> INFO: Expecting 41600 events.
[08:39:42.381] <TB1> INFO: 41600 events read in total (3685ms).
[08:39:42.381] <TB1> INFO: Test took 4529ms.
[08:39:42.384] <TB1> INFO: scanning low vcal = 190
[08:39:42.646] <TB1> INFO: Expecting 41600 events.
[08:39:46.928] <TB1> INFO: 41600 events read in total (3725ms).
[08:39:46.929] <TB1> INFO: Test took 4545ms.
[08:39:46.932] <TB1> INFO: scanning low vcal = 200
[08:39:47.236] <TB1> INFO: Expecting 41600 events.
[08:39:51.472] <TB1> INFO: 41600 events read in total (3680ms).
[08:39:51.472] <TB1> INFO: Test took 4540ms.
[08:39:51.475] <TB1> INFO: scanning low vcal = 210
[08:39:51.738] <TB1> INFO: Expecting 41600 events.
[08:39:55.979] <TB1> INFO: 41600 events read in total (3684ms).
[08:39:55.979] <TB1> INFO: Test took 4504ms.
[08:39:55.982] <TB1> INFO: scanning low vcal = 220
[08:39:56.258] <TB1> INFO: Expecting 41600 events.
[08:40:00.480] <TB1> INFO: 41600 events read in total (3666ms).
[08:40:00.481] <TB1> INFO: Test took 4499ms.
[08:40:00.484] <TB1> INFO: scanning low vcal = 230
[08:40:00.797] <TB1> INFO: Expecting 41600 events.
[08:40:05.048] <TB1> INFO: 41600 events read in total (3694ms).
[08:40:05.048] <TB1> INFO: Test took 4563ms.
[08:40:05.051] <TB1> INFO: scanning low vcal = 240
[08:40:05.310] <TB1> INFO: Expecting 41600 events.
[08:40:09.491] <TB1> INFO: 41600 events read in total (3625ms).
[08:40:09.493] <TB1> INFO: Test took 4442ms.
[08:40:09.495] <TB1> INFO: scanning low vcal = 250
[08:40:09.755] <TB1> INFO: Expecting 41600 events.
[08:40:14.038] <TB1> INFO: 41600 events read in total (3727ms).
[08:40:14.039] <TB1> INFO: Test took 4544ms.
[08:40:14.043] <TB1> INFO: scanning high vcal = 30 (= 210 in low range)
[08:40:14.312] <TB1> INFO: Expecting 41600 events.
[08:40:18.542] <TB1> INFO: 41600 events read in total (3674ms).
[08:40:18.543] <TB1> INFO: Test took 4500ms.
[08:40:18.546] <TB1> INFO: scanning high vcal = 50 (= 350 in low range)
[08:40:18.811] <TB1> INFO: Expecting 41600 events.
[08:40:23.058] <TB1> INFO: 41600 events read in total (3690ms).
[08:40:23.059] <TB1> INFO: Test took 4513ms.
[08:40:23.062] <TB1> INFO: scanning high vcal = 70 (= 490 in low range)
[08:40:23.322] <TB1> INFO: Expecting 41600 events.
[08:40:27.534] <TB1> INFO: 41600 events read in total (3655ms).
[08:40:27.535] <TB1> INFO: Test took 4473ms.
[08:40:27.538] <TB1> INFO: scanning high vcal = 90 (= 630 in low range)
[08:40:27.797] <TB1> INFO: Expecting 41600 events.
[08:40:32.015] <TB1> INFO: 41600 events read in total (3662ms).
[08:40:32.015] <TB1> INFO: Test took 4478ms.
[08:40:32.018] <TB1> INFO: scanning high vcal = 200 (= 1400 in low range)
[08:40:32.276] <TB1> INFO: Expecting 41600 events.
[08:40:36.496] <TB1> INFO: 41600 events read in total (3664ms).
[08:40:36.496] <TB1> INFO: Test took 4478ms.
[08:40:36.972] <TB1> INFO: PixTestGainPedestal::measure() done
[08:41:07.968] <TB1> INFO: PixTestGainPedestal::fit() done
[08:41:07.969] <TB1> INFO: non-linearity mean: 0.959 0.960 0.957 0.953 0.956 0.958 0.951 0.952 0.953 0.954 0.951 0.954 0.953 0.952 0.958 0.955
[08:41:07.969] <TB1> INFO: non-linearity RMS: 0.005 0.006 0.005 0.006 0.006 0.006 0.005 0.005 0.006 0.005 0.006 0.005 0.005 0.005 0.005 0.007
[08:41:07.969] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[08:41:07.990] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[08:41:08.009] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[08:41:08.028] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[08:41:08.048] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[08:41:08.073] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[08:41:08.113] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[08:41:08.139] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[08:41:08.158] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[08:41:08.188] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[08:41:08.207] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[08:41:08.226] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[08:41:08.245] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[08:41:08.264] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[08:41:08.283] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[08:41:08.301] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[08:41:08.320] <TB1> INFO: PixTestGainPedestal::fullTest() done, duration: 164 seconds
[08:41:08.320] <TB1> INFO: Decoding statistics:
[08:41:08.320] <TB1> INFO: General information:
[08:41:08.320] <TB1> INFO: 16bit words read: 2662400
[08:41:08.320] <TB1> INFO: valid events total: 166400
[08:41:08.320] <TB1> INFO: empty events: 0
[08:41:08.320] <TB1> INFO: valid events with pixels: 166400
[08:41:08.320] <TB1> INFO: valid pixel hits: 665580
[08:41:08.320] <TB1> INFO: Event errors: 0
[08:41:08.320] <TB1> INFO: start marker: 0
[08:41:08.320] <TB1> INFO: stop marker: 0
[08:41:08.320] <TB1> INFO: overflow: 0
[08:41:08.320] <TB1> INFO: invalid 5bit words: 0
[08:41:08.320] <TB1> INFO: invalid XOR eye diagram: 0
[08:41:08.320] <TB1> INFO: frame (failed synchr.): 0
[08:41:08.320] <TB1> INFO: idle data (no TBM trl): 0
[08:41:08.320] <TB1> INFO: no data (only TBM hdr): 0
[08:41:08.320] <TB1> INFO: TBM errors: 0
[08:41:08.320] <TB1> INFO: flawed TBM headers: 0
[08:41:08.320] <TB1> INFO: flawed TBM trailers: 0
[08:41:08.320] <TB1> INFO: event ID mismatches: 0
[08:41:08.320] <TB1> INFO: ROC errors: 0
[08:41:08.320] <TB1> INFO: missing ROC header(s): 0
[08:41:08.320] <TB1> INFO: misplaced readback start: 0
[08:41:08.320] <TB1> INFO: Pixel decoding errors: 0
[08:41:08.320] <TB1> INFO: pixel data incomplete: 0
[08:41:08.320] <TB1> INFO: pixel address: 0
[08:41:08.320] <TB1> INFO: pulse height fill bit: 0
[08:41:08.320] <TB1> INFO: buffer corruption: 0
[08:41:08.328] <TB1> INFO: readReadbackCal: /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C15.dat
[08:41:08.329] <TB1> INFO: ######################################################################
[08:41:08.329] <TB1> INFO: PixTestReadback::doTest()
[08:41:08.329] <TB1> INFO: ######################################################################
[08:41:08.329] <TB1> INFO: ----------------------------------------------------------------------
[08:41:08.329] <TB1> INFO: PixTestReadback::CalibrateVd()
[08:41:08.329] <TB1> INFO: ----------------------------------------------------------------------
[08:41:17.808] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C0.dat
[08:41:17.808] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C1.dat
[08:41:17.808] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C2.dat
[08:41:17.808] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C3.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C4.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C5.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C6.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C7.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C8.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C9.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C10.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C11.dat
[08:41:17.809] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C12.dat
[08:41:17.810] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C13.dat
[08:41:17.810] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C14.dat
[08:41:17.810] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C15.dat
[08:41:17.839] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:41:17.839] <TB1> INFO: ----------------------------------------------------------------------
[08:41:17.839] <TB1> INFO: PixTestReadback::CalibrateVa()
[08:41:17.839] <TB1> INFO: ----------------------------------------------------------------------
[08:41:27.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C0.dat
[08:41:27.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C1.dat
[08:41:27.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C2.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C3.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C4.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C5.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C6.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C7.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C8.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C9.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C10.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C11.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C12.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C13.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C14.dat
[08:41:27.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C15.dat
[08:41:27.331] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:41:27.331] <TB1> INFO: ----------------------------------------------------------------------
[08:41:27.331] <TB1> INFO: PixTestReadback::readbackVbg()
[08:41:27.331] <TB1> INFO: ----------------------------------------------------------------------
[08:41:34.631] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:41:34.631] <TB1> INFO: ----------------------------------------------------------------------
[08:41:34.631] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[08:41:34.631] <TB1> INFO: ----------------------------------------------------------------------
[08:41:34.631] <TB1> INFO: Vbg will be calibrated using Vd calibration
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 151.1calibrated Vbg = 1.17164 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 153.4calibrated Vbg = 1.17063 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.5calibrated Vbg = 1.1734 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 147.6calibrated Vbg = 1.1854 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149.3calibrated Vbg = 1.17708 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 149calibrated Vbg = 1.17903 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 143.9calibrated Vbg = 1.18174 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 152.5calibrated Vbg = 1.1847 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 145.7calibrated Vbg = 1.1877 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 151.9calibrated Vbg = 1.18731 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 158.9calibrated Vbg = 1.18451 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 154.1calibrated Vbg = 1.18427 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 154.4calibrated Vbg = 1.18311 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 153calibrated Vbg = 1.1792 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 157.1calibrated Vbg = 1.1854 :::*/*/*/*/
[08:41:34.631] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 159.9calibrated Vbg = 1.18472 :::*/*/*/*/
[08:41:34.633] <TB1> INFO: ----------------------------------------------------------------------
[08:41:34.633] <TB1> INFO: PixTestReadback::CalibrateIa()
[08:41:34.633] <TB1> INFO: ----------------------------------------------------------------------
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C0.dat
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C1.dat
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C2.dat
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C3.dat
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C4.dat
[08:44:10.022] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C5.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C6.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C7.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C8.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C9.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C10.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C11.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C12.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C13.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C14.dat
[08:44:10.023] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2205_FullQualification_2016-04-13_09h07m_1460531261//000_FulltestPxar_m20//readbackCal_C15.dat
[08:44:10.051] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:44:10.052] <TB1> INFO: PixTestReadback::doTest() done
[08:44:10.052] <TB1> INFO: Decoding statistics:
[08:44:10.052] <TB1> INFO: General information:
[08:44:10.052] <TB1> INFO: 16bit words read: 1024
[08:44:10.052] <TB1> INFO: valid events total: 128
[08:44:10.052] <TB1> INFO: empty events: 128
[08:44:10.052] <TB1> INFO: valid events with pixels: 0
[08:44:10.052] <TB1> INFO: valid pixel hits: 0
[08:44:10.052] <TB1> INFO: Event errors: 0
[08:44:10.052] <TB1> INFO: start marker: 0
[08:44:10.052] <TB1> INFO: stop marker: 0
[08:44:10.052] <TB1> INFO: overflow: 0
[08:44:10.052] <TB1> INFO: invalid 5bit words: 0
[08:44:10.052] <TB1> INFO: invalid XOR eye diagram: 0
[08:44:10.052] <TB1> INFO: frame (failed synchr.): 0
[08:44:10.052] <TB1> INFO: idle data (no TBM trl): 0
[08:44:10.052] <TB1> INFO: no data (only TBM hdr): 0
[08:44:10.052] <TB1> INFO: TBM errors: 0
[08:44:10.052] <TB1> INFO: flawed TBM headers: 0
[08:44:10.052] <TB1> INFO: flawed TBM trailers: 0
[08:44:10.052] <TB1> INFO: event ID mismatches: 0
[08:44:10.052] <TB1> INFO: ROC errors: 0
[08:44:10.052] <TB1> INFO: missing ROC header(s): 0
[08:44:10.052] <TB1> INFO: misplaced readback start: 0
[08:44:10.052] <TB1> INFO: Pixel decoding errors: 0
[08:44:10.052] <TB1> INFO: pixel data incomplete: 0
[08:44:10.052] <TB1> INFO: pixel address: 0
[08:44:10.052] <TB1> INFO: pulse height fill bit: 0
[08:44:10.052] <TB1> INFO: buffer corruption: 0
[08:44:10.070] <TB1> INFO: Decoding statistics:
[08:44:10.070] <TB1> INFO: General information:
[08:44:10.070] <TB1> INFO: 16bit words read: 2755356
[08:44:10.070] <TB1> INFO: valid events total: 176768
[08:44:10.070] <TB1> INFO: empty events: 7865
[08:44:10.070] <TB1> INFO: valid events with pixels: 168903
[08:44:10.070] <TB1> INFO: valid pixel hits: 668083
[08:44:10.070] <TB1> INFO: Event errors: 0
[08:44:10.070] <TB1> INFO: start marker: 0
[08:44:10.070] <TB1> INFO: stop marker: 0
[08:44:10.070] <TB1> INFO: overflow: 0
[08:44:10.070] <TB1> INFO: invalid 5bit words: 0
[08:44:10.070] <TB1> INFO: invalid XOR eye diagram: 0
[08:44:10.070] <TB1> INFO: frame (failed synchr.): 0
[08:44:10.070] <TB1> INFO: idle data (no TBM trl): 0
[08:44:10.070] <TB1> INFO: no data (only TBM hdr): 0
[08:44:10.070] <TB1> INFO: TBM errors: 0
[08:44:10.070] <TB1> INFO: flawed TBM headers: 0
[08:44:10.070] <TB1> INFO: flawed TBM trailers: 0
[08:44:10.070] <TB1> INFO: event ID mismatches: 0
[08:44:10.070] <TB1> INFO: ROC errors: 0
[08:44:10.070] <TB1> INFO: missing ROC header(s): 0
[08:44:10.070] <TB1> INFO: misplaced readback start: 0
[08:44:10.070] <TB1> INFO: Pixel decoding errors: 0
[08:44:10.070] <TB1> INFO: pixel data incomplete: 0
[08:44:10.070] <TB1> INFO: pixel address: 0
[08:44:10.070] <TB1> INFO: pulse height fill bit: 0
[08:44:10.070] <TB1> INFO: buffer corruption: 0
[08:44:10.070] <TB1> INFO: enter test to run
[08:44:10.070] <TB1> INFO: test: exit no parameter change
[08:44:10.229] <TB1> QUIET: Connection to board 153 closed.
[08:44:10.311] <TB1> INFO: pXar: this is the end, my friend