[11:24:28.336] <TB0> INFO: *** Welcome to pxar ***
[11:24:28.336] <TB0> INFO: *** Today: 2016/10/10
[11:24:30.874] <TB0> INFO: *** Version: 0b00-dirty
[11:24:30.874] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C15.dat
[11:24:30.874] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//tbmParameters_C0b.dat
[11:24:30.874] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//defaultMaskFile.dat
[11:24:30.874] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters_C15.dat
[11:24:30.945] <TB0> INFO: clk: 4
[11:24:30.945] <TB0> INFO: ctr: 4
[11:24:30.945] <TB0> INFO: sda: 19
[11:24:30.945] <TB0> INFO: tin: 9
[11:24:30.945] <TB0> INFO: level: 15
[11:24:30.945] <TB0> INFO: triggerdelay: 0
[11:24:30.945] <TB0> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:24:30.945] <TB0> INFO: Log level: INFO
[11:24:30.955] <TB0> INFO: Found DTB DTB_WS6AYH
[11:24:30.968] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[11:24:30.971] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[11:24:30.972] <TB0> INFO: RPC call hashes of host and DTB match: 486171790
[11:24:32.472] <TB0> INFO: DUT info:
[11:24:32.472] <TB0> INFO: The DUT currently contains the following objects:
[11:24:32.472] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[11:24:32.472] <TB0> INFO: TBM Core alpha (0): 7 registers set
[11:24:32.472] <TB0> INFO: TBM Core beta (1): 7 registers set
[11:24:32.472] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:24:32.472] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.472] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:32.873] <TB0> INFO: enter 'restricted' command line mode
[11:24:32.873] <TB0> INFO: enter test to run
[11:24:32.873] <TB0> INFO: test: pretest no parameter change
[11:24:32.873] <TB0> INFO: running: pretest
[11:24:32.878] <TB0> INFO: ----------------------------------------------------------------------
[11:24:32.878] <TB0> INFO: PixTestPretest::programROC()
[11:24:32.878] <TB0> INFO: ----------------------------------------------------------------------
[11:24:50.893] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[11:24:50.893] <TB0> INFO: IA differences per ROC: 18.5 19.3 18.5 20.1 20.1 19.3 17.7 18.5 21.7 18.5 19.3 20.1 21.7 19.3 20.1 20.1
[11:24:51.102] <TB0> INFO: enter test to run
[11:24:51.102] <TB0> INFO: test: pretest no parameter change
[11:24:51.102] <TB0> INFO: running: pretest
[11:24:51.103] <TB0> INFO: ----------------------------------------------------------------------
[11:24:51.103] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[11:24:51.103] <TB0> INFO: ----------------------------------------------------------------------
[11:24:56.788] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 377.8 mA = 23.6125 mA/ROC
[11:24:56.788] <TB0> INFO: i(loss) [mA/ROC]: 19.3 19.3 19.3 19.3 19.3 18.5 18.5 19.3 19.3 19.3 18.5 18.5 19.3 19.3 19.3 18.5
[11:24:56.821] <TB0> INFO: enter test to run
[11:24:56.821] <TB0> INFO: test: pretest no parameter change
[11:24:56.821] <TB0> INFO: running: pretest
[11:24:56.821] <TB0> INFO: ----------------------------------------------------------------------
[11:24:56.821] <TB0> INFO: PixTestPretest::findTiming()
[11:24:56.821] <TB0> INFO: ----------------------------------------------------------------------
[11:24:56.821] <TB0> INFO: PixTestCmd::init()

[11:26:26.154] <TB0> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[11:26:26.154] <TB0> INFO: (success/tries = 100/100), width = 4
[11:26:26.155] <TB0> INFO: enter test to run
[11:26:26.155] <TB0> INFO: test: pretest no parameter change
[11:26:26.155] <TB0> INFO: running: pretest
[11:26:26.157] <TB0> INFO: ----------------------------------------------------------------------
[11:26:26.157] <TB0> INFO: PixTestPretest::findWorkingPixel()
[11:26:26.157] <TB0> INFO: ----------------------------------------------------------------------
[11:26:26.252] <TB0> INFO: Expecting 231680 events.


