[60.406369] Initializing watchdogs
[60.406418]   /dev/watchdog0
[60.422105] [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]
[60.426563] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.428825] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.433105] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[60.576196] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[60.580269] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.686458] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[60.784712] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[60.787083] Starting dynamic subtest: pipe-A-default-mode
[63.544559] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s)
[63.546839] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.747s)
[64.385367] [003/131] (956s left) gem_exec_fence (submit67)
[64.583493] Starting subtest: submit67
[64.587913] Subtest submit67: SKIP (0.000s)
[66.397621] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[66.400991] [004/131] (954s left) kms_addfb_basic (tile-pitch-mismatch)
[66.458002] Starting subtest: tile-pitch-mismatch
[66.462776] Subtest tile-pitch-mismatch: SKIP (0.000s)
[66.582602] [005/131] (954s left) drm_read (empty-block)
[66.750545] Starting subtest: empty-block
[67.751597] Subtest empty-block: SUCCESS (0.998s)
[67.886403] [006/131] (953s left) syncobj_timeline (signal-point-0)
[67.946213] Starting subtest: signal-point-0
[67.948713] Subtest signal-point-0: SUCCESS (0.000s)
[68.045195] [007/131] (953s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[68.109637] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[68.114268] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[68.291786] [008/131] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[68.406183] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[68.410104] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[68.504039] [009/131] (952s left) kms_cursor_crc (cursor-offscreen-128x128)
[68.703706] Starting subtest: cursor-offscreen-128x128
[68.705990] Starting dynamic subtest: pipe-A-eDP-1
[70.643537] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[70.674370] Starting dynamic subtest: pipe-D-eDP-1
[73.352384] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.685s)
[73.354895] Subtest cursor-offscreen-128x128: SUCCESS (4.644s)
[74.154448] [010/131] (947s left) gem_ppgtt (blt-vs-render-ctxn)
[74.216696] Starting subtest: blt-vs-render-ctxN
[107.097055] Subtest blt-vs-render-ctxN: SUCCESS (32.866s)
[107.250628] [011/131] (914s left) gem_exec_fence (syncobj-timeline-unused-fence)
[107.887806] Starting subtest: syncobj-timeline-unused-fence
[107.896087] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s)
[109.426902] [012/131] (911s left) gem_pwrite (basic-random)
[109.501390] Subtest basic-random: SKIP (0.000s)
[109.559918] [013/131] (911s left) gem_mmap_gtt (pf-nonblock)
[109.620215] Subtest pf-nonblock: SKIP (0.000s)
[109.686203] [014/131] (911s left) gem_userptr_blits (dmabuf-sync)
[109.757830] Starting subtest: dmabuf-sync
[109.762116] Subtest dmabuf-sync: SKIP (0.002s)
[109.921468] [015/131] (911s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[110.011597] Starting subtest: random-ccs-data-y-tiled-ccs
[110.013883] Starting dynamic subtest: pipe-A-eDP-1
[110.039418] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[110.049900] Starting dynamic subtest: pipe-B-eDP-1
[110.073695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[110.082583] Starting dynamic subtest: pipe-C-eDP-1
[110.105543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[110.113815] Starting dynamic subtest: pipe-D-eDP-1
[110.137713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[110.142118] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[112.329462] [016/131] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[112.427119] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[112.431669] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[112.526016] [017/131] (909s left) kms_psr (fbc-pr-primary-blt)
[112.628473] Starting subtest: fbc-pr-primary-blt
[112.632722] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[112.699912] [018/131] (908s left) kms_lease (lease-revoke)
[112.810835] Starting subtest: lease-revoke
[112.813508] Starting dynamic subtest: pipe-A-eDP-1
[112.848711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.035s)
[112.862238] Starting dynamic subtest: pipe-B-eDP-1
[112.874090] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[112.882568] Starting dynamic subtest: pipe-C-eDP-1
[112.901081] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[112.909667] Starting dynamic subtest: pipe-D-eDP-1
[112.930344] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[112.932608] Subtest lease-revoke: SUCCESS (0.121s)
[113.057627] [019/131] (908s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[113.153233] Starting subtest: psr-rgb101010-draw-mmap-gtt
[113.157453] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[113.258149] [020/131] (908s left) kms_vblank (wait-idle)
[113.346089] Starting subtest: wait-idle
[113.347718] Starting dynamic subtest: pipe-A-eDP-1
[115.100289] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[115.115396] Starting dynamic subtest: pipe-D-eDP-1
[117.585989] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.483s)
[117.588104] Subtest wait-idle: SUCCESS (4.238s)
[118.394881] [021/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[118.497639] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[118.501805] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.590965] [022/131] (903s left) kms_chamelium_frames (hdmi-crc-fast)
[118.963707] Subtest hdmi-crc-fast: SKIP (0.000s)
[119.800920] [023/131] (902s left) kms_flip (2x-flip-vs-wf_vblank)
[119.893142] Starting subtest: 2x-flip-vs-wf_vblank
[119.904307] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[119.980887] [024/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[120.070952] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[120.075033] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[120.166721] [025/131] (901s left) kms_plane_alpha_blend (constant-alpha-mid)
[120.257310] Starting subtest: constant-alpha-mid
[120.539822] Starting dynamic subtest: pipe-A-eDP-1
[121.440851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[121.450726] Starting dynamic subtest: pipe-D-eDP-1
[122.916874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.476s)
[122.919274] Subtest constant-alpha-mid: SUCCESS (2.662s)
[123.799245] [026/131] (898s left) gem_ctx_persistence (hang)
[123.853927] Starting subtest: hang
[123.858719] Subtest hang: SKIP (0.000s)
[123.954070] [027/131] (898s left) kms_psr (fbc-psr2-primary-render)
[124.035983] Starting subtest: fbc-psr2-primary-render
[124.038316] Starting dynamic subtest: eDP-1
[124.042692] Dynamic subtest eDP-1: SKIP (0.000s)
[124.047113] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[124.108991] [028/131] (897s left) gem_ctx_param (vm)
[124.171620] Starting subtest: vm
[124.221324] Subtest vm: SUCCESS (0.049s)
[124.343730] [029/131] (897s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[124.412586] Starting subtest: invalid-multi-wait-unsubmitted
[124.414827] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[124.504255] [030/131] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[124.608960] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[131.943051] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.337s)
[132.075805] [031/131] (890s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[132.186206] Starting subtest: yf-tiled-16bpp-rotate-90
[132.190711] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[132.280935] [032/131] (889s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[132.663288] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[133.447777] [033/131] (888s left) i915_suspend (forcewake)
[133.497192] Starting subtest: forcewake
[166.989113] Subtest forcewake: SUCCESS (3.192s)
[173.076635] [034/131] (855s left) kms_addfb_basic (bad-pitch-128)
[173.149990] Starting subtest: bad-pitch-128
[173.152362] Subtest bad-pitch-128: SUCCESS (0.000s)
[173.342030] [035/131] (855s left) kms_selftest (drm_plane_helper)
[173.396800] Starting subtest: drm_plane_helper
[173.408192] Starting dynamic subtest: drm_test_check_plane_state
[173.511998] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.100s)
[173.522741] Starting dynamic subtest: drm_test_check_invalid_plane_state
[173.608849] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.096s)
[173.611232] Subtest drm_plane_helper: SUCCESS (0.207s)
[173.759314] [036/131] (854s left) prime_vgem (basic-read)
[173.844604] Starting subtest: basic-read
[173.852120] Subtest basic-read: SKIP (0.005s)
[173.968904] [037/131] (854s left) gem_spin_batch (spin-each)
[174.046816] Starting subtest: spin-each
[177.437001] Subtest spin-each: SUCCESS (3.321s)
[177.668134] [038/131] (850s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[177.771980] Starting subtest: fbc-dirtyfb-ioctl
[177.774462] Starting dynamic subtest: A-eDP-1
[180.416668] Dynamic subtest A-eDP-1: SUCCESS (2.614s)
[180.419085] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.615s)
[181.246328] [039/131] (847s left) gem_exec_schedule (u-fairslice-all)
[181.327650] Starting subtest: u-fairslice-all
[183.384872] Subtest u-fairslice-all: SUCCESS (2.047s)
[184.723632] [040/131] (843s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[184.837517] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[184.842147] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[184.946028] [041/131] (843s left) gem_close_race (basic-process)
[185.024942] Starting subtest: basic-process
[185.074801] Subtest basic-process: SUCCESS (0.052s)
[185.263250] [042/131] (843s left) kms_invalid_mode (bad-htotal)
[185.359609] Starting subtest: bad-htotal
[185.361947] Starting dynamic subtest: pipe-A-eDP-1
[185.650173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[185.663709] Starting dynamic subtest: pipe-B-eDP-1
[185.666089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[185.675659] Starting dynamic subtest: pipe-C-eDP-1
[185.677708] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[185.687433] Starting dynamic subtest: pipe-D-eDP-1
[185.689831] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[185.692305] Subtest bad-htotal: SUCCESS (0.297s)
[186.505212] [043/131] (842s left) kms_flip (basic-flip-vs-modeset)
[186.601080] Starting subtest: basic-flip-vs-modeset
[186.603406] Starting dynamic subtest: A-eDP1
[189.189837] Dynamic subtest A-eDP1: SUCCESS (2.577s)
[189.200938] Starting dynamic subtest: B-eDP1
[191.371491] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[191.380733] Starting dynamic subtest: C-eDP1
[193.528072] Dynamic subtest C-eDP1: SUCCESS (2.152s)
[193.539382] Starting dynamic subtest: D-eDP1
[195.614622] Dynamic subtest D-eDP1: SUCCESS (2.081s)
[195.616781] Subtest basic-flip-vs-modeset: SUCCESS (8.989s)
[196.420461] [044/131] (832s left) gem_watchdog (default-virtual)
[196.491941] Starting subtest: default-virtual
[202.771386] Subtest default-virtual: SUCCESS (6.281s)
[202.871274] [045/131] (825s left) perf_pmu (init-busy)
[202.913548] Starting subtest: init-busy
[202.916081] Starting dynamic subtest: rcs0
[202.918427] Dynamic subtest rcs0: SUCCESS (0.002s)
[202.929869] Starting dynamic subtest: bcs0
[202.932050] Dynamic subtest bcs0: SUCCESS (0.000s)
[202.941237] Starting dynamic subtest: vcs0
[202.943626] Dynamic subtest vcs0: SUCCESS (0.001s)
[202.956437] Starting dynamic subtest: vcs1
[202.958610] Dynamic subtest vcs1: SUCCESS (0.001s)
[202.967680] Starting dynamic subtest: vecs0
[202.969545] Dynamic subtest vecs0: SUCCESS (0.001s)
[202.979075] Starting dynamic subtest: ccs0
[202.981290] Dynamic subtest ccs0: SUCCESS (0.000s)
[202.983614] Subtest init-busy: SUCCESS (0.008s)
[203.039372] [046/131] (825s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[203.128733] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[203.130904] Starting dynamic subtest: pipe-A-eDP-1
[203.152717] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[203.163950] Starting dynamic subtest: pipe-B-eDP-1
[203.183969] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[203.192872] Starting dynamic subtest: pipe-C-eDP-1
[203.214873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[203.223939] Starting dynamic subtest: pipe-D-eDP-1
[203.245586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[203.249655] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[205.380095] [047/131] (823s left) kms_pm_dc (dc6-psr)
[206.491185] Starting subtest: dc6-psr
[209.372813] Subtest dc6-psr: SUCCESS (2.880s)
[210.215746] [048/131] (818s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[210.324243] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[210.326623] Starting dynamic subtest: pipe-A-default-mode
[211.465481] Dynamic subtest pipe-A-default-mode: SKIP (1.138s)
[211.470112] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.140s)
[211.626004] [049/131] (817s left) gem_unref_active_buffers
[211.835673] [050/131] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[211.948580] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[211.952979] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[212.051194] [051/131] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[212.146672] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[216.588361] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.445s)
[217.745314] [052/131] (811s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[217.870261] Starting subtest: cursorA-vs-flipB-atomic-transitions
[217.874930] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[218.018537] [053/131] (811s left) kms_setmode (basic)
[218.077629] Starting subtest: basic
[218.403322] Starting dynamic subtest: pipe-A-eDP-1
[220.462805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.055s)
[220.811982] Starting dynamic subtest: pipe-B-eDP-1
[222.889160] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.081s)
[223.196764] Subtest basic: SUCCESS (5.115s)
[224.036728] [054/131] (805s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[224.153013] Starting subtest: y-tiled-64bpp-rotate-0
[224.157241] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[224.246183] [055/131] (805s left) kms_feature_discovery (display-1x)
[224.345747] Starting subtest: display-1x
[224.348011] Subtest display-1x: SUCCESS (0.000s)
[224.421233] [056/131] (804s left) gem_exec_reloc (basic-wc-noreloc)
[224.478015] Subtest basic-wc-noreloc: SKIP (0.000s)
[224.567759] [057/131] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[224.659382] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[224.663253] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[224.766763] [058/131] (804s left) gem_exec_reloc (basic-wc-read-noreloc)
[224.819657] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[224.893959] [059/131] (804s left) kms_color (ctm-red-to-blue)
[224.996453] Starting subtest: ctm-red-to-blue
[224.998312] Starting dynamic subtest: pipe-A-eDP-1
[225.707077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[225.716349] Starting dynamic subtest: pipe-B-eDP-1
[227.148105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[227.158101] Starting dynamic subtest: pipe-C-eDP-1
[228.522504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[228.532651] Starting dynamic subtest: pipe-D-eDP-1
[229.839753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[229.842038] Subtest ctm-red-to-blue: SUCCESS (4.841s)
[230.648932] [060/131] (798s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[230.745564] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[230.747737] Starting dynamic subtest: pipe-A
[231.098958] Dynamic subtest pipe-A: SUCCESS (0.355s)
[231.109261] Starting dynamic subtest: pipe-B
[232.530882] Dynamic subtest pipe-B: SUCCESS (1.431s)
[232.540927] Starting dynamic subtest: pipe-C
[233.974156] Dynamic subtest pipe-C: SUCCESS (1.442s)
[233.984536] Starting dynamic subtest: pipe-D
[235.450161] Dynamic subtest pipe-D: SUCCESS (1.475s)
[235.452451] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.706s)
[236.585089] [061/131] (792s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[236.696137] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[236.700164] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[236.799217] [062/131] (792s left) kms_rmfb (rmfb-ioctl)
[236.896963] Starting subtest: rmfb-ioctl
[236.899064] Starting dynamic subtest: pipe-A-eDP-1
[237.003305] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[237.015071] Starting dynamic subtest: pipe-B-eDP-1
[238.143517] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[238.155002] Starting dynamic subtest: pipe-C-eDP-1
[239.267868] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[239.277672] Starting dynamic subtest: pipe-D-eDP-1
[240.396214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[240.398475] Subtest rmfb-ioctl: SUCCESS (3.501s)
[241.619307] [063/131] (787s left) kms_force_connector_basic (prune-stale-modes)
[241.716055] Starting subtest: prune-stale-modes
[242.028733] Subtest prune-stale-modes: SUCCESS (0.315s)
[242.187577] [064/131] (787s left) kms_properties (connector-properties-atomic)
[242.281194] Starting subtest: connector-properties-atomic
[242.283082] Starting dynamic subtest: pipe-A-eDP-1
[250.394610] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.111s)
[250.404769] Starting dynamic subtest: pipe-None-DP-1
[250.409318] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[250.418106] Starting dynamic subtest: pipe-None-HDMI-A-1
[250.422301] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[250.431471] Starting dynamic subtest: pipe-None-DP-2
[250.435969] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[250.445389] Starting dynamic subtest: pipe-None-HDMI-A-2
[250.449928] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[250.459431] Starting dynamic subtest: pipe-None-DP-3
[250.464165] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[250.473566] Starting dynamic subtest: pipe-None-DP-4
[250.478366] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[250.480730] Subtest connector-properties-atomic: SUCCESS (8.123s)
[251.234050] [065/131] (778s left) syncobj_timeline (etime-multi-wait-submitted)
[251.301455] Starting subtest: etime-multi-wait-submitted
[251.406508] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[251.483629] [066/131] (778s left) kms_psr (fbc-psr2-sprite-render)
[251.578234] Starting subtest: fbc-psr2-sprite-render
[251.580602] Starting dynamic subtest: eDP-1
[251.585213] Dynamic subtest eDP-1: SKIP (0.000s)
[251.589819] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[251.650721] [067/131] (778s left) kms_cursor_crc (cursor-random-512x512)
[251.939585] Starting subtest: cursor-random-512x512
[251.944154] Subtest cursor-random-512x512: SKIP (0.001s)
[252.088681] [068/131] (777s left) gem_flink_basic (flink-lifetime)
[252.149390] Starting subtest: flink-lifetime
[252.151798] Subtest flink-lifetime: SUCCESS (0.002s)
[252.250120] [069/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[252.343306] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[252.347568] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[252.444747] [070/131] (777s left) kms_plane_multiple (2x-tiling-none)
[252.536123] Starting subtest: 2x-tiling-none
[252.539660] Subtest 2x-tiling-none: SKIP (0.000s)
[252.608462] [071/131] (777s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[252.695381] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[252.721404] Starting dynamic subtest: pipe-A-plane-0
[253.154623] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[253.163949] Starting dynamic subtest: pipe-A-plane-3
[253.410635] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[254.500333] Starting dynamic subtest: pipe-B-plane-0
[254.941786] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[254.966560] Starting dynamic subtest: pipe-B-plane-3
[255.203418] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[255.512918] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.817s)
[256.943082] [072/131] (773s left) kms_busy (extended-pageflip-hang-oldfb)
[257.057144] Starting subtest: extended-pageflip-hang-oldfb
[257.059495] Starting dynamic subtest: pipe-A
[257.472116] Dynamic subtest pipe-A: SUCCESS (0.415s)
[257.482540] Starting dynamic subtest: pipe-D
[258.625815] Dynamic subtest pipe-D: SUCCESS (1.150s)
[258.628079] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.570s)
[259.441394] [073/131] (770s left) gen9_exec_parse (bb-oversize)
[259.497215] Subtest bb-oversize: SKIP (0.000s)
[259.568069] [074/131] (770s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[259.660116] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[264.162295] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.502s)
[265.353814] [075/131] (764s left) gem_render_copy (linear-to-vebox-yf-tiled)
[265.416861] Starting subtest: linear-to-vebox-yf-tiled
[265.420981] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[265.615730] [076/131] (764s left) gem_readwrite (write-bad-handle)
[265.686371] Subtest write-bad-handle: SKIP (0.000s)
[265.753151] [077/131] (764s left) prime_self_import (basic-with_two_bos)
[265.795675] Starting subtest: basic-with_two_bos
[265.812059] Subtest basic-with_two_bos: SUCCESS (0.016s)
[265.931282] [078/131] (764s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[266.028341] Starting subtest: pr-cursor-plane-move-continuous-sf
[266.032218] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[266.098845] [079/131] (764s left) kms_pm_rpm (i2c)
[267.824563] Starting subtest: i2c
[273.348799] Subtest i2c: SUCCESS (5.528s)
[273.452278] [080/131] (756s left) dmabuf_sync_file (import-multiple-read-only)
[273.500123] Starting subtest: import-multiple-read-only
[273.504576] Subtest import-multiple-read-only: SUCCESS (0.006s)
[273.557448] [081/131] (756s left) perf_pmu (busy-double-start)
[273.600939] Starting subtest: busy-double-start
[273.602845] Starting dynamic subtest: rcs0
[277.246344] Dynamic subtest rcs0: FAIL (3.590s)
[277.257439] Starting dynamic subtest: bcs0
[280.769226] Dynamic subtest bcs0: SUCCESS (3.568s)
[280.781954] Starting dynamic subtest: vcs0
[285.137599] Dynamic subtest vcs0: SUCCESS (4.379s)
[285.149523] Starting dynamic subtest: vcs1
[289.143597] Dynamic subtest vcs1: SUCCESS (4.004s)
[289.155580] Starting dynamic subtest: vecs0
[293.114809] Dynamic subtest vecs0: SUCCESS (3.969s)
[293.126821] Starting dynamic subtest: ccs0
[296.751831] Dynamic subtest ccs0: FAIL (3.566s)
[296.753816] Subtest busy-double-start: FAIL (23.086s)
[296.797112] [082/131] (733s left) api_intel_bb (intel-bb-blit-y)
[296.869226] Starting subtest: intel-bb-blit-y
[300.382300] Subtest intel-bb-blit-y: SUCCESS (3.514s)
[300.494395] [083/131] (729s left) gem_exec_params (no-vebox)
[300.554202] Starting subtest: no-vebox
[300.559150] Subtest no-vebox: SUCCESS (0.004s)
[301.691715] [084/131] (728s left) syncobj_wait (invalid-signal-one-illegal-handle)
[301.762704] Starting subtest: invalid-signal-one-illegal-handle
[301.765193] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[301.877512] [085/131] (728s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[302.001366] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[303.091368] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s)
[303.213433] [086/131] (727s left) i915_drm_fdinfo (busy-idle)
[303.257120] Starting subtest: busy-idle
[303.258878] Starting dynamic subtest: rcs0
[303.277854] Dynamic subtest rcs0: SKIP (0.019s)
[303.289012] Starting dynamic subtest: bcs0
[303.292589] Dynamic subtest bcs0: SKIP (0.000s)
[303.301621] Starting dynamic subtest: vcs0
[303.304954] Dynamic subtest vcs0: SKIP (0.000s)
[303.314257] Starting dynamic subtest: vcs1
[303.317808] Dynamic subtest vcs1: SKIP (0.000s)
[303.326991] Starting dynamic subtest: vecs0
[303.330413] Dynamic subtest vecs0: SKIP (0.000s)
[303.339556] Starting dynamic subtest: ccs0
[303.343011] Dynamic subtest ccs0: SKIP (0.000s)
[303.346405] Subtest busy-idle: SKIP (0.024s)
[303.384836] [087/131] (727s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[303.476405] Starting subtest: bad-aux-stride-yf-tiled-ccs
[303.478290] Starting dynamic subtest: pipe-A-eDP-1
[303.496723] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[303.509615] Starting dynamic subtest: pipe-B-eDP-1
[303.526512] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[303.535613] Starting dynamic subtest: pipe-C-eDP-1
[303.552517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[303.561881] Starting dynamic subtest: pipe-D-eDP-1
[303.581254] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[303.584763] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[305.789069] [088/131] (724s left) gem_exec_params (invalid-bsd2-flag-on-render)
[305.858757] Starting subtest: invalid-bsd2-flag-on-render
[305.861058] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[305.957168] [089/131] (724s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[306.070667] Starting subtest: cursorB-vs-flipA-toggle
[306.075007] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[306.227814] [090/131] (724s left) gem_exec_balancer (bonded-pair)
[306.294462] Starting subtest: bonded-pair
[306.299078] Subtest bonded-pair: SKIP (0.000s)
[306.602437] [091/131] (724s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[306.705859] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[306.708138] Starting dynamic subtest: pipe-A-eDP-1
[306.729730] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.741030] Starting dynamic subtest: pipe-B-eDP-1
[306.761493] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.770995] Starting dynamic subtest: pipe-C-eDP-1
[306.791079] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.800275] Starting dynamic subtest: pipe-D-eDP-1
[306.820955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.825029] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[308.957747] [092/131] (721s left) i915_module_load (reload-no-display)
[309.016666] Starting subtest: reload-no-display
[315.158952] Subtest reload-no-display: SUCCESS (6.141s)
[315.193846] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[315.194566] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[315.197843] [093/131] (715s left) kms_flip (wf_vblank-ts-check-interruptible)
[316.788157] Starting subtest: wf_vblank-ts-check-interruptible
[316.792912] Starting dynamic subtest: A-eDP1
[325.767126] Dynamic subtest A-eDP1: SUCCESS (8.974s)
[325.779508] Starting dynamic subtest: B-eDP1
[334.707206] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[334.719929] Starting dynamic subtest: C-eDP1
[343.627125] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[343.638644] Starting dynamic subtest: D-eDP1
[352.566662] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[352.571745] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.775s)
[353.745952] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[353.747356] [FACT kms_flip (wf_vblank-ts-check-interruptible)] new: kernel.kmod_is_loaded.i915: true
[353.751596] [094/131] (677s left) kms_frontbuffer_tracking (fbc-tiling-4)
[353.861757] Starting subtest: fbc-tiling-4
[358.043707] Subtest fbc-tiling-4: SUCCESS (4.184s)
[359.219748] [095/131] (671s left) gem_huc_copy (huc-copy)
[359.299710] Starting subtest: huc-copy
[359.304517] Subtest huc-copy: SUCCESS (0.004s)
[359.415082] [096/131] (671s left) kms_psr (pr-dpms)
[359.505228] Starting subtest: pr-dpms
[359.509474] Subtest pr-dpms: SKIP (0.000s)
[359.581850] [097/131] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[359.681404] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[359.685571] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[359.787330] [098/131] (671s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[359.872617] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[359.875125] Starting dynamic subtest: pipe-A-eDP-1
[359.930548] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[359.940326] Starting dynamic subtest: pipe-B-eDP-1
[359.998175] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[360.009289] Starting dynamic subtest: pipe-C-eDP-1
[360.065923] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[360.075932] Starting dynamic subtest: pipe-D-eDP-1
[360.132943] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[360.137192] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[362.177751] [099/131] (668s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[362.281650] Starting subtest: 4-tiled-8bpp-rotate-180
[363.485559] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.204s)
[363.634388] [100/131] (667s left) gem_exec_whisper (basic-forked)
[363.704267] Starting subtest: basic-forked
[370.915510] Subtest basic-forked: SUCCESS (7.209s)
[371.107007] [101/131] (660s left) kms_atomic (crtc-invalid-params-fence)
[371.212946] Starting subtest: crtc-invalid-params-fence
[371.215255] Starting dynamic subtest: pipe-A-eDP-1
[371.623060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[371.625436] Subtest crtc-invalid-params-fence: SUCCESS (0.412s)
[372.428662] [102/131] (658s left) kms_content_protection (mei-interface)
[372.582309] Starting subtest: mei-interface
[372.587019] Subtest mei-interface: SKIP (0.001s)
[372.713876] [103/131] (658s left) prime_self_import (reimport-vs-gem_close-race)
[372.752519] Starting subtest: reimport-vs-gem_close-race
[377.837876] Subtest reimport-vs-gem_close-race: SUCCESS (5.083s)
[377.921175] [104/131] (653s left) kms_psr (psr2-sprite-render)
[378.011139] Starting subtest: psr2-sprite-render
[378.013527] Starting dynamic subtest: eDP-1
[379.820405] Dynamic subtest eDP-1: SUCCESS (1.809s)
[379.822879] Subtest psr2-sprite-render: SUCCESS (1.810s)
[380.683196] [105/131] (650s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[380.782076] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[380.784447] Starting dynamic subtest: pipe-A
[380.845260] Dynamic subtest pipe-A: SUCCESS (0.065s)
[380.856992] Starting dynamic subtest: pipe-B
[382.008201] Dynamic subtest pipe-B: SUCCESS (1.161s)
[382.019869] Starting dynamic subtest: pipe-C
[383.116981] Dynamic subtest pipe-C: SUCCESS (1.108s)
[383.127451] Starting dynamic subtest: pipe-D
[384.261587] Dynamic subtest pipe-D: SUCCESS (1.141s)
[384.264220] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.480s)
[385.443636] [106/131] (646s left) syncobj_basic (create-signaled)
[385.504708] Starting subtest: create-signaled
[385.506706] Subtest create-signaled: SUCCESS (0.000s)
[385.617367] [107/131] (645s left) api_intel_allocator (fork-simple-stress)
[385.678207] Starting subtest: fork-simple-stress
[391.080788] Subtest fork-simple-stress: SUCCESS (5.399s)
[391.215401] [108/131] (640s left) gem_mmap_gtt (cpuset-basic-small-copy)
[391.288345] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[391.363138] [109/131] (640s left) gem_ccs (block-copy-uncompressed)
[391.426603] Starting subtest: block-copy-uncompressed
[391.428876] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[391.453627] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.026s)
[391.464866] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[391.473092] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[391.482628] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[391.494175] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[391.503869] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[391.513425] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[391.515648] Subtest block-copy-uncompressed: SUCCESS (0.087s)
[391.651488] [110/131] (639s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[391.777448] Starting subtest: fbcpsr-slowdraw
[417.199439] Subtest fbcpsr-slowdraw: SUCCESS (25.429s)
[417.350803] [111/131] (614s left) gem_mmap_gtt (basic-read)
[417.416462] Subtest basic-read: SKIP (0.000s)
[417.474809] [112/131] (614s left) gem_exec_schedule (implicit-write-read)
[417.559935] Starting subtest: implicit-write-read
[417.562037] Starting dynamic subtest: rcs0
[417.665812] Dynamic subtest rcs0: SUCCESS (0.116s)
[417.677591] Starting dynamic subtest: vcs0
[417.754934] Dynamic subtest vcs0: SUCCESS (0.087s)
[417.769131] Starting dynamic subtest: vcs1
[417.839676] Dynamic subtest vcs1: SUCCESS (0.084s)
[417.851239] Starting dynamic subtest: vecs0
[417.920688] Dynamic subtest vecs0: SUCCESS (0.080s)
[417.932740] Starting dynamic subtest: ccs0
[418.008300] Dynamic subtest ccs0: SUCCESS (0.087s)
[418.010480] Subtest implicit-write-read: SUCCESS (0.459s)
[419.752135] [113/131] (612s left) syncobj_timeline (device-submit-unordered)
[419.809625] Starting subtest: device-submit-unordered
[419.811984] Subtest device-submit-unordered: SUCCESS (0.001s)
[419.914534] [114/131] (611s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[420.038365] Starting subtest: x-tiled-8bpp-rotate-180
[421.230249] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.192s)
[421.354103] [115/131] (610s left) syncobj_timeline (invalid-signal-illegal-handle)
[421.414603] Starting subtest: invalid-signal-illegal-handle
[421.416587] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[421.540409] [116/131] (610s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[421.637024] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[425.838589] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.205s)
[426.982016] [117/131] (604s left) kms_cursor_crc (cursor-sliding-512x512)
[427.241976] Starting subtest: cursor-sliding-512x512
[427.246191] Subtest cursor-sliding-512x512: SKIP (0.001s)
[427.390478] [118/131] (604s left) prime_self_import (basic-llseek-size)
[427.423922] Starting subtest: basic-llseek-size
[427.442339] Subtest basic-llseek-size: SUCCESS (0.020s)
[427.539655] [119/131] (604s left) sysfs_defaults (readonly)
[427.592345] Starting subtest: readonly
[427.594545] Starting dynamic subtest: vecs0
[427.596825] Dynamic subtest vecs0: SUCCESS (0.000s)
[427.606933] Starting dynamic subtest: ccs0
[427.608836] Dynamic subtest ccs0: SUCCESS (0.000s)
[427.618282] Starting dynamic subtest: vcs0
[427.620466] Dynamic subtest vcs0: SUCCESS (0.000s)
[427.629780] Starting dynamic subtest: bcs0
[427.632044] Dynamic subtest bcs0: SUCCESS (0.000s)
[427.641079] Starting dynamic subtest: rcs0
[427.643763] Dynamic subtest rcs0: SUCCESS (0.000s)
[427.653004] Starting dynamic subtest: vcs1
[427.655179] Dynamic subtest vcs1: SUCCESS (0.000s)
[427.657370] Subtest readonly: SUCCESS (0.006s)
[427.696316] [120/131] (604s left) prime_mmap_coherency (ioctl-errors)
[427.752179] Starting subtest: ioctl-errors
[430.710530] Subtest ioctl-errors: SUCCESS (2.956s)
[430.862097] [121/131] (601s left) syncobj_timeline (reset-multiple-signaled)
[430.959877] Starting subtest: reset-multiple-signaled
[430.961994] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[431.068706] [122/131] (601s left) kms_async_flips (async-flip-suspend-resume)
[431.170996] Starting subtest: async-flip-suspend-resume
[431.541845] Starting dynamic subtest: pipe-A-eDP-1
[449.978284] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.122s)
[450.348212] Starting dynamic subtest: pipe-B-eDP-1
[468.975660] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.287s)
[469.354020] Starting dynamic subtest: pipe-C-eDP-1
[487.989119] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.313s)
[488.354166] Starting dynamic subtest: pipe-D-eDP-1
[506.996981] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.306s)
[506.999453] Subtest async-flip-suspend-resume: SUCCESS (15.489s)
[514.196854] [123/131] (524s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[514.322367] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[514.326558] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[514.398284] [124/131] (523s left) i915_pm_rc6_residency (media-rc6-accuracy)
[514.457215] Starting subtest: media-rc6-accuracy
[514.461319] Subtest media-rc6-accuracy: SKIP (0.000s)
[514.572056] [125/131] (523s left) perf_pmu (semaphore-busy)
[514.618492] Starting subtest: semaphore-busy
[514.620902] Starting dynamic subtest: rcs0
[516.263697] Dynamic subtest rcs0: SUCCESS (1.641s)
[516.276167] Starting dynamic subtest: bcs0
[516.889493] Dynamic subtest bcs0: FAIL (0.576s)
[516.899715] Starting dynamic subtest: vcs0
[517.459512] Dynamic subtest vcs0: FAIL (0.551s)
[517.471404] Starting dynamic subtest: vcs1
[518.516457] Dynamic subtest vcs1: FAIL (1.055s)
[518.528461] Starting dynamic subtest: vecs0
[520.564542] Dynamic subtest vecs0: FAIL (2.046s)
[520.576552] Starting dynamic subtest: ccs0
[522.547016] Dynamic subtest ccs0: FAIL (1.985s)
[522.549146] Subtest semaphore-busy: FAIL (7.862s)
[522.594101] [126/131] (515s left) kms_tv_load_detect (load-detect)
[522.656872] Subtest load-detect: SKIP (0.000s)
[522.717104] [127/131] (515s left) gem_create (create-ext-placement-all)
[522.901734] Starting subtest: create-ext-placement-all
[522.904344] Subtest create-ext-placement-all: SUCCESS (0.000s)
[523.004190] [128/131] (515s left) gem_sync (basic-store-all)
[523.080351] Starting subtest: basic-store-all
[525.412279] Subtest basic-store-all: SUCCESS (2.341s)
[525.616618] [129/131] (512s left) gem_exec_endless (dispatch)
[525.697256] Starting subtest: dispatch
[525.699284] Starting dynamic subtest: rcs0
[525.703892] Dynamic subtest rcs0: SUCCESS (0.005s)
[525.718366] Starting dynamic subtest: bcs0
[525.723053] Dynamic subtest bcs0: SUCCESS (0.005s)
[525.735223] Starting dynamic subtest: vcs0
[525.739576] Dynamic subtest vcs0: SUCCESS (0.004s)
[525.749921] Starting dynamic subtest: vcs1
[525.754294] Dynamic subtest vcs1: SUCCESS (0.004s)
[525.764472] Starting dynamic subtest: vecs0
[525.768935] Dynamic subtest vecs0: SUCCESS (0.004s)
[525.778774] Starting dynamic subtest: ccs0
[525.783182] Dynamic subtest ccs0: SUCCESS (0.004s)
[525.785377] Subtest dispatch: SUCCESS (0.031s)
[527.000323] [130/131] (511s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[527.128115] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[533.895338] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.674s)
[534.025793] [131/131] (504s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[534.125914] Starting subtest: invalidate-primary-flip-overlay
[544.883407] Subtest invalidate-primary-flip-overlay: SUCCESS (10.677s)
[545.006210] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: drm_read
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: gem_ppgtt
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_pwrite
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_alpha_blend
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: i915_suspend
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_selftest
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: gem_spin_batch
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_close_race
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_watchdog
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_pm_dc
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_unref_active_buffers
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_setmode
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_feature_discovery
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_color
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: kms_force_connector_basic
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_flink_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane_multiple
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_render_copy
results: parsing output: 75/ for test: gem_readwrite
results: parsing output: 76/ for test: prime_self_import
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: dmabuf_sync_file
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: i915_module_load
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_huc_copy
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: kms_atomic
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: prime_self_import
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: syncobj_basic
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_ccs
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: sysfs_defaults
results: parsing output: 119/ for test: prime_mmap_coherency
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: i915_pm_rc6_residency
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_tv_load_detect
results: parsing output: 126/ for test: gem_create
results: parsing output: 127/ for test: gem_sync
results: parsing output: 128/ for test: gem_exec_endless
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr_stress_test
Done.