[57.359167] Initializing watchdogs [57.359227] /dev/watchdog0 [57.371024] [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] [57.374742] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.376894] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.380169] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [57.544817] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [62.716087] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.173s) [62.838818] [002/131] (955s left) kms_psr (fbc-pr-sprite-plane-move) [62.943845] Starting subtest: fbc-pr-sprite-plane-move [62.948277] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [63.007403] [003/131] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [63.109717] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [63.114082] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [63.198647] [004/131] (954s left) kms_fbcon_fbt (psr-suspend) [63.255131] Starting subtest: psr-suspend [110.319486] Subtest psr-suspend: SUCCESS (17.849s) [110.395675] [005/131] (936s left) kms_plane_alpha_blend (alpha-transparent-fb) [110.490868] Starting subtest: alpha-transparent-fb [110.897518] Starting dynamic subtest: pipe-A-eDP-1 [111.471035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s) [111.480706] Starting dynamic subtest: pipe-D-eDP-1 [112.780864] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s) [112.782920] Subtest alpha-transparent-fb: SUCCESS (2.285s) [113.606831] [006/131] (933s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [118.675884] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [118.678012] Starting dynamic subtest: pipe-A-eDP-1 [119.459159] Dynamic subtest pipe-A-eDP-1: SKIP (0.780s) [119.468609] Starting dynamic subtest: pipe-B-eDP-1 [120.581160] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s) [120.585481] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.904s) [121.757077] [007/131] (925s left) kms_atomic (atomic-invalid-params) [121.861930] Starting subtest: atomic-invalid-params [121.864368] Starting dynamic subtest: pipe-A-eDP-1 [122.285030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s) [122.287574] Subtest atomic-invalid-params: SUCCESS (0.422s) [123.091303] [008/131] (924s left) kms_big_fb (4-tiled-addfb-size-overflow) [123.200920] Starting subtest: 4-tiled-addfb-size-overflow [123.203071] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [123.290034] [009/131] (924s left) api_intel_bb (lot-of-buffers) [123.347450] Starting subtest: lot-of-buffers [124.255640] Subtest lot-of-buffers: SUCCESS (0.909s) [124.646239] [010/131] (922s left) kms_chamelium_hpd (common-hpd-after-suspend) [125.038037] Subtest common-hpd-after-suspend: SKIP (0.000s) [125.793689] [011/131] (921s left) kms_vblank (wait-idle-hang) [125.896888] Starting subtest: wait-idle-hang [125.899411] Starting dynamic subtest: pipe-A-eDP-1 [151.864248] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.960s) [151.876824] Starting dynamic subtest: pipe-D-eDP-1 [176.899199] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s) [176.901262] Subtest wait-idle-hang: SUCCESS (50.994s) [177.678447] [012/131] (869s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [177.774373] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [177.776939] Starting dynamic subtest: pipe-A-eDP-1 [194.411879] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.412s) [194.422303] Starting dynamic subtest: pipe-B-eDP-1 [211.315753] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.320s) [211.324045] Starting dynamic subtest: pipe-C-eDP-1 [228.276821] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.266s) [228.285072] Starting dynamic subtest: pipe-D-eDP-1 [245.279086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.229s) [245.281759] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.230s) [246.378211] [013/131] (860s left) prime_mmap (test_invalid_sync_flags) [246.445753] Starting subtest: test_invalid_sync_flags [246.448902] Starting dynamic subtest: test_invalid_sync_flags-smem [246.451939] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [246.454577] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [246.529300] [014/131] (860s left) kms_lease (empty-lease) [246.625405] Starting subtest: empty-lease [246.627979] Starting dynamic subtest: pipe-A-eDP-1 [246.630364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [246.640593] Starting dynamic subtest: pipe-B-eDP-1 [246.643027] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [246.650251] Starting dynamic subtest: pipe-C-eDP-1 [246.652857] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [246.660687] Starting dynamic subtest: pipe-D-eDP-1 [246.663089] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [246.665853] Subtest empty-lease: SUCCESS (0.006s) [246.743009] [015/131] (860s left) syncobj_wait (invalid-signal-bad-pad) [246.793060] Starting subtest: invalid-signal-bad-pad [246.795511] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [246.878103] [016/131] (859s left) kms_pm_dc (dc3co-vpb-simulation) [247.981059] Starting subtest: dc3co-vpb-simulation [256.950054] Subtest dc3co-vpb-simulation: SKIP (8.963s) [257.062428] [017/131] (849s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [257.158952] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling [257.161793] Starting dynamic subtest: pipe-A-default-mode [259.885879] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s) [259.888903] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.725s) [260.660483] [018/131] (846s left) perf (invalid-oa-metric-set-id) [260.779225] Starting subtest: invalid-oa-metric-set-id [260.795071] Subtest invalid-oa-metric-set-id: SUCCESS (0.017s) [260.827567] [019/131] (846s left) gem_vm_create (isolation) [260.886232] Starting subtest: isolation [260.895737] Subtest isolation: SUCCESS (0.009s) [261.019685] [020/131] (845s left) syncobj_timeline (single-wait-all-signaled) [261.072056] Starting subtest: single-wait-all-signaled [261.074881] Subtest single-wait-all-signaled: SUCCESS (0.001s) [261.175359] [021/131] (845s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [261.278861] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [261.284008] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [261.358763] [022/131] (845s left) i915_pm_rpm (system-suspend-execbuf) [263.594658] Starting subtest: system-suspend-execbuf [322.148879] Subtest system-suspend-execbuf: SUCCESS (42.992s) [322.516349] [023/131] (800s left) kms_cursor_crc (cursor-random-256x256) [322.731620] Starting subtest: cursor-random-256x256 [322.734165] Starting dynamic subtest: pipe-A-eDP-1 [326.535882] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.798s) [326.566650] Starting dynamic subtest: pipe-D-eDP-1 [330.923686] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.362s) [330.925828] Subtest cursor-random-256x256: SUCCESS (8.188s) [331.736325] [024/131] (790s left) gem_exec_params (secure-non-master) [331.790326] Starting subtest: secure-non-master [331.795572] Subtest secure-non-master: SKIP (0.000s) [331.899782] [025/131] (790s left) kms_flip (flip-vs-rmfb) [332.002150] Starting subtest: flip-vs-rmfb [332.004866] Starting dynamic subtest: A-eDP1 [340.736012] Dynamic subtest A-eDP1: SUCCESS (8.730s) [340.743353] Starting dynamic subtest: B-eDP1 [349.466975] Dynamic subtest B-eDP1: SUCCESS (8.726s) [349.475038] Starting dynamic subtest: C-eDP1 [358.183989] Dynamic subtest C-eDP1: SUCCESS (8.713s) [358.192570] Starting dynamic subtest: D-eDP1 [366.807129] Dynamic subtest D-eDP1: SUCCESS (8.619s) [366.809533] Subtest flip-vs-rmfb: SUCCESS (34.795s) [367.971189] [026/131] (754s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [368.062403] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [368.064812] Starting dynamic subtest: pipe-A-eDP-1 [368.090399] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [368.097712] Starting dynamic subtest: pipe-B-eDP-1 [368.123927] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [368.131965] Starting dynamic subtest: pipe-C-eDP-1 [368.157993] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [368.164867] Starting dynamic subtest: pipe-D-eDP-1 [368.190992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [368.196442] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [370.220617] [027/131] (752s left) gem_mmap_gtt (big-bo-tiledy) [370.279418] Subtest big-bo-tiledY: SKIP (0.000s) [370.338303] [028/131] (752s left) gem_exec_reloc (basic-gtt-wc-noreloc) [370.401971] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [370.475385] [029/131] (752s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [370.578706] Starting subtest: yf-tiled-8bpp-rotate-90 [370.583988] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [370.678155] [030/131] (752s left) kms_atomic_transition (plane-all-transition) [370.786834] Starting subtest: plane-all-transition [370.788950] Starting dynamic subtest: pipe-A-eDP-1 [373.290857] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s) [373.586724] Starting dynamic subtest: pipe-B-eDP-1 [376.863600] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s) [377.139161] Subtest plane-all-transition: SUCCESS (6.352s) [377.970483] [031/131] (744s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [378.036462] Starting subtest: x-tiled-to-vebox-y-tiled [378.041957] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [378.210609] [032/131] (744s left) gem_tiled_wb [378.335938] [033/131] (744s left) api_intel_bb (object-reloc-purge-cache) [378.400631] Starting subtest: object-reloc-purge-cache [378.405861] Subtest object-reloc-purge-cache: SKIP (0.003s) [378.524778] [034/131] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [378.625011] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [378.630119] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [378.713521] [035/131] (744s left) gem_ctx_sseu (mmap-args) [378.771930] Subtest mmap-args: SKIP (0.000s) [378.853885] [036/131] (744s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [383.829746] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [383.832283] Starting dynamic subtest: pipe-A-eDP-1 [390.424965] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.599s) [390.433186] Starting dynamic subtest: pipe-B-eDP-1 [397.043675] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.623s) [397.046700] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.226s) [397.913748] [037/131] (725s left) kms_big_fb (y-tiled-8bpp-rotate-90) [398.014172] Starting subtest: y-tiled-8bpp-rotate-90 [398.018947] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [398.116166] [038/131] (725s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [398.214617] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [398.216978] Starting dynamic subtest: pipe-A-default-mode [398.500167] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [398.504962] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.282s) [399.334428] [039/131] (723s left) gem_lmem_evict (dontneed-evict-race) [399.384120] Subtest dontneed-evict-race: SKIP (0.000s) [399.418201] [040/131] (723s left) kms_atomic (plane-primary-overlay-mutable-zpos) [399.514109] Starting subtest: plane-primary-overlay-mutable-zpos [402.960872] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.443s) [404.130772] [041/131] (719s left) gem_exec_fence (syncobj-invalid-flags) [404.580913] Starting subtest: syncobj-invalid-flags [404.583859] Subtest syncobj-invalid-flags: SUCCESS (0.001s) [406.020346] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [406.024209] [042/131] (717s left) gem_partial_pwrite_pread (write) [406.094155] Subtest write: SKIP (0.000s) [406.159034] [043/131] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [406.273700] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [406.278843] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [406.381382] [044/131] (716s left) gem_exec_schedule (fifo) [406.455975] Starting subtest: fifo [406.457957] Starting dynamic subtest: rcs0 [406.555127] Dynamic subtest rcs0: SUCCESS (0.110s) [406.565926] Starting dynamic subtest: vcs0 [406.635420] Dynamic subtest vcs0: SUCCESS (0.079s) [406.643729] Starting dynamic subtest: vcs1 [406.710532] Dynamic subtest vcs1: SUCCESS (0.074s) [406.721930] Starting dynamic subtest: vecs0 [406.780570] Dynamic subtest vecs0: SUCCESS (0.070s) [406.790951] Starting dynamic subtest: ccs0 [406.855245] Dynamic subtest ccs0: SUCCESS (0.073s) [406.858171] Subtest fifo: SUCCESS (0.409s) [408.024890] [045/131] (715s left) kms_psr (fbc-psr-primary-page-flip) [408.119894] Starting subtest: fbc-psr-primary-page-flip [408.122509] Starting dynamic subtest: eDP-1 [408.127149] Dynamic subtest eDP-1: SKIP (0.000s) [408.131765] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [408.189185] [046/131] (715s left) vgem_basic (second-client) [408.237142] Starting subtest: second-client [408.258413] Subtest second-client: SUCCESS (0.021s) [408.313567] [047/131] (715s left) gem_softpin (evict-single-offset) [408.367916] Starting subtest: evict-single-offset [434.934736] Subtest evict-single-offset: SUCCESS (26.568s) [435.022681] [048/131] (688s left) kms_addfb_basic (unused-offsets) [435.108763] Starting subtest: unused-offsets [435.111185] Subtest unused-offsets: SUCCESS (0.000s) [435.243135] [049/131] (688s left) kms_vblank (wait-busy) [435.342847] Starting subtest: wait-busy [435.345375] Starting dynamic subtest: pipe-A-eDP-1 [437.240922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s) [437.254670] Starting dynamic subtest: pipe-D-eDP-1 [439.789135] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s) [439.791316] Subtest wait-busy: SUCCESS (4.443s) [440.580018] [050/131] (682s left) perf (gen12-mi-rpc) [440.706139] Starting subtest: gen12-mi-rpc [440.709057] Starting dynamic subtest: rcs0 [440.731372] Dynamic subtest rcs0: SUCCESS (0.022s) [440.733781] Subtest gen12-mi-rpc: SUCCESS (0.023s) [440.770578] [051/131] (682s left) tools_test (tools_test) [440.824654] Starting subtest: tools_test [440.880966] Subtest tools_test: SUCCESS (0.078s) [440.938537] [052/131] (682s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [441.033199] Starting subtest: etime-single-wait-all-available-unsubmitted [441.137460] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s) [441.205642] [053/131] (682s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [441.308336] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [445.811770] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.506s) [445.926644] [054/131] (677s left) kms_big_fb (x-tiled-16bpp-rotate-180) [446.038666] Starting subtest: x-tiled-16bpp-rotate-180 [447.515418] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.477s) [447.653513] [055/131] (676s left) i915_module_load (reload-no-display) [447.691742] Starting subtest: reload-no-display [452.572041] Subtest reload-no-display: SUCCESS (4.878s) [452.597409] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [452.598121] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [452.601630] [056/131] (671s left) gem_mmap_gtt (big-bo-tiledx) [454.090453] Subtest big-bo-tiledX: SKIP (0.000s) [454.146733] [FACT gem_mmap_gtt (big-bo-tiledx)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [454.149062] [FACT gem_mmap_gtt (big-bo-tiledx)] new: kernel.kmod_is_loaded.i915: true [454.153004] [057/131] (669s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [454.285017] Starting subtest: cursorB-vs-flipB-atomic-transitions [454.290116] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [454.376604] [058/131] (669s left) gem_close (basic) [454.441441] Starting subtest: basic [454.444053] Subtest basic: SUCCESS (0.000s) [454.515251] [059/131] (669s left) kms_cursor_crc (cursor-rapid-movement-64x64) [454.678466] Starting subtest: cursor-rapid-movement-64x64 [454.690145] Starting dynamic subtest: pipe-A-eDP-1 [455.273517] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s) [455.303152] Starting dynamic subtest: pipe-D-eDP-1 [456.524042] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [456.526799] Subtest cursor-rapid-movement-64x64: SUCCESS (1.844s) [457.364258] [060/131] (666s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [457.475200] Starting subtest: psr-modesetfrombusy [461.531872] Subtest psr-modesetfrombusy: SUCCESS (4.061s) [461.699213] [061/131] (662s left) sysfs_heartbeat_interval (mixed) [461.757806] Starting subtest: mixed [461.760161] Starting dynamic subtest: vecs0 [467.019877] Dynamic subtest vecs0: SUCCESS (5.260s) [467.032160] Starting dynamic subtest: ccs0 [472.242504] Dynamic subtest ccs0: SUCCESS (5.219s) [472.252322] Starting dynamic subtest: vcs0 [477.456270] Dynamic subtest vcs0: SUCCESS (5.211s) [477.465317] Starting dynamic subtest: bcs0 [482.671832] Dynamic subtest bcs0: SUCCESS (5.213s) [482.681460] Starting dynamic subtest: rcs0 [487.852463] Dynamic subtest rcs0: SUCCESS (5.178s) [487.864048] Starting dynamic subtest: vcs1 [493.066152] Dynamic subtest vcs1: SUCCESS (5.212s) [493.069490] Subtest mixed: SUCCESS (31.302s) [493.140356] [062/131] (630s left) gem_exec_reloc (basic-write-read-active) [493.200172] Subtest basic-write-read-active: SKIP (0.000s) [493.262365] [063/131] (630s left) gem_lmem_swapping (verify-random-ccs) [493.309945] Subtest verify-random-ccs: SKIP (0.000s) [493.341983] [064/131] (630s left) gem_exec_reloc (basic-write-cpu-noreloc) [493.406131] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [493.466279] [065/131] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [493.575989] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [493.580995] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [493.688790] [066/131] (630s left) kms_addfb_basic (tile-pitch-mismatch) [493.748588] Starting subtest: tile-pitch-mismatch [493.753147] Subtest tile-pitch-mismatch: SKIP (0.000s) [493.917452] [067/131] (630s left) kms_addfb_basic (basic-x-tiled-legacy) [493.981651] Starting subtest: basic-x-tiled-legacy [493.986529] Subtest basic-x-tiled-legacy: SKIP (0.000s) [494.128446] [068/131] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [494.240778] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [494.245001] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [494.351748] [069/131] (629s left) drm_fdinfo (busy-idle) [494.398319] Starting subtest: busy-idle [494.400365] Starting dynamic subtest: rcs0 [494.420451] Dynamic subtest rcs0: SKIP (0.022s) [494.429324] Starting dynamic subtest: bcs0 [494.433556] Dynamic subtest bcs0: SKIP (0.000s) [494.441940] Starting dynamic subtest: vcs0 [494.446780] Dynamic subtest vcs0: SKIP (0.000s) [494.454656] Starting dynamic subtest: vcs1 [494.459009] Dynamic subtest vcs1: SKIP (0.000s) [494.467918] Starting dynamic subtest: vecs0 [494.472601] Dynamic subtest vecs0: SKIP (0.000s) [494.480067] Starting dynamic subtest: ccs0 [494.484623] Dynamic subtest ccs0: SKIP (0.000s) [494.489165] Subtest busy-idle: SKIP (0.027s) [494.533840] [070/131] (629s left) gem_set_tiling_vs_pwrite [494.657093] [071/131] (629s left) kms_psr (fbc-psr-dpms) [494.755763] Starting subtest: fbc-psr-dpms [494.757951] Starting dynamic subtest: eDP-1 [494.762394] Dynamic subtest eDP-1: SKIP (0.000s) [494.767031] Subtest fbc-psr-dpms: SKIP (0.001s) [494.826271] [072/131] (629s left) perf_pmu (idle) [494.869200] Starting subtest: idle [494.872175] Starting dynamic subtest: rcs0 [495.422392] Dynamic subtest rcs0: SUCCESS (0.553s) [495.434268] Starting dynamic subtest: bcs0 [495.945207] Dynamic subtest bcs0: SUCCESS (0.516s) [495.955922] Starting dynamic subtest: vcs0 [496.462215] Dynamic subtest vcs0: SUCCESS (0.519s) [496.474411] Starting dynamic subtest: vcs1 [496.985588] Dynamic subtest vcs1: SUCCESS (0.521s) [496.996964] Starting dynamic subtest: vecs0 [497.507137] Dynamic subtest vecs0: SUCCESS (0.515s) [497.517833] Starting dynamic subtest: ccs0 [498.020141] Dynamic subtest ccs0: SUCCESS (0.515s) [498.023156] Subtest idle: SUCCESS (3.152s) [498.110486] [073/131] (626s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [498.228994] Starting subtest: 2x-cursor-vs-flip-atomic [498.234898] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [498.322626] [074/131] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [498.420910] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [498.425838] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [498.503540] [075/131] (626s left) kms_plane (plane-position-covered) [498.603154] Starting subtest: plane-position-covered [499.116116] Starting dynamic subtest: pipe-A-plane-1 [500.390620] Dynamic subtest pipe-A-plane-1: SUCCESS (1.273s) [500.400500] Starting dynamic subtest: pipe-A-plane-2 [501.627886] Dynamic subtest pipe-A-plane-2: SUCCESS (1.239s) [501.636940] Starting dynamic subtest: pipe-A-plane-3 [502.831160] Dynamic subtest pipe-A-plane-3: SUCCESS (1.201s) [502.841154] Starting dynamic subtest: pipe-A-plane-4 [504.058621] Dynamic subtest pipe-A-plane-4: SUCCESS (1.226s) [504.069122] Starting dynamic subtest: pipe-A-plane-5 [504.094557] Dynamic subtest pipe-A-plane-5: SUCCESS (0.035s) [505.211130] Starting dynamic subtest: pipe-B-plane-1 [506.421727] Dynamic subtest pipe-B-plane-1: SUCCESS (1.217s) [506.431902] Starting dynamic subtest: pipe-B-plane-2 [507.631136] Dynamic subtest pipe-B-plane-2: SUCCESS (1.210s) [507.642071] Starting dynamic subtest: pipe-B-plane-3 [508.852037] Dynamic subtest pipe-B-plane-3: SUCCESS (1.220s) [508.861866] Starting dynamic subtest: pipe-B-plane-4 [510.095838] Dynamic subtest pipe-B-plane-4: SUCCESS (1.243s) [510.104150] Starting dynamic subtest: pipe-B-plane-5 [510.136652] Dynamic subtest pipe-B-plane-5: SUCCESS (0.040s) [510.138757] Subtest plane-position-covered: SUCCESS (11.528s) [510.892210] [076/131] (613s left) kms_plane_scaling (planes-downscale-factor-0-5) [510.982907] Starting subtest: planes-downscale-factor-0-5 [510.985458] Starting dynamic subtest: pipe-A [510.995237] Dynamic subtest pipe-A: SKIP (0.005s) [511.010789] Starting dynamic subtest: pipe-B [511.019989] Dynamic subtest pipe-B: SKIP (0.015s) [511.028413] Starting dynamic subtest: pipe-C [511.037194] Dynamic subtest pipe-C: SKIP (0.019s) [511.045780] Starting dynamic subtest: pipe-D [511.055882] Dynamic subtest pipe-D: SKIP (0.015s) [511.060946] Subtest planes-downscale-factor-0-5: SKIP (0.056s) [511.125868] [077/131] (613s left) kms_prime (d3hot) [513.398877] Subtest D3hot: SKIP (0.000s) [513.471487] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.amdgpu: true [513.472166] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.xe: true [513.475881] [078/131] (611s left) gem_mmap_wc (write-read-distinct) [513.546836] Subtest write-read-distinct: SKIP (0.000s) [513.612659] [079/131] (611s left) gem_exec_schedule (semaphore-codependency) [513.698820] Starting subtest: semaphore-codependency [513.705221] Subtest semaphore-codependency: SUCCESS (0.015s) [514.084663] [080/131] (610s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [514.188386] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [514.191026] Starting dynamic subtest: pipe-A-default-mode [515.343315] Dynamic subtest pipe-A-default-mode: SKIP (1.149s) [515.348998] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.150s) [515.512832] [081/131] (609s left) kms_dirtyfb (default-dirtyfb-ioctl) [515.611946] Starting subtest: default-dirtyfb-ioctl [515.614779] Starting dynamic subtest: A-eDP-1 [517.244127] Dynamic subtest A-eDP-1: SUCCESS (1.629s) [517.246798] Subtest default-dirtyfb-ioctl: SUCCESS (1.630s) [518.038596] [082/131] (606s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [518.147475] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [522.705856] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.564s) [522.814468] [083/131] (601s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [522.926865] Starting subtest: extended-modeset-hang-oldfb-with-reset [522.929405] Starting dynamic subtest: pipe-A [534.566332] Dynamic subtest pipe-A: SUCCESS (11.639s) [534.576814] Starting dynamic subtest: pipe-D [546.811186] Dynamic subtest pipe-D: SUCCESS (12.247s) [546.814383] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.889s) [547.593643] [084/131] (577s left) gem_workarounds (basic-read-fd) [547.660883] Starting subtest: basic-read-fd [547.672831] Subtest basic-read-fd: SUCCESS (0.012s) [547.818332] [085/131] (577s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [547.874753] Starting subtest: wait-all-for-submit-delayed-submit [547.976175] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [548.049851] [086/131] (576s left) prime_self_import (export-vs-gem_close-race) [548.090964] Starting subtest: export-vs-gem_close-race [553.166052] Subtest export-vs-gem_close-race: SUCCESS (5.080s) [553.237262] [087/131] (571s left) gen9_exec_parse (valid-registers) [553.299840] Subtest valid-registers: SKIP (0.000s) [553.372778] [088/131] (571s left) fbdev (read) [553.418880] Starting subtest: read [554.174146] Subtest read: SUCCESS (0.753s) [554.240547] [089/131] (570s left) kms_addfb_basic (bo-too-small-due-to-tiling) [554.341687] Starting subtest: bo-too-small-due-to-tiling [554.346938] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [554.444321] [090/131] (570s left) gem_exec_create (basic) [554.510678] Starting subtest: basic [554.513421] Starting dynamic subtest: smem [557.941860] Dynamic subtest smem: SUCCESS (3.430s) [557.944987] Subtest basic: SUCCESS (3.431s) [558.121452] [091/131] (566s left) kms_psr (psr2-primary-mmap-cpu) [558.220945] Starting subtest: psr2-primary-mmap-cpu [558.223880] Starting dynamic subtest: eDP-1 [559.973172] Dynamic subtest eDP-1: SUCCESS (1.751s) [559.975941] Subtest psr2-primary-mmap-cpu: SUCCESS (1.752s) [560.838140] [092/131] (564s left) gem_softpin (allocator-basic-reserve) [560.905146] Starting subtest: allocator-basic-reserve [560.966155] Subtest allocator-basic-reserve: SUCCESS (0.062s) [561.106363] [093/131] (564s left) kms_flip (flip-vs-absolute-wf_vblank) [561.199859] Starting subtest: flip-vs-absolute-wf_vblank [561.202358] Starting dynamic subtest: A-eDP1 [570.191686] Dynamic subtest A-eDP1: SUCCESS (8.992s) [570.199819] Starting dynamic subtest: B-eDP1 [579.114022] Dynamic subtest B-eDP1: SUCCESS (8.920s) [579.130320] Starting dynamic subtest: C-eDP1 [588.029164] Dynamic subtest C-eDP1: SUCCESS (8.912s) [588.038393] Starting dynamic subtest: D-eDP1 [596.958591] Dynamic subtest D-eDP1: SUCCESS (8.926s) [596.963779] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.763s) [598.172472] [094/131] (527s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [598.267357] Starting subtest: random-ccs-data-yf-tiled-ccs [598.269756] Starting dynamic subtest: pipe-A-eDP-1 [598.295763] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [598.304881] Starting dynamic subtest: pipe-B-eDP-1 [598.330058] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [598.339131] Starting dynamic subtest: pipe-C-eDP-1 [598.367870] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [598.377123] Starting dynamic subtest: pipe-D-eDP-1 [598.406136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [598.410940] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s) [600.416809] [095/131] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [600.523280] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [600.528158] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [600.638509] [096/131] (524s left) gem_pxp (create-regular-context-2) [600.768911] Starting subtest: create-regular-context-2 [600.771991] Subtest create-regular-context-2: SUCCESS (0.002s) [600.893612] [097/131] (524s left) gem_exec_whisper (basic-forked) [600.959752] Starting subtest: basic-forked [608.522783] Subtest basic-forked: SUCCESS (7.563s) [608.708850] [098/131] (516s left) gem_ctx_persistence (many-contexts) [608.767790] Starting subtest: many-contexts [654.043257] Subtest many-contexts: SUCCESS (45.269s) [654.118270] [099/131] (471s left) gem_exec_endless (dispatch) [654.185169] Starting subtest: dispatch [654.188263] Starting dynamic subtest: rcs0 [654.195412] Dynamic subtest rcs0: SUCCESS (0.005s) [654.216368] Starting dynamic subtest: bcs0 [654.222259] Dynamic subtest bcs0: SUCCESS (0.006s) [654.231379] Starting dynamic subtest: vcs0 [654.236123] Dynamic subtest vcs0: SUCCESS (0.004s) [654.244700] Starting dynamic subtest: vcs1 [654.249678] Dynamic subtest vcs1: SUCCESS (0.004s) [654.258691] Starting dynamic subtest: vecs0 [654.263821] Dynamic subtest vecs0: SUCCESS (0.004s) [654.273147] Starting dynamic subtest: ccs0 [654.278159] Dynamic subtest ccs0: SUCCESS (0.004s) [654.280681] Subtest dispatch: SUCCESS (0.030s) [655.959217] [100/131] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [656.073042] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [656.078432] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [656.147374] [101/131] (469s left) gem_ctx_persistence (engines-hang) [656.209356] Starting subtest: engines-hang [656.212157] Starting dynamic subtest: rcs0 [656.345419] Dynamic subtest rcs0: SUCCESS (0.135s) [656.358591] Starting dynamic subtest: bcs0 [656.453257] Dynamic subtest bcs0: SUCCESS (0.106s) [656.465183] Starting dynamic subtest: vcs0 [656.559628] Dynamic subtest vcs0: SUCCESS (0.104s) [656.571970] Starting dynamic subtest: vcs1 [656.671545] Dynamic subtest vcs1: SUCCESS (0.110s) [656.684119] Starting dynamic subtest: vecs0 [656.776582] Dynamic subtest vecs0: SUCCESS (0.103s) [656.789438] Starting dynamic subtest: ccs0 [656.893204] Dynamic subtest ccs0: SUCCESS (0.115s) [656.896242] Subtest engines-hang: SUCCESS (0.685s) [656.965254] [102/131] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [657.061745] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [661.375526] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.316s) [661.505423] [103/131] (464s left) gem_fenced_exec_thrash (2-spare-fences) [661.570967] Subtest 2-spare-fences: SKIP (0.000s) [661.657292] [104/131] (463s left) gem_exec_reloc (basic-cpu-read) [661.718180] Subtest basic-cpu-read: SKIP (0.000s) [661.776821] [105/131] (463s left) gem_exec_balancer (individual) [661.845726] Starting subtest: individual [663.950973] Subtest individual: SUCCESS (2.103s) [664.250981] [106/131] (461s left) kms_display_modes (extended-mode-basic) [664.354764] Starting subtest: extended-mode-basic [664.359958] Subtest extended-mode-basic: SKIP (0.000s) [664.398894] [107/131] (461s left) kms_chamelium_color (ctm-negative) [664.488647] Subtest ctm-negative: SKIP (0.000s) [664.531881] [108/131] (461s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [664.592034] Starting subtest: etime-multi-wait-all-submitted-signaled [664.697171] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s) [664.771012] [109/131] (461s left) kms_sequence (queue-busy) [664.861589] Starting subtest: queue-busy [664.863975] Starting dynamic subtest: pipe-A-eDP-1 [666.800729] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s) [666.810831] Starting dynamic subtest: pipe-B-eDP-1 [669.361129] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s) [669.371738] Starting dynamic subtest: pipe-C-eDP-1 [671.978628] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s) [671.989048] Starting dynamic subtest: pipe-D-eDP-1 [674.506808] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s) [674.509642] Subtest queue-busy: SUCCESS (9.641s) [675.379501] [110/131] (450s left) kms_big_fb (x-tiled-64bpp-rotate-90) [675.488759] Starting subtest: x-tiled-64bpp-rotate-90 [675.507553] Subtest x-tiled-64bpp-rotate-90: SKIP (0.018s) [675.651942] [111/131] (450s left) gem_exec_reloc (basic-gtt-noreloc) [675.714996] Subtest basic-gtt-noreloc: SKIP (0.000s) [675.794426] [112/131] (450s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [675.892031] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [675.894979] Starting dynamic subtest: pipe-A-eDP-1 [675.922971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [675.933482] Starting dynamic subtest: pipe-B-eDP-1 [675.960114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [675.969384] Starting dynamic subtest: pipe-C-eDP-1 [675.995915] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [676.005120] Starting dynamic subtest: pipe-D-eDP-1 [676.031597] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [676.036663] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [678.043712] [113/131] (447s left) kms_content_protection (mei-interface) [678.228927] Starting subtest: mei-interface [678.235021] Subtest mei-interface: SKIP (0.003s) [678.347026] [114/131] (447s left) kms_psr (psr2-sprite-plane-onoff) [678.440635] Starting subtest: psr2-sprite-plane-onoff [678.442989] Starting dynamic subtest: eDP-1 [680.140418] Dynamic subtest eDP-1: SUCCESS (1.699s) [680.142959] Subtest psr2-sprite-plane-onoff: SUCCESS (1.700s) [681.005178] [115/131] (445s left) gem_ccs (block-copy-uncompressed) [681.074066] Starting subtest: block-copy-uncompressed [681.076968] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [681.098631] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s) [681.109136] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem [681.117121] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [681.129642] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem [681.134944] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s) [681.144851] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem [681.154720] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s) [681.157144] Subtest block-copy-uncompressed: SUCCESS (0.082s) [681.296462] [116/131] (444s left) gem_mmap_offset (mmap-boundaries) [681.355701] Starting subtest: mmap-boundaries [681.358143] Starting dynamic subtest: smem0 [682.422750] Dynamic subtest smem0: SUCCESS (1.068s) [682.425593] Subtest mmap-boundaries: SUCCESS (1.069s) [682.595468] [117/131] (443s left) kms_hdr (static-toggle-suspend) [682.684147] Starting subtest: static-toggle-suspend [682.691485] Subtest static-toggle-suspend: SKIP (0.000s) [682.759313] [118/131] (443s left) kms_cursor_legacy (flip-vs-cursor-toggle) [682.866948] Starting subtest: flip-vs-cursor-toggle [690.567848] Subtest flip-vs-cursor-toggle: SUCCESS (7.696s) [691.417650] [119/131] (434s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [691.793267] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [692.624487] [120/131] (433s left) gem_exec_schedule (u-fairslice-all) [692.694257] Starting subtest: u-fairslice-all [694.758560] Subtest u-fairslice-all: SUCCESS (2.063s) [695.922314] [121/131] (430s left) api_intel_allocator (fork-simple-once) [695.973645] Starting subtest: fork-simple-once [695.991961] Subtest fork-simple-once: SUCCESS (0.021s) [696.131537] [122/131] (430s left) kms_3d [698.418707] [123/131] (427s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [698.480162] Starting subtest: invalid-single-wait-all-unsubmitted [698.482550] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [698.580487] [124/131] (427s left) prime_vgem (sync) [698.665606] Starting subtest: sync [698.668444] Starting dynamic subtest: rcs0 [698.734637] Dynamic subtest rcs0: SUCCESS (0.068s) [698.744280] Starting dynamic subtest: bcs0 [698.808906] Dynamic subtest bcs0: SUCCESS (0.072s) [698.818891] Starting dynamic subtest: vcs0 [698.857164] Dynamic subtest vcs0: SUCCESS (0.048s) [698.867013] Starting dynamic subtest: vcs1 [698.906451] Dynamic subtest vcs1: SUCCESS (0.049s) [698.915981] Starting dynamic subtest: vecs0 [698.951180] Dynamic subtest vecs0: SUCCESS (0.044s) [698.960930] Starting dynamic subtest: ccs0 [698.997212] Dynamic subtest ccs0: SUCCESS (0.046s) [698.999984] Subtest sync: SUCCESS (0.332s) [699.127820] [125/131] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [699.234958] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [704.069684] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.840s) [704.189514] [126/131] (422s left) kms_joiner (basic-force-big-joiner) [704.298525] Starting subtest: basic-force-big-joiner [704.300803] Starting dynamic subtest: single [707.623355] Dynamic subtest single: SUCCESS (3.333s) [707.626124] Subtest basic-force-big-joiner: SUCCESS (3.334s) [708.771585] [127/131] (417s left) prime_self_import (reimport-vs-gem_close-race) [708.805642] Starting subtest: reimport-vs-gem_close-race [713.903511] Subtest reimport-vs-gem_close-race: SUCCESS (5.094s) [713.971228] [128/131] (412s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [714.077615] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [714.080140] Starting dynamic subtest: pipe-A-eDP-1 [714.959697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.869s) [714.970174] Starting dynamic subtest: pipe-B-eDP-1 [716.482261] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.522s) [716.492708] Starting dynamic subtest: pipe-C-eDP-1 [717.949531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s) [717.960559] Starting dynamic subtest: pipe-D-eDP-1 [719.424758] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.475s) [719.427391] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.338s) [720.573393] [129/131] (405s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [720.701148] Starting subtest: flip-vs-cursor-busy-crc-legacy [721.460165] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.758s) [722.268297] [130/131] (404s left) kms_pm_rpm (cursor) [724.123549] Starting subtest: cursor [724.129652] Subtest cursor: SKIP (0.000s) [724.582608] [131/131] (402s left) gem_ctx_engines (invalid-engines) [724.638319] Starting subtest: invalid-engines [724.646961] Subtest invalid-engines: SUCCESS (0.008s) [724.883867] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_fbcon_fbt results: parsing output: 4/ for test: kms_plane_alpha_blend results: parsing output: 5/ for test: kms_psr2_sf results: parsing output: 6/ for test: kms_atomic results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: api_intel_bb results: parsing output: 9/ for test: kms_chamelium_hpd results: parsing output: 10/ for test: kms_vblank results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: prime_mmap results: parsing output: 13/ for test: kms_lease results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: kms_pm_dc results: parsing output: 16/ for test: kms_flip_scaled_crc results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: gem_vm_create results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: i915_pm_rpm results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: gem_exec_params results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: kms_ccs results: parsing output: 26/ for test: gem_mmap_gtt results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_atomic_transition results: parsing output: 30/ for test: gem_render_copy results: parsing output: 31/ for test: gem_tiled_wb results: parsing output: 32/ for test: api_intel_bb results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_ctx_sseu results: parsing output: 35/ for test: kms_psr2_sf results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: kms_flip_scaled_crc results: parsing output: 38/ for test: gem_lmem_evict results: parsing output: 39/ for test: kms_atomic results: parsing output: 40/ for test: gem_exec_fence results: parsing output: 41/ for test: gem_partial_pwrite_pread results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: kms_psr results: parsing output: 45/ for test: vgem_basic results: parsing output: 46/ for test: gem_softpin results: parsing output: 47/ for test: kms_addfb_basic results: parsing output: 48/ for test: kms_vblank results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: tools_test results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: i915_module_load results: parsing output: 55/ for test: gem_mmap_gtt results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: gem_close results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: sysfs_heartbeat_interval results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: gem_lmem_swapping results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: drm_fdinfo results: parsing output: 69/ for test: gem_set_tiling_vs_pwrite results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_cursor_legacy results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_plane results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: kms_prime results: parsing output: 77/ for test: gem_mmap_wc results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_flip_scaled_crc results: parsing output: 80/ for test: kms_dirtyfb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_busy results: parsing output: 83/ for test: gem_workarounds results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: prime_self_import results: parsing output: 86/ for test: gen9_exec_parse results: parsing output: 87/ for test: fbdev results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: gem_exec_create results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: gem_softpin results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_pxp results: parsing output: 96/ for test: gem_exec_whisper results: parsing output: 97/ for test: gem_ctx_persistence results: parsing output: 98/ for test: gem_exec_endless results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_ctx_persistence results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_fenced_exec_thrash results: parsing output: 103/ for test: gem_exec_reloc results: parsing output: 104/ for test: gem_exec_balancer results: parsing output: 105/ for test: kms_display_modes results: parsing output: 106/ for test: kms_chamelium_color results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_sequence results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: gem_exec_reloc results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: kms_content_protection results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_ccs results: parsing output: 115/ for test: gem_mmap_offset results: parsing output: 116/ for test: kms_hdr results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: kms_chamelium_hpd results: parsing output: 119/ for test: gem_exec_schedule results: parsing output: 120/ for test: api_intel_allocator results: parsing output: 121/ for test: kms_3d results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: prime_vgem results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_joiner results: parsing output: 126/ for test: prime_self_import results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: kms_pm_rpm results: parsing output: 130/ for test: gem_ctx_engines Done.