[11:26:35.505] <TB0> INFO: 231680 events read in total (8697ms).
[11:26:35.511] <TB0> INFO: Test took 9348ms.
[11:26:35.731] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[11:26:35.791] <TB0> INFO: enter test to run
[11:26:35.791] <TB0> INFO: test: pretest no parameter change
[11:26:35.791] <TB0> INFO: running: pretest
[11:26:35.792] <TB0> INFO: ----------------------------------------------------------------------
[11:26:35.792] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[11:26:35.792] <TB0> INFO: ----------------------------------------------------------------------
[11:26:35.884] <TB0> INFO: Expecting 231680 events.
[11:26:45.188] <TB0> INFO: 231680 events read in total (8748ms).
[11:26:45.195] <TB0> INFO: Test took 9400ms.
[11:26:45.430] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[11:26:45.431] <TB0> INFO: CalDel: 138 151 126 167 140 133 155 154 145 142 145 162 145 119 166 145
[11:26:45.431] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[11:26:45.464] <TB0> INFO: enter test to run
[11:26:45.464] <TB0> INFO: test: pretest no parameter change
[11:26:45.464] <TB0> INFO: running: pretest
[11:26:45.464] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C0.dat
[11:26:45.464] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C1.dat
[11:26:45.464] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C2.dat
[11:26:45.464] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C3.dat
[11:26:45.464] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C4.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C5.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C6.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C7.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C8.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C9.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C10.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C11.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C12.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C13.dat
[11:26:45.465] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C14.dat
[11:26:45.466] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters_C15.dat
[11:26:45.466] <TB0> INFO: enter test to run
[11:26:45.466] <TB0> INFO: test: fulltest no parameter change
[11:26:45.466] <TB0> INFO: running: fulltest
[11:26:45.466] <TB0> INFO: ######################################################################
[11:26:45.466] <TB0> INFO: PixTestFullTest::doTest()
[11:26:45.466] <TB0> INFO: ######################################################################
[11:26:45.467] <TB0> INFO: ######################################################################
[11:26:45.467] <TB0> INFO: PixTestAlive::doTest()
[11:26:45.467] <TB0> INFO: ######################################################################
[11:26:45.468] <TB0> INFO: ----------------------------------------------------------------------
[11:26:45.468] <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)
[11:26:45.468] <TB0> INFO: ----------------------------------------------------------------------
[11:26:45.754] <TB0> INFO: Expecting 41600 events.
[11:26:49.200] <TB0> INFO: 41600 events read in total (2890ms).
[11:26:49.200] <TB0> INFO: Test took 3731ms.
[11:26:49.423] <TB0> INFO: PixTestAlive::aliveTest() done
[11:26:49.423] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:26:49.425] <TB0> INFO: ----------------------------------------------------------------------
[11:26:49.425] <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)
[11:26:49.425] <TB0> INFO: ----------------------------------------------------------------------
[11:26:49.696] <TB0> INFO: Expecting 41600 events.
[11:26:52.446] <TB0> INFO: 41600 events read in total (2194ms).
[11:26:52.446] <TB0> INFO: Test took 3019ms.
[11:26:52.447] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:26:52.677] <TB0> INFO: PixTestAlive::maskTest() done
[11:26:52.677] <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
[11:26:52.679] <TB0> INFO: ----------------------------------------------------------------------
[11:26:52.679] <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)
[11:26:52.679] <TB0> INFO: ----------------------------------------------------------------------
[11:26:52.946] <TB0> INFO: Expecting 41600 events.
[11:26:56.421] <TB0> INFO: 41600 events read in total (2919ms).
[11:26:56.421] <TB0> INFO: Test took 3741ms.
[11:26:56.643] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[11:26:56.643] <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
[11:26:56.643] <TB0> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[11:26:56.643] <TB0> INFO: Decoding statistics:
[11:26:56.643] <TB0> INFO: General information:
[11:26:56.643] <TB0> INFO: 16bit words read: 0
[11:26:56.643] <TB0> INFO: valid events total: 0
[11:26:56.643] <TB0> INFO: empty events: 0
[11:26:56.643] <TB0> INFO: valid events with pixels: 0
[11:26:56.643] <TB0> INFO: valid pixel hits: 0
[11:26:56.643] <TB0> INFO: Event errors: 0
[11:26:56.643] <TB0> INFO: start marker: 0
[11:26:56.643] <TB0> INFO: stop marker: 0
[11:26:56.644] <TB0> INFO: overflow: 0
[11:26:56.644] <TB0> INFO: invalid 5bit words: 0
[11:26:56.644] <TB0> INFO: invalid XOR eye diagram: 0
[11:26:56.644] <TB0> INFO: frame (failed synchr.): 0
[11:26:56.644] <TB0> INFO: idle data (no TBM trl): 0
[11:26:56.644] <TB0> INFO: no data (only TBM hdr): 0
[11:26:56.644] <TB0> INFO: TBM errors: 0
[11:26:56.644] <TB0> INFO: flawed TBM headers: 0
[11:26:56.644] <TB0> INFO: flawed TBM trailers: 0
[11:26:56.644] <TB0> INFO: event ID mismatches: 0
[11:26:56.644] <TB0> INFO: ROC errors: 0
[11:26:56.644] <TB0> INFO: missing ROC header(s): 0
[11:26:56.644] <TB0> INFO: misplaced readback start: 0
[11:26:56.644] <TB0> INFO: Pixel decoding errors: 0
[11:26:56.644] <TB0> INFO: pixel data incomplete: 0
[11:26:56.644] <TB0> INFO: pixel address: 0
[11:26:56.644] <TB0> INFO: pulse height fill bit: 0
[11:26:56.644] <TB0> INFO: buffer corruption: 0
[11:26:56.656] <TB0> INFO: ######################################################################
[11:26:56.656] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[11:26:56.656] <TB0> INFO: ######################################################################
[11:26:56.659] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[11:26:56.670] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[11:26:56.670] <TB0> INFO: run 1 of 1
[11:26:56.960] <TB0> INFO: Expecting 3120000 events.
[11:27:34.652] <TB0> INFO: 873645 events read in total (37136ms).
[11:28:11.029] <TB0> INFO: 1730940 events read in total (73513ms).
[11:28:47.813] <TB0> INFO: 2598555 events read in total (110297ms).
[11:29:09.412] <TB0> INFO: 3120000 events read in total (131896ms).
[11:29:09.482] <TB0> INFO: Test took 132813ms.
[11:29:33.096] <TB0> INFO: PixTestBBMap::doTest() done, duration: 156 seconds
[11:29:33.096] <TB0> INFO: number of dead bumps (per ROC): 2 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[11:29:33.096] <TB0> INFO: separation cut (per ROC): 95 77 97 76 92 85 75 84 72 71 83 75 85 90 64 73
[11:29:33.096] <TB0> INFO: Decoding statistics:
[11:29:33.096] <TB0> INFO: General information:
[11:29:33.096] <TB0> INFO: 16bit words read: 0
[11:29:33.096] <TB0> INFO: valid events total: 0
[11:29:33.096] <TB0> INFO: empty events: 0
[11:29:33.096] <TB0> INFO: valid events with pixels: 0
[11:29:33.096] <TB0> INFO: valid pixel hits: 0
[11:29:33.096] <TB0> INFO: Event errors: 0
[11:29:33.096] <TB0> INFO: start marker: 0
[11:29:33.096] <TB0> INFO: stop marker: 0
[11:29:33.096] <TB0> INFO: overflow: 0
[11:29:33.096] <TB0> INFO: invalid 5bit words: 0
[11:29:33.096] <TB0> INFO: invalid XOR eye diagram: 0
[11:29:33.096] <TB0> INFO: frame (failed synchr.): 0
[11:29:33.096] <TB0> INFO: idle data (no TBM trl): 0
[11:29:33.096] <TB0> INFO: no data (only TBM hdr): 0
[11:29:33.096] <TB0> INFO: TBM errors: 0
[11:29:33.096] <TB0> INFO: flawed TBM headers: 0
[11:29:33.096] <TB0> INFO: flawed TBM trailers: 0
[11:29:33.096] <TB0> INFO: event ID mismatches: 0
[11:29:33.096] <TB0> INFO: ROC errors: 0
[11:29:33.096] <TB0> INFO: missing ROC header(s): 0
[11:29:33.096] <TB0> INFO: misplaced readback start: 0
[11:29:33.096] <TB0> INFO: Pixel decoding errors: 0
[11:29:33.096] <TB0> INFO: pixel data incomplete: 0
[11:29:33.096] <TB0> INFO: pixel address: 0
[11:29:33.096] <TB0> INFO: pulse height fill bit: 0
[11:29:33.096] <TB0> INFO: buffer corruption: 0
[11:29:33.169] <TB0> INFO: ######################################################################
[11:29:33.169] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[11:29:33.169] <TB0> INFO: ######################################################################
[11:29:33.169] <TB0> INFO: ----------------------------------------------------------------------
[11:29:33.169] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[11:29:33.169] <TB0> INFO: ----------------------------------------------------------------------
[11:29:33.169] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 200 (-1/-1) hits flags = 528 (plus default)
[11:29:33.178] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[11:29:33.178] <TB0> INFO: run 1 of 1
[11:29:33.444] <TB0> INFO: Expecting 36608000 events.
[11:30:02.724] <TB0> INFO: 797950 events read in total (28724ms).
[11:30:30.635] <TB0> INFO: 1585050 events read in total (56635ms).
[11:30:58.287] <TB0> INFO: 2372850 events read in total (84287ms).
[11:31:26.300] <TB0> INFO: 3158050 events read in total (112300ms).
[11:31:54.161] <TB0> INFO: 3945550 events read in total (140161ms).
[11:32:22.134] <TB0> INFO: 4731600 events read in total (168134ms).
[11:32:50.031] <TB0> INFO: 5519250 events read in total (196031ms).
[11:33:17.950] <TB0> INFO: 6306950 events read in total (223950ms).
[11:33:46.009] <TB0> INFO: 7092450 events read in total (252009ms).
[11:34:13.718] <TB0> INFO: 7880600 events read in total (279718ms).
[11:34:41.913] <TB0> INFO: 8666800 events read in total (307913ms).
[11:35:09.970] <TB0> INFO: 9453000 events read in total (335970ms).
[11:35:38.024] <TB0> INFO: 10238800 events read in total (364024ms).
[11:36:05.844] <TB0> INFO: 11025050 events read in total (391844ms).
[11:36:33.974] <TB0> INFO: 11812350 events read in total (419974ms).
[11:37:02.198] <TB0> INFO: 12599000 events read in total (448198ms).
[11:37:30.095] <TB0> INFO: 13386850 events read in total (476095ms).
[11:37:57.603] <TB0> INFO: 14172700 events read in total (503603ms).
[11:38:24.907] <TB0> INFO: 14959050 events read in total (530907ms).
[11:38:52.717] <TB0> INFO: 15743050 events read in total (558717ms).
[11:39:20.620] <TB0> INFO: 16530600 events read in total (586620ms).
[11:39:48.472] <TB0> INFO: 17316450 events read in total (614472ms).
[11:40:17.945] <TB0> INFO: 18100700 events read in total (643945ms).
[11:40:46.711] <TB0> INFO: 18882450 events read in total (672711ms).
[11:41:15.185] <TB0> INFO: 19663950 events read in total (701185ms).
[11:41:43.217] <TB0> INFO: 20444300 events read in total (729217ms).
[11:42:11.156] <TB0> INFO: 21224700 events read in total (757156ms).
[11:42:39.165] <TB0> INFO: 22005350 events read in total (785165ms).
[11:43:06.919] <TB0> INFO: 22784100 events read in total (812919ms).
[11:43:34.801] <TB0> INFO: 23563400 events read in total (840801ms).
[11:44:02.588] <TB0> INFO: 24342900 events read in total (868588ms).
[11:44:30.785] <TB0> INFO: 25120900 events read in total (896785ms).
[11:44:58.550] <TB0> INFO: 25901800 events read in total (924550ms).
[11:45:26.422] <TB0> INFO: 26680100 events read in total (952422ms).
[11:45:54.199] <TB0> INFO: 27458550 events read in total (980199ms).
[11:46:21.878] <TB0> INFO: 28236800 events read in total (1007878ms).
[11:46:49.594] <TB0> INFO: 29016350 events read in total (1035594ms).
[11:47:17.389] <TB0> INFO: 29794200 events read in total (1063389ms).
[11:47:45.189] <TB0> INFO: 30573350 events read in total (1091189ms).
[11:48:12.961] <TB0> INFO: 31351500 events read in total (1118961ms).
[11:48:40.916] <TB0> INFO: 32130750 events read in total (1146916ms).
[11:49:08.479] <TB0> INFO: 32910200 events read in total (1174479ms).
[11:49:36.330] <TB0> INFO: 33689800 events read in total (1202330ms).
[11:50:04.310] <TB0> INFO: 34471750 events read in total (1230310ms).
[11:50:32.298] <TB0> INFO: 35252700 events read in total (1258298ms).
[11:51:00.339] <TB0> INFO: 36035550 events read in total (1286339ms).
[11:51:20.690] <TB0> INFO: 36608000 events read in total (1306690ms).
[11:51:20.750] <TB0> INFO: Test took 1307571ms.
[11:51:21.204] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:23.031] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:24.759] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:26.501] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:28.225] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:29.948] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:31.717] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:33.639] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:35.471] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:37.191] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:38.883] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:40.599] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:42.300] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:44.138] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:46.177] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:47.950] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[11:51:49.824] <TB0> INFO: PixTestScurves::scurves() done
[11:51:49.824] <TB0> INFO: Vcal mean: 96.75 84.87 88.37 82.12 85.74 91.75 82.83 84.56 79.71 80.86 78.77 82.24 81.34 87.22 63.78 78.30
[11:51:49.824] <TB0> INFO: Vcal RMS: 5.30 5.99 5.15 4.23 5.03 5.86 5.15 4.67 4.22 4.72 4.81 4.58 4.18 4.84 3.95 3.79
[11:51:49.824] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1336 seconds
[11:51:49.824] <TB0> INFO: Decoding statistics:
[11:51:49.824] <TB0> INFO: General information:
[11:51:49.824] <TB0> INFO: 16bit words read: 0
[11:51:49.824] <TB0> INFO: valid events total: 0
[11:51:49.824] <TB0> INFO: empty events: 0
[11:51:49.824] <TB0> INFO: valid events with pixels: 0
[11:51:49.824] <TB0> INFO: valid pixel hits: 0
[11:51:49.824] <TB0> INFO: Event errors: 0
[11:51:49.824] <TB0> INFO: start marker: 0
[11:51:49.824] <TB0> INFO: stop marker: 0
[11:51:49.824] <TB0> INFO: overflow: 0
[11:51:49.824] <TB0> INFO: invalid 5bit words: 0
[11:51:49.824] <TB0> INFO: invalid XOR eye diagram: 0
[11:51:49.824] <TB0> INFO: frame (failed synchr.): 0
[11:51:49.824] <TB0> INFO: idle data (no TBM trl): 0
[11:51:49.824] <TB0> INFO: no data (only TBM hdr): 0
[11:51:49.824] <TB0> INFO: TBM errors: 0
[11:51:49.824] <TB0> INFO: flawed TBM headers: 0
[11:51:49.824] <TB0> INFO: flawed TBM trailers: 0
[11:51:49.824] <TB0> INFO: event ID mismatches: 0
[11:51:49.824] <TB0> INFO: ROC errors: 0
[11:51:49.824] <TB0> INFO: missing ROC header(s): 0
[11:51:49.824] <TB0> INFO: misplaced readback start: 0
[11:51:49.824] <TB0> INFO: Pixel decoding errors: 0
[11:51:49.824] <TB0> INFO: pixel data incomplete: 0
[11:51:49.824] <TB0> INFO: pixel address: 0
[11:51:49.824] <TB0> INFO: pulse height fill bit: 0
[11:51:49.824] <TB0> INFO: buffer corruption: 0
[11:51:49.903] <TB0> INFO: ######################################################################
[11:51:49.903] <TB0> INFO: PixTestTrim::doTest()
[11:51:49.903] <TB0> INFO: ######################################################################
[11:51:49.904] <TB0> INFO: ----------------------------------------------------------------------
[11:51:49.904] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[11:51:49.904] <TB0> INFO: ----------------------------------------------------------------------
[11:51:49.984] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[11:51:49.984] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[11:51:49.993] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[11:51:49.993] <TB0> INFO: run 1 of 1
[11:51:50.257] <TB0> INFO: Expecting 6281600 events.
[11:52:29.081] <TB0> INFO: 1102490 events read in total (38266ms).
[11:53:05.297] <TB0> INFO: 2199220 events read in total (74482ms).
[11:53:41.427] <TB0> INFO: 3289860 events read in total (110612ms).
[11:54:17.470] <TB0> INFO: 4387370 events read in total (146655ms).
[11:54:53.752] <TB0> INFO: 5488990 events read in total (182938ms).
[11:55:19.713] <TB0> INFO: 6281600 events read in total (208898ms).
[11:55:19.764] <TB0> INFO: Test took 209771ms.
[11:55:40.138] <TB0> INFO: ROC 0 VthrComp = 102
[11:55:40.139] <TB0> INFO: ROC 1 VthrComp = 86
[11:55:40.139] <TB0> INFO: ROC 2 VthrComp = 97
[11:55:40.139] <TB0> INFO: ROC 3 VthrComp = 86
[11:55:40.139] <TB0> INFO: ROC 4 VthrComp = 93
[11:55:40.139] <TB0> INFO: ROC 5 VthrComp = 94
[11:55:40.139] <TB0> INFO: ROC 6 VthrComp = 82
[11:55:40.139] <TB0> INFO: ROC 7 VthrComp = 88
[11:55:40.139] <TB0> INFO: ROC 8 VthrComp = 87
[11:55:40.139] <TB0> INFO: ROC 9 VthrComp = 85
[11:55:40.139] <TB0> INFO: ROC 10 VthrComp = 81
[11:55:40.140] <TB0> INFO: ROC 11 VthrComp = 84
[11:55:40.141] <TB0> INFO: ROC 12 VthrComp = 89
[11:55:40.141] <TB0> INFO: ROC 13 VthrComp = 95
[11:55:40.142] <TB0> INFO: ROC 14 VthrComp = 72
[11:55:40.142] <TB0> INFO: ROC 15 VthrComp = 86
[11:55:40.143] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[11:55:40.143] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[11:55:40.152] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[11:55:40.152] <TB0> INFO: run 1 of 1
[11:55:40.418] <TB0> INFO: Expecting 6281600 events.
[11:56:11.871] <TB0> INFO: 755980 events read in total (30897ms).
[11:56:42.873] <TB0> INFO: 1511180 events read in total (61899ms).
[11:57:13.411] <TB0> INFO: 2266880 events read in total (92437ms).
[11:57:43.765] <TB0> INFO: 3022860 events read in total (122791ms).
[11:58:14.582] <TB0> INFO: 3774080 events read in total (153608ms).
[11:58:44.863] <TB0> INFO: 4522290 events read in total (183889ms).
[11:59:15.253] <TB0> INFO: 5268860 events read in total (214279ms).
[11:59:45.780] <TB0> INFO: 6015820 events read in total (244806ms).
[11:59:56.850] <TB0> INFO: 6281600 events read in total (255876ms).
[11:59:56.907] <TB0> INFO: Test took 256755ms.
[12:00:22.348] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 59.235 for pixel 1/8 mean/min/max = 45.986/32.6961/59.2758
[12:00:22.348] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 63.6257 for pixel 6/1 mean/min/max = 47.4095/31.1607/63.6584
[12:00:22.348] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 57.4455 for pixel 4/1 mean/min/max = 44.2545/31.0523/57.4567
[12:00:22.349] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 56.7801 for pixel 43/13 mean/min/max = 44.8605/32.7311/56.99
[12:00:22.349] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 57.048 for pixel 23/66 mean/min/max = 44.9201/32.4741/57.3662
[12:00:22.349] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 60.8187 for pixel 8/5 mean/min/max = 46.2756/31.5502/61.001
[12:00:22.349] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 61.9098 for pixel 0/3 mean/min/max = 46.9594/31.9766/61.9422
[12:00:22.350] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 57.5115 for pixel 43/2 mean/min/max = 45.2026/32.8247/57.5804
[12:00:22.350] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 57.033 for pixel 6/6 mean/min/max = 44.6489/31.7397/57.558
[12:00:22.350] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 60.4243 for pixel 0/61 mean/min/max = 46.4992/31.9983/61.0001
[12:00:22.350] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 58.4425 for pixel 2/73 mean/min/max = 45.5625/32.6812/58.4439
[12:00:22.351] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 59.1462 for pixel 3/79 mean/min/max = 45.9317/32.7072/59.1561
[12:00:22.351] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 56.8086 for pixel 6/79 mean/min/max = 44.6597/32.4261/56.8934
[12:00:22.351] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 57.0767 for pixel 18/6 mean/min/max = 44.6616/32.1253/57.198
[12:00:22.351] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 54.9154 for pixel 21/55 mean/min/max = 44.0844/33.2193/54.9495
[12:00:22.352] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 55.2155 for pixel 17/6 mean/min/max = 43.6669/32.0249/55.3088
[12:00:22.352] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:00:22.440] <TB0> INFO: Expecting 514560 events.
[12:00:33.407] <TB0> INFO: 514560 events read in total (10411ms).
[12:00:33.414] <TB0> INFO: Expecting 514560 events.
[12:00:44.328] <TB0> INFO: 514560 events read in total (10512ms).
[12:00:44.343] <TB0> INFO: Expecting 514560 events.
[12:00:55.362] <TB0> INFO: 514560 events read in total (10617ms).
[12:00:55.385] <TB0> INFO: Expecting 514560 events.
[12:01:06.682] <TB0> INFO: 514560 events read in total (10895ms).
[12:01:06.712] <TB0> INFO: Expecting 514560 events.
[12:01:17.653] <TB0> INFO: 514560 events read in total (10540ms).
[12:01:17.674] <TB0> INFO: Expecting 514560 events.
[12:01:28.388] <TB0> INFO: 514560 events read in total (10312ms).
[12:01:28.412] <TB0> INFO: Expecting 514560 events.
[12:01:39.106] <TB0> INFO: 514560 events read in total (10293ms).
[12:01:39.133] <TB0> INFO: Expecting 514560 events.
[12:01:50.075] <TB0> INFO: 514560 events read in total (10540ms).
[12:01:50.107] <TB0> INFO: Expecting 514560 events.
[12:02:00.973] <TB0> INFO: 514560 events read in total (10465ms).
[12:02:01.007] <TB0> INFO: Expecting 514560 events.
[12:02:11.837] <TB0> INFO: 514560 events read in total (10428ms).
[12:02:11.872] <TB0> INFO: Expecting 514560 events.
[12:02:22.681] <TB0> INFO: 514560 events read in total (10407ms).
[12:02:22.721] <TB0> INFO: Expecting 514560 events.
[12:02:33.486] <TB0> INFO: 514560 events read in total (10364ms).
[12:02:33.526] <TB0> INFO: Expecting 514560 events.
[12:02:44.381] <TB0> INFO: 514560 events read in total (10453ms).
[12:02:44.425] <TB0> INFO: Expecting 514560 events.
[12:02:55.249] <TB0> INFO: 514560 events read in total (10424ms).
[12:02:55.289] <TB0> INFO: Expecting 514560 events.
[12:03:06.028] <TB0> INFO: 514560 events read in total (10337ms).
[12:03:06.070] <TB0> INFO: Expecting 514560 events.
[12:03:16.937] <TB0> INFO: 514560 events read in total (10465ms).
[12:03:16.985] <TB0> INFO: Test took 174633ms.
[12:03:18.078] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:03:18.086] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:03:18.086] <TB0> INFO: run 1 of 1
[12:03:18.347] <TB0> INFO: Expecting 6281600 events.
[12:03:49.275] <TB0> INFO: 745310 events read in total (30372ms).
[12:04:19.684] <TB0> INFO: 1490030 events read in total (60781ms).
[12:04:49.996] <TB0> INFO: 2235410 events read in total (91093ms).
[12:05:21.226] <TB0> INFO: 2980800 events read in total (122323ms).
[12:05:51.789] <TB0> INFO: 3721100 events read in total (152886ms).
[12:06:22.283] <TB0> INFO: 4457390 events read in total (183380ms).
[12:06:52.432] <TB0> INFO: 5191730 events read in total (213529ms).
[12:07:22.854] <TB0> INFO: 5926150 events read in total (243951ms).
[12:07:37.857] <TB0> INFO: 6281600 events read in total (258954ms).
[12:07:37.940] <TB0> INFO: Test took 259853ms.
[12:08:01.053] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 10.205454 .. 49.839548
[12:08:01.314] <TB0> INFO: Expecting 208000 events.
[12:08:11.142] <TB0> INFO: 208000 events read in total (9272ms).
[12:08:11.142] <TB0> INFO: Test took 10089ms.
[12:08:11.228] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 59 (-1/-1) hits flags = 528 (plus default)
[12:08:11.236] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:08:11.236] <TB0> INFO: run 1 of 1
[12:08:11.497] <TB0> INFO: Expecting 2496000 events.
[12:08:47.236] <TB0> INFO: 957480 events read in total (35183ms).
[12:09:21.108] <TB0> INFO: 1908660 events read in total (69055ms).
[12:09:42.882] <TB0> INFO: 2496000 events read in total (90829ms).
[12:09:42.923] <TB0> INFO: Test took 91687ms.
[12:09:57.753] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 20.870145 .. 44.642856
[12:09:58.015] <TB0> INFO: Expecting 208000 events.
[12:10:08.469] <TB0> INFO: 208000 events read in total (9898ms).
[12:10:08.470] <TB0> INFO: Test took 10716ms.
[12:10:08.558] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 10 .. 54 (-1/-1) hits flags = 528 (plus default)
[12:10:08.567] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:10:08.567] <TB0> INFO: run 1 of 1
[12:10:08.841] <TB0> INFO: Expecting 1872000 events.
[12:10:46.233] <TB0> INFO: 934890 events read in total (36836ms).
[12:11:20.407] <TB0> INFO: 1868140 events read in total (71010ms).
[12:11:20.938] <TB0> INFO: 1872000 events read in total (71541ms).
[12:11:20.956] <TB0> INFO: Test took 72388ms.
[12:11:34.406] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 21.822166 .. 42.035814
[12:11:34.667] <TB0> INFO: Expecting 208000 events.
[12:11:44.806] <TB0> INFO: 208000 events read in total (9583ms).
[12:11:44.806] <TB0> INFO: Test took 10399ms.
[12:11:44.894] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 11 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:11:44.902] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:11:44.906] <TB0> INFO: run 1 of 1
[12:11:45.174] <TB0> INFO: Expecting 1747200 events.
[12:12:21.164] <TB0> INFO: 947020 events read in total (35433ms).
[12:12:50.129] <TB0> INFO: 1747200 events read in total (64398ms).
[12:12:50.149] <TB0> INFO: Test took 65243ms.
[12:13:03.552] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 22.714648 .. 42.035814
[12:13:03.816] <TB0> INFO: Expecting 208000 events.
[12:13:13.662] <TB0> INFO: 208000 events read in total (9290ms).
[12:13:13.663] <TB0> INFO: Test took 10110ms.
[12:13:13.810] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 12 .. 52 (-1/-1) hits flags = 528 (plus default)
[12:13:13.819] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:13:13.819] <TB0> INFO: run 1 of 1
[12:13:14.092] <TB0> INFO: Expecting 1705600 events.
[12:13:49.422] <TB0> INFO: 941840 events read in total (34774ms).
[12:14:17.785] <TB0> INFO: 1705600 events read in total (63137ms).
[12:14:17.804] <TB0> INFO: Test took 63985ms.
[12:14:31.833] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[12:14:31.833] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[12:14:31.842] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:14:31.842] <TB0> INFO: run 1 of 1
[12:14:32.108] <TB0> INFO: Expecting 1705600 events.
[12:15:06.517] <TB0> INFO: 894160 events read in total (33853ms).
[12:15:37.511] <TB0> INFO: 1705600 events read in total (64847ms).
[12:15:37.530] <TB0> INFO: Test took 65688ms.
[12:15:51.498] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C0.dat
[12:15:51.498] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C1.dat
[12:15:51.498] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C2.dat
[12:15:51.498] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C3.dat
[12:15:51.498] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C4.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C5.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C6.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C7.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C8.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C9.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C10.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C11.dat
[12:15:51.499] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C12.dat
[12:15:51.500] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C13.dat
[12:15:51.500] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C14.dat
[12:15:51.500] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C15.dat
[12:15:51.500] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C0.dat
[12:15:51.507] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C1.dat
[12:15:51.513] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C2.dat
[12:15:51.519] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C3.dat
[12:15:51.526] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C4.dat
[12:15:51.532] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C5.dat
[12:15:51.539] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C6.dat
[12:15:51.545] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C7.dat
[12:15:51.552] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C8.dat
[12:15:51.558] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C9.dat
[12:15:51.565] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C10.dat
[12:15:51.571] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C11.dat
[12:15:51.578] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C12.dat
[12:15:51.584] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C13.dat
[12:15:51.591] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C14.dat
[12:15:51.597] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//trimParameters35_C15.dat
[12:15:51.604] <TB0> INFO: PixTestTrim::trimTest() done
[12:15:51.604] <TB0> INFO: vtrim: 102 127 96 97 101 111 105 104 106 110 92 95 101 104 86 87
[12:15:51.604] <TB0> INFO: vthrcomp: 102 86 97 86 93 94 82 88 87 85 81 84 89 95 72 86
[12:15:51.604] <TB0> INFO: vcal mean: 34.96 35.04 34.94 34.96 35.01 34.94 34.99 34.95 34.97 35.00 34.95 34.99 34.98 34.96 34.97 34.95
[12:15:51.604] <TB0> INFO: vcal RMS: 0.87 0.89 0.82 0.84 0.80 0.92 0.87 0.82 0.81 0.85 0.79 0.82 0.81 0.84 0.77 0.80
[12:15:51.604] <TB0> INFO: bits mean: 9.32 9.27 9.85 9.60 9.39 9.63 9.21 9.56 9.69 8.82 9.12 9.09 9.75 9.84 9.77 9.89
[12:15:51.604] <TB0> INFO: bits RMS: 2.64 2.80 2.72 2.56 2.75 2.65 2.74 2.56 2.72 2.98 2.77 2.76 2.62 2.57 2.44 2.63
[12:15:51.610] <TB0> INFO: ----------------------------------------------------------------------
[12:15:51.610] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[12:15:51.610] <TB0> INFO: ----------------------------------------------------------------------
[12:15:51.612] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[12:15:51.621] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:15:51.621] <TB0> INFO: run 1 of 1
[12:15:51.885] <TB0> INFO: Expecting 4160000 events.
[12:16:30.017] <TB0> INFO: 896960 events read in total (37576ms).
[12:17:06.281] <TB0> INFO: 1790890 events read in total (73840ms).
[12:17:42.865] <TB0> INFO: 2679095 events read in total (110424ms).
[12:18:19.722] <TB0> INFO: 3564380 events read in total (147281ms).
[12:18:44.471] <TB0> INFO: 4160000 events read in total (172030ms).
[12:18:44.533] <TB0> INFO: Test took 172912ms.
[12:19:13.786] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 153 (-1/-1) hits flags = 528 (plus default)
[12:19:13.795] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:19:13.795] <TB0> INFO: run 1 of 1
[12:19:14.057] <TB0> INFO: Expecting 3203200 events.
[12:19:54.337] <TB0> INFO: 959715 events read in total (39724ms).
[12:20:31.557] <TB0> INFO: 1912190 events read in total (76944ms).
[12:21:08.898] <TB0> INFO: 2856100 events read in total (114285ms).
[12:21:22.788] <TB0> INFO: 3203200 events read in total (128175ms).
[12:21:22.840] <TB0> INFO: Test took 129045ms.
[12:21:47.668] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 143 (-1/-1) hits flags = 528 (plus default)
[12:21:47.676] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:21:47.676] <TB0> INFO: run 1 of 1
[12:21:47.949] <TB0> INFO: Expecting 2995200 events.
[12:22:27.281] <TB0> INFO: 989795 events read in total (38776ms).
[12:23:05.277] <TB0> INFO: 1969150 events read in total (76772ms).
[12:23:43.311] <TB0> INFO: 2942700 events read in total (114806ms).
[12:23:45.700] <TB0> INFO: 2995200 events read in total (117195ms).
[12:23:45.744] <TB0> INFO: Test took 118068ms.
[12:24:09.667] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 143 (-1/-1) hits flags = 528 (plus default)
[12:24:09.676] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:24:09.676] <TB0> INFO: run 1 of 1
[12:24:09.945] <TB0> INFO: Expecting 2995200 events.
[12:24:49.912] <TB0> INFO: 988735 events read in total (39411ms).
[12:25:28.518] <TB0> INFO: 1967470 events read in total (78017ms).
[12:26:07.124] <TB0> INFO: 2940235 events read in total (116623ms).
[12:26:09.578] <TB0> INFO: 2995200 events read in total (119077ms).
[12:26:09.620] <TB0> INFO: Test took 119944ms.
[12:26:33.485] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 143 (-1/-1) hits flags = 528 (plus default)
[12:26:33.494] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:26:33.494] <TB0> INFO: run 1 of 1
[12:26:33.771] <TB0> INFO: Expecting 2995200 events.
[12:27:13.008] <TB0> INFO: 988120 events read in total (38681ms).
[12:27:51.586] <TB0> INFO: 1965665 events read in total (77259ms).
[12:28:29.952] <TB0> INFO: 2937675 events read in total (115625ms).
[12:28:32.480] <TB0> INFO: 2995200 events read in total (118153ms).
[12:28:32.521] <TB0> INFO: Test took 119028ms.
[12:28:55.940] <TB0> INFO: PixTestTrim::trimBitTest() done
[12:28:55.942] <TB0> INFO: PixTestTrim::doTest() done, duration: 2226 seconds
[12:28:55.942] <TB0> INFO: Decoding statistics:
[12:28:55.942] <TB0> INFO: General information:
[12:28:55.942] <TB0> INFO: 16bit words read: 0
[12:28:55.942] <TB0> INFO: valid events total: 0
[12:28:55.942] <TB0> INFO: empty events: 0
[12:28:55.942] <TB0> INFO: valid events with pixels: 0
[12:28:55.942] <TB0> INFO: valid pixel hits: 0
[12:28:55.942] <TB0> INFO: Event errors: 0
[12:28:55.942] <TB0> INFO: start marker: 0
[12:28:55.942] <TB0> INFO: stop marker: 0
[12:28:55.942] <TB0> INFO: overflow: 0
[12:28:55.942] <TB0> INFO: invalid 5bit words: 0
[12:28:55.942] <TB0> INFO: invalid XOR eye diagram: 0
[12:28:55.942] <TB0> INFO: frame (failed synchr.): 0
[12:28:55.942] <TB0> INFO: idle data (no TBM trl): 0
[12:28:55.942] <TB0> INFO: no data (only TBM hdr): 0
[12:28:55.942] <TB0> INFO: TBM errors: 0
[12:28:55.942] <TB0> INFO: flawed TBM headers: 0
[12:28:55.942] <TB0> INFO: flawed TBM trailers: 0
[12:28:55.942] <TB0> INFO: event ID mismatches: 0
[12:28:55.942] <TB0> INFO: ROC errors: 0
[12:28:55.942] <TB0> INFO: missing ROC header(s): 0
[12:28:55.942] <TB0> INFO: misplaced readback start: 0
[12:28:55.942] <TB0> INFO: Pixel decoding errors: 0
[12:28:55.942] <TB0> INFO: pixel data incomplete: 0
[12:28:55.942] <TB0> INFO: pixel address: 0
[12:28:55.942] <TB0> INFO: pulse height fill bit: 0
[12:28:55.942] <TB0> INFO: buffer corruption: 0
[12:28:56.660] <TB0> INFO: ######################################################################
[12:28:56.660] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[12:28:56.660] <TB0> INFO: ######################################################################
[12:28:56.923] <TB0> INFO: Expecting 41600 events.
[12:29:00.328] <TB0> INFO: 41600 events read in total (2849ms).
[12:29:00.329] <TB0> INFO: Test took 3668ms.
[12:29:00.815] <TB0> INFO: Expecting 41600 events.
[12:29:04.339] <TB0> INFO: 41600 events read in total (2968ms).
[12:29:04.340] <TB0> INFO: Test took 3816ms.
[12:29:04.628] <TB0> INFO: Expecting 41600 events.
[12:29:08.115] <TB0> INFO: 41600 events read in total (2931ms).
[12:29:08.115] <TB0> INFO: Test took 3754ms.
[12:29:08.370] <TB0> INFO: Expecting 2560 events.
[12:29:09.228] <TB0> INFO: 2560 events read in total (302ms).
[12:29:09.228] <TB0> INFO: Test took 1100ms.
[12:29:09.533] <TB0> INFO: Expecting 2560 events.
[12:29:10.390] <TB0> INFO: 2560 events read in total (301ms).
[12:29:10.390] <TB0> INFO: Test took 1162ms.
[12:29:10.695] <TB0> INFO: Expecting 2560 events.
[12:29:11.550] <TB0> INFO: 2560 events read in total (299ms).
[12:29:11.550] <TB0> INFO: Test took 1159ms.
[12:29:11.855] <TB0> INFO: Expecting 2560 events.
[12:29:12.707] <TB0> INFO: 2560 events read in total (295ms).
[12:29:12.708] <TB0> INFO: Test took 1157ms.
[12:29:13.013] <TB0> INFO: Expecting 2560 events.
[12:29:13.867] <TB0> INFO: 2560 events read in total (297ms).
[12:29:13.867] <TB0> INFO: Test took 1152ms.
[12:29:14.172] <TB0> INFO: Expecting 2560 events.
[12:29:15.027] <TB0> INFO: 2560 events read in total (299ms).
[12:29:15.027] <TB0> INFO: Test took 1160ms.
[12:29:15.332] <TB0> INFO: Expecting 2560 events.
[12:29:16.188] <TB0> INFO: 2560 events read in total (300ms).
[12:29:16.188] <TB0> INFO: Test took 1161ms.
[12:29:16.493] <TB0> INFO: Expecting 2560 events.
[12:29:17.346] <TB0> INFO: 2560 events read in total (297ms).
[12:29:17.346] <TB0> INFO: Test took 1157ms.
[12:29:17.651] <TB0> INFO: Expecting 2560 events.
[12:29:18.507] <TB0> INFO: 2560 events read in total (300ms).
[12:29:18.507] <TB0> INFO: Test took 1160ms.
[12:29:18.812] <TB0> INFO: Expecting 2560 events.
[12:29:19.664] <TB0> INFO: 2560 events read in total (296ms).
[12:29:19.664] <TB0> INFO: Test took 1155ms.
[12:29:19.969] <TB0> INFO: Expecting 2560 events.
[12:29:20.820] <TB0> INFO: 2560 events read in total (294ms).
[12:29:20.822] <TB0> INFO: Test took 1156ms.
[12:29:21.126] <TB0> INFO: Expecting 2560 events.
[12:29:21.980] <TB0> INFO: 2560 events read in total (298ms).
[12:29:21.980] <TB0> INFO: Test took 1158ms.
[12:29:22.284] <TB0> INFO: Expecting 2560 events.
[12:29:23.138] <TB0> INFO: 2560 events read in total (297ms).
[12:29:23.138] <TB0> INFO: Test took 1158ms.
[12:29:23.443] <TB0> INFO: Expecting 2560 events.
[12:29:24.295] <TB0> INFO: 2560 events read in total (296ms).
[12:29:24.295] <TB0> INFO: Test took 1156ms.
[12:29:24.600] <TB0> INFO: Expecting 2560 events.
[12:29:25.452] <TB0> INFO: 2560 events read in total (296ms).
[12:29:25.452] <TB0> INFO: Test took 1156ms.
[12:29:25.758] <TB0> INFO: Expecting 2560 events.
[12:29:26.608] <TB0> INFO: 2560 events read in total (294ms).
[12:29:26.608] <TB0> INFO: Test took 1154ms.
[12:29:26.611] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:29:26.914] <TB0> INFO: Expecting 655360 events.
[12:29:41.046] <TB0> INFO: 655360 events read in total (13576ms).
[12:29:41.063] <TB0> INFO: Expecting 655360 events.
[12:29:54.797] <TB0> INFO: 655360 events read in total (13333ms).
[12:29:54.812] <TB0> INFO: Expecting 655360 events.
[12:30:08.708] <TB0> INFO: 655360 events read in total (13494ms).
[12:30:08.731] <TB0> INFO: Expecting 655360 events.
[12:30:22.510] <TB0> INFO: 655360 events read in total (13377ms).
[12:30:22.533] <TB0> INFO: Expecting 655360 events.
[12:30:36.495] <TB0> INFO: 655360 events read in total (13560ms).
[12:30:36.522] <TB0> INFO: Expecting 655360 events.
[12:30:50.474] <TB0> INFO: 655360 events read in total (13551ms).
[12:30:50.507] <TB0> INFO: Expecting 655360 events.
[12:31:04.422] <TB0> INFO: 655360 events read in total (13514ms).
[12:31:04.457] <TB0> INFO: Expecting 655360 events.
[12:31:18.395] <TB0> INFO: 655360 events read in total (13536ms).
[12:31:18.442] <TB0> INFO: Expecting 655360 events.
[12:31:32.359] <TB0> INFO: 655360 events read in total (13515ms).
[12:31:32.402] <TB0> INFO: Expecting 655360 events.
[12:31:46.382] <TB0> INFO: 655360 events read in total (13578ms).
[12:31:46.432] <TB0> INFO: Expecting 655360 events.
[12:32:00.505] <TB0> INFO: 655360 events read in total (13671ms).
[12:32:00.557] <TB0> INFO: Expecting 655360 events.
[12:32:14.510] <TB0> INFO: 655360 events read in total (13534ms).
[12:32:14.569] <TB0> INFO: Expecting 655360 events.
[12:32:28.511] <TB0> INFO: 655360 events read in total (13541ms).
[12:32:28.582] <TB0> INFO: Expecting 655360 events.
[12:32:42.513] <TB0> INFO: 655360 events read in total (13530ms).
[12:32:42.576] <TB0> INFO: Expecting 655360 events.
[12:32:56.620] <TB0> INFO: 655360 events read in total (13643ms).
[12:32:56.692] <TB0> INFO: Expecting 655360 events.
[12:33:10.732] <TB0> INFO: 655360 events read in total (13638ms).
[12:33:10.820] <TB0> INFO: Test took 224209ms.
[12:33:10.901] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:33:11.132] <TB0> INFO: Expecting 655360 events.
[12:33:25.224] <TB0> INFO: 655360 events read in total (13536ms).
[12:33:25.234] <TB0> INFO: Expecting 655360 events.
[12:33:39.269] <TB0> INFO: 655360 events read in total (13634ms).
[12:33:39.284] <TB0> INFO: Expecting 655360 events.
[12:33:53.321] <TB0> INFO: 655360 events read in total (13636ms).
[12:33:53.340] <TB0> INFO: Expecting 655360 events.
[12:34:07.444] <TB0> INFO: 655360 events read in total (13703ms).
[12:34:07.468] <TB0> INFO: Expecting 655360 events.
[12:34:21.405] <TB0> INFO: 655360 events read in total (13536ms).
[12:34:21.435] <TB0> INFO: Expecting 655360 events.
[12:34:35.394] <TB0> INFO: 655360 events read in total (13557ms).
[12:34:35.426] <TB0> INFO: Expecting 655360 events.
[12:34:49.442] <TB0> INFO: 655360 events read in total (13614ms).
[12:34:49.479] <TB0> INFO: Expecting 655360 events.
[12:35:03.548] <TB0> INFO: 655360 events read in total (13667ms).
[12:35:03.605] <TB0> INFO: Expecting 655360 events.
[12:35:17.546] <TB0> INFO: 655360 events read in total (13539ms).
[12:35:17.594] <TB0> INFO: Expecting 655360 events.
[12:35:31.555] <TB0> INFO: 655360 events read in total (13559ms).
[12:35:31.604] <TB0> INFO: Expecting 655360 events.
[12:35:45.515] <TB0> INFO: 655360 events read in total (13510ms).
[12:35:45.578] <TB0> INFO: Expecting 655360 events.
[12:35:59.538] <TB0> INFO: 655360 events read in total (13558ms).
[12:35:59.594] <TB0> INFO: Expecting 655360 events.
[12:36:13.583] <TB0> INFO: 655360 events read in total (13587ms).
[12:36:13.650] <TB0> INFO: Expecting 655360 events.
[12:36:27.732] <TB0> INFO: 655360 events read in total (13680ms).
[12:36:27.801] <TB0> INFO: Expecting 655360 events.
[12:36:41.746] <TB0> INFO: 655360 events read in total (13544ms).
[12:36:41.817] <TB0> INFO: Expecting 655360 events.
[12:36:55.828] <TB0> INFO: 655360 events read in total (13609ms).
[12:36:55.911] <TB0> INFO: Test took 225010ms.
[12:36:56.129] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.137] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.144] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.151] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.163] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.174] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.185] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.192] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.200] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.207] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.214] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.221] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.228] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.238] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.245] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.252] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C0.dat
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C1.dat
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C2.dat
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C3.dat
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C4.dat
[12:36:56.284] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C5.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C6.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C7.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C8.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C9.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C10.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C11.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C12.dat
[12:36:56.285] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C13.dat
[12:36:56.286] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C14.dat
[12:36:56.286] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//dacParameters35_C15.dat
[12:36:56.555] <TB0> INFO: Expecting 41600 events.
[12:36:59.670] <TB0> INFO: 41600 events read in total (2559ms).
[12:36:59.670] <TB0> INFO: Test took 3382ms.
[12:37:00.111] <TB0> INFO: Expecting 41600 events.
[12:37:03.235] <TB0> INFO: 41600 events read in total (2568ms).
[12:37:03.236] <TB0> INFO: Test took 3390ms.
[12:37:03.683] <TB0> INFO: Expecting 41600 events.
[12:37:06.821] <TB0> INFO: 41600 events read in total (2582ms).
[12:37:06.822] <TB0> INFO: Test took 3404ms.
[12:37:07.006] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:07.095] <TB0> INFO: Expecting 2560 events.
[12:37:07.948] <TB0> INFO: 2560 events read in total (297ms).
[12:37:07.948] <TB0> INFO: Test took 942ms.
[12:37:07.950] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:08.253] <TB0> INFO: Expecting 2560 events.
[12:37:09.109] <TB0> INFO: 2560 events read in total (300ms).
[12:37:09.109] <TB0> INFO: Test took 1159ms.
[12:37:09.111] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:09.415] <TB0> INFO: Expecting 2560 events.
[12:37:10.268] <TB0> INFO: 2560 events read in total (297ms).
[12:37:10.268] <TB0> INFO: Test took 1157ms.
[12:37:10.270] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:10.573] <TB0> INFO: Expecting 2560 events.
[12:37:11.425] <TB0> INFO: 2560 events read in total (296ms).
[12:37:11.425] <TB0> INFO: Test took 1155ms.
[12:37:11.427] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:11.730] <TB0> INFO: Expecting 2560 events.
[12:37:12.581] <TB0> INFO: 2560 events read in total (295ms).
[12:37:12.582] <TB0> INFO: Test took 1155ms.
[12:37:12.583] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:12.887] <TB0> INFO: Expecting 2560 events.
[12:37:13.745] <TB0> INFO: 2560 events read in total (302ms).
[12:37:13.745] <TB0> INFO: Test took 1162ms.
[12:37:13.748] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:14.051] <TB0> INFO: Expecting 2560 events.
[12:37:14.904] <TB0> INFO: 2560 events read in total (297ms).
[12:37:14.904] <TB0> INFO: Test took 1157ms.
[12:37:14.906] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:15.211] <TB0> INFO: Expecting 2560 events.
[12:37:16.072] <TB0> INFO: 2560 events read in total (305ms).
[12:37:16.073] <TB0> INFO: Test took 1167ms.
[12:37:16.074] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:16.378] <TB0> INFO: Expecting 2560 events.
[12:37:17.236] <TB0> INFO: 2560 events read in total (301ms).
[12:37:17.237] <TB0> INFO: Test took 1163ms.
[12:37:17.241] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:17.542] <TB0> INFO: Expecting 2560 events.
[12:37:18.401] <TB0> INFO: 2560 events read in total (303ms).
[12:37:18.401] <TB0> INFO: Test took 1160ms.
[12:37:18.403] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:18.706] <TB0> INFO: Expecting 2560 events.
[12:37:19.559] <TB0> INFO: 2560 events read in total (297ms).
[12:37:19.559] <TB0> INFO: Test took 1157ms.
[12:37:19.561] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:19.865] <TB0> INFO: Expecting 2560 events.
[12:37:20.722] <TB0> INFO: 2560 events read in total (301ms).
[12:37:20.723] <TB0> INFO: Test took 1162ms.
[12:37:20.724] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:21.028] <TB0> INFO: Expecting 2560 events.
[12:37:21.879] <TB0> INFO: 2560 events read in total (295ms).
[12:37:21.880] <TB0> INFO: Test took 1156ms.
[12:37:21.882] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:22.185] <TB0> INFO: Expecting 2560 events.
[12:37:23.037] <TB0> INFO: 2560 events read in total (296ms).
[12:37:23.037] <TB0> INFO: Test took 1156ms.
[12:37:23.040] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:23.343] <TB0> INFO: Expecting 2560 events.
[12:37:24.198] <TB0> INFO: 2560 events read in total (299ms).
[12:37:24.199] <TB0> INFO: Test took 1159ms.
[12:37:24.202] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:24.504] <TB0> INFO: Expecting 2560 events.
[12:37:25.363] <TB0> INFO: 2560 events read in total (303ms).
[12:37:25.363] <TB0> INFO: Test took 1161ms.
[12:37:25.365] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:25.669] <TB0> INFO: Expecting 2560 events.
[12:37:26.522] <TB0> INFO: 2560 events read in total (297ms).
[12:37:26.522] <TB0> INFO: Test took 1157ms.
[12:37:26.524] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:26.828] <TB0> INFO: Expecting 2560 events.
[12:37:27.683] <TB0> INFO: 2560 events read in total (299ms).
[12:37:27.683] <TB0> INFO: Test took 1159ms.
[12:37:27.685] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:27.988] <TB0> INFO: Expecting 2560 events.
[12:37:28.840] <TB0> INFO: 2560 events read in total (295ms).
[12:37:28.840] <TB0> INFO: Test took 1156ms.
[12:37:28.842] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:29.146] <TB0> INFO: Expecting 2560 events.
[12:37:29.999] <TB0> INFO: 2560 events read in total (297ms).
[12:37:30.000] <TB0> INFO: Test took 1158ms.
[12:37:30.002] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:30.305] <TB0> INFO: Expecting 2560 events.
[12:37:31.163] <TB0> INFO: 2560 events read in total (302ms).
[12:37:31.164] <TB0> INFO: Test took 1162ms.
[12:37:31.167] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:31.469] <TB0> INFO: Expecting 2560 events.
[12:37:32.324] <TB0> INFO: 2560 events read in total (299ms).
[12:37:32.325] <TB0> INFO: Test took 1159ms.
[12:37:32.327] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:32.630] <TB0> INFO: Expecting 2560 events.
[12:37:33.486] <TB0> INFO: 2560 events read in total (300ms).
[12:37:33.486] <TB0> INFO: Test took 1159ms.
[12:37:33.490] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:33.791] <TB0> INFO: Expecting 2560 events.
[12:37:34.645] <TB0> INFO: 2560 events read in total (298ms).
[12:37:34.645] <TB0> INFO: Test took 1155ms.
[12:37:34.647] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:34.951] <TB0> INFO: Expecting 2560 events.
[12:37:35.804] <TB0> INFO: 2560 events read in total (297ms).
[12:37:35.804] <TB0> INFO: Test took 1157ms.
[12:37:35.806] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:36.109] <TB0> INFO: Expecting 2560 events.
[12:37:36.961] <TB0> INFO: 2560 events read in total (296ms).
[12:37:36.962] <TB0> INFO: Test took 1156ms.
[12:37:36.965] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:37.267] <TB0> INFO: Expecting 2560 events.
[12:37:38.122] <TB0> INFO: 2560 events read in total (299ms).
[12:37:38.122] <TB0> INFO: Test took 1157ms.
[12:37:38.124] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:38.427] <TB0> INFO: Expecting 2560 events.
[12:37:39.290] <TB0> INFO: 2560 events read in total (307ms).
[12:37:39.290] <TB0> INFO: Test took 1166ms.
[12:37:39.292] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:39.595] <TB0> INFO: Expecting 2560 events.
[12:37:40.448] <TB0> INFO: 2560 events read in total (297ms).
[12:37:40.448] <TB0> INFO: Test took 1156ms.
[12:37:40.450] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:40.754] <TB0> INFO: Expecting 2560 events.
[12:37:41.613] <TB0> INFO: 2560 events read in total (303ms).
[12:37:41.613] <TB0> INFO: Test took 1163ms.
[12:37:41.616] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:41.918] <TB0> INFO: Expecting 2560 events.
[12:37:42.774] <TB0> INFO: 2560 events read in total (300ms).
[12:37:42.774] <TB0> INFO: Test took 1158ms.
[12:37:42.777] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:37:43.080] <TB0> INFO: Expecting 2560 events.
[12:37:43.937] <TB0> INFO: 2560 events read in total (301ms).
[12:37:43.938] <TB0> INFO: Test took 1161ms.
[12:37:44.410] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 527 seconds
[12:37:44.410] <TB0> INFO: PH scale (per ROC): 81 78 90 78 91 76 79 84 81 81 88 83 81 91 87 89
[12:37:44.410] <TB0> INFO: PH offset (per ROC): 147 160 150 150 142 157 166 150 141 162 144 147 145 154 137 137
[12:37:44.415] <TB0> INFO: Decoding statistics:
[12:37:44.415] <TB0> INFO: General information:
[12:37:44.415] <TB0> INFO: 16bit words read: 86922
[12:37:44.415] <TB0> INFO: valid events total: 10240
[12:37:44.415] <TB0> INFO: empty events: 7739
[12:37:44.415] <TB0> INFO: valid events with pixels: 2501
[12:37:44.415] <TB0> INFO: valid pixel hits: 2501
[12:37:44.415] <TB0> INFO: Event errors: 0
[12:37:44.415] <TB0> INFO: start marker: 0
[12:37:44.415] <TB0> INFO: stop marker: 0
[12:37:44.415] <TB0> INFO: overflow: 0
[12:37:44.415] <TB0> INFO: invalid 5bit words: 0
[12:37:44.415] <TB0> INFO: invalid XOR eye diagram: 0
[12:37:44.415] <TB0> INFO: frame (failed synchr.): 0
[12:37:44.415] <TB0> INFO: idle data (no TBM trl): 0
[12:37:44.415] <TB0> INFO: no data (only TBM hdr): 0
[12:37:44.415] <TB0> INFO: TBM errors: 0
[12:37:44.415] <TB0> INFO: flawed TBM headers: 0
[12:37:44.415] <TB0> INFO: flawed TBM trailers: 0
[12:37:44.415] <TB0> INFO: event ID mismatches: 0
[12:37:44.415] <TB0> INFO: ROC errors: 0
[12:37:44.415] <TB0> INFO: missing ROC header(s): 0
[12:37:44.415] <TB0> INFO: misplaced readback start: 0
[12:37:44.415] <TB0> INFO: Pixel decoding errors: 0
[12:37:44.415] <TB0> INFO: pixel data incomplete: 0
[12:37:44.415] <TB0> INFO: pixel address: 0
[12:37:44.415] <TB0> INFO: pulse height fill bit: 0
[12:37:44.415] <TB0> INFO: buffer corruption: 0
[12:37:44.604] <TB0> INFO: ######################################################################
[12:37:44.604] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[12:37:44.604] <TB0> INFO: ######################################################################
[12:37:44.614] <TB0> INFO: scanning low vcal = 10
[12:37:44.884] <TB0> INFO: Expecting 41600 events.
[12:37:48.289] <TB0> INFO: 41600 events read in total (2849ms).
[12:37:48.289] <TB0> INFO: Test took 3675ms.
[12:37:48.291] <TB0> INFO: scanning low vcal = 20
[12:37:48.584] <TB0> INFO: Expecting 41600 events.
[12:37:51.998] <TB0> INFO: 41600 events read in total (2857ms).
[12:37:51.998] <TB0> INFO: Test took 3707ms.
[12:37:51.999] <TB0> INFO: scanning low vcal = 30
[12:37:52.297] <TB0> INFO: Expecting 41600 events.
[12:37:55.730] <TB0> INFO: 41600 events read in total (2877ms).
[12:37:55.731] <TB0> INFO: Test took 3732ms.
[12:37:55.733] <TB0> INFO: scanning low vcal = 40
[12:37:56.018] <TB0> INFO: Expecting 41600 events.
[12:37:59.903] <TB0> INFO: 41600 events read in total (3329ms).
[12:37:59.904] <TB0> INFO: Test took 4171ms.
[12:37:59.907] <TB0> INFO: scanning low vcal = 50
[12:38:00.190] <TB0> INFO: Expecting 41600 events.
[12:38:04.127] <TB0> INFO: 41600 events read in total (3381ms).
[12:38:04.128] <TB0> INFO: Test took 4221ms.
[12:38:04.130] <TB0> INFO: scanning low vcal = 60
[12:38:04.399] <TB0> INFO: Expecting 41600 events.
[12:38:08.346] <TB0> INFO: 41600 events read in total (3391ms).
[12:38:08.346] <TB0> INFO: Test took 4216ms.
[12:38:08.349] <TB0> INFO: scanning low vcal = 70
[12:38:08.613] <TB0> INFO: Expecting 41600 events.
[12:38:12.578] <TB0> INFO: 41600 events read in total (3408ms).
[12:38:12.578] <TB0> INFO: Test took 4229ms.
[12:38:12.581] <TB0> INFO: scanning low vcal = 80
[12:38:12.841] <TB0> INFO: Expecting 41600 events.
[12:38:16.779] <TB0> INFO: 41600 events read in total (3382ms).
[12:38:16.780] <TB0> INFO: Test took 4199ms.
[12:38:16.782] <TB0> INFO: scanning low vcal = 90
[12:38:17.048] <TB0> INFO: Expecting 41600 events.
[12:38:20.981] <TB0> INFO: 41600 events read in total (3377ms).
[12:38:20.982] <TB0> INFO: Test took 4200ms.
[12:38:20.985] <TB0> INFO: scanning low vcal = 100
[12:38:21.245] <TB0> INFO: Expecting 41600 events.
[12:38:25.204] <TB0> INFO: 41600 events read in total (3403ms).
[12:38:25.205] <TB0> INFO: Test took 4220ms.
[12:38:25.207] <TB0> INFO: scanning low vcal = 110
[12:38:25.472] <TB0> INFO: Expecting 41600 events.
[12:38:29.429] <TB0> INFO: 41600 events read in total (3401ms).
[12:38:29.431] <TB0> INFO: Test took 4224ms.
[12:38:29.434] <TB0> INFO: scanning low vcal = 120
[12:38:29.703] <TB0> INFO: Expecting 41600 events.
[12:38:33.670] <TB0> INFO: 41600 events read in total (3411ms).
[12:38:33.671] <TB0> INFO: Test took 4237ms.
[12:38:33.673] <TB0> INFO: scanning low vcal = 130
[12:38:33.959] <TB0> INFO: Expecting 41600 events.
[12:38:37.894] <TB0> INFO: 41600 events read in total (3379ms).
[12:38:37.895] <TB0> INFO: Test took 4222ms.
[12:38:37.897] <TB0> INFO: scanning low vcal = 140
[12:38:38.161] <TB0> INFO: Expecting 41600 events.
[12:38:42.105] <TB0> INFO: 41600 events read in total (3388ms).
[12:38:42.105] <TB0> INFO: Test took 4208ms.
[12:38:42.107] <TB0> INFO: scanning low vcal = 150
[12:38:42.372] <TB0> INFO: Expecting 41600 events.
[12:38:46.375] <TB0> INFO: 41600 events read in total (3447ms).
[12:38:46.375] <TB0> INFO: Test took 4267ms.
[12:38:46.378] <TB0> INFO: scanning low vcal = 160
[12:38:46.641] <TB0> INFO: Expecting 41600 events.
[12:38:50.601] <TB0> INFO: 41600 events read in total (3404ms).
[12:38:50.601] <TB0> INFO: Test took 4223ms.
[12:38:50.609] <TB0> INFO: scanning low vcal = 170
[12:38:50.875] <TB0> INFO: Expecting 41600 events.
[12:38:54.834] <TB0> INFO: 41600 events read in total (3403ms).
[12:38:54.834] <TB0> INFO: Test took 4225ms.
[12:38:54.838] <TB0> INFO: scanning low vcal = 180
[12:38:55.103] <TB0> INFO: Expecting 41600 events.
[12:38:59.069] <TB0> INFO: 41600 events read in total (3409ms).
[12:38:59.070] <TB0> INFO: Test took 4232ms.
[12:38:59.072] <TB0> INFO: scanning low vcal = 190
[12:38:59.336] <TB0> INFO: Expecting 41600 events.
[12:39:03.281] <TB0> INFO: 41600 events read in total (3389ms).
[12:39:03.281] <TB0> INFO: Test took 4209ms.
[12:39:03.283] <TB0> INFO: scanning low vcal = 200
[12:39:03.549] <TB0> INFO: Expecting 41600 events.
[12:39:07.507] <TB0> INFO: 41600 events read in total (3402ms).
[12:39:07.507] <TB0> INFO: Test took 4224ms.
[12:39:07.510] <TB0> INFO: scanning low vcal = 210
[12:39:07.795] <TB0> INFO: Expecting 41600 events.
[12:39:11.752] <TB0> INFO: 41600 events read in total (3401ms).
[12:39:11.753] <TB0> INFO: Test took 4243ms.
[12:39:11.755] <TB0> INFO: scanning low vcal = 220
[12:39:12.026] <TB0> INFO: Expecting 41600 events.
[12:39:15.994] <TB0> INFO: 41600 events read in total (3412ms).
[12:39:15.995] <TB0> INFO: Test took 4240ms.
[12:39:15.997] <TB0> INFO: scanning low vcal = 230
[12:39:16.260] <TB0> INFO: Expecting 41600 events.
[12:39:20.196] <TB0> INFO: 41600 events read in total (3380ms).
[12:39:20.197] <TB0> INFO: Test took 4200ms.
[12:39:20.199] <TB0> INFO: scanning low vcal = 240
[12:39:20.463] <TB0> INFO: Expecting 41600 events.
[12:39:24.417] <TB0> INFO: 41600 events read in total (3398ms).
[12:39:24.418] <TB0> INFO: Test took 4218ms.
[12:39:24.421] <TB0> INFO: scanning low vcal = 250
[12:39:24.706] <TB0> INFO: Expecting 41600 events.
[12:39:28.664] <TB0> INFO: 41600 events read in total (3402ms).
[12:39:28.665] <TB0> INFO: Test took 4244ms.
[12:39:28.668] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[12:39:28.932] <TB0> INFO: Expecting 41600 events.
[12:39:32.893] <TB0> INFO: 41600 events read in total (3405ms).
[12:39:32.893] <TB0> INFO: Test took 4225ms.
[12:39:32.896] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[12:39:33.172] <TB0> INFO: Expecting 41600 events.
[12:39:37.128] <TB0> INFO: 41600 events read in total (3399ms).
[12:39:37.129] <TB0> INFO: Test took 4233ms.
[12:39:37.132] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[12:39:37.397] <TB0> INFO: Expecting 41600 events.
[12:39:41.325] <TB0> INFO: 41600 events read in total (3371ms).
[12:39:41.326] <TB0> INFO: Test took 4194ms.
[12:39:41.328] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[12:39:41.593] <TB0> INFO: Expecting 41600 events.
[12:39:45.534] <TB0> INFO: 41600 events read in total (3384ms).
[12:39:45.534] <TB0> INFO: Test took 4206ms.
[12:39:45.537] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[12:39:45.810] <TB0> INFO: Expecting 41600 events.
[12:39:49.735] <TB0> INFO: 41600 events read in total (3368ms).
[12:39:49.736] <TB0> INFO: Test took 4199ms.
[12:39:50.269] <TB0> INFO: PixTestGainPedestal::measure() done
[12:40:24.428] <TB0> INFO: PixTestGainPedestal::fit() done
[12:40:24.429] <TB0> INFO: non-linearity mean: 0.957 0.948 0.958 0.956 0.951 0.959 0.949 0.953 0.955 0.954 0.951 0.953 0.957 0.960 0.959 0.950
[12:40:24.429] <TB0> INFO: non-linearity RMS: 0.006 0.007 0.005 0.006 0.007 0.006 0.006 0.006 0.005 0.007 0.005 0.007 0.006 0.006 0.005 0.006
[12:40:24.429] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[12:40:24.461] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[12:40:24.493] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[12:40:24.525] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[12:40:24.557] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[12:40:24.589] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[12:40:24.621] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[12:40:24.643] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[12:40:24.661] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[12:40:24.679] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[12:40:24.697] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[12:40:24.715] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[12:40:24.733] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[12:40:24.751] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[12:40:24.769] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[12:40:24.787] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[12:40:24.805] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 160 seconds
[12:40:24.805] <TB0> INFO: Decoding statistics:
[12:40:24.805] <TB0> INFO: General information:
[12:40:24.805] <TB0> INFO: 16bit words read: 2662400
[12:40:24.805] <TB0> INFO: valid events total: 166400
[12:40:24.805] <TB0> INFO: empty events: 0
[12:40:24.805] <TB0> INFO: valid events with pixels: 166400
[12:40:24.805] <TB0> INFO: valid pixel hits: 665600
[12:40:24.805] <TB0> INFO: Event errors: 0
[12:40:24.805] <TB0> INFO: start marker: 0
[12:40:24.805] <TB0> INFO: stop marker: 0
[12:40:24.805] <TB0> INFO: overflow: 0
[12:40:24.805] <TB0> INFO: invalid 5bit words: 0
[12:40:24.805] <TB0> INFO: invalid XOR eye diagram: 0
[12:40:24.805] <TB0> INFO: frame (failed synchr.): 0
[12:40:24.805] <TB0> INFO: idle data (no TBM trl): 0
[12:40:24.805] <TB0> INFO: no data (only TBM hdr): 0
[12:40:24.805] <TB0> INFO: TBM errors: 0
[12:40:24.805] <TB0> INFO: flawed TBM headers: 0
[12:40:24.805] <TB0> INFO: flawed TBM trailers: 0
[12:40:24.805] <TB0> INFO: event ID mismatches: 0
[12:40:24.805] <TB0> INFO: ROC errors: 0
[12:40:24.805] <TB0> INFO: missing ROC header(s): 0
[12:40:24.805] <TB0> INFO: misplaced readback start: 0
[12:40:24.805] <TB0> INFO: Pixel decoding errors: 0
[12:40:24.805] <TB0> INFO: pixel data incomplete: 0
[12:40:24.805] <TB0> INFO: pixel address: 0
[12:40:24.805] <TB0> INFO: pulse height fill bit: 0
[12:40:24.805] <TB0> INFO: buffer corruption: 0
[12:40:24.813] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C15.dat
[12:40:24.815] <TB0> INFO: ######################################################################
[12:40:24.815] <TB0> INFO: PixTestReadback::doTest()
[12:40:24.815] <TB0> INFO: ######################################################################
[12:40:24.815] <TB0> INFO: ----------------------------------------------------------------------
[12:40:24.815] <TB0> INFO: PixTestReadback::CalibrateVd()
[12:40:24.815] <TB0> INFO: ----------------------------------------------------------------------
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C0.dat
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C1.dat
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C2.dat
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C3.dat
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C4.dat
[12:40:34.249] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C5.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C6.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C7.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C8.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C9.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C10.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C11.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C12.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C13.dat
[12:40:34.250] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C14.dat
[12:40:34.251] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C15.dat
[12:40:34.276] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[12:40:34.276] <TB0> INFO: ----------------------------------------------------------------------
[12:40:34.276] <TB0> INFO: PixTestReadback::CalibrateVa()
[12:40:34.276] <TB0> INFO: ----------------------------------------------------------------------
[12:40:43.762] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C0.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C1.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C2.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C3.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C4.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C5.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C6.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C7.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C8.dat
[12:40:43.783] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C9.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C10.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C11.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C12.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C13.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C14.dat
[12:40:43.784] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C15.dat
[12:40:43.813] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[12:40:43.813] <TB0> INFO: ----------------------------------------------------------------------
[12:40:43.813] <TB0> INFO: PixTestReadback::readbackVbg()
[12:40:43.813] <TB0> INFO: ----------------------------------------------------------------------
[12:40:51.113] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[12:40:51.113] <TB0> INFO: ----------------------------------------------------------------------
[12:40:51.113] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[12:40:51.113] <TB0> INFO: ----------------------------------------------------------------------
[12:40:51.113] <TB0> INFO: Vbg will be calibrated using Vd calibration
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 152.6calibrated Vbg = 1.23325 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 141.7calibrated Vbg = 1.23167 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 146.5calibrated Vbg = 1.23327 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 149.6calibrated Vbg = 1.23939 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 144calibrated Vbg = 1.235 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 152.5calibrated Vbg = 1.24249 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 156.7calibrated Vbg = 1.24286 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 152.5calibrated Vbg = 1.24141 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 144.1calibrated Vbg = 1.24007 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 147.9calibrated Vbg = 1.24303 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 156.6calibrated Vbg = 1.23989 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 159.2calibrated Vbg = 1.24086 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 148.4calibrated Vbg = 1.23902 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 157.6calibrated Vbg = 1.2269 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 136calibrated Vbg = 1.23511 :::*/*/*/*/
[12:40:51.113] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 153.3calibrated Vbg = 1.23442 :::*/*/*/*/
[12:40:51.117] <TB0> INFO: ----------------------------------------------------------------------
[12:40:51.117] <TB0> INFO: PixTestReadback::CalibrateIa()
[12:40:51.117] <TB0> INFO: ----------------------------------------------------------------------
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C0.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C1.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C2.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C3.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C4.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C5.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C6.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C7.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C8.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C9.dat
[12:43:26.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C10.dat
[12:43:26.328] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C11.dat
[12:43:26.328] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C12.dat
[12:43:26.328] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C13.dat
[12:43:26.328] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C14.dat
[12:43:26.328] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2356_FullQualification_2016-10-10_09h35m_1476084938//002_FulltestPxar_m20//readbackCal_C15.dat
[12:43:26.348] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[12:43:26.349] <TB0> INFO: PixTestReadback::doTest() done
[12:43:26.349] <TB0> INFO: Decoding statistics:
[12:43:26.349] <TB0> INFO: General information:
[12:43:26.349] <TB0> INFO: 16bit words read: 1024
[12:43:26.349] <TB0> INFO: valid events total: 128
[12:43:26.349] <TB0> INFO: empty events: 128
[12:43:26.349] <TB0> INFO: valid events with pixels: 0
[12:43:26.349] <TB0> INFO: valid pixel hits: 0
[12:43:26.349] <TB0> INFO: Event errors: 0
[12:43:26.349] <TB0> INFO: start marker: 0
[12:43:26.349] <TB0> INFO: stop marker: 0
[12:43:26.349] <TB0> INFO: overflow: 0
[12:43:26.349] <TB0> INFO: invalid 5bit words: 0
[12:43:26.349] <TB0> INFO: invalid XOR eye diagram: 0
[12:43:26.349] <TB0> INFO: frame (failed synchr.): 0
[12:43:26.349] <TB0> INFO: idle data (no TBM trl): 0
[12:43:26.349] <TB0> INFO: no data (only TBM hdr): 0
[12:43:26.349] <TB0> INFO: TBM errors: 0
[12:43:26.349] <TB0> INFO: flawed TBM headers: 0
[12:43:26.349] <TB0> INFO: flawed TBM trailers: 0
[12:43:26.349] <TB0> INFO: event ID mismatches: 0
[12:43:26.349] <TB0> INFO: ROC errors: 0
[12:43:26.349] <TB0> INFO: missing ROC header(s): 0
[12:43:26.349] <TB0> INFO: misplaced readback start: 0
[12:43:26.349] <TB0> INFO: Pixel decoding errors: 0
[12:43:26.349] <TB0> INFO: pixel data incomplete: 0
[12:43:26.349] <TB0> INFO: pixel address: 0
[12:43:26.349] <TB0> INFO: pulse height fill bit: 0
[12:43:26.349] <TB0> INFO: buffer corruption: 0
[12:43:26.369] <TB0> INFO: Decoding statistics:
[12:43:26.369] <TB0> INFO: General information:
[12:43:26.369] <TB0> INFO: 16bit words read: 2750346
[12:43:26.369] <TB0> INFO: valid events total: 176768
[12:43:26.369] <TB0> INFO: empty events: 7867
[12:43:26.369] <TB0> INFO: valid events with pixels: 168901
[12:43:26.369] <TB0> INFO: valid pixel hits: 668101
[12:43:26.369] <TB0> INFO: Event errors: 0
[12:43:26.369] <TB0> INFO: start marker: 0
[12:43:26.369] <TB0> INFO: stop marker: 0
[12:43:26.369] <TB0> INFO: overflow: 0
[12:43:26.369] <TB0> INFO: invalid 5bit words: 0
[12:43:26.369] <TB0> INFO: invalid XOR eye diagram: 0
[12:43:26.369] <TB0> INFO: frame (failed synchr.): 0
[12:43:26.369] <TB0> INFO: idle data (no TBM trl): 0
[12:43:26.369] <TB0> INFO: no data (only TBM hdr): 0
[12:43:26.369] <TB0> INFO: TBM errors: 0
[12:43:26.369] <TB0> INFO: flawed TBM headers: 0
[12:43:26.369] <TB0> INFO: flawed TBM trailers: 0
[12:43:26.369] <TB0> INFO: event ID mismatches: 0
[12:43:26.369] <TB0> INFO: ROC errors: 0
[12:43:26.369] <TB0> INFO: missing ROC header(s): 0
[12:43:26.369] <TB0> INFO: misplaced readback start: 0
[12:43:26.369] <TB0> INFO: Pixel decoding errors: 0
[12:43:26.369] <TB0> INFO: pixel data incomplete: 0
[12:43:26.369] <TB0> INFO: pixel address: 0
[12:43:26.369] <TB0> INFO: pulse height fill bit: 0
[12:43:26.369] <TB0> INFO: buffer corruption: 0
[12:43:26.369] <TB0> INFO: enter test to run
[12:43:26.369] <TB0> INFO: test: exit no parameter change
[12:43:26.562] <TB0> QUIET: Connection to board 73 closed.
[12:43:26.642] <TB0> INFO: pXar: this is the end, my friend