MORE-Web

Test Date: 2015-09-21 09:54
Analysis date: 2015-11-24 02:15
Logfile
LogfileView
[14:02:31.047] <TB1>     INFO: *** Welcome to pxar ***

[14:02:31.047] <TB1>     INFO: *** Today: 2015/09/21

[14:02:31.118] <TB1>     INFO: *** Version: bccb-dirty

[14:02:31.118] <TB1>     INFO: readRocDacs: /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//dacParameters_C15.dat

[14:02:31.119] <TB1>     INFO: readTbmDacs: /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//tbmParameters_C0b.dat

[14:02:31.120] <TB1>     INFO: readMaskFile: /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//defaultMaskFile.dat

[14:02:31.120] <TB1>     INFO: readTrimFile: /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2103_FullQualification_2015-09-21_09h54m_1442822099//004_FulltestPxar_p17//trimParameters_C15.dat

[14:02:31.197] <TB1>     INFO:         clk: 4

[14:02:31.197] <TB1>     INFO:         ctr: 4

[14:02:31.197] <TB1>     INFO:         sda: 19

[14:02:31.197] <TB1>     INFO:         tin: 9

[14:02:31.197] <TB1>     INFO:         level: 15

[14:02:31.197] <TB1>     INFO:         triggerdelay: 0

[14:02:31.197] <TB1>    QUIET: Instanciating API for pxar prod-11

[14:02:31.197] <TB1>     INFO: Log level: INFO

[14:02:31.204] <TB1>     INFO: Found DTB DTB_WXBYFL

[14:02:31.218] <TB1>    QUIET: Connection to board DTB_WXBYFL opened.

[14:02:31.221] <TB1>     INFO: DTB startup information

--- DTB info------------------------------------------

Board id:    153

HW version:  DTB1.2

FW version:  4.2

SW version:  4.4

USB id:      DTB_WXBYFL

MAC address: 40D855118099

Hostname:    pixelDTB153

Comment:     

------------------------------------------------------

[14:02:31.224] <TB1>     INFO: RPC call hashes of host and DTB match: 397073690

[14:02:32.743] <TB1>     INFO: DUT info: 

[14:02:32.743] <TB1>     INFO: The DUT currently contains the following objects:

[14:02:32.743] <TB1>     INFO:  2 TBM Cores tbm09c (2 ON)

[14:02:32.743] <TB1>     INFO: 	TBM Core alpha (0): 7 registers set

[14:02:32.743] <TB1>     INFO: 	TBM Core beta  (1): 7 registers set

[14:02:32.743] <TB1>     INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs

[14:02:32.743] <TB1>     INFO: 	ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.743] <TB1>     INFO: 	ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:32.744] <TB1>     INFO: 	ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.

[14:02:33.145] <TB1>     INFO: enter 'restricted' command line mode

[14:02:33.145] <TB1>     INFO: enter test to run

[14:02:33.145] <TB1>     INFO:   test: pretest no parameter change

[14:02:33.145] <TB1>     INFO:   running: pretest

[14:02:33.152] <TB1>     INFO: ######################################################################

[14:02:33.152] <TB1>     INFO: PixTestPretest::doTest()

[14:02:33.152] <TB1>     INFO: ######################################################################

[14:02:33.154] <TB1>     INFO:    ----------------------------------------------------------------------

[14:02:33.154] <TB1>     INFO:    PixTestPretest::programROC() 

[14:02:33.154] <TB1>     INFO:    ----------------------------------------------------------------------

[14:02:51.176] <TB1>     INFO: PixTestPretest::programROC() done: ROCs 0 1 2 3 4 5 6 7 8 9 10 11 12 13 14 15 cannot be programmed! Error!

[14:02:51.176] <TB1>     INFO: IA differences per ROC:  0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.0 0.8 0.0 0.0 0.0 0.0 0.0 0.0

[14:02:51.264] <TB1>     INFO: ######################################################################

[14:02:51.264] <TB1>     INFO: ERROR: some ROCs are not programmable; stop

[14:02:51.264] <TB1>     INFO: ######################################################################

[14:02:51.290] <TB1>     INFO: enter test to run

[14:02:51.290] <TB1>     INFO:   test: fulltest no parameter change

[14:02:51.290] <TB1>     INFO:   running: fulltest

[14:02:51.290] <TB1>     INFO: ######################################################################

[14:02:51.290] <TB1>     INFO: PixTestFullTest::doTest()

[14:02:51.290] <TB1>     INFO: ######################################################################

[14:02:51.292] <TB1>     INFO: ######################################################################

[14:02:51.292] <TB1>     INFO: PixTestAlive::doTest()

[14:02:51.292] <TB1>     INFO: ######################################################################

[14:02:51.294] <TB1>     INFO:    ----------------------------------------------------------------------

[14:02:51.294] <TB1>     INFO:    PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[14:02:51.294] <TB1>     INFO:    ----------------------------------------------------------------------

