[10:49:57.434] <TB2> INFO: *** Welcome to pxar ***
[10:49:57.434] <TB2> INFO: *** Today: 2016/02/05
[10:49:57.535] <TB2> INFO: *** Version: 9751-dirty
[10:49:57.535] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C15.dat
[10:49:57.536] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//tbmParameters_C0b.dat
[10:49:57.536] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//defaultMaskFile.dat
[10:49:57.536] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters_C15.dat
[10:49:57.607] <TB2> INFO: clk: 4
[10:49:57.607] <TB2> INFO: ctr: 4
[10:49:57.607] <TB2> INFO: sda: 19
[10:49:57.607] <TB2> INFO: tin: 9
[10:49:57.607] <TB2> INFO: level: 15
[10:49:57.607] <TB2> INFO: triggerdelay: 0
[10:49:57.607] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[10:49:57.607] <TB2> INFO: Log level: INFO
[10:49:57.614] <TB2> INFO: Found DTB DTB_WXC55Z
[10:49:57.624] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[10:49:57.626] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[10:49:57.628] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[10:49:59.168] <TB2> INFO: DUT info:
[10:49:59.168] <TB2> INFO: The DUT currently contains the following objects:
[10:49:59.168] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[10:49:59.168] <TB2> INFO: TBM Core alpha (0): 7 registers set
[10:49:59.169] <TB2> INFO: TBM Core beta (1): 7 registers set
[10:49:59.169] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:49:59.169] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.169] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:49:59.571] <TB2> INFO: enter 'restricted' command line mode
[10:49:59.571] <TB2> INFO: enter test to run
[10:49:59.571] <TB2> INFO: test: pretest no parameter change
[10:49:59.571] <TB2> INFO: running: pretest
[10:49:59.578] <TB2> INFO: ----------------------------------------------------------------------
[10:49:59.578] <TB2> INFO: PixTestPretest::programROC()
[10:49:59.578] <TB2> INFO: ----------------------------------------------------------------------
[10:50:17.595] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[10:50:17.595] <TB2> INFO: IA differences per ROC: 19.3 20.1 19.3 20.1 19.3 19.3 18.5 19.3 20.9 20.9 20.1 20.1 20.9 18.5 20.9 19.3
[10:50:17.697] <TB2> INFO: enter test to run
[10:50:17.697] <TB2> INFO: test: pretest no parameter change
[10:50:17.697] <TB2> INFO: running: pretest
[10:50:17.698] <TB2> INFO: ----------------------------------------------------------------------
[10:50:17.698] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[10:50:17.698] <TB2> INFO: ----------------------------------------------------------------------
[10:50:38.967] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 389.1 mA = 24.3188 mA/ROC
[10:50:38.968] <TB2> INFO: i(loss) [mA/ROC]: 20.1 20.1 18.5 20.1 20.1 19.3 19.3 19.3 20.1 19.3 19.3 19.3 19.3 19.3 19.3 20.1
[10:50:39.000] <TB2> INFO: enter test to run
[10:50:39.000] <TB2> INFO: test: pretest no parameter change
[10:50:39.000] <TB2> INFO: running: pretest
[10:50:39.000] <TB2> INFO: ----------------------------------------------------------------------
[10:50:39.000] <TB2> INFO: PixTestPretest::findTiming()
[10:50:39.000] <TB2> INFO: ----------------------------------------------------------------------
[10:50:39.000] <TB2> INFO: PixTestCmd::init()

[10:52:08.037] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[10:52:08.037] <TB2> INFO: (success/tries = 100/100), width = 4
[10:52:08.038] <TB2> INFO: enter test to run
[10:52:08.038] <TB2> INFO: test: pretest no parameter change
[10:52:08.038] <TB2> INFO: running: pretest
[10:52:08.039] <TB2> INFO: ----------------------------------------------------------------------
[10:52:08.039] <TB2> INFO: PixTestPretest::findWorkingPixel()
[10:52:08.039] <TB2> INFO: ----------------------------------------------------------------------
[10:52:08.130] <TB2> INFO: Expecting 231680 events.


