[57.177198] Initializing watchdogs
[57.177246]   /dev/watchdog0
[57.191698] [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.196066] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.198266] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.201573] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-64x64)
[57.419754] Starting subtest: cursor-onscreen-64x64
[57.435585] Starting dynamic subtest: pipe-A-eDP-1
[59.605564] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.166s)
[59.639605] Starting dynamic subtest: pipe-D-eDP-1
[62.379211] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.740s)
[62.381560] Subtest cursor-onscreen-64x64: SUCCESS (4.950s)
[63.281391] [002/133] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[63.378047] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[63.382249] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.478698] [003/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[63.587657] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[70.985973] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.398s)
[71.129215] [004/133] (946s left) kms_plane_alpha_blend (constant-alpha-min)
[71.216722] Starting subtest: constant-alpha-min
[71.503589] Starting dynamic subtest: pipe-A-eDP-1
[72.204778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[72.213930] Starting dynamic subtest: pipe-D-eDP-1
[73.672521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.466s)
[73.675230] Subtest constant-alpha-min: SUCCESS (2.455s)
[74.473503] [005/133] (943s left) kms_chamelium_edid (dp-mode-timings)
[74.868492] Subtest dp-mode-timings: SKIP (0.000s)
[75.688090] [006/133] (942s left) gem_tiled_fence_blits (basic)
[75.751475] Subtest basic: SKIP (0.000s)
[75.792827] [007/133] (942s left) kms_color (gamma)
[75.892273] Starting subtest: gamma
[75.894199] Starting dynamic subtest: pipe-A-eDP-1
[76.624272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[76.632430] Starting dynamic subtest: pipe-B-eDP-1
[78.015623] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[78.024052] Starting dynamic subtest: pipe-C-eDP-1
[79.390354] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[79.400920] Starting dynamic subtest: pipe-D-eDP-1
[80.727376] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[80.729676] Subtest gamma: SUCCESS (4.835s)
[81.519147] [008/133] (936s left) gem_lmem_swapping (verify)
[81.569743] Subtest verify: SKIP (0.000s)
[81.611742] [009/133] (936s left) sysfs_heartbeat_interval (nopreempt)
[81.662899] Starting subtest: nopreempt
[81.665246] Starting dynamic subtest: vecs0
[90.901622] Dynamic subtest vecs0: SUCCESS (9.235s)
[90.910695] Starting dynamic subtest: ccs0
[94.888881] Dynamic subtest ccs0: SUCCESS (3.988s)
[94.899128] Starting dynamic subtest: vcs0
[103.884900] Dynamic subtest vcs0: SUCCESS (8.993s)
[103.894752] Starting dynamic subtest: bcs0
[107.850570] Dynamic subtest bcs0: SUCCESS (3.965s)
[107.859286] Starting dynamic subtest: rcs0
[111.851417] Dynamic subtest rcs0: SUCCESS (4.000s)
[111.861275] Starting dynamic subtest: vcs1
[121.935628] Dynamic subtest vcs1: SUCCESS (10.083s)
[121.938191] Subtest nopreempt: SUCCESS (40.272s)
[122.011472] [010/133] (896s left) gem_exec_schedule (preempt-other)
[122.077198] Starting subtest: preempt-other
[122.079150] Starting dynamic subtest: rcs0
[122.206491] Dynamic subtest rcs0: SUCCESS (0.134s)
[122.217201] Starting dynamic subtest: bcs0
[122.324434] Dynamic subtest bcs0: SUCCESS (0.118s)
[122.331653] Starting dynamic subtest: vcs0
[122.450783] Dynamic subtest vcs0: SUCCESS (0.125s)
[122.462014] Starting dynamic subtest: vcs1
[122.564774] Dynamic subtest vcs1: SUCCESS (0.114s)
[122.575310] Starting dynamic subtest: vecs0
[122.688261] Dynamic subtest vecs0: SUCCESS (0.123s)
[122.698984] Starting dynamic subtest: ccs0
[122.808260] Dynamic subtest ccs0: SUCCESS (0.120s)
[122.810494] Subtest preempt-other: SUCCESS (0.736s)
[123.952311] [011/133] (894s left) gem_ctx_engines (execute-one)
[124.007730] Starting subtest: execute-one
[127.986377] Subtest execute-one: SUCCESS (3.978s)
[128.905073] [012/133] (889s left) kms_addfb_basic (master-rmfb)
[128.965617] Starting subtest: master-rmfb
[128.967819] Subtest master-rmfb: SUCCESS (0.001s)
[129.090300] [013/133] (889s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[129.173109] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[129.175431] Starting dynamic subtest: pipe-A-eDP-1
[129.198794] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.207844] Starting dynamic subtest: pipe-B-eDP-1
[129.228681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.235947] Starting dynamic subtest: pipe-C-eDP-1
[129.256704] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.263781] Starting dynamic subtest: pipe-D-eDP-1
[129.285280] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.289640] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[131.401036] [014/133] (886s left) kms_atomic (plane-immutable-zpos)
[131.489792] Starting subtest: plane-immutable-zpos
[131.492141] Starting dynamic subtest: pipe-A-eDP-1
[132.148460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.657s)
[132.150897] Subtest plane-immutable-zpos: SUCCESS (0.658s)
[132.938213] [015/133] (885s left) kms_vblank (ts-continuation-idle-hang)
[133.029313] Starting subtest: ts-continuation-idle-hang
[133.031624] Starting dynamic subtest: pipe-A-eDP-1
[159.651638] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.617s)
[159.664527] Starting dynamic subtest: pipe-D-eDP-1
[174.678989] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.021s)
[174.681068] Subtest ts-continuation-idle-hang: SUCCESS (41.646s)
[175.488389] [016/133] (842s left) gem_userptr_blits (set-cache-level)
[175.570233] Starting subtest: set-cache-level
[175.574761] Subtest set-cache-level: SKIP (0.000s)
[175.692425] [017/133] (842s left) gem_exec_balancer (full-late)
[175.762885] Starting subtest: full-late
[180.787021] Subtest full-late: SUCCESS (5.023s)
[181.104987] [018/133] (837s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[181.200505] Starting subtest: yf-tiled-16bpp-rotate-180
[181.204736] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[181.294484] [019/133] (837s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[181.385279] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[181.389609] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[181.454146] [020/133] (836s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[181.557378] Starting subtest: fbc-shrfb-scaledprimary
[184.592425] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.038s)
[185.816332] [021/133] (832s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[185.921268] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[193.368997] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.449s)
[193.478396] [022/133] (825s left) kms_pm_rpm (cursor)
[195.006892] Starting subtest: cursor
[195.011203] Subtest cursor: SKIP (0.000s)
[195.729804] [023/133] (822s left) kms_psr (fbc-psr-sprite-blt)
[195.816976] Starting subtest: fbc-psr-sprite-blt
[195.819319] Starting dynamic subtest: eDP-1
[195.823585] Dynamic subtest eDP-1: SKIP (0.000s)
[195.827923] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[195.899888] [024/133] (822s left) syncobj_wait (single-wait-all-for-submit-submitted)
[195.953461] Starting subtest: single-wait-all-for-submit-submitted
[196.057036] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[196.130231] [025/133] (822s left) gem_exec_reloc (basic-write-gtt-noreloc)
[196.180765] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[196.253680] [026/133] (822s left) kms_hdr (brightness-with-hdr)
[196.345957] Starting subtest: brightness-with-hdr
[196.352505] Subtest brightness-with-hdr: SKIP (0.000s)
[196.427686] [027/133] (822s left) gen3_render_tiledy_blits
[196.538827] [028/133] (822s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[196.621679] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[196.623922] Starting dynamic subtest: pipe-A-eDP-1
[196.632131] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.646656] Starting dynamic subtest: pipe-B-eDP-1
[196.655586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.665081] Starting dynamic subtest: pipe-C-eDP-1
[196.673399] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.680959] Starting dynamic subtest: pipe-D-eDP-1
[196.689243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.693458] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[198.881294] [029/133] (819s left) gem_mmap_gtt (medium-copy)
[198.942262] Subtest medium-copy: SKIP (0.000s)
[198.999185] [030/133] (819s left) gem_exec_flush (basic-wb-ro-before-default)
[199.055469] Starting subtest: basic-wb-ro-before-default
[204.515282] Subtest basic-wb-ro-before-default: SUCCESS (5.460s)
[204.699443] [031/133] (814s left) gem_exec_async (concurrent-writes)
[204.762630] Starting subtest: concurrent-writes
[204.764827] Starting dynamic subtest: rcs0
[204.791161] Dynamic subtest rcs0: SUCCESS (0.028s)
[204.805866] Starting dynamic subtest: bcs0
[204.807782] Dynamic subtest bcs0: SUCCESS (0.009s)
[204.819620] Starting dynamic subtest: vcs0
[204.821931] Dynamic subtest vcs0: SUCCESS (0.009s)
[204.830301] Starting dynamic subtest: vcs1
[204.832547] Dynamic subtest vcs1: SUCCESS (0.010s)
[204.841295] Starting dynamic subtest: vecs0
[204.843451] Dynamic subtest vecs0: SUCCESS (0.009s)
[204.851266] Starting dynamic subtest: ccs0
[204.857830] Dynamic subtest ccs0: SUCCESS (0.008s)
[204.859893] Subtest concurrent-writes: SUCCESS (0.077s)
[205.062976] [032/133] (813s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[205.128790] Starting subtest: invalid-bsd2-flag-on-blt
[205.131083] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[205.253090] [033/133] (813s left) kms_chamelium_color (ctm-blue-to-red)
[205.343143] Subtest ctm-blue-to-red: SKIP (0.000s)
[205.387123] [034/133] (813s left) gem_render_copy (y-tiled)
[205.448565] Starting subtest: y-tiled
[205.453035] Subtest y-tiled: SKIP (0.000s)
[205.646551] [035/133] (813s left) gem_ctx_persistence (saturated-hostile)
[205.704445] Starting subtest: saturated-hostile
[205.706725] Starting dynamic subtest: rcs0
[206.510774] Dynamic subtest rcs0: SUCCESS (0.803s)
[206.518964] Starting dynamic subtest: bcs0
[207.271431] Dynamic subtest bcs0: SUCCESS (0.759s)
[207.281384] Starting dynamic subtest: vcs0
[208.060788] Dynamic subtest vcs0: SUCCESS (0.790s)
[208.072220] Starting dynamic subtest: vcs1
[208.854502] Dynamic subtest vcs1: SUCCESS (0.793s)
[208.866563] Starting dynamic subtest: vecs0
[209.669430] Dynamic subtest vecs0: SUCCESS (0.812s)
[209.680610] Starting dynamic subtest: ccs0
[210.508660] Dynamic subtest ccs0: SUCCESS (0.837s)
[210.511238] Subtest saturated-hostile: SUCCESS (4.805s)
[210.598539] [036/133] (808s left) kms_psr (fbc-pr-sprite-plane-onoff)
[210.692815] Starting subtest: fbc-pr-sprite-plane-onoff
[210.697305] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[210.766426] [037/133] (808s left) kms_flip (2x-flip-vs-suspend-interruptible)
[210.866842] Starting subtest: 2x-flip-vs-suspend-interruptible
[210.878240] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[211.002624] [038/133] (808s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[211.055059] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[211.161609] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s)
[211.246659] [039/133] (807s left) kms_psr (psr2-sprite-mmap-cpu)
[211.346982] Starting subtest: psr2-sprite-mmap-cpu
[211.349760] Starting dynamic subtest: eDP-1
[213.080703] Dynamic subtest eDP-1: SUCCESS (1.733s)
[213.083064] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.734s)
[213.940218] [040/133] (805s left) gem_userptr_blits (readonly-pwrite-unsync)
[213.998905] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[214.133069] [041/133] (805s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[214.214057] Starting subtest: plane-downscale-factor-0-5-with-rotation
[214.216286] Starting dynamic subtest: pipe-A
[214.235437] Dynamic subtest pipe-A: SKIP (0.017s)
[214.244445] Starting dynamic subtest: pipe-B
[214.268295] Dynamic subtest pipe-B: SKIP (0.032s)
[214.276803] Starting dynamic subtest: pipe-C
[214.300928] Dynamic subtest pipe-C: SKIP (0.032s)
[214.308894] Starting dynamic subtest: pipe-D
[214.330924] Dynamic subtest pipe-D: SKIP (0.030s)
[214.335120] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.114s)
[214.432844] [042/133] (804s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[214.480769] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[214.483056] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[214.564705] [043/133] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[214.659022] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[214.663241] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[214.756591] [044/133] (804s left) gem_mmap_gtt (hang-busy)
[214.813109] Subtest hang-busy: SKIP (0.000s)
[214.866639] [045/133] (804s left) core_auth (basic-auth)
[214.921556] Starting subtest: basic-auth
[214.923467] Subtest basic-auth: SUCCESS (0.001s)
[215.029220] [046/133] (804s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[215.125611] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[215.129195] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[215.229221] [047/133] (804s left) perf_pmu (init-busy)
[215.269193] Starting subtest: init-busy
[215.271152] Starting dynamic subtest: rcs0
[215.273075] Dynamic subtest rcs0: SUCCESS (0.001s)
[215.281887] Starting dynamic subtest: bcs0
[215.283754] Dynamic subtest bcs0: SUCCESS (0.000s)
[215.291254] Starting dynamic subtest: vcs0
[215.293059] Dynamic subtest vcs0: SUCCESS (0.001s)
[215.300637] Starting dynamic subtest: vcs1
[215.302477] Dynamic subtest vcs1: SUCCESS (0.000s)
[215.310056] Starting dynamic subtest: vecs0
[215.311849] Dynamic subtest vecs0: SUCCESS (0.000s)
[215.319614] Starting dynamic subtest: ccs0
[215.321470] Dynamic subtest ccs0: SUCCESS (0.000s)
[215.323319] Subtest init-busy: SUCCESS (0.007s)
[215.382403] [048/133] (804s left) gem_eio (wait-immediate)
[215.581055] Starting subtest: wait-immediate
[215.898615] Subtest wait-immediate: SUCCESS (0.317s)
[216.024900] [049/133] (803s left) i915_pm_rpm (system-suspend-execbuf)
[218.155227] Starting subtest: system-suspend-execbuf
[276.729677] Subtest system-suspend-execbuf: SUCCESS (43.819s)
[277.102690] [050/133] (742s left) kms_properties (plane-properties-atomic)
[277.209938] Starting subtest: plane-properties-atomic
[277.212264] Starting dynamic subtest: pipe-A-eDP-1
[277.771435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s)
[277.785489] Starting dynamic subtest: pipe-B-eDP-1
[279.063566] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s)
[279.073144] Starting dynamic subtest: pipe-C-eDP-1
[280.301046] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[280.311959] Starting dynamic subtest: pipe-D-eDP-1
[281.534878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[281.536784] Subtest plane-properties-atomic: SUCCESS (4.324s)
[282.345122] [051/133] (737s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[282.440449] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[282.442706] Starting dynamic subtest: pipe-A-eDP-1
[293.122657] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.682s)
[293.133567] Starting dynamic subtest: pipe-B-eDP-1
[304.567237] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.437s)
[304.569197] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.122s)
[305.410831] [052/133] (714s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[305.814596] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[306.619300] [053/133] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[306.721827] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[306.726045] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[306.804694] [054/133] (712s left) gem_userptr_blits (readonly-unsync)
[306.864708] Subtest readonly-unsync: SKIP (0.000s)
[306.977223] [055/133] (712s left) gem_exec_fence (syncobj-import)
[307.446455] Starting subtest: syncobj-import
[307.451117] Subtest syncobj-import: SUCCESS (0.007s)
[308.656733] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[308.660365] [056/133] (711s left) gem_ctx_param (get-priority-new-ctx)
[308.721678] Starting subtest: get-priority-new-ctx
[308.724142] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[308.843859] [057/133] (711s left) kms_psr (pr-cursor-mmap-gtt)
[308.933090] Starting subtest: pr-cursor-mmap-gtt
[308.937084] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[309.006296] [058/133] (710s left) kms_cursor_crc (cursor-random-max-size)
[309.346487] Starting subtest: cursor-random-max-size
[309.352987] Subtest cursor-random-max-size: SKIP (0.000s)
[309.484474] [059/133] (710s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[309.547017] Starting subtest: yf-tiled-ccs-to-x-tiled
[309.551499] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[309.742679] [060/133] (710s left) api_intel_bb (lot-of-buffers)
[309.797904] Starting subtest: lot-of-buffers
[310.899532] Subtest lot-of-buffers: SUCCESS (1.101s)
[311.416476] [061/133] (708s left) kms_invalid_mode (int-max-clock)
[311.514948] Starting subtest: int-max-clock
[311.517284] Starting dynamic subtest: pipe-A-eDP-1
[311.800818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[311.809881] Starting dynamic subtest: pipe-B-eDP-1
[311.812005] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[311.820550] Starting dynamic subtest: pipe-C-eDP-1
[311.822790] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[311.831192] Starting dynamic subtest: pipe-D-eDP-1
[311.833091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[311.835072] Subtest int-max-clock: SUCCESS (0.294s)
[312.665001] [062/133] (707s left) gen9_exec_parse (basic-rejected)
[312.731475] Subtest basic-rejected: SKIP (0.000s)
[312.801916] [063/133] (707s left) perf (unprivileged-single-ctx-counters)
[312.919506] Starting subtest: unprivileged-single-ctx-counters
[312.923142] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[312.969978] [064/133] (707s left) kms_properties (plane-properties-legacy)
[313.077519] Starting subtest: plane-properties-legacy
[313.079435] Starting dynamic subtest: pipe-A-eDP-1
[313.628805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[313.639196] Starting dynamic subtest: pipe-B-eDP-1
[314.945470] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[314.955923] Starting dynamic subtest: pipe-C-eDP-1
[316.183358] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[316.193851] Starting dynamic subtest: pipe-D-eDP-1
[317.419871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[317.422035] Subtest plane-properties-legacy: SUCCESS (4.341s)
[318.212159] [065/133] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.308931] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[318.312833] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.412087] [066/133] (701s left) kms_prop_blob (blob-multiple)
[318.464432] Starting subtest: blob-multiple
[318.466681] Subtest blob-multiple: SUCCESS (0.002s)
[318.561449] [067/133] (701s left) gem_ctx_persistence (engines-hostile-preempt)
[318.623333] Starting subtest: engines-hostile-preempt
[318.625672] Starting dynamic subtest: rcs0
[318.711984] Dynamic subtest rcs0: SUCCESS (0.089s)
[318.723970] Starting dynamic subtest: bcs0
[318.764265] Dynamic subtest bcs0: SUCCESS (0.050s)
[318.777981] Starting dynamic subtest: vcs0
[320.547071] Dynamic subtest vcs0: SUCCESS (1.778s)
[320.559789] Starting dynamic subtest: vcs1
[322.503255] Dynamic subtest vcs1: SUCCESS (1.952s)
[322.515334] Starting dynamic subtest: vecs0
[324.573550] Dynamic subtest vecs0: SUCCESS (2.067s)
[324.585657] Starting dynamic subtest: ccs0
[324.631632] Dynamic subtest ccs0: SUCCESS (0.057s)
[324.634212] Subtest engines-hostile-preempt: SUCCESS (6.007s)
[324.724972] [068/133] (695s left) i915_hangman (detector)
[324.801104] Starting subtest: detector
[324.803363] Starting dynamic subtest: rcs0
[335.554502] Dynamic subtest rcs0: SUCCESS (10.753s)
[335.565794] Starting dynamic subtest: bcs0
[346.562165] Dynamic subtest bcs0: SUCCESS (11.007s)
[346.574181] Starting dynamic subtest: vcs0
[357.506008] Dynamic subtest vcs0: SUCCESS (10.941s)
[357.518612] Starting dynamic subtest: vcs1
[369.474108] Dynamic subtest vcs1: SUCCESS (11.964s)
[369.486794] Starting dynamic subtest: vecs0
[380.545116] Dynamic subtest vecs0: SUCCESS (11.067s)
[380.557155] Starting dynamic subtest: ccs0
[392.514366] Dynamic subtest ccs0: SUCCESS (11.964s)
[392.517618] Subtest detector: SUCCESS (67.713s)
[392.648183] [069/133] (627s left) i915_drm_fdinfo (busy-hang)
[392.701419] Starting subtest: busy-hang
[392.703794] Starting dynamic subtest: rcs0
[392.731760] Dynamic subtest rcs0: SKIP (0.030s)
[392.743153] Starting dynamic subtest: bcs0
[392.747507] Dynamic subtest bcs0: SKIP (0.001s)
[392.756808] Starting dynamic subtest: vcs0
[392.760921] Dynamic subtest vcs0: SKIP (0.001s)
[392.770178] Starting dynamic subtest: vcs1
[392.774543] Dynamic subtest vcs1: SKIP (0.001s)
[392.783397] Starting dynamic subtest: vecs0
[392.787758] Dynamic subtest vecs0: SKIP (0.001s)
[392.796453] Starting dynamic subtest: ccs0
[392.800912] Dynamic subtest ccs0: SKIP (0.001s)
[392.805284] Subtest busy-hang: SKIP (0.039s)
[392.843137] [070/133] (627s left) syncobj_timeline (single-wait-available-submitted)
[392.896761] Starting subtest: single-wait-available-submitted
[392.899027] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[393.011238] [071/133] (627s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[393.114994] Starting subtest: y-tiled-8bpp-rotate-180
[393.118847] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[393.217911] [072/133] (627s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[393.337176] Starting subtest: basic-busy-flip-before-cursor-atomic
[393.341696] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[393.484926] [073/133] (627s left) gem_exec_schedule (reorder-wide)
[393.661557] Subtest reorder-wide: SKIP (0.000s)
[393.853631] [074/133] (626s left) kms_big_fb (linear-32bpp-rotate-90)
[393.949593] Starting subtest: linear-32bpp-rotate-90
[393.969803] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[394.087429] [075/133] (626s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[394.185029] Starting subtest: fbc-2p-pri-indfb-multidraw
[394.189307] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[394.289605] [076/133] (626s left) gem_eio (in-flight-contexts-10ms)
[394.458258] Starting subtest: in-flight-contexts-10ms
[404.609501] Subtest in-flight-contexts-10ms: SUCCESS (10.148s)
[404.771004] [077/133] (615s left) gem_exec_fence (syncobj-timeline-signal)
[405.333766] Starting subtest: syncobj-timeline-signal
[405.342250] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[406.646226] [078/133] (614s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[406.741753] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[406.744103] Starting dynamic subtest: pipe-A-eDP-1
[406.768237] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[406.779756] Starting dynamic subtest: pipe-B-eDP-1
[406.803895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[406.814026] Starting dynamic subtest: pipe-C-eDP-1
[406.838379] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.848992] Starting dynamic subtest: pipe-D-eDP-1
[406.872677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.876790] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[408.980551] [079/133] (611s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[409.047460] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[409.111536] [080/133] (611s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[409.201567] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[409.203819] Starting dynamic subtest: pipe-A-default-mode
[411.950974] Dynamic subtest pipe-A-default-mode: SUCCESS (2.748s)
[411.953305] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.749s)
[412.777319] [081/133] (608s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[412.878418] Starting subtest: primary-yf-tiled-reflect-x-0
[412.949349] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[413.055125] [082/133] (607s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[413.175681] Starting subtest: cursorB-vs-flipB-toggle
[413.180173] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[413.323865] [083/133] (607s left) gem_ringfill (engines-basic)
[418.599635] Starting subtest: engines-basic
[418.602180] Starting dynamic subtest: rcs0
[418.660945] Dynamic subtest rcs0: SUCCESS (0.061s)
[418.672851] Starting dynamic subtest: bcs0
[418.706290] Dynamic subtest bcs0: SUCCESS (0.044s)
[418.716897] Starting dynamic subtest: vcs0
[418.750390] Dynamic subtest vcs0: SUCCESS (0.042s)
[418.764315] Starting dynamic subtest: vcs1
[418.794279] Dynamic subtest vcs1: SUCCESS (0.042s)
[418.804638] Starting dynamic subtest: vecs0
[418.838206] Dynamic subtest vecs0: SUCCESS (0.042s)
[418.848742] Starting dynamic subtest: ccs0
[418.883649] Dynamic subtest ccs0: SUCCESS (0.044s)
[418.886107] Subtest engines-basic: SUCCESS (0.286s)
[418.962529] [084/133] (602s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[419.053893] Starting subtest: drrs-dirtyfb-ioctl
[419.067100] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[419.149432] [085/133] (601s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[419.236194] Starting subtest: fbcpsr-modesetfrombusy
[425.476606] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.243s)
[425.617918] [086/133] (595s left) gem_mmap_wc (write)
[425.681077] Subtest write: SKIP (0.000s)
[425.751566] [087/133] (595s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[425.880865] Starting subtest: flip-vs-cursor-varying-size
[434.591781] Subtest flip-vs-cursor-varying-size: SUCCESS (8.706s)
[435.386685] [088/133] (585s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[435.495274] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[435.499810] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[435.620500] [089/133] (585s left) perf (gen12-group-exclusive-stream-ctx-handle)
[435.723365] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[435.746783] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[435.786496] [090/133] (585s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[437.614813] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[444.706574] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.092s)
[444.846628] [091/133] (576s left) gem_lmem_evict (dontneed-evict-race)
[444.906197] Subtest dontneed-evict-race: SKIP (0.000s)
[444.950794] [092/133] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[445.053306] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[445.057744] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.145625] [093/133] (576s left) syncobj_basic (illegal-fd-to-handle)
[445.201808] Starting subtest: illegal-fd-to-handle
[445.204000] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[445.291635] [094/133] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[445.385460] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[452.505585] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.121s)
[452.632293] [095/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[452.732491] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[452.736687] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[452.833459] [096/133] (568s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[452.965489] Starting subtest: flip-vs-cursor-busy-crc-atomic
[453.769531] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.804s)
[454.634250] [097/133] (566s left) kms_big_fb (x-tiled-addfb)
[454.730974] Starting subtest: x-tiled-addfb
[454.733373] Subtest x-tiled-addfb: SUCCESS (0.000s)
[454.832280] [098/133] (566s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[454.932362] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[454.936422] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[455.009171] [099/133] (566s left) kms_plane_scaling (planes-upscale-factor-0-25)
[455.108049] Starting subtest: planes-upscale-factor-0-25
[455.110342] Starting dynamic subtest: pipe-A
[455.167958] Dynamic subtest pipe-A: SUCCESS (0.062s)
[455.177774] Starting dynamic subtest: pipe-B
[456.264344] Dynamic subtest pipe-B: SUCCESS (1.095s)
[456.276144] Starting dynamic subtest: pipe-C
[457.376290] Dynamic subtest pipe-C: SUCCESS (1.111s)
[457.387984] Starting dynamic subtest: pipe-D
[458.520885] Dynamic subtest pipe-D: SUCCESS (1.144s)
[458.523004] Subtest planes-upscale-factor-0-25: SUCCESS (3.415s)
[459.661927] [100/133] (562s left) gem_exec_reloc (basic-cpu-gtt-active)
[459.719230] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[459.780627] [101/133] (562s left) kms_frontbuffer_tracking (fbc-tiling-4)
[459.888824] Starting subtest: fbc-tiling-4
[464.103220] Subtest fbc-tiling-4: SUCCESS (4.218s)
[465.269276] [102/133] (556s left) gem_softpin (zero)
[465.326986] Starting subtest: zero
[465.334017] Subtest zero: SUCCESS (0.005s)
[465.447559] [103/133] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[465.538140] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[465.542529] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[465.634318] [104/133] (556s left) perf (i915-ref-count)
[465.691768] Starting subtest: i915-ref-count
[465.730833] Subtest i915-ref-count: SUCCESS (0.036s)
[465.788970] [105/133] (556s left) prime_busy (after)
[465.837611] Starting subtest: after
[465.843013] Starting dynamic subtest: rcs0
[465.881474] Dynamic subtest rcs0: SUCCESS (0.041s)
[465.892373] Starting dynamic subtest: bcs0
[465.935839] Dynamic subtest bcs0: SUCCESS (0.054s)
[465.945512] Starting dynamic subtest: vcs0
[465.979131] Dynamic subtest vcs0: SUCCESS (0.041s)
[465.988703] Starting dynamic subtest: vcs1
[466.021703] Dynamic subtest vcs1: SUCCESS (0.041s)
[466.031087] Starting dynamic subtest: vecs0
[466.062473] Dynamic subtest vecs0: SUCCESS (0.040s)
[466.072335] Starting dynamic subtest: ccs0
[466.103539] Dynamic subtest ccs0: SUCCESS (0.040s)
[466.212491] Subtest after: SUCCESS (0.373s)
[466.309546] [106/133] (555s left) gem_exec_reloc (basic-write-cpu-active)
[466.376984] Subtest basic-write-cpu-active: SKIP (0.000s)
[466.463658] [107/133] (555s left) kms_plane (pixel-format-4-tiled-modifier)
[466.549034] Starting subtest: pixel-format-4-tiled-modifier
[466.575111] Starting dynamic subtest: pipe-A-plane-0
[467.219014] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s)
[467.227932] Starting dynamic subtest: pipe-A-plane-3
[467.685205] Dynamic subtest pipe-A-plane-3: SUCCESS (0.464s)
[467.696281] Starting dynamic subtest: pipe-A-plane-5
[467.699877] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[468.743237] Starting dynamic subtest: pipe-B-plane-0
[469.402121] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[469.414081] Starting dynamic subtest: pipe-B-plane-3
[469.823435] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[469.832111] Starting dynamic subtest: pipe-B-plane-5
[469.835425] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[470.136476] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.587s)
[471.025025] [108/133] (551s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[471.138679] Starting subtest: cursor-vs-flip-toggle
[502.077553] Subtest cursor-vs-flip-toggle: SUCCESS (30.944s)
[502.951924] [109/133] (519s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[503.053550] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[503.055547] Starting dynamic subtest: pipe-A-eDP-1
[503.940308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.882s)
[503.956116] Starting dynamic subtest: pipe-B-eDP-1
[505.607537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.662s)
[505.618291] Starting dynamic subtest: pipe-C-eDP-1
[507.114473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[507.124087] Starting dynamic subtest: pipe-D-eDP-1
[508.648850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[508.651220] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.590s)
[509.878178] [110/133] (512s left) kms_dsc (dsc-with-output-formats)
[509.971427] Starting subtest: dsc-with-output-formats
[509.992576] Subtest dsc-with-output-formats: SKIP (0.000s)
[510.044167] [111/133] (512s left) api_intel_bb (crc32)
[510.097341] Starting subtest: crc32
[510.099398] Starting dynamic subtest: rcs0-smem0
[510.391260] Dynamic subtest rcs0-smem0: SUCCESS (0.293s)
[510.403794] Starting dynamic subtest: bcs0-smem0
[510.715683] Dynamic subtest bcs0-smem0: SUCCESS (0.321s)
[510.727863] Starting dynamic subtest: vcs0-smem0
[511.027277] Dynamic subtest vcs0-smem0: SUCCESS (0.310s)
[511.038496] Starting dynamic subtest: vcs1-smem0
[511.447821] Dynamic subtest vcs1-smem0: SUCCESS (0.416s)
[511.460386] Starting dynamic subtest: vecs0-smem0
[511.749899] Dynamic subtest vecs0-smem0: SUCCESS (0.299s)
[511.761791] Starting dynamic subtest: ccs0-smem0
[512.068915] Dynamic subtest ccs0-smem0: SUCCESS (0.316s)
[512.071799] Subtest crc32: SUCCESS (1.973s)
[512.211455] [112/133] (510s left) gem_exec_store (basic)
[512.272270] Starting subtest: basic
[512.373316] Subtest basic: SUCCESS (0.101s)
[512.560375] [113/133] (509s left) kms_plane_multiple (2x-tiling-none)
[512.669547] Starting subtest: 2x-tiling-none
[512.673872] Subtest 2x-tiling-none: SKIP (0.000s)
[512.742581] [114/133] (509s left) syncobj_timeline (invalid-signal-bad-pad)
[512.802776] Starting subtest: invalid-signal-bad-pad
[512.805015] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[512.903667] [115/133] (509s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[513.000516] Starting subtest: primary-4-tiled-reflect-x-0
[520.143901] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.144s)
[521.335941] [116/133] (501s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[521.440287] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[521.442413] Starting dynamic subtest: A-eDP1
[530.382926] Dynamic subtest A-eDP1: SUCCESS (8.940s)
[530.395619] Starting dynamic subtest: B-eDP1
[539.310015] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[539.323175] Starting dynamic subtest: C-eDP1
[548.233886] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[548.245916] Starting dynamic subtest: D-eDP1
[557.160252] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[557.165859] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.719s)
[558.391692] [117/133] (464s left) core_getversion (all-cards)
[558.430807] Starting subtest: all-cards
[558.438874] Subtest all-cards: SUCCESS (0.012s)
[558.494237] [118/133] (464s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[558.602935] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[558.607131] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[558.697629] [119/133] (463s left) gem_shrink (reclaim)
[558.753381] Starting subtest: reclaim
[561.249967] Subtest reclaim: SUCCESS (2.492s)
[561.376114] [120/133] (461s left) kms_psr (fbc-pr-primary-mmap-gtt)
[561.472550] Starting subtest: fbc-pr-primary-mmap-gtt
[561.476838] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[561.551826] [121/133] (461s left) gem_pwrite (basic-random)
[561.603319] Subtest basic-random: SKIP (0.000s)
[561.661074] [122/133] (461s left) kms_mmap_write_crc (main)
[561.757870] Starting subtest: main
[561.760019] Starting dynamic subtest: pipe-A-eDP-1
[565.295453] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.534s)
[565.297650] Subtest main: SUCCESS (3.536s)
[566.123643] [123/133] (456s left) gem_exec_balancer (waits)
[566.184043] Starting subtest: waits
[572.683039] Subtest waits: SUCCESS (6.495s)
[572.992023] [124/133] (449s left) kms_cursor_edge_walk (64x64-right-edge)
[573.091517] Starting subtest: 64x64-right-edge
[573.093694] Starting dynamic subtest: pipe-A-eDP-1
[576.574224] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[576.583788] Starting dynamic subtest: pipe-D-eDP-1
[579.735553] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.162s)
[579.737856] Subtest 64x64-right-edge: SUCCESS (6.646s)
[580.539175] [125/133] (442s left) i915_pm_rps (thresholds-idle-park)
[580.604378] Starting subtest: thresholds-idle-park
[580.608646] Subtest thresholds-idle-park: SKIP (0.001s)
[580.711834] [126/133] (442s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[580.831007] Starting subtest: 2x-cursor-vs-flip-legacy
[580.835330] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[581.007148] [127/133] (441s left) gem_busy (semaphore)
[581.199687] Subtest semaphore: SKIP (0.000s)
[581.421463] [128/133] (441s left) kms_big_fb (4-tiled-addfb)
[581.535066] Starting subtest: 4-tiled-addfb
[581.537299] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[581.631914] [129/133] (441s left) kms_flip (dpms-off-confusion-interruptible)
[581.718468] Starting subtest: dpms-off-confusion-interruptible
[581.720688] Starting dynamic subtest: A-eDP1
[590.347646] Dynamic subtest A-eDP1: SUCCESS (8.626s)
[590.361807] Starting dynamic subtest: B-eDP1
[598.974793] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[598.988582] Starting dynamic subtest: C-eDP1
[607.599392] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[607.608962] Starting dynamic subtest: D-eDP1
[616.230449] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[616.235839] Subtest dpms-off-confusion-interruptible: SUCCESS (34.509s)
[617.414804] [130/133] (405s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[617.513587] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[617.518283] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[617.621630] [131/133] (405s left) syncobj_timeline (reset-multiple-signaled)
[617.679494] Starting subtest: reset-multiple-signaled
[617.682074] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[617.793016] [132/133] (405s left) kms_content_protection (dp-mst-type-0)
[617.938178] Starting subtest: dp-mst-type-0
[617.942967] Subtest dp-mst-type-0: SKIP (0.000s)
[618.084136] [133/133] (405s left) kms_selftest (drm_framebuffer)
[618.128576] Starting subtest: drm_framebuffer
[618.179421] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[618.295118] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.115s)
[618.306008] Starting dynamic subtest: drm_test_framebuffer_cleanup
[618.404435] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.111s)
[618.415941] Starting dynamic subtest: drm_test_framebuffer_create
[618.601919] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.195s)
[618.612469] Starting dynamic subtest: drm_test_framebuffer_free
[618.798362] Dynamic subtest drm_test_framebuffer_free: FAIL (0.155s)
[618.802233] Subtest drm_framebuffer: FAIL (0.631s)
[618.898433] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[618.915877] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[618.916735] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: kms_chamelium_edid
results: parsing output: 5/ for test: gem_tiled_fence_blits
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: sysfs_heartbeat_interval
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_ctx_engines
results: parsing output: 11/ for test: kms_addfb_basic
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_atomic
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: gen3_render_tiledy_blits
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: gem_exec_flush
results: parsing output: 30/ for test: gem_exec_async
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: kms_chamelium_color
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: core_auth
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_properties
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_invalid_mode
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_prop_blob
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: i915_hangman
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gem_exec_fence
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: gem_ringfill
results: parsing output: 83/ for test: kms_dirtyfb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_mmap_wc
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: prime_busy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_dsc
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_exec_store
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: core_getversion
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_shrink
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_pwrite
results: parsing output: 121/ for test: kms_mmap_write_crc
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: gem_busy
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_content_protection
results: parsing output: 132/ for test: kms_selftest
Done.