[06:18:43.772] <TB0> INFO: *** Welcome to pxar ***
[06:18:43.773] <TB0> INFO: *** Today: 2016/06/15
[06:18:44.275] <TB0> INFO: *** Version: 9751-dirty
[06:18:44.275] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C15.dat
[06:18:44.275] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//tbmParameters_C0b.dat
[06:18:44.275] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//defaultMaskFile.dat
[06:18:44.275] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters_C15.dat
[06:18:44.341] <TB0> INFO: clk: 4
[06:18:44.341] <TB0> INFO: ctr: 4
[06:18:44.341] <TB0> INFO: sda: 19
[06:18:44.341] <TB0> INFO: tin: 9
[06:18:44.341] <TB0> INFO: level: 15
[06:18:44.341] <TB0> INFO: triggerdelay: 0
[06:18:44.341] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[06:18:44.341] <TB0> INFO: Log level: INFO
[06:18:44.348] <TB0> INFO: Found DTB DTB_WS6AYH
[06:18:44.360] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[06:18:44.361] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[06:18:44.363] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[06:18:45.894] <TB0> INFO: DUT info:
[06:18:45.894] <TB0> INFO: The DUT currently contains the following objects:
[06:18:45.894] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[06:18:45.894] <TB0> INFO: TBM Core alpha (0): 7 registers set
[06:18:45.894] <TB0> INFO: TBM Core beta (1): 7 registers set
[06:18:45.894] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:18:45.894] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:45.894] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:18:46.294] <TB0> INFO: enter 'restricted' command line mode
[06:18:46.294] <TB0> INFO: enter test to run
[06:18:46.295] <TB0> INFO: test: pretest no parameter change
[06:18:46.295] <TB0> INFO: running: pretest
[06:18:46.299] <TB0> INFO: ----------------------------------------------------------------------
[06:18:46.299] <TB0> INFO: PixTestPretest::programROC()
[06:18:46.300] <TB0> INFO: ----------------------------------------------------------------------
[06:19:04.314] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[06:19:04.314] <TB0> INFO: IA differences per ROC: 21.7 20.1 20.1 18.5 18.5 20.9 20.1 19.3 18.5 19.3 17.7 19.3 20.1 19.3 20.1 16.9
[06:19:04.422] <TB0> INFO: enter test to run
[06:19:04.422] <TB0> INFO: test: pretest no parameter change
[06:19:04.422] <TB0> INFO: running: pretest
[06:19:04.423] <TB0> INFO: ----------------------------------------------------------------------
[06:19:04.423] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[06:19:04.423] <TB0> INFO: ----------------------------------------------------------------------
[06:19:12.321] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 379.4 mA = 23.7125 mA/ROC
[06:19:12.321] <TB0> INFO: i(loss) [mA/ROC]: 18.5 18.5 17.6 18.5 18.5 18.5 19.3 18.5 20.1 18.5 18.5 18.5 18.5 18.5 18.5 18.5
[06:19:12.349] <TB0> INFO: enter test to run
[06:19:12.350] <TB0> INFO: test: pretest no parameter change
[06:19:12.350] <TB0> INFO: running: pretest
[06:19:12.350] <TB0> INFO: ----------------------------------------------------------------------
[06:19:12.350] <TB0> INFO: PixTestPretest::findTiming()
[06:19:12.350] <TB0> INFO: ----------------------------------------------------------------------
[06:19:12.350] <TB0> INFO: PixTestCmd::init()
[06:19:13.308] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!
[06:20:41.009] <TB0> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[06:20:41.009] <TB0> INFO: (success/tries = 100/100), width = 4
[06:20:41.011] <TB0> INFO: enter test to run
[06:20:41.011] <TB0> INFO: test: pretest no parameter change
[06:20:41.011] <TB0> INFO: running: pretest
[06:20:41.012] <TB0> INFO: ----------------------------------------------------------------------
[06:20:41.012] <TB0> INFO: PixTestPretest::findWorkingPixel()
[06:20:41.012] <TB0> INFO: ----------------------------------------------------------------------
[06:20:41.106] <TB0> INFO: Expecting 231680 events.
[06:20:46.884] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[06:20:46.968] <TB0> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[06:20:51.283] <TB0> INFO: 231680 events read in total (9620ms).
[06:20:51.287] <TB0> INFO: Test took 10270ms.
[06:20:51.509] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[06:20:51.569] <TB0> INFO: enter test to run
[06:20:51.569] <TB0> INFO: test: pretest no parameter change
[06:20:51.569] <TB0> INFO: running: pretest
[06:20:51.570] <TB0> INFO: ----------------------------------------------------------------------
[06:20:51.570] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[06:20:51.570] <TB0> INFO: ----------------------------------------------------------------------
[06:20:51.662] <TB0> INFO: Expecting 231680 events.
[06:21:01.869] <TB0> INFO: 231680 events read in total (9651ms).
[06:21:01.872] <TB0> INFO: Test took 10298ms.
[06:21:02.113] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[06:21:02.113] <TB0> INFO: CalDel: 141 152 133 140 152 143 143 153 160 142 130 143 142 131 137 149
[06:21:02.113] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[06:21:02.147] <TB0> INFO: enter test to run
[06:21:02.147] <TB0> INFO: test: pretest no parameter change
[06:21:02.147] <TB0> INFO: running: pretest
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C0.dat
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C1.dat
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C2.dat
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C3.dat
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C4.dat
[06:21:02.147] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C5.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C6.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C7.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C8.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C9.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C10.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C11.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C12.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C13.dat
[06:21:02.148] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C14.dat
[06:21:02.149] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C15.dat
[06:21:02.149] <TB0> INFO: enter test to run
[06:21:02.149] <TB0> INFO: test: fulltest no parameter change
[06:21:02.149] <TB0> INFO: running: fulltest
[06:21:02.149] <TB0> INFO: ######################################################################
[06:21:02.149] <TB0> INFO: PixTestFullTest::doTest()
[06:21:02.149] <TB0> INFO: ######################################################################
[06:21:02.150] <TB0> INFO: ######################################################################
[06:21:02.150] <TB0> INFO: PixTestAlive::doTest()
[06:21:02.150] <TB0> INFO: ######################################################################
[06:21:02.151] <TB0> INFO: ----------------------------------------------------------------------
[06:21:02.151] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:21:02.151] <TB0> INFO: ----------------------------------------------------------------------
[06:21:02.416] <TB0> INFO: Expecting 41600 events.
[06:21:06.227] <TB0> INFO: 41600 events read in total (3255ms).
[06:21:06.227] <TB0> INFO: Test took 4075ms.
[06:21:06.458] <TB0> INFO: PixTestAlive::aliveTest() done
[06:21:06.459] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:21:06.460] <TB0> INFO: ----------------------------------------------------------------------
[06:21:06.460] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:21:06.460] <TB0> INFO: ----------------------------------------------------------------------
[06:21:06.731] <TB0> INFO: Expecting 41600 events.
[06:21:09.678] <TB0> INFO: 41600 events read in total (2391ms).
[06:21:09.679] <TB0> INFO: Test took 3217ms.
[06:21:09.679] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[06:21:09.923] <TB0> INFO: PixTestAlive::maskTest() done
[06:21:09.923] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:21:09.924] <TB0> INFO: ----------------------------------------------------------------------
[06:21:09.924] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:21:09.924] <TB0> INFO: ----------------------------------------------------------------------
[06:21:10.186] <TB0> INFO: Expecting 41600 events.
[06:21:13.950] <TB0> INFO: 41600 events read in total (3208ms).
[06:21:13.951] <TB0> INFO: Test took 4025ms.
[06:21:14.176] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[06:21:14.176] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:21:14.176] <TB0> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[06:21:14.176] <TB0> INFO: Decoding statistics:
[06:21:14.176] <TB0> INFO: General information:
[06:21:14.176] <TB0> INFO: 16bit words read: 0
[06:21:14.177] <TB0> INFO: valid events total: 0
[06:21:14.177] <TB0> INFO: empty events: 0
[06:21:14.177] <TB0> INFO: valid events with pixels: 0
[06:21:14.177] <TB0> INFO: valid pixel hits: 0
[06:21:14.177] <TB0> INFO: Event errors: 0
[06:21:14.177] <TB0> INFO: start marker: 0
[06:21:14.177] <TB0> INFO: stop marker: 0
[06:21:14.177] <TB0> INFO: overflow: 0
[06:21:14.177] <TB0> INFO: invalid 5bit words: 0
[06:21:14.177] <TB0> INFO: invalid XOR eye diagram: 0
[06:21:14.177] <TB0> INFO: frame (failed synchr.): 0
[06:21:14.177] <TB0> INFO: idle data (no TBM trl): 0
[06:21:14.177] <TB0> INFO: no data (only TBM hdr): 0
[06:21:14.177] <TB0> INFO: TBM errors: 0
[06:21:14.177] <TB0> INFO: flawed TBM headers: 0
[06:21:14.177] <TB0> INFO: flawed TBM trailers: 0
[06:21:14.177] <TB0> INFO: event ID mismatches: 0
[06:21:14.177] <TB0> INFO: ROC errors: 0
[06:21:14.177] <TB0> INFO: missing ROC header(s): 0
[06:21:14.177] <TB0> INFO: misplaced readback start: 0
[06:21:14.177] <TB0> INFO: Pixel decoding errors: 0
[06:21:14.177] <TB0> INFO: pixel data incomplete: 0
[06:21:14.177] <TB0> INFO: pixel address: 0
[06:21:14.177] <TB0> INFO: pulse height fill bit: 0
[06:21:14.177] <TB0> INFO: buffer corruption: 0
[06:21:14.188] <TB0> INFO: ######################################################################
[06:21:14.188] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[06:21:14.188] <TB0> INFO: ######################################################################
[06:21:14.190] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[06:21:14.201] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[06:21:14.201] <TB0> INFO: run 1 of 1
[06:21:14.465] <TB0> INFO: Expecting 3120000 events.
[06:21:55.618] <TB0> INFO: 860920 events read in total (40596ms).
[06:22:36.133] <TB0> INFO: 1713540 events read in total (81111ms).
[06:23:17.042] <TB0> INFO: 2578040 events read in total (122021ms).
[06:23:43.177] <TB0> INFO: 3120000 events read in total (148155ms).
[06:23:43.240] <TB0> INFO: Test took 149040ms.
[06:24:09.642] <TB0> INFO: PixTestBBMap::doTest() done, duration: 175 seconds
[06:24:09.642] <TB0> INFO: number of dead bumps (per ROC): 17 0 0 0 0 0 0 0 2 0 0 5 2 1 8 30
[06:24:09.642] <TB0> INFO: separation cut (per ROC): 81 85 83 93 86 98 86 74 80 70 67 77 76 92 78 69
[06:24:09.642] <TB0> INFO: Decoding statistics:
[06:24:09.642] <TB0> INFO: General information:
[06:24:09.642] <TB0> INFO: 16bit words read: 0
[06:24:09.642] <TB0> INFO: valid events total: 0
[06:24:09.643] <TB0> INFO: empty events: 0
[06:24:09.643] <TB0> INFO: valid events with pixels: 0
[06:24:09.643] <TB0> INFO: valid pixel hits: 0
[06:24:09.643] <TB0> INFO: Event errors: 0
[06:24:09.643] <TB0> INFO: start marker: 0
[06:24:09.643] <TB0> INFO: stop marker: 0
[06:24:09.643] <TB0> INFO: overflow: 0
[06:24:09.643] <TB0> INFO: invalid 5bit words: 0
[06:24:09.643] <TB0> INFO: invalid XOR eye diagram: 0
[06:24:09.643] <TB0> INFO: frame (failed synchr.): 0
[06:24:09.643] <TB0> INFO: idle data (no TBM trl): 0
[06:24:09.643] <TB0> INFO: no data (only TBM hdr): 0
[06:24:09.643] <TB0> INFO: TBM errors: 0
[06:24:09.643] <TB0> INFO: flawed TBM headers: 0
[06:24:09.643] <TB0> INFO: flawed TBM trailers: 0
[06:24:09.643] <TB0> INFO: event ID mismatches: 0
[06:24:09.643] <TB0> INFO: ROC errors: 0
[06:24:09.643] <TB0> INFO: missing ROC header(s): 0
[06:24:09.643] <TB0> INFO: misplaced readback start: 0
[06:24:09.643] <TB0> INFO: Pixel decoding errors: 0
[06:24:09.643] <TB0> INFO: pixel data incomplete: 0
[06:24:09.643] <TB0> INFO: pixel address: 0
[06:24:09.643] <TB0> INFO: pulse height fill bit: 0
[06:24:09.643] <TB0> INFO: buffer corruption: 0
[06:24:09.755] <TB0> INFO: ######################################################################
[06:24:09.755] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:24:09.755] <TB0> INFO: ######################################################################
[06:24:09.755] <TB0> INFO: ----------------------------------------------------------------------
[06:24:09.755] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:24:09.755] <TB0> INFO: ----------------------------------------------------------------------
[06:24:09.755] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[06:24:09.767] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[06:24:09.768] <TB0> INFO: run 1 of 1
[06:24:10.069] <TB0> INFO: Expecting 26208000 events.
[06:24:44.731] <TB0> INFO: 861700 events read in total (34105ms).
[06:25:17.168] <TB0> INFO: 1712300 events read in total (66542ms).
[06:25:49.599] <TB0> INFO: 2561100 events read in total (98973ms).
[06:26:22.341] <TB0> INFO: 3407900 events read in total (131715ms).
[06:26:54.686] <TB0> INFO: 4252200 events read in total (164060ms).
[06:27:26.884] <TB0> INFO: 5099750 events read in total (196258ms).
[06:27:59.185] <TB0> INFO: 5941850 events read in total (228559ms).
[06:28:31.499] <TB0> INFO: 6784550 events read in total (260873ms).
[06:29:03.901] <TB0> INFO: 7627500 events read in total (293275ms).
[06:29:36.088] <TB0> INFO: 8466000 events read in total (325462ms).
[06:30:08.201] <TB0> INFO: 9307800 events read in total (357575ms).
[06:30:40.619] <TB0> INFO: 10147700 events read in total (389993ms).
[06:31:12.592] <TB0> INFO: 10986600 events read in total (421966ms).
[06:31:44.854] <TB0> INFO: 11827850 events read in total (454228ms).
[06:32:17.221] <TB0> INFO: 12668050 events read in total (486595ms).
[06:32:49.863] <TB0> INFO: 13500500 events read in total (519237ms).
[06:33:22.308] <TB0> INFO: 14334100 events read in total (551682ms).
[06:33:54.502] <TB0> INFO: 15164300 events read in total (583876ms).
[06:34:26.722] <TB0> INFO: 15992600 events read in total (616096ms).
[06:34:58.709] <TB0> INFO: 16820750 events read in total (648083ms).
[06:35:30.698] <TB0> INFO: 17649150 events read in total (680072ms).
[06:36:02.902] <TB0> INFO: 18475550 events read in total (712276ms).
[06:36:34.952] <TB0> INFO: 19303000 events read in total (744326ms).
[06:37:06.817] <TB0> INFO: 20130000 events read in total (776191ms).
[06:37:38.787] <TB0> INFO: 20956550 events read in total (808161ms).
[06:38:10.736] <TB0> INFO: 21783550 events read in total (840110ms).
[06:38:42.821] <TB0> INFO: 22608650 events read in total (872195ms).
[06:39:14.772] <TB0> INFO: 23435750 events read in total (904146ms).
[06:39:46.686] <TB0> INFO: 24264350 events read in total (936060ms).
[06:40:18.652] <TB0> INFO: 25090350 events read in total (968026ms).
[06:40:50.963] <TB0> INFO: 25924000 events read in total (1000337ms).
[06:41:01.800] <TB0> INFO: 26208000 events read in total (1011174ms).
[06:41:01.832] <TB0> INFO: Test took 1012064ms.
[06:41:02.110] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:03.569] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:05.200] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:06.603] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:08.006] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:09.687] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:11.290] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:12.844] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:14.301] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:15.685] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:17.108] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:18.583] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:19.997] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:21.400] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:22.775] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:24.199] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:41:25.655] <TB0> INFO: PixTestScurves::scurves() done
[06:41:25.655] <TB0> INFO: Vcal mean: 95.42 82.78 84.16 88.71 83.07 93.47 84.20 78.05 86.00 70.10 67.88 81.19 82.40 90.30 79.82 82.24
[06:41:25.655] <TB0> INFO: Vcal RMS: 5.50 4.48 4.68 5.60 4.87 6.48 5.13 4.42 5.26 4.84 4.58 4.58 4.96 5.31 3.99 4.87
[06:41:25.655] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1035 seconds
[06:41:25.655] <TB0> INFO: Decoding statistics:
[06:41:25.655] <TB0> INFO: General information:
[06:41:25.655] <TB0> INFO: 16bit words read: 0
[06:41:25.655] <TB0> INFO: valid events total: 0
[06:41:25.655] <TB0> INFO: empty events: 0
[06:41:25.655] <TB0> INFO: valid events with pixels: 0
[06:41:25.655] <TB0> INFO: valid pixel hits: 0
[06:41:25.655] <TB0> INFO: Event errors: 0
[06:41:25.655] <TB0> INFO: start marker: 0
[06:41:25.655] <TB0> INFO: stop marker: 0
[06:41:25.655] <TB0> INFO: overflow: 0
[06:41:25.655] <TB0> INFO: invalid 5bit words: 0
[06:41:25.655] <TB0> INFO: invalid XOR eye diagram: 0
[06:41:25.655] <TB0> INFO: frame (failed synchr.): 0
[06:41:25.655] <TB0> INFO: idle data (no TBM trl): 0
[06:41:25.655] <TB0> INFO: no data (only TBM hdr): 0
[06:41:25.655] <TB0> INFO: TBM errors: 0
[06:41:25.655] <TB0> INFO: flawed TBM headers: 0
[06:41:25.655] <TB0> INFO: flawed TBM trailers: 0
[06:41:25.655] <TB0> INFO: event ID mismatches: 0
[06:41:25.655] <TB0> INFO: ROC errors: 0
[06:41:25.655] <TB0> INFO: missing ROC header(s): 0
[06:41:25.655] <TB0> INFO: misplaced readback start: 0
[06:41:25.655] <TB0> INFO: Pixel decoding errors: 0
[06:41:25.655] <TB0> INFO: pixel data incomplete: 0
[06:41:25.655] <TB0> INFO: pixel address: 0
[06:41:25.655] <TB0> INFO: pulse height fill bit: 0
[06:41:25.655] <TB0> INFO: buffer corruption: 0
[06:41:25.731] <TB0> INFO: ######################################################################
[06:41:25.731] <TB0> INFO: PixTestTrim::doTest()
[06:41:25.731] <TB0> INFO: ######################################################################
[06:41:25.732] <TB0> INFO: ----------------------------------------------------------------------
[06:41:25.732] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[06:41:25.732] <TB0> INFO: ----------------------------------------------------------------------
[06:41:25.815] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[06:41:25.815] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:41:25.824] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:41:25.824] <TB0> INFO: run 1 of 1
[06:41:26.089] <TB0> INFO: Expecting 6281600 events.
[06:42:05.324] <TB0> INFO: 1065900 events read in total (38677ms).
[06:42:44.019] <TB0> INFO: 2123860 events read in total (77372ms).
[06:43:22.866] <TB0> INFO: 3176450 events read in total (116219ms).
[06:44:01.885] <TB0> INFO: 4236500 events read in total (155238ms).
[06:44:40.669] <TB0> INFO: 5298280 events read in total (194023ms).
[06:45:16.154] <TB0> INFO: 6281600 events read in total (229507ms).
[06:45:16.191] <TB0> INFO: Test took 230367ms.
[06:45:35.471] <TB0> INFO: ROC 0 VthrComp = 98
[06:45:35.471] <TB0> INFO: ROC 1 VthrComp = 88
[06:45:35.471] <TB0> INFO: ROC 2 VthrComp = 88
[06:45:35.471] <TB0> INFO: ROC 3 VthrComp = 91
[06:45:35.471] <TB0> INFO: ROC 4 VthrComp = 85
[06:45:35.471] <TB0> INFO: ROC 5 VthrComp = 90
[06:45:35.471] <TB0> INFO: ROC 6 VthrComp = 87
[06:45:35.472] <TB0> INFO: ROC 7 VthrComp = 80
[06:45:35.472] <TB0> INFO: ROC 8 VthrComp = 89
[06:45:35.472] <TB0> INFO: ROC 9 VthrComp = 76
[06:45:35.472] <TB0> INFO: ROC 10 VthrComp = 75
[06:45:35.472] <TB0> INFO: ROC 11 VthrComp = 86
[06:45:35.472] <TB0> INFO: ROC 12 VthrComp = 87
[06:45:35.472] <TB0> INFO: ROC 13 VthrComp = 99
[06:45:35.472] <TB0> INFO: ROC 14 VthrComp = 86
[06:45:35.473] <TB0> INFO: ROC 15 VthrComp = 86
[06:45:35.473] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[06:45:35.473] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:45:35.481] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:45:35.481] <TB0> INFO: run 1 of 1
[06:45:35.742] <TB0> INFO: Expecting 6281600 events.
[06:46:11.570] <TB0> INFO: 754920 events read in total (35272ms).
[06:46:46.399] <TB0> INFO: 1508270 events read in total (70101ms).
[06:47:21.185] <TB0> INFO: 2261880 events read in total (104887ms).
[06:47:56.519] <TB0> INFO: 3015620 events read in total (140221ms).
[06:48:31.440] <TB0> INFO: 3764810 events read in total (175142ms).
[06:49:06.501] <TB0> INFO: 4510150 events read in total (210203ms).
[06:49:41.481] <TB0> INFO: 5254110 events read in total (245183ms).
[06:50:16.358] <TB0> INFO: 5997570 events read in total (280060ms).
[06:50:30.075] <TB0> INFO: 6281600 events read in total (293777ms).
[06:50:30.122] <TB0> INFO: Test took 294640ms.
[06:50:53.759] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 58.5444 for pixel 0/2 mean/min/max = 45.1404/31.7224/58.5584
[06:50:53.759] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 56.9089 for pixel 15/75 mean/min/max = 44.8812/32.7608/57.0015
[06:50:53.760] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 57.3891 for pixel 51/8 mean/min/max = 45.0088/32.5592/57.4584
[06:50:53.760] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 59.615 for pixel 49/63 mean/min/max = 46.2977/32.93/59.6654
[06:50:53.760] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 57.8196 for pixel 0/77 mean/min/max = 45.3061/32.7447/57.8675
[06:50:53.760] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 65.0387 for pixel 23/75 mean/min/max = 47.8112/30.5241/65.0984
[06:50:53.761] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 58.0768 for pixel 36/79 mean/min/max = 45.1513/31.9082/58.3945
[06:50:53.761] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 58.7645 for pixel 15/3 mean/min/max = 45.8877/32.9231/58.8524
[06:50:53.761] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 58.918 for pixel 27/53 mean/min/max = 46.0437/33.1245/58.963
[06:50:53.761] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 57.348 for pixel 51/27 mean/min/max = 46.016/34.6279/57.4041
[06:50:53.762] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 57.3273 for pixel 0/78 mean/min/max = 45.7049/33.9278/57.482
[06:50:53.762] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 57.242 for pixel 23/79 mean/min/max = 44.5914/31.9237/57.2592
[06:50:53.762] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 59.1184 for pixel 17/11 mean/min/max = 45.5428/31.7835/59.302
[06:50:53.762] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 56.5106 for pixel 23/23 mean/min/max = 44.0205/31.3332/56.7078
[06:50:53.763] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 55.7164 for pixel 17/1 mean/min/max = 44.0179/32.1963/55.8394
[06:50:53.763] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 59.0629 for pixel 15/46 mean/min/max = 45.4045/31.7323/59.0766
[06:50:53.763] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[06:50:53.854] <TB0> INFO: Expecting 514560 events.
[06:51:06.601] <TB0> INFO: 514560 events read in total (12191ms).
[06:51:06.606] <TB0> INFO: Expecting 514560 events.
[06:51:19.226] <TB0> INFO: 514560 events read in total (12198ms).
[06:51:19.233] <TB0> INFO: Expecting 514560 events.
[06:51:31.975] <TB0> INFO: 514560 events read in total (12320ms).
[06:51:31.982] <TB0> INFO: Expecting 514560 events.
[06:51:44.700] <TB0> INFO: 514560 events read in total (12294ms).
[06:51:44.709] <TB0> INFO: Expecting 514560 events.
[06:51:57.507] <TB0> INFO: 514560 events read in total (12391ms).
[06:51:57.518] <TB0> INFO: Expecting 514560 events.
[06:52:10.370] <TB0> INFO: 514560 events read in total (12431ms).
[06:52:10.385] <TB0> INFO: Expecting 514560 events.
[06:52:23.120] <TB0> INFO: 514560 events read in total (12332ms).
[06:52:23.134] <TB0> INFO: Expecting 514560 events.
[06:52:35.949] <TB0> INFO: 514560 events read in total (12402ms).
[06:52:35.965] <TB0> INFO: Expecting 514560 events.
[06:52:48.910] <TB0> INFO: 514560 events read in total (12535ms).
[06:52:48.929] <TB0> INFO: Expecting 514560 events.
[06:53:01.748] <TB0> INFO: 514560 events read in total (12417ms).
[06:53:01.770] <TB0> INFO: Expecting 514560 events.
[06:53:14.514] <TB0> INFO: 514560 events read in total (12342ms).
[06:53:14.537] <TB0> INFO: Expecting 514560 events.
[06:53:27.159] <TB0> INFO: 514560 events read in total (12215ms).
[06:53:27.185] <TB0> INFO: Expecting 514560 events.
[06:53:39.862] <TB0> INFO: 514560 events read in total (12275ms).
[06:53:39.891] <TB0> INFO: Expecting 514560 events.
[06:53:52.558] <TB0> INFO: 514560 events read in total (12266ms).
[06:53:52.587] <TB0> INFO: Expecting 514560 events.
[06:54:05.372] <TB0> INFO: 514560 events read in total (12383ms).
[06:54:05.416] <TB0> INFO: Expecting 514560 events.
[06:54:18.136] <TB0> INFO: 514560 events read in total (12318ms).
[06:54:18.170] <TB0> INFO: Test took 204407ms.
[06:54:19.141] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[06:54:19.149] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:54:19.149] <TB0> INFO: run 1 of 1
[06:54:19.424] <TB0> INFO: Expecting 6281600 events.
[06:54:55.210] <TB0> INFO: 742050 events read in total (35229ms).
[06:55:29.939] <TB0> INFO: 1482590 events read in total (69958ms).
[06:56:04.805] <TB0> INFO: 2223870 events read in total (104824ms).
[06:56:39.673] <TB0> INFO: 2965580 events read in total (139692ms).
[06:57:14.319] <TB0> INFO: 3702360 events read in total (174338ms).
[06:57:48.797] <TB0> INFO: 4435300 events read in total (208816ms).
[06:58:23.600] <TB0> INFO: 5166650 events read in total (243619ms).
[06:58:57.932] <TB0> INFO: 5896960 events read in total (277951ms).
[06:59:16.204] <TB0> INFO: 6281600 events read in total (296223ms).
[06:59:16.249] <TB0> INFO: Test took 297100ms.
[06:59:40.410] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.008644 .. 52.943655
[06:59:40.513] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 62 (-1/-1) hits flags = 528 (plus default)
[06:59:40.521] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:59:40.521] <TB0> INFO: run 1 of 1
[06:59:40.807] <TB0> INFO: Expecting 2620800 events.
[07:00:18.966] <TB0> INFO: 917730 events read in total (37599ms).
[07:00:56.188] <TB0> INFO: 1833920 events read in total (74821ms).
[07:01:28.335] <TB0> INFO: 2620800 events read in total (106968ms).
[07:01:28.354] <TB0> INFO: Test took 107832ms.
[07:01:44.371] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 16.919341 .. 47.174143
[07:01:44.455] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 57 (-1/-1) hits flags = 528 (plus default)
[07:01:44.464] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[07:01:44.464] <TB0> INFO: run 1 of 1
[07:01:44.757] <TB0> INFO: Expecting 2163200 events.
[07:02:22.727] <TB0> INFO: 917700 events read in total (37414ms).
[07:03:00.052] <TB0> INFO: 1833420 events read in total (74739ms).
[07:03:14.063] <TB0> INFO: 2163200 events read in total (88750ms).
[07:03:14.080] <TB0> INFO: Test took 89616ms.
[07:03:27.700] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 22.501161 .. 44.314410
[07:03:27.777] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 12 .. 54 (-1/-1) hits flags = 528 (plus default)
[07:03:27.785] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[07:03:27.785] <TB0> INFO: run 1 of 1
[07:03:28.047] <TB0> INFO: Expecting 1788800 events.
[07:04:06.167] <TB0> INFO: 906830 events read in total (37564ms).
[07:04:42.703] <TB0> INFO: 1788800 events read in total (74100ms).
[07:04:42.722] <TB0> INFO: Test took 74937ms.
[07:04:56.191] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 25.362051 .. 44.314410
[07:04:56.276] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 15 .. 54 (-1/-1) hits flags = 528 (plus default)
[07:04:56.284] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[07:04:56.284] <TB0> INFO: run 1 of 1
[07:04:56.557] <TB0> INFO: Expecting 1664000 events.
[07:05:34.583] <TB0> INFO: 885730 events read in total (37470ms).
[07:06:07.577] <TB0> INFO: 1664000 events read in total (70464ms).
[07:06:07.588] <TB0> INFO: Test took 71304ms.
[07:06:20.800] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[07:06:20.800] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[07:06:20.809] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[07:06:20.809] <TB0> INFO: run 1 of 1
[07:06:21.075] <TB0> INFO: Expecting 1705600 events.
[07:06:58.866] <TB0> INFO: 879520 events read in total (37235ms).
[07:07:33.486] <TB0> INFO: 1705600 events read in total (71855ms).
[07:07:33.503] <TB0> INFO: Test took 72693ms.
[07:07:47.067] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C0.dat
[07:07:47.067] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C1.dat
[07:07:47.067] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C2.dat
[07:07:47.067] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C3.dat
[07:07:47.068] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C4.dat
[07:07:47.068] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C5.dat
[07:07:47.068] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C6.dat
[07:07:47.068] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C7.dat
[07:07:47.068] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C8.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C9.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C10.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C11.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C12.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C13.dat
[07:07:47.069] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C14.dat
[07:07:47.070] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C15.dat
[07:07:47.070] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C0.dat
[07:07:47.081] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C1.dat
[07:07:47.092] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C2.dat
[07:07:47.102] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C3.dat
[07:07:47.108] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C4.dat
[07:07:47.115] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C5.dat
[07:07:47.121] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C6.dat
[07:07:47.128] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C7.dat
[07:07:47.135] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C8.dat
[07:07:47.141] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C9.dat
[07:07:47.148] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C10.dat
[07:07:47.155] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C11.dat
[07:07:47.161] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C12.dat
[07:07:47.168] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C13.dat
[07:07:47.175] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C14.dat
[07:07:47.181] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C15.dat
[07:07:47.188] <TB0> INFO: PixTestTrim::trimTest() done
[07:07:47.188] <TB0> INFO: vtrim: 94 85 82 89 90 109 85 100 101 86 84 91 109 90 90 99
[07:07:47.188] <TB0> INFO: vthrcomp: 98 88 88 91 85 90 87 80 89 76 75 86 87 99 86 86
[07:07:47.188] <TB0> INFO: vcal mean: 34.98 34.97 34.98 34.95 34.98 34.98 34.97 35.01 35.01 35.02 34.98 34.95 34.99 34.93 34.97 34.99
[07:07:47.188] <TB0> INFO: vcal RMS: 0.88 0.80 0.77 0.88 0.84 0.94 0.77 0.83 0.83 0.76 0.72 0.94 0.85 0.88 0.80 0.87
[07:07:47.188] <TB0> INFO: bits mean: 9.14 9.83 8.84 9.43 9.10 9.33 9.30 9.22 9.22 8.29 8.51 9.52 9.85 10.08 9.71 9.59
[07:07:47.188] <TB0> INFO: bits RMS: 2.94 2.49 2.92 2.63 2.84 2.74 2.79 2.70 2.68 2.77 2.80 2.84 2.55 2.63 2.67 2.71
[07:07:47.193] <TB0> INFO: ----------------------------------------------------------------------
[07:07:47.193] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[07:07:47.193] <TB0> INFO: ----------------------------------------------------------------------
[07:07:47.195] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[07:07:47.204] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:07:47.204] <TB0> INFO: run 1 of 1
[07:07:47.497] <TB0> INFO: Expecting 4160000 events.
[07:08:28.904] <TB0> INFO: 899125 events read in total (40851ms).
[07:09:09.295] <TB0> INFO: 1790450 events read in total (81242ms).
[07:09:49.979] <TB0> INFO: 2675535 events read in total (121926ms).
[07:10:30.276] <TB0> INFO: 3556650 events read in total (162223ms).
[07:10:58.161] <TB0> INFO: 4160000 events read in total (190108ms).
[07:10:58.204] <TB0> INFO: Test took 191000ms.
[07:11:27.739] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 162 (-1/-1) hits flags = 528 (plus default)
[07:11:27.747] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:11:27.747] <TB0> INFO: run 1 of 1
[07:11:28.006] <TB0> INFO: Expecting 3390400 events.
[07:12:10.223] <TB0> INFO: 937805 events read in total (41661ms).
[07:12:51.690] <TB0> INFO: 1864675 events read in total (83128ms).
[07:13:32.747] <TB0> INFO: 2781805 events read in total (124185ms).
[07:13:59.924] <TB0> INFO: 3390400 events read in total (151362ms).
[07:13:59.974] <TB0> INFO: Test took 152227ms.
[07:14:24.795] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 151 (-1/-1) hits flags = 528 (plus default)
[07:14:24.803] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:14:24.803] <TB0> INFO: run 1 of 1
[07:14:25.065] <TB0> INFO: Expecting 3161600 events.
[07:15:07.803] <TB0> INFO: 964960 events read in total (42181ms).
[07:15:49.396] <TB0> INFO: 1916160 events read in total (83774ms).
[07:16:30.852] <TB0> INFO: 2857140 events read in total (125230ms).
[07:16:44.273] <TB0> INFO: 3161600 events read in total (138651ms).
[07:16:44.304] <TB0> INFO: Test took 139501ms.
[07:17:10.387] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 152 (-1/-1) hits flags = 528 (plus default)
[07:17:10.396] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:17:10.396] <TB0> INFO: run 1 of 1
[07:17:10.684] <TB0> INFO: Expecting 3182400 events.
[07:17:53.179] <TB0> INFO: 961765 events read in total (41939ms).
[07:18:34.468] <TB0> INFO: 1910545 events read in total (83229ms).
[07:19:15.732] <TB0> INFO: 2849615 events read in total (124492ms).
[07:19:30.638] <TB0> INFO: 3182400 events read in total (139398ms).
[07:19:30.673] <TB0> INFO: Test took 140277ms.
[07:19:55.979] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 152 (-1/-1) hits flags = 528 (plus default)
[07:19:55.991] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:19:55.991] <TB0> INFO: run 1 of 1
[07:19:56.285] <TB0> INFO: Expecting 3182400 events.
[07:20:38.841] <TB0> INFO: 961395 events read in total (42000ms).
[07:21:20.284] <TB0> INFO: 1909660 events read in total (83443ms).
[07:22:01.888] <TB0> INFO: 2848580 events read in total (125048ms).
[07:22:16.655] <TB0> INFO: 3182400 events read in total (139814ms).
[07:22:16.689] <TB0> INFO: Test took 140698ms.
[07:22:41.048] <TB0> INFO: PixTestTrim::trimBitTest() done
[07:22:41.049] <TB0> INFO: PixTestTrim::doTest() done, duration: 2475 seconds
[07:22:41.049] <TB0> INFO: Decoding statistics:
[07:22:41.049] <TB0> INFO: General information:
[07:22:41.049] <TB0> INFO: 16bit words read: 0
[07:22:41.049] <TB0> INFO: valid events total: 0
[07:22:41.049] <TB0> INFO: empty events: 0
[07:22:41.049] <TB0> INFO: valid events with pixels: 0
[07:22:41.049] <TB0> INFO: valid pixel hits: 0
[07:22:41.049] <TB0> INFO: Event errors: 0
[07:22:41.049] <TB0> INFO: start marker: 0
[07:22:41.049] <TB0> INFO: stop marker: 0
[07:22:41.049] <TB0> INFO: overflow: 0
[07:22:41.049] <TB0> INFO: invalid 5bit words: 0
[07:22:41.049] <TB0> INFO: invalid XOR eye diagram: 0
[07:22:41.049] <TB0> INFO: frame (failed synchr.): 0
[07:22:41.049] <TB0> INFO: idle data (no TBM trl): 0
[07:22:41.049] <TB0> INFO: no data (only TBM hdr): 0
[07:22:41.049] <TB0> INFO: TBM errors: 0
[07:22:41.049] <TB0> INFO: flawed TBM headers: 0
[07:22:41.049] <TB0> INFO: flawed TBM trailers: 0
[07:22:41.049] <TB0> INFO: event ID mismatches: 0
[07:22:41.049] <TB0> INFO: ROC errors: 0
[07:22:41.049] <TB0> INFO: missing ROC header(s): 0
[07:22:41.049] <TB0> INFO: misplaced readback start: 0
[07:22:41.049] <TB0> INFO: Pixel decoding errors: 0
[07:22:41.049] <TB0> INFO: pixel data incomplete: 0
[07:22:41.049] <TB0> INFO: pixel address: 0
[07:22:41.049] <TB0> INFO: pulse height fill bit: 0
[07:22:41.049] <TB0> INFO: buffer corruption: 0
[07:22:41.754] <TB0> INFO: ######################################################################
[07:22:41.754] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[07:22:41.754] <TB0> INFO: ######################################################################
[07:22:42.050] <TB0> INFO: Expecting 41600 events.
[07:22:45.806] <TB0> INFO: 41600 events read in total (3200ms).
[07:22:45.807] <TB0> INFO: Test took 4051ms.
[07:22:46.272] <TB0> INFO: Expecting 41600 events.
[07:22:50.076] <TB0> INFO: 41600 events read in total (3248ms).
[07:22:50.077] <TB0> INFO: Test took 4066ms.
[07:22:50.361] <TB0> INFO: Expecting 41600 events.
[07:22:54.221] <TB0> INFO: 41600 events read in total (3304ms).
[07:22:54.222] <TB0> INFO: Test took 4124ms.
[07:22:54.477] <TB0> INFO: Expecting 2560 events.
[07:22:55.334] <TB0> INFO: 2560 events read in total (301ms).
[07:22:55.334] <TB0> INFO: Test took 1099ms.
[07:22:55.639] <TB0> INFO: Expecting 2560 events.
[07:22:56.492] <TB0> INFO: 2560 events read in total (297ms).
[07:22:56.493] <TB0> INFO: Test took 1158ms.
[07:22:56.797] <TB0> INFO: Expecting 2560 events.
[07:22:57.653] <TB0> INFO: 2560 events read in total (299ms).
[07:22:57.653] <TB0> INFO: Test took 1158ms.
[07:22:57.958] <TB0> INFO: Expecting 2560 events.
[07:22:58.816] <TB0> INFO: 2560 events read in total (301ms).
[07:22:58.816] <TB0> INFO: Test took 1163ms.
[07:22:59.121] <TB0> INFO: Expecting 2560 events.
[07:22:59.973] <TB0> INFO: 2560 events read in total (296ms).
[07:22:59.974] <TB0> INFO: Test took 1157ms.
[07:23:00.279] <TB0> INFO: Expecting 2560 events.
[07:23:01.133] <TB0> INFO: 2560 events read in total (298ms).
[07:23:01.134] <TB0> INFO: Test took 1160ms.
[07:23:01.439] <TB0> INFO: Expecting 2560 events.
[07:23:02.291] <TB0> INFO: 2560 events read in total (296ms).
[07:23:02.291] <TB0> INFO: Test took 1157ms.
[07:23:02.596] <TB0> INFO: Expecting 2560 events.
[07:23:03.449] <TB0> INFO: 2560 events read in total (297ms).
[07:23:03.449] <TB0> INFO: Test took 1157ms.
[07:23:03.755] <TB0> INFO: Expecting 2560 events.
[07:23:04.608] <TB0> INFO: 2560 events read in total (297ms).
[07:23:04.609] <TB0> INFO: Test took 1159ms.
[07:23:04.914] <TB0> INFO: Expecting 2560 events.
[07:23:05.766] <TB0> INFO: 2560 events read in total (296ms).
[07:23:05.767] <TB0> INFO: Test took 1158ms.
[07:23:06.072] <TB0> INFO: Expecting 2560 events.
[07:23:06.925] <TB0> INFO: 2560 events read in total (297ms).
[07:23:06.926] <TB0> INFO: Test took 1159ms.
[07:23:07.231] <TB0> INFO: Expecting 2560 events.
[07:23:08.082] <TB0> INFO: 2560 events read in total (295ms).
[07:23:08.082] <TB0> INFO: Test took 1156ms.
[07:23:08.391] <TB0> INFO: Expecting 2560 events.
[07:23:09.246] <TB0> INFO: 2560 events read in total (299ms).
[07:23:09.246] <TB0> INFO: Test took 1163ms.
[07:23:09.551] <TB0> INFO: Expecting 2560 events.
[07:23:10.405] <TB0> INFO: 2560 events read in total (298ms).
[07:23:10.405] <TB0> INFO: Test took 1158ms.
[07:23:10.709] <TB0> INFO: Expecting 2560 events.
[07:23:11.562] <TB0> INFO: 2560 events read in total (296ms).
[07:23:11.562] <TB0> INFO: Test took 1156ms.
[07:23:11.867] <TB0> INFO: Expecting 2560 events.
[07:23:12.723] <TB0> INFO: 2560 events read in total (300ms).
[07:23:12.723] <TB0> INFO: Test took 1160ms.
[07:23:12.726] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:23:13.029] <TB0> INFO: Expecting 655360 events.
[07:23:30.166] <TB0> INFO: 655360 events read in total (16580ms).
[07:23:30.179] <TB0> INFO: Expecting 655360 events.
[07:23:47.093] <TB0> INFO: 655360 events read in total (16513ms).
[07:23:47.105] <TB0> INFO: Expecting 655360 events.
[07:24:03.900] <TB0> INFO: 655360 events read in total (16393ms).
[07:24:03.916] <TB0> INFO: Expecting 655360 events.
[07:24:20.894] <TB0> INFO: 655360 events read in total (16576ms).
[07:24:20.922] <TB0> INFO: Expecting 655360 events.
[07:24:37.936] <TB0> INFO: 655360 events read in total (16612ms).
[07:24:37.960] <TB0> INFO: Expecting 655360 events.
[07:24:54.620] <TB0> INFO: 655360 events read in total (16258ms).
[07:24:54.658] <TB0> INFO: Expecting 655360 events.
[07:25:11.227] <TB0> INFO: 655360 events read in total (16167ms).
[07:25:11.256] <TB0> INFO: Expecting 655360 events.
[07:25:27.901] <TB0> INFO: 655360 events read in total (16243ms).
[07:25:27.933] <TB0> INFO: Expecting 655360 events.
[07:25:44.436] <TB0> INFO: 655360 events read in total (16101ms).
[07:25:44.473] <TB0> INFO: Expecting 655360 events.
[07:26:01.023] <TB0> INFO: 655360 events read in total (16148ms).
[07:26:01.063] <TB0> INFO: Expecting 655360 events.
[07:26:17.723] <TB0> INFO: 655360 events read in total (16258ms).
[07:26:17.765] <TB0> INFO: Expecting 655360 events.
[07:26:34.326] <TB0> INFO: 655360 events read in total (16160ms).
[07:26:34.373] <TB0> INFO: Expecting 655360 events.
[07:26:50.984] <TB0> INFO: 655360 events read in total (16210ms).
[07:26:51.055] <TB0> INFO: Expecting 655360 events.
[07:27:07.602] <TB0> INFO: 655360 events read in total (16145ms).
[07:27:07.654] <TB0> INFO: Expecting 655360 events.
[07:27:24.323] <TB0> INFO: 655360 events read in total (16268ms).
[07:27:24.406] <TB0> INFO: Expecting 655360 events.
[07:27:41.174] <TB0> INFO: 655360 events read in total (16366ms).
[07:27:41.233] <TB0> INFO: Test took 268507ms.
[07:27:41.311] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:27:41.541] <TB0> INFO: Expecting 655360 events.
[07:27:58.126] <TB0> INFO: 655360 events read in total (16029ms).
[07:27:58.134] <TB0> INFO: Expecting 655360 events.
[07:28:14.762] <TB0> INFO: 655360 events read in total (16226ms).
[07:28:14.777] <TB0> INFO: Expecting 655360 events.
[07:28:31.383] <TB0> INFO: 655360 events read in total (16199ms).
[07:28:31.399] <TB0> INFO: Expecting 655360 events.
[07:28:47.952] <TB0> INFO: 655360 events read in total (16152ms).
[07:28:47.971] <TB0> INFO: Expecting 655360 events.
[07:29:04.515] <TB0> INFO: 655360 events read in total (16142ms).
[07:29:04.537] <TB0> INFO: Expecting 655360 events.
[07:29:21.112] <TB0> INFO: 655360 events read in total (16173ms).
[07:29:21.139] <TB0> INFO: Expecting 655360 events.
[07:29:37.699] <TB0> INFO: 655360 events read in total (16158ms).
[07:29:37.730] <TB0> INFO: Expecting 655360 events.
[07:29:54.209] <TB0> INFO: 655360 events read in total (16078ms).
[07:29:54.249] <TB0> INFO: Expecting 655360 events.
[07:30:10.975] <TB0> INFO: 655360 events read in total (16325ms).
[07:30:11.015] <TB0> INFO: Expecting 655360 events.
[07:30:27.788] <TB0> INFO: 655360 events read in total (16372ms).
[07:30:27.837] <TB0> INFO: Expecting 655360 events.
[07:30:44.392] <TB0> INFO: 655360 events read in total (16153ms).
[07:30:44.439] <TB0> INFO: Expecting 655360 events.
[07:31:00.949] <TB0> INFO: 655360 events read in total (16109ms).
[07:31:00.997] <TB0> INFO: Expecting 655360 events.
[07:31:17.338] <TB0> INFO: 655360 events read in total (15939ms).
[07:31:17.392] <TB0> INFO: Expecting 655360 events.
[07:31:33.978] <TB0> INFO: 655360 events read in total (16185ms).
[07:31:34.031] <TB0> INFO: Expecting 655360 events.
[07:31:50.584] <TB0> INFO: 655360 events read in total (16152ms).
[07:31:50.641] <TB0> INFO: Expecting 655360 events.
[07:32:07.333] <TB0> INFO: 655360 events read in total (16290ms).
[07:32:07.397] <TB0> INFO: Test took 266086ms.
[07:32:07.594] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.602] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.610] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.617] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.625] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.632] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.640] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[07:32:07.647] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[07:32:07.655] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[07:32:07.662] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[07:32:07.670] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.678] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.686] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.693] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.700] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.707] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.714] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.721] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.728] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.734] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[07:32:07.741] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[07:32:07.748] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[07:32:07.754] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:32:07.790] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C0.dat
[07:32:07.790] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C1.dat
[07:32:07.790] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C2.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C3.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C4.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C5.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C6.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C7.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C8.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C9.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C10.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C11.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C12.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C13.dat
[07:32:07.791] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C14.dat
[07:32:07.792] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C15.dat
[07:32:08.062] <TB0> INFO: Expecting 41600 events.
[07:32:11.544] <TB0> INFO: 41600 events read in total (2926ms).
[07:32:11.544] <TB0> INFO: Test took 3750ms.
[07:32:11.993] <TB0> INFO: Expecting 41600 events.
[07:32:15.526] <TB0> INFO: 41600 events read in total (2977ms).
[07:32:15.527] <TB0> INFO: Test took 3806ms.
[07:32:15.996] <TB0> INFO: Expecting 41600 events.
[07:32:19.476] <TB0> INFO: 41600 events read in total (2924ms).
[07:32:19.477] <TB0> INFO: Test took 3774ms.
[07:32:19.662] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:19.749] <TB0> INFO: Expecting 2560 events.
[07:32:20.604] <TB0> INFO: 2560 events read in total (298ms).
[07:32:20.604] <TB0> INFO: Test took 943ms.
[07:32:20.606] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:20.911] <TB0> INFO: Expecting 2560 events.
[07:32:21.766] <TB0> INFO: 2560 events read in total (299ms).
[07:32:21.766] <TB0> INFO: Test took 1160ms.
[07:32:21.768] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:22.072] <TB0> INFO: Expecting 2560 events.
[07:32:22.925] <TB0> INFO: 2560 events read in total (297ms).
[07:32:22.925] <TB0> INFO: Test took 1157ms.
[07:32:22.927] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:23.231] <TB0> INFO: Expecting 2560 events.
[07:32:24.084] <TB0> INFO: 2560 events read in total (297ms).
[07:32:24.085] <TB0> INFO: Test took 1158ms.
[07:32:24.086] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:24.390] <TB0> INFO: Expecting 2560 events.
[07:32:25.244] <TB0> INFO: 2560 events read in total (298ms).
[07:32:25.244] <TB0> INFO: Test took 1158ms.
[07:32:25.246] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:25.549] <TB0> INFO: Expecting 2560 events.
[07:32:26.404] <TB0> INFO: 2560 events read in total (299ms).
[07:32:26.404] <TB0> INFO: Test took 1158ms.
[07:32:26.407] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:26.709] <TB0> INFO: Expecting 2560 events.
[07:32:27.562] <TB0> INFO: 2560 events read in total (297ms).
[07:32:27.562] <TB0> INFO: Test took 1155ms.
[07:32:27.564] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:27.867] <TB0> INFO: Expecting 2560 events.
[07:32:28.719] <TB0> INFO: 2560 events read in total (296ms).
[07:32:28.719] <TB0> INFO: Test took 1155ms.
[07:32:28.721] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:29.025] <TB0> INFO: Expecting 2560 events.
[07:32:29.877] <TB0> INFO: 2560 events read in total (296ms).
[07:32:29.877] <TB0> INFO: Test took 1156ms.
[07:32:29.879] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:30.183] <TB0> INFO: Expecting 2560 events.
[07:32:31.037] <TB0> INFO: 2560 events read in total (298ms).
[07:32:31.038] <TB0> INFO: Test took 1159ms.
[07:32:31.040] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:31.343] <TB0> INFO: Expecting 2560 events.
[07:32:32.196] <TB0> INFO: 2560 events read in total (297ms).
[07:32:32.196] <TB0> INFO: Test took 1156ms.
[07:32:32.198] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:32.502] <TB0> INFO: Expecting 2560 events.
[07:32:33.356] <TB0> INFO: 2560 events read in total (298ms).
[07:32:33.356] <TB0> INFO: Test took 1158ms.
[07:32:33.358] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:33.662] <TB0> INFO: Expecting 2560 events.
[07:32:34.515] <TB0> INFO: 2560 events read in total (297ms).
[07:32:34.516] <TB0> INFO: Test took 1158ms.
[07:32:34.517] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:34.821] <TB0> INFO: Expecting 2560 events.
[07:32:35.674] <TB0> INFO: 2560 events read in total (297ms).
[07:32:35.674] <TB0> INFO: Test took 1157ms.
[07:32:35.676] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:35.980] <TB0> INFO: Expecting 2560 events.
[07:32:36.837] <TB0> INFO: 2560 events read in total (302ms).
[07:32:36.838] <TB0> INFO: Test took 1162ms.
[07:32:36.839] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:37.143] <TB0> INFO: Expecting 2560 events.
[07:32:37.996] <TB0> INFO: 2560 events read in total (297ms).
[07:32:37.996] <TB0> INFO: Test took 1157ms.
[07:32:37.998] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:38.302] <TB0> INFO: Expecting 2560 events.
[07:32:39.156] <TB0> INFO: 2560 events read in total (298ms).
[07:32:39.156] <TB0> INFO: Test took 1158ms.
[07:32:39.157] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:39.462] <TB0> INFO: Expecting 2560 events.
[07:32:40.321] <TB0> INFO: 2560 events read in total (302ms).
[07:32:40.322] <TB0> INFO: Test took 1165ms.
[07:32:40.326] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:40.629] <TB0> INFO: Expecting 2560 events.
[07:32:41.487] <TB0> INFO: 2560 events read in total (302ms).
[07:32:41.487] <TB0> INFO: Test took 1162ms.
[07:32:41.489] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:41.793] <TB0> INFO: Expecting 2560 events.
[07:32:42.651] <TB0> INFO: 2560 events read in total (302ms).
[07:32:42.651] <TB0> INFO: Test took 1162ms.
[07:32:42.654] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:42.957] <TB0> INFO: Expecting 2560 events.
[07:32:43.815] <TB0> INFO: 2560 events read in total (302ms).
[07:32:43.815] <TB0> INFO: Test took 1161ms.
[07:32:43.817] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:44.120] <TB0> INFO: Expecting 2560 events.
[07:32:44.972] <TB0> INFO: 2560 events read in total (296ms).
[07:32:44.972] <TB0> INFO: Test took 1156ms.
[07:32:44.974] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:45.278] <TB0> INFO: Expecting 2560 events.
[07:32:46.130] <TB0> INFO: 2560 events read in total (296ms).
[07:32:46.130] <TB0> INFO: Test took 1156ms.
[07:32:46.132] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:46.436] <TB0> INFO: Expecting 2560 events.
[07:32:47.293] <TB0> INFO: 2560 events read in total (301ms).
[07:32:47.293] <TB0> INFO: Test took 1161ms.
[07:32:47.294] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:47.598] <TB0> INFO: Expecting 2560 events.
[07:32:48.451] <TB0> INFO: 2560 events read in total (296ms).
[07:32:48.451] <TB0> INFO: Test took 1157ms.
[07:32:48.453] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:48.757] <TB0> INFO: Expecting 2560 events.
[07:32:49.610] <TB0> INFO: 2560 events read in total (297ms).
[07:32:49.611] <TB0> INFO: Test took 1158ms.
[07:32:49.612] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:49.916] <TB0> INFO: Expecting 2560 events.
[07:32:50.769] <TB0> INFO: 2560 events read in total (297ms).
[07:32:50.769] <TB0> INFO: Test took 1157ms.
[07:32:50.771] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:51.075] <TB0> INFO: Expecting 2560 events.
[07:32:51.930] <TB0> INFO: 2560 events read in total (299ms).
[07:32:51.930] <TB0> INFO: Test took 1159ms.
[07:32:51.932] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:52.236] <TB0> INFO: Expecting 2560 events.
[07:32:53.089] <TB0> INFO: 2560 events read in total (297ms).
[07:32:53.089] <TB0> INFO: Test took 1157ms.
[07:32:53.091] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:53.395] <TB0> INFO: Expecting 2560 events.
[07:32:54.248] <TB0> INFO: 2560 events read in total (297ms).
[07:32:54.248] <TB0> INFO: Test took 1157ms.
[07:32:54.251] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:54.554] <TB0> INFO: Expecting 2560 events.
[07:32:55.407] <TB0> INFO: 2560 events read in total (297ms).
[07:32:55.407] <TB0> INFO: Test took 1156ms.
[07:32:55.409] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:32:55.713] <TB0> INFO: Expecting 2560 events.
[07:32:56.566] <TB0> INFO: 2560 events read in total (297ms).
[07:32:56.566] <TB0> INFO: Test took 1157ms.
[07:32:57.019] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 615 seconds
[07:32:57.019] <TB0> INFO: PH scale (per ROC): 74 71 84 80 84 80 82 80 85 81 100 89 85 90 80 91
[07:32:57.019] <TB0> INFO: PH offset (per ROC): 163 170 148 153 163 174 160 161 152 166 140 156 172 144 160 148
[07:32:57.023] <TB0> INFO: Decoding statistics:
[07:32:57.024] <TB0> INFO: General information:
[07:32:57.024] <TB0> INFO: 16bit words read: 91908
[07:32:57.024] <TB0> INFO: valid events total: 10240
[07:32:57.024] <TB0> INFO: empty events: 7743
[07:32:57.024] <TB0> INFO: valid events with pixels: 2497
[07:32:57.024] <TB0> INFO: valid pixel hits: 2497
[07:32:57.024] <TB0> INFO: Event errors: 0
[07:32:57.024] <TB0> INFO: start marker: 0
[07:32:57.024] <TB0> INFO: stop marker: 0
[07:32:57.024] <TB0> INFO: overflow: 0
[07:32:57.024] <TB0> INFO: invalid 5bit words: 0
[07:32:57.024] <TB0> INFO: invalid XOR eye diagram: 0
[07:32:57.024] <TB0> INFO: frame (failed synchr.): 0
[07:32:57.024] <TB0> INFO: idle data (no TBM trl): 0
[07:32:57.024] <TB0> INFO: no data (only TBM hdr): 0
[07:32:57.024] <TB0> INFO: TBM errors: 0
[07:32:57.024] <TB0> INFO: flawed TBM headers: 0
[07:32:57.024] <TB0> INFO: flawed TBM trailers: 0
[07:32:57.024] <TB0> INFO: event ID mismatches: 0
[07:32:57.024] <TB0> INFO: ROC errors: 0
[07:32:57.024] <TB0> INFO: missing ROC header(s): 0
[07:32:57.024] <TB0> INFO: misplaced readback start: 0
[07:32:57.024] <TB0> INFO: Pixel decoding errors: 0
[07:32:57.024] <TB0> INFO: pixel data incomplete: 0
[07:32:57.024] <TB0> INFO: pixel address: 0
[07:32:57.024] <TB0> INFO: pulse height fill bit: 0
[07:32:57.024] <TB0> INFO: buffer corruption: 0
[07:32:57.195] <TB0> INFO: ######################################################################
[07:32:57.195] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[07:32:57.195] <TB0> INFO: ######################################################################
[07:32:57.204] <TB0> INFO: scanning low vcal = 10
[07:32:57.465] <TB0> INFO: Expecting 41600 events.
[07:33:00.995] <TB0> INFO: 41600 events read in total (2974ms).
[07:33:00.995] <TB0> INFO: Test took 3791ms.
[07:33:00.997] <TB0> INFO: scanning low vcal = 20
[07:33:01.301] <TB0> INFO: Expecting 41600 events.
[07:33:04.847] <TB0> INFO: 41600 events read in total (2990ms).
[07:33:04.847] <TB0> INFO: Test took 3850ms.
[07:33:04.849] <TB0> INFO: scanning low vcal = 30
[07:33:05.152] <TB0> INFO: Expecting 41600 events.
[07:33:08.693] <TB0> INFO: 41600 events read in total (2985ms).
[07:33:08.693] <TB0> INFO: Test took 3844ms.
[07:33:08.695] <TB0> INFO: scanning low vcal = 40
[07:33:08.992] <TB0> INFO: Expecting 41600 events.
[07:33:13.122] <TB0> INFO: 41600 events read in total (3573ms).
[07:33:13.122] <TB0> INFO: Test took 4427ms.
[07:33:13.125] <TB0> INFO: scanning low vcal = 50
[07:33:13.391] <TB0> INFO: Expecting 41600 events.
[07:33:17.564] <TB0> INFO: 41600 events read in total (3617ms).
[07:33:17.565] <TB0> INFO: Test took 4440ms.
[07:33:17.567] <TB0> INFO: scanning low vcal = 60
[07:33:17.829] <TB0> INFO: Expecting 41600 events.
[07:33:22.008] <TB0> INFO: 41600 events read in total (3623ms).
[07:33:22.008] <TB0> INFO: Test took 4441ms.
[07:33:22.011] <TB0> INFO: scanning low vcal = 70
[07:33:22.272] <TB0> INFO: Expecting 41600 events.
[07:33:26.459] <TB0> INFO: 41600 events read in total (3631ms).
[07:33:26.459] <TB0> INFO: Test took 4448ms.
[07:33:26.462] <TB0> INFO: scanning low vcal = 80
[07:33:26.725] <TB0> INFO: Expecting 41600 events.
[07:33:30.889] <TB0> INFO: 41600 events read in total (3608ms).
[07:33:30.890] <TB0> INFO: Test took 4428ms.
[07:33:30.892] <TB0> INFO: scanning low vcal = 90
[07:33:31.156] <TB0> INFO: Expecting 41600 events.
[07:33:35.340] <TB0> INFO: 41600 events read in total (3628ms).
[07:33:35.341] <TB0> INFO: Test took 4448ms.
[07:33:35.344] <TB0> INFO: scanning low vcal = 100
[07:33:35.642] <TB0> INFO: Expecting 41600 events.
[07:33:39.869] <TB0> INFO: 41600 events read in total (3671ms).
[07:33:39.869] <TB0> INFO: Test took 4524ms.
[07:33:39.872] <TB0> INFO: scanning low vcal = 110
[07:33:40.162] <TB0> INFO: Expecting 41600 events.
[07:33:44.348] <TB0> INFO: 41600 events read in total (3630ms).
[07:33:44.349] <TB0> INFO: Test took 4477ms.
[07:33:44.351] <TB0> INFO: scanning low vcal = 120
[07:33:44.612] <TB0> INFO: Expecting 41600 events.
[07:33:48.799] <TB0> INFO: 41600 events read in total (3631ms).
[07:33:48.799] <TB0> INFO: Test took 4448ms.
[07:33:48.802] <TB0> INFO: scanning low vcal = 130
[07:33:49.066] <TB0> INFO: Expecting 41600 events.
[07:33:53.237] <TB0> INFO: 41600 events read in total (3615ms).
[07:33:53.238] <TB0> INFO: Test took 4436ms.
[07:33:53.240] <TB0> INFO: scanning low vcal = 140
[07:33:53.512] <TB0> INFO: Expecting 41600 events.
[07:33:57.697] <TB0> INFO: 41600 events read in total (3629ms).
[07:33:57.698] <TB0> INFO: Test took 4458ms.
[07:33:57.700] <TB0> INFO: scanning low vcal = 150
[07:33:57.971] <TB0> INFO: Expecting 41600 events.
[07:34:02.185] <TB0> INFO: 41600 events read in total (3658ms).
[07:34:02.186] <TB0> INFO: Test took 4486ms.
[07:34:02.188] <TB0> INFO: scanning low vcal = 160
[07:34:02.450] <TB0> INFO: Expecting 41600 events.
[07:34:06.625] <TB0> INFO: 41600 events read in total (3619ms).
[07:34:06.625] <TB0> INFO: Test took 4437ms.
[07:34:06.628] <TB0> INFO: scanning low vcal = 170
[07:34:06.891] <TB0> INFO: Expecting 41600 events.
[07:34:11.066] <TB0> INFO: 41600 events read in total (3619ms).
[07:34:11.067] <TB0> INFO: Test took 4439ms.
[07:34:11.071] <TB0> INFO: scanning low vcal = 180
[07:34:11.330] <TB0> INFO: Expecting 41600 events.
[07:34:15.491] <TB0> INFO: 41600 events read in total (3606ms).
[07:34:15.492] <TB0> INFO: Test took 4421ms.
[07:34:15.494] <TB0> INFO: scanning low vcal = 190
[07:34:15.760] <TB0> INFO: Expecting 41600 events.
[07:34:19.952] <TB0> INFO: 41600 events read in total (3635ms).
[07:34:19.953] <TB0> INFO: Test took 4458ms.
[07:34:19.955] <TB0> INFO: scanning low vcal = 200
[07:34:20.218] <TB0> INFO: Expecting 41600 events.
[07:34:24.406] <TB0> INFO: 41600 events read in total (3632ms).
[07:34:24.406] <TB0> INFO: Test took 4450ms.
[07:34:24.409] <TB0> INFO: scanning low vcal = 210
[07:34:24.668] <TB0> INFO: Expecting 41600 events.
[07:34:28.875] <TB0> INFO: 41600 events read in total (3650ms).
[07:34:28.876] <TB0> INFO: Test took 4467ms.
[07:34:28.878] <TB0> INFO: scanning low vcal = 220
[07:34:29.150] <TB0> INFO: Expecting 41600 events.
[07:34:33.345] <TB0> INFO: 41600 events read in total (3639ms).
[07:34:33.346] <TB0> INFO: Test took 4468ms.
[07:34:33.348] <TB0> INFO: scanning low vcal = 230
[07:34:33.619] <TB0> INFO: Expecting 41600 events.
[07:34:37.814] <TB0> INFO: 41600 events read in total (3639ms).
[07:34:37.814] <TB0> INFO: Test took 4466ms.
[07:34:37.816] <TB0> INFO: scanning low vcal = 240
[07:34:38.080] <TB0> INFO: Expecting 41600 events.
[07:34:42.284] <TB0> INFO: 41600 events read in total (3648ms).
[07:34:42.284] <TB0> INFO: Test took 4468ms.
[07:34:42.287] <TB0> INFO: scanning low vcal = 250
[07:34:42.566] <TB0> INFO: Expecting 41600 events.
[07:34:46.754] <TB0> INFO: 41600 events read in total (3632ms).
[07:34:46.755] <TB0> INFO: Test took 4468ms.
[07:34:46.758] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[07:34:47.021] <TB0> INFO: Expecting 41600 events.
[07:34:51.210] <TB0> INFO: 41600 events read in total (3632ms).
[07:34:51.211] <TB0> INFO: Test took 4452ms.
[07:34:51.213] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[07:34:51.474] <TB0> INFO: Expecting 41600 events.
[07:34:55.709] <TB0> INFO: 41600 events read in total (3679ms).
[07:34:55.709] <TB0> INFO: Test took 4496ms.
[07:34:55.712] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[07:34:55.984] <TB0> INFO: Expecting 41600 events.
[07:35:00.172] <TB0> INFO: 41600 events read in total (3632ms).
[07:35:00.172] <TB0> INFO: Test took 4460ms.
[07:35:00.175] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[07:35:00.437] <TB0> INFO: Expecting 41600 events.
[07:35:04.626] <TB0> INFO: 41600 events read in total (3633ms).
[07:35:04.627] <TB0> INFO: Test took 4452ms.
[07:35:04.629] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[07:35:04.892] <TB0> INFO: Expecting 41600 events.
[07:35:09.089] <TB0> INFO: 41600 events read in total (3641ms).
[07:35:09.090] <TB0> INFO: Test took 4461ms.
[07:35:09.584] <TB0> INFO: PixTestGainPedestal::measure() done
[07:35:44.169] <TB0> INFO: PixTestGainPedestal::fit() done
[07:35:44.169] <TB0> INFO: non-linearity mean: 0.955 0.953 0.960 0.953 0.959 0.960 0.956 0.953 0.955 0.946 0.953 0.954 0.961 0.955 0.957 0.953
[07:35:44.169] <TB0> INFO: non-linearity RMS: 0.005 0.007 0.005 0.006 0.005 0.004 0.006 0.006 0.006 0.006 0.005 0.005 0.005 0.005 0.004 0.006
[07:35:44.169] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[07:35:44.189] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[07:35:44.214] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[07:35:44.234] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[07:35:44.254] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[07:35:44.275] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[07:35:44.293] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[07:35:44.312] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[07:35:44.331] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[07:35:44.349] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[07:35:44.370] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[07:35:44.390] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[07:35:44.409] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[07:35:44.433] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[07:35:44.453] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[07:35:44.472] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[07:35:44.492] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 167 seconds
[07:35:44.492] <TB0> INFO: Decoding statistics:
[07:35:44.492] <TB0> INFO: General information:
[07:35:44.492] <TB0> INFO: 16bit words read: 2662400
[07:35:44.492] <TB0> INFO: valid events total: 166400
[07:35:44.492] <TB0> INFO: empty events: 0
[07:35:44.492] <TB0> INFO: valid events with pixels: 166400
[07:35:44.492] <TB0> INFO: valid pixel hits: 665600
[07:35:44.492] <TB0> INFO: Event errors: 0
[07:35:44.492] <TB0> INFO: start marker: 0
[07:35:44.492] <TB0> INFO: stop marker: 0
[07:35:44.492] <TB0> INFO: overflow: 0
[07:35:44.492] <TB0> INFO: invalid 5bit words: 0
[07:35:44.492] <TB0> INFO: invalid XOR eye diagram: 0
[07:35:44.492] <TB0> INFO: frame (failed synchr.): 0
[07:35:44.492] <TB0> INFO: idle data (no TBM trl): 0
[07:35:44.492] <TB0> INFO: no data (only TBM hdr): 0
[07:35:44.492] <TB0> INFO: TBM errors: 0
[07:35:44.492] <TB0> INFO: flawed TBM headers: 0
[07:35:44.492] <TB0> INFO: flawed TBM trailers: 0
[07:35:44.492] <TB0> INFO: event ID mismatches: 0
[07:35:44.492] <TB0> INFO: ROC errors: 0
[07:35:44.492] <TB0> INFO: missing ROC header(s): 0
[07:35:44.492] <TB0> INFO: misplaced readback start: 0
[07:35:44.492] <TB0> INFO: Pixel decoding errors: 0
[07:35:44.492] <TB0> INFO: pixel data incomplete: 0
[07:35:44.492] <TB0> INFO: pixel address: 0
[07:35:44.492] <TB0> INFO: pulse height fill bit: 0
[07:35:44.492] <TB0> INFO: buffer corruption: 0
[07:35:44.499] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:35:44.501] <TB0> INFO: ######################################################################
[07:35:44.501] <TB0> INFO: PixTestReadback::doTest()
[07:35:44.501] <TB0> INFO: ######################################################################
[07:35:44.501] <TB0> INFO: ----------------------------------------------------------------------
[07:35:44.501] <TB0> INFO: PixTestReadback::CalibrateVd()
[07:35:44.501] <TB0> INFO: ----------------------------------------------------------------------
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:35:53.960] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:35:53.961] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:35:53.991] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:35:53.991] <TB0> INFO: ----------------------------------------------------------------------
[07:35:53.991] <TB0> INFO: PixTestReadback::CalibrateVa()
[07:35:53.991] <TB0> INFO: ----------------------------------------------------------------------
[07:36:04.155] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:36:04.156] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:36:04.157] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:36:04.180] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:36:04.180] <TB0> INFO: ----------------------------------------------------------------------
[07:36:04.180] <TB0> INFO: PixTestReadback::readbackVbg()
[07:36:04.180] <TB0> INFO: ----------------------------------------------------------------------
[07:36:11.474] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:36:11.475] <TB0> INFO: ----------------------------------------------------------------------
[07:36:11.475] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[07:36:11.475] <TB0> INFO: ----------------------------------------------------------------------
[07:36:11.475] <TB0> INFO: Vbg will be calibrated using Vd calibration
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 153.2calibrated Vbg = 1.20877 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 153.3calibrated Vbg = 1.20448 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.5calibrated Vbg = 1.20708 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 156.3calibrated Vbg = 1.22255 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 152.9calibrated Vbg = 1.23161 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 158calibrated Vbg = 1.2358 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 144calibrated Vbg = 1.23622 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 150.8calibrated Vbg = 1.22839 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 158.2calibrated Vbg = 1.23366 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 146.7calibrated Vbg = 1.22756 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 160.5calibrated Vbg = 1.22914 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 156calibrated Vbg = 1.22059 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 149.2calibrated Vbg = 1.21366 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 144.7calibrated Vbg = 1.22101 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 147.6calibrated Vbg = 1.21317 :::*/*/*/*/
[07:36:11.475] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 156.8calibrated Vbg = 1.22299 :::*/*/*/*/
[07:36:11.477] <TB0> INFO: ----------------------------------------------------------------------
[07:36:11.477] <TB0> INFO: PixTestReadback::CalibrateIa()
[07:36:11.477] <TB0> INFO: ----------------------------------------------------------------------
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:38:46.588] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:38:46.589] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2257_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:38:46.611] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:38:46.612] <TB0> INFO: PixTestReadback::doTest() done
[07:38:46.612] <TB0> INFO: Decoding statistics:
[07:38:46.612] <TB0> INFO: General information:
[07:38:46.612] <TB0> INFO: 16bit words read: 1024
[07:38:46.612] <TB0> INFO: valid events total: 128
[07:38:46.612] <TB0> INFO: empty events: 128
[07:38:46.612] <TB0> INFO: valid events with pixels: 0
[07:38:46.612] <TB0> INFO: valid pixel hits: 0
[07:38:46.612] <TB0> INFO: Event errors: 0
[07:38:46.612] <TB0> INFO: start marker: 0
[07:38:46.612] <TB0> INFO: stop marker: 0
[07:38:46.612] <TB0> INFO: overflow: 0
[07:38:46.612] <TB0> INFO: invalid 5bit words: 0
[07:38:46.612] <TB0> INFO: invalid XOR eye diagram: 0
[07:38:46.612] <TB0> INFO: frame (failed synchr.): 0
[07:38:46.612] <TB0> INFO: idle data (no TBM trl): 0
[07:38:46.612] <TB0> INFO: no data (only TBM hdr): 0
[07:38:46.612] <TB0> INFO: TBM errors: 0
[07:38:46.612] <TB0> INFO: flawed TBM headers: 0
[07:38:46.612] <TB0> INFO: flawed TBM trailers: 0
[07:38:46.612] <TB0> INFO: event ID mismatches: 0
[07:38:46.612] <TB0> INFO: ROC errors: 0
[07:38:46.612] <TB0> INFO: missing ROC header(s): 0
[07:38:46.612] <TB0> INFO: misplaced readback start: 0
[07:38:46.612] <TB0> INFO: Pixel decoding errors: 0
[07:38:46.612] <TB0> INFO: pixel data incomplete: 0
[07:38:46.612] <TB0> INFO: pixel address: 0
[07:38:46.612] <TB0> INFO: pulse height fill bit: 0
[07:38:46.612] <TB0> INFO: buffer corruption: 0
[07:38:46.636] <TB0> INFO: Decoding statistics:
[07:38:46.636] <TB0> INFO: General information:
[07:38:46.636] <TB0> INFO: 16bit words read: 2755332
[07:38:46.636] <TB0> INFO: valid events total: 176768
[07:38:46.636] <TB0> INFO: empty events: 7871
[07:38:46.636] <TB0> INFO: valid events with pixels: 168897
[07:38:46.636] <TB0> INFO: valid pixel hits: 668097
[07:38:46.636] <TB0> INFO: Event errors: 0
[07:38:46.636] <TB0> INFO: start marker: 0
[07:38:46.636] <TB0> INFO: stop marker: 0
[07:38:46.636] <TB0> INFO: overflow: 0
[07:38:46.636] <TB0> INFO: invalid 5bit words: 0
[07:38:46.636] <TB0> INFO: invalid XOR eye diagram: 0
[07:38:46.636] <TB0> INFO: frame (failed synchr.): 0
[07:38:46.636] <TB0> INFO: idle data (no TBM trl): 0
[07:38:46.636] <TB0> INFO: no data (only TBM hdr): 0
[07:38:46.636] <TB0> INFO: TBM errors: 0
[07:38:46.636] <TB0> INFO: flawed TBM headers: 0
[07:38:46.636] <TB0> INFO: flawed TBM trailers: 0
[07:38:46.636] <TB0> INFO: event ID mismatches: 0
[07:38:46.636] <TB0> INFO: ROC errors: 0
[07:38:46.636] <TB0> INFO: missing ROC header(s): 0
[07:38:46.636] <TB0> INFO: misplaced readback start: 0
[07:38:46.636] <TB0> INFO: Pixel decoding errors: 0
[07:38:46.636] <TB0> INFO: pixel data incomplete: 0
[07:38:46.636] <TB0> INFO: pixel address: 0
[07:38:46.636] <TB0> INFO: pulse height fill bit: 0
[07:38:46.636] <TB0> INFO: buffer corruption: 0
[07:38:46.636] <TB0> INFO: enter test to run
[07:38:46.636] <TB0> INFO: test: exit no parameter change
[07:38:46.809] <TB0> QUIET: Connection to board 73 closed.
[07:38:46.889] <TB0> INFO: pXar: this is the end, my friend