[10:52:18.338] <TB2> INFO: 231680 events read in total (9651ms).
[10:52:18.342] <TB2> INFO: Test took 10300ms.
[10:52:18.566] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[10:52:18.623] <TB2> INFO: enter test to run
[10:52:18.623] <TB2> INFO: test: pretest no parameter change
[10:52:18.623] <TB2> INFO: running: pretest
[10:52:18.624] <TB2> INFO: ----------------------------------------------------------------------
[10:52:18.624] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[10:52:18.624] <TB2> INFO: ----------------------------------------------------------------------
[10:52:18.715] <TB2> INFO: Expecting 231680 events.
[10:52:28.988] <TB2> INFO: 231680 events read in total (9717ms).
[10:52:28.991] <TB2> INFO: Test took 10364ms.
[10:52:29.251] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[10:52:29.251] <TB2> INFO: CalDel: 163 142 153 143 131 138 151 139 126 151 154 162 146 143 161 154
[10:52:29.251] <TB2> INFO: VthrComp: 51 54 51 51 51 51 51 51 51 52 51 52 51 51 51 51
[10:52:29.288] <TB2> INFO: enter test to run
[10:52:29.288] <TB2> INFO: test: pretest no parameter change
[10:52:29.288] <TB2> INFO: running: pretest
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C0.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C1.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C2.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C3.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C4.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C5.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C6.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C7.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C8.dat
[10:52:29.289] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C9.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C10.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C11.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C12.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C13.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C14.dat
[10:52:29.290] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters_C15.dat
[10:52:29.290] <TB2> INFO: enter test to run
[10:52:29.290] <TB2> INFO: test: fulltest no parameter change
[10:52:29.290] <TB2> INFO: running: fulltest
[10:52:29.290] <TB2> INFO: ######################################################################
[10:52:29.290] <TB2> INFO: PixTestFullTest::doTest()
[10:52:29.290] <TB2> INFO: ######################################################################
[10:52:29.291] <TB2> INFO: ######################################################################
[10:52:29.291] <TB2> INFO: PixTestAlive::doTest()
[10:52:29.291] <TB2> INFO: ######################################################################
[10:52:29.293] <TB2> INFO: ----------------------------------------------------------------------
[10:52:29.293] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:52:29.293] <TB2> INFO: ----------------------------------------------------------------------
[10:52:29.558] <TB2> INFO: Expecting 41600 events.
[10:52:33.352] <TB2> INFO: 41600 events read in total (3237ms).
[10:52:33.352] <TB2> INFO: Test took 4058ms.
[10:52:33.580] <TB2> INFO: PixTestAlive::aliveTest() done
[10:52:33.580] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:52:33.582] <TB2> INFO: ----------------------------------------------------------------------
[10:52:33.582] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:52:33.582] <TB2> INFO: ----------------------------------------------------------------------
[10:52:33.867] <TB2> INFO: Expecting 41600 events.
[10:52:36.862] <TB2> INFO: 41600 events read in total (2439ms).
[10:52:36.862] <TB2> INFO: Test took 3278ms.
[10:52:36.863] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:52:37.104] <TB2> INFO: PixTestAlive::maskTest() done
[10:52:37.104] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:52:37.106] <TB2> INFO: ----------------------------------------------------------------------
[10:52:37.106] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:52:37.106] <TB2> INFO: ----------------------------------------------------------------------
[10:52:37.377] <TB2> INFO: Expecting 41600 events.
[10:52:41.199] <TB2> INFO: 41600 events read in total (3265ms).
[10:52:41.200] <TB2> INFO: Test took 4092ms.
[10:52:41.421] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[10:52:41.421] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:52:41.421] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[10:52:41.421] <TB2> INFO: Decoding statistics:
[10:52:41.421] <TB2> INFO: General information:
[10:52:41.421] <TB2> INFO: 16bit words read: 0
[10:52:41.421] <TB2> INFO: valid events total: 0
[10:52:41.421] <TB2> INFO: empty events: 0
[10:52:41.421] <TB2> INFO: valid events with pixels: 0
[10:52:41.421] <TB2> INFO: valid pixel hits: 0
[10:52:41.421] <TB2> INFO: Event errors: 0
[10:52:41.421] <TB2> INFO: start marker: 0
[10:52:41.421] <TB2> INFO: stop marker: 0
[10:52:41.421] <TB2> INFO: overflow: 0
[10:52:41.421] <TB2> INFO: invalid 5bit words: 0
[10:52:41.421] <TB2> INFO: invalid XOR eye diagram: 0
[10:52:41.421] <TB2> INFO: frame (failed synchr.): 0
[10:52:41.421] <TB2> INFO: idle data (no TBM trl): 0
[10:52:41.422] <TB2> INFO: no data (only TBM hdr): 0
[10:52:41.422] <TB2> INFO: TBM errors: 0
[10:52:41.422] <TB2> INFO: flawed TBM headers: 0
[10:52:41.422] <TB2> INFO: flawed TBM trailers: 0
[10:52:41.422] <TB2> INFO: event ID mismatches: 0
[10:52:41.422] <TB2> INFO: ROC errors: 0
[10:52:41.422] <TB2> INFO: missing ROC header(s): 0
[10:52:41.422] <TB2> INFO: misplaced readback start: 0
[10:52:41.422] <TB2> INFO: Pixel decoding errors: 0
[10:52:41.422] <TB2> INFO: pixel data incomplete: 0
[10:52:41.422] <TB2> INFO: pixel address: 0
[10:52:41.422] <TB2> INFO: pulse height fill bit: 0
[10:52:41.422] <TB2> INFO: buffer corruption: 0
[10:52:41.429] <TB2> INFO: ######################################################################
[10:52:41.429] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[10:52:41.429] <TB2> INFO: ######################################################################
[10:52:41.432] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[10:52:41.442] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[10:52:41.442] <TB2> INFO: run 1 of 1
[10:52:41.711] <TB2> INFO: Expecting 3120000 events.
[10:53:23.480] <TB2> INFO: 871335 events read in total (41212ms).
[10:54:04.824] <TB2> INFO: 1730960 events read in total (82557ms).
[10:54:45.676] <TB2> INFO: 2598170 events read in total (123409ms).
[10:55:10.477] <TB2> INFO: 3120000 events read in total (148209ms).
[10:55:10.526] <TB2> INFO: Test took 149083ms.
[10:55:35.111] <TB2> INFO: PixTestBBMap::doTest() done, duration: 173 seconds
[10:55:35.111] <TB2> INFO: number of dead bumps (per ROC): 0 5 0 7 0 1 2 3 0 0 10 1 1 0 2 1
[10:55:35.111] <TB2> INFO: separation cut (per ROC): 88 112 103 104 104 94 102 97 91 108 96 100 97 98 98 75
[10:55:35.111] <TB2> INFO: Decoding statistics:
[10:55:35.111] <TB2> INFO: General information:
[10:55:35.111] <TB2> INFO: 16bit words read: 0
[10:55:35.111] <TB2> INFO: valid events total: 0
[10:55:35.111] <TB2> INFO: empty events: 0
[10:55:35.111] <TB2> INFO: valid events with pixels: 0
[10:55:35.111] <TB2> INFO: valid pixel hits: 0
[10:55:35.111] <TB2> INFO: Event errors: 0
[10:55:35.111] <TB2> INFO: start marker: 0
[10:55:35.111] <TB2> INFO: stop marker: 0
[10:55:35.111] <TB2> INFO: overflow: 0
[10:55:35.111] <TB2> INFO: invalid 5bit words: 0
[10:55:35.111] <TB2> INFO: invalid XOR eye diagram: 0
[10:55:35.111] <TB2> INFO: frame (failed synchr.): 0
[10:55:35.111] <TB2> INFO: idle data (no TBM trl): 0
[10:55:35.111] <TB2> INFO: no data (only TBM hdr): 0
[10:55:35.112] <TB2> INFO: TBM errors: 0
[10:55:35.112] <TB2> INFO: flawed TBM headers: 0
[10:55:35.112] <TB2> INFO: flawed TBM trailers: 0
[10:55:35.112] <TB2> INFO: event ID mismatches: 0
[10:55:35.112] <TB2> INFO: ROC errors: 0
[10:55:35.112] <TB2> INFO: missing ROC header(s): 0
[10:55:35.112] <TB2> INFO: misplaced readback start: 0
[10:55:35.112] <TB2> INFO: Pixel decoding errors: 0
[10:55:35.112] <TB2> INFO: pixel data incomplete: 0
[10:55:35.112] <TB2> INFO: pixel address: 0
[10:55:35.112] <TB2> INFO: pulse height fill bit: 0
[10:55:35.112] <TB2> INFO: buffer corruption: 0
[10:55:35.189] <TB2> INFO: ######################################################################
[10:55:35.189] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[10:55:35.189] <TB2> INFO: ######################################################################
[10:55:35.189] <TB2> INFO: ----------------------------------------------------------------------
[10:55:35.189] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[10:55:35.189] <TB2> INFO: ----------------------------------------------------------------------
[10:55:35.189] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[10:55:35.197] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[10:55:35.197] <TB2> INFO: run 1 of 1
[10:55:35.491] <TB2> INFO: Expecting 26208000 events.
[10:56:09.899] <TB2> INFO: 922300 events read in total (33852ms).
[10:56:43.495] <TB2> INFO: 1826300 events read in total (67448ms).
[10:57:17.146] <TB2> INFO: 2731250 events read in total (101099ms).
[10:57:50.519] <TB2> INFO: 3634700 events read in total (134472ms).
[10:58:24.030] <TB2> INFO: 4535250 events read in total (167983ms).
[10:58:57.705] <TB2> INFO: 5433650 events read in total (201658ms).
[10:59:31.085] <TB2> INFO: 6333600 events read in total (235038ms).
[11:00:04.575] <TB2> INFO: 7230900 events read in total (268528ms).
[11:00:38.214] <TB2> INFO: 8130500 events read in total (302167ms).
[11:01:11.882] <TB2> INFO: 9026000 events read in total (335835ms).
[11:01:45.428] <TB2> INFO: 9923050 events read in total (369381ms).
[11:02:18.639] <TB2> INFO: 10820400 events read in total (402592ms).
[11:02:51.940] <TB2> INFO: 11717150 events read in total (435893ms).
[11:03:25.402] <TB2> INFO: 12612450 events read in total (469355ms).
[11:03:59.103] <TB2> INFO: 13499250 events read in total (503056ms).
[11:04:32.846] <TB2> INFO: 14386600 events read in total (536799ms).
[11:05:06.541] <TB2> INFO: 15271000 events read in total (570494ms).
[11:05:40.343] <TB2> INFO: 16155250 events read in total (604296ms).
[11:06:13.750] <TB2> INFO: 17035150 events read in total (637703ms).
[11:06:47.427] <TB2> INFO: 17917450 events read in total (671380ms).
[11:07:20.998] <TB2> INFO: 18802700 events read in total (704951ms).
[11:07:54.310] <TB2> INFO: 19683400 events read in total (738263ms).
[11:08:27.669] <TB2> INFO: 20561700 events read in total (771622ms).
[11:09:01.194] <TB2> INFO: 21443550 events read in total (805147ms).
[11:09:34.729] <TB2> INFO: 22324700 events read in total (838682ms).
[11:10:08.321] <TB2> INFO: 23206200 events read in total (872274ms).
[11:10:42.006] <TB2> INFO: 24085450 events read in total (905959ms).
[11:11:15.350] <TB2> INFO: 24970950 events read in total (939303ms).
[11:11:49.247] <TB2> INFO: 25861200 events read in total (973200ms).
[11:12:02.172] <TB2> INFO: 26208000 events read in total (986125ms).
[11:12:02.208] <TB2> INFO: Test took 987011ms.
[11:12:02.505] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:03.917] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:05.468] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:06.917] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:08.290] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:09.690] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:11.159] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:12.607] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:14.003] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:15.386] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:16.766] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:18.227] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:19.751] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:21.406] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:22.847] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:24.259] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[11:12:25.768] <TB2> INFO: PixTestScurves::scurves() done
[11:12:25.768] <TB2> INFO: Vcal mean: 86.96 107.94 100.14 102.16 99.53 83.80 99.48 91.73 93.89 99.94 85.30 99.17 93.18 87.91 95.19 79.49
[11:12:25.768] <TB2> INFO: Vcal RMS: 5.33 6.54 5.69 6.24 5.61 5.46 5.73 5.32 4.98 5.82 5.29 6.05 5.80 5.45 5.95 4.70
[11:12:25.768] <TB2> INFO: PixTestScurves::fullTest() done, duration: 1010 seconds
[11:12:25.768] <TB2> INFO: Decoding statistics:
[11:12:25.768] <TB2> INFO: General information:
[11:12:25.768] <TB2> INFO: 16bit words read: 0
[11:12:25.768] <TB2> INFO: valid events total: 0
[11:12:25.768] <TB2> INFO: empty events: 0
[11:12:25.768] <TB2> INFO: valid events with pixels: 0
[11:12:25.768] <TB2> INFO: valid pixel hits: 0
[11:12:25.768] <TB2> INFO: Event errors: 0
[11:12:25.768] <TB2> INFO: start marker: 0
[11:12:25.768] <TB2> INFO: stop marker: 0
[11:12:25.768] <TB2> INFO: overflow: 0
[11:12:25.768] <TB2> INFO: invalid 5bit words: 0
[11:12:25.768] <TB2> INFO: invalid XOR eye diagram: 0
[11:12:25.768] <TB2> INFO: frame (failed synchr.): 0
[11:12:25.768] <TB2> INFO: idle data (no TBM trl): 0
[11:12:25.768] <TB2> INFO: no data (only TBM hdr): 0
[11:12:25.768] <TB2> INFO: TBM errors: 0
[11:12:25.768] <TB2> INFO: flawed TBM headers: 0
[11:12:25.768] <TB2> INFO: flawed TBM trailers: 0
[11:12:25.768] <TB2> INFO: event ID mismatches: 0
[11:12:25.768] <TB2> INFO: ROC errors: 0
[11:12:25.768] <TB2> INFO: missing ROC header(s): 0
[11:12:25.768] <TB2> INFO: misplaced readback start: 0
[11:12:25.768] <TB2> INFO: Pixel decoding errors: 0
[11:12:25.768] <TB2> INFO: pixel data incomplete: 0
[11:12:25.768] <TB2> INFO: pixel address: 0
[11:12:25.768] <TB2> INFO: pulse height fill bit: 0
[11:12:25.768] <TB2> INFO: buffer corruption: 0
[11:12:25.838] <TB2> INFO: ######################################################################
[11:12:25.838] <TB2> INFO: PixTestTrim::doTest()
[11:12:25.838] <TB2> INFO: ######################################################################
[11:12:25.839] <TB2> INFO: ----------------------------------------------------------------------
[11:12:25.839] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[11:12:25.839] <TB2> INFO: ----------------------------------------------------------------------
[11:12:25.920] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[11:12:25.920] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[11:12:25.928] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:12:25.928] <TB2> INFO: run 1 of 1
[11:12:26.202] <TB2> INFO: Expecting 6281600 events.
[11:13:06.914] <TB2> INFO: 1083810 events read in total (40156ms).
[11:13:47.247] <TB2> INFO: 2161720 events read in total (80489ms).
[11:14:27.207] <TB2> INFO: 3232590 events read in total (120450ms).
[11:15:07.381] <TB2> INFO: 4308920 events read in total (160623ms).
[11:15:47.402] <TB2> INFO: 5387760 events read in total (200644ms).
[11:16:21.066] <TB2> INFO: 6281600 events read in total (234308ms).
[11:16:21.099] <TB2> INFO: Test took 235171ms.
[11:16:40.949] <TB2> INFO: ROC 0 VthrComp = 91
[11:16:40.949] <TB2> INFO: ROC 1 VthrComp = 103
[11:16:40.949] <TB2> INFO: ROC 2 VthrComp = 100
[11:16:40.949] <TB2> INFO: ROC 3 VthrComp = 102
[11:16:40.949] <TB2> INFO: ROC 4 VthrComp = 101
[11:16:40.949] <TB2> INFO: ROC 5 VthrComp = 86
[11:16:40.949] <TB2> INFO: ROC 6 VthrComp = 101
[11:16:40.950] <TB2> INFO: ROC 7 VthrComp = 93
[11:16:40.950] <TB2> INFO: ROC 8 VthrComp = 97
[11:16:40.950] <TB2> INFO: ROC 9 VthrComp = 103
[11:16:40.950] <TB2> INFO: ROC 10 VthrComp = 88
[11:16:40.950] <TB2> INFO: ROC 11 VthrComp = 97
[11:16:40.950] <TB2> INFO: ROC 12 VthrComp = 96
[11:16:40.950] <TB2> INFO: ROC 13 VthrComp = 94
[11:16:40.950] <TB2> INFO: ROC 14 VthrComp = 96
[11:16:40.950] <TB2> INFO: ROC 15 VthrComp = 82
[11:16:40.950] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[11:16:40.950] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[11:16:40.958] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:16:40.958] <TB2> INFO: run 1 of 1
[11:16:41.222] <TB2> INFO: Expecting 6281600 events.
[11:17:17.753] <TB2> INFO: 757020 events read in total (35975ms).
[11:17:53.479] <TB2> INFO: 1511790 events read in total (71701ms).
[11:18:29.591] <TB2> INFO: 2266470 events read in total (107813ms).
[11:19:05.176] <TB2> INFO: 3021950 events read in total (143398ms).
[11:19:40.559] <TB2> INFO: 3771710 events read in total (178781ms).
[11:20:15.900] <TB2> INFO: 4518670 events read in total (214122ms).
[11:20:50.962] <TB2> INFO: 5263450 events read in total (249184ms).
[11:21:26.758] <TB2> INFO: 6008880 events read in total (284980ms).
[11:21:39.873] <TB2> INFO: 6281600 events read in total (298095ms).
[11:21:39.915] <TB2> INFO: Test took 298957ms.
[11:22:03.367] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 59.2854 for pixel 0/13 mean/min/max = 46.075/32.8151/59.3348
[11:22:03.367] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 65.5103 for pixel 0/31 mean/min/max = 48.6572/31.8031/65.5112
[11:22:03.367] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 59.7059 for pixel 13/0 mean/min/max = 46.019/32.2433/59.7948
[11:22:03.368] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 61.3093 for pixel 10/7 mean/min/max = 46.3702/31.4046/61.3359
[11:22:03.368] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 59.458 for pixel 13/73 mean/min/max = 45.7166/31.9312/59.502
[11:22:03.368] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 59.7937 for pixel 3/79 mean/min/max = 45.852/31.8761/59.8279
[11:22:03.368] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 60.2846 for pixel 22/21 mean/min/max = 45.9106/31.5127/60.3085
[11:22:03.369] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 58.5525 for pixel 15/15 mean/min/max = 45.8483/33.1142/58.5823
[11:22:03.369] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 57.6136 for pixel 16/62 mean/min/max = 45.0971/32.4506/57.7436
[11:22:03.369] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 60.4704 for pixel 0/74 mean/min/max = 46.2178/31.9588/60.4767
[11:22:03.369] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 59.1483 for pixel 0/15 mean/min/max = 46.0779/32.9578/59.198
[11:22:03.370] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 61.195 for pixel 0/5 mean/min/max = 46.4397/31.6255/61.2538
[11:22:03.370] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 60.5127 for pixel 20/28 mean/min/max = 45.9086/31.2466/60.5707
[11:22:03.370] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.4763 for pixel 3/79 mean/min/max = 45.0897/31.7014/58.4781
[11:22:03.371] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 58.7999 for pixel 24/1 mean/min/max = 45.1607/31.5112/58.8103
[11:22:03.371] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 59.0414 for pixel 22/75 mean/min/max = 45.4263/31.7275/59.1252
[11:22:03.371] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[11:22:03.459] <TB2> INFO: Expecting 514560 events.
[11:22:16.545] <TB2> INFO: 514560 events read in total (12530ms).
[11:22:16.550] <TB2> INFO: Expecting 514560 events.
[11:22:29.398] <TB2> INFO: 514560 events read in total (12425ms).
[11:22:29.405] <TB2> INFO: Expecting 514560 events.
[11:22:42.252] <TB2> INFO: 514560 events read in total (12430ms).
[11:22:42.260] <TB2> INFO: Expecting 514560 events.
[11:22:55.133] <TB2> INFO: 514560 events read in total (12461ms).
[11:22:55.144] <TB2> INFO: Expecting 514560 events.
[11:23:08.011] <TB2> INFO: 514560 events read in total (12456ms).
[11:23:08.024] <TB2> INFO: Expecting 514560 events.
[11:23:20.890] <TB2> INFO: 514560 events read in total (12452ms).
[11:23:20.904] <TB2> INFO: Expecting 514560 events.
[11:23:33.833] <TB2> INFO: 514560 events read in total (12511ms).
[11:23:33.848] <TB2> INFO: Expecting 514560 events.
[11:23:46.816] <TB2> INFO: 514560 events read in total (12557ms).
[11:23:46.834] <TB2> INFO: Expecting 514560 events.
[11:23:59.785] <TB2> INFO: 514560 events read in total (12549ms).
[11:23:59.805] <TB2> INFO: Expecting 514560 events.
[11:24:12.694] <TB2> INFO: 514560 events read in total (12488ms).
[11:24:12.717] <TB2> INFO: Expecting 514560 events.
[11:24:25.571] <TB2> INFO: 514560 events read in total (12448ms).
[11:24:25.594] <TB2> INFO: Expecting 514560 events.
[11:24:38.329] <TB2> INFO: 514560 events read in total (12331ms).
[11:24:38.356] <TB2> INFO: Expecting 514560 events.
[11:24:51.305] <TB2> INFO: 514560 events read in total (12545ms).
[11:24:51.330] <TB2> INFO: Expecting 514560 events.
[11:25:04.123] <TB2> INFO: 514560 events read in total (12388ms).
[11:25:04.152] <TB2> INFO: Expecting 514560 events.
[11:25:17.041] <TB2> INFO: 514560 events read in total (12487ms).
[11:25:17.072] <TB2> INFO: Expecting 514560 events.
[11:25:29.830] <TB2> INFO: 514560 events read in total (12357ms).
[11:25:29.877] <TB2> INFO: Test took 206506ms.
[11:25:30.807] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[11:25:30.815] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:25:30.815] <TB2> INFO: run 1 of 1
[11:25:31.088] <TB2> INFO: Expecting 6281600 events.
[11:26:06.736] <TB2> INFO: 741230 events read in total (35092ms).
[11:26:42.194] <TB2> INFO: 1480990 events read in total (70550ms).
[11:27:17.469] <TB2> INFO: 2220820 events read in total (105825ms).
[11:27:52.741] <TB2> INFO: 2961690 events read in total (141097ms).
[11:28:27.917] <TB2> INFO: 3696940 events read in total (176273ms).
[11:29:03.188] <TB2> INFO: 4428650 events read in total (211544ms).
[11:29:38.150] <TB2> INFO: 5159180 events read in total (246506ms).
[11:30:13.120] <TB2> INFO: 5889880 events read in total (281476ms).
[11:30:31.871] <TB2> INFO: 6281600 events read in total (300227ms).
[11:30:31.916] <TB2> INFO: Test took 301100ms.
[11:30:57.243] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.201174 .. 255.000000
[11:30:57.320] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[11:30:57.329] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:30:57.329] <TB2> INFO: run 1 of 1
[11:30:57.592] <TB2> INFO: Expecting 10649600 events.
[11:31:33.051] <TB2> INFO: 712280 events read in total (34903ms).
[11:32:07.787] <TB2> INFO: 1424750 events read in total (69639ms).
[11:32:42.921] <TB2> INFO: 2137290 events read in total (104773ms).
[11:33:18.220] <TB2> INFO: 2850090 events read in total (140072ms).
[11:33:53.090] <TB2> INFO: 3562480 events read in total (174942ms).
[11:34:27.471] <TB2> INFO: 4275090 events read in total (209323ms).
[11:35:02.259] <TB2> INFO: 4987960 events read in total (244111ms).
[11:35:36.913] <TB2> INFO: 5700190 events read in total (278765ms).
[11:36:12.116] <TB2> INFO: 6412360 events read in total (313968ms).
[11:36:46.922] <TB2> INFO: 7123700 events read in total (348774ms).
[11:37:21.730] <TB2> INFO: 7835430 events read in total (383582ms).
[11:37:56.573] <TB2> INFO: 8546440 events read in total (418425ms).
[11:38:31.467] <TB2> INFO: 9257400 events read in total (453319ms).
[11:39:06.055] <TB2> INFO: 9968410 events read in total (487907ms).
[11:39:39.478] <TB2> INFO: 10649600 events read in total (521330ms).
[11:39:39.582] <TB2> INFO: Test took 522254ms.
[11:40:08.529] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 14.999727 .. 50.182201
[11:40:08.603] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 4 .. 60 (-1/-1) hits flags = 528 (plus default)
[11:40:08.611] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:40:08.611] <TB2> INFO: run 1 of 1
[11:40:08.870] <TB2> INFO: Expecting 2371200 events.
[11:40:47.488] <TB2> INFO: 909690 events read in total (38062ms).
[11:41:24.899] <TB2> INFO: 1818450 events read in total (75473ms).
[11:41:48.200] <TB2> INFO: 2371200 events read in total (98775ms).
[11:41:48.222] <TB2> INFO: Test took 99612ms.
[11:42:03.427] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 18.538401 .. 46.608316
[11:42:03.517] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 8 .. 56 (-1/-1) hits flags = 528 (plus default)
[11:42:03.525] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:42:03.525] <TB2> INFO: run 1 of 1
[11:42:03.818] <TB2> INFO: Expecting 2038400 events.
[11:42:42.337] <TB2> INFO: 916660 events read in total (37963ms).
[11:43:20.908] <TB2> INFO: 1831920 events read in total (76535ms).
[11:43:29.717] <TB2> INFO: 2038400 events read in total (85343ms).
[11:43:29.735] <TB2> INFO: Test took 86210ms.
[11:43:44.685] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 1.909373 .. 46.608316
[11:43:44.763] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 1 .. 56 (-1/-1) hits flags = 528 (plus default)
[11:43:44.771] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:43:44.771] <TB2> INFO: run 1 of 1
[11:43:45.035] <TB2> INFO: Expecting 2329600 events.
[11:44:24.045] <TB2> INFO: 953430 events read in total (38454ms).
[11:45:03.095] <TB2> INFO: 1906800 events read in total (77504ms).
[11:45:20.478] <TB2> INFO: 2329600 events read in total (94888ms).
[11:45:20.490] <TB2> INFO: Test took 95720ms.
[11:45:34.819] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[11:45:34.819] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[11:45:34.827] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[11:45:34.827] <TB2> INFO: run 1 of 1
[11:45:35.092] <TB2> INFO: Expecting 1705600 events.
[11:46:14.138] <TB2> INFO: 879260 events read in total (38489ms).
[11:46:49.322] <TB2> INFO: 1705600 events read in total (73673ms).
[11:46:49.345] <TB2> INFO: Test took 74519ms.
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C0.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C1.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C2.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C3.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C4.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C5.dat
[11:47:02.728] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C6.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C7.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C8.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C9.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C10.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C11.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C12.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C13.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C14.dat
[11:47:02.729] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C15.dat
[11:47:02.729] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C0.dat
[11:47:02.736] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C1.dat
[11:47:02.742] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C2.dat
[11:47:02.748] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C3.dat
[11:47:02.755] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C4.dat
[11:47:02.761] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C5.dat
[11:47:02.767] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C6.dat
[11:47:02.773] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C7.dat
[11:47:02.780] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C8.dat
[11:47:02.786] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C9.dat
[11:47:02.792] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C10.dat
[11:47:02.799] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C11.dat
[11:47:02.805] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C12.dat
[11:47:02.811] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C13.dat
[11:47:02.817] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C14.dat
[11:47:02.824] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//trimParameters35_C15.dat
[11:47:02.830] <TB2> INFO: PixTestTrim::trimTest() done
[11:47:02.830] <TB2> INFO: vtrim: 109 114 92 115 98 89 100 111 104 101 87 99 99 97 92 92
[11:47:02.830] <TB2> INFO: vthrcomp: 91 103 100 102 101 86 101 93 97 103 88 97 96 94 96 82
[11:47:02.830] <TB2> INFO: vcal mean: 34.97 34.97 35.00 35.00 34.97 34.94 34.97 34.97 34.99 35.02 34.98 34.99 34.96 34.99 35.02 34.96
[11:47:02.830] <TB2> INFO: vcal RMS: 0.80 0.99 0.84 0.89 0.83 0.88 0.87 0.88 0.83 0.84 0.83 1.05 0.88 0.82 3.52 0.87
[11:47:02.830] <TB2> INFO: bits mean: 9.03 9.35 9.21 9.57 9.54 8.90 9.42 9.67 9.82 9.20 9.00 8.99 9.65 9.52 9.24 9.50
[11:47:02.830] <TB2> INFO: bits RMS: 2.74 2.50 2.73 2.64 2.66 2.93 2.72 2.49 2.50 2.73 2.74 2.89 2.65 2.77 2.90 2.75
[11:47:02.836] <TB2> INFO: ----------------------------------------------------------------------
[11:47:02.836] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[11:47:02.836] <TB2> INFO: ----------------------------------------------------------------------
[11:47:02.839] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[11:47:02.847] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:47:02.847] <TB2> INFO: run 1 of 1
[11:47:03.106] <TB2> INFO: Expecting 4160000 events.
[11:47:46.807] <TB2> INFO: 941320 events read in total (43144ms).
[11:48:29.396] <TB2> INFO: 1875260 events read in total (85733ms).
[11:49:11.963] <TB2> INFO: 2801170 events read in total (128300ms).
[11:49:54.716] <TB2> INFO: 3724180 events read in total (171053ms).
[11:50:14.714] <TB2> INFO: 4160000 events read in total (191051ms).
[11:50:14.751] <TB2> INFO: Test took 191905ms.
[11:50:44.367] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 202 (-1/-1) hits flags = 528 (plus default)
[11:50:44.377] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:50:44.378] <TB2> INFO: run 1 of 1
[11:50:44.638] <TB2> INFO: Expecting 4222400 events.
[11:51:26.757] <TB2> INFO: 905510 events read in total (41563ms).
[11:52:08.205] <TB2> INFO: 1804715 events read in total (83011ms).
[11:52:49.778] <TB2> INFO: 2697855 events read in total (124584ms).
[11:53:31.017] <TB2> INFO: 3587700 events read in total (165823ms).
[11:54:00.619] <TB2> INFO: 4222400 events read in total (195425ms).
[11:54:00.662] <TB2> INFO: Test took 196284ms.
[11:54:30.162] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)
[11:54:30.170] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:54:30.170] <TB2> INFO: run 1 of 1
[11:54:30.429] <TB2> INFO: Expecting 3868800 events.
[11:55:13.720] <TB2> INFO: 935360 events read in total (42735ms).
[11:55:56.232] <TB2> INFO: 1863750 events read in total (85247ms).
[11:56:38.470] <TB2> INFO: 2783120 events read in total (127485ms).
[11:57:20.530] <TB2> INFO: 3701065 events read in total (169545ms).
[11:57:28.554] <TB2> INFO: 3868800 events read in total (177569ms).
[11:57:28.600] <TB2> INFO: Test took 178430ms.
[11:57:55.438] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)
[11:57:55.446] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[11:57:55.446] <TB2> INFO: run 1 of 1
[11:57:55.706] <TB2> INFO: Expecting 3868800 events.
[11:58:38.684] <TB2> INFO: 934620 events read in total (42422ms).
[11:59:20.658] <TB2> INFO: 1862535 events read in total (84396ms).
[12:00:02.626] <TB2> INFO: 2781090 events read in total (126364ms).
[12:00:44.433] <TB2> INFO: 3698370 events read in total (168171ms).
[12:00:52.282] <TB2> INFO: 3868800 events read in total (176020ms).
[12:00:52.313] <TB2> INFO: Test took 176867ms.
[12:01:21.903] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 184 (-1/-1) hits flags = 528 (plus default)
[12:01:21.910] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[12:01:21.910] <TB2> INFO: run 1 of 1
[12:01:22.190] <TB2> INFO: Expecting 3848000 events.
[12:02:04.454] <TB2> INFO: 935840 events read in total (41707ms).
[12:02:46.488] <TB2> INFO: 1864615 events read in total (83741ms).
[12:03:28.443] <TB2> INFO: 2784010 events read in total (125696ms).
[12:04:10.460] <TB2> INFO: 3702670 events read in total (167713ms).
[12:04:17.377] <TB2> INFO: 3848000 events read in total (174630ms).
[12:04:17.409] <TB2> INFO: Test took 175499ms.
[12:04:43.896] <TB2> INFO: PixTestTrim::trimBitTest() done
[12:04:43.897] <TB2> INFO: PixTestTrim::doTest() done, duration: 3138 seconds
[12:04:43.897] <TB2> INFO: Decoding statistics:
[12:04:43.897] <TB2> INFO: General information:
[12:04:43.897] <TB2> INFO: 16bit words read: 0
[12:04:43.897] <TB2> INFO: valid events total: 0
[12:04:43.897] <TB2> INFO: empty events: 0
[12:04:43.897] <TB2> INFO: valid events with pixels: 0
[12:04:43.897] <TB2> INFO: valid pixel hits: 0
[12:04:43.897] <TB2> INFO: Event errors: 0
[12:04:43.897] <TB2> INFO: start marker: 0
[12:04:43.897] <TB2> INFO: stop marker: 0
[12:04:43.897] <TB2> INFO: overflow: 0
[12:04:43.897] <TB2> INFO: invalid 5bit words: 0
[12:04:43.897] <TB2> INFO: invalid XOR eye diagram: 0
[12:04:43.897] <TB2> INFO: frame (failed synchr.): 0
[12:04:43.897] <TB2> INFO: idle data (no TBM trl): 0
[12:04:43.897] <TB2> INFO: no data (only TBM hdr): 0
[12:04:43.897] <TB2> INFO: TBM errors: 0
[12:04:43.897] <TB2> INFO: flawed TBM headers: 0
[12:04:43.897] <TB2> INFO: flawed TBM trailers: 0
[12:04:43.897] <TB2> INFO: event ID mismatches: 0
[12:04:43.897] <TB2> INFO: ROC errors: 0
[12:04:43.897] <TB2> INFO: missing ROC header(s): 0
[12:04:43.897] <TB2> INFO: misplaced readback start: 0
[12:04:43.897] <TB2> INFO: Pixel decoding errors: 0
[12:04:43.897] <TB2> INFO: pixel data incomplete: 0
[12:04:43.897] <TB2> INFO: pixel address: 0
[12:04:43.897] <TB2> INFO: pulse height fill bit: 0
[12:04:43.897] <TB2> INFO: buffer corruption: 0
[12:04:44.566] <TB2> INFO: ######################################################################
[12:04:44.566] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[12:04:44.566] <TB2> INFO: ######################################################################
[12:04:44.827] <TB2> INFO: Expecting 41600 events.
[12:04:48.622] <TB2> INFO: 41600 events read in total (3239ms).
[12:04:48.623] <TB2> INFO: Test took 4056ms.
[12:04:49.097] <TB2> INFO: Expecting 41600 events.
[12:04:52.961] <TB2> INFO: 41600 events read in total (3308ms).
[12:04:52.961] <TB2> INFO: Test took 4142ms.
[12:04:53.278] <TB2> INFO: Expecting 41600 events.
[12:04:57.119] <TB2> INFO: 41600 events read in total (3285ms).
[12:04:57.120] <TB2> INFO: Test took 4135ms.
[12:04:57.375] <TB2> INFO: Expecting 2560 events.
[12:04:58.229] <TB2> INFO: 2560 events read in total (298ms).
[12:04:58.229] <TB2> INFO: Test took 1096ms.
[12:04:58.535] <TB2> INFO: Expecting 2560 events.
[12:04:59.394] <TB2> INFO: 2560 events read in total (303ms).
[12:04:59.394] <TB2> INFO: Test took 1164ms.
[12:04:59.700] <TB2> INFO: Expecting 2560 events.
[12:05:00.557] <TB2> INFO: 2560 events read in total (301ms).
[12:05:00.557] <TB2> INFO: Test took 1162ms.
[12:05:00.869] <TB2> INFO: Expecting 2560 events.
[12:05:01.728] <TB2> INFO: 2560 events read in total (302ms).
[12:05:01.728] <TB2> INFO: Test took 1170ms.
[12:05:02.034] <TB2> INFO: Expecting 2560 events.
[12:05:02.895] <TB2> INFO: 2560 events read in total (305ms).
[12:05:02.895] <TB2> INFO: Test took 1166ms.
[12:05:03.200] <TB2> INFO: Expecting 2560 events.
[12:05:04.058] <TB2> INFO: 2560 events read in total (301ms).
[12:05:04.058] <TB2> INFO: Test took 1162ms.
[12:05:04.363] <TB2> INFO: Expecting 2560 events.
[12:05:05.217] <TB2> INFO: 2560 events read in total (298ms).
[12:05:05.217] <TB2> INFO: Test took 1158ms.
[12:05:05.521] <TB2> INFO: Expecting 2560 events.
[12:05:06.374] <TB2> INFO: 2560 events read in total (296ms).
[12:05:06.374] <TB2> INFO: Test took 1157ms.
[12:05:06.679] <TB2> INFO: Expecting 2560 events.
[12:05:07.533] <TB2> INFO: 2560 events read in total (297ms).
[12:05:07.533] <TB2> INFO: Test took 1159ms.
[12:05:07.839] <TB2> INFO: Expecting 2560 events.
[12:05:08.696] <TB2> INFO: 2560 events read in total (301ms).
[12:05:08.696] <TB2> INFO: Test took 1162ms.
[12:05:09.001] <TB2> INFO: Expecting 2560 events.
[12:05:09.855] <TB2> INFO: 2560 events read in total (297ms).
[12:05:09.856] <TB2> INFO: Test took 1160ms.
[12:05:10.161] <TB2> INFO: Expecting 2560 events.
[12:05:11.014] <TB2> INFO: 2560 events read in total (297ms).
[12:05:11.014] <TB2> INFO: Test took 1158ms.
[12:05:11.319] <TB2> INFO: Expecting 2560 events.
[12:05:12.173] <TB2> INFO: 2560 events read in total (298ms).
[12:05:12.173] <TB2> INFO: Test took 1158ms.
[12:05:12.478] <TB2> INFO: Expecting 2560 events.
[12:05:13.337] <TB2> INFO: 2560 events read in total (303ms).
[12:05:13.337] <TB2> INFO: Test took 1163ms.
[12:05:13.642] <TB2> INFO: Expecting 2560 events.
[12:05:14.497] <TB2> INFO: 2560 events read in total (299ms).
[12:05:14.497] <TB2> INFO: Test took 1160ms.
[12:05:14.802] <TB2> INFO: Expecting 2560 events.
[12:05:15.657] <TB2> INFO: 2560 events read in total (298ms).
[12:05:15.657] <TB2> INFO: Test took 1160ms.
[12:05:15.659] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:05:15.963] <TB2> INFO: Expecting 655360 events.
[12:05:32.938] <TB2> INFO: 655360 events read in total (16401ms).
[12:05:32.948] <TB2> INFO: Expecting 655360 events.
[12:05:49.740] <TB2> INFO: 655360 events read in total (16390ms).
[12:05:49.752] <TB2> INFO: Expecting 655360 events.
[12:06:06.462] <TB2> INFO: 655360 events read in total (16308ms).
[12:06:06.481] <TB2> INFO: Expecting 655360 events.
[12:06:23.297] <TB2> INFO: 655360 events read in total (16415ms).
[12:06:23.319] <TB2> INFO: Expecting 655360 events.
[12:06:40.096] <TB2> INFO: 655360 events read in total (16375ms).
[12:06:40.118] <TB2> INFO: Expecting 655360 events.
[12:06:56.862] <TB2> INFO: 655360 events read in total (16342ms).
[12:06:56.889] <TB2> INFO: Expecting 655360 events.
[12:07:13.615] <TB2> INFO: 655360 events read in total (16324ms).
[12:07:13.643] <TB2> INFO: Expecting 655360 events.
[12:07:30.378] <TB2> INFO: 655360 events read in total (16333ms).
[12:07:30.422] <TB2> INFO: Expecting 655360 events.
[12:07:47.110] <TB2> INFO: 655360 events read in total (16286ms).
[12:07:47.165] <TB2> INFO: Expecting 655360 events.
[12:08:03.989] <TB2> INFO: 655360 events read in total (16423ms).
[12:08:04.028] <TB2> INFO: Expecting 655360 events.
[12:08:20.788] <TB2> INFO: 655360 events read in total (16358ms).
[12:08:20.830] <TB2> INFO: Expecting 655360 events.
[12:08:37.598] <TB2> INFO: 655360 events read in total (16366ms).
[12:08:37.645] <TB2> INFO: Expecting 655360 events.
[12:08:54.541] <TB2> INFO: 655360 events read in total (16494ms).
[12:08:54.596] <TB2> INFO: Expecting 655360 events.
[12:09:11.412] <TB2> INFO: 655360 events read in total (16414ms).
[12:09:11.465] <TB2> INFO: Expecting 655360 events.
[12:09:28.244] <TB2> INFO: 655360 events read in total (16377ms).
[12:09:28.311] <TB2> INFO: Expecting 655360 events.
[12:09:45.097] <TB2> INFO: 655360 events read in total (16385ms).
[12:09:45.166] <TB2> INFO: Test took 269507ms.
[12:09:45.250] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:09:45.481] <TB2> INFO: Expecting 655360 events.
[12:10:02.489] <TB2> INFO: 655360 events read in total (16452ms).
[12:10:02.499] <TB2> INFO: Expecting 655360 events.
[12:10:18.717] <TB2> INFO: 655360 events read in total (15817ms).
[12:10:18.729] <TB2> INFO: Expecting 655360 events.
[12:10:35.372] <TB2> INFO: 655360 events read in total (16241ms).
[12:10:35.388] <TB2> INFO: Expecting 655360 events.
[12:10:52.118] <TB2> INFO: 655360 events read in total (16328ms).
[12:10:52.137] <TB2> INFO: Expecting 655360 events.
[12:11:08.945] <TB2> INFO: 655360 events read in total (16406ms).
[12:11:08.971] <TB2> INFO: Expecting 655360 events.
[12:11:25.711] <TB2> INFO: 655360 events read in total (16338ms).
[12:11:25.739] <TB2> INFO: Expecting 655360 events.
[12:11:42.560] <TB2> INFO: 655360 events read in total (16420ms).
[12:11:42.588] <TB2> INFO: Expecting 655360 events.
[12:11:59.543] <TB2> INFO: 655360 events read in total (16553ms).
[12:11:59.575] <TB2> INFO: Expecting 655360 events.
[12:12:16.468] <TB2> INFO: 655360 events read in total (16491ms).
[12:12:16.502] <TB2> INFO: Expecting 655360 events.
[12:12:33.545] <TB2> INFO: 655360 events read in total (16641ms).
[12:12:33.584] <TB2> INFO: Expecting 655360 events.
[12:12:50.456] <TB2> INFO: 655360 events read in total (16470ms).
[12:12:50.506] <TB2> INFO: Expecting 655360 events.
[12:13:07.390] <TB2> INFO: 655360 events read in total (16482ms).
[12:13:07.436] <TB2> INFO: Expecting 655360 events.
[12:13:24.198] <TB2> INFO: 655360 events read in total (16360ms).
[12:13:24.278] <TB2> INFO: Expecting 655360 events.
[12:13:41.159] <TB2> INFO: 655360 events read in total (16479ms).
[12:13:41.213] <TB2> INFO: Expecting 655360 events.
[12:13:57.677] <TB2> INFO: 655360 events read in total (16062ms).
[12:13:57.739] <TB2> INFO: Expecting 655360 events.
[12:14:14.308] <TB2> INFO: 655360 events read in total (16168ms).
[12:14:14.370] <TB2> INFO: Test took 269120ms.
[12:14:14.562] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.569] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.577] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.584] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.591] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.598] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.604] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.613] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.621] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[12:14:14.628] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[12:14:14.635] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.641] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.648] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.655] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.662] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.670] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.677] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.684] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C0.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C1.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C2.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C3.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C4.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C5.dat
[12:14:14.725] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C6.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C7.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C8.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C9.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C10.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C11.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C12.dat
[12:14:14.726] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C13.dat
[12:14:14.727] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C14.dat
[12:14:14.727] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//dacParameters35_C15.dat
[12:14:14.991] <TB2> INFO: Expecting 41600 events.
[12:14:18.476] <TB2> INFO: 41600 events read in total (2929ms).
[12:14:18.476] <TB2> INFO: Test took 3746ms.
[12:14:18.952] <TB2> INFO: Expecting 41600 events.
[12:14:22.464] <TB2> INFO: 41600 events read in total (2955ms).
[12:14:22.465] <TB2> INFO: Test took 3803ms.
[12:14:22.903] <TB2> INFO: Expecting 41600 events.
[12:14:26.407] <TB2> INFO: 41600 events read in total (2948ms).
[12:14:26.407] <TB2> INFO: Test took 3763ms.
[12:14:26.591] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:26.679] <TB2> INFO: Expecting 2560 events.
[12:14:27.535] <TB2> INFO: 2560 events read in total (300ms).
[12:14:27.536] <TB2> INFO: Test took 945ms.
[12:14:27.539] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:27.840] <TB2> INFO: Expecting 2560 events.
[12:14:28.699] <TB2> INFO: 2560 events read in total (303ms).
[12:14:28.699] <TB2> INFO: Test took 1160ms.
[12:14:28.701] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:29.005] <TB2> INFO: Expecting 2560 events.
[12:14:29.862] <TB2> INFO: 2560 events read in total (301ms).
[12:14:29.862] <TB2> INFO: Test took 1162ms.
[12:14:29.865] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:30.168] <TB2> INFO: Expecting 2560 events.
[12:14:31.023] <TB2> INFO: 2560 events read in total (299ms).
[12:14:31.023] <TB2> INFO: Test took 1158ms.
[12:14:31.025] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:31.329] <TB2> INFO: Expecting 2560 events.
[12:14:32.187] <TB2> INFO: 2560 events read in total (302ms).
[12:14:32.188] <TB2> INFO: Test took 1163ms.
[12:14:32.189] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:32.493] <TB2> INFO: Expecting 2560 events.
[12:14:33.347] <TB2> INFO: 2560 events read in total (298ms).
[12:14:33.347] <TB2> INFO: Test took 1158ms.
[12:14:33.349] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:33.653] <TB2> INFO: Expecting 2560 events.
[12:14:34.507] <TB2> INFO: 2560 events read in total (298ms).
[12:14:34.507] <TB2> INFO: Test took 1158ms.
[12:14:34.509] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:34.813] <TB2> INFO: Expecting 2560 events.
[12:14:35.666] <TB2> INFO: 2560 events read in total (297ms).
[12:14:35.666] <TB2> INFO: Test took 1157ms.
[12:14:35.667] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:35.972] <TB2> INFO: Expecting 2560 events.
[12:14:36.824] <TB2> INFO: 2560 events read in total (296ms).
[12:14:36.824] <TB2> INFO: Test took 1157ms.
[12:14:36.826] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:37.130] <TB2> INFO: Expecting 2560 events.
[12:14:37.982] <TB2> INFO: 2560 events read in total (296ms).
[12:14:37.982] <TB2> INFO: Test took 1156ms.
[12:14:37.984] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:38.287] <TB2> INFO: Expecting 2560 events.
[12:14:39.140] <TB2> INFO: 2560 events read in total (296ms).
[12:14:39.140] <TB2> INFO: Test took 1156ms.
[12:14:39.142] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:39.446] <TB2> INFO: Expecting 2560 events.
[12:14:40.298] <TB2> INFO: 2560 events read in total (296ms).
[12:14:40.298] <TB2> INFO: Test took 1156ms.
[12:14:40.300] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:40.604] <TB2> INFO: Expecting 2560 events.
[12:14:41.457] <TB2> INFO: 2560 events read in total (297ms).
[12:14:41.457] <TB2> INFO: Test took 1157ms.
[12:14:41.459] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:41.762] <TB2> INFO: Expecting 2560 events.
[12:14:42.615] <TB2> INFO: 2560 events read in total (297ms).
[12:14:42.615] <TB2> INFO: Test took 1156ms.
[12:14:42.617] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:42.920] <TB2> INFO: Expecting 2560 events.
[12:14:43.773] <TB2> INFO: 2560 events read in total (297ms).
[12:14:43.773] <TB2> INFO: Test took 1156ms.
[12:14:43.774] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:44.078] <TB2> INFO: Expecting 2560 events.
[12:14:44.931] <TB2> INFO: 2560 events read in total (296ms).
[12:14:44.932] <TB2> INFO: Test took 1158ms.
[12:14:44.933] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:45.237] <TB2> INFO: Expecting 2560 events.
[12:14:46.090] <TB2> INFO: 2560 events read in total (297ms).
[12:14:46.090] <TB2> INFO: Test took 1157ms.
[12:14:46.092] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:46.395] <TB2> INFO: Expecting 2560 events.
[12:14:47.250] <TB2> INFO: 2560 events read in total (299ms).
[12:14:47.250] <TB2> INFO: Test took 1158ms.
[12:14:47.252] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:47.556] <TB2> INFO: Expecting 2560 events.
[12:14:48.412] <TB2> INFO: 2560 events read in total (300ms).
[12:14:48.412] <TB2> INFO: Test took 1160ms.
[12:14:48.414] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:48.717] <TB2> INFO: Expecting 2560 events.
[12:14:49.570] <TB2> INFO: 2560 events read in total (297ms).
[12:14:49.570] <TB2> INFO: Test took 1156ms.
[12:14:49.572] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:49.876] <TB2> INFO: Expecting 2560 events.
[12:14:50.728] <TB2> INFO: 2560 events read in total (296ms).
[12:14:50.729] <TB2> INFO: Test took 1157ms.
[12:14:50.730] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:51.034] <TB2> INFO: Expecting 2560 events.
[12:14:51.887] <TB2> INFO: 2560 events read in total (297ms).
[12:14:51.888] <TB2> INFO: Test took 1158ms.
[12:14:51.890] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:52.193] <TB2> INFO: Expecting 2560 events.
[12:14:53.048] <TB2> INFO: 2560 events read in total (299ms).
[12:14:53.049] <TB2> INFO: Test took 1160ms.
[12:14:53.051] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:53.354] <TB2> INFO: Expecting 2560 events.
[12:14:54.208] <TB2> INFO: 2560 events read in total (298ms).
[12:14:54.208] <TB2> INFO: Test took 1158ms.
[12:14:54.210] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:54.514] <TB2> INFO: Expecting 2560 events.
[12:14:55.369] <TB2> INFO: 2560 events read in total (299ms).
[12:14:55.369] <TB2> INFO: Test took 1159ms.
[12:14:55.371] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:55.674] <TB2> INFO: Expecting 2560 events.
[12:14:56.527] <TB2> INFO: 2560 events read in total (297ms).
[12:14:56.527] <TB2> INFO: Test took 1156ms.
[12:14:56.529] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:56.833] <TB2> INFO: Expecting 2560 events.
[12:14:57.687] <TB2> INFO: 2560 events read in total (298ms).
[12:14:57.687] <TB2> INFO: Test took 1158ms.
[12:14:57.703] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:57.993] <TB2> INFO: Expecting 2560 events.
[12:14:58.846] <TB2> INFO: 2560 events read in total (297ms).
[12:14:58.846] <TB2> INFO: Test took 1143ms.
[12:14:58.848] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:14:59.151] <TB2> INFO: Expecting 2560 events.
[12:15:00.005] <TB2> INFO: 2560 events read in total (298ms).
[12:15:00.005] <TB2> INFO: Test took 1157ms.
[12:15:00.007] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:15:00.310] <TB2> INFO: Expecting 2560 events.
[12:15:01.166] <TB2> INFO: 2560 events read in total (300ms).
[12:15:01.166] <TB2> INFO: Test took 1159ms.
[12:15:01.168] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:15:01.473] <TB2> INFO: Expecting 2560 events.
[12:15:02.328] <TB2> INFO: 2560 events read in total (299ms).
[12:15:02.329] <TB2> INFO: Test took 1161ms.
[12:15:02.330] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:15:02.634] <TB2> INFO: Expecting 2560 events.
[12:15:03.487] <TB2> INFO: 2560 events read in total (297ms).
[12:15:03.488] <TB2> INFO: Test took 1158ms.
[12:15:03.954] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 619 seconds
[12:15:03.954] <TB2> INFO: PH scale (per ROC): 81 75 78 77 86 78 79 80 76 77 91 69 84 87 83 84
[12:15:03.954] <TB2> INFO: PH offset (per ROC): 160 176 185 175 158 163 163 163 163 178 149 173 157 147 167 167
[12:15:03.958] <TB2> INFO: Decoding statistics:
[12:15:03.958] <TB2> INFO: General information:
[12:15:03.958] <TB2> INFO: 16bit words read: 91924
[12:15:03.958] <TB2> INFO: valid events total: 10240
[12:15:03.958] <TB2> INFO: empty events: 7739
[12:15:03.958] <TB2> INFO: valid events with pixels: 2501
[12:15:03.958] <TB2> INFO: valid pixel hits: 2501
[12:15:03.958] <TB2> INFO: Event errors: 0
[12:15:03.958] <TB2> INFO: start marker: 0
[12:15:03.958] <TB2> INFO: stop marker: 0
[12:15:03.958] <TB2> INFO: overflow: 0
[12:15:03.958] <TB2> INFO: invalid 5bit words: 0
[12:15:03.958] <TB2> INFO: invalid XOR eye diagram: 0
[12:15:03.958] <TB2> INFO: frame (failed synchr.): 0
[12:15:03.958] <TB2> INFO: idle data (no TBM trl): 0
[12:15:03.958] <TB2> INFO: no data (only TBM hdr): 0
[12:15:03.958] <TB2> INFO: TBM errors: 0
[12:15:03.958] <TB2> INFO: flawed TBM headers: 0
[12:15:03.958] <TB2> INFO: flawed TBM trailers: 0
[12:15:03.958] <TB2> INFO: event ID mismatches: 0
[12:15:03.958] <TB2> INFO: ROC errors: 0
[12:15:03.958] <TB2> INFO: missing ROC header(s): 0
[12:15:03.958] <TB2> INFO: misplaced readback start: 0
[12:15:03.958] <TB2> INFO: Pixel decoding errors: 0
[12:15:03.958] <TB2> INFO: pixel data incomplete: 0
[12:15:03.958] <TB2> INFO: pixel address: 0
[12:15:03.958] <TB2> INFO: pulse height fill bit: 0
[12:15:03.958] <TB2> INFO: buffer corruption: 0
[12:15:04.127] <TB2> INFO: ######################################################################
[12:15:04.127] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[12:15:04.127] <TB2> INFO: ######################################################################
[12:15:04.137] <TB2> INFO: scanning low vcal = 10
[12:15:04.396] <TB2> INFO: Expecting 41600 events.
[12:15:07.957] <TB2> INFO: 41600 events read in total (3005ms).
[12:15:07.957] <TB2> INFO: Test took 3820ms.
[12:15:07.959] <TB2> INFO: scanning low vcal = 20
[12:15:08.278] <TB2> INFO: Expecting 41600 events.
[12:15:11.841] <TB2> INFO: 41600 events read in total (3006ms).
[12:15:11.841] <TB2> INFO: Test took 3882ms.
[12:15:11.843] <TB2> INFO: scanning low vcal = 30
[12:15:12.185] <TB2> INFO: Expecting 41600 events.
[12:15:15.720] <TB2> INFO: 41600 events read in total (2979ms).
[12:15:15.721] <TB2> INFO: Test took 3878ms.
[12:15:15.723] <TB2> INFO: scanning low vcal = 40
[12:15:16.021] <TB2> INFO: Expecting 41600 events.
[12:15:20.207] <TB2> INFO: 41600 events read in total (3630ms).
[12:15:20.207] <TB2> INFO: Test took 4484ms.
[12:15:20.210] <TB2> INFO: scanning low vcal = 50
[12:15:20.481] <TB2> INFO: Expecting 41600 events.
[12:15:24.697] <TB2> INFO: 41600 events read in total (3659ms).
[12:15:24.697] <TB2> INFO: Test took 4487ms.
[12:15:24.700] <TB2> INFO: scanning low vcal = 60
[12:15:24.984] <TB2> INFO: Expecting 41600 events.
[12:15:29.235] <TB2> INFO: 41600 events read in total (3695ms).
[12:15:29.236] <TB2> INFO: Test took 4536ms.
[12:15:29.239] <TB2> INFO: scanning low vcal = 70
[12:15:29.527] <TB2> INFO: Expecting 41600 events.
[12:15:33.752] <TB2> INFO: 41600 events read in total (3669ms).
[12:15:33.753] <TB2> INFO: Test took 4514ms.
[12:15:33.755] <TB2> INFO: scanning low vcal = 80
[12:15:34.012] <TB2> INFO: Expecting 41600 events.
[12:15:38.252] <TB2> INFO: 41600 events read in total (3683ms).
[12:15:38.252] <TB2> INFO: Test took 4497ms.
[12:15:38.255] <TB2> INFO: scanning low vcal = 90
[12:15:38.522] <TB2> INFO: Expecting 41600 events.
[12:15:42.781] <TB2> INFO: 41600 events read in total (3703ms).
[12:15:42.782] <TB2> INFO: Test took 4527ms.
[12:15:42.785] <TB2> INFO: scanning low vcal = 100
[12:15:43.052] <TB2> INFO: Expecting 41600 events.
[12:15:47.302] <TB2> INFO: 41600 events read in total (3693ms).
[12:15:47.302] <TB2> INFO: Test took 4517ms.
[12:15:47.305] <TB2> INFO: scanning low vcal = 110
[12:15:47.568] <TB2> INFO: Expecting 41600 events.
[12:15:51.835] <TB2> INFO: 41600 events read in total (3711ms).
[12:15:51.836] <TB2> INFO: Test took 4531ms.
[12:15:51.867] <TB2> INFO: scanning low vcal = 120
[12:15:52.135] <TB2> INFO: Expecting 41600 events.
[12:15:56.375] <TB2> INFO: 41600 events read in total (3684ms).
[12:15:56.375] <TB2> INFO: Test took 4508ms.
[12:15:56.378] <TB2> INFO: scanning low vcal = 130
[12:15:56.643] <TB2> INFO: Expecting 41600 events.
[12:16:00.903] <TB2> INFO: 41600 events read in total (3703ms).
[12:16:00.903] <TB2> INFO: Test took 4525ms.
[12:16:00.906] <TB2> INFO: scanning low vcal = 140
[12:16:01.186] <TB2> INFO: Expecting 41600 events.
[12:16:05.438] <TB2> INFO: 41600 events read in total (3696ms).
[12:16:05.438] <TB2> INFO: Test took 4532ms.
[12:16:05.441] <TB2> INFO: scanning low vcal = 150
[12:16:05.710] <TB2> INFO: Expecting 41600 events.
[12:16:09.958] <TB2> INFO: 41600 events read in total (3692ms).
[12:16:09.959] <TB2> INFO: Test took 4518ms.
[12:16:09.961] <TB2> INFO: scanning low vcal = 160
[12:16:10.256] <TB2> INFO: Expecting 41600 events.
[12:16:14.525] <TB2> INFO: 41600 events read in total (3712ms).
[12:16:14.526] <TB2> INFO: Test took 4565ms.
[12:16:14.528] <TB2> INFO: scanning low vcal = 170
[12:16:14.803] <TB2> INFO: Expecting 41600 events.
[12:16:19.050] <TB2> INFO: 41600 events read in total (3690ms).
[12:16:19.051] <TB2> INFO: Test took 4522ms.
[12:16:19.054] <TB2> INFO: scanning low vcal = 180
[12:16:19.317] <TB2> INFO: Expecting 41600 events.
[12:16:23.578] <TB2> INFO: 41600 events read in total (3704ms).
[12:16:23.579] <TB2> INFO: Test took 4525ms.
[12:16:23.582] <TB2> INFO: scanning low vcal = 190
[12:16:23.848] <TB2> INFO: Expecting 41600 events.
[12:16:28.098] <TB2> INFO: 41600 events read in total (3694ms).
[12:16:28.099] <TB2> INFO: Test took 4517ms.
[12:16:28.101] <TB2> INFO: scanning low vcal = 200
[12:16:28.378] <TB2> INFO: Expecting 41600 events.
[12:16:32.582] <TB2> INFO: 41600 events read in total (3647ms).
[12:16:32.582] <TB2> INFO: Test took 4481ms.
[12:16:32.585] <TB2> INFO: scanning low vcal = 210
[12:16:32.847] <TB2> INFO: Expecting 41600 events.
[12:16:37.095] <TB2> INFO: 41600 events read in total (3692ms).
[12:16:37.095] <TB2> INFO: Test took 4510ms.
[12:16:37.098] <TB2> INFO: scanning low vcal = 220
[12:16:37.364] <TB2> INFO: Expecting 41600 events.
[12:16:41.644] <TB2> INFO: 41600 events read in total (3724ms).
[12:16:41.645] <TB2> INFO: Test took 4547ms.
[12:16:41.647] <TB2> INFO: scanning low vcal = 230
[12:16:41.918] <TB2> INFO: Expecting 41600 events.
[12:16:46.151] <TB2> INFO: 41600 events read in total (3677ms).
[12:16:46.152] <TB2> INFO: Test took 4505ms.
[12:16:46.154] <TB2> INFO: scanning low vcal = 240
[12:16:46.417] <TB2> INFO: Expecting 41600 events.
[12:16:50.667] <TB2> INFO: 41600 events read in total (3694ms).
[12:16:50.668] <TB2> INFO: Test took 4513ms.
[12:16:50.671] <TB2> INFO: scanning low vcal = 250
[12:16:50.945] <TB2> INFO: Expecting 41600 events.
[12:16:55.213] <TB2> INFO: 41600 events read in total (3711ms).
[12:16:55.214] <TB2> INFO: Test took 4543ms.
[12:16:55.218] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[12:16:55.490] <TB2> INFO: Expecting 41600 events.
[12:16:59.729] <TB2> INFO: 41600 events read in total (3683ms).
[12:16:59.729] <TB2> INFO: Test took 4511ms.
[12:16:59.732] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[12:17:00.009] <TB2> INFO: Expecting 41600 events.
[12:17:04.275] <TB2> INFO: 41600 events read in total (3710ms).
[12:17:04.275] <TB2> INFO: Test took 4543ms.
[12:17:04.278] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[12:17:04.543] <TB2> INFO: Expecting 41600 events.
[12:17:08.792] <TB2> INFO: 41600 events read in total (3693ms).
[12:17:08.793] <TB2> INFO: Test took 4515ms.
[12:17:08.795] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[12:17:09.057] <TB2> INFO: Expecting 41600 events.
[12:17:13.290] <TB2> INFO: 41600 events read in total (3677ms).
[12:17:13.290] <TB2> INFO: Test took 4495ms.
[12:17:13.294] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[12:17:13.579] <TB2> INFO: Expecting 41600 events.
[12:17:17.748] <TB2> INFO: 41600 events read in total (3612ms).
[12:17:17.749] <TB2> INFO: Test took 4455ms.
[12:17:18.205] <TB2> INFO: PixTestGainPedestal::measure() done
[12:17:51.147] <TB2> INFO: PixTestGainPedestal::fit() done
[12:17:51.147] <TB2> INFO: non-linearity mean: 0.957 0.959 0.960 0.961 0.957 0.956 0.960 0.961 0.958 0.949 0.956 0.963 0.960 0.957 0.958 0.950
[12:17:51.147] <TB2> INFO: non-linearity RMS: 0.006 0.006 0.006 0.005 0.006 0.005 0.006 0.004 0.007 0.006 0.005 0.006 0.006 0.005 0.005 0.006
[12:17:51.148] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[12:17:51.167] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[12:17:51.186] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[12:17:51.205] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[12:17:51.224] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[12:17:51.243] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[12:17:51.262] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[12:17:51.280] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[12:17:51.300] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[12:17:51.320] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[12:17:51.339] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[12:17:51.358] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[12:17:51.377] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[12:17:51.396] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[12:17:51.414] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[12:17:51.432] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[12:17:51.450] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 167 seconds
[12:17:51.450] <TB2> INFO: Decoding statistics:
[12:17:51.450] <TB2> INFO: General information:
[12:17:51.450] <TB2> INFO: 16bit words read: 2662400
[12:17:51.450] <TB2> INFO: valid events total: 166400
[12:17:51.450] <TB2> INFO: empty events: 0
[12:17:51.450] <TB2> INFO: valid events with pixels: 166400
[12:17:51.450] <TB2> INFO: valid pixel hits: 665580
[12:17:51.450] <TB2> INFO: Event errors: 0
[12:17:51.450] <TB2> INFO: start marker: 0
[12:17:51.450] <TB2> INFO: stop marker: 0
[12:17:51.450] <TB2> INFO: overflow: 0
[12:17:51.450] <TB2> INFO: invalid 5bit words: 0
[12:17:51.450] <TB2> INFO: invalid XOR eye diagram: 0
[12:17:51.450] <TB2> INFO: frame (failed synchr.): 0
[12:17:51.450] <TB2> INFO: idle data (no TBM trl): 0
[12:17:51.450] <TB2> INFO: no data (only TBM hdr): 0
[12:17:51.450] <TB2> INFO: TBM errors: 0
[12:17:51.450] <TB2> INFO: flawed TBM headers: 0
[12:17:51.450] <TB2> INFO: flawed TBM trailers: 0
[12:17:51.450] <TB2> INFO: event ID mismatches: 0
[12:17:51.450] <TB2> INFO: ROC errors: 0
[12:17:51.450] <TB2> INFO: missing ROC header(s): 0
[12:17:51.450] <TB2> INFO: misplaced readback start: 0
[12:17:51.450] <TB2> INFO: Pixel decoding errors: 0
[12:17:51.450] <TB2> INFO: pixel data incomplete: 0
[12:17:51.450] <TB2> INFO: pixel address: 0
[12:17:51.450] <TB2> INFO: pulse height fill bit: 0
[12:17:51.450] <TB2> INFO: buffer corruption: 0
[12:17:51.457] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C15.dat
[12:17:51.459] <TB2> INFO: ######################################################################
[12:17:51.459] <TB2> INFO: PixTestReadback::doTest()
[12:17:51.459] <TB2> INFO: ######################################################################
[12:17:51.459] <TB2> INFO: ----------------------------------------------------------------------
[12:17:51.459] <TB2> INFO: PixTestReadback::CalibrateVd()
[12:17:51.459] <TB2> INFO: ----------------------------------------------------------------------
[12:18:00.922] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C0.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C1.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C2.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C3.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C4.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C5.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C6.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C7.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C8.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C9.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C10.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C11.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C12.dat
[12:18:00.923] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C13.dat
[12:18:00.924] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C14.dat
[12:18:00.924] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C15.dat
[12:18:00.951] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[12:18:00.951] <TB2> INFO: ----------------------------------------------------------------------
[12:18:00.951] <TB2> INFO: PixTestReadback::CalibrateVa()
[12:18:00.951] <TB2> INFO: ----------------------------------------------------------------------
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C0.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C1.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C2.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C3.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C4.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C5.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C6.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C7.dat
[12:18:10.410] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C8.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C9.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C10.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C11.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C12.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C13.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C14.dat
[12:18:10.411] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C15.dat
[12:18:10.437] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[12:18:10.437] <TB2> INFO: ----------------------------------------------------------------------
[12:18:10.437] <TB2> INFO: PixTestReadback::readbackVbg()
[12:18:10.437] <TB2> INFO: ----------------------------------------------------------------------
[12:18:17.726] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[12:18:17.726] <TB2> INFO: ----------------------------------------------------------------------
[12:18:17.726] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[12:18:17.726] <TB2> INFO: ----------------------------------------------------------------------
[12:18:17.727] <TB2> INFO: Vbg will be calibrated using Vd calibration
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 158.5calibrated Vbg = 1.19081 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 158calibrated Vbg = 1.18322 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 145calibrated Vbg = 1.19317 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 154.7calibrated Vbg = 1.20129 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 159.6calibrated Vbg = 1.20008 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 163.7calibrated Vbg = 1.20044 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 155.3calibrated Vbg = 1.20009 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 158.2calibrated Vbg = 1.20797 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 155.2calibrated Vbg = 1.20447 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 155.4calibrated Vbg = 1.20717 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 147calibrated Vbg = 1.19838 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 143calibrated Vbg = 1.198 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 159calibrated Vbg = 1.19372 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 165.8calibrated Vbg = 1.18831 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 157.8calibrated Vbg = 1.19695 :::*/*/*/*/
[12:18:17.727] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 147.4calibrated Vbg = 1.19949 :::*/*/*/*/
[12:18:17.729] <TB2> INFO: ----------------------------------------------------------------------
[12:18:17.729] <TB2> INFO: PixTestReadback::CalibrateIa()
[12:18:17.729] <TB2> INFO: ----------------------------------------------------------------------
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C0.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C1.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C2.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C3.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C4.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C5.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C6.dat
[12:20:52.905] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C7.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C8.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C9.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C10.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C11.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C12.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C13.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C14.dat
[12:20:52.906] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2146_FullQualification_2016-02-05_11h40m_1454668827//000_FulltestPxar_m20//readbackCal_C15.dat
[12:20:52.936] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[12:20:52.937] <TB2> INFO: PixTestReadback::doTest() done
[12:20:52.937] <TB2> INFO: Decoding statistics:
[12:20:52.937] <TB2> INFO: General information:
[12:20:52.937] <TB2> INFO: 16bit words read: 1024
[12:20:52.937] <TB2> INFO: valid events total: 128
[12:20:52.937] <TB2> INFO: empty events: 128
[12:20:52.937] <TB2> INFO: valid events with pixels: 0
[12:20:52.937] <TB2> INFO: valid pixel hits: 0
[12:20:52.937] <TB2> INFO: Event errors: 0
[12:20:52.937] <TB2> INFO: start marker: 0
[12:20:52.937] <TB2> INFO: stop marker: 0
[12:20:52.937] <TB2> INFO: overflow: 0
[12:20:52.937] <TB2> INFO: invalid 5bit words: 0
[12:20:52.937] <TB2> INFO: invalid XOR eye diagram: 0
[12:20:52.937] <TB2> INFO: frame (failed synchr.): 0
[12:20:52.937] <TB2> INFO: idle data (no TBM trl): 0
[12:20:52.937] <TB2> INFO: no data (only TBM hdr): 0
[12:20:52.937] <TB2> INFO: TBM errors: 0
[12:20:52.937] <TB2> INFO: flawed TBM headers: 0
[12:20:52.937] <TB2> INFO: flawed TBM trailers: 0
[12:20:52.937] <TB2> INFO: event ID mismatches: 0
[12:20:52.937] <TB2> INFO: ROC errors: 0
[12:20:52.937] <TB2> INFO: missing ROC header(s): 0
[12:20:52.937] <TB2> INFO: misplaced readback start: 0
[12:20:52.937] <TB2> INFO: Pixel decoding errors: 0
[12:20:52.937] <TB2> INFO: pixel data incomplete: 0
[12:20:52.937] <TB2> INFO: pixel address: 0
[12:20:52.937] <TB2> INFO: pulse height fill bit: 0
[12:20:52.937] <TB2> INFO: buffer corruption: 0
[12:20:52.954] <TB2> INFO: Decoding statistics:
[12:20:52.954] <TB2> INFO: General information:
[12:20:52.954] <TB2> INFO: 16bit words read: 2755348
[12:20:52.954] <TB2> INFO: valid events total: 176768
[12:20:52.954] <TB2> INFO: empty events: 7867
[12:20:52.954] <TB2> INFO: valid events with pixels: 168901
[12:20:52.954] <TB2> INFO: valid pixel hits: 668081
[12:20:52.954] <TB2> INFO: Event errors: 0
[12:20:52.954] <TB2> INFO: start marker: 0
[12:20:52.954] <TB2> INFO: stop marker: 0
[12:20:52.954] <TB2> INFO: overflow: 0
[12:20:52.954] <TB2> INFO: invalid 5bit words: 0
[12:20:52.954] <TB2> INFO: invalid XOR eye diagram: 0
[12:20:52.954] <TB2> INFO: frame (failed synchr.): 0
[12:20:52.954] <TB2> INFO: idle data (no TBM trl): 0
[12:20:52.954] <TB2> INFO: no data (only TBM hdr): 0
[12:20:52.954] <TB2> INFO: TBM errors: 0
[12:20:52.954] <TB2> INFO: flawed TBM headers: 0
[12:20:52.954] <TB2> INFO: flawed TBM trailers: 0
[12:20:52.954] <TB2> INFO: event ID mismatches: 0
[12:20:52.954] <TB2> INFO: ROC errors: 0
[12:20:52.954] <TB2> INFO: missing ROC header(s): 0
[12:20:52.954] <TB2> INFO: misplaced readback start: 0
[12:20:52.954] <TB2> INFO: Pixel decoding errors: 0
[12:20:52.954] <TB2> INFO: pixel data incomplete: 0
[12:20:52.955] <TB2> INFO: pixel address: 0
[12:20:52.955] <TB2> INFO: pulse height fill bit: 0
[12:20:52.955] <TB2> INFO: buffer corruption: 0
[12:20:52.955] <TB2> INFO: enter test to run
[12:20:52.955] <TB2> INFO: test: exit no parameter change
[12:20:53.105] <TB2> QUIET: Connection to board 156 closed.
[12:20:53.184] <TB2> INFO: pXar: this is the end, my friend