[14:02:51.634] <TB1>     INFO: Expecting 41600 events.

[14:02:55.095] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:02:55.423] <TB1>     INFO: Expecting 41600 events.

[14:02:58.784] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:02:59.124] <TB1>     INFO: Expecting 41600 events.

[14:03:02.485] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:02.804] <TB1>     INFO: Expecting 41600 events.

[14:03:06.165] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:06.480] <TB1>     INFO: Expecting 41600 events.

[14:03:09.841] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:10.154] <TB1>     INFO: Expecting 41600 events.

[14:03:13.515] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:13.678] <TB1>     INFO: PixTestAlive::aliveTest() done with 666667 decoding errors

[14:03:13.678] <TB1>     INFO: number of dead pixels (per ROC):  4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160 4160

[14:03:13.680] <TB1>     INFO:    ----------------------------------------------------------------------

[14:03:13.680] <TB1>     INFO:    PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[14:03:13.680] <TB1>     INFO:    ----------------------------------------------------------------------

[14:03:13.997] <TB1>     INFO: Expecting 41600 events.

[14:03:16.639] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:16.951] <TB1>     INFO: Expecting 41600 events.

[14:03:19.595] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:19.930] <TB1>     INFO: Expecting 41600 events.

[14:03:22.572] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:22.885] <TB1>     INFO: Expecting 41600 events.

[14:03:25.527] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:25.847] <TB1>     INFO: Expecting 41600 events.

[14:03:28.489] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:28.814] <TB1>     INFO: Expecting 41600 events.

[14:03:31.456] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:31.457] <TB1>     INFO: mask vs. old pixelAlive PixelAlive_C0_V0 ..  PixelAlive_C15_V0

[14:03:31.599] <TB1>     INFO: PixTestAlive::maskTest() done with 666667 decoding errors

[14:03:31.599] <TB1>     INFO: number of mask-defect pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[14:03:31.601] <TB1>     INFO:    ----------------------------------------------------------------------

[14:03:31.601] <TB1>     INFO:    PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)

[14:03:31.601] <TB1>     INFO:    ----------------------------------------------------------------------

[14:03:31.918] <TB1>     INFO: Expecting 41600 events.

[14:03:35.278] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:35.590] <TB1>     INFO: Expecting 41600 events.

[14:03:38.951] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:39.258] <TB1>     INFO: Expecting 41600 events.

[14:03:42.618] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:42.927] <TB1>     INFO: Expecting 41600 events.

[14:03:46.287] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:46.595] <TB1>     INFO: Expecting 41600 events.

[14:03:49.956] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:50.280] <TB1>     INFO: Expecting 41600 events.

[14:03:53.641] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L779> Incomplete DAQ data readout! Missing 4160 Events.

[14:03:53.781] <TB1>     INFO: PixTestAlive::addressDecodingTest() done with 666667 decoding errors

[14:03:53.781] <TB1>     INFO: number of address-decoding pixels (per ROC):     0    0    0    0    0    0    0    0    0    0    0    0    0    0    0    0

[14:03:53.782] <TB1>     INFO: PixTestAlive::doTest() done, duration: 62 seconds

[14:03:53.782] <TB1>     INFO: Fetched DAQ statistics. Counters are being reset now.

[14:03:53.782] <TB1>     INFO: Decoding statistics:

[14:03:53.782] <TB1>     INFO:   General information:

[14:03:53.782] <TB1>     INFO: 	 16bit words read:         0

[14:03:53.782] <TB1>     INFO: 	 valid events total:       0

[14:03:53.782] <TB1>     INFO: 	 empty events:             0

[14:03:53.782] <TB1>     INFO: 	 valid events with pixels: 0

[14:03:53.782] <TB1>     INFO: 	 valid pixel hits:         0

[14:03:53.782] <TB1>     INFO:   Event errors: 	           0

[14:03:53.782] <TB1>     INFO: 	 start marker:             0

[14:03:53.782] <TB1>     INFO: 	 stop marker:              0

[14:03:53.782] <TB1>     INFO: 	 overflow:                 0

[14:03:53.782] <TB1>     INFO: 	 invalid 5bit words:       0

[14:03:53.782] <TB1>     INFO: 	 invalid XOR eye diagram:  0

[14:03:53.782] <TB1>     INFO:   TBM errors: 		           0

[14:03:53.782] <TB1>     INFO: 	 flawed TBM headers:       0

[14:03:53.782] <TB1>     INFO: 	 flawed TBM trailers:      0

[14:03:53.782] <TB1>     INFO: 	 event ID mismatches:      0

[14:03:53.782] <TB1>     INFO:   ROC errors: 		           0

[14:03:53.782] <TB1>     INFO: 	 missing ROC header(s):    0

[14:03:53.782] <TB1>     INFO: 	 misplaced readback start: 0

