[62.809327] Initializing watchdogs [62.809372] /dev/watchdog0 [62.822677] [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] [62.826443] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.828476] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.831891] [001/130] (960s left) perf (invalid-remove-userspace-config) [63.004852] Starting subtest: invalid-remove-userspace-config [63.011669] Subtest invalid-remove-userspace-config: SUCCESS (0.010s) [63.045370] [002/130] (960s left) kms_flip (basic-flip-vs-wf_vblank) [63.144287] Starting subtest: basic-flip-vs-wf_vblank [63.146634] Starting dynamic subtest: A-eDP1 [65.086241] Dynamic subtest A-eDP1: SUCCESS (1.942s) [65.097200] Starting dynamic subtest: B-eDP1 [67.016296] Dynamic subtest B-eDP1: SUCCESS (1.929s) [67.022550] Starting dynamic subtest: C-eDP1 [68.936920] Dynamic subtest C-eDP1: SUCCESS (1.919s) [68.945794] Starting dynamic subtest: D-eDP1 [70.866700] Dynamic subtest D-eDP1: SUCCESS (1.929s) [70.869248] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.726s) [72.085899] [003/130] (951s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [72.192606] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [73.433915] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.243s) [73.732053] [004/130] (949s left) kms_addfb_basic (bo-too-small) [73.836952] Starting subtest: bo-too-small [73.839257] Subtest bo-too-small: SUCCESS (0.000s) [73.945051] [005/130] (949s left) kms_cursor_crc (cursor-offscreen-512x170) [74.198576] Starting subtest: cursor-offscreen-512x170 [74.202610] Subtest cursor-offscreen-512x170: SKIP (0.001s) [74.349079] [006/130] (949s left) kms_color (invalid-degamma-lut-sizes) [74.445828] Starting subtest: invalid-degamma-lut-sizes [74.448072] Starting dynamic subtest: pipe-A [74.732699] Dynamic subtest pipe-A: SUCCESS (0.285s) [74.741414] Starting dynamic subtest: pipe-B [74.743806] Dynamic subtest pipe-B: SUCCESS (0.001s) [74.750700] Starting dynamic subtest: pipe-C [74.753062] Dynamic subtest pipe-C: SUCCESS (0.001s) [74.759351] Starting dynamic subtest: pipe-D [74.761335] Dynamic subtest pipe-D: SUCCESS (0.001s) [74.763320] Subtest invalid-degamma-lut-sizes: SUCCESS (0.287s) [75.510364] [007/130] (948s left) kms_cursor_crc (cursor-onscreen-64x21) [75.676629] Starting subtest: cursor-onscreen-64x21 [75.714508] Subtest cursor-onscreen-64x21: SKIP (0.033s) [75.960025] [008/130] (947s left) perf_pmu (faulting-read) [76.001550] Starting subtest: faulting-read [76.003831] Starting dynamic subtest: wb [76.006137] Dynamic subtest wb: SUCCESS (0.001s) [76.012613] Starting dynamic subtest: wc [76.014875] Dynamic subtest wc: SUCCESS (0.000s) [76.021285] Starting dynamic subtest: uc [76.023492] Dynamic subtest uc: SUCCESS (0.000s) [76.025720] Subtest faulting-read: SUCCESS (0.002s) [76.115314] [009/130] (947s left) kms_getfb (getfb-handle-zero) [76.163883] Starting subtest: getfb-handle-zero [76.166155] Subtest getfb-handle-zero: SUCCESS (0.000s) [76.265485] [010/130] (947s left) gem_ctx_persistence (engines-mixed) [76.323161] Starting subtest: engines-mixed [76.325469] Starting dynamic subtest: rcs0 [76.420692] Dynamic subtest rcs0: SUCCESS (0.097s) [76.427638] Starting dynamic subtest: bcs0 [76.486416] Dynamic subtest bcs0: SUCCESS (0.066s) [76.494821] Starting dynamic subtest: vcs0 [76.554492] Dynamic subtest vcs0: SUCCESS (0.068s) [76.563566] Starting dynamic subtest: vcs1 [76.620504] Dynamic subtest vcs1: SUCCESS (0.066s) [76.629261] Starting dynamic subtest: vecs0 [76.680598] Dynamic subtest vecs0: SUCCESS (0.060s) [76.688511] Starting dynamic subtest: ccs0 [76.756588] Dynamic subtest ccs0: SUCCESS (0.076s) [76.758955] Subtest engines-mixed: SUCCESS (0.434s) [76.828755] [011/130] (946s left) gem_exec_balancer (full-late-pulse) [76.891472] Starting subtest: full-late-pulse [81.684935] Subtest full-late-pulse: SUCCESS (4.793s) [81.994132] [012/130] (941s left) gem_exec_reloc (basic-wc-gtt-noreloc) [82.054637] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [82.141877] [013/130] (941s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [82.253599] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [82.258163] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [82.344317] [014/130] (941s left) kms_prop_blob (blob-prop-lifetime) [82.389478] Starting subtest: blob-prop-lifetime [82.391903] Subtest blob-prop-lifetime: SUCCESS (0.001s) [82.487006] [015/130] (941s left) syncobj_timeline (single-wait-for-submit-signaled) [82.541140] Starting subtest: single-wait-for-submit-signaled [82.543081] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [82.635977] [016/130] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [82.747042] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [82.751300] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [82.848639] [017/130] (940s left) kms_plane_alpha_blend (constant-alpha-min) [82.953518] Starting subtest: constant-alpha-min [83.357891] Starting dynamic subtest: pipe-A-eDP-1 [84.047840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [84.056409] Starting dynamic subtest: pipe-D-eDP-1 [85.468201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s) [85.470284] Subtest constant-alpha-min: SUCCESS (2.511s) [86.269901] [018/130] (937s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [86.331030] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [86.434500] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [86.500093] [019/130] (937s left) gem_exec_parallel (userptr) [86.560516] Starting subtest: userptr [86.562961] Starting dynamic subtest: rcs0 [88.008622] Dynamic subtest rcs0: SUCCESS (1.447s) [88.018209] Starting dynamic subtest: bcs0 [89.465081] Dynamic subtest bcs0: SUCCESS (1.456s) [89.474027] Starting dynamic subtest: vcs0 [90.952192] Dynamic subtest vcs0: SUCCESS (1.486s) [90.960162] Starting dynamic subtest: vcs1 [92.910761] Dynamic subtest vcs1: SUCCESS (1.958s) [92.920736] Starting dynamic subtest: vecs0 [94.957842] Dynamic subtest vecs0: SUCCESS (2.046s) [94.967586] Starting dynamic subtest: ccs0 [96.432012] Dynamic subtest ccs0: SUCCESS (1.476s) [96.434730] Subtest userptr: SUCCESS (9.871s) [96.614685] [020/130] (927s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [96.674924] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [96.677479] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [96.770984] [021/130] (927s left) kms_big_fb (linear-8bpp-rotate-90) [96.879061] Starting subtest: linear-8bpp-rotate-90 [96.900693] Subtest linear-8bpp-rotate-90: SKIP (0.021s) [97.028657] [022/130] (926s left) gem_mmap_offset (mmap-unmap) [97.092172] Starting subtest: mmap-unmap [97.094455] Starting dynamic subtest: smem0 [120.505407] Dynamic subtest smem0: SUCCESS (23.413s) [120.507851] Subtest mmap-unmap: SUCCESS (23.414s) [120.693777] [023/130] (903s left) prime_vgem (coherency-blt) [120.845941] Starting subtest: coherency-blt [122.517401] Subtest coherency-blt: SUCCESS (1.672s) [122.652291] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true [122.655427] [024/130] (901s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [122.755286] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [122.759217] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [122.863704] [025/130] (901s left) kms_big_fb (yf-tiled-32bpp-rotate-0) [122.964944] Starting subtest: yf-tiled-32bpp-rotate-0 [122.969465] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s) [123.049932] [026/130] (901s left) i915_hangman (hangcheck-unterminated) [123.119389] Starting subtest: hangcheck-unterminated [134.924828] Subtest hangcheck-unterminated: SUCCESS (11.804s) [135.054248] [027/130] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [135.155097] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [139.690565] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.538s) [139.796831] [028/130] (884s left) gem_ccs (large-ctrl-surf-copy) [139.869718] Starting subtest: large-ctrl-surf-copy [139.874059] Subtest large-ctrl-surf-copy: SKIP (0.000s) [139.966451] [029/130] (884s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [140.061928] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [140.064293] Starting dynamic subtest: pipe-A [140.224286] Dynamic subtest pipe-A: SKIP (0.156s) [140.235314] Starting dynamic subtest: pipe-B [141.434428] Dynamic subtest pipe-B: SKIP (1.211s) [141.444140] Starting dynamic subtest: pipe-C [142.656663] Dynamic subtest pipe-C: SUCCESS (1.227s) [142.668388] Starting dynamic subtest: pipe-D [143.848595] Dynamic subtest pipe-D: SUCCESS (1.192s) [143.851061] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.787s) [145.025893] [030/130] (879s left) gen7_exec_parse (basic-allocation) [145.091460] Subtest basic-allocation: SKIP (0.000s) [145.150027] [031/130] (879s left) gem_exec_params (invalid-ring) [145.214417] Starting subtest: invalid-ring [145.216700] Subtest invalid-ring: SUCCESS (0.000s) [145.321901] [032/130] (879s left) kms_psr2_su (page_flip-xrgb8888) [145.376070] Subtest page_flip-XRGB8888: SKIP (0.000s) [145.441600] [033/130] (878s left) gem_eio (kms) [145.678174] Starting subtest: kms [167.511648] Subtest kms: SUCCESS (21.834s) [168.671142] [034/130] (855s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [168.735905] Starting subtest: etime-multi-wait-available-unsubmitted [168.841635] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.105s) [168.908111] [035/130] (855s left) kms_vblank (query-busy-hang) [169.004842] Starting subtest: query-busy-hang [169.007058] Starting dynamic subtest: pipe-A-eDP-1 [170.892678] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s) [170.906770] Starting dynamic subtest: pipe-D-eDP-1 [173.434839] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s) [173.437532] Subtest query-busy-hang: SUCCESS (4.428s) [174.233744] [036/130] (850s left) gem_mmap_wc (read) [174.301954] Subtest read: SKIP (0.000s) [174.360298] [037/130] (850s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [174.460911] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [174.463149] Starting dynamic subtest: pipe-A-eDP-1 [174.485184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [174.492964] Starting dynamic subtest: pipe-B-eDP-1 [174.513634] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [174.521227] Starting dynamic subtest: pipe-C-eDP-1 [174.542721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [174.551789] Starting dynamic subtest: pipe-D-eDP-1 [174.573063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [174.577370] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s) [176.572222] [038/130] (847s left) gem_exec_whisper (basic-fds) [176.628604] Starting subtest: basic-fds [183.673887] Subtest basic-fds: SUCCESS (7.042s) [183.851663] [039/130] (840s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [183.900874] Starting subtest: multi-wait-all-for-submit-signaled [183.902932] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [183.991100] [040/130] (840s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [184.083087] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [184.085809] Starting dynamic subtest: pipe-A-eDP-1 [184.145205] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [184.155022] Starting dynamic subtest: pipe-B-eDP-1 [184.215400] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [184.222617] Starting dynamic subtest: pipe-C-eDP-1 [184.278289] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [184.287157] Starting dynamic subtest: pipe-D-eDP-1 [184.344599] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [184.349128] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s) [186.217226] [041/130] (838s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [186.321053] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [186.432102] [042/130] (838s left) kms_getfb (getfb2-handle-zero) [186.484842] Starting subtest: getfb2-handle-zero [186.487130] Subtest getfb2-handle-zero: SUCCESS (0.000s) [186.576490] [043/130] (838s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [186.669162] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [186.671537] Starting dynamic subtest: pipe-A-default-mode [187.764302] Dynamic subtest pipe-A-default-mode: SKIP (1.090s) [187.768943] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.092s) [187.920813] [044/130] (836s left) perf_pmu (most-busy-idle-check-all) [187.962288] Starting subtest: most-busy-idle-check-all [187.964472] Starting dynamic subtest: rcs0 [189.934429] Dynamic subtest rcs0: SUCCESS (1.972s) [189.945814] Starting dynamic subtest: bcs0 [191.917639] Dynamic subtest bcs0: SUCCESS (1.982s) [191.929283] Starting dynamic subtest: vcs0 [193.903733] Dynamic subtest vcs0: SUCCESS (1.984s) [193.913964] Starting dynamic subtest: vcs1 [195.950428] Dynamic subtest vcs1: SUCCESS (2.044s) [195.959363] Starting dynamic subtest: vecs0 [197.934786] Dynamic subtest vecs0: SUCCESS (1.982s) [197.945882] Starting dynamic subtest: ccs0 [199.918218] Dynamic subtest ccs0: SUCCESS (1.981s) [199.921247] Subtest most-busy-idle-check-all: SUCCESS (11.957s) [200.020386] [045/130] (824s left) kms_cursor_legacy (torture-move) [200.152590] Starting subtest: torture-move [200.154515] Starting dynamic subtest: pipe-A [205.866582] Dynamic subtest pipe-A: SUCCESS (5.709s) [205.878259] Starting dynamic subtest: pipe-B [212.340392] Dynamic subtest pipe-B: SUCCESS (6.476s) [212.350386] Starting dynamic subtest: pipe-C [218.837388] Dynamic subtest pipe-C: SUCCESS (6.495s) [218.848388] Starting dynamic subtest: pipe-D [225.254246] Dynamic subtest pipe-D: SUCCESS (6.415s) [225.264478] Starting dynamic subtest: all-pipes [231.574954] Dynamic subtest all-pipes: SUCCESS (6.319s) [231.577653] Subtest torture-move: SUCCESS (31.420s) [231.728942] [046/130] (793s left) kms_chamelium_hpd (dp-hpd-storm) [232.116750] Subtest dp-hpd-storm: SKIP (0.000s) [232.934578] [047/130] (791s left) kms_psr (fbc-pr-sprite-render) [233.034972] Starting subtest: fbc-pr-sprite-render [233.040139] Subtest fbc-pr-sprite-render: SKIP (0.000s) [233.104402] [048/130] (791s left) kms_cursor_crc (cursor-rapid-movement-256x85) [233.347261] Starting subtest: cursor-rapid-movement-256x85 [233.387910] Subtest cursor-rapid-movement-256x85: SKIP (0.035s) [233.540787] [049/130] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [233.651697] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [233.655855] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [233.758322] [050/130] (791s left) gem_mmap_gtt (hang-user) [233.818811] Subtest hang-user: SKIP (0.000s) [233.868906] [051/130] (791s left) sysfs_heartbeat_interval (mixed) [233.929577] Starting subtest: mixed [233.931527] Starting dynamic subtest: vecs0 [239.179405] Dynamic subtest vecs0: SUCCESS (5.248s) [239.189473] Starting dynamic subtest: ccs0 [244.380070] Dynamic subtest ccs0: SUCCESS (5.199s) [244.391277] Starting dynamic subtest: vcs0 [249.603109] Dynamic subtest vcs0: SUCCESS (5.222s) [249.613956] Starting dynamic subtest: bcs0 [254.819176] Dynamic subtest bcs0: SUCCESS (5.214s) [254.827170] Starting dynamic subtest: rcs0 [260.056517] Dynamic subtest rcs0: SUCCESS (5.236s) [260.067755] Starting dynamic subtest: vcs1 [265.314451] Dynamic subtest vcs1: SUCCESS (5.256s) [265.317536] Subtest mixed: SUCCESS (31.385s) [265.383895] [052/130] (759s left) kms_dp_link_training (non-uhbr-mst) [265.487043] Starting subtest: non-uhbr-mst [265.495337] Subtest non-uhbr-mst: SKIP (0.000s) [265.556132] [053/130] (759s left) gem_exec_params (invalid-bsd-ring) [265.622110] Starting subtest: invalid-bsd-ring [265.624414] Subtest invalid-bsd-ring: SUCCESS (0.000s) [265.721089] [054/130] (759s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [265.820937] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [265.831841] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s) [265.905451] [055/130] (759s left) gem_ctx_persistence (legacy-engines-mixed-process) [265.969449] Starting subtest: legacy-engines-mixed-process [265.971867] Starting dynamic subtest: render [267.969266] Dynamic subtest render: SUCCESS (1.997s) [267.979616] Starting dynamic subtest: bsd1 [269.947723] Dynamic subtest bsd1: SUCCESS (1.979s) [269.957957] Starting dynamic subtest: bsd2 [271.927563] Dynamic subtest bsd2: SUCCESS (1.978s) [271.938064] Starting dynamic subtest: blt [273.910336] Dynamic subtest blt: SUCCESS (1.981s) [273.919297] Starting dynamic subtest: vebox [275.969941] Dynamic subtest vebox: SUCCESS (2.054s) [275.972526] Subtest legacy-engines-mixed-process: SUCCESS (9.997s) [276.054409] [056/130] (749s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [276.119298] Starting subtest: multi-wait-for-submit-unsubmitted [276.225369] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [276.297174] [057/130] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [276.406184] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [276.410189] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [276.521259] [058/130] (748s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25) [276.616305] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25 [276.618617] Starting dynamic subtest: pipe-A [276.636696] Dynamic subtest pipe-A: SKIP (0.014s) [276.645659] Starting dynamic subtest: pipe-B [276.657766] Dynamic subtest pipe-B: SKIP (0.021s) [276.667634] Starting dynamic subtest: pipe-C [276.680265] Dynamic subtest pipe-C: SKIP (0.023s) [276.689898] Starting dynamic subtest: pipe-D [276.705880] Dynamic subtest pipe-D: SKIP (0.024s) [276.710351] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.083s) [276.799764] [059/130] (748s left) kms_psr (pr-primary-mmap-gtt) [276.898323] Starting subtest: pr-primary-mmap-gtt [276.902839] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [276.963998] [060/130] (748s left) gem_tiled_pread_basic [277.077304] [061/130] (748s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [277.203623] Starting subtest: cursorB-vs-flipA-legacy [277.208062] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s) [277.331040] [062/130] (748s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [277.399094] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [277.402838] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [277.576724] [063/130] (747s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [277.696483] Starting subtest: short-flip-before-cursor-toggle [278.611947] Subtest short-flip-before-cursor-toggle: SUCCESS (0.917s) [279.474354] [064/130] (745s left) kms_force_connector_basic (prune-stale-modes) [279.553258] Starting subtest: prune-stale-modes [279.953490] Subtest prune-stale-modes: SUCCESS (0.400s) [280.095589] [065/130] (745s left) kms_chamelium_edid (hdmi-mode-timings) [280.481360] Subtest hdmi-mode-timings: SKIP (0.000s) [281.270502] [066/130] (744s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [286.368265] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [286.370814] Starting dynamic subtest: pipe-A-eDP-1 [287.144375] Dynamic subtest pipe-A-eDP-1: SKIP (0.771s) [287.153102] Starting dynamic subtest: pipe-B-eDP-1 [288.345535] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s) [288.349596] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.974s) [289.490836] [067/130] (736s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [289.611883] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [297.784997] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.173s) [298.589191] [068/130] (726s left) perf (invalid-open-flags) [298.674564] Starting subtest: invalid-open-flags [298.676585] Subtest invalid-open-flags: SUCCESS (0.000s) [298.709615] [069/130] (726s left) prime_vgem (basic-read) [298.780083] Starting subtest: basic-read [298.797186] Subtest basic-read: SKIP (0.015s) [298.913369] [070/130] (726s left) kms_psr (fbc-psr-cursor-plane-onoff) [299.016634] Starting subtest: fbc-psr-cursor-plane-onoff [299.018951] Starting dynamic subtest: eDP-1 [299.023169] Dynamic subtest eDP-1: SKIP (0.000s) [299.027463] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [299.093404] [071/130] (726s left) gen9_exec_parse (bb-start-param) [299.151514] Subtest bb-start-param: SKIP (0.000s) [299.213568] [072/130] (726s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [299.320962] Starting subtest: fbc-farfromfence-mmap-gtt [299.325420] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [299.411373] [073/130] (726s left) core_setmaster (master-drop-set-shared-fd) [301.441878] Starting subtest: master-drop-set-shared-fd [301.461446] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [301.488209] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.amdgpu: true [301.488841] [FACT core_setmaster (master-drop-set-shared-fd)] new: kernel.kmod_is_loaded.xe: true [301.491959] [074/130] (724s left) gem_exec_schedule (submit-golden-slice) [301.566916] Starting subtest: submit-golden-slice [301.569230] Starting dynamic subtest: rcs0 [301.599069] Dynamic subtest rcs0: SUCCESS (0.038s) [301.610705] Starting dynamic subtest: bcs0 [301.633192] Dynamic subtest bcs0: SUCCESS (0.034s) [301.641998] Starting dynamic subtest: vcs0 [301.666041] Dynamic subtest vcs0: SUCCESS (0.032s) [301.677549] Starting dynamic subtest: vcs1 [301.700884] Dynamic subtest vcs1: SUCCESS (0.034s) [301.709882] Starting dynamic subtest: vecs0 [301.735810] Dynamic subtest vecs0: SUCCESS (0.034s) [301.750029] Starting dynamic subtest: ccs0 [301.772496] Dynamic subtest ccs0: SUCCESS (0.036s) [301.774761] Subtest submit-golden-slice: SUCCESS (0.212s) [303.081061] [075/130] (722s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [303.183141] Starting subtest: psr-rgb101010-draw-render [308.278306] Subtest psr-rgb101010-draw-render: SUCCESS (5.099s) [308.416083] [076/130] (717s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [308.519362] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [308.531283] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [308.649385] [077/130] (717s left) kms_frontbuffer_tracking (fbc-stridechange) [308.762731] Starting subtest: fbc-stridechange [311.072092] Subtest fbc-stridechange: SUCCESS (2.313s) [311.214136] [078/130] (714s left) drm_read (empty-nonblock) [311.374278] Starting subtest: empty-nonblock [311.376902] Subtest empty-nonblock: SUCCESS (0.000s) [311.498908] [079/130] (714s left) gem_pxp (fail-invalid-protected-context) [311.621769] Starting subtest: fail-invalid-protected-context [311.624083] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [311.724456] [080/130] (714s left) api_intel_allocator (gem-pool) [311.785400] Starting subtest: gem-pool [311.793127] Subtest gem-pool: SUCCESS (0.009s) [311.934414] [081/130] (714s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-out-visible-area) [311.992909] Subtest fbc-dirty-rectangle-out-visible-area: SKIP (0.000s) [312.041996] [082/130] (714s left) vgem_basic (dmabuf-fence-before) [312.081495] Starting subtest: dmabuf-fence-before [312.083347] Subtest dmabuf-fence-before: SUCCESS (0.000s) [312.130497] [083/130] (713s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [312.236403] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [313.448069] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.211s) [313.585189] [084/130] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt) [313.688034] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt [313.691657] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [313.788921] [085/130] (712s left) fbdev (info) [313.821040] Starting subtest: info [313.822719] Subtest info: SUCCESS (0.000s) [313.878434] [086/130] (712s left) drm_fdinfo (idle) [313.915762] Starting subtest: idle [313.917378] Starting dynamic subtest: rcs0 [314.496801] Dynamic subtest rcs0: SUCCESS (0.581s) [314.508069] Starting dynamic subtest: bcs0 [315.003879] Dynamic subtest bcs0: SUCCESS (0.503s) [315.015047] Starting dynamic subtest: vcs0 [315.509510] Dynamic subtest vcs0: SUCCESS (0.503s) [315.520298] Starting dynamic subtest: vcs1 [316.014885] Dynamic subtest vcs1: SUCCESS (0.503s) [316.025052] Starting dynamic subtest: vecs0 [316.521392] Dynamic subtest vecs0: SUCCESS (0.504s) [316.532705] Starting dynamic subtest: ccs0 [317.026909] Dynamic subtest ccs0: SUCCESS (0.503s) [317.029554] Subtest idle: SUCCESS (3.111s) [317.097410] [087/130] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [317.210441] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [317.214873] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [317.314701] [088/130] (708s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [317.414607] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [317.419064] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [317.524673] [089/130] (708s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [317.636692] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [320.202678] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.570s) [320.312438] [090/130] (706s left) kms_psr (psr-basic) [320.404108] Starting subtest: psr-basic [320.406130] Starting dynamic subtest: eDP-1 [322.041055] Dynamic subtest eDP-1: SUCCESS (1.634s) [322.043254] Subtest psr-basic: SUCCESS (1.635s) [322.888155] [091/130] (703s left) kms_addfb_basic (bad-pitch-256) [322.943755] Starting subtest: bad-pitch-256 [322.946098] Subtest bad-pitch-256: SUCCESS (0.000s) [323.094772] [092/130] (703s left) kms_vrr (flip-suspend) [323.196071] Starting subtest: flip-suspend [323.202651] Subtest flip-suspend: SKIP (0.000s) [323.264466] [093/130] (703s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [323.335560] Starting subtest: yf-tiled-ccs-to-y-tiled [323.340186] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [323.512249] [094/130] (702s left) gem_exec_endless (dispatch) [323.577752] Starting subtest: dispatch [323.580238] Starting dynamic subtest: rcs0 [323.588319] Dynamic subtest rcs0: SUCCESS (0.005s) [323.599837] Starting dynamic subtest: bcs0 [323.604697] Dynamic subtest bcs0: SUCCESS (0.007s) [323.614576] Starting dynamic subtest: vcs0 [323.618872] Dynamic subtest vcs0: SUCCESS (0.004s) [323.626713] Starting dynamic subtest: vcs1 [323.631111] Dynamic subtest vcs1: SUCCESS (0.005s) [323.638803] Starting dynamic subtest: vecs0 [323.643241] Dynamic subtest vecs0: SUCCESS (0.005s) [323.650827] Starting dynamic subtest: ccs0 [323.655384] Dynamic subtest ccs0: SUCCESS (0.004s) [323.657710] Subtest dispatch: SUCCESS (0.034s) [324.941834] [095/130] (701s left) prime_vgem (basic-fence-flip) [325.027493] Starting subtest: basic-fence-flip [325.327465] Subtest basic-fence-flip: SUCCESS (0.300s) [325.425593] [096/130] (701s left) gem_mmap_wc (set-cache-level) [325.496127] Subtest set-cache-level: SKIP (0.000s) [325.549297] [097/130] (701s left) gem_exercise_blt (fast-copy-emit) [325.608325] Starting subtest: fast-copy-emit [325.610676] Starting dynamic subtest: linear-smem-smem-emit [325.630400] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [325.638338] Starting dynamic subtest: xmajor-smem-smem-emit [325.648329] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [325.656248] Starting dynamic subtest: tile4-smem-smem-emit [325.666071] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [325.673819] Starting dynamic subtest: tile64-smem-smem-emit [325.683184] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [325.685690] Subtest fast-copy-emit: SUCCESS (0.075s) [325.805776] [098/130] (700s left) gem_softpin (softpin) [325.864298] Starting subtest: softpin [358.251346] Subtest softpin: SUCCESS (32.382s) [358.387226] [099/130] (668s left) kms_pm_dc (dc6-psr) [359.495947] Starting subtest: dc6-psr [366.706106] Subtest dc6-psr: FAIL (6.627s) [366.740008] [100/130] (659s left) kms_big_fb (y-tiled-8bpp-rotate-270) [366.833922] Starting subtest: y-tiled-8bpp-rotate-270 [366.838116] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [366.911248] [101/130] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [367.007140] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [370.277052] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (3.275s) [370.397012] [102/130] (656s left) kms_flip (2x-absolute-wf_vblank) [370.507308] Starting subtest: 2x-absolute-wf_vblank [370.518433] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [370.592090] [103/130] (656s left) sw_sync (alloc_timeline) [370.628887] Starting subtest: alloc_timeline [370.630839] Subtest alloc_timeline: SUCCESS (0.000s) [370.669259] [104/130] (656s left) gem_cs_tlb (engines) [370.732072] Starting subtest: engines [370.734101] Starting dynamic subtest: rcs0 [372.889057] Dynamic subtest rcs0: SUCCESS (2.152s) [372.899436] Starting dynamic subtest: bcs0 [375.042424] Dynamic subtest bcs0: SUCCESS (2.152s) [375.053366] Starting dynamic subtest: vcs0 [377.195892] Dynamic subtest vcs0: SUCCESS (2.153s) [377.207018] Starting dynamic subtest: vcs1 [379.350784] Dynamic subtest vcs1: SUCCESS (2.153s) [379.361469] Starting dynamic subtest: vecs0 [381.503571] Dynamic subtest vecs0: SUCCESS (2.153s) [381.514321] Starting dynamic subtest: ccs0 [383.659964] Dynamic subtest ccs0: SUCCESS (2.155s) [383.662076] Subtest engines: SUCCESS (12.924s) [383.790961] [105/130] (643s left) gem_unref_active_buffers [384.020900] [106/130] (642s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [384.128077] Starting subtest: crc-primary-basic-yf-tiled-ccs [384.130322] Starting dynamic subtest: pipe-A-eDP-1 [384.152716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [384.162934] Starting dynamic subtest: pipe-B-eDP-1 [384.184723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [384.192268] Starting dynamic subtest: pipe-C-eDP-1 [384.212971] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [384.220309] Starting dynamic subtest: pipe-D-eDP-1 [384.242138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [384.246492] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s) [386.386195] [107/130] (640s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [386.509121] Starting subtest: basic-flip-before-cursor-legacy [387.422958] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.916s) [388.282917] [108/130] (638s left) gem_exec_fence (syncobj-timeline-export) [388.844388] Starting subtest: syncobj-timeline-export [388.851073] Subtest syncobj-timeline-export: SUCCESS (0.006s) [389.992858] [109/130] (636s left) i915_pm_rps (thresholds) [390.054275] Starting subtest: thresholds [390.058786] Subtest thresholds: SKIP (0.000s) [390.125524] [110/130] (636s left) kms_invalid_mode (bad-hsync-start) [390.233154] Starting subtest: bad-hsync-start [390.235461] Starting dynamic subtest: pipe-A-eDP-1 [390.514743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [390.524604] Starting dynamic subtest: pipe-B-eDP-1 [390.526891] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [390.535040] Starting dynamic subtest: pipe-C-eDP-1 [390.537409] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [390.546061] Starting dynamic subtest: pipe-D-eDP-1 [390.548432] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [390.550956] Subtest bad-hsync-start: SUCCESS (0.286s) [391.379761] [111/130] (635s left) gem_spin_batch (user-each) [391.448289] Starting subtest: user-each [394.720676] Subtest user-each: SUCCESS (3.265s) [395.024430] [112/130] (632s left) kms_frontbuffer_tracking (fbc-1p-rte) [395.139430] Starting subtest: fbc-1p-rte [399.487297] Subtest fbc-1p-rte: SUCCESS (4.353s) [399.653544] [113/130] (627s left) kms_async_flips (crc-atomic) [399.768542] Starting subtest: crc-atomic [400.126060] Starting dynamic subtest: pipe-A-eDP-1 [403.056805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.930s) [403.440113] Starting dynamic subtest: pipe-B-eDP-1 [406.366628] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.934s) [406.728721] Starting dynamic subtest: pipe-C-eDP-1 [409.631870] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.911s) [409.988964] Starting dynamic subtest: pipe-D-eDP-1 [412.832484] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s) [412.834652] Subtest crc-atomic: SUCCESS (13.065s) [413.984958] [114/130] (613s left) prime_vgem (fence-read-hang) [414.082534] Subtest fence-read-hang: SKIP (0.000s) [414.187530] [115/130] (612s left) kms_atomic_transition (modeset-transition) [414.294758] Starting subtest: modeset-transition [414.296848] Starting dynamic subtest: 1x-outputs [424.881439] Dynamic subtest 1x-outputs: SUCCESS (10.587s) [425.155782] Subtest modeset-transition: SUCCESS (10.861s) [425.984965] [116/130] (601s left) kms_flip (nonexisting-fb-interruptible) [426.089745] Starting subtest: nonexisting-fb-interruptible [426.091954] Starting dynamic subtest: A-eDP1 [427.246215] Dynamic subtest A-eDP1: SUCCESS (1.154s) [427.255441] Starting dynamic subtest: B-eDP1 [428.448794] Dynamic subtest B-eDP1: SUCCESS (1.202s) [428.457673] Starting dynamic subtest: C-eDP1 [429.646403] Dynamic subtest C-eDP1: SUCCESS (1.197s) [429.655675] Starting dynamic subtest: D-eDP1 [430.845312] Dynamic subtest D-eDP1: SUCCESS (1.198s) [430.847707] Subtest nonexisting-fb-interruptible: SUCCESS (4.757s) [432.077776] [117/130] (595s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [432.175039] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [432.177168] Starting dynamic subtest: pipe-A-eDP-1 [432.202045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [432.211780] Starting dynamic subtest: pipe-B-eDP-1 [432.235594] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [432.244580] Starting dynamic subtest: pipe-C-eDP-1 [432.269175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [432.278871] Starting dynamic subtest: pipe-D-eDP-1 [432.303302] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [432.307754] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s) [434.379014] [118/130] (592s left) gem_exec_schedule (preempt-queue-chain) [434.456082] Subtest preempt-queue-chain: SKIP (0.000s) [434.746464] [119/130] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [434.852727] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [434.856931] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [434.947917] [120/130] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [435.051658] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [435.056263] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [435.149819] [121/130] (592s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [435.246852] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [435.249242] Starting dynamic subtest: pipe-A-eDP-1 [435.271592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [435.280087] Starting dynamic subtest: pipe-B-eDP-1 [435.301447] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [435.309199] Starting dynamic subtest: pipe-C-eDP-1 [435.330834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [435.338762] Starting dynamic subtest: pipe-D-eDP-1 [435.360752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [435.365162] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [437.478928] [122/130] (589s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [437.531989] Starting subtest: multi-wait-for-submit-available-submitted [437.534176] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [437.629325] [123/130] (589s left) kms_tiled_display (basic-test-pattern) [437.764085] Subtest basic-test-pattern: SKIP (0.000s) [437.803331] [124/130] (589s left) kms_lease (setcrtc-implicit-plane) [437.903762] Starting subtest: setcrtc-implicit-plane [437.906066] Starting dynamic subtest: pipe-A-eDP-1 [438.361758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s) [438.376190] Starting dynamic subtest: pipe-B-eDP-1 [439.477693] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.115s) [439.487146] Starting dynamic subtest: pipe-C-eDP-1 [440.565571] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.087s) [440.574868] Starting dynamic subtest: pipe-D-eDP-1 [441.666442] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s) [441.668801] Subtest setcrtc-implicit-plane: SUCCESS (3.762s) [442.475979] [125/130] (585s left) kms_psr (pr-sprite-mmap-cpu) [442.564284] Starting subtest: pr-sprite-mmap-cpu [442.568650] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [442.633204] [126/130] (584s left) kms_flip (flip-vs-fences) [442.740205] Starting subtest: flip-vs-fences [442.744635] Subtest flip-vs-fences: SKIP (0.000s) [442.857198] [127/130] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [442.965646] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [442.969955] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [443.046648] [128/130] (584s left) kms_atomic_interruptible (legacy-pageflip) [443.147312] Starting subtest: legacy-pageflip [443.149616] Starting dynamic subtest: pipe-A-eDP-1 [450.587975] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.440s) [450.589971] Subtest legacy-pageflip: SUCCESS (7.442s) [451.381442] [129/130] (576s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [451.494330] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [451.498331] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [451.604837] [130/130] (576s left) kms_plane (plane-position-hole-dpms) [451.699240] Starting subtest: plane-position-hole-dpms [452.225455] Starting dynamic subtest: pipe-A-plane-1 [454.584406] Dynamic subtest pipe-A-plane-1: SUCCESS (2.358s) [454.593276] Starting dynamic subtest: pipe-A-plane-2 [456.886702] Dynamic subtest pipe-A-plane-2: SUCCESS (2.301s) [456.896140] Starting dynamic subtest: pipe-A-plane-3 [459.185912] Dynamic subtest pipe-A-plane-3: SUCCESS (2.301s) [459.195688] Starting dynamic subtest: pipe-A-plane-4 [461.507366] Dynamic subtest pipe-A-plane-4: SUCCESS (2.320s) [461.516979] Starting dynamic subtest: pipe-A-plane-5 [461.547359] Dynamic subtest pipe-A-plane-5: SUCCESS (0.037s) [462.751560] Starting dynamic subtest: pipe-B-plane-1 [465.097069] Dynamic subtest pipe-B-plane-1: SUCCESS (2.352s) [465.106810] Starting dynamic subtest: pipe-B-plane-2 [467.406049] Dynamic subtest pipe-B-plane-2: SUCCESS (2.309s) [467.417430] Starting dynamic subtest: pipe-B-plane-3 [469.796246] Dynamic subtest pipe-B-plane-3: SUCCESS (2.388s) [469.810595] Starting dynamic subtest: pipe-B-plane-4 [472.083501] Dynamic subtest pipe-B-plane-4: SUCCESS (2.289s) [472.092797] Starting dynamic subtest: pipe-B-plane-5 [472.122687] Dynamic subtest pipe-B-plane-5: SUCCESS (0.037s) [472.124606] Subtest plane-position-hole-dpms: SUCCESS (20.421s) [472.873309] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_addfb_basic results: parsing output: 4/ for test: kms_cursor_crc results: parsing output: 5/ for test: kms_color results: parsing output: 6/ for test: kms_cursor_crc results: parsing output: 7/ for test: perf_pmu results: parsing output: 8/ for test: kms_getfb results: parsing output: 9/ for test: gem_ctx_persistence results: parsing output: 10/ for test: gem_exec_balancer results: parsing output: 11/ for test: gem_exec_reloc results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_prop_blob results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_plane_alpha_blend results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: gem_exec_parallel results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: gem_mmap_offset results: parsing output: 22/ for test: prime_vgem results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: i915_hangman results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: gen7_exec_parse results: parsing output: 30/ for test: gem_exec_params results: parsing output: 31/ for test: kms_psr2_su results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: syncobj_timeline results: parsing output: 34/ for test: kms_vblank results: parsing output: 35/ for test: gem_mmap_wc results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: gem_exec_whisper results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: kms_addfb_basic results: parsing output: 41/ for test: kms_getfb results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: perf_pmu results: parsing output: 44/ for test: kms_cursor_legacy results: parsing output: 45/ for test: kms_chamelium_hpd results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_mmap_gtt results: parsing output: 50/ for test: sysfs_heartbeat_interval results: parsing output: 51/ for test: kms_dp_link_training results: parsing output: 52/ for test: gem_exec_params results: parsing output: 53/ for test: kms_flip results: parsing output: 54/ for test: gem_ctx_persistence results: parsing output: 55/ for test: syncobj_wait results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_plane_scaling results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: gem_tiled_pread_basic results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: gem_render_copy results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: kms_force_connector_basic results: parsing output: 64/ for test: kms_chamelium_edid results: parsing output: 65/ for test: kms_psr2_sf results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: perf results: parsing output: 68/ for test: prime_vgem results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: gen9_exec_parse results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: core_setmaster results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: drm_read results: parsing output: 78/ for test: gem_pxp results: parsing output: 79/ for test: api_intel_allocator results: parsing output: 80/ for test: kms_fbc_dirty_rect results: parsing output: 81/ for test: vgem_basic results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: fbdev results: parsing output: 85/ for test: drm_fdinfo results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_psr results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_vrr results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: gem_exec_endless results: parsing output: 94/ for test: prime_vgem results: parsing output: 95/ for test: gem_mmap_wc results: parsing output: 96/ for test: gem_exercise_blt results: parsing output: 97/ for test: gem_softpin results: parsing output: 98/ for test: kms_pm_dc results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: gem_cs_tlb results: parsing output: 104/ for test: gem_unref_active_buffers results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_cursor_legacy results: parsing output: 107/ for test: gem_exec_fence results: parsing output: 108/ for test: i915_pm_rps results: parsing output: 109/ for test: kms_invalid_mode results: parsing output: 110/ for test: gem_spin_batch results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_async_flips results: parsing output: 113/ for test: prime_vgem results: parsing output: 114/ for test: kms_atomic_transition results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_ccs results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: kms_tiled_display results: parsing output: 123/ for test: kms_lease results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_flip results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_atomic_interruptible results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_plane Done.