[58.088370] Initializing watchdogs
[58.088481]   /dev/watchdog0
[58.102888] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.107104] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.109268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.112608] [001/131] (960s left) kms_cursor_edge_walk (256x256-top-bottom)
[58.239675] Starting subtest: 256x256-top-bottom
[58.241866] Starting dynamic subtest: pipe-A-eDP-1
[61.734176] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[61.742810] Starting dynamic subtest: pipe-D-eDP-1
[64.867295] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[64.869726] Subtest 256x256-top-bottom: SUCCESS (6.585s)
[65.698448] [002/131] (952s left) kms_legacy_colorkey (basic)
[65.798251] Starting subtest: basic
[65.800392] Starting dynamic subtest: pipe-A
[65.841654] Dynamic subtest pipe-A: SUCCESS (0.045s)
[65.851299] Starting dynamic subtest: pipe-B
[65.853696] Dynamic subtest pipe-B: SUCCESS (0.001s)
[65.860180] Starting dynamic subtest: pipe-C
[65.862399] Dynamic subtest pipe-C: SUCCESS (0.001s)
[65.868966] Starting dynamic subtest: pipe-D
[65.870928] Dynamic subtest pipe-D: SUCCESS (0.000s)
[65.872802] Subtest basic: SUCCESS (0.048s)
[65.932109] [003/131] (952s left) gem_exec_balancer (parallel-out-fence)
[66.191883] Starting subtest: parallel-out-fence
[67.759878] Subtest parallel-out-fence: SUCCESS (1.563s)
[67.915580] [004/131] (950s left) kms_force_connector_basic (force-connector-state)
[68.009890] Starting subtest: force-connector-state
[68.624983] Subtest force-connector-state: SUCCESS (0.614s)
[69.555634] [005/131] (949s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[69.617547] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[69.721222] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[69.817873] [006/131] (948s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[69.917649] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[69.920111] Starting dynamic subtest: pipe-A-default-mode
[70.205818] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[70.210619] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.287s)
[71.045594] [007/131] (947s left) kms_psr (fbc-psr-basic)
[71.151187] Starting subtest: fbc-psr-basic
[71.153611] Starting dynamic subtest: eDP-1
[71.158109] Dynamic subtest eDP-1: SKIP (0.000s)
[71.162627] Subtest fbc-psr-basic: SKIP (0.000s)
[71.242180] [008/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[71.347393] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[71.351673] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.486210] [009/131] (947s left) kms_flip_tiling (flip-change-tiling)
[71.571977] Starting subtest: flip-change-tiling
[71.574427] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[71.774733] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.202s)
[71.784669] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[71.921464] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[71.931371] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[72.054827] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[72.065224] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[72.198316] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.144s)
[72.208342] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[72.343074] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s)
[72.358885] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[72.487082] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[72.496998] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[72.621296] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.133s)
[72.635020] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[72.732359] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[72.742241] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[72.867355] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[72.877102] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[72.999476] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.133s)
[73.009412] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[73.148779] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.149s)
[73.158264] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[73.260320] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[73.273860] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[73.371981] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.110s)
[73.381718] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[73.494259] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.121s)
[73.502816] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[73.605399] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[73.614945] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[73.739218] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[73.748234] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[73.882700] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.144s)
[73.891258] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[74.027365] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.144s)
[74.035820] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[74.161401] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.133s)
[74.172058] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[74.294879] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.132s)
[74.304285] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[74.428639] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.132s)
[74.438568] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[74.550488] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.121s)
[74.560000] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[74.695266] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.144s)
[74.705098] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[74.839553] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.144s)
[74.849526] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[74.973129] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.133s)
[74.982096] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[75.117254] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[75.126528] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[75.261934] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[75.273949] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[75.406655] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[75.417867] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[75.529625] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.121s)
[75.538747] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[75.673701] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.144s)
[75.683228] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[75.818141] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[75.827450] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[75.951682] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.133s)
[75.961630] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[76.085685] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[76.098494] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[76.229938] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.144s)
[76.239771] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[76.374601] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.144s)
[76.384097] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[76.496572] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.121s)
[76.548975] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[77.772389] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.228s)
[77.781876] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[77.906662] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.133s)
[77.916387] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[78.039915] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[78.049784] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[78.171653] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.132s)
[78.183061] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[78.316414] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.144s)
[78.326112] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[78.460780] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[78.470395] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[78.594973] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.132s)
[78.604868] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[78.705625] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[78.715816] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[78.841878] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.133s)
[78.850885] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[78.983479] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.144s)
[78.995177] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[79.127952] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.144s)
[79.138029] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[79.272323] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.144s)
[79.282379] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[79.406570] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[79.415794] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[79.552591] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.144s)
[79.563075] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[79.662703] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.110s)
[79.673046] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[79.807256] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.144s)
[79.817360] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[79.950990] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.144s)
[79.961603] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[80.095641] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[80.104505] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[80.242918] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[80.253047] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[80.385086] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.144s)
[80.393531] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[80.529938] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s)
[80.540086] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[80.651308] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s)
[80.660792] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[80.807168] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.154s)
[80.817399] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[80.951704] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[80.961268] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[81.085371] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.132s)
[81.094939] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[81.229226] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.144s)
[81.239344] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[81.374408] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[81.384817] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[81.518923] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[81.527667] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[81.641680] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.121s)
[81.655040] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[81.785589] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[81.795465] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[81.919713] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.132s)
[81.929666] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[82.063696] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.144s)
[82.074305] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[82.208217] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.143s)
[82.218504] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[82.352476] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.144s)
[82.362504] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[82.500571] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.144s)
[82.508051] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[82.630955] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.132s)
[82.681717] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[83.876827] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.198s)
[83.886972] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[83.988033] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.110s)
[84.001265] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[84.087761] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[84.097925] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[84.199050] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.111s)
[84.209126] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[84.309878] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[84.317131] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[84.459472] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.149s)
[84.469104] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[84.560556] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[84.570737] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[84.660629] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[84.670908] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[84.760724] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.100s)
[84.770421] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[84.860121] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[84.870090] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[84.970658] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[84.982023] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[85.081942] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[85.091227] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[85.182219] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[85.191107] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[85.282690] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[85.292353] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[85.382579] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[85.392438] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[85.493453] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[85.503066] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[85.593064] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.099s)
[85.602144] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[85.693298] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.100s)
[85.702820] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[85.793710] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[85.803543] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[85.893913] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[85.903852] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[85.994343] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[86.005154] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[86.105518] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[86.115663] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[86.216027] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[86.225758] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[86.327101] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[86.337084] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[86.427157] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[86.436625] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[86.527184] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[86.535729] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[86.638526] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.111s)
[86.648055] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[86.749612] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[86.759221] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[86.861234] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[86.871886] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[86.972185] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[86.981891] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[87.083086] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[87.091963] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[87.182945] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[87.192658] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[87.294246] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[87.303585] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[87.405328] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.111s)
[87.414927] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[87.517087] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[87.527080] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[87.628510] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[87.671523] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[88.874508] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.211s)
[88.884703] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[88.974594] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[88.984960] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[89.074334] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[89.083859] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[89.174305] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.099s)
[89.183929] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[89.273929] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.099s)
[89.284098] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[89.373862] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.099s)
[89.383643] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[89.474886] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[89.485392] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[89.574761] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[89.585033] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[89.674673] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[89.684861] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[89.775313] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[89.785608] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[89.874122] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.099s)
[89.883493] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[89.973873] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s)
[89.983314] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[90.074873] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[90.084594] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[90.174865] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[90.184822] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[90.275260] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[90.285162] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[90.386435] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[90.396341] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[90.496493] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[90.505764] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[90.607578] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[90.615172] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[90.707787] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[90.717124] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[90.819529] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[90.829234] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[90.919471] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[90.929106] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[91.030344] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[91.039249] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[91.141336] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[91.150551] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[91.252519] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.111s)
[91.261738] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[91.352732] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s)
[91.360872] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[91.463895] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[91.472588] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[91.574774] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[91.584469] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[91.686037] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[91.695304] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[91.797481] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[91.807264] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[91.919404] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.121s)
[91.926400] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[92.030396] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[92.039714] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[92.143052] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[92.152959] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[92.253066] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[92.262572] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[92.364117] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[92.373538] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[92.475287] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[92.484841] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[92.586535] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[92.619790] Subtest flip-change-tiling: SUCCESS (21.032s)
[93.855482] [010/131] (925s left) gem_media_vme
[93.987623] [011/131] (925s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[94.097159] Starting subtest: yf-tiled-32bpp-rotate-90
[94.101414] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[94.211454] [012/131] (924s left) i915_pm_rps (min-max-config-idle)
[94.281770] Starting subtest: min-max-config-idle
[94.286028] Subtest min-max-config-idle: SKIP (0.000s)
[94.413550] [013/131] (924s left) gen7_exec_parse (basic-rejected)
[94.475187] Subtest basic-rejected: SKIP (0.000s)
[94.566330] [014/131] (924s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[94.659425] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[99.075555] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.419s)
[100.266984] [015/131] (918s left) sriov_basic (enable-vfs-bind-unbind-each)
[100.330058] Starting subtest: enable-vfs-bind-unbind-each
[100.332517] Starting dynamic subtest: numvfs-1
[100.407896] Dynamic subtest numvfs-1: FAIL (0.014s)
[100.417047] Starting dynamic subtest: numvfs-2
[100.490276] Dynamic subtest numvfs-2: FAIL (0.004s)
[100.499248] Starting dynamic subtest: numvfs-3
[100.572280] Dynamic subtest numvfs-3: FAIL (0.004s)
[100.580859] Starting dynamic subtest: numvfs-4
[100.652685] Dynamic subtest numvfs-4: FAIL (0.004s)
[100.661977] Starting dynamic subtest: numvfs-5
[100.737075] Dynamic subtest numvfs-5: FAIL (0.004s)
[100.745213] Starting dynamic subtest: numvfs-6
[100.817250] Dynamic subtest numvfs-6: FAIL (0.004s)
[100.826584] Starting dynamic subtest: numvfs-7
[100.900925] Dynamic subtest numvfs-7: FAIL (0.004s)
[100.910293] Starting dynamic subtest: numvfs-random
[100.983583] Dynamic subtest numvfs-random: FAIL (0.004s)
[100.985598] Subtest enable-vfs-bind-unbind-each: FAIL (0.045s)
[101.020275] [016/131] (918s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[101.120990] Starting subtest: drrs-dirtyfb-ioctl
[101.134482] Subtest drrs-dirtyfb-ioctl: SKIP (0.002s)
[101.259926] [017/131] (917s left) syncobj_basic (test-valid-cycle)
[101.310101] Starting subtest: test-valid-cycle
[101.311879] Subtest test-valid-cycle: SUCCESS (0.000s)
[101.425235] [018/131] (917s left) gem_ctx_sseu (mmap-args)
[101.481697] Subtest mmap-args: SKIP (0.000s)
[101.570239] [019/131] (917s left) kms_invalid_mode (bad-vsync-end)
[101.664090] Starting subtest: bad-vsync-end
[101.666085] Starting dynamic subtest: pipe-A-eDP-1
[101.954737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[101.963639] Starting dynamic subtest: pipe-B-eDP-1
[101.965887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[101.974408] Starting dynamic subtest: pipe-C-eDP-1
[101.976667] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[101.983164] Starting dynamic subtest: pipe-D-eDP-1
[101.985305] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[101.987479] Subtest bad-vsync-end: SUCCESS (0.294s)
[102.770755] [020/131] (916s left) perf_pmu (busy-idle-no-semaphores)
[102.815929] Starting subtest: busy-idle-no-semaphores
[102.818343] Starting dynamic subtest: rcs0
[103.495567] Dynamic subtest rcs0: SUCCESS (0.677s)
[103.505903] Starting dynamic subtest: bcs0
[104.145766] Dynamic subtest bcs0: SUCCESS (0.649s)
[104.156346] Starting dynamic subtest: vcs0
[104.795520] Dynamic subtest vcs0: SUCCESS (0.649s)
[104.804687] Starting dynamic subtest: vcs1
[106.556643] Dynamic subtest vcs1: SUCCESS (1.758s)
[106.570275] Starting dynamic subtest: vecs0
[108.540762] Dynamic subtest vecs0: SUCCESS (1.983s)
[108.551443] Starting dynamic subtest: ccs0
[110.525078] Dynamic subtest ccs0: SUCCESS (1.983s)
[110.528075] Subtest busy-idle-no-semaphores: SUCCESS (7.706s)
[110.664385] [021/131] (908s left) gem_userptr_blits (set-cache-level)
[110.730385] Starting subtest: set-cache-level
[110.735504] Subtest set-cache-level: SKIP (0.000s)
[110.888697] [022/131] (908s left) kms_plane_alpha_blend (constant-alpha-min)
[110.994877] Starting subtest: constant-alpha-min
[111.293147] Starting dynamic subtest: pipe-A-eDP-1
[111.997198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[112.005799] Starting dynamic subtest: pipe-D-eDP-1
[113.503108] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[113.505455] Subtest constant-alpha-min: SUCCESS (2.508s)
[114.360301] [023/131] (905s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[114.460934] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[115.406325] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.944s)
[115.580766] [024/131] (903s left) kms_content_protection (atomic)
[115.736195] Starting subtest: atomic
[115.739905] Subtest atomic: SKIP (0.000s)
[115.884840] [025/131] (903s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[115.975964] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[115.978061] Starting dynamic subtest: pipe-A-default-mode
[118.733348] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[118.735632] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.754s)
[119.560360] [026/131] (900s left) gem_mmap_wc (fault-concurrent)
[119.630523] Subtest fault-concurrent: SKIP (0.000s)
[119.695063] [027/131] (899s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[119.800207] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[120.746854] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.946s)
[121.553274] [028/131] (898s left) gem_create (busy-create)
[121.611530] Starting subtest: busy-create
[121.613942] Starting dynamic subtest: smem0
[154.886405] Dynamic subtest smem0: SUCCESS (33.270s)
[154.889065] Subtest busy-create: SUCCESS (33.271s)
[155.088682] [029/131] (864s left) gem_pread (snoop)
[155.145561] Subtest snoop: SKIP (0.000s)
[155.208608] [030/131] (864s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[155.320317] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[155.324731] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[155.431086] [031/131] (864s left) gem_userptr_blits (input-checking)
[155.493814] Starting subtest: input-checking
[155.496104] Subtest input-checking: SUCCESS (0.000s)
[155.660827] [032/131] (864s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[155.761107] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[155.763446] Starting dynamic subtest: pipe-A-eDP-1
[156.199274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[156.206579] Starting dynamic subtest: pipe-B-eDP-1
[157.645213] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[157.657433] Starting dynamic subtest: pipe-C-eDP-1
[158.981074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.337s)
[158.990360] Starting dynamic subtest: pipe-D-eDP-1
[160.396156] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.412s)
[160.398474] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.607s)
[161.566098] [033/131] (858s left) gem_mmap_wc (read-write-distinct)
[161.639269] Subtest read-write-distinct: SKIP (0.000s)
[161.705989] [034/131] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[161.801187] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[161.805198] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[161.936343] [035/131] (857s left) core_getversion (all-cards)
[161.984844] Starting subtest: all-cards
[161.991736] Subtest all-cards: SUCCESS (0.008s)
[162.032284] [036/131] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[162.136441] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[162.140603] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[162.270887] [037/131] (857s left) kms_addfb_basic (basic)
[162.326187] Starting subtest: basic
[162.328351] Subtest basic: SUCCESS (0.000s)
[162.494903] [038/131] (857s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[162.592396] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[162.594371] Starting dynamic subtest: pipe-A-eDP-1
[162.614945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[162.624167] Starting dynamic subtest: pipe-B-eDP-1
[162.642814] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.650052] Starting dynamic subtest: pipe-C-eDP-1
[162.668907] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.676020] Starting dynamic subtest: pipe-D-eDP-1
[162.696074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.699399] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[164.864171] [039/131] (855s left) gem_busy (close-race)
[164.923385] Starting subtest: close-race
[190.898271] Subtest close-race: SUCCESS (25.970s)
[191.298125] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[191.302614] [040/131] (828s left) gem_ccs (block-multicopy-compressed)
[191.420646] Starting subtest: block-multicopy-compressed
[191.425246] Subtest block-multicopy-compressed: SKIP (0.000s)
[191.557250] [041/131] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[191.666064] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[191.670516] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[191.814175] [042/131] (828s left) gem_userptr_blits (process-exit)
[191.879237] Starting subtest: process-exit
[191.886694] Subtest process-exit: SUCCESS (0.010s)
[192.026389] [043/131] (828s left) gem_ringfill (legacy-basic)
[197.912206] Starting subtest: legacy-basic
[197.914797] Starting dynamic subtest: default
[197.974252] Dynamic subtest default: SUCCESS (0.061s)
[197.985825] Starting dynamic subtest: render
[198.016886] Dynamic subtest render: SUCCESS (0.041s)
[198.026559] Starting dynamic subtest: bsd
[198.059915] Dynamic subtest bsd: SUCCESS (0.041s)
[198.069662] Starting dynamic subtest: bsd1
[198.100267] Dynamic subtest bsd1: SUCCESS (0.038s)
[198.109890] Starting dynamic subtest: bsd2
[198.142865] Dynamic subtest bsd2: SUCCESS (0.041s)
[198.152303] Starting dynamic subtest: blt
[198.187887] Dynamic subtest blt: SUCCESS (0.043s)
[198.197824] Starting dynamic subtest: vebox
[198.230735] Dynamic subtest vebox: SUCCESS (0.041s)
[198.233074] Subtest legacy-basic: SUCCESS (0.320s)
[198.331450] [044/131] (821s left) gem_render_copy (linear-to-vebox-y-tiled)
[198.396031] Starting subtest: linear-to-vebox-y-tiled
[198.400654] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[198.610761] [045/131] (821s left) perf_pmu (module-unload)
[198.701278] Starting subtest: module-unload
[205.632082] Subtest module-unload: FAIL (6.827s)
[205.666317] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[205.667035] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[205.670420] [046/131] (814s left) gem_exec_schedule (noreorder-priority)
[207.341826] Starting subtest: noreorder-priority
[207.344327] Starting dynamic subtest: rcs0
[208.507922] Dynamic subtest rcs0: SUCCESS (1.166s)
[208.521036] Starting dynamic subtest: vcs0
[209.886523] Dynamic subtest vcs0: SUCCESS (1.376s)
[209.897440] Starting dynamic subtest: vcs1
[211.946849] Dynamic subtest vcs1: SUCCESS (2.059s)
[211.957907] Starting dynamic subtest: vecs0
[213.928268] Dynamic subtest vecs0: SUCCESS (1.979s)
[213.939395] Starting dynamic subtest: ccs0
[215.079340] Dynamic subtest ccs0: SUCCESS (1.150s)
[215.082028] Subtest noreorder-priority: SUCCESS (7.738s)
[215.230929] [FACT gem_exec_schedule (noreorder-priority)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[215.232142] [FACT gem_exec_schedule (noreorder-priority)] new: kernel.kmod_is_loaded.i915: true
[215.236073] [047/131] (805s left) i915_query (query-regions-garbage-items)
[215.298389] Starting subtest: query-regions-garbage-items
[215.300610] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[215.432505] [048/131] (805s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[215.525951] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[215.528284] Starting dynamic subtest: pipe-A-eDP-1
[215.550932] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.561929] Starting dynamic subtest: pipe-B-eDP-1
[215.583092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.590381] Starting dynamic subtest: pipe-C-eDP-1
[215.611180] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.618625] Starting dynamic subtest: pipe-D-eDP-1
[215.639926] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.644122] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[217.744437] [049/131] (802s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[217.843942] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[217.845928] Starting dynamic subtest: pipe-A-eDP-1
[250.325221] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.432s)
[250.334753] Starting dynamic subtest: pipe-B-eDP-1
[283.252712] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.628s)
[283.262384] Starting dynamic subtest: pipe-C-eDP-1
[316.241665] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.590s)
[316.251511] Starting dynamic subtest: pipe-D-eDP-1
[349.240065] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.609s)
[349.242482] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.264s)
[350.538771] [050/131] (669s left) kms_plane (plane-panning-top-left)
[350.652364] Starting subtest: plane-panning-top-left
[350.654826] Starting dynamic subtest: pipe-A
[352.445643] Dynamic subtest pipe-A: SUCCESS (1.735s)
[352.455449] Starting dynamic subtest: pipe-B
[354.844242] Dynamic subtest pipe-B: SUCCESS (2.336s)
[354.846599] Subtest plane-panning-top-left: SUCCESS (4.074s)
[355.704302] [051/131] (664s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[355.838372] Starting subtest: cursor-vs-flip-toggle
[386.634784] Subtest cursor-vs-flip-toggle: SUCCESS (30.653s)
[387.470354] [052/131] (633s left) sw_sync (sync_multi_timeline_wait)
[387.509608] Starting subtest: sync_multi_timeline_wait
[387.511986] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[387.587215] [053/131] (633s left) syncobj_timeline (wait-for-submit-delayed-submit)
[387.651844] Starting subtest: wait-for-submit-delayed-submit
[387.756280] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[387.857278] [054/131] (632s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[392.835553] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[392.840395] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[393.716861] [055/131] (627s left) kms_big_fb (yf-tiled-addfb)
[393.828694] Starting subtest: yf-tiled-addfb
[393.833023] Subtest yf-tiled-addfb: SKIP (0.000s)
[393.954461] [056/131] (626s left) gem_exec_balancer (bonded-pair)
[394.018778] Starting subtest: bonded-pair
[394.023343] Subtest bonded-pair: SKIP (0.000s)
[394.358544] [057/131] (626s left) perf (invalid-oa-exponent)
[394.507666] Starting subtest: invalid-oa-exponent
[394.528425] Subtest invalid-oa-exponent: SUCCESS (0.020s)
[394.565054] [058/131] (626s left) gem_render_copy (y-tiled)
[394.628348] Starting subtest: y-tiled
[394.632867] Subtest y-tiled: SKIP (0.000s)
[394.838327] [059/131] (626s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[394.904352] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[394.906636] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[395.018211] [060/131] (625s left) kms_content_protection (lic-type-1)
[395.174661] Starting subtest: lic-type-1
[395.178898] Subtest lic-type-1: SKIP (0.000s)
[395.324711] [061/131] (625s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[395.443645] Starting subtest: fbcpsr-shrfb-scaledprimary
[401.177445] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.738s)
[401.350368] [062/131] (619s left) kms_scaling_modes (scaling-mode-full)
[401.452745] Starting subtest: scaling-mode-full
[401.454982] Starting dynamic subtest: pipe-A-eDP-1
[401.544612] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[401.554363] Starting dynamic subtest: pipe-B-eDP-1
[402.734473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[402.744930] Starting dynamic subtest: pipe-C-eDP-1
[403.851392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[403.861959] Starting dynamic subtest: pipe-D-eDP-1
[404.981017] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[404.983184] Subtest scaling-mode-full: SUCCESS (3.531s)
[406.169269] [063/131] (614s left) syncobj_wait (multi-wait-all-signaled)
[406.225719] Starting subtest: multi-wait-all-signaled
[406.228054] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[406.362101] [064/131] (614s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[406.418240] Starting subtest: invalid-signal-one-illegal-handle
[406.420603] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[406.560314] [065/131] (614s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[406.645671] Starting subtest: primary-x-tiled-reflect-x-180
[413.547338] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.901s)
[414.750199] [066/131] (606s left) kms_addfb_basic (addfb25-4-tiled)
[414.855403] Starting subtest: addfb25-4-tiled
[414.857319] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[414.971175] [067/131] (606s left) kms_psr (psr2-cursor-blt)
[415.067375] Starting subtest: psr2-cursor-blt
[415.069498] Starting dynamic subtest: eDP-1
[416.789781] Dynamic subtest eDP-1: SUCCESS (1.722s)
[416.792257] Subtest psr2-cursor-blt: SUCCESS (1.723s)
[417.612306] [068/131] (603s left) gem_exec_reloc (basic-active)
[417.673921] Subtest basic-active: SKIP (0.000s)
[417.749950] [069/131] (603s left) kms_rotation_crc (cursor-rotation-180)
[417.845509] Starting subtest: cursor-rotation-180
[419.342559] Subtest cursor-rotation-180: SUCCESS (1.497s)
[420.578448] [070/131] (600s left) kms_vrr (seamless-rr-switch-drrs)
[420.684338] Starting subtest: seamless-rr-switch-drrs
[420.691070] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[420.778092] [071/131] (600s left) gem_mmap_offset (open-flood)
[420.840078] Starting subtest: open-flood
[442.335588] Subtest open-flood: SUCCESS (21.490s)
[442.480565] [072/131] (578s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[442.667471] Starting subtest: cursor-rapid-movement-64x21
[442.711016] Subtest cursor-rapid-movement-64x21: SKIP (0.040s)
[442.967071] [073/131] (578s left) kms_flip (2x-absolute-wf_vblank)
[443.056622] Starting subtest: 2x-absolute-wf_vblank
[443.065464] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[443.169515] [074/131] (578s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[443.271405] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[443.273330] Starting dynamic subtest: pipe-A
[443.333462] Dynamic subtest pipe-A: SUCCESS (0.064s)
[443.342800] Starting dynamic subtest: pipe-B
[444.482842] Dynamic subtest pipe-B: SUCCESS (1.147s)
[444.492609] Starting dynamic subtest: pipe-C
[445.587802] Dynamic subtest pipe-C: SUCCESS (1.104s)
[445.597083] Starting dynamic subtest: pipe-D
[446.725185] Dynamic subtest pipe-D: SUCCESS (1.137s)
[446.727507] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.457s)
[447.909003] [075/131] (573s left) kms_atomic_interruptible (legacy-setmode)
[448.004554] Starting subtest: legacy-setmode
[448.006785] Starting dynamic subtest: pipe-A-eDP-1
[454.867552] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.865s)
[454.869782] Subtest legacy-setmode: SUCCESS (6.866s)
[455.693429] [076/131] (565s left) api_intel_allocator (simple-allocator)
[455.760792] Starting subtest: simple-allocator
[455.763026] Starting dynamic subtest: basic
[455.764900] Dynamic subtest basic: SUCCESS (0.004s)
[455.777374] Starting dynamic subtest: parallel-one
[455.953466] Dynamic subtest parallel-one: SUCCESS (0.189s)
[455.964773] Starting dynamic subtest: print
[455.967105] Dynamic subtest print: SUCCESS (0.000s)
[455.976015] Starting dynamic subtest: reuse
[455.977872] Dynamic subtest reuse: SUCCESS (0.000s)
[455.985877] Starting dynamic subtest: reserve
[455.987768] Dynamic subtest reserve: SUCCESS (0.000s)
[455.995761] Starting dynamic subtest: fork-reopen-allocator
[455.997609] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[455.999519] Subtest simple-allocator: SUCCESS (0.208s)
[456.121762] [077/131] (565s left) gem_exec_schedule (u-submit-golden-slice)
[456.196815] Starting subtest: u-submit-golden-slice
[456.199069] Starting dynamic subtest: rcs0
[456.222359] Dynamic subtest rcs0: SUCCESS (0.034s)
[456.233956] Starting dynamic subtest: bcs0
[456.251987] Dynamic subtest bcs0: SUCCESS (0.029s)
[456.261333] Starting dynamic subtest: vcs0
[456.285962] Dynamic subtest vcs0: SUCCESS (0.033s)
[456.295521] Starting dynamic subtest: vcs1
[456.317274] Dynamic subtest vcs1: SUCCESS (0.031s)
[456.326744] Starting dynamic subtest: vecs0
[456.345005] Dynamic subtest vecs0: SUCCESS (0.027s)
[456.353594] Starting dynamic subtest: ccs0
[456.375127] Dynamic subtest ccs0: SUCCESS (0.029s)
[456.377328] Subtest u-submit-golden-slice: SUCCESS (0.188s)
[457.715105] [078/131] (563s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[457.813305] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[464.602181] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.791s)
[464.772942] [079/131] (556s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[464.863126] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[464.874739] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[465.005829] [080/131] (556s left) perf (invalid-oa-metric-set-id)
[465.107143] Starting subtest: invalid-oa-metric-set-id
[465.118704] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[465.160188] [081/131] (556s left) gem_exec_whisper (basic-queues-priority-all)
[465.226380] Starting subtest: basic-queues-priority-all
[486.933825] Subtest basic-queues-priority-all: SUCCESS (21.702s)
[487.143567] [082/131] (534s left) gem_pxp (create-regular-buffer)
[487.270761] Starting subtest: create-regular-buffer
[487.273312] Subtest create-regular-buffer: SUCCESS (0.000s)
[487.402273] [083/131] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[487.504811] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[495.025170] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.520s)
[495.225521] [084/131] (526s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[495.770551] Starting subtest: syncobj-backward-timeline-chain-engines
[495.863663] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.098s)
[497.734204] [085/131] (524s left) gem_exec_suspend (basic-s3-devices)
[497.811056] Starting subtest: basic-S3-devices
[497.813335] Starting dynamic subtest: smem
[509.558056] Dynamic subtest smem: SUCCESS (11.743s)
[509.561080] Subtest basic-S3-devices: SUCCESS (11.745s)
[509.767167] [086/131] (512s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[509.866071] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[509.868255] Starting dynamic subtest: pipe-A
[510.203939] Dynamic subtest pipe-A: SUCCESS (0.338s)
[510.221792] Starting dynamic subtest: pipe-B
[511.577284] Dynamic subtest pipe-B: SUCCESS (1.372s)
[511.587209] Starting dynamic subtest: pipe-C
[513.005075] Dynamic subtest pipe-C: SUCCESS (1.426s)
[513.019898] Starting dynamic subtest: pipe-D
[514.438130] Dynamic subtest pipe-D: SUCCESS (1.434s)
[514.440400] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.573s)
[515.633400] [087/131] (506s left) gem_ctx_param (invalid-set-no-zeromap)
[515.705109] Starting subtest: invalid-set-no-zeromap
[515.707453] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[515.806318] [088/131] (506s left) kms_pm_rpm (universal-planes)
[517.753606] Starting subtest: universal-planes
[517.755974] Starting dynamic subtest: plane-33
[526.012220] Dynamic subtest plane-33: SUCCESS (8.261s)
[526.023270] Starting dynamic subtest: plane-63
[534.609768] Dynamic subtest plane-63: SUCCESS (8.594s)
[534.621932] Starting dynamic subtest: plane-93
[542.897589] Dynamic subtest plane-93: SUCCESS (8.284s)
[542.907641] Starting dynamic subtest: plane-123
[551.513218] Dynamic subtest plane-123: SUCCESS (8.611s)
[551.526309] Starting dynamic subtest: plane-133
[559.818165] Dynamic subtest plane-133: SUCCESS (8.301s)
[559.830011] Starting dynamic subtest: plane-143
[568.413542] Dynamic subtest plane-143: SUCCESS (8.591s)
[568.416601] Subtest universal-planes: SUCCESS (50.658s)
[568.803681] [089/131] (453s left) kms_rotation_crc (sprite-rotation-180)
[568.894088] Starting subtest: sprite-rotation-180
[575.802471] Subtest sprite-rotation-180: SUCCESS (6.910s)
[577.065124] [090/131] (445s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[577.173429] Starting subtest: flip-vs-cursor-busy-crc-legacy
[577.973970] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.800s)
[578.801936] [091/131] (443s left) kms_flip (flip-vs-expired-vblank)
[578.902358] Starting subtest: flip-vs-expired-vblank
[578.904676] Starting dynamic subtest: A-eDP1
[587.569280] Dynamic subtest A-eDP1: SUCCESS (8.667s)
[587.580841] Starting dynamic subtest: B-eDP1
[596.200161] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[596.217395] Starting dynamic subtest: C-eDP1
[604.828815] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[604.839741] Starting dynamic subtest: D-eDP1
[613.462781] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[613.468029] Subtest flip-vs-expired-vblank: SUCCESS (34.563s)
[614.662786] [092/131] (407s left) gen3_render_linear_blits
[614.790644] [093/131] (407s left) kms_psr (psr2-sprite-plane-onoff)
[614.889818] Starting subtest: psr2-sprite-plane-onoff
[614.892120] Starting dynamic subtest: eDP-1
[616.655336] Dynamic subtest eDP-1: SUCCESS (1.764s)
[616.657374] Subtest psr2-sprite-plane-onoff: SUCCESS (1.765s)
[617.511745] [094/131] (404s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[617.607292] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[617.611347] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[617.743546] [095/131] (404s left) kms_cursor_crc (cursor-onscreen-64x21)
[617.939150] Starting subtest: cursor-onscreen-64x21
[617.984501] Subtest cursor-onscreen-64x21: SKIP (0.039s)
[618.268502] [096/131] (404s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[618.368220] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[618.372504] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.495620] [097/131] (403s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[618.593019] Starting subtest: x-tiled-16bpp-rotate-0
[619.930225] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.335s)
[620.100859] [098/131] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[620.222783] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[627.525061] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.305s)
[627.695091] [099/131] (394s left) i915_hangman (gt-error-state-capture)
[627.780525] Starting subtest: gt-error-state-capture
[627.782555] Starting dynamic subtest: rcs0
[639.509110] Dynamic subtest rcs0: SUCCESS (11.726s)
[639.531418] Starting dynamic subtest: bcs0
[651.542145] Dynamic subtest bcs0: SUCCESS (12.028s)
[651.555481] Starting dynamic subtest: vcs0
[663.572795] Dynamic subtest vcs0: SUCCESS (12.025s)
[663.585123] Starting dynamic subtest: vcs1
[674.515767] Dynamic subtest vcs1: SUCCESS (10.938s)
[674.533503] Starting dynamic subtest: vecs0
[685.524167] Dynamic subtest vecs0: SUCCESS (11.002s)
[685.540644] Starting dynamic subtest: ccs0
[697.556804] Dynamic subtest ccs0: SUCCESS (12.027s)
[697.559597] Subtest gt-error-state-capture: SUCCESS (69.763s)
[697.664717] [100/131] (324s left) syncobj_wait (wait-any-interrupted)
[697.729363] Starting subtest: wait-any-interrupted
[697.829717] Subtest wait-any-interrupted: SUCCESS (0.102s)
[697.936875] [101/131] (324s left) i915_drm_fdinfo (context-close-stress)
[697.977692] Starting subtest: context-close-stress
[708.724059] Subtest context-close-stress: SUCCESS (10.744s)
[708.896806] [102/131] (313s left) api_intel_bb (simple-bb-ctx)
[709.084704] Starting subtest: simple-bb-ctx
[709.095528] Subtest simple-bb-ctx: SUCCESS (0.015s)
[709.264558] [103/131] (313s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[709.663735] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[710.514930] [104/131] (312s left) kms_atomic_transition (plane-all-transition-nonblocking)
[710.611902] Starting subtest: plane-all-transition-nonblocking
[710.614255] Starting dynamic subtest: pipe-A-eDP-1
[713.106815] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[713.421032] Starting dynamic subtest: pipe-B-eDP-1
[716.665158] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.260s)
[716.962605] Subtest plane-all-transition-nonblocking: SUCCESS (6.350s)
[717.812925] [105/131] (304s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[717.934434] Starting subtest: y-tiled-32bpp-rotate-90
[717.939129] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[718.077946] [106/131] (304s left) gem_exec_schedule (u-semaphore-codependency)
[718.148480] Starting subtest: u-semaphore-codependency
[718.153010] Subtest u-semaphore-codependency: SUCCESS (0.011s)
[718.546861] [107/131] (304s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[718.656311] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[718.660842] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[718.808840] [108/131] (304s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[718.906269] Starting subtest: psr-farfromfence-mmap-gtt
[718.910379] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[719.049528] [109/131] (303s left) gem_eio (in-flight-internal-immediate)
[719.289664] Starting subtest: in-flight-internal-immediate
[720.633709] Subtest in-flight-internal-immediate: SUCCESS (1.342s)
[720.818896] [110/131] (302s left) gem_exec_reloc (basic-gtt-active)
[720.888261] Subtest basic-gtt-active: SKIP (0.000s)
[720.969860] [111/131] (302s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[721.084502] Starting subtest: fbc-rgb101010-draw-pwrite
[726.432362] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.350s)
[727.618396] [112/131] (295s left) kms_psr (pr-primary-blt)
[727.719408] Starting subtest: pr-primary-blt
[727.723868] Subtest pr-primary-blt: SKIP (0.000s)
[727.819385] [113/131] (295s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[732.879258] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[732.881240] Starting dynamic subtest: pipe-A-eDP-1
[744.299629] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.416s)
[744.309661] Starting dynamic subtest: pipe-B-eDP-1
[755.729780] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.425s)
[755.732198] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.846s)
[756.610862] [114/131] (266s left) kms_async_flips (test-cursor)
[756.700023] Starting subtest: test-cursor
[756.704417] Subtest test-cursor: SKIP (0.000s)
[757.942269] [115/131] (265s left) gem_exec_params (invalid-bsd1-flag-on-render)
[757.996470] Starting subtest: invalid-bsd1-flag-on-render
[757.998954] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[758.127795] [116/131] (265s left) gem_ctx_persistence (heartbeat-hostile)
[758.189806] Starting subtest: heartbeat-hostile
[758.194413] Subtest heartbeat-hostile: SKIP (0.000s)
[758.327600] [117/131] (264s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[758.422894] Starting subtest: fbc-pr-sprite-mmap-gtt
[758.427353] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[758.523448] [118/131] (264s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[758.588608] Starting subtest: multi-wait-available-unsubmitted-signaled
[758.590662] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[758.723569] [119/131] (264s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[760.749552] Starting subtest: modeset-lpsp-stress-no-wait
[770.410236] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.661s)
[770.527959] [120/131] (252s left) syncobj_wait (invalid-signal-illegal-handle)
[770.589112] Starting subtest: invalid-signal-illegal-handle
[770.591105] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[770.723058] [121/131] (252s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[770.841335] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[770.845783] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[770.989270] [122/131] (252s left) kms_vblank (query-busy-hang)
[771.094362] Starting subtest: query-busy-hang
[771.096452] Starting dynamic subtest: pipe-A-eDP-1
[797.365546] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.262s)
[797.381234] Starting dynamic subtest: pipe-D-eDP-1
[812.399561] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.028s)
[812.401433] Subtest query-busy-hang: SUCCESS (41.294s)
[813.251153] [123/131] (210s left) gem_exec_flush (basic-wb-ro-default)
[813.327788] Starting subtest: basic-wb-ro-default
[818.779094] Subtest basic-wb-ro-default: SUCCESS (5.451s)
[819.003848] [124/131] (204s left) kms_frontbuffer_tracking (fbc-2p-rte)
[819.110224] Starting subtest: fbc-2p-rte
[819.114591] Subtest fbc-2p-rte: SKIP (0.000s)
[819.259353] [125/131] (204s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[819.361858] Starting subtest: 4-tiled-64bpp-rotate-0
[821.001467] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.639s)
[821.224654] [126/131] (202s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[821.337287] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[821.341547] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[821.481630] [127/131] (202s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[821.588313] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[821.592561] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[821.731333] [128/131] (202s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[821.829623] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[821.831962] Starting dynamic subtest: pipe-A-eDP-1
[821.854230] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[821.866109] Starting dynamic subtest: pipe-B-eDP-1
[821.887822] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[821.896909] Starting dynamic subtest: pipe-C-eDP-1
[821.918345] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[821.927350] Starting dynamic subtest: pipe-D-eDP-1
[821.949053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[821.953388] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[824.028127] [129/131] (199s left) kms_chamelium_frames (dp-crc-multiple)
[824.426048] Subtest dp-crc-multiple: SKIP (0.000s)
[825.230157] [130/131] (198s left) gem_softpin (evict-prime-sanity-check)
[825.302159] Starting subtest: evict-prime-sanity-check
[825.304335] Starting dynamic subtest: rcs0
[826.498780] Dynamic subtest rcs0: SUCCESS (1.199s)
[826.512499] Starting dynamic subtest: bcs0
[827.653924] Dynamic subtest bcs0: SUCCESS (1.152s)
[827.667228] Starting dynamic subtest: vcs0
[829.574097] Dynamic subtest vcs0: SUCCESS (1.916s)
[829.587650] Starting dynamic subtest: vcs1
[831.615128] Dynamic subtest vcs1: SUCCESS (2.038s)
[831.629072] Starting dynamic subtest: vecs0
[833.591783] Dynamic subtest vecs0: SUCCESS (1.975s)
[833.603291] Starting dynamic subtest: ccs0
[834.744935] Dynamic subtest ccs0: SUCCESS (1.150s)
[834.768161] Starting dynamic subtest: all
[835.912621] Dynamic subtest all: SUCCESS (1.164s)
[835.915397] Subtest evict-prime-sanity-check: SUCCESS (10.612s)
[836.055368] [131/131] (187s left) kms_draw_crc (draw-method-pwrite)
[836.184693] Starting subtest: draw-method-pwrite
[836.186903] Starting dynamic subtest: xrgb8888-untiled
[836.728479] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s)
[836.739419] Starting dynamic subtest: rgb565-untiled
[837.172458] Dynamic subtest rgb565-untiled: SUCCESS (0.442s)
[837.183132] Starting dynamic subtest: xrgb2101010-untiled
[837.705759] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.533s)
[837.716400] Starting dynamic subtest: xbgr16161616f-untiled
[838.439351] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.733s)
[838.449965] Starting dynamic subtest: xrgb8888-xtiled
[840.151015] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.710s)
[840.161634] Starting dynamic subtest: rgb565-xtiled
[841.184543] Dynamic subtest rgb565-xtiled: SUCCESS (1.033s)
[841.197669] Starting dynamic subtest: xrgb2101010-xtiled
[842.940637] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.755s)
[842.951032] Starting dynamic subtest: xbgr16161616f-xtiled
[846.119428] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.177s)
[846.129963] Starting dynamic subtest: xrgb8888-4tiled
[847.163942] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.044s)
[847.176816] Starting dynamic subtest: rgb565-4tiled
[847.708777] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s)
[847.719374] Starting dynamic subtest: xrgb2101010-4tiled
[848.753145] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.044s)
[848.763792] Starting dynamic subtest: xbgr16161616f-4tiled
[851.611244] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.855s)
[851.613653] Subtest draw-method-pwrite: SUCCESS (15.424s)
[851.751192] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_edge_walk
results: parsing output: 1/ for test: kms_legacy_colorkey
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_force_connector_basic
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip_tiling
results: parsing output: 9/ for test: gem_media_vme
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: i915_pm_rps
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: kms_dirtyfb
results: parsing output: 16/ for test: syncobj_basic
results: parsing output: 17/ for test: gem_ctx_sseu
results: parsing output: 18/ for test: kms_invalid_mode
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_flip_scaled_crc
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_create
results: parsing output: 28/ for test: gem_pread
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: core_getversion
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_busy
results: parsing output: 39/ for test: gem_ccs
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: gem_ringfill
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_scaling_modes
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: kms_vrr
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_whisper
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gen3_render_linear_blits
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: i915_drm_fdinfo
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_atomic_transition
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_vblank
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_chamelium_frames
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_draw_crc
Done.