[43.757296] Initializing watchdogs
[43.757362]   /dev/watchdog0
[43.772415] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[43.777822] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.780195] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.781989] [001/134] (960s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc_dec)
[43.924131] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc_dec: SKIP (0.000s)
[43.992876] [002/134] (960s left) gem_exec_reloc (basic-gtt-read-active)
[44.031999] Starting subtest: basic-gtt-read-active
[44.165448] Subtest basic-gtt-read-active: SUCCESS (0.124s)
[44.285073] [003/134] (960s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[44.318181] Starting subtest: etime-single-wait-available-unsubmitted
[44.421697] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[44.502577] [004/134] (959s left) gem_softpin (evict-prime)
[44.537965] Starting subtest: evict-prime
[44.538746] Starting dynamic subtest: rcs0
[45.664971] Dynamic subtest rcs0: SUCCESS (1.126s)
[45.680049] Starting dynamic subtest: bcs0
[46.796980] Dynamic subtest bcs0: SUCCESS (1.131s)
[46.812771] Starting dynamic subtest: vcs0
[47.935834] Dynamic subtest vcs0: SUCCESS (1.124s)
[47.953013] Starting dynamic subtest: vcs1
[49.074972] Dynamic subtest vcs1: SUCCESS (1.124s)
[49.088847] Starting dynamic subtest: vecs0
[50.226948] Dynamic subtest vecs0: SUCCESS (1.139s)
[50.244428] Starting dynamic subtest: all
[51.355745] Dynamic subtest all: SUCCESS (1.118s)
[51.356955] Subtest evict-prime: SUCCESS (6.766s)
[51.459327] [005/134] (952s left) i915_drm_fdinfo (busy-hang)
[51.496492] Starting subtest: busy-hang
[51.497249] Starting dynamic subtest: rcs0
[52.535849] Dynamic subtest rcs0: SUCCESS (1.031s)
[52.544050] Starting dynamic subtest: bcs0
[53.569550] Dynamic subtest bcs0: SUCCESS (1.026s)
[53.577341] Starting dynamic subtest: vcs0
[54.607628] Dynamic subtest vcs0: SUCCESS (1.031s)
[54.615798] Starting dynamic subtest: vcs1
[55.646517] Dynamic subtest vcs1: SUCCESS (1.032s)
[55.653483] Starting dynamic subtest: vecs0
[56.677441] Dynamic subtest vecs0: SUCCESS (1.027s)
[56.678554] Subtest busy-hang: SUCCESS (5.149s)
[56.737243] [006/134] (947s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[56.769388] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[56.808860] [007/134] (947s left) kms_flip (plain-flip-fb-recreate-interruptible)
[56.898454] Starting subtest: plain-flip-fb-recreate-interruptible
[56.901206] Starting dynamic subtest: A-HDMI-A1
[64.744532] Dynamic subtest A-HDMI-A1: SUCCESS (7.823s)
[64.758257] Starting dynamic subtest: B-HDMI-A1
[72.532984] Dynamic subtest B-HDMI-A1: SUCCESS (7.780s)
[72.545183] Starting dynamic subtest: C-HDMI-A1
[80.307660] Dynamic subtest C-HDMI-A1: SUCCESS (7.771s)
[80.319505] Starting dynamic subtest: D-HDMI-A1
[88.095654] Dynamic subtest D-HDMI-A1: SUCCESS (7.786s)
[88.100116] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.170s)
[88.256297] [008/134] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[88.347710] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[89.848657] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (1.501s)
[90.001730] [009/134] (914s left) kms_flip (2x-modeset-vs-vblank-race)
[90.087162] Starting subtest: 2x-modeset-vs-vblank-race
[90.096517] Subtest 2x-modeset-vs-vblank-race: SKIP (0.009s)
[90.181921] [010/134] (914s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[90.265435] Starting subtest: plane-all-modeset-transition-internal-panels
[90.266838] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[90.349717] [011/134] (914s left) kms_lease (lessee-list)
[90.435792] Starting subtest: lessee-list
[90.436545] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.437286] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[90.443973] Starting dynamic subtest: pipe-B-HDMI-A-1
[90.444744] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[90.450456] Starting dynamic subtest: pipe-C-HDMI-A-1
[90.451174] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[90.457197] Starting dynamic subtest: pipe-D-HDMI-A-1
[90.457898] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[90.458558] Subtest lessee-list: SUCCESS (0.007s)
[90.512058] [012/134] (914s left) kms_flip (2x-plain-flip)
[90.595280] Starting subtest: 2x-plain-flip
[90.604336] Subtest 2x-plain-flip: SKIP (0.009s)
[90.690532] [013/134] (914s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[92.086701] Starting subtest: dpms-mode-unset-lpsp
[95.673993] Subtest dpms-mode-unset-lpsp: SUCCESS (3.587s)
[95.855523] [014/134] (908s left) kms_psr (fbc-psr2-sprite-plane-move)
[95.960585] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[95.987430] [015/134] (908s left) kms_rotation_crc (sprite-rotation-90)
[96.069780] Starting subtest: sprite-rotation-90
[99.330569] Subtest sprite-rotation-90: SUCCESS (3.260s)
[99.553973] [016/134] (905s left) kms_addfb_basic (unused-pitches)
[99.587893] Starting subtest: unused-pitches
[99.588625] Subtest unused-pitches: SUCCESS (0.000s)
[99.740858] [017/134] (905s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[99.827497] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[99.829099] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.846224] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[99.852009] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.870439] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[99.876286] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.893989] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[99.899696] Starting dynamic subtest: pipe-D-HDMI-A-1
[99.917683] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.003s)
[99.919084] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.021s)
[100.091325] [018/134] (904s left) kms_plane_scaling (planes-upscale-factor-0-25)
[100.174782] Starting subtest: planes-upscale-factor-0-25
[100.175529] Starting dynamic subtest: pipe-A
[100.236880] Dynamic subtest pipe-A: SUCCESS (0.062s)
[100.242714] Starting dynamic subtest: pipe-B
[100.387482] Dynamic subtest pipe-B: SUCCESS (0.150s)
[100.394800] Starting dynamic subtest: pipe-C
[100.522204] Dynamic subtest pipe-C: SUCCESS (0.134s)
[100.530018] Starting dynamic subtest: pipe-D
[100.655140] Dynamic subtest pipe-D: SUCCESS (0.132s)
[100.656090] Subtest planes-upscale-factor-0-25: SUCCESS (0.481s)
[100.858908] [019/134] (904s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[100.941675] Starting subtest: plane-downscale-factor-0-5-with-rotation
[100.942361] Starting dynamic subtest: pipe-A
[102.048142] Dynamic subtest pipe-A: SKIP (1.105s)
[102.054017] Starting dynamic subtest: pipe-B
[103.178026] Dynamic subtest pipe-B: SKIP (1.129s)
[103.186428] Starting dynamic subtest: pipe-C
[104.289726] Dynamic subtest pipe-C: SKIP (1.111s)
[104.295702] Starting dynamic subtest: pipe-D
[105.440965] Dynamic subtest pipe-D: SKIP (1.150s)
[105.442340] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (4.498s)
[105.625541] [020/134] (899s left) gem_exec_balancer (bonded-chain)
[105.676077] Starting subtest: bonded-chain
[112.963369] Subtest bonded-chain: SUCCESS (7.278s)
[113.150647] [021/134] (891s left) gem_exec_create (forked)
[113.193270] Starting subtest: forked
[113.194077] Starting dynamic subtest: smem
[133.307446] Dynamic subtest smem: SUCCESS (20.113s)
[133.308238] Subtest forked: SUCCESS (20.114s)
[133.510804] [022/134] (871s left) perf_pmu (module-unload)
[133.554875] Starting subtest: module-unload
[136.528285] Subtest module-unload: FAIL (2.939s)
[136.548050] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[136.549642] [023/134] (868s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[137.537372] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[137.646750] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.110s)
[137.688396] [FACT syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)] new: kernel.kmod_is_loaded.i915: true
[137.690715] [024/134] (867s left) core_setmaster (master-drop-set-root)
[137.757199] Starting subtest: master-drop-set-root
[137.763052] Subtest master-drop-set-root: SUCCESS (0.006s)
[137.802200] [025/134] (867s left) gen9_exec_parse (batch-without-end)
[137.840549] Subtest batch-without-end: SKIP (0.000s)
[137.883161] [026/134] (867s left) gem_lmem_swapping (parallel-random-verify-ccs)
[137.919355] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[137.957198] [027/134] (867s left) prime_mmap (test_forked)
[137.988278] Starting subtest: test_forked
[137.989066] Starting dynamic subtest: test_forked-smem
[137.999679] Dynamic subtest test_forked-smem: SUCCESS (0.011s)
[138.000430] Subtest test_forked: SUCCESS (0.012s)
[138.101191] [028/134] (867s left) kms_prop_blob (basic)
[138.132728] Starting subtest: basic
[138.133419] Subtest basic: SUCCESS (0.000s)
[138.204685] [029/134] (867s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[138.244149] Starting subtest: y-tiled-to-vebox-yf-tiled
[138.244872] Starting dynamic subtest: smem
[138.317111] Dynamic subtest smem: SUCCESS (0.072s)
[138.317878] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.073s)
[138.511155] [030/134] (866s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[138.604075] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[138.605457] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[138.699118] [031/134] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[138.788089] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[138.789491] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[138.900607] [032/134] (866s left) gem_ctx_isolation (dirty-create)
[138.940120] Starting subtest: dirty-create
[138.940935] Starting dynamic subtest: rcs0
[139.126988] Dynamic subtest rcs0: SUCCESS (0.178s)
[139.132885] Starting dynamic subtest: bcs0
[139.357859] Dynamic subtest bcs0: SUCCESS (0.229s)
[139.363805] Starting dynamic subtest: vcs0
[139.580718] Dynamic subtest vcs0: SUCCESS (0.222s)
[139.587022] Starting dynamic subtest: vcs1
[139.798028] Dynamic subtest vcs1: SUCCESS (0.216s)
[139.804275] Starting dynamic subtest: vecs0
[140.029224] Dynamic subtest vecs0: SUCCESS (0.231s)
[140.029999] Subtest dirty-create: SUCCESS (1.081s)
[140.213104] [033/134] (865s left) gem_ctx_persistence (hostile)
[140.250208] Starting subtest: hostile
[150.879960] Subtest hostile: SUCCESS (10.622s)
[150.985897] [034/134] (854s left) gem_pxp (protected-raw-src-copy-not-readible)
[151.088787] Starting subtest: protected-raw-src-copy-not-readible
[151.134613] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.048s)
[151.284720] [035/134] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[151.374829] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[153.030842] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.656s)
[153.186707] [036/134] (852s left) kms_atomic (plane-invalid-params-fence)
[153.274080] Starting subtest: plane-invalid-params-fence
[153.275976] Starting dynamic subtest: pipe-A-HDMI-A-1
[153.396265] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.120s)
[153.397062] Subtest plane-invalid-params-fence: SUCCESS (0.122s)
[153.529464] [037/134] (852s left) kms_colorop (plane-xr24-xr24-ctm_3x4_overdrive)
[153.667708] Subtest plane-XR24-XR24-ctm_3x4_overdrive: SKIP (0.000s)
[153.750519] [038/134] (851s left) prime_self_import (basic-llseek-size)
[153.780814] Starting subtest: basic-llseek-size
[153.783420] Subtest basic-llseek-size: SUCCESS (0.003s)
[153.895404] [039/134] (851s left) gem_exec_schedule (submit-early-slice)
[153.939923] Starting subtest: submit-early-slice
[153.940627] Starting dynamic subtest: rcs0
[153.968167] Dynamic subtest rcs0: SUCCESS (0.029s)
[153.976192] Starting dynamic subtest: bcs0
[153.994869] Dynamic subtest bcs0: SUCCESS (0.026s)
[154.002907] Starting dynamic subtest: vcs0
[154.020716] Dynamic subtest vcs0: SUCCESS (0.025s)
[154.029317] Starting dynamic subtest: vcs1
[154.049724] Dynamic subtest vcs1: SUCCESS (0.028s)
[154.058284] Starting dynamic subtest: vecs0
[154.076121] Dynamic subtest vecs0: SUCCESS (0.025s)
[154.076885] Subtest submit-early-slice: SUCCESS (0.138s)
[154.378694] [040/134] (851s left) kms_psr (pr-suspend)
[154.462881] Subtest pr-suspend: SKIP (0.000s)
[154.500196] [041/134] (851s left) kms_flip (2x-flip-vs-fences-interruptible)
[154.587936] Starting subtest: 2x-flip-vs-fences-interruptible
[154.597713] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.009s)
[154.656591] [042/134] (851s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[154.745081] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[155.867192] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.123s)
[156.001210] [043/134] (849s left) gem_lmem_swapping (heavy-verify-random-ccs)
[156.037752] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[156.075095] [044/134] (849s left) kms_universal_plane (cursor-fb-leak)
[156.161015] Starting subtest: cursor-fb-leak
[156.162882] Starting dynamic subtest: pipe-A-HDMI-A-1
[156.357698] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.195s)
[156.371200] Starting dynamic subtest: pipe-B-HDMI-A-1
[156.639954] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.278s)
[156.649991] Starting dynamic subtest: pipe-C-HDMI-A-1
[156.923313] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.259s)
[156.929586] Starting dynamic subtest: pipe-D-HDMI-A-1
[157.162388] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.256s)
[157.163520] Subtest cursor-fb-leak: SUCCESS (1.003s)
[157.361172] [045/134] (848s left) vgem_basic (unload)
[157.393043] Starting subtest: unload
[186.399363] Subtest unload: SUCCESS (28.976s)
[186.480785] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[186.482629] [046/134] (819s left) gem_exec_await (wide-contexts)
[186.552978] Starting subtest: wide-contexts
[208.581494] Subtest wide-contexts: SUCCESS (22.031s)
[208.794683] [047/134] (797s left) gem_exec_fence (syncobj-signal)
[209.172111] Starting subtest: syncobj-signal
[209.173165] Subtest syncobj-signal: SUCCESS (0.002s)
[209.475223] [048/134] (796s left) dumb_buffer (map-uaf)
[209.507673] Starting subtest: map-uaf
[209.512198] Subtest map-uaf: SUCCESS (0.005s)
[209.621297] [049/134] (796s left) gem_mmap_wc (fault-concurrent)
[209.654074] Starting subtest: fault-concurrent
[209.730646] Subtest fault-concurrent: SUCCESS (0.077s)
[209.819559] [050/134] (796s left) gem_exec_schedule (preempt-contexts)
[209.873403] Starting subtest: preempt-contexts
[209.874129] Starting dynamic subtest: rcs0
[209.911612] Dynamic subtest rcs0: SUCCESS (0.038s)
[209.920767] Starting dynamic subtest: bcs0
[209.952644] Dynamic subtest bcs0: SUCCESS (0.040s)
[209.962071] Starting dynamic subtest: vcs0
[209.993794] Dynamic subtest vcs0: SUCCESS (0.040s)
[210.001468] Starting dynamic subtest: vcs1
[210.034400] Dynamic subtest vcs1: SUCCESS (0.039s)
[210.043378] Starting dynamic subtest: vecs0
[210.076586] Dynamic subtest vecs0: SUCCESS (0.041s)
[210.077402] Subtest preempt-contexts: SUCCESS (0.204s)
[210.381652] [051/134] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[210.477391] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[210.478853] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[210.599408] [052/134] (795s left) gem_mmap_offset (pf-nonblock)
[210.631858] Starting subtest: pf-nonblock
[210.635400] Subtest pf-nonblock: SUCCESS (0.004s)
[210.755137] [053/134] (795s left) gem_exec_params (invalid-bsd2-flag-on-render)
[210.790373] Starting subtest: invalid-bsd2-flag-on-render
[210.791110] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[210.889515] [054/134] (795s left) kms_hdr (bpc-switch-dpms)
[210.973450] Starting subtest: bpc-switch-dpms
[210.975542] Subtest bpc-switch-dpms: SKIP (0.001s)
[211.061875] [055/134] (795s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[211.151130] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[211.187914] [056/134] (795s left) kms_psr (psr-sprite-plane-onoff)
[211.271786] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[211.313206] [057/134] (795s left) api_intel_allocator (reopen)
[211.345815] Starting subtest: reopen
[211.348297] Subtest reopen: SUCCESS (0.002s)
[211.489485] [058/134] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[211.578438] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[211.579901] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[211.687713] [059/134] (794s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[211.772573] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[211.773339] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.780565] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[211.789652] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.796899] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[211.803980] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.810680] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[211.817662] Starting dynamic subtest: pipe-D-HDMI-A-1
[211.824467] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[211.825805] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[212.059953] [060/134] (794s left) perf_pmu (busy-no-semaphores)
[212.095550] Starting subtest: busy-no-semaphores
[212.096303] Starting dynamic subtest: rcs0
[212.648453] Dynamic subtest rcs0: SUCCESS (0.543s)
[212.658810] Starting dynamic subtest: bcs0
[213.171512] Dynamic subtest bcs0: SUCCESS (0.521s)
[213.182968] Starting dynamic subtest: vcs0
[213.695352] Dynamic subtest vcs0: SUCCESS (0.522s)
[213.707305] Starting dynamic subtest: vcs1
[214.217961] Dynamic subtest vcs1: SUCCESS (0.521s)
[214.229009] Starting dynamic subtest: vecs0
[214.740445] Dynamic subtest vecs0: SUCCESS (0.520s)
[214.741422] Subtest busy-no-semaphores: SUCCESS (2.637s)
[214.819017] [061/134] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[214.909785] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[214.911176] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[215.031814] [062/134] (791s left) kms_invalid_mode (zero-vdisplay)
[215.116612] Starting subtest: zero-vdisplay
[215.118471] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.168574] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[215.179389] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.180166] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[215.187349] Starting dynamic subtest: pipe-C-HDMI-A-1
[215.188105] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[215.194934] Starting dynamic subtest: pipe-D-HDMI-A-1
[215.195686] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[215.196428] Subtest zero-vdisplay: SUCCESS (0.059s)
[215.314855] [063/134] (791s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[215.349226] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[215.453740] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[215.535673] [064/134] (791s left) kms_chamelium_frames (dp-crc-single)
[215.673923] Subtest dp-crc-single: SKIP (0.000s)
[215.767911] [065/134] (790s left) sysfs_timeslice_duration (invalid)
[215.807453] Starting subtest: invalid
[215.809336] Starting dynamic subtest: vecs0
[215.810091] Dynamic subtest vecs0: SUCCESS (0.001s)
[215.817298] Starting dynamic subtest: vcs0
[215.818015] Dynamic subtest vcs0: SUCCESS (0.001s)
[215.825106] Starting dynamic subtest: bcs0
[215.825808] Dynamic subtest bcs0: SUCCESS (0.001s)
[215.832701] Starting dynamic subtest: rcs0
[215.833400] Dynamic subtest rcs0: SUCCESS (0.001s)
[215.840082] Starting dynamic subtest: vcs1
[215.840790] Dynamic subtest vcs1: SUCCESS (0.001s)
[215.841474] Subtest invalid: SUCCESS (0.012s)
[215.923115] [066/134] (790s left) sw_sync (sync_merge_same)
[215.955118] Starting subtest: sync_merge_same
[215.955838] Subtest sync_merge_same: SUCCESS (0.000s)
[216.031217] [067/134] (790s left) kms_big_fb (4-tiled-addfb)
[216.126578] Starting subtest: 4-tiled-addfb
[216.128040] Subtest 4-tiled-addfb: SKIP (0.000s)
[216.239932] [068/134] (790s left) gem_mmap_offset (mmap-unmap)
[216.272423] Starting subtest: mmap-unmap
[216.273186] Starting dynamic subtest: smem0
[247.881669] Dynamic subtest smem0: SUCCESS (31.601s)
[247.882430] Subtest mmap-unmap: SUCCESS (31.603s)
[248.003940] [069/134] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[248.094449] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[248.095871] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.193809] [070/134] (758s left) gem_softpin (evict-active)
[248.232288] Starting subtest: evict-active
[248.237047] Subtest evict-active: SUCCESS (0.005s)
[248.387056] [071/134] (758s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[248.537154] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[248.631214] [072/134] (758s left) kms_pm_dc (dc6-psr)
[249.726177] Starting subtest: dc6-psr
[249.727564] Subtest dc6-psr: SKIP (0.000s)
[249.793577] [073/134] (757s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[249.879169] Starting subtest: basic-busy-flip-before-cursor-legacy
[249.880544] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[249.985601] [074/134] (757s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[250.071159] Starting subtest: short-flip-after-cursor-toggle
[250.596639] Subtest short-flip-after-cursor-toggle: SUCCESS (0.525s)
[250.748474] [075/134] (756s left) kms_cursor_crc (cursor-random-128x42)
[250.842041] Starting subtest: cursor-random-128x42
[250.847427] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.753751] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.906s)
[252.787988] Starting dynamic subtest: pipe-D-HDMI-A-1
[254.653572] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.872s)
[254.654263] Subtest cursor-random-128x42: SUCCESS (3.812s)
[254.785662] [076/134] (752s left) gem_exec_basic (basic)
[254.825645] Starting subtest: basic
[254.826359] Starting dynamic subtest: rcs0-smem
[254.827105] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[254.836275] Starting dynamic subtest: bcs0-smem
[254.836978] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[254.843986] Starting dynamic subtest: vcs0-smem
[254.844708] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[254.851553] Starting dynamic subtest: vcs1-smem
[254.852260] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[254.858835] Starting dynamic subtest: vecs0-smem
[254.859550] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[254.860232] Subtest basic: SUCCESS (0.007s)
[255.013590] [077/134] (752s left) gem_mmap_gtt (basic-read-write-distinct)
[255.047058] Starting subtest: basic-read-write-distinct
[255.049174] Subtest basic-read-write-distinct: SUCCESS (0.003s)
[255.148151] [078/134] (752s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[255.233463] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[255.234891] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[255.413763] [079/134] (751s left) gem_userptr_blits (mmap-offset-banned)
[255.460937] Starting subtest: mmap-offset-banned
[255.461657] Starting dynamic subtest: gtt
[255.462371] Dynamic subtest gtt: SUCCESS (0.000s)
[255.469832] Starting dynamic subtest: wb
[255.470535] Dynamic subtest wb: SUCCESS (0.001s)
[255.477911] Starting dynamic subtest: wc
[255.478610] Dynamic subtest wc: SUCCESS (0.000s)
[255.485454] Starting dynamic subtest: uc
[255.486130] Dynamic subtest uc: SUCCESS (0.000s)
[255.486794] Subtest mmap-offset-banned: SUCCESS (0.007s)
[255.599195] [080/134] (751s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[255.688339] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[255.689815] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[255.801818] [081/134] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[255.890487] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[255.891977] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[255.999067] [082/134] (751s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut-srgb_eotf_lut)
[256.138090] Subtest plane-XR24-XR24-srgb_inv_eotf_lut-srgb_eotf_lut: SKIP (0.000s)
[256.203834] [083/134] (751s left) gem_exec_alignment (forked)
[256.240601] Starting subtest: forked
[294.248816] Subtest forked: SUCCESS (38.000s)
[294.318776] [084/134] (713s left) gem_exec_reloc (basic-cpu-read)
[294.400965] Starting subtest: basic-cpu-read
[294.406504] Subtest basic-cpu-read: SUCCESS (0.006s)
[294.551877] [085/134] (712s left) perf (short-reads)
[294.662582] Starting subtest: short-reads
[294.681390] Subtest short-reads: SUCCESS (0.019s)
[294.723835] [086/134] (712s left) kms_busy (extended-modeset-hang-oldfb)
[294.815222] Starting subtest: extended-modeset-hang-oldfb
[294.817075] Starting dynamic subtest: pipe-A
[305.419911] Dynamic subtest pipe-A: SUCCESS (10.604s)
[305.430749] Starting dynamic subtest: pipe-D
[316.153034] Dynamic subtest pipe-D: SUCCESS (10.729s)
[316.153765] Subtest extended-modeset-hang-oldfb: SUCCESS (21.339s)
[316.288809] [087/134] (691s left) kms_cursor_legacy (forked-move)
[316.375997] Starting subtest: forked-move
[316.376698] Starting dynamic subtest: pipe-A
[321.836071] Dynamic subtest pipe-A: SUCCESS (5.424s)
[321.845929] Starting dynamic subtest: pipe-B
[327.233006] Dynamic subtest pipe-B: SUCCESS (5.422s)
[327.240720] Starting dynamic subtest: pipe-C
[332.682556] Dynamic subtest pipe-C: SUCCESS (5.423s)
[332.691047] Starting dynamic subtest: pipe-D
[338.117601] Dynamic subtest pipe-D: SUCCESS (5.433s)
[338.126706] Starting dynamic subtest: all-pipes
[343.556050] Dynamic subtest all-pipes: SUCCESS (5.436s)
[343.556979] Subtest forked-move: SUCCESS (27.147s)
[343.615872] [088/134] (664s left) gem_exec_fence (syncobj-timeline-unused-fence)
[344.069212] Starting subtest: syncobj-timeline-unused-fence
[344.070025] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[344.267857] [089/134] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[344.360042] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[345.591748] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.232s)
[345.731169] [090/134] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[345.821823] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[345.823299] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[345.922107] [091/134] (661s left) api_intel_bb (crc32)
[345.955982] Starting subtest: crc32
[345.957425] Subtest crc32: SKIP (0.000s)
[346.056597] [092/134] (661s left) gem_ctx_bad_destroy (double-destroy)
[346.088513] Starting subtest: double-destroy
[346.089237] Subtest double-destroy: SUCCESS (0.000s)
[346.171824] [093/134] (661s left) kms_psr (fbc-pr-cursor-plane-move)
[346.256766] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[346.297617] [094/134] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[346.385228] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[346.386708] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[346.516834] [095/134] (661s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[346.625527] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[346.924446] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.299s)
[347.107133] [096/134] (660s left) gem_ctx_engines (invalid-engines)
[347.149020] Starting subtest: invalid-engines
[347.154045] Subtest invalid-engines: SUCCESS (0.005s)
[347.358736] [097/134] (660s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[347.444105] Starting subtest: flip-vs-cursor-atomic-transitions
[354.025576] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (6.580s)
[354.165017] [098/134] (653s left) kms_writeback (writeback-invalid-parameters)
[354.252550] Subtest writeback-invalid-parameters: SKIP (0.000s)
[354.294475] [099/134] (653s left) gem_exec_flush (basic-batch-kernel-default-wb)
[354.334653] Starting subtest: basic-batch-kernel-default-wb
[359.929250] Subtest basic-batch-kernel-default-wb: SUCCESS (5.595s)
[360.149165] [100/134] (648s left) kms_dirtyfb (default-dirtyfb-ioctl)
[360.239438] Starting subtest: default-dirtyfb-ioctl
[360.241747] Starting dynamic subtest: A-HDMI-A-1
[361.446412] Dynamic subtest A-HDMI-A-1: SUCCESS (1.205s)
[361.447169] Subtest default-dirtyfb-ioctl: SUCCESS (1.207s)
[361.566620] [101/134] (646s left) syncobj_eventfd (invalid-bad-pad)
[361.602293] Starting subtest: invalid-bad-pad
[361.603064] Subtest invalid-bad-pad: SUCCESS (0.000s)
[361.692259] [102/134] (646s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[361.780205] Starting subtest: cursor-rapid-movement-64x64
[361.785043] Starting dynamic subtest: pipe-A-HDMI-A-1
[362.027629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.242s)
[362.063651] Starting dynamic subtest: pipe-D-HDMI-A-1
[362.261896] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.207s)
[362.262669] Subtest cursor-rapid-movement-64x64: SUCCESS (0.482s)
[362.430674] [103/134] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[362.517764] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[362.519272] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[362.624672] [104/134] (645s left) kms_psr (fbc-pr-no-drrs)
[362.709987] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[362.751515] [105/134] (645s left) gem_ctx_param (invalid-param-get)
[362.783245] Starting subtest: invalid-param-get
[362.784011] Subtest invalid-param-get: SUCCESS (0.000s)
[362.864963] [106/134] (645s left) kms_psr (pr-primary-blt)
[362.951274] Subtest pr-primary-blt: SKIP (0.000s)
[362.995377] [107/134] (645s left) syncobj_timeline (single-wait-all-available-submitted)
[363.029527] Starting subtest: single-wait-all-available-submitted
[363.030282] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[363.116434] [108/134] (645s left) gem_exec_store (dword)
[363.156926] Starting subtest: dword
[363.157746] Starting dynamic subtest: rcs0
[363.200112] Dynamic subtest rcs0: SUCCESS (0.042s)
[363.219531] Starting dynamic subtest: bcs0
[363.223102] Dynamic subtest bcs0: SUCCESS (0.021s)
[363.233987] Starting dynamic subtest: vcs0
[363.240872] Dynamic subtest vcs0: SUCCESS (0.016s)
[363.251166] Starting dynamic subtest: vcs1
[363.259993] Dynamic subtest vcs1: SUCCESS (0.018s)
[363.270209] Starting dynamic subtest: vecs0
[363.273886] Dynamic subtest vecs0: SUCCESS (0.013s)
[363.274739] Subtest dword: SUCCESS (0.118s)
[363.460099] [109/134] (645s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[363.555125] Starting subtest: yf-tiled-32bpp-rotate-0
[363.556542] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[363.661112] [110/134] (644s left) syncobj_timeline (invalid-wait-illegal-handle)
[363.694329] Starting subtest: invalid-wait-illegal-handle
[363.695048] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[363.784167] [111/134] (644s left) gem_fence_thrash (bo-write-verify-y)
[363.815468] Starting subtest: bo-write-verify-y
[364.958939] Subtest bo-write-verify-y: SUCCESS (1.136s)
[365.042800] [112/134] (643s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[365.131122] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[365.140160] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[365.231760] [113/134] (643s left) i915_getparams_basic (basic-subslice-total)
[365.265036] Starting subtest: basic-subslice-total
[365.266468] Subtest basic-subslice-total: SUCCESS (0.000s)
[365.340258] [114/134] (643s left) kms_vblank (wait-forked-hang)
[365.426979] Starting subtest: wait-forked-hang
[365.427741] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.547550] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.120s)
[379.560425] Starting dynamic subtest: pipe-D-HDMI-A-1
[393.857542] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.305s)
[393.858301] Subtest wait-forked-hang: SUCCESS (28.431s)
[394.035271] [115/134] (614s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[394.122999] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[394.123739] Starting dynamic subtest: pipe-A-HDMI-A-1
[394.130484] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[394.138198] Starting dynamic subtest: pipe-B-HDMI-A-1
[394.144956] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[394.152590] Starting dynamic subtest: pipe-C-HDMI-A-1
[394.159306] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[394.166720] Starting dynamic subtest: pipe-D-HDMI-A-1
[394.173520] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[394.174856] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.007s)
[394.378132] [116/134] (614s left) syncobj_timeline (wait-any-complex)
[394.411942] Starting subtest: wait-any-complex
[394.473928] Subtest wait-any-complex: SUCCESS (0.062s)
[394.569687] [117/134] (614s left) gem_mmap_wc (write-cpu-read-wc)
[394.601593] Starting subtest: write-cpu-read-wc
[394.679020] Subtest write-cpu-read-wc: SUCCESS (0.077s)
[394.776059] [118/134] (614s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[394.861270] Starting subtest: addfb25-yf-tiled-legacy
[394.862038] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[394.981295] [119/134] (614s left) kms_content_protection (dp-mst-lic-type-1)
[395.070591] Starting subtest: dp-mst-lic-type-1
[395.072075] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[395.184097] [120/134] (613s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[395.268617] Starting subtest: random-ccs-data-yf-tiled-ccs
[395.269362] Starting dynamic subtest: pipe-A-HDMI-A-1
[395.276957] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[395.286656] Starting dynamic subtest: pipe-B-HDMI-A-1
[395.294346] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[395.303872] Starting dynamic subtest: pipe-C-HDMI-A-1
[395.311445] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[395.320859] Starting dynamic subtest: pipe-D-HDMI-A-1
[395.328682] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[395.330259] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.007s)
[395.543418] [121/134] (613s left) kms_plane_alpha_blend (alpha-opaque-fb)
[395.628421] Starting subtest: alpha-opaque-fb
[395.694956] Starting dynamic subtest: pipe-A-HDMI-A-1
[395.972756] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.277s)
[395.983921] Starting dynamic subtest: pipe-D-HDMI-A-1
[396.306197] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.330s)
[396.306935] Subtest alpha-opaque-fb: SUCCESS (0.677s)
[396.457278] [122/134] (612s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[396.543303] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[396.544050] Starting dynamic subtest: pipe-A-valid-mode
[396.597914] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[396.599334] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.055s)
[396.713795] [123/134] (612s left) i915_pm_rpm (gem-pread)
[398.106376] Starting subtest: gem-pread
[399.496227] Subtest gem-pread: SUCCESS (1.389s)
[399.625789] [124/134] (609s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[399.718161] Starting subtest: x-tiled-64bpp-rotate-90
[399.764343] Subtest x-tiled-64bpp-rotate-90: SKIP (0.044s)
[399.906251] [125/134] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[399.994052] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[399.995489] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[400.098114] [126/134] (609s left) gem_eio (in-flight-1us)
[400.141091] Starting subtest: in-flight-1us
[402.483072] Subtest in-flight-1us: SUCCESS (2.341s)
[402.634651] [127/134] (606s left) gem_userptr_blits (create-destroy-unsync)
[402.673165] Subtest create-destroy-unsync: SKIP (0.000s)
[402.816764] [128/134] (606s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[402.910583] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[402.911991] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[403.015513] [129/134] (606s left) i915_suspend (basic-s3-without-i915)
[403.045769] Starting subtest: basic-s3-without-i915