[61.920013] Initializing watchdogs [61.920122] /dev/watchdog0 [61.940038] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [61.950988] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [61.955063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.957582] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [62.140135] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [62.141856] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s) [62.274051] [002/133] (960s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [62.466041] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [62.467792] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [62.646458] [003/133] (959s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [62.831428] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [62.833369] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [63.028252] [004/133] (959s left) prime_mmap_coherency (ioctl-errors) [63.114385] Starting subtest: ioctl-errors [68.464006] Subtest ioctl-errors: SUCCESS (5.354s) [68.720813] [005/133] (954s left) perf (non-sampling-read-error) [69.191856] Starting subtest: non-sampling-read-error [69.208747] Subtest non-sampling-read-error: SUCCESS (0.018s) [69.258595] [006/133] (953s left) core_getversion (basic) [69.314954] Starting subtest: basic [69.316885] Subtest basic: SUCCESS (0.000s) [69.454994] [007/133] (953s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset) [69.643486] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset [69.658589] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.015s) [69.781554] [008/133] (953s left) api_intel_allocator (execbuf-with-allocator) [69.858957] Starting subtest: execbuf-with-allocator [69.887381] Subtest execbuf-with-allocator: SUCCESS (0.028s) [70.047528] [009/133] (952s left) tools_test (sysfs_l3_parity) [70.095169] Starting subtest: sysfs_l3_parity [70.169228] Subtest sysfs_l3_parity: SKIP (0.078s) [70.324735] [010/133] (952s left) kms_invalid_mode (bad-htotal) [70.502624] Starting subtest: bad-htotal [70.503485] Starting dynamic subtest: pipe-A-DP-3 [70.577231] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s) [70.586902] Starting dynamic subtest: pipe-B-DP-3 [70.588176] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [70.597593] Starting dynamic subtest: pipe-C-DP-3 [70.598792] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [70.608150] Starting dynamic subtest: pipe-D-DP-3 [70.609127] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [70.610071] Subtest bad-htotal: SUCCESS (0.080s) [70.853066] [011/133] (952s left) kms_getfb (getfb2-handle-closed) [71.033492] Starting subtest: getfb2-handle-closed [71.034404] Subtest getfb2-handle-closed: SUCCESS (0.000s) [71.210136] [012/133] (952s left) gen3_mixed_blits [71.347937] [013/133] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [71.529393] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [71.531113] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [71.663377] [014/133] (951s left) kms_cursor_crc (cursor-tearing-position-change) [71.895159] Starting subtest: cursor-tearing-position-change [71.897094] Starting dynamic subtest: pipe-A-DP-3 [72.407299] Dynamic subtest pipe-A-DP-3: SUCCESS (0.511s) [72.428580] Starting dynamic subtest: pipe-D-DP-3 [72.862372] Dynamic subtest pipe-D-DP-3: SUCCESS (0.452s) [72.863296] Subtest cursor-tearing-position-change: SUCCESS (0.967s) [73.453498] [015/133] (949s left) kms_flip (absolute-wf_vblank) [73.629747] Starting subtest: absolute-wf_vblank [73.633581] Starting dynamic subtest: A-DP3 [81.650513] Dynamic subtest A-DP3: SUCCESS (8.021s) [81.662155] Starting dynamic subtest: B-DP3 [89.577897] Dynamic subtest B-DP3: SUCCESS (7.931s) [89.587361] Starting dynamic subtest: C-DP3 [97.512391] Dynamic subtest C-DP3: SUCCESS (7.937s) [97.521576] Starting dynamic subtest: D-DP3 [105.454234] Dynamic subtest D-DP3: SUCCESS (7.943s) [105.456139] Subtest absolute-wf_vblank: SUCCESS (31.841s) [105.816430] [016/133] (917s left) kms_pm_backlight (basic-brightness) [105.992603] Subtest basic-brightness: SKIP (0.000s) [106.040282] [017/133] (917s left) kms_color (ctm-max) [106.216416] Starting subtest: ctm-max [106.217301] Starting dynamic subtest: pipe-A-DP-3 [106.901799] Dynamic subtest pipe-A-DP-3: SUCCESS (0.685s) [106.923283] Starting dynamic subtest: pipe-B-DP-3 [107.521331] Dynamic subtest pipe-B-DP-3: SUCCESS (0.619s) [107.532393] Starting dynamic subtest: pipe-C-DP-3 [108.095335] Dynamic subtest pipe-C-DP-3: SUCCESS (0.574s) [108.106335] Starting dynamic subtest: pipe-D-DP-3 [108.705700] Dynamic subtest pipe-D-DP-3: SUCCESS (0.610s) [108.706696] Subtest ctm-max: SUCCESS (2.490s) [109.040011] [018/133] (914s left) gem_exec_params (rel-constants-invalid) [109.114250] Starting subtest: rel-constants-invalid [109.115166] Subtest rel-constants-invalid: SUCCESS (0.000s) [109.263493] [019/133] (914s left) gem_exec_schedule (noreorder-corked) [109.488683] Starting subtest: noreorder-corked [109.490461] Starting dynamic subtest: rcs0 [110.655431] Dynamic subtest rcs0: SUCCESS (1.167s) [110.665870] Starting dynamic subtest: bcs0 [111.801520] Dynamic subtest bcs0: SUCCESS (1.146s) [111.812292] Starting dynamic subtest: vcs0 [112.937244] Dynamic subtest vcs0: SUCCESS (1.136s) [112.947283] Starting dynamic subtest: vcs1 [114.060255] Dynamic subtest vcs1: SUCCESS (1.123s) [114.069447] Starting dynamic subtest: vecs0 [115.199348] Dynamic subtest vecs0: SUCCESS (1.139s) [115.209503] Starting dynamic subtest: vecs1 [116.348438] Dynamic subtest vecs1: SUCCESS (1.149s) [116.360043] Starting dynamic subtest: ccs0 [117.452542] Dynamic subtest ccs0: SUCCESS (1.104s) [117.453470] Subtest noreorder-corked: SUCCESS (7.966s) [117.714871] [020/133] (906s left) gem_mmap_gtt (cpuset-medium-copy-xy) [117.783668] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [117.848626] [021/133] (905s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [118.103489] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [118.248090] [022/133] (905s left) gem_exec_whisper (basic-contexts-priority-all) [118.330304] Starting subtest: basic-contexts-priority-all [140.747276] Subtest basic-contexts-priority-all: SUCCESS (22.418s) [141.013854] [023/133] (882s left) gen9_exec_parse (allowed-all) [141.086065] Subtest allowed-all: SKIP (0.000s) [141.149013] [024/133] (882s left) perf_pmu (busy-accuracy-98) [141.209780] Starting subtest: busy-accuracy-98 [141.210649] Starting dynamic subtest: rcs0 [144.274507] Dynamic subtest rcs0: SUCCESS (3.061s) [144.313171] Starting dynamic subtest: bcs0 [147.366934] Dynamic subtest bcs0: SUCCESS (3.091s) [147.377302] Starting dynamic subtest: vcs0 [150.418369] Dynamic subtest vcs0: SUCCESS (3.050s) [150.428551] Starting dynamic subtest: vcs1 [153.473490] Dynamic subtest vcs1: SUCCESS (3.054s) [153.484155] Starting dynamic subtest: vecs0 [156.526812] Dynamic subtest vecs0: SUCCESS (3.052s) [156.537130] Starting dynamic subtest: vecs1 [159.581648] Dynamic subtest vecs1: SUCCESS (3.054s) [159.591996] Starting dynamic subtest: ccs0 [162.637799] Dynamic subtest ccs0: SUCCESS (3.055s) [162.638619] Subtest busy-accuracy-98: SUCCESS (21.418s) [162.867638] [025/133] (861s left) gem_workarounds (suspend-resume-fd) [162.951997] Starting subtest: suspend-resume-fd [182.472971] Subtest suspend-resume-fd: SUCCESS (3.757s) [182.632911] [026/133] (841s left) kms_psr (fbc-pr-sprite-plane-move) [182.814249] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [182.875559] [027/133] (841s left) syncobj_wait (invalid-wait-bad-flags) [182.943221] Starting subtest: invalid-wait-bad-flags [182.944182] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [183.103266] [028/133] (841s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [183.286720] Starting subtest: fbc-rgb565-draw-mmap-wc [183.288377] Subtest fbc-rgb565-draw-mmap-wc: SKIP (0.000s) [183.460267] [029/133] (840s left) kms_addfb_basic (unused-offsets) [183.534437] Starting subtest: unused-offsets [183.535412] Subtest unused-offsets: SUCCESS (0.000s) [183.818767] [030/133] (840s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [183.887217] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [183.888330] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [184.066208] [031/133] (840s left) kms_psr (fbc-pr-cursor-plane-move) [184.251820] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [184.309393] [032/133] (840s left) kms_psr (psr-cursor-render) [184.505274] Subtest psr-cursor-render: SKIP (0.000s) [184.548620] [033/133] (840s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [184.728613] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [184.744319] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.015s) [184.904967] [034/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [185.087602] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [185.089369] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [185.215143] [035/133] (839s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [185.395240] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [185.396910] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [185.515512] [036/133] (839s left) kms_addfb_basic (invalid-get-prop) [185.589216] Starting subtest: invalid-get-prop [185.590108] Subtest invalid-get-prop: SUCCESS (0.000s) [185.885082] [037/133] (838s left) gem_softpin (evict-prime-sanity-check) [185.964819] Starting subtest: evict-prime-sanity-check [185.965676] Starting dynamic subtest: rcs0 [187.131521] Dynamic subtest rcs0: SUCCESS (1.167s) [187.143603] Starting dynamic subtest: bcs0 [188.265802] Dynamic subtest bcs0: SUCCESS (1.134s) [188.282491] Starting dynamic subtest: vcs0 [189.388636] Dynamic subtest vcs0: SUCCESS (1.122s) [189.401500] Starting dynamic subtest: vcs1 [190.524706] Dynamic subtest vcs1: SUCCESS (1.136s) [190.538615] Starting dynamic subtest: vecs0 [191.659697] Dynamic subtest vecs0: SUCCESS (1.135s) [191.673244] Starting dynamic subtest: vecs1 [192.786605] Dynamic subtest vecs1: SUCCESS (1.126s) [192.799315] Starting dynamic subtest: ccs0 [193.892541] Dynamic subtest ccs0: SUCCESS (1.106s) [193.904685] Starting dynamic subtest: all [195.004499] Dynamic subtest all: SUCCESS (1.112s) [195.005638] Subtest evict-prime-sanity-check: SUCCESS (9.040s) [195.178991] [038/133] (829s left) i915_suspend (fence-restore-untiled) [195.267410] Starting subtest: fence-restore-untiled [195.269191] Subtest fence-restore-untiled: SKIP (0.000s) [195.428033] [039/133] (829s left) kms_psr (psr-sprite-mmap-gtt) [195.605585] Subtest psr-sprite-mmap-gtt: SKIP (0.000s) [195.660050] [040/133] (829s left) gem_userptr_blits (unsync-unmap) [195.735815] Subtest unsync-unmap: SKIP (0.000s) [195.962435] [041/133] (829s left) gem_exec_balancer (bonded-true-hang) [196.295648] Starting subtest: bonded-true-hang [196.297418] Subtest bonded-true-hang: SKIP (0.000s) [196.455728] [042/133] (828s left) gem_lmem_swapping (parallel-random-engines) [199.305005] Starting subtest: parallel-random-engines [199.305775] Starting dynamic subtest: lmem0 [239.133520] Dynamic subtest lmem0: SUCCESS (39.825s) [239.134559] Subtest parallel-random-engines: SUCCESS (39.826s) [240.275512] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [240.277137] [043/133] (784s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [241.892567] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [241.894464] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [242.107121] [FACT gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)] new: kernel.kmod_is_loaded.i915: true [242.109764] [044/133] (783s left) syncobj_timeline (etime-single-wait-all-submitted) [242.181754] Starting subtest: etime-single-wait-all-submitted [242.289330] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s) [242.431596] [045/133] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [242.614655] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [242.616294] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [242.817427] [046/133] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [243.003828] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [243.005493] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [243.187382] [047/133] (782s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [243.363197] Starting subtest: short-busy-flip-before-cursor-toggle [243.364945] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [243.521276] [048/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [243.707709] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [243.709390] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [243.901267] [049/133] (781s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [244.076499] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [244.077403] Starting dynamic subtest: pipe-A-DP-3 [244.085684] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [244.096602] Starting dynamic subtest: pipe-B-DP-3 [244.104812] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [244.116474] Starting dynamic subtest: pipe-C-DP-3 [244.124615] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [244.135454] Starting dynamic subtest: pipe-D-DP-3 [244.145270] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [244.147381] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s) [244.547453] [050/133] (781s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [244.724693] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [244.725612] Starting dynamic subtest: pipe-A-DP-3 [244.734120] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [244.745056] Starting dynamic subtest: pipe-B-DP-3 [244.753300] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [244.763887] Starting dynamic subtest: pipe-C-DP-3 [244.772004] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [244.782591] Starting dynamic subtest: pipe-D-DP-3 [244.792721] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [244.794697] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [245.204610] [051/133] (780s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [245.387663] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [245.389369] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [245.590458] [052/133] (780s left) gem_partial_pwrite_pread (reads-snoop) [245.667573] Subtest reads-snoop: SKIP (0.000s) [245.732887] [053/133] (780s left) syncobj_timeline (invalid-query-illegal-handle) [245.800267] Starting subtest: invalid-query-illegal-handle [245.801187] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [245.959532] [054/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [246.139834] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [246.141459] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [246.329230] [055/133] (779s left) kms_lease (lease-unleased-connector) [246.511683] Starting subtest: lease-unleased-connector [246.513765] Starting dynamic subtest: pipe-A-DP-3 [246.618549] Dynamic subtest pipe-A-DP-3: SUCCESS (0.106s) [246.630956] Starting dynamic subtest: pipe-B-DP-3 [246.726974] Dynamic subtest pipe-B-DP-3: SUCCESS (0.107s) [246.739434] Starting dynamic subtest: pipe-C-DP-3 [246.847255] Dynamic subtest pipe-C-DP-3: SUCCESS (0.115s) [246.892776] Starting dynamic subtest: pipe-D-DP-3 [246.975134] Dynamic subtest pipe-D-DP-3: SUCCESS (0.125s) [246.975970] Subtest lease-unleased-connector: SUCCESS (0.464s) [247.132643] [056/133] (779s left) syncobj_wait (invalid-single-wait-unsubmitted) [247.206546] Starting subtest: invalid-single-wait-unsubmitted [247.207503] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [247.392133] [057/133] (778s left) gem_mmap_gtt (ptrace) [247.462398] Subtest ptrace: SKIP (0.000s) [247.539678] [058/133] (778s left) syncobj_timeline (multi-wait-submitted-signaled) [247.608381] Starting subtest: multi-wait-submitted-signaled [247.609243] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [247.789908] [059/133] (778s left) gem_madvise (dontneed-before-exec) [247.832456] Starting subtest: dontneed-before-exec [247.860214] Subtest dontneed-before-exec: SKIP (0.027s) [247.934818] [060/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [248.123759] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [248.125522] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [248.322786] [061/133] (778s left) gem_ccs (ctrl-surf-copy-new-ctx) [248.406556] Starting subtest: ctrl-surf-copy-new-ctx [248.407476] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0 [248.471257] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.064s) [248.483735] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0 [248.694599] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.209s) [248.705810] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0 [248.712817] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.031s) [248.724533] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0 [248.885621] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.172s) [248.896771] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0 [248.916359] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.030s) [248.927975] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0 [249.089380] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.172s) [249.100652] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0 [249.118500] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s) [249.129958] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0 [249.296424] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.177s) [249.297453] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.890s) [249.488740] [062/133] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [249.669803] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [252.327964] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.659s) [252.538238] [063/133] (774s left) syncobj_wait (single-wait-all-for-submit-signaled) [252.604483] Starting subtest: single-wait-all-for-submit-signaled [252.605444] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [252.775489] [064/133] (773s left) gem_ctx_isolation (nonpriv-switch) [252.858059] Starting subtest: nonpriv-switch [252.858931] Starting dynamic subtest: rcs0 [253.737161] Dynamic subtest rcs0: SUCCESS (0.879s) [253.749484] Starting dynamic subtest: bcs0 [254.653106] Dynamic subtest bcs0: SUCCESS (0.915s) [254.664874] Starting dynamic subtest: vcs0 [255.572625] Dynamic subtest vcs0: SUCCESS (0.919s) [255.584750] Starting dynamic subtest: vcs1 [256.499455] Dynamic subtest vcs1: SUCCESS (0.926s) [256.511423] Starting dynamic subtest: vecs0 [257.391393] Dynamic subtest vecs0: SUCCESS (0.891s) [257.403683] Starting dynamic subtest: vecs1 [258.340004] Dynamic subtest vecs1: SUCCESS (0.948s) [258.351702] Starting dynamic subtest: ccs0 [259.288700] Dynamic subtest ccs0: SUCCESS (0.948s) [259.289644] Subtest nonpriv-switch: SUCCESS (6.431s) [259.621505] [065/133] (767s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [259.800529] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [259.802238] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [259.934089] [066/133] (766s left) i915_drm_fdinfo (most-busy-check-all) [259.995696] Starting subtest: most-busy-check-all [259.996666] Starting dynamic subtest: rcs0 [260.023702] Dynamic subtest rcs0: SKIP (0.027s) [260.036115] Starting dynamic subtest: bcs0 [260.038490] Dynamic subtest bcs0: SKIP (0.000s) [260.050166] Starting dynamic subtest: vcs0 [260.052387] Dynamic subtest vcs0: SKIP (0.000s) [260.063630] Starting dynamic subtest: vcs1 [260.065754] Dynamic subtest vcs1: SKIP (0.001s) [260.076752] Starting dynamic subtest: vecs0 [260.078756] Dynamic subtest vecs0: SKIP (0.000s) [260.090164] Starting dynamic subtest: vecs1 [260.092469] Dynamic subtest vecs1: SKIP (0.000s) [260.106430] Starting dynamic subtest: ccs0 [260.108881] Dynamic subtest ccs0: SKIP (0.001s) [260.111106] Subtest most-busy-check-all: SKIP (0.034s) [260.153123] [067/133] (766s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [260.367949] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [260.419119] [068/133] (766s left) gem_create (create-ext-placement-each) [260.599656] Starting subtest: create-ext-placement-each [260.600548] Subtest create-ext-placement-each: SUCCESS (0.000s) [260.804980] [069/133] (766s left) gen7_exec_parse (basic-allocation) [260.881331] Subtest basic-allocation: SKIP (0.000s) [260.951957] [070/133] (766s left) api_intel_bb (intel-bb-blit-none) [261.019463] Starting subtest: intel-bb-blit-none [261.713208] Subtest intel-bb-blit-none: SUCCESS (0.693s) [261.875250] [071/133] (765s left) kms_chamelium_hpd (vga-hpd) [262.140159] Subtest vga-hpd: SKIP (0.000s) [262.290253] [072/133] (764s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [262.360424] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [262.428121] [073/133] (764s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [262.502701] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s) [262.614607] [074/133] (764s left) i915_pm_rps (reset) [262.703303] Starting subtest: reset [267.781255] Subtest reset: SUCCESS (5.077s) [268.025103] [075/133] (759s left) kms_cursor_legacy (cursor-vs-flip-legacy) [268.204447] Starting subtest: cursor-vs-flip-legacy [298.611971] Subtest cursor-vs-flip-legacy: SUCCESS (30.410s) [298.932463] [076/133] (728s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [299.112351] Starting subtest: crc-primary-suspend-yf-tiled-ccs [299.113214] Starting dynamic subtest: pipe-A-DP-3 [299.116451] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [299.129443] Starting dynamic subtest: pipe-B-DP-3 [299.132932] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [299.145652] Starting dynamic subtest: pipe-C-DP-3 [299.149140] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [299.161679] Starting dynamic subtest: pipe-D-DP-3 [299.165228] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [299.166857] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.006s) [299.573855] [077/133] (728s left) gem_exec_balancer (parallel-keep-in-fence) [299.943329] Starting subtest: parallel-keep-in-fence [302.204823] Subtest parallel-keep-in-fence: SUCCESS (2.262s) [302.381852] [078/133] (725s left) prime_busy (after-wait) [302.456735] Starting subtest: after-wait [302.461553] Starting dynamic subtest: rcs0 [302.513759] Dynamic subtest rcs0: SUCCESS (0.052s) [302.526870] Starting dynamic subtest: bcs0 [302.566718] Dynamic subtest bcs0: SUCCESS (0.052s) [302.589399] Starting dynamic subtest: vcs0 [302.608835] Dynamic subtest vcs0: SUCCESS (0.041s) [302.631946] Starting dynamic subtest: vcs1 [302.650545] Dynamic subtest vcs1: SUCCESS (0.041s) [302.668164] Starting dynamic subtest: vecs0 [302.692178] Dynamic subtest vecs0: SUCCESS (0.041s) [302.709849] Starting dynamic subtest: vecs1 [302.732009] Dynamic subtest vecs1: SUCCESS (0.039s) [302.749562] Starting dynamic subtest: ccs0 [302.771805] Dynamic subtest ccs0: SUCCESS (0.039s) [302.881392] Subtest after-wait: SUCCESS (0.422s) [303.090026] [079/133] (724s left) gem_exec_schedule (u-independent) [303.169634] Starting subtest: u-independent [303.170555] Starting dynamic subtest: rcs0 [303.604592] Dynamic subtest rcs0: SUCCESS (0.435s) [303.618709] Starting dynamic subtest: bcs0 [303.983656] Dynamic subtest bcs0: SUCCESS (0.378s) [303.999482] Starting dynamic subtest: vcs0 [304.363711] Dynamic subtest vcs0: SUCCESS (0.379s) [304.383460] Starting dynamic subtest: vcs1 [304.748961] Dynamic subtest vcs1: SUCCESS (0.384s) [304.766321] Starting dynamic subtest: vecs0 [305.141572] Dynamic subtest vecs0: SUCCESS (0.392s) [305.155794] Starting dynamic subtest: vecs1 [305.542820] Dynamic subtest vecs1: SUCCESS (0.400s) [305.568208] Starting dynamic subtest: ccs0 [305.896740] Dynamic subtest ccs0: SUCCESS (0.353s) [305.897881] Subtest u-independent: SUCCESS (2.728s) [306.310094] [080/133] (721s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [306.491381] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [306.556824] [081/133] (721s left) kms_sequence (queue-busy) [306.741198] Starting subtest: queue-busy [306.742119] Starting dynamic subtest: pipe-A-DP-3 [309.320429] Dynamic subtest pipe-A-DP-3: SUCCESS (2.578s) [309.335245] Starting dynamic subtest: pipe-B-DP-3 [311.806405] Dynamic subtest pipe-B-DP-3: SUCCESS (2.484s) [311.825803] Starting dynamic subtest: pipe-C-DP-3 [314.320081] Dynamic subtest pipe-C-DP-3: SUCCESS (2.512s) [314.334550] Starting dynamic subtest: pipe-D-DP-3 [316.797493] Dynamic subtest pipe-D-DP-3: SUCCESS (2.476s) [316.798393] Subtest queue-busy: SUCCESS (10.056s) [317.109499] [082/133] (710s left) kms_chamelium_audio (hdmi-audio) [317.370818] Subtest hdmi-audio: SKIP (0.000s) [317.524148] [083/133] (710s left) gem_mmap_gtt (big-bo-tiledy) [317.598425] Subtest big-bo-tiledY: SKIP (0.000s) [317.663485] [084/133] (710s left) gem_mmap_wc (write-prefaulted) [317.740391] Subtest write-prefaulted: SKIP (0.000s) [317.853691] [085/133] (710s left) gem_exec_fence (syncobj-unused-fence) [318.423499] Starting subtest: syncobj-unused-fence [318.452075] Subtest syncobj-unused-fence: SUCCESS (0.028s) [318.901287] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [318.903184] [086/133] (709s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [318.981755] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [319.088504] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s) [319.251272] [087/133] (709s left) i915_hangman (engine-engine-hang) [319.346338] Starting subtest: engine-engine-hang [319.347163] Starting dynamic subtest: rcs0 [320.212158] Dynamic subtest rcs0: SUCCESS (0.865s) [320.231997] Starting dynamic subtest: bcs0 [320.961589] Dynamic subtest bcs0: SUCCESS (0.748s) [320.975494] Starting dynamic subtest: vcs0 [321.803966] Dynamic subtest vcs0: SUCCESS (0.841s) [321.822054] Starting dynamic subtest: vcs1 [322.588791] Dynamic subtest vcs1: SUCCESS (0.784s) [322.604029] Starting dynamic subtest: vecs0 [323.393641] Dynamic subtest vecs0: SUCCESS (0.804s) [323.407511] Starting dynamic subtest: vecs1 [324.196625] Dynamic subtest vecs1: SUCCESS (0.802s) [324.210460] Starting dynamic subtest: ccs0 [325.030819] Dynamic subtest ccs0: SUCCESS (0.833s) [325.031810] Subtest engine-engine-hang: SUCCESS (5.685s) [325.186485] [088/133] (703s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [325.372720] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [325.374869] Starting dynamic subtest: pipe-A-DP-3 [325.396190] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [325.409350] Starting dynamic subtest: pipe-B-DP-3 [325.430436] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [325.443584] Starting dynamic subtest: pipe-C-DP-3 [325.469175] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [325.483035] Starting dynamic subtest: pipe-D-DP-3 [325.504224] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [325.506455] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.013s) [325.866012] [089/133] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [326.056215] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [326.057874] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [326.246392] [090/133] (702s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [326.427774] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [326.429547] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [326.578590] [091/133] (702s left) prime_mmap (test_map_unmap) [326.653757] Starting subtest: test_map_unmap [326.654664] Starting dynamic subtest: test_map_unmap-smem [326.702892] Dynamic subtest test_map_unmap-smem: SUCCESS (0.049s) [326.716193] Starting dynamic subtest: test_map_unmap-lmem0 [326.894747] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.191s) [326.895682] Subtest test_map_unmap: SUCCESS (0.241s) [327.037889] [092/133] (701s left) prime_self_import (basic-with_two_bos) [327.085330] Starting subtest: basic-with_two_bos [327.129616] Subtest basic-with_two_bos: SUCCESS (0.045s) [327.308105] [093/133] (701s left) sysfs_preempt_timeout (invalid) [327.392952] Starting subtest: invalid [327.393814] Starting dynamic subtest: vecs0 [327.394698] Dynamic subtest vecs0: SUCCESS (0.000s) [327.408180] Starting dynamic subtest: ccs0 [327.409516] Dynamic subtest ccs0: SUCCESS (0.000s) [327.422874] Starting dynamic subtest: vcs0 [327.423927] Dynamic subtest vcs0: SUCCESS (0.000s) [327.437305] Starting dynamic subtest: bcs0 [327.438416] Dynamic subtest bcs0: SUCCESS (0.000s) [327.451320] Starting dynamic subtest: vecs1 [327.452230] Dynamic subtest vecs1: SUCCESS (0.000s) [327.468111] Starting dynamic subtest: rcs0 [327.469209] Dynamic subtest rcs0: SUCCESS (0.000s) [327.482068] Starting dynamic subtest: vcs1 [327.482898] Dynamic subtest vcs1: SUCCESS (0.000s) [327.483714] Subtest invalid: SUCCESS (0.009s) [327.572893] [094/133] (701s left) kms_big_fb (linear-64bpp-rotate-180) [327.766724] Starting subtest: linear-64bpp-rotate-180 [329.797308] Subtest linear-64bpp-rotate-180: SUCCESS (2.029s) [330.046403] [095/133] (698s left) gem_tiled_pread_pwrite [330.192627] [096/133] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [330.383011] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [333.663412] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (3.281s) [333.845609] [097/133] (695s left) gem_fence_thrash (bo-write-verify-y) [333.892681] Starting subtest: bo-write-verify-y [333.930380] Subtest bo-write-verify-y: SKIP (0.037s) [334.011852] [098/133] (695s left) kms_big_fb (4-tiled-addfb) [334.205247] Starting subtest: 4-tiled-addfb [334.206179] Subtest 4-tiled-addfb: SUCCESS (0.000s) [334.414165] [099/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [334.608016] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [337.763355] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.156s) [338.014158] [100/133] (691s left) gem_exec_fence (syncobj-timeline-chain-engines) [338.691335] Starting subtest: syncobj-timeline-chain-engines [338.849546] Subtest syncobj-timeline-chain-engines: SUCCESS (0.158s) [339.232800] [101/133] (690s left) kms_pm_rpm (modeset-non-lpsp) [340.829900] Starting subtest: modeset-non-lpsp [341.449877] Subtest modeset-non-lpsp: SUCCESS (0.622s) [341.747818] [102/133] (687s left) kms_addfb_basic (addfb25-x-tiled-legacy) [341.938349] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [342.149094] [103/133] (687s left) kms_cursor_crc (cursor-size-hints) [342.407749] Starting subtest: cursor-size-hints [342.409932] Starting dynamic subtest: pipe-A-DP-3 [343.031604] Dynamic subtest pipe-A-DP-3: SUCCESS (0.622s) [343.047826] Starting dynamic subtest: pipe-D-DP-3 [343.529317] Dynamic subtest pipe-D-DP-3: SUCCESS (0.496s) [343.530249] Subtest cursor-size-hints: SUCCESS (1.122s) [344.107732] [104/133] (685s left) kms_big_fb (yf-tiled-addfb-size-overflow) [344.308522] Starting subtest: yf-tiled-addfb-size-overflow [344.310429] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [344.520520] [105/133] (685s left) gem_pxp (verify-pxp-stale-ctx-execution) [347.125837] Starting subtest: verify-pxp-stale-ctx-execution [347.128095] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s) [347.267717] [106/133] (682s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [347.463237] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [348.753499] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.290s) [348.991310] [107/133] (680s left) kms_psr (psr2-cursor-mmap-cpu) [349.176877] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s) [349.249827] [108/133] (680s left) kms_psr (fbc-psr-sprite-plane-onoff) [349.440872] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s) [349.499423] [109/133] (680s left) kms_pm_rpm (fences-dpms) [351.820696] Starting subtest: fences-dpms [351.822876] Subtest fences-dpms: SKIP (0.000s) [352.264473] [110/133] (677s left) prime_mmap_coherency (read) [352.371161] Starting subtest: read [357.778321] Subtest read: SUCCESS (5.406s) [357.933046] [111/133] (672s left) gem_exec_fence (basic-busy-all) [358.019622] Starting subtest: basic-busy-all [358.161875] Subtest basic-busy-all: SUCCESS (0.141s) [359.086018] [112/133] (671s left) prime_vgem (basic-fence-flip) [359.183531] Starting subtest: basic-fence-flip [359.299374] Subtest basic-fence-flip: SKIP (0.116s) [359.515488] [113/133] (670s left) syncobj_wait (invalid-signal-bad-pad) [359.596698] Starting subtest: invalid-signal-bad-pad [359.597599] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [359.784981] [114/133] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [359.978043] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [359.979641] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [360.183734] [115/133] (670s left) kms_big_fb (x-tiled-addfb) [360.379835] Starting subtest: x-tiled-addfb [360.380690] Subtest x-tiled-addfb: SUCCESS (0.000s) [360.542876] [116/133] (670s left) gem_ctx_persistence (legacy-engines-hostile) [360.631218] Starting subtest: legacy-engines-hostile [360.632202] Starting dynamic subtest: render [360.739700] Dynamic subtest render: SUCCESS (0.108s) [360.763221] Starting dynamic subtest: bsd1 [360.832492] Dynamic subtest bsd1: SUCCESS (0.090s) [360.880175] Starting dynamic subtest: bsd2 [360.886503] Dynamic subtest bsd2: SUCCESS (0.050s) [360.903523] Starting dynamic subtest: blt [360.934566] Dynamic subtest blt: SUCCESS (0.047s) [360.950199] Starting dynamic subtest: vebox [361.031482] Dynamic subtest vebox: SUCCESS (0.095s) [361.036904] Subtest legacy-engines-hostile: SUCCESS (0.402s) [361.245737] [117/133] (669s left) kms_big_fb (4-tiled-16bpp-rotate-180) [361.438643] Starting subtest: 4-tiled-16bpp-rotate-180 [363.212185] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.773s) [363.431315] [118/133] (667s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [363.623616] Starting subtest: compare-crc-sanitycheck-nv12 [363.624486] Starting dynamic subtest: pipe-A-DP-3 [364.402390] Dynamic subtest pipe-A-DP-3: SUCCESS (0.777s) [364.417511] Starting dynamic subtest: pipe-B-DP-3 [365.033212] Dynamic subtest pipe-B-DP-3: SUCCESS (0.630s) [365.049251] Starting dynamic subtest: pipe-C-DP-3 [365.632949] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s) [365.648574] Starting dynamic subtest: pipe-D-DP-3 [366.244159] Dynamic subtest pipe-D-DP-3: SUCCESS (0.609s) [366.245022] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.622s) [366.548462] [119/133] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [366.737317] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [366.739076] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [366.946184] [120/133] (663s left) kms_flip (wf_vblank-ts-check-interruptible) [367.139436] Starting subtest: wf_vblank-ts-check-interruptible [367.144208] Starting dynamic subtest: A-DP3 [375.251818] Dynamic subtest A-DP3: SUCCESS (8.108s) [375.270633] Starting dynamic subtest: B-DP3 [383.288675] Dynamic subtest B-DP3: SUCCESS (8.035s) [383.304786] Starting dynamic subtest: C-DP3 [391.318823] Dynamic subtest C-DP3: SUCCESS (8.029s) [391.335112] Starting dynamic subtest: D-DP3 [399.351701] Dynamic subtest D-DP3: SUCCESS (8.032s) [399.353948] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.215s) [399.737058] [121/133] (631s left) gem_eio (create) [400.063667] Starting subtest: create [400.541397] Subtest create: SUCCESS (0.478s) [400.821190] [122/133] (630s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [401.076512] Starting subtest: dp-mst-lic-type-0-hdcp14 [401.078391] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [401.283767] [123/133] (629s left) kms_vblank (query-idle) [401.474028] Starting subtest: query-idle [401.476521] Starting dynamic subtest: pipe-A-DP-3 [403.807425] Dynamic subtest pipe-A-DP-3: SUCCESS (2.329s) [403.834795] Starting dynamic subtest: pipe-D-DP-3 [406.062343] Dynamic subtest pipe-D-DP-3: SUCCESS (2.247s) [406.063141] Subtest query-idle: SUCCESS (4.588s) [406.317692] [124/133] (624s left) kms_plane_scaling (invalid-num-scalers) [406.500674] Starting subtest: invalid-num-scalers [406.507241] Starting dynamic subtest: pipe-A-DP-3-invalid-num-scalers [406.529766] Dynamic subtest pipe-A-DP-3-invalid-num-scalers: SUCCESS (0.021s) [406.549670] Starting dynamic subtest: pipe-B-DP-3-invalid-num-scalers [406.574106] Dynamic subtest pipe-B-DP-3-invalid-num-scalers: SUCCESS (0.037s) [406.594479] Starting dynamic subtest: pipe-C-DP-3-invalid-num-scalers [406.619165] Dynamic subtest pipe-C-DP-3-invalid-num-scalers: SUCCESS (0.037s) [406.639714] Starting dynamic subtest: pipe-D-DP-3-invalid-num-scalers [406.664701] Dynamic subtest pipe-D-DP-3-invalid-num-scalers: SUCCESS (0.037s) [406.665421] Subtest invalid-num-scalers: SUCCESS (0.165s) [406.880417] [125/133] (624s left) kms_cursor_crc (cursor-onscreen-512x170) [407.361636] Starting subtest: cursor-onscreen-512x170 [407.363431] Subtest cursor-onscreen-512x170: SKIP (0.001s) [407.655454] [126/133] (623s left) kms_rotation_crc (primary-rotation-270) [407.844541] Starting subtest: primary-rotation-270 [407.846290] Subtest primary-rotation-270: SKIP (0.001s) [408.014505] [127/133] (623s left) perf (invalid-oa-metric-set-id) [408.442821] Starting subtest: invalid-oa-metric-set-id [408.460727] Subtest invalid-oa-metric-set-id: SUCCESS (0.018s) [408.519689] [128/133] (623s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [408.598626] Starting subtest: single-wait-all-for-submit-available-submitted [408.599569] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [408.803266] [129/133] (622s left) kms_draw_crc (draw-method-render) [408.989698] Starting subtest: draw-method-render [408.990584] Starting dynamic subtest: xrgb8888-untiled [409.370183] Dynamic subtest xrgb8888-untiled: SUCCESS (0.380s) [409.388790] Starting dynamic subtest: rgb565-untiled [409.703378] Dynamic subtest rgb565-untiled: SUCCESS (0.328s) [409.721579] Starting dynamic subtest: xrgb2101010-untiled [410.019770] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.312s) [410.065651] Starting dynamic subtest: xbgr16161616f-untiled [410.368609] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.345s) [410.387370] Starting dynamic subtest: xrgb8888-xtiled [410.537856] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.167s) [410.586307] Starting dynamic subtest: rgb565-xtiled [410.736832] Dynamic subtest rgb565-xtiled: SUCCESS (0.194s) [410.784178] Starting dynamic subtest: xrgb2101010-xtiled [410.919871] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.178s) [410.963799] Starting dynamic subtest: xbgr16161616f-xtiled [411.103283] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.179s) [411.148824] Starting dynamic subtest: xrgb8888-4tiled [411.303502] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.195s) [411.350802] Starting dynamic subtest: rgb565-4tiled [411.486890] Dynamic subtest rgb565-4tiled: SUCCESS (0.178s) [411.533467] Starting dynamic subtest: xrgb2101010-4tiled [411.668721] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.178s) [411.685323] Starting dynamic subtest: xbgr16161616f-4tiled [411.819985] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.149s) [411.825653] Subtest draw-method-render: SUCCESS (2.833s) [412.010887] [130/133] (619s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [412.195696] Starting subtest: basic-flip-before-cursor-legacy [413.229256] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.034s) [413.589452] [131/133] (618s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [413.786338] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [413.788089] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [413.974711] [132/133] (617s left) perf_pmu (idle-no-semaphores) [414.044586] Starting subtest: idle-no-semaphores [414.045523] Starting dynamic subtest: rcs0 [414.623905] Dynamic subtest rcs0: SUCCESS (0.578s) [414.641863] Starting dynamic subtest: bcs0 [415.143545] Dynamic subtest bcs0: SUCCESS (0.515s) [415.161122] Starting dynamic subtest: vcs0 [415.662630] Dynamic subtest vcs0: SUCCESS (0.514s) [415.680178] Starting dynamic subtest: vcs1 [416.181586] Dynamic subtest vcs1: SUCCESS (0.514s) [416.199946] Starting dynamic subtest: vecs0 [416.699617] Dynamic subtest vecs0: SUCCESS (0.513s) [416.717519] Starting dynamic subtest: vecs1 [417.215559] Dynamic subtest vecs1: SUCCESS (0.511s) [417.233401] Starting dynamic subtest: ccs0 [417.733601] Dynamic subtest ccs0: SUCCESS (0.513s) [417.737722] Subtest idle-no-semaphores: SUCCESS (3.691s) [417.908763] [133/133] (614s left) syncobj_wait (multi-wait-all-for-submit-signaled) [417.986615] Starting subtest: multi-wait-all-for-submit-signaled [417.987558] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [418.139616] Closing watchdogs results: parsing output: 0/ for test: kms_plane results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: prime_mmap_coherency results: parsing output: 4/ for test: perf results: parsing output: 5/ for test: core_getversion results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: api_intel_allocator results: parsing output: 8/ for test: tools_test results: parsing output: 9/ for test: kms_invalid_mode results: parsing output: 10/ for test: kms_getfb results: parsing output: 11/ for test: gen3_mixed_blits results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_flip results: parsing output: 15/ for test: kms_pm_backlight results: parsing output: 16/ for test: kms_color results: parsing output: 17/ for test: gem_exec_params results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: kms_chamelium_frames results: parsing output: 21/ for test: gem_exec_whisper results: parsing output: 22/ for test: gen9_exec_parse results: parsing output: 23/ for test: perf_pmu results: parsing output: 24/ for test: gem_workarounds results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_flip_scaled_crc results: parsing output: 35/ for test: kms_addfb_basic results: parsing output: 36/ for test: gem_softpin results: parsing output: 37/ for test: i915_suspend results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: gem_exec_balancer results: parsing output: 41/ for test: gem_lmem_swapping results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_partial_pwrite_pread results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_lease results: parsing output: 55/ for test: syncobj_wait results: parsing output: 56/ for test: gem_mmap_gtt results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: gem_madvise results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_ccs results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: syncobj_wait results: parsing output: 63/ for test: gem_ctx_isolation results: parsing output: 64/ for test: kms_flip_scaled_crc results: parsing output: 65/ for test: i915_drm_fdinfo results: parsing output: 66/ for test: kms_psr2_sf results: parsing output: 67/ for test: gem_create results: parsing output: 68/ for test: gen7_exec_parse results: parsing output: 69/ for test: api_intel_bb results: parsing output: 70/ for test: kms_chamelium_hpd results: parsing output: 71/ for test: kms_pipe_b_c_ivb results: parsing output: 72/ for test: gem_exec_reloc results: parsing output: 73/ for test: i915_pm_rps results: parsing output: 74/ for test: kms_cursor_legacy results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: prime_busy results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_psr2_sf results: parsing output: 80/ for test: kms_sequence results: parsing output: 81/ for test: kms_chamelium_audio results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: gem_mmap_wc results: parsing output: 84/ for test: gem_exec_fence results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: i915_hangman results: parsing output: 87/ for test: kms_ccs results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: prime_mmap results: parsing output: 91/ for test: prime_self_import results: parsing output: 92/ for test: sysfs_preempt_timeout results: parsing output: 93/ for test: kms_big_fb results: parsing output: 94/ for test: gem_tiled_pread_pwrite results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_fence_thrash results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_exec_fence results: parsing output: 100/ for test: kms_pm_rpm results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: kms_cursor_crc results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_pxp results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: kms_pm_rpm results: parsing output: 109/ for test: prime_mmap_coherency results: parsing output: 110/ for test: gem_exec_fence results: parsing output: 111/ for test: prime_vgem results: parsing output: 112/ for test: syncobj_wait results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: gem_ctx_persistence results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_eio results: parsing output: 121/ for test: kms_content_protection results: parsing output: 122/ for test: kms_vblank results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_rotation_crc results: parsing output: 126/ for test: perf results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: kms_draw_crc results: parsing output: 129/ for test: kms_cursor_legacy results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: perf_pmu results: parsing output: 132/ for test: syncobj_wait Done.