[57.877770] Initializing watchdogs
[57.877899]   /dev/watchdog0
[57.893457] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.897732] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.899952] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.903190] [001/131] (960s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[57.989167] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[58.059080] [002/131] (960s left) gem_exec_reloc (basic-write-read-noreloc)
[58.109227] Subtest basic-write-read-noreloc: SKIP (0.000s)
[58.183585] [003/131] (960s left) gem_ctx_exec (basic-invalid-context)
[58.245608] Starting subtest: basic-invalid-context
[58.252066] Subtest basic-invalid-context: SUCCESS (0.008s)
[58.420522] [004/131] (960s left) perf_pmu (enable-race)
[58.458902] Starting subtest: enable-race
[58.461284] Starting dynamic subtest: rcs0
[71.238966] Dynamic subtest rcs0: SUCCESS (12.780s)
[71.246547] Starting dynamic subtest: bcs0
[83.979304] Dynamic subtest bcs0: SUCCESS (12.739s)
[83.986914] Starting dynamic subtest: vcs0
[99.924023] Dynamic subtest vcs0: SUCCESS (15.942s)
[99.934492] Starting dynamic subtest: vcs1
[115.859908] Dynamic subtest vcs1: SUCCESS (15.935s)
[115.868484] Starting dynamic subtest: vecs0
[131.861857] Dynamic subtest vecs0: SUCCESS (16.001s)
[131.871814] Starting dynamic subtest: ccs0
[144.606150] Dynamic subtest ccs0: SUCCESS (12.745s)
[144.608521] Subtest enable-race: SUCCESS (86.147s)
[144.739155] [005/131] (873s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[144.840800] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[148.360936] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.522s)
[149.518490] [006/131] (869s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[149.900125] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[150.688768] [007/131] (867s left) gem_close_race (multigpu-basic-process)
[150.754293] Starting subtest: multigpu-basic-process
[150.758696] Subtest multigpu-basic-process: SKIP (0.000s)
[151.007202] [008/131] (867s left) fbdev (pan)
[151.047234] Starting subtest: pan
[151.069238] Subtest pan: SUCCESS (0.026s)
[151.163155] [009/131] (867s left) gem_ctx_persistence (heartbeat-hang)
[151.223142] Starting subtest: heartbeat-hang
[151.227851] Subtest heartbeat-hang: SKIP (0.000s)
[151.384204] [010/131] (867s left) kms_psr (fbc-psr2-cursor-plane-move)
[151.486774] Starting subtest: fbc-psr2-cursor-plane-move
[151.488657] Starting dynamic subtest: eDP-1
[151.492720] Dynamic subtest eDP-1: SKIP (0.000s)
[151.496778] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[151.583511] [011/131] (867s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[156.627311] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[156.629733] Starting dynamic subtest: pipe-A-eDP-1
[168.351246] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.722s)
[168.360779] Starting dynamic subtest: pipe-B-eDP-1
[180.092254] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.736s)
[180.094503] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.462s)
[180.962641] [012/131] (837s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[181.020616] Starting subtest: invalid-single-wait-all-unsubmitted
[181.022576] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[181.133995] [013/131] (837s left) i915_drm_fdinfo (virtual-busy-hang)
[181.178613] Starting subtest: virtual-busy-hang
[181.183078] Subtest virtual-busy-hang: SKIP (0.000s)
[181.264396] [014/131] (837s left) gem_tiled_wc
[181.388430] [015/131] (837s left) kms_pm_rpm (legacy-planes-dpms)
[183.043981] Starting subtest: legacy-planes-dpms
[183.046407] Starting dynamic subtest: plane-63
[191.606083] Dynamic subtest plane-63: SUCCESS (8.561s)
[191.616581] Starting dynamic subtest: plane-93
[200.022319] Dynamic subtest plane-93: SUCCESS (8.416s)
[200.032952] Starting dynamic subtest: plane-123
[208.626537] Dynamic subtest plane-123: SUCCESS (8.602s)
[208.637086] Starting dynamic subtest: plane-133
[216.956474] Dynamic subtest plane-133: SUCCESS (8.328s)
[216.959508] Subtest legacy-planes-dpms: SUCCESS (33.911s)
[217.355122] [016/131] (801s left) kms_psr (psr2-cursor-mmap-gtt)
[217.461692] Starting subtest: psr2-cursor-mmap-gtt
[217.464588] Starting dynamic subtest: eDP-1
[219.193316] Dynamic subtest eDP-1: SUCCESS (1.730s)
[219.195553] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.731s)
[220.011406] [017/131] (798s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[220.150121] Starting subtest: cursorA-vs-flipB-legacy
[220.154690] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[220.315225] [018/131] (798s left) kms_flip (2x-flip-vs-dpms)
[220.423093] Starting subtest: 2x-flip-vs-dpms
[220.431996] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[220.575684] [019/131] (798s left) gem_exec_schedule (submit-late-slice)
[220.658332] Starting subtest: submit-late-slice
[220.660319] Starting dynamic subtest: rcs0
[220.687337] Dynamic subtest rcs0: SUCCESS (0.034s)
[220.695218] Starting dynamic subtest: bcs0
[220.715658] Dynamic subtest bcs0: SUCCESS (0.028s)
[220.723903] Starting dynamic subtest: vcs0
[220.745081] Dynamic subtest vcs0: SUCCESS (0.029s)
[220.755304] Starting dynamic subtest: vcs1
[220.774300] Dynamic subtest vcs1: SUCCESS (0.029s)
[220.782212] Starting dynamic subtest: vecs0
[220.804234] Dynamic subtest vecs0: SUCCESS (0.030s)
[220.812552] Starting dynamic subtest: ccs0
[220.839879] Dynamic subtest ccs0: SUCCESS (0.035s)
[220.842228] Subtest submit-late-slice: SUCCESS (0.187s)
[222.032599] [020/131] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[222.135616] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[229.477542] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.344s)
[229.641716] [021/131] (789s left) gem_wait (wait)
[229.704946] Starting subtest: wait
[229.707262] Starting dynamic subtest: all-engines
[230.932865] Dynamic subtest all-engines: SUCCESS (1.226s)
[230.943849] Starting dynamic subtest: rcs0
[231.978768] Dynamic subtest rcs0: SUCCESS (1.046s)
[231.989350] Starting dynamic subtest: bcs0
[233.024689] Dynamic subtest bcs0: SUCCESS (1.045s)
[233.034918] Starting dynamic subtest: vcs0
[234.069423] Dynamic subtest vcs0: SUCCESS (1.044s)
[234.079366] Starting dynamic subtest: vcs1
[235.113987] Dynamic subtest vcs1: SUCCESS (1.044s)
[235.124217] Starting dynamic subtest: vecs0
[236.158450] Dynamic subtest vecs0: SUCCESS (1.043s)
[236.168350] Starting dynamic subtest: ccs0
[237.204020] Dynamic subtest ccs0: SUCCESS (1.045s)
[237.206435] Subtest wait: SUCCESS (7.499s)
[237.426910] [022/131] (781s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[237.491619] Starting subtest: mixed-tiled-to-y-tiled-ccs
[237.496191] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[237.699837] [023/131] (781s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[242.700751] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[242.703059] Starting dynamic subtest: pipe-A-eDP-1
[243.490347] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[243.499214] Starting dynamic subtest: pipe-B-eDP-1
[244.622963] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[244.627530] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.920s)
[245.845027] [024/131] (773s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[245.939808] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[245.942203] Starting dynamic subtest: pipe-A-eDP-1
[247.212727] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.274s)
[247.220565] Starting dynamic subtest: pipe-B-eDP-1
[249.562940] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.349s)
[249.570804] Starting dynamic subtest: pipe-C-eDP-1
[251.894987] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.331s)
[251.907855] Starting dynamic subtest: pipe-D-eDP-1
[254.223840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.327s)
[254.226130] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.286s)
[255.449985] [025/131] (763s left) gem_exec_reloc (basic-wc-cpu)
[255.527801] Subtest basic-wc-cpu: SKIP (0.000s)
[255.603465] [026/131] (763s left) gem_exec_schedule (preempt-queue)
[255.677177] Subtest preempt-queue: SKIP (0.000s)
[255.986845] [027/131] (763s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[256.037016] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[256.039389] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[256.152189] [028/131] (763s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[256.276946] Starting subtest: flip-vs-cursor-crc-legacy
[256.969213] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.691s)
[257.780832] [029/131] (761s left) i915_pm_rps (basic-api)
[257.833409] Starting subtest: basic-api
[257.837837] Subtest basic-api: SKIP (0.001s)
[257.931330] [030/131] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[258.026364] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[265.409485] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.386s)
[265.580350] [031/131] (753s left) syncobj_timeline (reset-unsignaled)
[265.643363] Starting subtest: reset-unsignaled
[265.645317] Subtest reset-unsignaled: SUCCESS (0.000s)
[265.762839] [032/131] (753s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[265.871636] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[265.875981] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[266.007176] [033/131] (753s left) kms_getfb (getfb2-handle-not-fb)
[266.117593] Starting subtest: getfb2-handle-not-fb
[266.119803] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[266.253279] [034/131] (753s left) gem_userptr_blits (access-control)
[266.324707] Starting subtest: access-control
[266.328294] Subtest access-control: SKIP (0.000s)
[266.485286] [035/131] (753s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[266.578182] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[266.580093] Starting dynamic subtest: pipe-A-default-mode
[266.877722] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[266.882281] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.298s)
[267.777756] [036/131] (751s left) kms_lease (simple-lease)
[267.886294] Starting subtest: simple-lease
[267.888613] Starting dynamic subtest: pipe-A-eDP-1
[268.385326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[268.393850] Starting dynamic subtest: pipe-B-eDP-1
[269.787374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[269.795922] Starting dynamic subtest: pipe-C-eDP-1
[271.193446] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[271.204080] Starting dynamic subtest: pipe-D-eDP-1
[272.594249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[272.596670] Subtest simple-lease: SUCCESS (4.710s)
[273.425422] [037/131] (746s left) kms_flip (2x-busy-flip)
[273.530256] Starting subtest: 2x-busy-flip
[273.539053] Subtest 2x-busy-flip: SKIP (0.011s)
[273.640122] [038/131] (746s left) gem_reg_read (timestamp-moving)
[273.696370] Starting subtest: timestamp-moving
[274.697196] Subtest timestamp-moving: SUCCESS (1.001s)
[274.799024] [039/131] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[274.901551] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[274.905761] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[275.007528] [040/131] (744s left) kms_pm_rpm (modeset-non-lpsp-stress)
[277.026920] Starting subtest: modeset-non-lpsp-stress
[278.171764] Subtest modeset-non-lpsp-stress: SKIP (1.146s)
[278.577835] [041/131] (741s left) gem_exec_schedule (deep)
[278.770032] Starting subtest: deep
[278.772318] Starting dynamic subtest: rcs0
[283.702717] Dynamic subtest rcs0: SKIP (4.931s)
[283.714051] Starting dynamic subtest: vcs0
[293.749204] Dynamic subtest vcs0: SUCCESS (10.048s)
[293.760022] Starting dynamic subtest: vcs1
[304.579204] Dynamic subtest vcs1: SUCCESS (10.827s)
[304.593829] Starting dynamic subtest: vecs0
[316.187273] Dynamic subtest vecs0: SUCCESS (11.608s)
[316.195880] Starting dynamic subtest: ccs0
[328.355020] Dynamic subtest ccs0: SUCCESS (12.164s)
[328.357609] Subtest deep: SUCCESS (49.583s)
[330.254493] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[330.257637] [042/131] (689s left) prime_mmap (test_forked_cpu_write)
[330.317984] Starting subtest: test_forked_cpu_write
[330.319931] Starting dynamic subtest: test_forked_cpu_write-smem
[330.324360] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[330.326688] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[330.466926] [043/131] (689s left) kms_selftest (drm_damage_helper)
[330.499074] Starting subtest: drm_damage_helper
[330.578445] Starting dynamic subtest: drm_test_damage_iter_no_damage
[330.733562] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.152s)
[330.746052] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[330.873578] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.139s)
[330.882859] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[330.985023] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.111s)
[330.994054] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[331.104388] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.118s)
[331.113394] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[331.198836] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.094s)
[331.206606] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[331.290309] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.092s)
[331.298303] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[331.414290] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.122s)
[331.422036] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[331.513814] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.099s)
[331.523255] Starting dynamic subtest: drm_test_damage_iter_single_damage
[331.595937] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.081s)
[331.605163] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[331.679656] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.083s)
[331.688676] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[331.769076] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.090s)
[331.776913] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[331.909397] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.138s)
[331.918808] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[332.040739] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.131s)
[332.050447] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[332.174670] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.134s)
[332.182137] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[332.307819] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.131s)
[332.316501] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[332.451259] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.143s)
[332.458928] Starting dynamic subtest: drm_test_damage_iter_damage
[332.591247] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.140s)
[332.599065] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[332.688671] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.098s)
[332.698062] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[332.783236] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.094s)
[332.790854] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[332.922133] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.138s)
[332.929892] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[333.061101] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.136s)
[333.063104] Subtest drm_damage_helper: SUCCESS (2.562s)
[333.301299] [044/131] (686s left) syncobj_wait (wait-for-submit-complex)
[333.367521] Starting subtest: wait-for-submit-complex
[333.427757] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[333.535266] [045/131] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[333.644786] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[333.648895] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[333.764812] [046/131] (686s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[333.855112] Starting subtest: addfb25-y-tiled-small-legacy
[333.859596] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[333.981925] [047/131] (686s left) gem_mmap_gtt (medium-copy-xy)
[334.046050] Subtest medium-copy-XY: SKIP (0.000s)
[334.100844] [048/131] (686s left) kms_vrr (flip-suspend)
[334.199213] Starting subtest: flip-suspend
[334.205500] Subtest flip-suspend: SKIP (0.000s)
[334.294476] [049/131] (686s left) i915_module_load (reload-with-fault-injection)
[334.323456] Starting subtest: reload-with-fault-injection
[337.733912] Subtest reload-with-fault-injection: SKIP (3.407s)
[337.763331] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[337.764043] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true
[337.767415] [050/131] (682s left) vgem_basic (dmabuf-export)
[337.815035] Starting subtest: dmabuf-export
[339.359229] Subtest dmabuf-export: SUCCESS (1.548s)
[339.457813] [FACT vgem_basic (dmabuf-export)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[339.459111] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.i915: true
[339.462708] [051/131] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[339.567230] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[339.571173] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[339.704785] [052/131] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[339.815993] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[339.820517] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[339.951156] [053/131] (680s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[340.082201] Starting subtest: 2x-cursor-vs-flip-legacy
[340.086496] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[340.247865] [054/131] (680s left) perf_pmu (busy-idle-check-all)
[340.295071] Starting subtest: busy-idle-check-all
[340.296774] Starting dynamic subtest: rcs0
[340.972927] Dynamic subtest rcs0: SUCCESS (0.679s)
[340.983805] Starting dynamic subtest: bcs0
[341.626860] Dynamic subtest bcs0: SUCCESS (0.652s)
[341.636957] Starting dynamic subtest: vcs0
[342.934498] Dynamic subtest vcs0: SUCCESS (1.304s)
[342.945058] Starting dynamic subtest: vcs1
[344.916222] Dynamic subtest vcs1: SUCCESS (1.980s)
[344.927117] Starting dynamic subtest: vecs0
[346.900348] Dynamic subtest vecs0: SUCCESS (1.982s)
[346.911151] Starting dynamic subtest: ccs0
[347.556584] Dynamic subtest ccs0: SUCCESS (0.655s)
[347.559123] Subtest busy-idle-check-all: SUCCESS (7.264s)
[347.694797] [055/131] (672s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[347.810304] Starting subtest: yf-tiled-16bpp-rotate-180
[347.814439] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[347.947634] [056/131] (672s left) gem_exec_flush (basic-wb-pro-default)
[348.020684] Starting subtest: basic-wb-pro-default
[353.482614] Subtest basic-wb-pro-default: SUCCESS (5.464s)
[353.700117] [057/131] (666s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[353.808903] Starting subtest: yf-tiled-addfb-size-overflow
[353.813350] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[353.922164] [058/131] (666s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[354.046791] Starting subtest: short-flip-before-cursor-atomic-transitions
[355.039632] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.992s)
[355.861382] [059/131] (664s left) kms_cursor_crc (cursor-sliding-max-size)
[356.144830] Starting subtest: cursor-sliding-max-size
[356.151575] Subtest cursor-sliding-max-size: SKIP (0.000s)
[356.299808] [060/131] (664s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[356.358127] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[356.416161] [061/131] (664s left) gem_exec_fence (invalid-fence-array)
[356.822855] Starting subtest: invalid-fence-array
[356.825425] Subtest invalid-fence-array: SUCCESS (0.002s)
[358.051072] [062/131] (662s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[358.169343] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[359.139762] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.970s)
[360.004077] [063/131] (660s left) kms_debugfs (display-on-read-all)
[360.091838] Starting subtest: display-on-read-all
[360.259313] Subtest display-on-read-all: SUCCESS (0.168s)
[360.428397] [064/131] (660s left) syncobj_eventfd (binary-wait-before-signal)
[360.483335] Starting subtest: binary-wait-before-signal
[360.512108] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[360.612838] [065/131] (660s left) kms_psr (fbc-psr-primary-render)
[360.701092] Starting subtest: fbc-psr-primary-render
[360.703301] Starting dynamic subtest: eDP-1
[360.707331] Dynamic subtest eDP-1: SKIP (0.000s)
[360.711389] Subtest fbc-psr-primary-render: SKIP (0.001s)
[360.797507] [066/131] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[360.899978] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[370.202224] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.303s)
[370.350408] [067/131] (650s left) gem_exec_flush (basic-uc-rw-default)
[370.412260] Starting subtest: basic-uc-rw-default
[375.865731] Subtest basic-uc-rw-default: SUCCESS (5.453s)
[376.074963] [068/131] (644s left) gem_exec_params (sol-reset-not-gen7)
[376.136659] Starting subtest: sol-reset-not-gen7
[376.145081] Subtest sol-reset-not-gen7: SUCCESS (0.006s)
[376.263628] [069/131] (644s left) syncobj_wait (multi-wait-submitted-signaled)
[376.311380] Starting subtest: multi-wait-submitted-signaled
[376.313709] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[376.418519] [070/131] (644s left) gem_exec_params (no-bsd)
[376.480042] Starting subtest: no-bsd
[376.485323] Subtest no-bsd: SUCCESS (0.005s)
[378.004106] [071/131] (643s left) gem_mmap (short-mmap)
[378.071831] Subtest short-mmap: SKIP (0.000s)
[378.154178] [072/131] (643s left) syncobj_wait (invalid-signal-illegal-handle)
[378.202872] Starting subtest: invalid-signal-illegal-handle
[378.205281] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[378.334575] [073/131] (642s left) syncobj_wait (wait-zero-handles)
[378.391865] Starting subtest: wait-zero-handles
[378.394181] Subtest wait-zero-handles: SUCCESS (0.000s)
[378.534471] [074/131] (642s left) gem_exec_params (invalid-ring2)
[378.595156] Starting subtest: invalid-ring2
[378.597433] Subtest invalid-ring2: SUCCESS (0.000s)
[378.727176] [075/131] (642s left) kms_cursor_crc (cursor-random-32x32)
[378.884900] Starting subtest: cursor-random-32x32
[378.937030] Subtest cursor-random-32x32: SKIP (0.048s)
[379.258154] [076/131] (642s left) gem_pxp (create-regular-buffer)
[379.388477] Starting subtest: create-regular-buffer
[379.390564] Subtest create-regular-buffer: SUCCESS (0.000s)
[379.547547] [077/131] (641s left) gem_exec_nop (basic-parallel)
[379.625663] Starting subtest: basic-parallel
[395.860945] Subtest basic-parallel: SUCCESS (16.243s)
[396.145166] [078/131] (625s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[396.245890] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[396.248242] Starting dynamic subtest: pipe-A
[396.267958] Dynamic subtest pipe-A: SKIP (0.018s)
[396.276876] Starting dynamic subtest: pipe-B
[396.304561] Dynamic subtest pipe-B: SKIP (0.037s)
[396.313344] Starting dynamic subtest: pipe-C
[396.342952] Dynamic subtest pipe-C: SKIP (0.036s)
[396.351289] Starting dynamic subtest: pipe-D
[396.379652] Dynamic subtest pipe-D: SKIP (0.036s)
[396.383386] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.130s)
[396.511175] [079/131] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[396.612617] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[396.616766] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[396.754584] [080/131] (624s left) kms_dsc (dsc-with-output-formats-with-bpc)
[396.839393] Starting subtest: dsc-with-output-formats-with-bpc
[396.894261] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[396.934061] [081/131] (624s left) kms_flip (blocking-wf_vblank)
[397.024473] Starting subtest: blocking-wf_vblank
[397.026508] Starting dynamic subtest: A-eDP1
[405.983112] Dynamic subtest A-eDP1: SUCCESS (8.956s)
[405.994550] Starting dynamic subtest: B-eDP1
[414.906470] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[414.919614] Starting dynamic subtest: C-eDP1
[423.820718] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[423.830691] Starting dynamic subtest: D-eDP1
[432.750081] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[432.752529] Subtest blocking-wf_vblank: SUCCESS (35.727s)
[434.008930] [082/131] (587s left) kms_busy (extended-modeset-hang-oldfb)
[434.114058] Starting subtest: extended-modeset-hang-oldfb
[434.116369] Starting dynamic subtest: pipe-A
[445.855768] Dynamic subtest pipe-A: SUCCESS (11.742s)
[445.864649] Starting dynamic subtest: pipe-D
[458.120868] Dynamic subtest pipe-D: SUCCESS (12.262s)
[458.123241] Subtest extended-modeset-hang-oldfb: SUCCESS (24.009s)
[458.930124] [083/131] (562s left) kms_sequence (queue-busy)
[459.025722] Starting subtest: queue-busy
[459.028051] Starting dynamic subtest: pipe-A-eDP-1
[460.982879] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s)
[460.992966] Starting dynamic subtest: pipe-B-eDP-1
[463.607344] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.625s)
[463.618682] Starting dynamic subtest: pipe-C-eDP-1
[466.220794] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[466.230070] Starting dynamic subtest: pipe-D-eDP-1
[468.763057] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[468.765421] Subtest queue-busy: SUCCESS (9.739s)
[469.665858] [084/131] (552s left) kms_concurrent (multi-plane-atomic-lowres)
[469.764192] Starting subtest: multi-plane-atomic-lowres
[469.766074] Starting dynamic subtest: pipe-A-eDP-1
[470.269054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[470.271227] Subtest multi-plane-atomic-lowres: SUCCESS (0.506s)
[471.106308] [085/131] (550s left) core_getclient (basic)
[471.166675] Starting subtest: basic
[471.168720] Subtest basic: SUCCESS (0.000s)
[471.298217] [086/131] (550s left) kms_cursor_crc (cursor-offscreen-64x21)
[471.478527] Starting subtest: cursor-offscreen-64x21
[471.526977] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[471.802937] [087/131] (550s left) gem_exec_whisper (basic-contexts-forked)
[471.869234] Starting subtest: basic-contexts-forked
[495.532540] Subtest basic-contexts-forked: SUCCESS (23.648s)
[495.725406] [088/131] (526s left) gen9_exec_parse (allowed-all)
[495.795110] Subtest allowed-all: SKIP (0.000s)
[495.894318] [089/131] (526s left) gem_exec_async (concurrent-writes)
[495.959722] Starting subtest: concurrent-writes
[495.962160] Starting dynamic subtest: rcs0
[495.988591] Dynamic subtest rcs0: SUCCESS (0.029s)
[495.998691] Starting dynamic subtest: bcs0
[496.001016] Dynamic subtest bcs0: SUCCESS (0.010s)
[496.010305] Starting dynamic subtest: vcs0
[496.012536] Dynamic subtest vcs0: SUCCESS (0.008s)
[496.022655] Starting dynamic subtest: vcs1
[496.024884] Dynamic subtest vcs1: SUCCESS (0.008s)
[496.034069] Starting dynamic subtest: vecs0
[496.035962] Dynamic subtest vecs0: SUCCESS (0.011s)
[496.044890] Starting dynamic subtest: ccs0
[496.047136] Dynamic subtest ccs0: SUCCESS (0.008s)
[496.049357] Subtest concurrent-writes: SUCCESS (0.079s)
[496.329383] [090/131] (525s left) prime_mmap (test_dup)
[496.386100] Starting subtest: test_dup
[496.388468] Starting dynamic subtest: test_dup-smem
[496.417730] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[496.420022] Subtest test_dup: SUCCESS (0.034s)
[496.522264] [091/131] (525s left) gem_mmap_gtt (pf-nonblock)
[496.565082] Subtest pf-nonblock: SKIP (0.000s)
[496.626410] [092/131] (525s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[496.668156] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[496.776498] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[496.879536] [093/131] (525s left) kms_psr2_su (page_flip-xrgb8888)
[496.937824] Subtest page_flip-XRGB8888: SKIP (0.000s)
[497.006636] [094/131] (525s left) kms_atomic_transition (plane-all-transition)
[497.113520] Starting subtest: plane-all-transition
[497.115620] Starting dynamic subtest: pipe-A-eDP-1
[499.623272] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.511s)
[499.928422] Starting dynamic subtest: pipe-B-eDP-1
[503.122670] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s)
[503.428419] Subtest plane-all-transition: SUCCESS (6.315s)
[504.277087] [095/131] (517s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[504.338629] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[504.449056] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[504.551524] [096/131] (517s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[504.643851] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[504.648112] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.782220] [097/131] (517s left) kms_invalid_mode (bad-hsync-start)
[504.874043] Starting subtest: bad-hsync-start
[504.876374] Starting dynamic subtest: pipe-A-eDP-1
[505.166477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[505.176189] Starting dynamic subtest: pipe-B-eDP-1
[505.178107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[505.186408] Starting dynamic subtest: pipe-C-eDP-1
[505.188793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[505.197316] Starting dynamic subtest: pipe-D-eDP-1
[505.199581] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[505.201847] Subtest bad-hsync-start: SUCCESS (0.299s)
[506.010572] [098/131] (516s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[506.062379] Starting subtest: yf-tiled-to-vebox-y-tiled
[506.067303] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[506.269444] [099/131] (516s left) core_getversion (basic)
[506.313791] Starting subtest: basic
[506.318311] Subtest basic: SUCCESS (0.000s)
[506.405422] [100/131] (516s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[506.504144] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[506.506379] Starting dynamic subtest: pipe-A-eDP-1
[506.529243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.541650] Starting dynamic subtest: pipe-B-eDP-1
[506.563510] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.574424] Starting dynamic subtest: pipe-C-eDP-1
[506.596229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.605084] Starting dynamic subtest: pipe-D-eDP-1
[506.627101] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.631223] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[508.772340] [101/131] (513s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[508.875461] Starting subtest: 4-tiled-32bpp-rotate-0
[510.267053] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.390s)
[510.447715] [102/131] (512s left) api_intel_bb (bb-with-allocator)
[510.509676] Starting subtest: bb-with-allocator
[510.514687] Subtest bb-with-allocator: SUCCESS (0.007s)
[510.628294] [103/131] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[510.742139] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[510.745471] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[510.884972] [104/131] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[510.981793] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[510.985213] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[511.111965] [105/131] (511s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[511.212908] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[511.216521] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[511.331771] [106/131] (511s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[511.396101] Starting subtest: single-wait-all-for-submit-available-submitted
[511.398031] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[511.516284] [107/131] (511s left) gem_spin_batch (legacy)
[511.567051] Starting subtest: legacy
[511.568982] Starting dynamic subtest: default
[514.807272] Dynamic subtest default: SUCCESS (3.235s)
[514.818800] Starting dynamic subtest: render
[518.041584] Dynamic subtest render: SUCCESS (3.231s)
[518.052934] Starting dynamic subtest: bsd
[521.280446] Dynamic subtest bsd: SUCCESS (3.234s)
[521.291416] Starting dynamic subtest: bsd1
[524.516863] Dynamic subtest bsd1: SUCCESS (3.233s)
[524.527505] Starting dynamic subtest: bsd2
[527.751023] Dynamic subtest bsd2: SUCCESS (3.230s)
[527.761299] Starting dynamic subtest: blt
[530.987623] Dynamic subtest blt: SUCCESS (3.233s)
[531.001955] Starting dynamic subtest: vebox
[534.223569] Dynamic subtest vebox: SUCCESS (3.232s)
[534.226069] Subtest legacy: SUCCESS (22.651s)
[535.019890] [108/131] (487s left) kms_atomic (plane-invalid-params)
[535.115024] Starting subtest: plane-invalid-params
[535.117471] Starting dynamic subtest: pipe-A-eDP-1
[535.513027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[535.515173] Subtest plane-invalid-params: SUCCESS (0.399s)
[536.396091] [109/131] (486s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[536.495928] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[536.498259] Starting dynamic subtest: pipe-A
[536.559671] Dynamic subtest pipe-A: SUCCESS (0.065s)
[536.581616] Starting dynamic subtest: pipe-B
[537.697722] Dynamic subtest pipe-B: SUCCESS (1.136s)
[537.708890] Starting dynamic subtest: pipe-C
[538.806805] Dynamic subtest pipe-C: SUCCESS (1.104s)
[538.827462] Starting dynamic subtest: pipe-D
[539.942103] Dynamic subtest pipe-D: SUCCESS (1.135s)
[539.944385] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.448s)
[541.134054] [110/131] (481s left) gem_lmem_swapping (heavy-verify-random)
[541.179410] Subtest heavy-verify-random: SKIP (0.000s)
[541.227151] [111/131] (481s left) perf_pmu (rc6)
[541.271431] Starting subtest: rc6
[541.273417] Starting dynamic subtest: gt0
[547.649574] Dynamic subtest gt0: SUCCESS (6.377s)
[547.661216] Starting dynamic subtest: runtime-pm-gt0
[555.368656] Dynamic subtest runtime-pm-gt0: SUCCESS (7.717s)
[555.380637] Starting dynamic subtest: runtime-pm-long-gt0
[567.876041] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.504s)
[567.887841] Starting dynamic subtest: other-idle-gt0
[574.220857] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[574.230581] Starting dynamic subtest: gt1
[580.563065] Dynamic subtest gt1: SUCCESS (6.339s)
[580.575298] Starting dynamic subtest: runtime-pm-gt1
[587.994478] Dynamic subtest runtime-pm-gt1: SUCCESS (7.428s)
[588.006090] Starting dynamic subtest: runtime-pm-long-gt1
[600.443656] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.446s)
[600.454778] Starting dynamic subtest: other-idle-gt1
[606.807337] Dynamic subtest other-idle-gt1: SUCCESS (6.339s)
[606.809508] Subtest rc6: SUCCESS (65.511s)
[607.910438] [112/131] (415s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[608.013713] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[608.015906] Starting dynamic subtest: pipe-A-eDP-1
[608.038395] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[608.049636] Starting dynamic subtest: pipe-B-eDP-1
[608.070647] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[608.079368] Starting dynamic subtest: pipe-C-eDP-1
[608.098447] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[608.106873] Starting dynamic subtest: pipe-D-eDP-1
[608.125971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[608.129584] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[610.291818] [113/131] (412s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[610.387556] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[610.391917] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[611.512552] [114/131] (411s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[611.632063] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[612.837066] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.608s)
[612.877425] [115/131] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[612.995228] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[620.102390] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.109s)
[620.206074] [116/131] (402s left) syncobj_timeline (invalid-signal-illegal-point)
[620.266160] Starting subtest: invalid-signal-illegal-point
[620.268044] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[620.361422] [117/131] (402s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[620.463173] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[624.595312] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.135s)
[625.741829] [118/131] (397s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[625.856902] Starting subtest: psr-rgb565-draw-mmap-cpu
[632.622676] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.767s)
[632.739146] [119/131] (390s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[632.843448] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[632.847452] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[632.928228] [120/131] (390s left) gem_exec_balancer (semaphore)
[632.989047] Starting subtest: semaphore
[634.875797] Subtest semaphore: SUCCESS (1.885s)
[635.188335] [121/131] (388s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[635.295743] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[636.397330] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.103s)
[636.507324] [122/131] (386s left) kms_big_fb (y-tiled-addfb-size-overflow)
[636.602053] Starting subtest: y-tiled-addfb-size-overflow
[636.605555] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[636.686467] [123/131] (386s left) kms_lease (page-flip-implicit-plane)
[636.781506] Starting subtest: page-flip-implicit-plane
[636.783496] Starting dynamic subtest: pipe-A-eDP-1
[637.260661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[637.271567] Starting dynamic subtest: pipe-B-eDP-1
[638.420335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[638.430170] Starting dynamic subtest: pipe-C-eDP-1
[639.540242] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[639.553503] Starting dynamic subtest: pipe-D-eDP-1
[640.677605] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[640.680099] Subtest page-flip-implicit-plane: SUCCESS (3.898s)
[641.496831] [124/131] (381s left) kms_chamelium_color (ctm-0-75)
[641.601591] Subtest ctm-0-75: SKIP (0.000s)
[641.653053] [125/131] (381s left) kms_feature_discovery (psr1)
[641.750268] Starting subtest: psr1
[641.752141] Subtest psr1: SUCCESS (0.000s)
[641.800502] [126/131] (381s left) kms_flip (2x-wf_vblank-ts-check)
[641.910186] Starting subtest: 2x-wf_vblank-ts-check
[641.919257] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[642.017061] [127/131] (381s left) kms_plane_cursor (overlay)
[642.109554] Starting subtest: overlay
[642.113896] Starting dynamic subtest: pipe-A-eDP-1-size-64
[644.692981] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.585s)
[644.754825] Starting dynamic subtest: pipe-A-eDP-1-size-128
[647.339494] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.594s)
[647.402358] Starting dynamic subtest: pipe-A-eDP-1-size-256
[649.964196] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[650.318874] Starting dynamic subtest: pipe-B-eDP-1-size-64
[653.518400] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.208s)
[653.578975] Starting dynamic subtest: pipe-B-eDP-1-size-128
[656.152487] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[656.213192] Starting dynamic subtest: pipe-B-eDP-1-size-256
[658.721603] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.515s)
[659.069658] Starting dynamic subtest: pipe-C-eDP-1-size-64
[661.994188] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.936s)
[662.033243] Starting dynamic subtest: pipe-C-eDP-1-size-128
[664.272056] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.247s)
[664.310972] Starting dynamic subtest: pipe-C-eDP-1-size-256
[666.451221] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[666.788472] Starting dynamic subtest: pipe-D-eDP-1-size-64
[669.667297] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.889s)
[669.704909] Starting dynamic subtest: pipe-D-eDP-1-size-128
[671.845453] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[671.883115] Starting dynamic subtest: pipe-D-eDP-1-size-256
[674.034466] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[674.358226] Subtest overlay: SUCCESS (32.249s)
[675.218031] [128/131] (348s left) i915_suspend (basic-s2idle-without-i915)
[675.256959] Starting subtest: basic-s2idle-without-i915
[696.272229] Subtest basic-s2idle-without-i915: SUCCESS (9.740s)
[701.396277] [129/131] (327s left) kms_psr (psr-no-drrs)
[701.521200] Starting subtest: psr-no-drrs
[701.523453] Starting dynamic subtest: eDP-1
[703.162467] Dynamic subtest eDP-1: SUCCESS (1.636s)
[703.165287] Subtest psr-no-drrs: SUCCESS (1.637s)
[704.015411] [130/131] (324s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[704.404289] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[705.270355] [131/131] (323s left) gem_exec_balancer (full-late)
[705.364055] Starting subtest: full-late
[710.061126] Subtest full-late: SUCCESS (4.690s)
[710.370012] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_b_c_ivb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_ctx_exec
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_tiled_wc
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_wait
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: i915_pm_rps
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_getfb
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_reg_read
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: kms_selftest
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_addfb_basic
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: i915_module_load
results: parsing output: 49/ for test: vgem_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_debugfs
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_flush
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: gem_mmap
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: gem_exec_nop
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_dsc
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_busy
results: parsing output: 82/ for test: kms_sequence
results: parsing output: 83/ for test: kms_concurrent
results: parsing output: 84/ for test: core_getclient
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: gem_exec_async
results: parsing output: 89/ for test: prime_mmap
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_psr2_su
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: core_getversion
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: api_intel_bb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_spin_batch
results: parsing output: 107/ for test: kms_atomic
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: kms_feature_discovery
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_plane_cursor
results: parsing output: 127/ for test: i915_suspend
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: gem_exec_balancer
Done.