[07:33:31.349] <TB1> INFO: *** Welcome to pxar ***
[07:33:31.349] <TB1> INFO: *** Today: 2016/04/20
[07:33:31.416] <TB1> INFO: *** Version: 9751
[07:33:31.416] <TB1> INFO: readRocDacs: /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//dacParameters35_C15.dat
[07:33:31.417] <TB1> INFO: readTbmDacs: /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//tbmParameters_C0b.dat
[07:33:31.417] <TB1> INFO: readMaskFile: /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//defaultMaskFile.dat
[07:33:31.417] <TB1> INFO: readTrimFile: /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2210_XrayQualification_2016-04-20_09h33m_1461137580//000_PixelAlive_p17//trimParameters35_C15.dat
[07:33:31.486] <TB1> INFO: clk: 4
[07:33:31.486] <TB1> INFO: ctr: 4
[07:33:31.486] <TB1> INFO: sda: 19
[07:33:31.486] <TB1> INFO: tin: 9
[07:33:31.486] <TB1> INFO: level: 15
[07:33:31.486] <TB1> INFO: triggerdelay: 0
[07:33:31.486] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[07:33:31.486] <TB1> INFO: Log level: INFO
[07:33:31.499] <TB1> INFO: Found DTB DTB_WWXTQT
[07:33:31.509] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[07:33:31.511] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[07:33:31.513] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[07:33:33.049] <TB1> INFO: DUT info:
[07:33:33.049] <TB1> INFO: The DUT currently contains the following objects:
[07:33:33.049] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:33:33.049] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:33:33.049] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:33:33.049] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:33:33.049] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.049] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:33.450] <TB1> INFO: enter 'restricted' command line mode
[07:33:33.450] <TB1> INFO: enter test to run
[07:33:33.450] <TB1> INFO: test: PixelAlive no parameter change
[07:33:33.450] <TB1> INFO: running: pixelalive
[07:33:33.455] <TB1> INFO: ######################################################################
[07:33:33.455] <TB1> INFO: PixTestAlive::doTest()
[07:33:33.455] <TB1> INFO: ######################################################################
[07:33:33.456] <TB1> INFO: ----------------------------------------------------------------------
[07:33:33.456] <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)
[07:33:33.456] <TB1> INFO: ----------------------------------------------------------------------
[07:33:33.718] <TB1> INFO: Expecting 41600 events.
[07:33:37.616] <TB1> INFO: 41600 events read in total (3339ms).
[07:33:37.665] <TB1> INFO: Test took 4207ms.
[07:33:37.887] <TB1> INFO: PixTestAlive::aliveTest() done
[07:33:37.887] <TB1> INFO: number of dead pixels (per ROC): 1 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:33:37.888] <TB1> INFO: ----------------------------------------------------------------------
[07:33:37.888] <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)
[07:33:37.888] <TB1> INFO: ----------------------------------------------------------------------
[07:33:38.145] <TB1> INFO: Expecting 41600 events.
[07:33:41.056] <TB1> INFO: 41600 events read in total (2354ms).
[07:33:41.056] <TB1> INFO: Test took 3167ms.
[07:33:41.056] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[07:33:41.304] <TB1> INFO: PixTestAlive::maskTest() done
[07:33:41.304] <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
[07:33:41.305] <TB1> INFO: ----------------------------------------------------------------------
[07:33:41.305] <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)
[07:33:41.305] <TB1> INFO: ----------------------------------------------------------------------
[07:33:41.568] <TB1> INFO: Expecting 41600 events.
[07:33:44.550] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[07:33:44.550] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[07:33:44.550] <TB1> ERROR: <datapipe.cc/CheckEventID:L469> Channel 2 Event ID mismatch: local ID (161) != TBM ID (162)
[07:33:44.550] <TB1> ERROR: <datapipe.cc/CheckEventID:L469> Channel 3 Event ID mismatch: local ID (161) != TBM ID (162)
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a5 80c1 4070 4cc 2886 4070 4cc 28a6 4870 4cc 2889 4870 4cc 2889 e022 c000
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a29f 8041 4872 4cd 208c 4072 4cd 20ac 4072 4cd 208c 4872 4cd 2085 e022 c000
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a0 80b1 4871 4cd 208e 4871 4cd 20ad 4871 4cd 208e 4871 4cd 2089 e022 c000
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a1 80c1 4070 4cc 2885 4870 4cc 28a4 4070 4cc 2888 4af0 4cd 2889 f422 d400
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a2 8001 4070 4cc 2886 4070 4cc 28a5 4071 4cc 288c 4871 4cc 2889 e022 c000
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a3 8041 4870 4cc 2888 4871 4cc 28a6 4070 4cc 288a 4871 4cc 2889 e022 c000
[07:33:44.550] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2a4 80b1 4870 4cc 2888 4070 4cc 28a6 4070 4cc 288a 4070 4cc 2885 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a5 80c1 4070 4cc 28a0 4070 4cc 2880 4870 4cc 2888 4870 4cc 286f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a39f 8041 4872 4cd 20a6 4072 4cd 2084 4072 4cd 208f 4872 4cd 2085 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a0 80b1 4871 4cd 20a6 4871 4cd 2085 4871 4cd 208f 4871 4cd 2085 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a1 80c1 4071 4cc 28a2 4871 4cc 2882 4071 4cc 288d 4af1 4cd 286f f422 d400
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a2 8001 4070 4cc 288f 4070 4cc 2880 4071 4cc 288e 4871 4cc 286d e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a3 8041 4870 4cc 288f 4871 4cc 286f 4070 4cc 288c 4871 4cc 286f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3a4 80b1 4870 4cc 288e 4070 4cc 2881 4070 4cc 288c 4070 4cc 286f e022 c000
[07:33:44.551] <TB1> WARNING: Channel 2 ROC 0: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 2 ROC 1: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 2 ROC 2: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 2 ROC 3: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 3 ROC 0: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 3 ROC 1: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 3 ROC 2: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2b2 8001 4870 4cc 248c 4870 4cc 24a2 4071 4cc 2483 4871 4cc 2485 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ac 80b1 4071 4cc 248c 4071 4cc 24a2 4071 4cc 2485 4871 4cc 2483 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ad 80c1 4870 4cc 248c 4070 4cc 24a2 4870 4cc 2484 4870 4cc 2485 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ae 8001 4070 4cc 248d 4070 4cc 24a4 4070 4cc 2484 4870 4cc 2483 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2af 8041 4872 4cc 248a 4872 4cc 24a4 4872 4cc 2484 4872 4cc 2487 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2b0 80b1 4871 4cc 248a 4871 4cc 248f 4871 4cc 2482 4871 4cc 2485 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2b1 80c1 4070 4cc 2488 4870 4cc 24a1 4870 4cc 2481 4870 4cc 2481 e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3b2 8001 4870 4cc 24a4 4870 4cc 2480 4071 4cc 2486 4871 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3ac 80b1 4071 4cc 24a6 4071 4cc 246f 4071 4cc 2484 4871 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3ad 80c1 4870 4cc 24a4 4070 4cc 2480 4870 4cc 2483 4870 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3ae 8001 4070 4cc 24a5 4070 4cc 246f 4070 4cc 2484 4870 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3af 8041 4872 4cc 24a6 4872 4cc 246f 4872 4cc 2484 4872 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3b0 80b1 4871 4cc 24a4 4871 4cc 246f 4871 4cc 2483 4871 4cc 246f e022 c000
[07:33:44.551] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3b1 80c1 4071 4cc 24a6 4871 4cc 2481 4871 4cc 2486 4871 4cc 246f e022 c000
[07:33:45.477] <TB1> INFO: 41600 events read in total (3353ms).
[07:33:45.477] <TB1> INFO: Test took 4171ms.
[07:33:45.710] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[07:33:45.710] <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
[07:33:45.710] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[07:33:45.747] <TB1> INFO: enter test to run
[07:33:45.747] <TB1> INFO: test: no parameter change
[07:33:45.985] <TB1> QUIET: Connection to board 147 closed.
[07:33:46.064] <TB1> INFO: pXar: this is the end, my friend