[12:27:29.916] <TB0> INFO: *** Welcome to pxar ***
[12:27:29.916] <TB0> INFO: *** Today: 2016/03/22
[12:27:30.357] <TB0> INFO: *** Version: 9751-dirty
[12:27:30.357] <TB0> INFO: readRocDacs: /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C0.dat .. /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C15.dat
[12:27:30.372] <TB0> INFO: readTbmDacs: /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//tbmParameters_C0b.dat
[12:27:30.374] <TB0> INFO: readMaskFile: /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//defaultMaskFile.dat
[12:27:30.375] <TB0> INFO: readTrimFile: /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters_C0.dat .. /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters_C15.dat
[12:27:30.478] <TB0> INFO: clk: 4
[12:27:30.478] <TB0> INFO: ctr: 4
[12:27:30.478] <TB0> INFO: sda: 19
[12:27:30.478] <TB0> INFO: tin: 9
[12:27:30.478] <TB0> INFO: level: 15
[12:27:30.478] <TB0> INFO: triggerdelay: 0
[12:27:30.478] <TB0> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[12:27:30.478] <TB0> INFO: Log level: INFO
[12:27:30.485] <TB0> INFO: Found DTB DTB_WRQ4OZ
[12:27:30.492] <TB0> QUIET: Connection to board DTB_WRQ4OZ opened.
[12:27:30.494] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 71
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WRQ4OZ
MAC address: 40D855118047
Hostname: pixelDTB071
Comment:
------------------------------------------------------
[12:27:30.496] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[12:27:32.001] <TB0> INFO: DUT info:
[12:27:32.001] <TB0> INFO: The DUT currently contains the following objects:
[12:27:32.001] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[12:27:32.001] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:27:32.001] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:27:32.001] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:27:32.001] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.001] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:32.403] <TB0> INFO: enter 'restricted' command line mode
[12:27:32.403] <TB0> INFO: enter test to run
[12:27:32.403] <TB0> INFO: test: pretest no parameter change
[12:27:32.403] <TB0> INFO: running: pretest
[12:27:32.408] <TB0> INFO: ----------------------------------------------------------------------
[12:27:32.408] <TB0> INFO: PixTestPretest::programROC()
[12:27:32.408] <TB0> INFO: ----------------------------------------------------------------------
[12:27:50.422] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:27:50.423] <TB0> INFO: IA differences per ROC: 22.5 18.5 19.3 20.9 18.5 20.1 22.5 17.7 20.9 20.9 20.1 18.5 20.1 20.9 18.5 20.9
[12:27:50.515] <TB0> INFO: enter test to run
[12:27:50.515] <TB0> INFO: test: pretest no parameter change
[12:27:50.515] <TB0> INFO: running: pretest
[12:27:50.516] <TB0> INFO: ----------------------------------------------------------------------
[12:27:50.516] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:27:50.516] <TB0> INFO: ----------------------------------------------------------------------
[12:28:11.852] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 384.3 mA = 24.0187 mA/ROC
[12:28:11.852] <TB0> INFO: i(loss) [mA/ROC]: 19.3 18.5 19.3 19.3 19.3 19.3 18.5 19.3 19.3 20.1 17.7 19.3 19.3 19.3 19.3 18.5
[12:28:11.882] <TB0> INFO: enter test to run
[12:28:11.882] <TB0> INFO: test: pretest no parameter change
[12:28:11.882] <TB0> INFO: running: pretest
[12:28:11.882] <TB0> INFO: ----------------------------------------------------------------------
[12:28:11.882] <TB0> INFO: PixTestPretest::findTiming()
[12:28:11.882] <TB0> INFO: ----------------------------------------------------------------------
[12:28:11.883] <TB0> INFO: PixTestCmd::init()

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


