[60.914415] Initializing watchdogs
[60.914462]   /dev/watchdog0
[60.929451] [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.934039] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.936323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.939662] [001/132] (960s left) kms_vblank (query-forked)
[61.057833] Starting subtest: query-forked
[61.060051] Starting dynamic subtest: pipe-A-eDP-1
[62.893517] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s)
[62.905115] Starting dynamic subtest: pipe-D-eDP-1
[65.425232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[65.427462] Subtest query-forked: SUCCESS (4.368s)
[66.273251] [002/132] (955s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[66.395386] Starting subtest: cursor-vs-flip-varying-size
[98.103334] Subtest cursor-vs-flip-varying-size: SUCCESS (31.706s)
[98.899217] [003/132] (922s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[99.010054] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[99.014610] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[99.080391] [004/132] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[99.187064] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[106.336087] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.154s)
[106.457073] [005/132] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[106.554390] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[113.961964] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.410s)
[114.085864] [006/132] (907s left) kms_pm_rpm (basic-rte)
[114.123959] Starting subtest: basic-rte
[117.566392] Subtest basic-rte: SUCCESS (3.444s)
[119.069715] [007/132] (902s left) gem_userptr_blits (stress-mm)
[119.140464] Starting subtest: stress-mm
[124.508759] Subtest stress-mm: SUCCESS (5.369s)
[124.633214] [008/132] (897s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[124.750076] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[125.828389] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.079s)
[125.946937] [009/132] (895s left) kms_plane_multiple (tiling-none)
[126.058584] Starting subtest: tiling-none
[126.060759] Starting dynamic subtest: pipe-A-eDP-1
[129.788090] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.729s)
[129.796056] Starting dynamic subtest: pipe-B-eDP-1
[134.329102] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.539s)
[134.340499] Starting dynamic subtest: pipe-C-eDP-1
[138.679445] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.350s)
[138.692792] Starting dynamic subtest: pipe-D-eDP-1
[143.020576] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.337s)
[143.022847] Subtest tiling-none: SUCCESS (16.961s)
[143.825766] [010/132] (877s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[143.921101] Starting subtest: plane-upscale-20x20-with-pixel-format
[143.923419] Starting dynamic subtest: pipe-A
[144.968137] Dynamic subtest pipe-A: SUCCESS (1.049s)
[144.975158] Starting dynamic subtest: pipe-B
[147.138189] Dynamic subtest pipe-B: SUCCESS (2.169s)
[147.145907] Starting dynamic subtest: pipe-C
[148.342192] Dynamic subtest pipe-C: SUCCESS (1.203s)
[148.349808] Starting dynamic subtest: pipe-D
[149.573479] Dynamic subtest pipe-D: SUCCESS (1.229s)
[149.575823] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.655s)
[150.763464] [011/132] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[150.866928] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[150.871179] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[150.956347] [012/132] (870s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[151.043609] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[151.047999] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[151.120390] [013/132] (870s left) kms_cursor_crc (cursor-offscreen-128x42)
[151.341022] Starting subtest: cursor-offscreen-128x42
[151.389921] Subtest cursor-offscreen-128x42: SKIP (0.044s)
[151.573263] [014/132] (870s left) gem_exec_flush (basic-batch-kernel-default-wb)
[151.629515] Starting subtest: basic-batch-kernel-default-wb
[158.672019] Subtest basic-batch-kernel-default-wb: SUCCESS (7.043s)
[158.859741] [015/132] (863s left) gem_exec_whisper (basic-forked-all)
[158.924847] Starting subtest: basic-forked-all
[172.574022] Subtest basic-forked-all: SUCCESS (13.646s)
[172.755842] [016/132] (849s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[172.817333] Starting subtest: x-tiled-to-vebox-y-tiled
[172.821645] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[172.998960] [017/132] (849s left) kms_psr (fbc-pr-cursor-blt)
[173.100596] Starting subtest: fbc-pr-cursor-blt
[173.104515] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[173.168707] [018/132] (848s left) gem_partial_pwrite_pread (reads-snoop)
[173.221961] Subtest reads-snoop: SKIP (0.000s)
[173.285883] [019/132] (848s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[173.379792] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[173.381778] Starting dynamic subtest: pipe-A-eDP-1
[174.276733] Dynamic subtest pipe-A-eDP-1: FAIL (0.295s)
[174.285373] Starting dynamic subtest: pipe-B-eDP-1
[174.703713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.027s)
[174.975021] Subtest plane-all-modeset-transition-fencing-internal-panels: FAIL (1.597s)
[175.818387] [020/132] (846s left) kms_hdr (invalid-hdr)
[175.908926] Starting subtest: invalid-hdr
[178.053159] Starting dynamic subtest: pipe-A-eDP-1
[180.957531] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.905s)
[180.959782] Subtest invalid-hdr: SUCCESS (5.051s)
[181.060664] [021/132] (841s left) gem_mmap_gtt (coherency)
[181.120701] Subtest coherency: SKIP (0.000s)
[181.175419] [022/132] (841s left) gem_flink_basic (bad-flink)
[181.222946] Starting subtest: bad-flink
[181.225062] Subtest bad-flink: SUCCESS (0.000s)
[181.338744] [023/132] (840s left) vgem_basic (second-client)
[181.454926] Starting subtest: second-client
[181.477165] Subtest second-client: SUCCESS (0.022s)
[181.530554] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[181.533655] [024/132] (840s left) gem_exec_schedule (out-order)
[181.603247] Starting subtest: out-order
[181.605439] Starting dynamic subtest: rcs0
[181.707641] Dynamic subtest rcs0: SUCCESS (0.105s)
[181.718739] Starting dynamic subtest: vcs0
[181.793044] Dynamic subtest vcs0: SUCCESS (0.085s)
[181.804363] Starting dynamic subtest: vcs1
[181.886659] Dynamic subtest vcs1: SUCCESS (0.093s)
[181.897446] Starting dynamic subtest: vecs0
[181.972415] Dynamic subtest vecs0: SUCCESS (0.084s)
[181.982919] Starting dynamic subtest: ccs0
[182.056573] Dynamic subtest ccs0: SUCCESS (0.082s)
[182.058961] Subtest out-order: SUCCESS (0.455s)
[183.020717] [025/132] (839s left) sysfs_heartbeat_interval (invalid)
[183.072754] Starting subtest: invalid
[183.075489] Starting dynamic subtest: vecs0
[183.077992] Dynamic subtest vecs0: SUCCESS (0.000s)
[183.085889] Starting dynamic subtest: ccs0
[183.088132] Dynamic subtest ccs0: SUCCESS (0.000s)
[183.096199] Starting dynamic subtest: vcs0
[183.098081] Dynamic subtest vcs0: SUCCESS (0.000s)
[183.106047] Starting dynamic subtest: bcs0
[183.108273] Dynamic subtest bcs0: SUCCESS (0.000s)
[183.115849] Starting dynamic subtest: rcs0
[183.118092] Dynamic subtest rcs0: SUCCESS (0.000s)
[183.125604] Starting dynamic subtest: vcs1
[183.127832] Dynamic subtest vcs1: SUCCESS (0.000s)
[183.130072] Subtest invalid: SUCCESS (0.005s)
[183.166287] [026/132] (839s left) i915_drm_fdinfo (virtual-busy-hang-all)
[183.206812] Starting subtest: virtual-busy-hang-all
[183.211612] Subtest virtual-busy-hang-all: SKIP (0.000s)
[183.290633] [027/132] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[183.387191] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[187.251508] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.868s)
[188.387452] [028/132] (834s left) gem_exec_balancer (bonded-pair)
[188.452919] Starting subtest: bonded-pair
[188.457631] Subtest bonded-pair: SKIP (0.000s)
[188.773880] [029/132] (833s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[188.867187] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[188.869545] Starting dynamic subtest: pipe-A-default-mode
[190.043881] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[190.049451] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.177s)
[190.187444] [030/132] (832s left) i915_drm_fdinfo (memory-info-shared)
[190.231152] Starting subtest: memory-info-shared
[190.233726] Starting dynamic subtest: smem0
[190.273671] Dynamic subtest smem0: SUCCESS (0.045s)
[190.276297] Subtest memory-info-shared: SUCCESS (0.046s)
[190.355174] [031/132] (832s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[190.752092] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[191.531928] [032/132] (831s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[191.622308] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[191.624475] Starting dynamic subtest: pipe-A-eDP-1
[192.520124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[192.530111] Starting dynamic subtest: pipe-B-eDP-1
[194.220332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.696s)
[194.229503] Starting dynamic subtest: pipe-C-eDP-1
[195.793301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.572s)
[195.803137] Starting dynamic subtest: pipe-D-eDP-1
[197.306223] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s)
[197.308516] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.677s)
[198.485691] [033/132] (824s left) gem_mmap_gtt (cpuset-big-copy)
[198.551188] Subtest cpuset-big-copy: SKIP (0.000s)
[198.619493] [034/132] (824s left) kms_cursor_crc (cursor-random-128x42)
[198.831213] Starting subtest: cursor-random-128x42
[198.882773] Subtest cursor-random-128x42: SKIP (0.045s)
[199.113574] [035/132] (823s left) kms_joiner (invalid-modeset-force-big-joiner)
[199.212978] Starting subtest: invalid-modeset-force-big-joiner
[199.217339] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[199.278217] [036/132] (823s left) kms_big_fb (linear-16bpp-rotate-180)
[199.381609] Starting subtest: linear-16bpp-rotate-180
[200.726052] Subtest linear-16bpp-rotate-180: SUCCESS (1.345s)
[200.846877] [037/132] (822s left) api_intel_allocator (fork-simple-stress)
[200.903049] Starting subtest: fork-simple-stress
[206.301392] Subtest fork-simple-stress: SUCCESS (5.396s)
[206.424310] [038/132] (816s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[206.552033] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[206.556558] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[206.654526] [039/132] (816s left) kms_selftest (drm_dp_mst_helper)
[206.706453] Starting subtest: drm_dp_mst_helper
[206.740629] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[206.912033] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.168s)
[206.920357] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[207.066964] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.155s)
[207.076047] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[207.231365] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.163s)
[207.233602] Subtest drm_dp_mst_helper: SUCCESS (0.525s)
[207.432246] [040/132] (815s left) fbdev (nullptr)
[207.498350] Starting subtest: nullptr
[207.500369] Subtest nullptr: SUCCESS (0.000s)
[207.562355] [041/132] (815s left) gem_mmap_gtt (zero-extend)
[207.635317] Subtest zero-extend: SKIP (0.000s)
[207.712849] [042/132] (815s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[207.791206] Starting subtest: invalid-bsd2-flag-on-blt
[207.793105] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[207.928078] [043/132] (815s left) perf_pmu (busy-double-start)
[207.982310] Starting subtest: busy-double-start
[207.984481] Starting dynamic subtest: rcs0
[211.622610] Dynamic subtest rcs0: FAIL (3.573s)
[211.632486] Starting dynamic subtest: bcs0
[215.121962] Dynamic subtest bcs0: SUCCESS (3.566s)
[215.133318] Starting dynamic subtest: vcs0
[219.421875] Dynamic subtest vcs0: SUCCESS (4.297s)
[219.431986] Starting dynamic subtest: vcs1
[223.459800] Dynamic subtest vcs1: SUCCESS (4.036s)
[223.472463] Starting dynamic subtest: vecs0
[227.445701] Dynamic subtest vecs0: SUCCESS (3.984s)
[227.456783] Starting dynamic subtest: ccs0
[231.076620] Dynamic subtest ccs0: FAIL (3.564s)
[231.078760] Subtest busy-double-start: FAIL (23.030s)
[231.127809] [044/132] (792s left) syncobj_timeline (etime-single-wait-submitted)
[231.179850] Starting subtest: etime-single-wait-submitted
[231.289242] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[231.366102] [045/132] (791s left) gem_ctx_engines (independent)
[231.428869] Starting subtest: independent
[231.431351] Starting dynamic subtest: rcs0
[231.677626] Dynamic subtest rcs0: SUCCESS (0.246s)
[231.689684] Starting dynamic subtest: bcs0
[231.903841] Dynamic subtest bcs0: SUCCESS (0.224s)
[231.913862] Starting dynamic subtest: vcs0
[232.113575] Dynamic subtest vcs0: SUCCESS (0.209s)
[232.124265] Starting dynamic subtest: vcs1
[232.338033] Dynamic subtest vcs1: SUCCESS (0.224s)
[232.348664] Starting dynamic subtest: vecs0
[232.569245] Dynamic subtest vecs0: SUCCESS (0.231s)
[232.582063] Starting dynamic subtest: ccs0
[232.804068] Dynamic subtest ccs0: SUCCESS (0.234s)
[232.815513] Starting dynamic subtest: all-engines
[233.644372] Dynamic subtest all-engines: SUCCESS (0.840s)
[233.646707] Subtest independent: SUCCESS (2.216s)
[234.072741] [046/132] (789s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[234.169267] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[240.468075] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.302s)
[241.600325] [047/132] (781s left) perf_pmu (busy-no-semaphores)
[241.647774] Starting subtest: busy-no-semaphores
[241.649732] Starting dynamic subtest: rcs0
[242.210220] Dynamic subtest rcs0: SUCCESS (0.561s)
[242.221381] Starting dynamic subtest: bcs0
[242.759669] Dynamic subtest bcs0: SUCCESS (0.547s)
[242.771029] Starting dynamic subtest: vcs0
[243.310053] Dynamic subtest vcs0: SUCCESS (0.547s)
[243.320280] Starting dynamic subtest: vcs1
[244.437707] Dynamic subtest vcs1: SUCCESS (1.124s)
[244.448957] Starting dynamic subtest: vecs0
[246.422836] Dynamic subtest vecs0: SUCCESS (1.981s)
[246.431929] Starting dynamic subtest: ccs0
[248.408928] Dynamic subtest ccs0: SUCCESS (1.983s)
[248.411732] Subtest busy-no-semaphores: SUCCESS (6.762s)
[248.537811] [048/132] (774s left) kms_async_flips (crc-atomic)
[248.635739] Starting subtest: crc-atomic
[249.023879] Starting dynamic subtest: pipe-A-eDP-1
[251.927842] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.902s)
[252.311334] Starting dynamic subtest: pipe-B-eDP-1
[255.259317] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.963s)
[255.637040] Starting dynamic subtest: pipe-C-eDP-1
[258.547384] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s)
[258.928708] Starting dynamic subtest: pipe-D-eDP-1
[261.791698] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[261.793980] Subtest crc-atomic: SUCCESS (13.159s)
[262.954809] [049/132] (760s left) gem_exec_params (cliprects-invalid)
[263.017483] Starting subtest: cliprects-invalid
[263.019789] Subtest cliprects-invalid: SUCCESS (0.000s)
[263.116841] [050/132] (760s left) gem_linear_blits (interruptible)
[263.540980] Starting subtest: interruptible
[267.828699] Subtest interruptible: SUCCESS (4.287s)
[267.992899] [051/132] (755s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[268.139517] Starting subtest: y-tiled-8bpp-rotate-270
[268.143690] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[268.239641] [052/132] (755s left) kms_psr (fbc-psr-primary-page-flip)
[268.339326] Starting subtest: fbc-psr-primary-page-flip
[268.341715] Starting dynamic subtest: eDP-1
[268.345579] Dynamic subtest eDP-1: SKIP (0.000s)
[268.349730] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[268.410679] [053/132] (755s left) syncobj_wait (reset-signaled)
[268.466274] Starting subtest: reset-signaled
[268.468501] Subtest reset-signaled: SUCCESS (0.000s)
[268.574775] [054/132] (755s left) kms_color (legacy-gamma-reset)
[268.672175] Starting subtest: legacy-gamma-reset
[268.674342] Starting dynamic subtest: pipe-A-eDP-1
[269.046538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[269.056064] Starting dynamic subtest: pipe-B-eDP-1
[269.058377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[269.066761] Starting dynamic subtest: pipe-C-eDP-1
[269.071812] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[269.079972] Starting dynamic subtest: pipe-D-eDP-1
[269.085351] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[269.087648] Subtest legacy-gamma-reset: SUCCESS (0.413s)
[269.895611] [055/132] (753s left) kms_content_protection (mei-interface)
[270.044526] Starting subtest: mei-interface
[270.049245] Subtest mei-interface: SKIP (0.001s)
[270.168122] [056/132] (753s left) gem_exec_fence (syncobj-invalid-wait)
[270.633792] Starting subtest: syncobj-invalid-wait
[270.636256] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[271.969838] [057/132] (751s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[272.061223] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[272.065157] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[272.136931] [058/132] (751s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[272.194081] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[272.296963] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[272.373635] [059/132] (751s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[272.470761] Starting subtest: fbc-rgb565-draw-mmap-wc
[276.528278] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.060s)
[277.701606] [060/132] (746s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[277.795654] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[277.798164] Starting dynamic subtest: pipe-A-eDP-1
[277.821107] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.832207] Starting dynamic subtest: pipe-B-eDP-1
[277.853327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.861313] Starting dynamic subtest: pipe-C-eDP-1
[277.882830] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.890922] Starting dynamic subtest: pipe-D-eDP-1
[277.913422] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.917825] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[280.049814] [061/132] (743s left) gem_exec_whisper (basic-queues-all)
[280.102750] Starting subtest: basic-queues-all
[291.829945] Subtest basic-queues-all: SUCCESS (11.721s)
[292.026109] [062/132] (731s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[292.136518] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[292.140924] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[292.248856] [063/132] (731s left) syncobj_basic (test-valid-cycle)
[292.316600] Starting subtest: test-valid-cycle
[292.318673] Subtest test-valid-cycle: SUCCESS (0.000s)
[292.427007] [064/132] (731s left) gem_readwrite (read-bad-handle)
[292.492686] Subtest read-bad-handle: SKIP (0.000s)
[292.556011] [065/132] (731s left) syncobj_wait (wait-for-submit-complex)
[292.619092] Starting subtest: wait-for-submit-complex
[292.681863] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[292.791055] [066/132] (731s left) sw_sync (timeline_closed_signaled)
[292.830164] Starting subtest: timeline_closed_signaled
[292.832397] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[292.881235] [067/132] (731s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[292.979596] Starting subtest: 4-tiled-32bpp-rotate-90
[292.999683] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[293.103737] [068/132] (731s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[293.189921] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[293.193745] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[293.298979] [069/132] (730s left) syncobj_timeline (invalid-signal-bad-pad)
[293.355290] Starting subtest: invalid-signal-bad-pad
[293.357095] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[293.446812] [070/132] (730s left) prime_busy (hang)
[293.491650] Starting subtest: hang
[293.493966] Starting dynamic subtest: rcs0
[319.408683] Dynamic subtest rcs0: SUCCESS (25.910s)
[319.418355] Starting dynamic subtest: bcs0
[326.561073] Dynamic subtest bcs0: SUCCESS (7.154s)
[326.572513] Starting dynamic subtest: vcs0
[333.544416] Dynamic subtest vcs0: SUCCESS (6.980s)
[333.552546] Starting dynamic subtest: vcs1
[340.573314] Dynamic subtest vcs1: SUCCESS (7.031s)
[340.584612] Starting dynamic subtest: vecs0
[347.547215] Dynamic subtest vecs0: SUCCESS (6.972s)
[347.555934] Starting dynamic subtest: ccs0
[361.468548] Dynamic subtest ccs0: SUCCESS (13.916s)
[361.471047] Subtest hang: SUCCESS (67.971s)
[361.595925] [071/132] (662s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[361.652563] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[361.712873] [072/132] (662s left) kms_psr (psr2-dpms)
[361.811899] Starting subtest: psr2-dpms
[361.814019] Starting dynamic subtest: eDP-1
[364.686263] Dynamic subtest eDP-1: SUCCESS (2.874s)
[364.688397] Subtest psr2-dpms: SUCCESS (2.875s)
[365.552713] [073/132] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[365.652288] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[365.656389] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[365.745928] [074/132] (658s left) syncobj_wait (invalid-wait-bad-flags)
[365.808039] Starting subtest: invalid-wait-bad-flags
[365.810320] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[365.930065] [075/132] (658s left) kms_psr (psr-cursor-render)
[366.029224] Starting subtest: psr-cursor-render
[366.031301] Starting dynamic subtest: eDP-1
[367.758130] Dynamic subtest eDP-1: SUCCESS (1.729s)
[367.760500] Subtest psr-cursor-render: SUCCESS (1.730s)
[368.625551] [076/132] (655s left) gem_userptr_blits (userfault)
[368.686491] Starting subtest: userfault
[368.688780] Subtest userfault: SUCCESS (0.007s)
[368.809925] [077/132] (655s left) kms_dsc (dsc-fractional-bpp)
[368.900615] Starting subtest: dsc-fractional-bpp
[368.913276] Subtest dsc-fractional-bpp: SKIP (0.000s)
[368.986135] [078/132] (655s left) sw_sync (sync_busy)
[369.018712] Starting subtest: sync_busy
[369.020957] Subtest sync_busy: SUCCESS (0.002s)
[369.074953] [079/132] (655s left) i915_pm_rps (min-max-config-loaded)
[369.145997] Starting subtest: min-max-config-loaded
[369.150474] Subtest min-max-config-loaded: SKIP (0.001s)
[369.223893] [080/132] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[369.319182] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[369.323153] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[369.419752] [081/132] (655s left) gem_ctx_param (set-priority-range)
[369.481121] Starting subtest: set-priority-range
[369.496201] Subtest set-priority-range: SUCCESS (0.015s)
[369.612304] [082/132] (655s left) gem_exec_schedule (deep)
[369.798239] Starting subtest: deep
[369.800794] Starting dynamic subtest: rcs0
[375.120076] Dynamic subtest rcs0: SKIP (5.317s)
[375.143211] Starting dynamic subtest: vcs0
[385.272986] Dynamic subtest vcs0: SUCCESS (10.155s)
[385.286595] Starting dynamic subtest: vcs1
[396.063673] Dynamic subtest vcs1: SUCCESS (10.789s)
[396.075902] Starting dynamic subtest: vecs0
[407.216085] Dynamic subtest vecs0: SUCCESS (11.150s)
[407.226919] Starting dynamic subtest: ccs0
[419.342363] Dynamic subtest ccs0: SUCCESS (12.124s)
[419.345035] Subtest deep: SUCCESS (49.543s)
[420.858816] [083/132] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[420.951494] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[427.994360] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.045s)
[428.105657] [084/132] (596s left) gem_exec_capture (capture-invisible)
[428.166222] Starting subtest: capture-invisible
[428.168391] Starting dynamic subtest: smem0
[428.172620] Dynamic subtest smem0: SKIP (0.000s)
[428.176911] Subtest capture-invisible: SKIP (0.001s)
[428.256147] [085/132] (596s left) i915_pm_rps (thresholds-idle)
[428.308039] Starting subtest: thresholds-idle
[428.312314] Subtest thresholds-idle: SKIP (0.001s)
[428.407624] [086/132] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[428.503277] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[428.507476] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[428.595759] [087/132] (596s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[428.686149] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[428.714858] Starting dynamic subtest: pipe-A-plane-0
[429.013906] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[429.022286] Starting dynamic subtest: pipe-A-plane-3
[429.247222] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[429.255562] Starting dynamic subtest: pipe-A-plane-5
[429.258647] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[430.343494] Starting dynamic subtest: pipe-B-plane-0
[430.621828] Dynamic subtest pipe-B-plane-0: SUCCESS (0.288s)
[430.630569] Starting dynamic subtest: pipe-B-plane-3
[430.855268] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[430.869125] Starting dynamic subtest: pipe-B-plane-5
[430.873699] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[431.164242] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.478s)
[432.007862] [088/132] (592s left) gem_tiled_partial_pwrite_pread (writes)
[432.073832] Subtest writes: SKIP (0.000s)
[432.150148] [089/132] (592s left) gen9_exec_parse (bb-start-far)
[432.210952] Subtest bb-start-far: SKIP (0.000s)
[432.294086] [090/132] (592s left) kms_chamelium_frames (dp-crc-fast)
[432.663784] Subtest dp-crc-fast: SKIP (0.000s)
[433.519465] [091/132] (591s left) prime_self_import (basic-with_fd_dup)
[433.560085] Starting subtest: basic-with_fd_dup
[433.575182] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[433.682123] [092/132] (591s left) dumb_buffer (invalid-bpp)
[433.734373] Starting subtest: invalid-bpp
[433.737073] Subtest invalid-bpp: SUCCESS (0.000s)
[433.840571] [093/132] (591s left) gem_eio (in-flight-contexts-immediate)
[434.064295] Starting subtest: in-flight-contexts-immediate
[447.922865] Subtest in-flight-contexts-immediate: SUCCESS (13.856s)
[448.053495] [094/132] (577s left) api_intel_bb (full-batch)
[448.107835] Starting subtest: full-batch
[448.110569] Subtest full-batch: SUCCESS (0.005s)
[448.244621] [095/132] (577s left) kms_psr (pr-sprite-render)
[448.344486] Starting subtest: pr-sprite-render
[448.348787] Subtest pr-sprite-render: SKIP (0.000s)
[448.419368] [096/132] (576s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[448.469846] Starting subtest: single-wait-for-submit-available-signaled
[448.472177] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[448.591965] [097/132] (576s left) kms_lease (lease-invalid-crtc)
[448.689381] Starting subtest: lease-invalid-crtc
[448.691587] Starting dynamic subtest: pipe-A-eDP-1
[448.693891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[448.703491] Starting dynamic subtest: pipe-B-eDP-1
[448.705728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[448.714295] Starting dynamic subtest: pipe-C-eDP-1
[448.716559] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[448.725266] Starting dynamic subtest: pipe-D-eDP-1
[448.727417] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[448.729593] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[448.767057] [098/132] (576s left) gem_mmap_gtt (basic-write-gtt)
[448.829682] Subtest basic-write-gtt: SKIP (0.000s)
[448.895249] [099/132] (576s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[448.998225] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[449.007096] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[449.113534] [100/132] (576s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[449.214281] Starting subtest: fbc-1p-pri-indfb-multidraw
[462.237021] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.024s)
[463.669858] [101/132] (561s left) kms_flip (basic-plain-flip)
[463.765294] Starting subtest: basic-plain-flip
[463.767616] Starting dynamic subtest: A-eDP1
[465.456984] Dynamic subtest A-eDP1: SUCCESS (1.693s)
[465.470621] Starting dynamic subtest: B-eDP1
[467.094694] Dynamic subtest B-eDP1: SUCCESS (1.635s)
[467.105067] Starting dynamic subtest: C-eDP1
[468.734587] Dynamic subtest C-eDP1: SUCCESS (1.638s)
[468.746255] Starting dynamic subtest: D-eDP1
[470.366408] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[470.371259] Subtest basic-plain-flip: SUCCESS (6.610s)
[471.553089] [102/132] (554s left) gem_flink_race (flink_close)
[471.593891] Starting subtest: flink_close
[476.681318] Subtest flink_close: SUCCESS (5.087s)
[476.758478] [103/132] (548s left) kms_addfb_basic (bad-pitch-256)
[476.812861] Starting subtest: bad-pitch-256
[476.815493] Subtest bad-pitch-256: SUCCESS (0.000s)
[476.961552] [104/132] (548s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[477.019588] Starting subtest: multi-wait-available-unsubmitted-submitted
[477.021815] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[477.128711] [105/132] (548s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[477.237453] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[477.239605] Starting dynamic subtest: pipe-A-eDP-1
[477.261618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.275542] Starting dynamic subtest: pipe-B-eDP-1
[477.297050] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.305813] Starting dynamic subtest: pipe-C-eDP-1
[477.327263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.335818] Starting dynamic subtest: pipe-D-eDP-1
[477.357608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.361680] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[479.523588] [106/132] (546s left) gem_partial_pwrite_pread (writes-after-reads)
[479.587106] Subtest writes-after-reads: SKIP (0.000s)
[479.670459] [107/132] (546s left) kms_cursor_edge_walk (128x128-left-edge)
[479.763414] Starting subtest: 128x128-left-edge
[479.765734] Starting dynamic subtest: pipe-A-eDP-1
[483.192617] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s)
[483.202058] Starting dynamic subtest: pipe-D-eDP-1
[486.315079] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[486.317433] Subtest 128x128-left-edge: SUCCESS (6.554s)
[487.124330] [108/132] (538s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[487.221329] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[487.225275] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[487.317984] [109/132] (538s left) kms_plane (plane-panning-top-left)
[487.400917] Starting subtest: plane-panning-top-left
[487.402778] Starting dynamic subtest: pipe-A
[489.112346] Dynamic subtest pipe-A: SUCCESS (1.711s)
[489.121704] Starting dynamic subtest: pipe-B
[491.576701] Dynamic subtest pipe-B: SUCCESS (2.462s)
[491.579021] Subtest plane-panning-top-left: SUCCESS (4.176s)
[492.463292] [110/132] (533s left) kms_plane_alpha_blend (alpha-transparent-fb)
[492.546149] Starting subtest: alpha-transparent-fb
[492.830439] Starting dynamic subtest: pipe-A-eDP-1
[493.481857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.651s)
[493.492314] Starting dynamic subtest: pipe-D-eDP-1
[494.833499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.349s)
[494.835820] Subtest alpha-transparent-fb: SUCCESS (2.289s)
[495.646437] [111/132] (530s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[495.781070] Starting subtest: modeset-atomic-cursor-hotspot
[495.785415] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[495.924963] [112/132] (530s left) kms_cdclk (plane-scaling)
[496.018068] Starting subtest: plane-scaling
[496.020214] Starting dynamic subtest: pipe-A-eDP-1
[496.310225] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s)
[496.319472] Starting dynamic subtest: pipe-B-eDP-1
[496.323818] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[496.332745] Starting dynamic subtest: pipe-C-eDP-1
[496.337146] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[496.346375] Starting dynamic subtest: pipe-D-eDP-1
[496.350269] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[496.354267] Subtest plane-scaling: SKIP (0.298s)
[497.163102] [113/132] (528s left) kms_setmode (invalid-clone-single-crtc)
[497.216880] Starting subtest: invalid-clone-single-crtc
[497.223264] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[497.309529] [114/132] (528s left) intel_hwmon (hwmon-write)
[497.366188] Subtest hwmon-write: SKIP (0.000s)
[497.422329] [115/132] (528s left) gem_softpin (allocator-fork)
[497.472382] Starting subtest: allocator-fork
[499.684030] Subtest allocator-fork: SUCCESS (2.211s)
[499.804425] [116/132] (526s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[499.894773] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[499.897063] Starting dynamic subtest: pipe-A-eDP-1
[499.952643] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[499.961427] Starting dynamic subtest: pipe-B-eDP-1
[500.017062] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[500.027024] Starting dynamic subtest: pipe-C-eDP-1
[500.083574] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[500.093789] Starting dynamic subtest: pipe-D-eDP-1
[500.149796] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[500.154101] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[502.217162] [117/132] (524s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[502.314783] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[502.319070] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[502.407607] [118/132] (523s left) kms_prop_blob (invalid-get-prop)
[502.462691] Starting subtest: invalid-get-prop
[502.464829] Subtest invalid-get-prop: SUCCESS (0.000s)
[502.554907] [119/132] (523s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[502.671060] Starting subtest: basic-flip-before-cursor-legacy
[503.657906] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.986s)
[504.455689] [120/132] (521s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[504.561443] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[511.331763] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.774s)
[511.470897] [121/132] (514s left) gem_ctx_persistence (engines-hostile-preempt)
[511.525153] Starting subtest: engines-hostile-preempt
[511.527503] Starting dynamic subtest: rcs0
[511.599802] Dynamic subtest rcs0: SUCCESS (0.074s)
[511.612082] Starting dynamic subtest: bcs0
[511.652288] Dynamic subtest bcs0: SUCCESS (0.050s)
[511.666235] Starting dynamic subtest: vcs0
[512.912259] Dynamic subtest vcs0: SUCCESS (1.257s)
[512.923364] Starting dynamic subtest: vcs1
[514.895083] Dynamic subtest vcs1: SUCCESS (1.980s)
[514.905203] Starting dynamic subtest: vecs0
[516.860036] Dynamic subtest vecs0: SUCCESS (1.961s)
[516.872568] Starting dynamic subtest: ccs0
[516.948361] Dynamic subtest ccs0: SUCCESS (0.087s)
[516.951067] Subtest engines-hostile-preempt: SUCCESS (5.423s)
[517.041402] [122/132] (509s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[517.148182] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[517.994711] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[518.196797] [123/132] (508s left) gem_exec_reloc (basic-cpu-wc)
[518.253420] Subtest basic-cpu-wc: SKIP (0.000s)
[518.334466] [124/132] (508s left) gem_mmap_wc (pf-nonblock)
[518.388552] Subtest pf-nonblock: SKIP (0.000s)
[518.459224] [125/132] (508s left) gem_ctx_shared (exec-shared-gtt)
[518.520607] Starting subtest: exec-shared-gtt
[518.523308] Starting dynamic subtest: rcs0
[518.527728] Dynamic subtest rcs0: SUCCESS (0.007s)
[518.537207] Starting dynamic subtest: bcs0
[518.539459] Dynamic subtest bcs0: SUCCESS (0.006s)
[518.548568] Starting dynamic subtest: vcs0
[518.550847] Dynamic subtest vcs0: SUCCESS (0.007s)
[518.560482] Starting dynamic subtest: vcs1
[518.562732] Dynamic subtest vcs1: SUCCESS (0.006s)
[518.571954] Starting dynamic subtest: vecs0
[518.573881] Dynamic subtest vecs0: SUCCESS (0.005s)
[518.582193] Starting dynamic subtest: ccs0
[518.584076] Dynamic subtest ccs0: SUCCESS (0.007s)
[518.585946] Subtest exec-shared-gtt: SUCCESS (0.043s)
[518.764636] [126/132] (507s left) kms_flip (2x-busy-flip)
[518.859309] Starting subtest: 2x-busy-flip
[518.867568] Subtest 2x-busy-flip: SKIP (0.011s)
[518.955265] [127/132] (507s left) gem_mmap_gtt (basic)
[519.016818] Subtest basic: SKIP (0.000s)
[519.086302] [128/132] (507s left) kms_psr (fbc-pr-sprite-render)
[519.168443] Starting subtest: fbc-pr-sprite-render
[519.171935] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[519.239471] [129/132] (507s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[519.288959] Starting subtest: yf-tiled-to-vebox-y-tiled
[519.292770] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[519.476881] [130/132] (507s left) gem_ctx_persistence (legacy-engines-hang)
[519.530448] Starting subtest: legacy-engines-hang
[519.532841] Starting dynamic subtest: render
[519.648985] Dynamic subtest render: SUCCESS (0.118s)
[519.659791] Starting dynamic subtest: bsd1
[519.746682] Dynamic subtest bsd1: SUCCESS (0.095s)
[519.761527] Starting dynamic subtest: bsd2
[519.844975] Dynamic subtest bsd2: SUCCESS (0.095s)
[519.857443] Starting dynamic subtest: blt
[519.937621] Dynamic subtest blt: SUCCESS (0.091s)
[519.951575] Starting dynamic subtest: vebox
[520.034601] Dynamic subtest vebox: SUCCESS (0.094s)
[520.037225] Subtest legacy-engines-hang: SUCCESS (0.506s)
[520.130179] [131/132] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[520.218316] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[520.222696] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[520.310838] [132/132] (506s left) gem_exec_schedule (preempt-user)
[520.378599] Starting subtest: preempt-user
[520.380812] Starting dynamic subtest: rcs0
[520.395826] Dynamic subtest rcs0: SUCCESS (0.025s)
[520.405778] Starting dynamic subtest: bcs0
[520.413648] Dynamic subtest bcs0: SUCCESS (0.017s)
[520.422724] Starting dynamic subtest: vcs0
[520.431741] Dynamic subtest vcs0: SUCCESS (0.017s)
[520.440393] Starting dynamic subtest: vcs1
[520.455078] Dynamic subtest vcs1: SUCCESS (0.023s)
[520.464061] Starting dynamic subtest: vecs0
[520.472904] Dynamic subtest vecs0: SUCCESS (0.017s)
[520.482809] Starting dynamic subtest: ccs0
[520.494178] Dynamic subtest ccs0: SUCCESS (0.020s)
[520.496082] Subtest preempt-user: SUCCESS (0.125s)
[521.954091] Closing watchdogs
results: parsing output: 0/ for test: kms_vblank
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: gem_exec_flush
results: parsing output: 14/ for test: gem_exec_whisper
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: kms_atomic_transition
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_flink_basic
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: sysfs_heartbeat_interval
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_joiner
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: api_intel_allocator
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_selftest
results: parsing output: 39/ for test: fbdev
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_ctx_engines
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: gem_linear_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: gem_readwrite
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: prime_busy
results: parsing output: 70/ for test: kms_pipe_b_c_ivb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: kms_dsc
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_capture
results: parsing output: 84/ for test: i915_pm_rps
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 88/ for test: gen9_exec_parse
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: prime_self_import
results: parsing output: 91/ for test: dumb_buffer
results: parsing output: 92/ for test: gem_eio
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_flink_race
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: kms_cursor_edge_walk
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_plane_alpha_blend
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_cdclk
results: parsing output: 112/ for test: kms_setmode
results: parsing output: 113/ for test: intel_hwmon
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_prop_blob
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: gem_ctx_shared
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
Done.