[14:03:53.782] <TB1>     INFO:   Pixel decoding errors:	   0

[14:03:53.782] <TB1>     INFO: 	 pixel data incomplete:    0

[14:03:53.782] <TB1>     INFO: 	 pixel address:            0

[14:03:53.782] <TB1>     INFO: 	 pulse height fill bit:    0

[14:03:53.782] <TB1>     INFO: 	 buffer corruption:        0

[14:03:53.793] <TB1>     INFO: ######################################################################

[14:03:53.793] <TB1>     INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)

[14:03:53.793] <TB1>     INFO: ######################################################################

[14:03:53.797] <TB1>     INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)

[14:03:53.809] <TB1>     INFO:   dacScan split into 1 runs with ntrig = 5

[14:03:53.809] <TB1>     INFO:     run 1 of 1

[14:03:54.111] <TB1>     INFO: Expecting 3120000 events.

[14:04:59.254] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:04:59.564] <TB1>     INFO: Expecting 3120000 events.

[14:06:04.706] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:06:05.022] <TB1>     INFO: Expecting 3120000 events.

[14:07:10.163] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:07:10.473] <TB1>     INFO: Expecting 3120000 events.

[14:08:15.614] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:08:15.949] <TB1>     INFO: Expecting 3120000 events.

[14:09:21.090] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:09:21.436] <TB1>     INFO: Expecting 3120000 events.

[14:10:26.577] <TB1> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L954> Incomplete DAQ data readout! Missing 624000 Events.

[14:10:26.706] <TB1>     INFO: PixTestBBMap::doTest() done with 666667 decoding errors: , duration: 392 seconds

[14:10:26.706] <TB1>     INFO: number of dead bumps (per ROC): 

[14:10:26.706] <TB1>     INFO: separation cut       (per ROC): 

[14:10:26.706] <TB1>     INFO: Fetched DAQ statistics. Counters are being reset now.

[14:10:26.706] <TB1>     INFO: Decoding statistics:

[14:10:26.706] <TB1>     INFO:   General information:

[14:10:26.706] <TB1>     INFO: 	 16bit words read:         0

[14:10:26.706] <TB1>     INFO: 	 valid events total:       0

[14:10:26.706] <TB1>     INFO: 	 empty events:             0

[14:10:26.706] <TB1>     INFO: 	 valid events with pixels: 0

[14:10:26.706] <TB1>     INFO: 	 valid pixel hits:         0

[14:10:26.706] <TB1>     INFO:   Event errors: 	           0

[14:10:26.706] <TB1>     INFO: 	 start marker:             0

[14:10:26.706] <TB1>     INFO: 	 stop marker:              0

[14:10:26.706] <TB1>     INFO: 	 overflow:                 0

[14:10:26.706] <TB1>     INFO: 	 invalid 5bit words:       0

[14:10:26.706] <TB1>     INFO: 	 invalid XOR eye diagram:  0

[14:10:26.706] <TB1>     INFO:   TBM errors: 		           0

[14:10:26.706] <TB1>     INFO: 	 flawed TBM headers:       0

[14:10:26.706] <TB1>     INFO: 	 flawed TBM trailers:      0

[14:10:26.706] <TB1>     INFO: 	 event ID mismatches:      0

[14:10:26.706] <TB1>     INFO:   ROC errors: 		           0

[14:10:26.706] <TB1>     INFO: 	 missing ROC header(s):    0

[14:10:26.706] <TB1>     INFO: 	 misplaced readback start: 0

[14:10:26.706] <TB1>     INFO:   Pixel decoding errors:	   0

[14:10:26.706] <TB1>     INFO: 	 pixel data incomplete:    0

[14:10:26.706] <TB1>     INFO: 	 pixel address:            0

[14:10:26.706] <TB1>     INFO: 	 pulse height fill bit:    0

[14:10:26.706] <TB1>     INFO: 	 buffer corruption:        0

[14:10:26.708] <TB1>     INFO: ######################################################################

[14:10:26.708] <TB1>     INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1

[14:10:26.708] <TB1>     INFO: ######################################################################

[14:10:26.708] <TB1>     INFO:    ----------------------------------------------------------------------

[14:10:26.708] <TB1>     INFO:    PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1

[14:10:26.708] <TB1>     INFO:    ----------------------------------------------------------------------

[14:10:26.709] <TB1>     INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)

[14:10:26.720] <TB1>     INFO:   dacScan split into 1 runs with ntrig = 50

[14:10:26.720] <TB1>     INFO:     run 1 of 1

[14:10:27.061] <TB1>     INFO: Expecting 26208000 events.

[14:12:57.778] <TB1> CRITICAL: <USBInterface.libftd2xx.cc/FillBuffer:L266> Requested to read 1b, but read 0b - 1b missing!
MoReWeb-v0.6.7-71-g98621ee on branch dev-v0.7.0