[12:30:04.748] <TB0> INFO: 231680 events read in total (23701ms).
[12:30:04.752] <TB0> INFO: Test took 24350ms.
[12:30:04.980] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:30:05.041] <TB0> INFO: enter test to run
[12:30:05.041] <TB0> INFO: test: pretest no parameter change
[12:30:05.041] <TB0> INFO: running: pretest
[12:30:05.042] <TB0> INFO: ----------------------------------------------------------------------
[12:30:05.042] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[12:30:05.042] <TB0> INFO: ----------------------------------------------------------------------
[12:30:05.133] <TB0> INFO: Expecting 231680 events.
[12:30:29.298] <TB0> INFO: 231680 events read in total (23608ms).
[12:30:29.302] <TB0> INFO: Test took 24257ms.
[12:30:29.536] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[12:30:29.536] <TB0> INFO: CalDel: 135 133 140 150 139 168 141 146 144 143 141 119 133 146 145 159
[12:30:29.536] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 52 51 51 51 51 51
[12:30:29.570] <TB0> INFO: enter test to run
[12:30:29.570] <TB0> INFO: test: pretest no parameter change
[12:30:29.570] <TB0> INFO: running: pretest
[12:30:29.575] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C0.dat
[12:30:29.580] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C1.dat
[12:30:29.585] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C2.dat
[12:30:29.590] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C3.dat
[12:30:29.595] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C4.dat
[12:30:29.601] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C5.dat
[12:30:29.606] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C6.dat
[12:30:29.613] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C7.dat
[12:30:29.618] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C8.dat
[12:30:29.623] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C9.dat
[12:30:29.628] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C10.dat
[12:30:29.633] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C11.dat
[12:30:29.638] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C12.dat
[12:30:29.644] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C13.dat
[12:30:29.649] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C14.dat
[12:30:29.654] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters_C15.dat
[12:30:29.656] <TB0> INFO: enter test to run
[12:30:29.656] <TB0> INFO: test: fulltest no parameter change
[12:30:29.656] <TB0> INFO: running: fulltest
[12:30:29.656] <TB0> INFO: ######################################################################
[12:30:29.656] <TB0> INFO: PixTestFullTest::doTest()
[12:30:29.656] <TB0> INFO: ######################################################################
[12:30:29.657] <TB0> INFO: ######################################################################
[12:30:29.657] <TB0> INFO: PixTestAlive::doTest()
[12:30:29.657] <TB0> INFO: ######################################################################
[12:30:29.659] <TB0> INFO: ----------------------------------------------------------------------
[12:30:29.659] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:30:29.659] <TB0> INFO: ----------------------------------------------------------------------
[12:30:29.927] <TB0> INFO: Expecting 41600 events.
[12:30:37.926] <TB0> INFO: 41600 events read in total (7443ms).
[12:30:37.927] <TB0> INFO: Test took 8267ms.
[12:30:38.152] <TB0> INFO: PixTestAlive::aliveTest() done
[12:30:38.152] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:30:38.154] <TB0> INFO: ----------------------------------------------------------------------
[12:30:38.154] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:30:38.154] <TB0> INFO: ----------------------------------------------------------------------
[12:30:38.432] <TB0> INFO: Expecting 41600 events.
[12:30:43.502] <TB0> INFO: 41600 events read in total (4514ms).
[12:30:43.502] <TB0> INFO: Test took 5347ms.
[12:30:43.502] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:30:43.752] <TB0> INFO: PixTestAlive::maskTest() done
[12:30:43.752] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:30:43.753] <TB0> INFO: ----------------------------------------------------------------------
[12:30:43.753] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:30:43.753] <TB0> INFO: ----------------------------------------------------------------------
[12:30:44.026] <TB0> INFO: Expecting 41600 events.
[12:30:51.969] <TB0> INFO: 41600 events read in total (7387ms).
[12:30:51.970] <TB0> INFO: Test took 8216ms.
[12:30:52.196] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[12:30:52.196] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:30:52.196] <TB0> INFO: PixTestAlive::doTest() done, duration: 22 seconds
[12:30:52.196] <TB0> INFO: Decoding statistics:
[12:30:52.196] <TB0> INFO: General information:
[12:30:52.196] <TB0> INFO: 16bit words read: 0
[12:30:52.196] <TB0> INFO: valid events total: 0
[12:30:52.196] <TB0> INFO: empty events: 0
[12:30:52.196] <TB0> INFO: valid events with pixels: 0
[12:30:52.196] <TB0> INFO: valid pixel hits: 0
[12:30:52.196] <TB0> INFO: Event errors: 0
[12:30:52.196] <TB0> INFO: start marker: 0
[12:30:52.196] <TB0> INFO: stop marker: 0
[12:30:52.196] <TB0> INFO: overflow: 0
[12:30:52.196] <TB0> INFO: invalid 5bit words: 0
[12:30:52.196] <TB0> INFO: invalid XOR eye diagram: 0
[12:30:52.196] <TB0> INFO: frame (failed synchr.): 0
[12:30:52.196] <TB0> INFO: idle data (no TBM trl): 0
[12:30:52.196] <TB0> INFO: no data (only TBM hdr): 0
[12:30:52.196] <TB0> INFO: TBM errors: 0
[12:30:52.196] <TB0> INFO: flawed TBM headers: 0
[12:30:52.196] <TB0> INFO: flawed TBM trailers: 0
[12:30:52.196] <TB0> INFO: event ID mismatches: 0
[12:30:52.196] <TB0> INFO: ROC errors: 0
[12:30:52.196] <TB0> INFO: missing ROC header(s): 0
[12:30:52.196] <TB0> INFO: misplaced readback start: 0
[12:30:52.196] <TB0> INFO: Pixel decoding errors: 0
[12:30:52.196] <TB0> INFO: pixel data incomplete: 0
[12:30:52.196] <TB0> INFO: pixel address: 0
[12:30:52.196] <TB0> INFO: pulse height fill bit: 0
[12:30:52.196] <TB0> INFO: buffer corruption: 0
[12:30:52.202] <TB0> INFO: ######################################################################
[12:30:52.202] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:30:52.202] <TB0> INFO: ######################################################################
[12:30:52.205] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:30:52.218] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:30:52.218] <TB0> INFO: run 1 of 1
[12:30:52.514] <TB0> INFO: Expecting 3120000 events.
[12:32:38.428] <TB0> INFO: 828175 events read in total (105358ms).
[12:34:24.530] <TB0> INFO: 1649110 events read in total (211460ms).
[12:36:11.622] <TB0> INFO: 2480900 events read in total (318552ms).
[12:37:32.535] <TB0> INFO: 3120000 events read in total (399465ms).
[12:37:32.586] <TB0> INFO: Test took 400368ms.
[12:37:56.254] <TB0> INFO: PixTestBBMap::doTest() done, duration: 424 seconds
[12:37:56.254] <TB0> INFO: number of dead bumps (per ROC): 92 19 34 45 97 46 31 200 238 56 34 33 25 44 34 88
[12:37:56.254] <TB0> INFO: separation cut (per ROC): 82 80 74 83 67 65 66 64 80 73 74 68 82 69 70 83
[12:37:56.254] <TB0> INFO: Decoding statistics:
[12:37:56.254] <TB0> INFO: General information:
[12:37:56.254] <TB0> INFO: 16bit words read: 0
[12:37:56.254] <TB0> INFO: valid events total: 0
[12:37:56.254] <TB0> INFO: empty events: 0
[12:37:56.254] <TB0> INFO: valid events with pixels: 0
[12:37:56.254] <TB0> INFO: valid pixel hits: 0
[12:37:56.254] <TB0> INFO: Event errors: 0
[12:37:56.254] <TB0> INFO: start marker: 0
[12:37:56.254] <TB0> INFO: stop marker: 0
[12:37:56.254] <TB0> INFO: overflow: 0
[12:37:56.254] <TB0> INFO: invalid 5bit words: 0
[12:37:56.254] <TB0> INFO: invalid XOR eye diagram: 0
[12:37:56.254] <TB0> INFO: frame (failed synchr.): 0
[12:37:56.254] <TB0> INFO: idle data (no TBM trl): 0
[12:37:56.254] <TB0> INFO: no data (only TBM hdr): 0
[12:37:56.254] <TB0> INFO: TBM errors: 0
[12:37:56.254] <TB0> INFO: flawed TBM headers: 0
[12:37:56.254] <TB0> INFO: flawed TBM trailers: 0
[12:37:56.254] <TB0> INFO: event ID mismatches: 0
[12:37:56.254] <TB0> INFO: ROC errors: 0
[12:37:56.254] <TB0> INFO: missing ROC header(s): 0
[12:37:56.254] <TB0> INFO: misplaced readback start: 0
[12:37:56.254] <TB0> INFO: Pixel decoding errors: 0
[12:37:56.254] <TB0> INFO: pixel data incomplete: 0
[12:37:56.254] <TB0> INFO: pixel address: 0
[12:37:56.254] <TB0> INFO: pulse height fill bit: 0
[12:37:56.254] <TB0> INFO: buffer corruption: 0
[12:37:56.332] <TB0> INFO: ######################################################################
[12:37:56.332] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:37:56.332] <TB0> INFO: ######################################################################
[12:37:56.332] <TB0> INFO: ----------------------------------------------------------------------
[12:37:56.332] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:37:56.332] <TB0> INFO: ----------------------------------------------------------------------
[12:37:56.332] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:37:56.340] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[12:37:56.340] <TB0> INFO: run 1 of 1
[12:37:56.603] <TB0> INFO: Expecting 26208000 events.
[12:39:37.742] <TB0> INFO: 900800 events read in total (100582ms).
[12:41:18.348] <TB0> INFO: 1787100 events read in total (201188ms).
[12:42:58.522] <TB0> INFO: 2670800 events read in total (301362ms).
[12:44:38.776] <TB0> INFO: 3556250 events read in total (401616ms).
[12:46:18.460] <TB0> INFO: 4435400 events read in total (501300ms).
[12:47:58.791] <TB0> INFO: 5315650 events read in total (601631ms).
[12:49:39.230] <TB0> INFO: 6198850 events read in total (702070ms).
[12:51:20.024] <TB0> INFO: 7080250 events read in total (802864ms).
[12:52:59.143] <TB0> INFO: 7960600 events read in total (901983ms).
[12:54:38.528] <TB0> INFO: 8842150 events read in total (1001368ms).
[12:56:18.536] <TB0> INFO: 9724750 events read in total (1101376ms).
[12:57:59.064] <TB0> INFO: 10604650 events read in total (1201904ms).
[12:59:39.674] <TB0> INFO: 11482800 events read in total (1302514ms).
[13:01:20.249] <TB0> INFO: 12364000 events read in total (1403089ms).
[13:03:00.445] <TB0> INFO: 13241050 events read in total (1503285ms).
[13:04:40.466] <TB0> INFO: 14111650 events read in total (1603306ms).
[13:06:20.524] <TB0> INFO: 14979950 events read in total (1703364ms).
[13:08:00.855] <TB0> INFO: 15849450 events read in total (1803695ms).
[13:09:40.975] <TB0> INFO: 16717350 events read in total (1903815ms).
[13:11:21.169] <TB0> INFO: 17582750 events read in total (2004009ms).
[13:13:01.439] <TB0> INFO: 18451700 events read in total (2104279ms).
[13:14:41.899] <TB0> INFO: 19319900 events read in total (2204739ms).
[13:16:21.950] <TB0> INFO: 20185100 events read in total (2304790ms).
[13:18:02.071] <TB0> INFO: 21048000 events read in total (2404911ms).
[13:19:42.379] <TB0> INFO: 21916200 events read in total (2505219ms).
[13:21:22.452] <TB0> INFO: 22781050 events read in total (2605292ms).
[13:23:02.019] <TB0> INFO: 23648500 events read in total (2704859ms).
[13:24:41.958] <TB0> INFO: 24513550 events read in total (2804798ms).
[13:26:22.037] <TB0> INFO: 25377850 events read in total (2904877ms).
[13:27:56.372] <TB0> INFO: 26208000 events read in total (2999212ms).
[13:27:56.413] <TB0> INFO: Test took 3000073ms.
[13:27:56.657] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:27:58.203] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:27:59.759] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:01.296] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:02.862] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:04.404] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:06.041] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:07.741] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:09.310] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:10.866] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:12.499] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:14.192] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:15.741] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:17.229] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:19.208] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:20.794] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[13:28:22.288] <TB0> INFO: PixTestScurves::scurves() done
[13:28:22.288] <TB0> INFO: Vcal mean: 96.76 96.48 90.01 88.60 88.85 90.95 82.69 77.62 89.85 87.10 98.12 82.71 88.36 87.91 78.06 99.78
[13:28:22.288] <TB0> INFO: Vcal RMS: 5.76 6.44 5.66 5.40 5.70 5.21 4.57 4.85 5.33 5.44 5.63 5.20 5.97 5.02 4.00 5.69
[13:28:22.288] <TB0> INFO: PixTestScurves::fullTest() done, duration: 3025 seconds
[13:28:22.288] <TB0> INFO: Decoding statistics:
[13:28:22.288] <TB0> INFO: General information:
[13:28:22.288] <TB0> INFO: 16bit words read: 0
[13:28:22.288] <TB0> INFO: valid events total: 0
[13:28:22.288] <TB0> INFO: empty events: 0
[13:28:22.288] <TB0> INFO: valid events with pixels: 0
[13:28:22.288] <TB0> INFO: valid pixel hits: 0
[13:28:22.288] <TB0> INFO: Event errors: 0
[13:28:22.288] <TB0> INFO: start marker: 0
[13:28:22.288] <TB0> INFO: stop marker: 0
[13:28:22.288] <TB0> INFO: overflow: 0
[13:28:22.288] <TB0> INFO: invalid 5bit words: 0
[13:28:22.288] <TB0> INFO: invalid XOR eye diagram: 0
[13:28:22.288] <TB0> INFO: frame (failed synchr.): 0
[13:28:22.288] <TB0> INFO: idle data (no TBM trl): 0
[13:28:22.288] <TB0> INFO: no data (only TBM hdr): 0
[13:28:22.288] <TB0> INFO: TBM errors: 0
[13:28:22.288] <TB0> INFO: flawed TBM headers: 0
[13:28:22.288] <TB0> INFO: flawed TBM trailers: 0
[13:28:22.288] <TB0> INFO: event ID mismatches: 0
[13:28:22.288] <TB0> INFO: ROC errors: 0
[13:28:22.288] <TB0> INFO: missing ROC header(s): 0
[13:28:22.288] <TB0> INFO: misplaced readback start: 0
[13:28:22.288] <TB0> INFO: Pixel decoding errors: 0
[13:28:22.288] <TB0> INFO: pixel data incomplete: 0
[13:28:22.288] <TB0> INFO: pixel address: 0
[13:28:22.288] <TB0> INFO: pulse height fill bit: 0
[13:28:22.288] <TB0> INFO: buffer corruption: 0
[13:28:22.376] <TB0> INFO: ######################################################################
[13:28:22.376] <TB0> INFO: PixTestTrim::doTest()
[13:28:22.376] <TB0> INFO: ######################################################################
[13:28:22.377] <TB0> INFO: ----------------------------------------------------------------------
[13:28:22.377] <TB0> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[13:28:22.377] <TB0> INFO: ----------------------------------------------------------------------
[13:28:22.493] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[13:28:22.493] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:28:22.504] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[13:28:22.504] <TB0> INFO: run 1 of 1
[13:28:22.844] <TB0> INFO: Expecting 5025280 events.
[13:30:10.404] <TB0> INFO: 1061312 events read in total (107004ms).
[13:31:56.936] <TB0> INFO: 2115960 events read in total (213536ms).
[13:33:44.343] <TB0> INFO: 3171496 events read in total (320944ms).
[13:35:31.985] <TB0> INFO: 4232920 events read in total (428585ms).
[13:36:52.027] <TB0> INFO: 5025280 events read in total (508627ms).
[13:36:52.063] <TB0> INFO: Test took 509558ms.
[13:37:13.093] <TB0> INFO: ROC 0 VthrComp = 100
[13:37:13.093] <TB0> INFO: ROC 1 VthrComp = 96
[13:37:13.093] <TB0> INFO: ROC 2 VthrComp = 90
[13:37:13.093] <TB0> INFO: ROC 3 VthrComp = 97
[13:37:13.093] <TB0> INFO: ROC 4 VthrComp = 90
[13:37:13.093] <TB0> INFO: ROC 5 VthrComp = 90
[13:37:13.094] <TB0> INFO: ROC 6 VthrComp = 88
[13:37:13.094] <TB0> INFO: ROC 7 VthrComp = 82
[13:37:13.094] <TB0> INFO: ROC 8 VthrComp = 95
[13:37:13.094] <TB0> INFO: ROC 9 VthrComp = 91
[13:37:13.094] <TB0> INFO: ROC 10 VthrComp = 98
[13:37:13.094] <TB0> INFO: ROC 11 VthrComp = 86
[13:37:13.094] <TB0> INFO: ROC 12 VthrComp = 94
[13:37:13.094] <TB0> INFO: ROC 13 VthrComp = 88
[13:37:13.094] <TB0> INFO: ROC 14 VthrComp = 83
[13:37:13.094] <TB0> INFO: ROC 15 VthrComp = 100
[13:37:13.094] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:37:13.094] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:37:13.104] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[13:37:13.104] <TB0> INFO: run 1 of 1
[13:37:13.377] <TB0> INFO: Expecting 5025280 events.
[13:38:57.532] <TB0> INFO: 754488 events read in total (103599ms).
[13:40:40.472] <TB0> INFO: 1508376 events read in total (206539ms).
[13:42:24.250] <TB0> INFO: 2263232 events read in total (310317ms).
[13:44:08.309] <TB0> INFO: 3014384 events read in total (414376ms).
[13:45:52.260] <TB0> INFO: 3760640 events read in total (518327ms).
[13:47:35.845] <TB0> INFO: 4505568 events read in total (621912ms).
[13:48:47.803] <TB0> INFO: 5025280 events read in total (693870ms).
[13:48:47.850] <TB0> INFO: Test took 694746ms.
[13:49:13.104] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 59.322 for pixel 20/45 mean/min/max = 45.6249/31.8659/59.3839
[13:49:13.105] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 61.6394 for pixel 18/11 mean/min/max = 46.3049/30.7785/61.8314
[13:49:13.105] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 60.7194 for pixel 4/6 mean/min/max = 46.5623/32.0985/61.0261
[13:49:13.105] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 57.0994 for pixel 18/22 mean/min/max = 44.7195/32.1923/57.2467
[13:49:13.106] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 60.3788 for pixel 20/79 mean/min/max = 46.2449/32.0398/60.45
[13:49:13.106] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 59.4447 for pixel 19/12 mean/min/max = 46.3992/33.0718/59.7266
[13:49:13.106] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 56.906 for pixel 0/52 mean/min/max = 44.8262/32.6928/56.9596
[13:49:13.106] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 58.0932 for pixel 22/55 mean/min/max = 45.1323/32.0765/58.1881
[13:49:13.107] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 57.3795 for pixel 6/7 mean/min/max = 44.9306/32.2266/57.6346
[13:49:13.107] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 58.4705 for pixel 9/33 mean/min/max = 45.577/32.6649/58.489
[13:49:13.107] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 59.6897 for pixel 34/79 mean/min/max = 45.8492/31.9952/59.7033
[13:49:13.107] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 59.3692 for pixel 6/3 mean/min/max = 45.3694/31.1603/59.5785
[13:49:13.108] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 60.3442 for pixel 22/6 mean/min/max = 46.1288/31.8522/60.4053
[13:49:13.108] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 58.8743 for pixel 51/62 mean/min/max = 45.715/32.5308/58.8991
[13:49:13.108] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 55.9918 for pixel 24/9 mean/min/max = 44.1602/32.1923/56.1281
[13:49:13.108] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 60.7244 for pixel 12/19 mean/min/max = 46.1097/31.4948/60.7246
[13:49:13.109] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:49:13.197] <TB0> INFO: Expecting 411648 events.
[13:49:45.535] <TB0> INFO: 411648 events read in total (31778ms).
[13:49:45.540] <TB0> INFO: Expecting 411648 events.
[13:50:17.944] <TB0> INFO: 411648 events read in total (31981ms).
[13:50:17.951] <TB0> INFO: Expecting 411648 events.
[13:50:50.255] <TB0> INFO: 411648 events read in total (31882ms).
[13:50:50.263] <TB0> INFO: Expecting 411648 events.
[13:51:22.560] <TB0> INFO: 411648 events read in total (31879ms).
[13:51:22.570] <TB0> INFO: Expecting 411648 events.
[13:51:55.101] <TB0> INFO: 411648 events read in total (32108ms).
[13:51:55.114] <TB0> INFO: Expecting 411648 events.
[13:52:27.444] <TB0> INFO: 411648 events read in total (31909ms).
[13:52:27.458] <TB0> INFO: Expecting 411648 events.
[13:52:59.581] <TB0> INFO: 411648 events read in total (31705ms).
[13:52:59.598] <TB0> INFO: Expecting 411648 events.
[13:53:31.742] <TB0> INFO: 411648 events read in total (31728ms).
[13:53:31.760] <TB0> INFO: Expecting 411648 events.
[13:54:04.383] <TB0> INFO: 411648 events read in total (32207ms).
[13:54:04.404] <TB0> INFO: Expecting 411648 events.
[13:54:37.191] <TB0> INFO: 411648 events read in total (32381ms).
[13:54:37.213] <TB0> INFO: Expecting 411648 events.
[13:55:09.837] <TB0> INFO: 411648 events read in total (32220ms).
[13:55:09.860] <TB0> INFO: Expecting 411648 events.
[13:55:42.465] <TB0> INFO: 411648 events read in total (32196ms).
[13:55:42.494] <TB0> INFO: Expecting 411648 events.
[13:56:15.313] <TB0> INFO: 411648 events read in total (32417ms).
[13:56:15.343] <TB0> INFO: Expecting 411648 events.
[13:56:47.709] <TB0> INFO: 411648 events read in total (31965ms).
[13:56:47.738] <TB0> INFO: Expecting 411648 events.
[13:57:20.425] <TB0> INFO: 411648 events read in total (32283ms).
[13:57:20.461] <TB0> INFO: Expecting 411648 events.
[13:57:53.064] <TB0> INFO: 411648 events read in total (32201ms).
[13:57:53.098] <TB0> INFO: Test took 519989ms.
[13:57:54.079] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:57:54.087] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[13:57:54.087] <TB0> INFO: run 1 of 1
[13:57:54.352] <TB0> INFO: Expecting 5025280 events.
[13:59:39.043] <TB0> INFO: 739704 events read in total (104135ms).
[14:01:22.550] <TB0> INFO: 1478992 events read in total (207642ms).
[14:03:05.736] <TB0> INFO: 2218992 events read in total (310828ms).
[14:04:49.143] <TB0> INFO: 2955576 events read in total (414235ms).
[14:06:32.214] <TB0> INFO: 3686704 events read in total (517306ms).
[14:08:15.622] <TB0> INFO: 4415600 events read in total (620714ms).
[14:09:42.131] <TB0> INFO: 5025280 events read in total (707223ms).
[14:09:42.179] <TB0> INFO: Test took 708092ms.
[14:10:06.646] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 6.951068 .. 54.192389
[14:10:06.723] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 6 .. 64 (-1/-1) hits flags = 528 (plus default)
[14:10:06.730] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:10:06.730] <TB0> INFO: run 1 of 1
[14:10:06.990] <TB0> INFO: Expecting 1963520 events.
[14:11:53.136] <TB0> INFO: 880056 events read in total (105590ms).
[14:13:38.306] <TB0> INFO: 1752680 events read in total (210760ms).
[14:14:04.199] <TB0> INFO: 1963520 events read in total (236654ms).
[14:14:04.222] <TB0> INFO: Test took 237493ms.
[14:14:19.548] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 11.439168 .. 46.048621
[14:14:19.630] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 1 .. 56 (-1/-1) hits flags = 528 (plus default)
[14:14:19.640] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:14:19.640] <TB0> INFO: run 1 of 1
[14:14:19.909] <TB0> INFO: Expecting 1863680 events.
[14:16:07.954] <TB0> INFO: 950680 events read in total (107488ms).
[14:17:50.524] <TB0> INFO: 1863680 events read in total (210058ms).
[14:17:50.539] <TB0> INFO: Test took 210899ms.
[14:18:04.421] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 17.489389 .. 42.693746
[14:18:04.498] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 7 .. 52 (-1/-1) hits flags = 528 (plus default)
[14:18:04.506] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:18:04.506] <TB0> INFO: run 1 of 1
[14:18:04.769] <TB0> INFO: Expecting 1530880 events.
[14:19:52.754] <TB0> INFO: 954312 events read in total (107428ms).
[14:20:57.638] <TB0> INFO: 1530880 events read in total (172312ms).
[14:20:57.649] <TB0> INFO: Test took 173142ms.
[14:21:11.265] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 19.357317 .. 42.456898
[14:21:11.345] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 9 .. 52 (-1/-1) hits flags = 528 (plus default)
[14:21:11.355] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:21:11.355] <TB0> INFO: run 1 of 1
[14:21:11.624] <TB0> INFO: Expecting 1464320 events.
[14:22:58.471] <TB0> INFO: 942464 events read in total (106291ms).
[14:23:57.612] <TB0> INFO: 1464320 events read in total (165433ms).
[14:23:57.626] <TB0> INFO: Test took 166271ms.
[14:24:10.668] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[14:24:10.669] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:24:10.677] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:24:10.677] <TB0> INFO: run 1 of 1
[14:24:10.948] <TB0> INFO: Expecting 1364480 events.
[14:25:57.722] <TB0> INFO: 879592 events read in total (106218ms).
[14:26:56.355] <TB0> INFO: 1364480 events read in total (164851ms).
[14:26:56.370] <TB0> INFO: Test took 165693ms.
[14:27:10.768] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C0.dat
[14:27:10.772] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C1.dat
[14:27:10.776] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C2.dat
[14:27:10.780] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C3.dat
[14:27:10.784] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C4.dat
[14:27:10.787] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C5.dat
[14:27:10.791] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C6.dat
[14:27:10.795] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C7.dat
[14:27:10.799] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C8.dat
[14:27:10.802] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C9.dat
[14:27:10.806] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C10.dat
[14:27:10.810] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C11.dat
[14:27:10.813] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C12.dat
[14:27:10.817] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C13.dat
[14:27:10.821] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C14.dat
[14:27:10.825] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C15.dat
[14:27:10.828] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C0.dat
[14:27:10.841] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C1.dat
[14:27:10.853] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C2.dat
[14:27:10.867] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C3.dat
[14:27:10.880] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C4.dat
[14:27:10.893] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C5.dat
[14:27:10.905] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C6.dat
[14:27:10.916] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C7.dat
[14:27:10.930] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C8.dat
[14:27:10.942] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C9.dat
[14:27:10.955] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C10.dat
[14:27:10.968] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C11.dat
[14:27:10.981] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C12.dat
[14:27:10.993] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C13.dat
[14:27:11.006] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C14.dat
[14:27:11.019] <TB0> INFO: write trim parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//trimParameters35_C15.dat
[14:27:11.030] <TB0> INFO: PixTestTrim::trimTest() done
[14:27:11.030] <TB0> INFO: vtrim: 99 104 98 97 102 106 96 93 99 104 107 95 108 90 98 112
[14:27:11.030] <TB0> INFO: vthrcomp: 100 96 90 97 90 90 88 82 95 91 98 86 94 88 83 100
[14:27:11.030] <TB0> INFO: vcal mean: 34.99 34.97 35.01 34.98 34.97 34.95 35.01 35.01 35.00 34.96 34.98 34.97 34.98 35.00 34.98 34.95
[14:27:11.030] <TB0> INFO: vcal RMS: 0.93 1.03 0.93 0.92 0.93 0.96 0.89 0.91 0.90 0.86 0.96 0.88 0.91 0.89 0.89 1.11
[14:27:11.030] <TB0> INFO: bits mean: 9.36 9.57 9.21 9.81 9.45 9.19 9.82 9.53 9.72 9.23 9.68 9.24 9.41 8.85 9.97 10.01
[14:27:11.030] <TB0> INFO: bits RMS: 2.75 2.74 2.73 2.60 2.65 2.64 2.49 2.68 2.64 2.72 2.58 2.90 2.71 2.85 2.50 2.47
[14:27:11.036] <TB0> INFO: ----------------------------------------------------------------------
[14:27:11.036] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[14:27:11.036] <TB0> INFO: ----------------------------------------------------------------------
[14:27:11.038] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[14:27:11.047] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:27:11.047] <TB0> INFO: run 1 of 1
[14:27:11.318] <TB0> INFO: Expecting 4160000 events.
[14:29:01.360] <TB0> INFO: 929795 events read in total (109486ms).
[14:30:50.224] <TB0> INFO: 1854400 events read in total (218350ms).
[14:32:38.059] <TB0> INFO: 2771220 events read in total (326185ms).
[14:34:26.451] <TB0> INFO: 3685475 events read in total (434577ms).
[14:35:22.517] <TB0> INFO: 4160000 events read in total (490643ms).
[14:35:22.557] <TB0> INFO: Test took 491510ms.
[14:35:52.805] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 166 (-1/-1) hits flags = 528 (plus default)
[14:35:52.814] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:35:52.814] <TB0> INFO: run 1 of 1
[14:35:53.074] <TB0> INFO: Expecting 3473600 events.
[14:37:43.176] <TB0> INFO: 966835 events read in total (109545ms).
[14:39:33.019] <TB0> INFO: 1925795 events read in total (219388ms).
[14:41:21.471] <TB0> INFO: 2874790 events read in total (327840ms).
[14:42:29.767] <TB0> INFO: 3473600 events read in total (396136ms).
[14:42:29.803] <TB0> INFO: Test took 396988ms.
[14:42:56.483] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 154 (-1/-1) hits flags = 528 (plus default)
[14:42:56.493] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:42:56.493] <TB0> INFO: run 1 of 1
[14:42:56.773] <TB0> INFO: Expecting 3224000 events.
[14:44:46.622] <TB0> INFO: 1001415 events read in total (109288ms).
[14:46:36.086] <TB0> INFO: 1991480 events read in total (218752ms).
[14:48:25.224] <TB0> INFO: 2972115 events read in total (327891ms).
[14:48:53.321] <TB0> INFO: 3224000 events read in total (355987ms).
[14:48:53.351] <TB0> INFO: Test took 356859ms.
[14:49:17.152] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[14:49:17.161] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:49:17.161] <TB0> INFO: run 1 of 1
[14:49:17.433] <TB0> INFO: Expecting 3244800 events.
[14:51:07.213] <TB0> INFO: 997410 events read in total (109224ms).
[14:52:57.020] <TB0> INFO: 1983455 events read in total (219031ms).
[14:54:45.905] <TB0> INFO: 2960435 events read in total (327916ms).
[14:55:17.437] <TB0> INFO: 3244800 events read in total (359448ms).
[14:55:17.467] <TB0> INFO: Test took 360306ms.
[14:55:41.597] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 154 (-1/-1) hits flags = 528 (plus default)
[14:55:41.606] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:55:41.606] <TB0> INFO: run 1 of 1
[14:55:41.874] <TB0> INFO: Expecting 3224000 events.
[14:57:31.604] <TB0> INFO: 1000045 events read in total (109174ms).
[14:59:21.098] <TB0> INFO: 1988350 events read in total (218668ms).
[15:01:10.269] <TB0> INFO: 2967280 events read in total (327840ms).
[15:01:38.607] <TB0> INFO: 3224000 events read in total (356177ms).
[15:01:38.638] <TB0> INFO: Test took 357032ms.
[15:02:03.797] <TB0> INFO: PixTestTrim::trimBitTest() done
[15:02:03.799] <TB0> INFO: PixTestTrim::doTest() done, duration: 5621 seconds
[15:02:03.799] <TB0> INFO: Decoding statistics:
[15:02:03.799] <TB0> INFO: General information:
[15:02:03.799] <TB0> INFO: 16bit words read: 0
[15:02:03.799] <TB0> INFO: valid events total: 0
[15:02:03.799] <TB0> INFO: empty events: 0
[15:02:03.799] <TB0> INFO: valid events with pixels: 0
[15:02:03.799] <TB0> INFO: valid pixel hits: 0
[15:02:03.799] <TB0> INFO: Event errors: 0
[15:02:03.799] <TB0> INFO: start marker: 0
[15:02:03.799] <TB0> INFO: stop marker: 0
[15:02:03.799] <TB0> INFO: overflow: 0
[15:02:03.799] <TB0> INFO: invalid 5bit words: 0
[15:02:03.799] <TB0> INFO: invalid XOR eye diagram: 0
[15:02:03.799] <TB0> INFO: frame (failed synchr.): 0
[15:02:03.799] <TB0> INFO: idle data (no TBM trl): 0
[15:02:03.799] <TB0> INFO: no data (only TBM hdr): 0
[15:02:03.799] <TB0> INFO: TBM errors: 0
[15:02:03.799] <TB0> INFO: flawed TBM headers: 0
[15:02:03.799] <TB0> INFO: flawed TBM trailers: 0
[15:02:03.799] <TB0> INFO: event ID mismatches: 0
[15:02:03.799] <TB0> INFO: ROC errors: 0
[15:02:03.799] <TB0> INFO: missing ROC header(s): 0
[15:02:03.799] <TB0> INFO: misplaced readback start: 0
[15:02:03.799] <TB0> INFO: Pixel decoding errors: 0
[15:02:03.799] <TB0> INFO: pixel data incomplete: 0
[15:02:03.799] <TB0> INFO: pixel address: 0
[15:02:03.799] <TB0> INFO: pulse height fill bit: 0
[15:02:03.799] <TB0> INFO: buffer corruption: 0
[15:02:04.501] <TB0> INFO: ######################################################################
[15:02:04.501] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[15:02:04.501] <TB0> INFO: ######################################################################
[15:02:04.765] <TB0> INFO: Expecting 41600 events.
[15:02:12.651] <TB0> INFO: 41600 events read in total (7330ms).
[15:02:12.652] <TB0> INFO: Test took 8150ms.
[15:02:13.128] <TB0> INFO: Expecting 41600 events.
[15:02:21.061] <TB0> INFO: 41600 events read in total (7377ms).
[15:02:21.062] <TB0> INFO: Test took 8209ms.
[15:02:21.355] <TB0> INFO: Expecting 41600 events.
[15:02:29.344] <TB0> INFO: 41600 events read in total (7432ms).
[15:02:29.345] <TB0> INFO: Test took 8262ms.
[15:02:29.600] <TB0> INFO: Expecting 2560 events.
[15:02:30.590] <TB0> INFO: 2560 events read in total (433ms).
[15:02:30.590] <TB0> INFO: Test took 1231ms.
[15:02:30.897] <TB0> INFO: Expecting 2560 events.
[15:02:31.884] <TB0> INFO: 2560 events read in total (431ms).
[15:02:31.884] <TB0> INFO: Test took 1294ms.
[15:02:32.190] <TB0> INFO: Expecting 2560 events.
[15:02:33.178] <TB0> INFO: 2560 events read in total (431ms).
[15:02:33.178] <TB0> INFO: Test took 1293ms.
[15:02:33.484] <TB0> INFO: Expecting 2560 events.
[15:02:34.471] <TB0> INFO: 2560 events read in total (431ms).
[15:02:34.471] <TB0> INFO: Test took 1292ms.
[15:02:34.777] <TB0> INFO: Expecting 2560 events.
[15:02:35.765] <TB0> INFO: 2560 events read in total (432ms).
[15:02:35.765] <TB0> INFO: Test took 1294ms.
[15:02:36.071] <TB0> INFO: Expecting 2560 events.
[15:02:37.059] <TB0> INFO: 2560 events read in total (431ms).
[15:02:37.060] <TB0> INFO: Test took 1295ms.
[15:02:37.364] <TB0> INFO: Expecting 2560 events.
[15:02:38.358] <TB0> INFO: 2560 events read in total (438ms).
[15:02:38.358] <TB0> INFO: Test took 1298ms.
[15:02:38.664] <TB0> INFO: Expecting 2560 events.
[15:02:39.653] <TB0> INFO: 2560 events read in total (432ms).
[15:02:39.653] <TB0> INFO: Test took 1294ms.
[15:02:39.959] <TB0> INFO: Expecting 2560 events.
[15:02:40.948] <TB0> INFO: 2560 events read in total (433ms).
[15:02:40.948] <TB0> INFO: Test took 1295ms.
[15:02:41.253] <TB0> INFO: Expecting 2560 events.
[15:02:42.240] <TB0> INFO: 2560 events read in total (431ms).
[15:02:42.241] <TB0> INFO: Test took 1293ms.
[15:02:42.546] <TB0> INFO: Expecting 2560 events.
[15:02:43.536] <TB0> INFO: 2560 events read in total (433ms).
[15:02:43.536] <TB0> INFO: Test took 1295ms.
[15:02:43.841] <TB0> INFO: Expecting 2560 events.
[15:02:44.829] <TB0> INFO: 2560 events read in total (431ms).
[15:02:44.830] <TB0> INFO: Test took 1293ms.
[15:02:45.135] <TB0> INFO: Expecting 2560 events.
[15:02:46.122] <TB0> INFO: 2560 events read in total (431ms).
[15:02:46.122] <TB0> INFO: Test took 1291ms.
[15:02:46.428] <TB0> INFO: Expecting 2560 events.
[15:02:47.419] <TB0> INFO: 2560 events read in total (435ms).
[15:02:47.419] <TB0> INFO: Test took 1296ms.
[15:02:47.724] <TB0> INFO: Expecting 2560 events.
[15:02:48.714] <TB0> INFO: 2560 events read in total (434ms).
[15:02:48.714] <TB0> INFO: Test took 1294ms.
[15:02:49.019] <TB0> INFO: Expecting 2560 events.
[15:02:50.011] <TB0> INFO: 2560 events read in total (435ms).
[15:02:50.012] <TB0> INFO: Test took 1297ms.
[15:02:50.015] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:02:50.317] <TB0> INFO: Expecting 655360 events.
[15:03:43.429] <TB0> INFO: 655360 events read in total (52556ms).
[15:03:43.441] <TB0> INFO: Expecting 655360 events.
[15:04:36.321] <TB0> INFO: 655360 events read in total (52478ms).
[15:04:36.334] <TB0> INFO: Expecting 655360 events.
[15:05:29.435] <TB0> INFO: 655360 events read in total (52699ms).
[15:05:29.453] <TB0> INFO: Expecting 655360 events.
[15:06:22.491] <TB0> INFO: 655360 events read in total (52636ms).
[15:06:22.513] <TB0> INFO: Expecting 655360 events.
[15:07:15.618] <TB0> INFO: 655360 events read in total (52703ms).
[15:07:15.641] <TB0> INFO: Expecting 655360 events.
[15:08:08.775] <TB0> INFO: 655360 events read in total (52733ms).
[15:08:08.805] <TB0> INFO: Expecting 655360 events.
[15:09:01.792] <TB0> INFO: 655360 events read in total (52586ms).
[15:09:01.822] <TB0> INFO: Expecting 655360 events.
[15:09:54.962] <TB0> INFO: 655360 events read in total (52738ms).
[15:09:55.008] <TB0> INFO: Expecting 655360 events.
[15:10:48.132] <TB0> INFO: 655360 events read in total (52722ms).
[15:10:48.172] <TB0> INFO: Expecting 655360 events.
[15:11:41.219] <TB0> INFO: 655360 events read in total (52646ms).
[15:11:41.261] <TB0> INFO: Expecting 655360 events.
[15:12:34.398] <TB0> INFO: 655360 events read in total (52736ms).
[15:12:34.443] <TB0> INFO: Expecting 655360 events.
[15:13:27.606] <TB0> INFO: 655360 events read in total (52762ms).
[15:13:27.654] <TB0> INFO: Expecting 655360 events.
[15:14:20.802] <TB0> INFO: 655360 events read in total (52746ms).
[15:14:20.855] <TB0> INFO: Expecting 655360 events.
[15:15:13.935] <TB0> INFO: 655360 events read in total (52678ms).
[15:15:13.993] <TB0> INFO: Expecting 655360 events.
[15:16:07.225] <TB0> INFO: 655360 events read in total (52831ms).
[15:16:07.284] <TB0> INFO: Expecting 655360 events.
[15:17:00.270] <TB0> INFO: 655360 events read in total (52584ms).
[15:17:00.339] <TB0> INFO: Test took 850324ms.
[15:17:00.421] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:17:00.651] <TB0> INFO: Expecting 655360 events.
[15:17:53.867] <TB0> INFO: 655360 events read in total (52660ms).
[15:17:53.878] <TB0> INFO: Expecting 655360 events.
[15:18:46.911] <TB0> INFO: 655360 events read in total (52630ms).
[15:18:46.926] <TB0> INFO: Expecting 655360 events.
[15:19:39.969] <TB0> INFO: 655360 events read in total (52641ms).
[15:19:39.986] <TB0> INFO: Expecting 655360 events.
[15:20:32.911] <TB0> INFO: 655360 events read in total (52523ms).
[15:20:32.932] <TB0> INFO: Expecting 655360 events.
[15:21:26.037] <TB0> INFO: 655360 events read in total (52703ms).
[15:21:26.059] <TB0> INFO: Expecting 655360 events.
[15:22:18.458] <TB0> INFO: 655360 events read in total (51998ms).
[15:22:18.486] <TB0> INFO: Expecting 655360 events.
[15:23:11.282] <TB0> INFO: 655360 events read in total (52394ms).
[15:23:11.315] <TB0> INFO: Expecting 655360 events.
[15:24:04.252] <TB0> INFO: 655360 events read in total (52536ms).
[15:24:04.290] <TB0> INFO: Expecting 655360 events.
[15:24:57.394] <TB0> INFO: 655360 events read in total (52703ms).
[15:24:57.430] <TB0> INFO: Expecting 655360 events.
[15:25:50.361] <TB0> INFO: 655360 events read in total (52529ms).
[15:25:50.400] <TB0> INFO: Expecting 655360 events.
[15:26:43.738] <TB0> INFO: 655360 events read in total (52936ms).
[15:26:43.787] <TB0> INFO: Expecting 655360 events.
[15:27:36.919] <TB0> INFO: 655360 events read in total (52730ms).
[15:27:36.969] <TB0> INFO: Expecting 655360 events.
[15:28:30.579] <TB0> INFO: 655360 events read in total (53209ms).
[15:28:30.631] <TB0> INFO: Expecting 655360 events.
[15:29:23.844] <TB0> INFO: 655360 events read in total (52811ms).
[15:29:23.897] <TB0> INFO: Expecting 655360 events.
[15:30:17.448] <TB0> INFO: 655360 events read in total (53149ms).
[15:30:17.507] <TB0> INFO: Expecting 655360 events.
[15:31:11.091] <TB0> INFO: 655360 events read in total (53183ms).
[15:31:11.157] <TB0> INFO: Test took 850736ms.
[15:31:11.348] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.355] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:31:11.363] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[15:31:11.370] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.377] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.384] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:31:11.391] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.398] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.405] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.413] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.420] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:31:11.427] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.434] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.441] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.448] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:31:11.455] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[15:31:11.462] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[15:31:11.469] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[15:31:11.476] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.484] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:31:11.491] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[15:31:11.498] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.505] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.512] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.519] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.526] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:31:11.565] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C0.dat
[15:31:11.570] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C1.dat
[15:31:11.576] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C2.dat
[15:31:11.584] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C3.dat
[15:31:11.589] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C4.dat
[15:31:11.596] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C5.dat
[15:31:11.603] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C6.dat
[15:31:11.608] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C7.dat
[15:31:11.613] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C8.dat
[15:31:11.618] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C9.dat
[15:31:11.631] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C10.dat
[15:31:11.637] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C11.dat
[15:31:11.643] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C12.dat
[15:31:11.648] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C13.dat
[15:31:11.653] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C14.dat
[15:31:11.658] <TB0> INFO: write dac parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//dacParameters35_C15.dat
[15:31:11.931] <TB0> INFO: Expecting 41600 events.
[15:31:19.563] <TB0> INFO: 41600 events read in total (7075ms).
[15:31:19.564] <TB0> INFO: Test took 7900ms.
[15:31:20.007] <TB0> INFO: Expecting 41600 events.
[15:31:27.577] <TB0> INFO: 41600 events read in total (7014ms).
[15:31:27.578] <TB0> INFO: Test took 7832ms.
[15:31:28.031] <TB0> INFO: Expecting 41600 events.
[15:31:35.696] <TB0> INFO: 41600 events read in total (7108ms).
[15:31:35.697] <TB0> INFO: Test took 7941ms.
[15:31:35.881] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:35.969] <TB0> INFO: Expecting 2560 events.
[15:31:36.979] <TB0> INFO: 2560 events read in total (453ms).
[15:31:36.979] <TB0> INFO: Test took 1098ms.
[15:31:36.981] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:37.285] <TB0> INFO: Expecting 2560 events.
[15:31:38.290] <TB0> INFO: 2560 events read in total (449ms).
[15:31:38.291] <TB0> INFO: Test took 1310ms.
[15:31:38.293] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:38.597] <TB0> INFO: Expecting 2560 events.
[15:31:39.605] <TB0> INFO: 2560 events read in total (452ms).
[15:31:39.605] <TB0> INFO: Test took 1312ms.
[15:31:39.607] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:39.911] <TB0> INFO: Expecting 2560 events.
[15:31:40.919] <TB0> INFO: 2560 events read in total (452ms).
[15:31:40.920] <TB0> INFO: Test took 1313ms.
[15:31:40.922] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:41.226] <TB0> INFO: Expecting 2560 events.
[15:31:42.234] <TB0> INFO: 2560 events read in total (452ms).
[15:31:42.234] <TB0> INFO: Test took 1312ms.
[15:31:42.237] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:42.540] <TB0> INFO: Expecting 2560 events.
[15:31:43.550] <TB0> INFO: 2560 events read in total (453ms).
[15:31:43.550] <TB0> INFO: Test took 1313ms.
[15:31:43.553] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:43.856] <TB0> INFO: Expecting 2560 events.
[15:31:44.865] <TB0> INFO: 2560 events read in total (453ms).
[15:31:44.865] <TB0> INFO: Test took 1313ms.
[15:31:44.868] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:45.171] <TB0> INFO: Expecting 2560 events.
[15:31:46.179] <TB0> INFO: 2560 events read in total (452ms).
[15:31:46.179] <TB0> INFO: Test took 1311ms.
[15:31:46.181] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:46.486] <TB0> INFO: Expecting 2560 events.
[15:31:47.495] <TB0> INFO: 2560 events read in total (453ms).
[15:31:47.495] <TB0> INFO: Test took 1314ms.
[15:31:47.498] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:47.801] <TB0> INFO: Expecting 2560 events.
[15:31:48.806] <TB0> INFO: 2560 events read in total (449ms).
[15:31:48.807] <TB0> INFO: Test took 1310ms.
[15:31:48.809] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:49.113] <TB0> INFO: Expecting 2560 events.
[15:31:50.119] <TB0> INFO: 2560 events read in total (450ms).
[15:31:50.119] <TB0> INFO: Test took 1310ms.
[15:31:50.122] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:50.425] <TB0> INFO: Expecting 2560 events.
[15:31:51.433] <TB0> INFO: 2560 events read in total (451ms).
[15:31:51.434] <TB0> INFO: Test took 1312ms.
[15:31:51.437] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:51.739] <TB0> INFO: Expecting 2560 events.
[15:31:52.748] <TB0> INFO: 2560 events read in total (453ms).
[15:31:52.748] <TB0> INFO: Test took 1311ms.
[15:31:52.751] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:53.055] <TB0> INFO: Expecting 2560 events.
[15:31:54.065] <TB0> INFO: 2560 events read in total (454ms).
[15:31:54.065] <TB0> INFO: Test took 1314ms.
[15:31:54.068] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:54.371] <TB0> INFO: Expecting 2560 events.
[15:31:55.380] <TB0> INFO: 2560 events read in total (453ms).
[15:31:55.381] <TB0> INFO: Test took 1313ms.
[15:31:55.385] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:55.687] <TB0> INFO: Expecting 2560 events.
[15:31:56.696] <TB0> INFO: 2560 events read in total (453ms).
[15:31:56.697] <TB0> INFO: Test took 1312ms.
[15:31:56.699] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:57.003] <TB0> INFO: Expecting 2560 events.
[15:31:58.011] <TB0> INFO: 2560 events read in total (452ms).
[15:31:58.011] <TB0> INFO: Test took 1312ms.
[15:31:58.012] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:58.318] <TB0> INFO: Expecting 2560 events.
[15:31:59.326] <TB0> INFO: 2560 events read in total (452ms).
[15:31:59.327] <TB0> INFO: Test took 1315ms.
[15:31:59.329] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:31:59.633] <TB0> INFO: Expecting 2560 events.
[15:32:00.638] <TB0> INFO: 2560 events read in total (449ms).
[15:32:00.638] <TB0> INFO: Test took 1309ms.
[15:32:00.641] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:00.944] <TB0> INFO: Expecting 2560 events.
[15:32:01.952] <TB0> INFO: 2560 events read in total (452ms).
[15:32:01.952] <TB0> INFO: Test took 1311ms.
[15:32:01.955] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:02.259] <TB0> INFO: Expecting 2560 events.
[15:32:03.265] <TB0> INFO: 2560 events read in total (450ms).
[15:32:03.265] <TB0> INFO: Test took 1310ms.
[15:32:03.269] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:03.572] <TB0> INFO: Expecting 2560 events.
[15:32:04.581] <TB0> INFO: 2560 events read in total (453ms).
[15:32:04.581] <TB0> INFO: Test took 1313ms.
[15:32:04.584] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:04.887] <TB0> INFO: Expecting 2560 events.
[15:32:05.895] <TB0> INFO: 2560 events read in total (451ms).
[15:32:05.895] <TB0> INFO: Test took 1311ms.
[15:32:05.897] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:06.203] <TB0> INFO: Expecting 2560 events.
[15:32:07.208] <TB0> INFO: 2560 events read in total (449ms).
[15:32:07.208] <TB0> INFO: Test took 1311ms.
[15:32:07.210] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:07.514] <TB0> INFO: Expecting 2560 events.
[15:32:08.522] <TB0> INFO: 2560 events read in total (451ms).
[15:32:08.522] <TB0> INFO: Test took 1312ms.
[15:32:08.526] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:08.830] <TB0> INFO: Expecting 2560 events.
[15:32:09.837] <TB0> INFO: 2560 events read in total (451ms).
[15:32:09.837] <TB0> INFO: Test took 1312ms.
[15:32:09.839] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:10.143] <TB0> INFO: Expecting 2560 events.
[15:32:11.147] <TB0> INFO: 2560 events read in total (448ms).
[15:32:11.147] <TB0> INFO: Test took 1308ms.
[15:32:11.150] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:11.453] <TB0> INFO: Expecting 2560 events.
[15:32:12.463] <TB0> INFO: 2560 events read in total (453ms).
[15:32:12.463] <TB0> INFO: Test took 1313ms.
[15:32:12.466] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:12.769] <TB0> INFO: Expecting 2560 events.
[15:32:13.777] <TB0> INFO: 2560 events read in total (451ms).
[15:32:13.777] <TB0> INFO: Test took 1311ms.
[15:32:13.779] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:14.084] <TB0> INFO: Expecting 2560 events.
[15:32:15.092] <TB0> INFO: 2560 events read in total (452ms).
[15:32:15.092] <TB0> INFO: Test took 1313ms.
[15:32:15.094] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:15.398] <TB0> INFO: Expecting 2560 events.
[15:32:16.405] <TB0> INFO: 2560 events read in total (451ms).
[15:32:16.405] <TB0> INFO: Test took 1311ms.
[15:32:16.408] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:32:16.712] <TB0> INFO: Expecting 2560 events.
[15:32:17.714] <TB0> INFO: 2560 events read in total (446ms).
[15:32:17.715] <TB0> INFO: Test took 1307ms.
[15:32:18.175] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 1813 seconds
[15:32:18.175] <TB0> INFO: PH scale (per ROC): 80 83 80 85 84 81 80 85 79 95 77 76 80 78 80 81
[15:32:18.175] <TB0> INFO: PH offset (per ROC): 150 166 172 160 182 165 162 157 169 176 176 165 155 180 164 170
[15:32:18.180] <TB0> INFO: Decoding statistics:
[15:32:18.180] <TB0> INFO: General information:
[15:32:18.180] <TB0> INFO: 16bit words read: 91920
[15:32:18.180] <TB0> INFO: valid events total: 10240
[15:32:18.180] <TB0> INFO: empty events: 7740
[15:32:18.180] <TB0> INFO: valid events with pixels: 2500
[15:32:18.180] <TB0> INFO: valid pixel hits: 2500
[15:32:18.180] <TB0> INFO: Event errors: 0
[15:32:18.180] <TB0> INFO: start marker: 0
[15:32:18.180] <TB0> INFO: stop marker: 0
[15:32:18.180] <TB0> INFO: overflow: 0
[15:32:18.180] <TB0> INFO: invalid 5bit words: 0
[15:32:18.180] <TB0> INFO: invalid XOR eye diagram: 0
[15:32:18.180] <TB0> INFO: frame (failed synchr.): 0
[15:32:18.180] <TB0> INFO: idle data (no TBM trl): 0
[15:32:18.180] <TB0> INFO: no data (only TBM hdr): 0
[15:32:18.180] <TB0> INFO: TBM errors: 0
[15:32:18.180] <TB0> INFO: flawed TBM headers: 0
[15:32:18.180] <TB0> INFO: flawed TBM trailers: 0
[15:32:18.180] <TB0> INFO: event ID mismatches: 0
[15:32:18.180] <TB0> INFO: ROC errors: 0
[15:32:18.180] <TB0> INFO: missing ROC header(s): 0
[15:32:18.180] <TB0> INFO: misplaced readback start: 0
[15:32:18.180] <TB0> INFO: Pixel decoding errors: 0
[15:32:18.180] <TB0> INFO: pixel data incomplete: 0
[15:32:18.180] <TB0> INFO: pixel address: 0
[15:32:18.180] <TB0> INFO: pulse height fill bit: 0
[15:32:18.180] <TB0> INFO: buffer corruption: 0
[15:32:18.352] <TB0> INFO: ######################################################################
[15:32:18.352] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[15:32:18.352] <TB0> INFO: ######################################################################
[15:32:18.362] <TB0> INFO: scanning low vcal = 10
[15:32:18.697] <TB0> INFO: Expecting 41600 events.
[15:32:24.288] <TB0> INFO: 41600 events read in total (5035ms).
[15:32:24.289] <TB0> INFO: Test took 5927ms.
[15:32:24.290] <TB0> INFO: scanning low vcal = 20
[15:32:24.593] <TB0> INFO: Expecting 41600 events.
[15:32:30.172] <TB0> INFO: 41600 events read in total (5023ms).
[15:32:30.173] <TB0> INFO: Test took 5883ms.
[15:32:30.175] <TB0> INFO: scanning low vcal = 30
[15:32:30.478] <TB0> INFO: Expecting 41600 events.
[15:32:36.217] <TB0> INFO: 41600 events read in total (5182ms).
[15:32:36.218] <TB0> INFO: Test took 6043ms.
[15:32:36.220] <TB0> INFO: scanning low vcal = 40
[15:32:36.517] <TB0> INFO: Expecting 41600 events.
[15:32:44.765] <TB0> INFO: 41600 events read in total (7692ms).
[15:32:44.766] <TB0> INFO: Test took 8546ms.
[15:32:44.769] <TB0> INFO: scanning low vcal = 50
[15:32:45.029] <TB0> INFO: Expecting 41600 events.
[15:32:53.403] <TB0> INFO: 41600 events read in total (7817ms).
[15:32:53.404] <TB0> INFO: Test took 8635ms.
[15:32:53.406] <TB0> INFO: scanning low vcal = 60
[15:32:53.671] <TB0> INFO: Expecting 41600 events.
[15:33:02.059] <TB0> INFO: 41600 events read in total (7831ms).
[15:33:02.060] <TB0> INFO: Test took 8654ms.
[15:33:02.063] <TB0> INFO: scanning low vcal = 70
[15:33:02.328] <TB0> INFO: Expecting 41600 events.
[15:33:10.705] <TB0> INFO: 41600 events read in total (7821ms).
[15:33:10.706] <TB0> INFO: Test took 8643ms.
[15:33:10.709] <TB0> INFO: scanning low vcal = 80
[15:33:10.995] <TB0> INFO: Expecting 41600 events.
[15:33:19.352] <TB0> INFO: 41600 events read in total (7801ms).
[15:33:19.353] <TB0> INFO: Test took 8644ms.
[15:33:19.355] <TB0> INFO: scanning low vcal = 90
[15:33:19.621] <TB0> INFO: Expecting 41600 events.
[15:33:27.992] <TB0> INFO: 41600 events read in total (7815ms).
[15:33:27.993] <TB0> INFO: Test took 8637ms.
[15:33:27.996] <TB0> INFO: scanning low vcal = 100
[15:33:28.260] <TB0> INFO: Expecting 41600 events.
[15:33:36.624] <TB0> INFO: 41600 events read in total (7808ms).
[15:33:36.625] <TB0> INFO: Test took 8629ms.
[15:33:36.627] <TB0> INFO: scanning low vcal = 110
[15:33:36.893] <TB0> INFO: Expecting 41600 events.
[15:33:45.262] <TB0> INFO: 41600 events read in total (7813ms).
[15:33:45.263] <TB0> INFO: Test took 8636ms.
[15:33:45.266] <TB0> INFO: scanning low vcal = 120
[15:33:45.531] <TB0> INFO: Expecting 41600 events.
[15:33:53.895] <TB0> INFO: 41600 events read in total (7807ms).
[15:33:53.896] <TB0> INFO: Test took 8630ms.
[15:33:53.899] <TB0> INFO: scanning low vcal = 130
[15:33:54.170] <TB0> INFO: Expecting 41600 events.
[15:34:02.551] <TB0> INFO: 41600 events read in total (7825ms).
[15:34:02.552] <TB0> INFO: Test took 8653ms.
[15:34:02.555] <TB0> INFO: scanning low vcal = 140
[15:34:02.823] <TB0> INFO: Expecting 41600 events.
[15:34:11.170] <TB0> INFO: 41600 events read in total (7790ms).
[15:34:11.170] <TB0> INFO: Test took 8615ms.
[15:34:11.173] <TB0> INFO: scanning low vcal = 150
[15:34:11.443] <TB0> INFO: Expecting 41600 events.
[15:34:19.822] <TB0> INFO: 41600 events read in total (7823ms).
[15:34:19.824] <TB0> INFO: Test took 8651ms.
[15:34:19.827] <TB0> INFO: scanning low vcal = 160
[15:34:20.119] <TB0> INFO: Expecting 41600 events.
[15:34:28.488] <TB0> INFO: 41600 events read in total (7813ms).
[15:34:28.489] <TB0> INFO: Test took 8662ms.
[15:34:28.491] <TB0> INFO: scanning low vcal = 170
[15:34:28.760] <TB0> INFO: Expecting 41600 events.
[15:34:37.145] <TB0> INFO: 41600 events read in total (7829ms).
[15:34:37.145] <TB0> INFO: Test took 8654ms.
[15:34:37.149] <TB0> INFO: scanning low vcal = 180
[15:34:37.414] <TB0> INFO: Expecting 41600 events.
[15:34:45.791] <TB0> INFO: 41600 events read in total (7821ms).
[15:34:45.792] <TB0> INFO: Test took 8643ms.
[15:34:45.795] <TB0> INFO: scanning low vcal = 190
[15:34:46.079] <TB0> INFO: Expecting 41600 events.
[15:34:54.436] <TB0> INFO: 41600 events read in total (7801ms).
[15:34:54.438] <TB0> INFO: Test took 8642ms.
[15:34:54.440] <TB0> INFO: scanning low vcal = 200
[15:34:54.705] <TB0> INFO: Expecting 41600 events.
[15:35:03.076] <TB0> INFO: 41600 events read in total (7815ms).
[15:35:03.078] <TB0> INFO: Test took 8638ms.
[15:35:03.080] <TB0> INFO: scanning low vcal = 210
[15:35:03.352] <TB0> INFO: Expecting 41600 events.
[15:35:11.723] <TB0> INFO: 41600 events read in total (7814ms).
[15:35:11.724] <TB0> INFO: Test took 8644ms.
[15:35:11.726] <TB0> INFO: scanning low vcal = 220
[15:35:11.996] <TB0> INFO: Expecting 41600 events.
[15:35:20.387] <TB0> INFO: 41600 events read in total (7835ms).
[15:35:20.388] <TB0> INFO: Test took 8662ms.
[15:35:20.391] <TB0> INFO: scanning low vcal = 230
[15:35:20.657] <TB0> INFO: Expecting 41600 events.
[15:35:29.024] <TB0> INFO: 41600 events read in total (7811ms).
[15:35:29.026] <TB0> INFO: Test took 8635ms.
[15:35:29.029] <TB0> INFO: scanning low vcal = 240
[15:35:29.294] <TB0> INFO: Expecting 41600 events.
[15:35:37.668] <TB0> INFO: 41600 events read in total (7818ms).
[15:35:37.669] <TB0> INFO: Test took 8640ms.
[15:35:37.672] <TB0> INFO: scanning low vcal = 250
[15:35:37.962] <TB0> INFO: Expecting 41600 events.
[15:35:46.359] <TB0> INFO: 41600 events read in total (7841ms).
[15:35:46.361] <TB0> INFO: Test took 8689ms.
[15:35:46.365] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[15:35:46.625] <TB0> INFO: Expecting 41600 events.
[15:35:54.999] <TB0> INFO: 41600 events read in total (7817ms).
[15:35:55.000] <TB0> INFO: Test took 8635ms.
[15:35:55.003] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[15:35:55.268] <TB0> INFO: Expecting 41600 events.
[15:36:03.619] <TB0> INFO: 41600 events read in total (7795ms).
[15:36:03.620] <TB0> INFO: Test took 8616ms.
[15:36:03.624] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[15:36:03.887] <TB0> INFO: Expecting 41600 events.
[15:36:12.251] <TB0> INFO: 41600 events read in total (7808ms).
[15:36:12.252] <TB0> INFO: Test took 8628ms.
[15:36:12.255] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[15:36:12.523] <TB0> INFO: Expecting 41600 events.
[15:36:20.890] <TB0> INFO: 41600 events read in total (7811ms).
[15:36:20.891] <TB0> INFO: Test took 8636ms.
[15:36:20.894] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[15:36:21.168] <TB0> INFO: Expecting 41600 events.
[15:36:29.514] <TB0> INFO: 41600 events read in total (7790ms).
[15:36:29.516] <TB0> INFO: Test took 8622ms.
[15:36:30.553] <TB0> INFO: PixTestGainPedestal::measure() done
[15:37:04.130] <TB0> INFO: PixTestGainPedestal::fit() done
[15:37:04.130] <TB0> INFO: non-linearity mean: 0.955 0.958 0.954 0.954 0.958 0.964 0.956 0.958 0.957 0.962 0.958 0.960 0.949 0.958 0.950 0.960
[15:37:04.131] <TB0> INFO: non-linearity RMS: 0.005 0.006 0.006 0.005 0.007 0.006 0.006 0.005 0.006 0.004 0.006 0.005 0.006 0.006 0.006 0.006
[15:37:04.131] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[15:37:04.171] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[15:37:04.211] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[15:37:04.253] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[15:37:04.290] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[15:37:04.328] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[15:37:04.370] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[15:37:04.408] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[15:37:04.446] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[15:37:04.484] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[15:37:04.523] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[15:37:04.559] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[15:37:04.595] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[15:37:04.633] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[15:37:04.675] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[15:37:04.719] <TB0> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[15:37:04.758] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 286 seconds
[15:37:04.759] <TB0> INFO: Decoding statistics:
[15:37:04.759] <TB0> INFO: General information:
[15:37:04.759] <TB0> INFO: 16bit words read: 2662400
[15:37:04.759] <TB0> INFO: valid events total: 166400
[15:37:04.759] <TB0> INFO: empty events: 0
[15:37:04.759] <TB0> INFO: valid events with pixels: 166400
[15:37:04.759] <TB0> INFO: valid pixel hits: 665590
[15:37:04.759] <TB0> INFO: Event errors: 0
[15:37:04.759] <TB0> INFO: start marker: 0
[15:37:04.759] <TB0> INFO: stop marker: 0
[15:37:04.759] <TB0> INFO: overflow: 0
[15:37:04.759] <TB0> INFO: invalid 5bit words: 0
[15:37:04.759] <TB0> INFO: invalid XOR eye diagram: 0
[15:37:04.759] <TB0> INFO: frame (failed synchr.): 0
[15:37:04.759] <TB0> INFO: idle data (no TBM trl): 0
[15:37:04.759] <TB0> INFO: no data (only TBM hdr): 0
[15:37:04.759] <TB0> INFO: TBM errors: 0
[15:37:04.759] <TB0> INFO: flawed TBM headers: 0
[15:37:04.759] <TB0> INFO: flawed TBM trailers: 0
[15:37:04.759] <TB0> INFO: event ID mismatches: 0
[15:37:04.759] <TB0> INFO: ROC errors: 0
[15:37:04.759] <TB0> INFO: missing ROC header(s): 0
[15:37:04.759] <TB0> INFO: misplaced readback start: 0
[15:37:04.759] <TB0> INFO: Pixel decoding errors: 0
[15:37:04.759] <TB0> INFO: pixel data incomplete: 0
[15:37:04.759] <TB0> INFO: pixel address: 0
[15:37:04.759] <TB0> INFO: pulse height fill bit: 0
[15:37:04.759] <TB0> INFO: buffer corruption: 0
[15:37:04.766] <TB0> INFO: readReadbackCal: /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C0.dat .. /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C15.dat
[15:37:04.782] <TB0> INFO: ######################################################################
[15:37:04.782] <TB0> INFO: PixTestReadback::doTest()
[15:37:04.782] <TB0> INFO: ######################################################################
[15:37:04.782] <TB0> INFO: ----------------------------------------------------------------------
[15:37:04.782] <TB0> INFO: PixTestReadback::CalibrateVd()
[15:37:04.782] <TB0> INFO: ----------------------------------------------------------------------
[15:37:14.307] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C0.dat
[15:37:14.313] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C1.dat
[15:37:14.320] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C2.dat
[15:37:14.325] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C3.dat
[15:37:14.330] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C4.dat
[15:37:14.335] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C5.dat
[15:37:14.340] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C6.dat
[15:37:14.345] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C7.dat
[15:37:14.352] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C8.dat
[15:37:14.357] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C9.dat
[15:37:14.362] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C10.dat
[15:37:14.367] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C11.dat
[15:37:14.372] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C12.dat
[15:37:14.378] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C13.dat
[15:37:14.383] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C14.dat
[15:37:14.388] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C15.dat
[15:37:14.425] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:37:14.425] <TB0> INFO: ----------------------------------------------------------------------
[15:37:14.426] <TB0> INFO: PixTestReadback::CalibrateVa()
[15:37:14.426] <TB0> INFO: ----------------------------------------------------------------------
[15:37:24.313] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C0.dat
[15:37:24.372] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C1.dat
[15:37:24.439] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C2.dat
[15:37:24.522] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C3.dat
[15:37:24.590] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C4.dat
[15:37:24.656] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C5.dat
[15:37:24.732] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C6.dat
[15:37:24.802] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C7.dat
[15:37:24.807] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C8.dat
[15:37:24.813] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C9.dat
[15:37:24.821] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C10.dat
[15:37:24.826] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C11.dat
[15:37:24.831] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C12.dat
[15:37:24.856] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C13.dat
[15:37:24.861] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C14.dat
[15:37:24.867] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C15.dat
[15:37:24.905] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:37:24.905] <TB0> INFO: ----------------------------------------------------------------------
[15:37:24.905] <TB0> INFO: PixTestReadback::readbackVbg()
[15:37:24.905] <TB0> INFO: ----------------------------------------------------------------------
[15:37:32.193] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:37:32.194] <TB0> INFO: ----------------------------------------------------------------------
[15:37:32.194] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[15:37:32.194] <TB0> INFO: ----------------------------------------------------------------------
[15:37:32.194] <TB0> INFO: Vbg will be calibrated using Vd calibration
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 158.2calibrated Vbg = 1.20012 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 152.8calibrated Vbg = 1.19619 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 156calibrated Vbg = 1.20128 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 153.3calibrated Vbg = 1.20434 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 158.8calibrated Vbg = 1.20927 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 154.7calibrated Vbg = 1.21879 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 160.4calibrated Vbg = 1.21498 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 151.4calibrated Vbg = 1.21376 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 145.8calibrated Vbg = 1.21157 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 154.4calibrated Vbg = 1.2084 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 151.3calibrated Vbg = 1.20893 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 151.6calibrated Vbg = 1.20622 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 155calibrated Vbg = 1.20041 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 152.8calibrated Vbg = 1.20002 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 149.5calibrated Vbg = 1.20171 :::*/*/*/*/
[15:37:32.194] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 147.2calibrated Vbg = 1.20015 :::*/*/*/*/
[15:37:32.197] <TB0> INFO: ----------------------------------------------------------------------
[15:37:32.197] <TB0> INFO: PixTestReadback::CalibrateIa()
[15:37:32.197] <TB0> INFO: ----------------------------------------------------------------------
[15:40:07.544] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C0.dat
[15:40:07.549] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C1.dat
[15:40:07.555] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C2.dat
[15:40:07.560] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C3.dat
[15:40:07.565] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C4.dat
[15:40:07.570] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C5.dat
[15:40:07.576] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C6.dat
[15:40:07.581] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C7.dat
[15:40:07.586] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C8.dat
[15:40:07.591] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C9.dat
[15:40:07.597] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C10.dat
[15:40:07.602] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C11.dat
[15:40:07.610] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C12.dat
[15:40:07.616] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C13.dat
[15:40:07.621] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C14.dat
[15:40:07.626] <TB0> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2184_FullQualification_2016-03-22_13h14m_1458648895//000_FulltestPxar_m20//readbackCal_C15.dat
[15:40:07.663] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:40:07.667] <TB0> INFO: PixTestReadback::doTest() done
[15:40:07.667] <TB0> INFO: Decoding statistics:
[15:40:07.667] <TB0> INFO: General information:
[15:40:07.667] <TB0> INFO: 16bit words read: 1024
[15:40:07.667] <TB0> INFO: valid events total: 128
[15:40:07.667] <TB0> INFO: empty events: 128
[15:40:07.667] <TB0> INFO: valid events with pixels: 0
[15:40:07.667] <TB0> INFO: valid pixel hits: 0
[15:40:07.667] <TB0> INFO: Event errors: 0
[15:40:07.667] <TB0> INFO: start marker: 0
[15:40:07.667] <TB0> INFO: stop marker: 0
[15:40:07.667] <TB0> INFO: overflow: 0
[15:40:07.667] <TB0> INFO: invalid 5bit words: 0
[15:40:07.667] <TB0> INFO: invalid XOR eye diagram: 0
[15:40:07.667] <TB0> INFO: frame (failed synchr.): 0
[15:40:07.667] <TB0> INFO: idle data (no TBM trl): 0
[15:40:07.667] <TB0> INFO: no data (only TBM hdr): 0
[15:40:07.667] <TB0> INFO: TBM errors: 0
[15:40:07.667] <TB0> INFO: flawed TBM headers: 0
[15:40:07.667] <TB0> INFO: flawed TBM trailers: 0
[15:40:07.668] <TB0> INFO: event ID mismatches: 0
[15:40:07.668] <TB0> INFO: ROC errors: 0
[15:40:07.668] <TB0> INFO: missing ROC header(s): 0
[15:40:07.668] <TB0> INFO: misplaced readback start: 0
[15:40:07.668] <TB0> INFO: Pixel decoding errors: 0
[15:40:07.668] <TB0> INFO: pixel data incomplete: 0
[15:40:07.668] <TB0> INFO: pixel address: 0
[15:40:07.668] <TB0> INFO: pulse height fill bit: 0
[15:40:07.668] <TB0> INFO: buffer corruption: 0
[15:40:07.695] <TB0> INFO: Decoding statistics:
[15:40:07.695] <TB0> INFO: General information:
[15:40:07.695] <TB0> INFO: 16bit words read: 2755344
[15:40:07.695] <TB0> INFO: valid events total: 176768
[15:40:07.695] <TB0> INFO: empty events: 7868
[15:40:07.695] <TB0> INFO: valid events with pixels: 168900
[15:40:07.695] <TB0> INFO: valid pixel hits: 668090
[15:40:07.695] <TB0> INFO: Event errors: 0
[15:40:07.695] <TB0> INFO: start marker: 0
[15:40:07.695] <TB0> INFO: stop marker: 0
[15:40:07.695] <TB0> INFO: overflow: 0
[15:40:07.695] <TB0> INFO: invalid 5bit words: 0
[15:40:07.695] <TB0> INFO: invalid XOR eye diagram: 0
[15:40:07.695] <TB0> INFO: frame (failed synchr.): 0
[15:40:07.695] <TB0> INFO: idle data (no TBM trl): 0
[15:40:07.695] <TB0> INFO: no data (only TBM hdr): 0
[15:40:07.695] <TB0> INFO: TBM errors: 0
[15:40:07.695] <TB0> INFO: flawed TBM headers: 0
[15:40:07.695] <TB0> INFO: flawed TBM trailers: 0
[15:40:07.695] <TB0> INFO: event ID mismatches: 0
[15:40:07.695] <TB0> INFO: ROC errors: 0
[15:40:07.695] <TB0> INFO: missing ROC header(s): 0
[15:40:07.695] <TB0> INFO: misplaced readback start: 0
[15:40:07.695] <TB0> INFO: Pixel decoding errors: 0
[15:40:07.695] <TB0> INFO: pixel data incomplete: 0
[15:40:07.695] <TB0> INFO: pixel address: 0
[15:40:07.695] <TB0> INFO: pulse height fill bit: 0
[15:40:07.695] <TB0> INFO: buffer corruption: 0
[15:40:07.695] <TB0> INFO: enter test to run
[15:40:07.695] <TB0> INFO: test: exit no parameter change
[15:40:07.752] <TB0> QUIET: Connection to board 71 closed.
[15:40:07.832] <TB0> INFO: pXar: this is the end, my friend