[58.108260] Initializing watchdogs
[58.108312]   /dev/watchdog0
[58.123380] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.127928] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.130279] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.133780] [001/156] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[58.271989] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[58.276816] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[58.357600] [002/156] (960s left) gem_exec_reloc (basic-softpin)
[58.419716] Subtest basic-softpin: SKIP (0.000s)
[58.497188] [003/156] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[58.595509] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[58.599641] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[58.694134] [004/156] (960s left) kms_fbcon_fbt (fbc)
[58.749204] Starting subtest: fbc
[65.502293] Subtest fbc: SUCCESS (6.753s)
[66.672938] [005/156] (952s left) gem_softpin (evict-single-offset)
[66.736687] Starting subtest: evict-single-offset
[94.278768] Subtest evict-single-offset: SUCCESS (27.538s)
[94.361079] [006/156] (924s left) syncobj_timeline (host-signal-points)
[94.450977] Starting subtest: host-signal-points
[94.455612] Subtest host-signal-points: SUCCESS (0.005s)
[94.524944] [007/156] (924s left) kms_psr (fbc-psr2-primary-page-flip)
[94.627089] Starting subtest: fbc-psr2-primary-page-flip
[94.628962] Starting dynamic subtest: eDP-1
[94.633082] Dynamic subtest eDP-1: SKIP (0.000s)
[94.637140] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[94.696872] [008/156] (924s left) gem_sync (basic-all)
[94.777701] Starting subtest: basic-all
[98.309364] Subtest basic-all: SUCCESS (3.540s)
[98.486337] [009/156] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[98.592701] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[103.084047] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.498s)
[104.290390] [010/156] (914s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[104.420643] Starting subtest: cursor-vs-flip-atomic-transitions
[134.825499] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.404s)
[135.702038] [011/156] (883s left) kms_flip (flip-vs-rmfb)
[135.793335] Starting subtest: flip-vs-rmfb
[135.795704] Starting dynamic subtest: A-eDP1
[144.486471] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[144.497105] Starting dynamic subtest: B-eDP1
[153.119536] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[153.130297] Starting dynamic subtest: C-eDP1
[161.747908] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[161.762378] Starting dynamic subtest: D-eDP1
[170.386093] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[170.390909] Subtest flip-vs-rmfb: SUCCESS (34.596s)
[171.569486] [012/156] (847s left) i915_pm_rps (engine-order)
[171.638891] Starting subtest: engine-order
[176.773947] Subtest engine-order: SUCCESS (5.134s)
[176.908955] [013/156] (842s left) gem_pxp (display-protected-crc)
[177.048730] Starting subtest: display-protected-crc
[178.928458] Subtest display-protected-crc: SUCCESS (1.883s)
[179.037514] [014/156] (840s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[179.084524] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[179.086708] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[179.173021] [015/156] (839s left) syncobj_wait (reset-during-wait-for-submit)
[179.226483] Starting subtest: reset-during-wait-for-submit
[179.332835] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[179.412165] [016/156] (839s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[179.529910] Starting subtest: yf-tiled-32bpp-rotate-90
[179.534369] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[179.624671] [017/156] (839s left) gem_ctx_param (root-set)
[179.673074] Starting subtest: root-set
[179.675378] Subtest root-set: SUCCESS (0.001s)
[179.773600] [018/156] (839s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[179.882181] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[179.886633] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[179.968049] [019/156] (839s left) gem_exec_schedule (pi-common)
[180.149741] Starting subtest: pi-common
[180.151811] Starting dynamic subtest: rcs0
[180.228798] Dynamic subtest rcs0: SUCCESS (0.080s)
[180.243070] Starting dynamic subtest: bcs0
[180.255781] Dynamic subtest bcs0: SUCCESS (0.026s)
[180.269463] Starting dynamic subtest: vcs0
[180.282589] Dynamic subtest vcs0: SUCCESS (0.026s)
[180.296091] Starting dynamic subtest: vcs1
[180.308696] Dynamic subtest vcs1: SUCCESS (0.025s)
[180.322144] Starting dynamic subtest: vecs0
[180.334656] Dynamic subtest vecs0: SUCCESS (0.025s)
[180.347977] Starting dynamic subtest: ccs0
[180.360590] Dynamic subtest ccs0: SUCCESS (0.025s)
[180.362741] Subtest pi-common: SUCCESS (0.213s)
[180.601515] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[180.604926] [020/156] (838s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[180.657222] Starting subtest: multi-wait-all-for-submit-available-signaled
[180.659611] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[180.754483] [021/156] (838s left) kms_vrr (flip-basic-fastset)
[180.847107] Starting subtest: flip-basic-fastset
[180.853336] Subtest flip-basic-fastset: SKIP (0.000s)
[180.920614] [022/156] (838s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[181.022053] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[181.026259] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[181.119017] [023/156] (838s left) kms_vblank (query-busy-hang)
[181.212079] Starting subtest: query-busy-hang
[181.214176] Starting dynamic subtest: pipe-A-eDP-1
[208.076935] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.863s)
[208.091595] Starting dynamic subtest: pipe-D-eDP-1
[234.059114] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.980s)
[234.061459] Subtest query-busy-hang: SUCCESS (52.847s)
[234.954131] [024/156] (784s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[235.052511] Starting subtest: compare-crc-sanitycheck-nv12
[235.054754] Starting dynamic subtest: pipe-A-eDP-1
[235.770561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[235.780744] Starting dynamic subtest: pipe-B-eDP-1
[237.063131] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.293s)
[237.073702] Starting dynamic subtest: pipe-C-eDP-1
[238.332560] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.267s)
[238.342651] Starting dynamic subtest: pipe-D-eDP-1
[239.556710] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[239.559102] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.505s)
[240.382397] [025/156] (779s left) syncobj_timeline (wait-all-for-submit-complex)
[240.436548] Starting subtest: wait-all-for-submit-complex
[240.651220] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[240.727748] [026/156] (778s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[240.822320] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[240.824472] Starting dynamic subtest: pipe-A
[240.934217] Dynamic subtest pipe-A: SKIP (0.108s)
[240.944070] Starting dynamic subtest: pipe-B
[242.128751] Dynamic subtest pipe-B: SKIP (1.194s)
[242.138183] Starting dynamic subtest: pipe-C
[243.280019] Dynamic subtest pipe-C: SUCCESS (1.156s)
[243.290447] Starting dynamic subtest: pipe-D
[244.509563] Dynamic subtest pipe-D: SUCCESS (1.229s)
[244.511845] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.691s)
[245.706059] [027/156] (773s left) kms_frontbuffer_tracking (hdr-modesetfrombusy)
[245.797991] Starting subtest: hdr-modesetfrombusy
[245.802618] Subtest hdr-modesetfrombusy: SKIP (0.000s)
[245.879052] [028/156] (773s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[246.018575] Starting subtest: dp-mst-lic-type-0-hdcp14
[246.023463] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[246.136674] [029/156] (773s left) gem_exec_schedule (preempt-self)
[246.200192] Starting subtest: preempt-self
[246.202411] Starting dynamic subtest: rcs0
[246.212477] Dynamic subtest rcs0: SUCCESS (0.020s)
[246.223247] Starting dynamic subtest: bcs0
[246.227726] Dynamic subtest bcs0: SUCCESS (0.014s)
[246.236501] Starting dynamic subtest: vcs0
[246.245793] Dynamic subtest vcs0: SUCCESS (0.017s)
[246.257513] Starting dynamic subtest: vcs1
[246.264679] Dynamic subtest vcs1: SUCCESS (0.019s)
[246.275627] Starting dynamic subtest: vecs0
[246.283778] Dynamic subtest vecs0: SUCCESS (0.018s)
[246.293189] Starting dynamic subtest: ccs0
[246.302654] Dynamic subtest ccs0: SUCCESS (0.017s)
[246.304913] Subtest preempt-self: SUCCESS (0.111s)
[247.372734] [030/156] (772s left) gem_exec_await (wide-all)
[247.549813] Starting subtest: wide-all
[271.034420] Subtest wide-all: SUCCESS (23.482s)
[271.226521] [031/156] (748s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[271.367524] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[271.394079] Starting dynamic subtest: pipe-A-plane-0
[271.682971] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[271.692748] Starting dynamic subtest: pipe-A-plane-3
[271.916615] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[272.994519] Starting dynamic subtest: pipe-B-plane-0
[273.296072] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[273.306236] Starting dynamic subtest: pipe-B-plane-3
[273.529371] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[273.842907] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.473s)
[274.661475] [032/156] (745s left) syncobj_wait (multi-wait-submitted-signaled)
[274.716646] Starting subtest: multi-wait-submitted-signaled
[274.719113] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[274.796847] [033/156] (745s left) i915_pm_freq_api (freq-reset)
[274.873766] Starting subtest: freq-reset
[274.876685] Starting dynamic subtest: gt0
[275.062252] Dynamic subtest gt0: SUCCESS (0.191s)
[275.072813] Starting dynamic subtest: gt1
[275.231989] Dynamic subtest gt1: SUCCESS (0.167s)
[275.235427] Subtest freq-reset: SUCCESS (0.360s)
[275.319869] [034/156] (744s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[275.449771] Starting subtest: cursorB-vs-flipA-varying-size
[275.454523] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[275.614625] [035/156] (744s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[275.715332] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[275.719579] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[275.810040] [036/156] (744s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-render)
[275.913120] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-render
[275.917518] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[276.004118] [037/156] (744s left) syncobj_wait (multi-wait-submitted)
[276.060854] Starting subtest: multi-wait-submitted
[276.168805] Subtest multi-wait-submitted: SUCCESS (0.108s)
[276.269769] [038/156] (743s left) kms_feature_discovery (chamelium)
[276.372438] Starting subtest: chamelium
[276.376837] Subtest chamelium: SKIP (0.000s)
[276.445659] [039/156] (743s left) kms_chamelium_hpd (dp-hpd-fast)
[276.829690] Subtest dp-hpd-fast: SKIP (0.000s)
[277.668747] [040/156] (742s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[277.762216] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[277.764395] Starting dynamic subtest: pipe-A
[277.784439] Dynamic subtest pipe-A: SKIP (0.019s)
[277.793993] Starting dynamic subtest: pipe-B
[277.821024] Dynamic subtest pipe-B: SKIP (0.034s)
[277.830717] Starting dynamic subtest: pipe-C
[277.855775] Dynamic subtest pipe-C: SKIP (0.033s)
[277.865114] Starting dynamic subtest: pipe-D
[277.890174] Dynamic subtest pipe-D: SKIP (0.033s)
[277.894272] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.124s)
[277.977211] [041/156] (742s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[278.073896] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[278.078045] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[278.161936] [042/156] (742s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-msflip-blt)
[278.258437] Starting subtest: psrhdr-1p-primscrn-indfb-msflip-blt
[278.262441] Subtest psrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[278.380981] [043/156] (741s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[278.434656] Starting subtest: yf-tiled-to-vebox-y-tiled
[278.439298] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[278.619910] [044/156] (741s left) kms_addfb_basic (unused-handle)
[278.668028] Starting subtest: unused-handle
[278.670243] Subtest unused-handle: SUCCESS (0.000s)
[278.809508] [045/156] (741s left) gem_ctx_sseu (invalid-args)
[278.865223] Subtest invalid-args: SKIP (0.000s)
[278.940163] [046/156] (741s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[279.035796] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[279.040225] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[279.144504] [047/156] (741s left) kms_joiner (invalid-modeset-force-big-joiner)
[279.239230] Starting subtest: invalid-modeset-force-big-joiner
[279.243283] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[279.306757] [048/156] (741s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[279.400663] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[279.404831] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.486291] [049/156] (741s left) gem_vm_create (create-ext)
[279.540733] Starting subtest: create-ext
[279.545635] Subtest create-ext: SUCCESS (0.005s)
[279.671657] [050/156] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[279.772721] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[279.776243] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[279.874760] [051/156] (740s left) kms_cursor_edge_walk (128x128-left-edge)
[279.962467] Starting subtest: 128x128-left-edge
[279.964436] Starting dynamic subtest: pipe-A-eDP-1
[283.446356] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[283.455856] Starting dynamic subtest: pipe-D-eDP-1
[286.663644] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.216s)
[286.666024] Subtest 128x128-left-edge: SUCCESS (6.702s)
[287.487821] [052/156] (733s left) kms_cdclk (mode-transition-all-outputs)
[287.592321] Starting subtest: mode-transition-all-outputs
[287.884689] Subtest mode-transition-all-outputs: SKIP (0.287s)
[288.702798] [053/156] (732s left) gem_create (create-ext-cpu-access-big)
[288.868859] Starting subtest: create-ext-cpu-access-big
[288.874036] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[288.946433] [054/156] (731s left) kms_cursor_crc (cursor-dpms)
[289.077846] Starting subtest: cursor-dpms
[289.080092] Starting dynamic subtest: pipe-A-eDP-1
[292.158518] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.079s)
[292.168770] Starting dynamic subtest: pipe-D-eDP-1
[295.862017] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.699s)
[295.864142] Subtest cursor-dpms: SUCCESS (6.781s)
[296.687129] [055/156] (724s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[296.787194] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[296.791294] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[296.896569] [056/156] (724s left) gem_workarounds (basic-read)
[296.955878] Starting subtest: basic-read
[296.966139] Subtest basic-read: SUCCESS (0.010s)
[297.077177] [057/156] (723s left) perf_pmu (busy-no-semaphores)
[297.120371] Starting subtest: busy-no-semaphores
[297.122662] Starting dynamic subtest: rcs0
[297.681787] Dynamic subtest rcs0: SUCCESS (0.561s)
[297.695070] Starting dynamic subtest: bcs0
[298.232675] Dynamic subtest bcs0: SUCCESS (0.548s)
[298.245558] Starting dynamic subtest: vcs0
[298.783581] Dynamic subtest vcs0: SUCCESS (0.548s)
[298.795571] Starting dynamic subtest: vcs1
[300.809421] Dynamic subtest vcs1: SUCCESS (2.022s)
[300.822909] Starting dynamic subtest: vecs0
[302.793239] Dynamic subtest vecs0: SUCCESS (1.980s)
[302.805523] Starting dynamic subtest: ccs0
[304.842293] Dynamic subtest ccs0: SUCCESS (2.045s)
[304.845111] Subtest busy-no-semaphores: SUCCESS (7.724s)
[304.968575] [058/156] (716s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[305.081826] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[305.086241] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[305.167386] [059/156] (715s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[305.275952] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[305.278303] Starting dynamic subtest: pipe-A-eDP-1
[305.376435] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[305.386628] Starting dynamic subtest: pipe-B-eDP-1
[306.562730] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s)
[306.567453] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.290s)
[307.853690] [060/156] (713s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[307.952587] Starting subtest: y-tiled-8bpp-rotate-180
[307.957054] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[308.072307] [061/156] (713s left) gem_lmem_swapping (random)
[308.116832] Subtest random: SKIP (0.000s)
[308.156763] [062/156] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[308.255808] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[308.259921] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[308.371554] [063/156] (712s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[310.396302] Starting subtest: modeset-non-lpsp-stress-no-wait
[310.452471] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.054s)
[310.802860] [064/156] (710s left) kms_getfb (getfb-reject-nv12)
[310.889627] Starting subtest: getfb-reject-nv12
[310.891832] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[310.984124] [065/156] (710s left) gem_madvise (dontneed-before-exec)
[311.020738] Starting subtest: dontneed-before-exec
[311.042454] Subtest dontneed-before-exec: SKIP (0.019s)
[311.107593] [066/156] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[311.215099] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[311.219512] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[311.325534] [067/156] (710s left) api_intel_bb (render)
[311.389507] Starting subtest: render
[311.391559] Starting dynamic subtest: render-none-512
[311.489860] Dynamic subtest render-none-512: SUCCESS (0.103s)
[311.502196] Starting dynamic subtest: render-none-1024
[311.875712] Dynamic subtest render-none-1024: SUCCESS (0.383s)
[311.887861] Starting dynamic subtest: render-x-512
[311.963884] Dynamic subtest render-x-512: SUCCESS (0.087s)
[311.975772] Starting dynamic subtest: render-x-1024
[312.313724] Dynamic subtest render-x-1024: SUCCESS (0.349s)
[312.327228] Starting dynamic subtest: render-y-512
[312.400084] Dynamic subtest render-y-512: SUCCESS (0.086s)
[312.413177] Starting dynamic subtest: render-y-1024
[312.745810] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[312.748791] Subtest render: SUCCESS (1.359s)
[312.847494] [068/156] (708s left) kms_cursor_crc (cursor-random-64x21)
[313.027791] Starting subtest: cursor-random-64x21
[313.078416] Subtest cursor-random-64x21: SKIP (0.044s)
[313.328428] [069/156] (708s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[313.415376] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[313.417652] Starting dynamic subtest: pipe-A-default-mode
[314.566692] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[314.571302] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.152s)
[314.724244] [070/156] (706s left) syncobj_wait (reset-signaled)
[314.783624] Starting subtest: reset-signaled
[314.785604] Subtest reset-signaled: SUCCESS (0.000s)
[314.877784] [071/156] (706s left) gem_exec_params (invalid-flag)
[314.938846] Starting subtest: invalid-flag
[314.941624] Subtest invalid-flag: SUCCESS (0.000s)
[315.032474] [072/156] (706s left) gem_workarounds (reset-fd)
[315.093314] Starting subtest: reset-fd
[315.261590] Subtest reset-fd: SUCCESS (0.167s)
[315.374012] [073/156] (706s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[315.500723] Starting subtest: cursor-vs-flip-atomic
[345.227584] Subtest cursor-vs-flip-atomic: SUCCESS (29.725s)
[346.048263] [074/156] (675s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[346.158069] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[346.162264] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[346.263998] [075/156] (675s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[346.366236] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[346.370216] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[346.465374] [076/156] (675s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[346.560925] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[346.565283] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[346.668673] [077/156] (675s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[346.771808] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[346.776320] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[346.840878] [078/156] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[346.938951] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[353.342772] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.409s)
[354.551241] [079/156] (667s left) kms_async_flips (crc-atomic)
[354.655249] Starting subtest: crc-atomic
[355.028979] Starting dynamic subtest: pipe-A-eDP-1
[357.947668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.918s)
[358.326623] Starting dynamic subtest: pipe-B-eDP-1
[361.273444] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.956s)
[361.663999] Starting dynamic subtest: pipe-C-eDP-1
[364.569987] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.917s)
[364.951863] Starting dynamic subtest: pipe-D-eDP-1
[367.823550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.881s)
[367.825930] Subtest crc-atomic: SUCCESS (13.169s)
[368.981793] [080/156] (652s left) kms_psr (pr-primary-render)
[369.080152] Starting subtest: pr-primary-render
[369.084533] Subtest pr-primary-render: SKIP (0.000s)
[369.164453] [081/156] (652s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[369.207058] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[369.252038] [082/156] (652s left) perf_pmu (init-wait)
[369.288894] Starting subtest: init-wait
[369.291145] Starting dynamic subtest: rcs0
[369.293294] Dynamic subtest rcs0: SUCCESS (0.001s)
[369.303659] Starting dynamic subtest: bcs0
[369.305748] Dynamic subtest bcs0: SUCCESS (0.000s)
[369.315131] Starting dynamic subtest: vcs0
[369.317273] Dynamic subtest vcs0: SUCCESS (0.001s)
[369.326484] Starting dynamic subtest: vcs1
[369.328361] Dynamic subtest vcs1: SUCCESS (0.001s)
[369.337637] Starting dynamic subtest: vecs0
[369.339726] Dynamic subtest vecs0: SUCCESS (0.001s)
[369.349109] Starting dynamic subtest: ccs0
[369.350969] Dynamic subtest ccs0: SUCCESS (0.000s)
[369.352831] Subtest init-wait: SUCCESS (0.008s)
[369.406590] [083/156] (652s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[369.509082] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[369.513246] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[369.604822] [084/156] (652s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[369.702253] Starting subtest: fbcpsr-rgb565-draw-pwrite
[376.805254] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.107s)
[376.937051] [085/156] (645s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff)
[377.044172] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff
[377.048210] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[377.157386] [086/156] (645s left) kms_psr (psr2-primary-page-flip)
[377.251149] Starting subtest: psr2-primary-page-flip
[377.253410] Starting dynamic subtest: eDP-1
[378.979799] Dynamic subtest eDP-1: SUCCESS (1.727s)
[378.982073] Subtest psr2-primary-page-flip: SUCCESS (1.728s)
[379.876797] [087/156] (642s left) syncobj_wait (invalid-signal-illegal-handle)
[379.931890] Starting subtest: invalid-signal-illegal-handle
[379.934349] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[380.040962] [088/156] (642s left) kms_plane_multiple (tiling-y)
[380.139154] Starting subtest: tiling-y
[380.143209] Subtest tiling-y: SKIP (0.000s)
[380.223361] [089/156] (642s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[380.336771] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[380.341242] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[380.444317] [090/156] (641s left) gen7_exec_parse (basic-rejected)
[380.513490] Subtest basic-rejected: SKIP (0.000s)
[380.595776] [091/156] (641s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[380.691714] Starting subtest: fbchdr-tiling-4
[380.695775] Subtest fbchdr-tiling-4: SKIP (0.000s)
[380.807049] [092/156] (641s left) kms_chamelium_frames (hdmi-aspect-ratio)
[381.184106] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[381.965983] [093/156] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[382.078926] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[382.083362] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[382.186205] [094/156] (640s left) kms_big_fb (4-tiled-addfb-size-overflow)
[382.285975] Starting subtest: 4-tiled-addfb-size-overflow
[382.288312] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[382.388635] [095/156] (640s left) syncobj_timeline (reset-during-wait-for-submit)
[382.441999] Starting subtest: reset-during-wait-for-submit
[382.545993] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[382.626104] [096/156] (639s left) kms_atomic (atomic-invalid-params)
[382.722169] Starting subtest: atomic-invalid-params
[382.724456] Starting dynamic subtest: pipe-A-eDP-1
[383.112704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[383.114847] Subtest atomic-invalid-params: SUCCESS (0.391s)
[383.920227] [097/156] (638s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[384.014156] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[384.018567] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[384.123953] [098/156] (638s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[384.220501] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[384.222756] Starting dynamic subtest: pipe-A-eDP-1
[384.246182] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.258660] Starting dynamic subtest: pipe-B-eDP-1
[384.280332] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.289961] Starting dynamic subtest: pipe-C-eDP-1
[384.312605] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.323040] Starting dynamic subtest: pipe-D-eDP-1
[384.345776] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.350100] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[386.488200] [099/156] (636s left) i915_drm_fdinfo (virtual-busy-hang-all)
[386.535684] Starting subtest: virtual-busy-hang-all
[386.539498] Subtest virtual-busy-hang-all: SKIP (0.000s)
[386.619624] [100/156] (636s left) gem_ctx_param (invalid-set-no-zeromap)
[386.673918] Starting subtest: invalid-set-no-zeromap
[386.676401] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[386.751600] [101/156] (636s left) kms_rotation_crc (cursor-rotation-180)
[386.848806] Starting subtest: cursor-rotation-180
[388.349286] Subtest cursor-rotation-180: SUCCESS (1.499s)
[389.540361] [102/156] (633s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[389.646074] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[389.648392] Starting dynamic subtest: pipe-A-eDP-1
[389.708789] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[389.719792] Starting dynamic subtest: pipe-B-eDP-1
[389.778423] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[389.791452] Starting dynamic subtest: pipe-C-eDP-1
[389.850760] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[389.861679] Starting dynamic subtest: pipe-D-eDP-1
[389.917758] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[389.922176] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[391.893298] [103/156] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[391.994040] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[391.998090] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[392.080507] [104/156] (630s left) prime_vgem (basic-read)
[392.144507] Starting subtest: basic-read
[392.155881] Subtest basic-read: SKIP (0.011s)
[392.260160] [105/156] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[392.365827] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[400.202103] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.841s)
[400.331304] [106/156] (622s left) kms_rotation_crc (sprite-rotation-180)
[400.422148] Starting subtest: sprite-rotation-180
[407.223736] Subtest sprite-rotation-180: SUCCESS (6.803s)
[408.448892] [107/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[408.543822] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[408.548277] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[408.650576] [108/156] (614s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[408.746052] Starting subtest: nonblocking-crc-frame-sequence
[408.748216] Starting dynamic subtest: pipe-A-eDP-1
[409.490127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[409.499820] Starting dynamic subtest: pipe-B-eDP-1
[410.892745] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[410.903681] Starting dynamic subtest: pipe-C-eDP-1
[412.245440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s)
[412.257832] Starting dynamic subtest: pipe-D-eDP-1
[413.577078] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[413.579475] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.831s)
[414.380542] [109/156] (608s left) i915_query (query-regions-garbage-items)
[414.441599] Starting subtest: query-regions-garbage-items
[414.443737] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[414.546790] [110/156] (608s left) gem_exec_balancer (full-late)
[414.598653] Starting subtest: full-late
[419.180621] Subtest full-late: SUCCESS (4.582s)
[419.532291] [111/156] (603s left) dmabuf_sync_file (export-before-signal)
[419.579971] Starting subtest: export-before-signal
[419.582055] Subtest export-before-signal: SUCCESS (0.001s)
[419.653300] [112/156] (603s left) gem_mmap_offset (clear)
[419.709334] Starting subtest: clear
[419.711276] Starting dynamic subtest: smem0
[444.754809] Dynamic subtest smem0: SUCCESS (25.042s)
[444.757166] Subtest clear: SUCCESS (25.043s)
[444.885584] [113/156] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[445.039103] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[445.043320] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[445.143662] [114/156] (578s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[445.243975] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[445.248135] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.341043] [115/156] (578s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[445.437974] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[452.355999] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.920s)
[452.510391] [116/156] (570s left) kms_debugfs (display-on-read-all)
[452.602196] Starting subtest: display-on-read-all
[452.797070] Subtest display-on-read-all: SUCCESS (0.195s)
[452.915677] [117/156] (570s left) prime_vgem (busy)
[452.986539] Starting subtest: busy
[452.988648] Starting dynamic subtest: rcs0
[453.042096] Dynamic subtest rcs0: SUCCESS (0.055s)
[453.052278] Starting dynamic subtest: bcs0
[453.109238] Dynamic subtest bcs0: SUCCESS (0.066s)
[453.120255] Starting dynamic subtest: vcs0
[453.159204] Dynamic subtest vcs0: SUCCESS (0.049s)
[453.169415] Starting dynamic subtest: vcs1
[453.205672] Dynamic subtest vcs1: SUCCESS (0.045s)
[453.215680] Starting dynamic subtest: vecs0
[453.251159] Dynamic subtest vecs0: SUCCESS (0.044s)
[453.261029] Starting dynamic subtest: ccs0
[453.297780] Dynamic subtest ccs0: SUCCESS (0.046s)
[453.301584] Subtest busy: SUCCESS (0.312s)
[453.414426] [118/156] (570s left) gem_eio (banned)
[453.656716] Starting subtest: banned
[454.308523] Subtest banned: SUCCESS (0.653s)
[454.475936] [119/156] (569s left) gem_exec_whisper (basic-contexts-forked)
[454.540226] Starting subtest: basic-contexts-forked
[477.906718] Subtest basic-contexts-forked: SUCCESS (23.359s)
[478.088803] [120/156] (545s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[478.151223] Starting subtest: multi-wait-all-for-submit-unsubmitted
[478.257071] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[478.334588] [121/156] (545s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[478.438041] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[478.440408] Starting dynamic subtest: pipe-A-eDP-1
[479.344954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.900s)
[479.356060] Starting dynamic subtest: pipe-B-eDP-1
[481.060173] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.712s)
[481.073929] Starting dynamic subtest: pipe-C-eDP-1
[482.645740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.586s)
[482.656849] Starting dynamic subtest: pipe-D-eDP-1
[484.233179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.584s)
[484.235422] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.788s)
[485.438589] [122/156] (538s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[485.552379] Starting subtest: x-tiled-32bpp-rotate-270
[485.571774] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[485.675467] [123/156] (538s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[485.769295] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[485.773329] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[485.883897] [124/156] (537s left) gem_ccs (ctrl-surf-copy)
[485.940593] Starting subtest: ctrl-surf-copy
[485.944970] Subtest ctrl-surf-copy: SKIP (0.000s)
[486.045448] [125/156] (537s left) gem_reg_read (timestamp-moving)
[486.105097] Starting subtest: timestamp-moving
[487.106721] Subtest timestamp-moving: SUCCESS (1.001s)
[487.182902] [126/156] (536s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[487.236991] Starting subtest: yf-tiled-ccs-to-x-tiled
[487.241620] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[487.429427] [127/156] (536s left) kms_addfb_basic (bad-pitch-65536)
[487.484709] Starting subtest: bad-pitch-65536
[487.486995] Subtest bad-pitch-65536: SUCCESS (0.000s)
[487.613935] [128/156] (536s left) kms_properties (plane-properties-legacy)
[487.718174] Starting subtest: plane-properties-legacy
[487.720397] Starting dynamic subtest: pipe-A-eDP-1
[488.275235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[488.287253] Starting dynamic subtest: pipe-B-eDP-1
[489.602743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.328s)
[489.615599] Starting dynamic subtest: pipe-C-eDP-1
[490.840652] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[490.851309] Starting dynamic subtest: pipe-D-eDP-1
[492.077706] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[492.080118] Subtest plane-properties-legacy: SUCCESS (4.360s)
[492.887700] [129/156] (531s left) kms_pm_dc (dc9-dpms)
[493.989233] Starting subtest: dc9-dpms
[495.435287] Subtest dc9-dpms: SUCCESS (1.444s)
[495.525117] [130/156] (528s left) kms_busy (extended-modeset-hang-newfb)
[495.629218] Starting subtest: extended-modeset-hang-newfb
[495.631404] Starting dynamic subtest: pipe-A
[530.205779] Dynamic subtest pipe-A: SUCCESS (34.574s)
[530.219510] Starting dynamic subtest: pipe-D
[553.148018] Dynamic subtest pipe-D: SUCCESS (22.940s)
[553.150615] Subtest extended-modeset-hang-newfb: SUCCESS (57.519s)
[554.056235] [131/156] (470s left) gem_exec_endless (dispatch)
[554.115607] Starting subtest: dispatch
[554.117963] Starting dynamic subtest: rcs0
[554.122205] Dynamic subtest rcs0: SUCCESS (0.005s)
[554.134724] Starting dynamic subtest: bcs0
[554.139062] Dynamic subtest bcs0: SUCCESS (0.004s)
[554.149742] Starting dynamic subtest: vcs0
[554.154238] Dynamic subtest vcs0: SUCCESS (0.005s)
[554.164027] Starting dynamic subtest: vcs1
[554.168151] Dynamic subtest vcs1: SUCCESS (0.005s)
[554.177770] Starting dynamic subtest: vecs0
[554.181814] Dynamic subtest vecs0: SUCCESS (0.004s)
[554.191423] Starting dynamic subtest: ccs0
[554.195451] Dynamic subtest ccs0: SUCCESS (0.004s)
[554.197321] Subtest dispatch: SUCCESS (0.033s)
[555.387660] [132/156] (468s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[555.501242] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[555.505508] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[555.594296] [133/156] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[555.705875] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[555.710282] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[555.795426] [134/156] (468s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[555.904970] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[555.909179] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[556.019620] [135/156] (468s left) gem_ctx_persistence (saturated-hostile)
[556.087664] Starting subtest: saturated-hostile
[556.089992] Starting dynamic subtest: rcs0
[556.908353] Dynamic subtest rcs0: SUCCESS (0.820s)
[556.923488] Starting dynamic subtest: bcs0
[557.696360] Dynamic subtest bcs0: SUCCESS (0.786s)
[557.711091] Starting dynamic subtest: vcs0
[558.493247] Dynamic subtest vcs0: SUCCESS (0.795s)
[558.506305] Starting dynamic subtest: vcs1
[559.298817] Dynamic subtest vcs1: SUCCESS (0.803s)
[559.312282] Starting dynamic subtest: vecs0
[560.107575] Dynamic subtest vecs0: SUCCESS (0.806s)
[560.120778] Starting dynamic subtest: ccs0
[560.949431] Dynamic subtest ccs0: SUCCESS (0.840s)
[560.951958] Subtest saturated-hostile: SUCCESS (4.863s)
[561.087184] [136/156] (463s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[561.150708] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[561.216206] [137/156] (463s left) gem_exec_params (rs-invalid)
[561.285555] Starting subtest: rs-invalid
[561.287825] Subtest rs-invalid: SUCCESS (0.003s)
[561.423143] [138/156] (463s left) gem_close (basic)
[561.473363] Starting subtest: basic
[561.476074] Subtest basic: SUCCESS (0.000s)
[561.596074] [139/156] (462s left) kms_concurrent (multi-plane-atomic-lowres)
[561.691915] Starting subtest: multi-plane-atomic-lowres
[561.694220] Starting dynamic subtest: pipe-A-eDP-1
[562.228269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[562.238367] Starting dynamic subtest: pipe-B-eDP-1
[563.491943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[563.504194] Starting dynamic subtest: pipe-C-eDP-1
[564.715678] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.222s)
[564.726460] Starting dynamic subtest: pipe-D-eDP-1
[565.947157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[565.949509] Subtest multi-plane-atomic-lowres: SUCCESS (4.254s)
[566.772069] [140/156] (457s left) api_intel_bb (blit-reloc-keep-cache)
[566.823988] Starting subtest: blit-reloc-keep-cache
[566.828259] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[566.952328] [141/156] (457s left) gem_ppgtt (blt-vs-render-ctxn)
[567.008653] Starting subtest: blt-vs-render-ctxN
[599.741134] Subtest blt-vs-render-ctxN: SUCCESS (32.728s)
[599.885616] [142/156] (424s left) kms_big_fb (linear-8bpp-rotate-180)
[600.041453] Starting subtest: linear-8bpp-rotate-180
[601.421767] Subtest linear-8bpp-rotate-180: SUCCESS (1.381s)
[601.544227] [143/156] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[601.650358] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[608.484134] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.838s)
[608.638209] [144/156] (416s left) sysfs_heartbeat_interval (mixed)
[608.699867] Starting subtest: mixed
[608.702285] Starting dynamic subtest: vecs0
[613.897138] Dynamic subtest vecs0: SUCCESS (5.198s)
[613.917716] Starting dynamic subtest: ccs0
[619.089473] Dynamic subtest ccs0: SUCCESS (5.189s)
[619.103204] Starting dynamic subtest: vcs0
[624.279289] Dynamic subtest vcs0: SUCCESS (5.188s)
[624.293371] Starting dynamic subtest: bcs0
[629.502071] Dynamic subtest bcs0: SUCCESS (5.220s)
[629.516030] Starting dynamic subtest: rcs0
[634.722371] Dynamic subtest rcs0: SUCCESS (5.218s)
[634.733630] Starting dynamic subtest: vcs1
[639.938975] Dynamic subtest vcs1: SUCCESS (5.215s)
[639.941665] Subtest mixed: SUCCESS (31.241s)
[640.020625] [145/156] (384s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[640.121935] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[640.126311] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[640.223886] [146/156] (384s left) kms_selftest (drm_dp_mst_helper)
[640.269894] Starting subtest: drm_dp_mst_helper
[640.331077] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[640.435327] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.105s)
[640.447461] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[640.541725] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[640.552669] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[640.668914] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s)
[640.671108] Subtest drm_dp_mst_helper: SUCCESS (0.399s)
[640.851317] [147/156] (384s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[640.906524] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[641.007467] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[641.085064] [148/156] (383s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[641.181813] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[641.186219] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[641.282983] [149/156] (383s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[641.385727] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[645.443263] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.064s)
[646.637623] [150/156] (378s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[646.741544] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[646.745725] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[646.842185] [151/156] (378s left) gem_exec_fence (syncobj-invalid-wait)
[647.258128] Starting subtest: syncobj-invalid-wait
[647.260529] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[648.377152] [152/156] (376s left) kms_psr (fbc-psr-cursor-blt)
[648.470107] Starting subtest: fbc-psr-cursor-blt
[648.472401] Starting dynamic subtest: eDP-1
[648.476490] Dynamic subtest eDP-1: SKIP (0.000s)
[648.480593] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[648.545173] [153/156] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[648.644045] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[656.109264] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.471s)
[656.238761] [154/156] (368s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[656.349643] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[656.351913] Starting dynamic subtest: pipe-A-eDP-1
[662.251544] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.903s)
[662.262683] Starting dynamic subtest: pipe-B-eDP-1
[668.910936] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.658s)
[668.913302] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.564s)
[669.784888] [155/156] (355s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[669.900849] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[669.902894] Starting dynamic subtest: pipe-A-eDP-1
[670.054503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[670.069090] Starting dynamic subtest: pipe-B-eDP-1
[670.088774] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[670.099616] Starting dynamic subtest: pipe-C-eDP-1
[670.119331] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[670.128816] Starting dynamic subtest: pipe-D-eDP-1
[670.147539] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[670.149419] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[672.366875] [156/156] (352s left) gem_mmap_gtt (basic-small-copy-odd)
[672.428306] Subtest basic-small-copy-odd: SKIP (0.000s)
[672.481939] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_fbcon_fbt
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: gem_sync
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: i915_pm_rps
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_vrr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_pipe_crc_basic
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: gem_exec_await
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: i915_pm_freq_api
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_feature_discovery
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: gem_ctx_sseu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_joiner
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_vm_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_edge_walk
results: parsing output: 51/ for test: kms_cdclk
results: parsing output: 52/ for test: gem_create
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_workarounds
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: kms_getfb
results: parsing output: 64/ for test: gem_madvise
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: api_intel_bb
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: gem_workarounds
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_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen7_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_chamelium_frames
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: gem_ctx_param
results: parsing output: 100/ for test: kms_rotation_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_pipe_crc_basic
results: parsing output: 108/ for test: i915_query
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: dmabuf_sync_file
results: parsing output: 111/ for test: gem_mmap_offset
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_debugfs
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: gem_reg_read
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: kms_pm_dc
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: gem_exec_endless
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_ctx_persistence
results: parsing output: 135/ for test: kms_pipe_b_c_ivb
results: parsing output: 136/ for test: gem_exec_params
results: parsing output: 137/ for test: gem_close
results: parsing output: 138/ for test: kms_concurrent
results: parsing output: 139/ for test: api_intel_bb
results: parsing output: 140/ for test: gem_ppgtt
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: sysfs_heartbeat_interval
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_selftest
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_psr2_sf
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: gem_mmap_gtt
Done.