[59.180366] Initializing watchdogs
[59.180419]   /dev/watchdog0
[59.195455] [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]
[59.199835] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.202040] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.205578] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[59.336304] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[63.816037] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.483s)
[64.962194] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[65.060133] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[72.542947] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.489s)
[72.682784] [003/133] (947s left) gem_mmap_wc (close)
[72.751190] Subtest close: SKIP (0.000s)
[72.818101] [004/133] (947s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[72.914911] Starting subtest: crc-primary-basic-y-tiled-ccs
[72.917192] Starting dynamic subtest: pipe-A-eDP-1
[72.939779] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.949388] Starting dynamic subtest: pipe-B-eDP-1
[72.970699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[72.977772] Starting dynamic subtest: pipe-C-eDP-1
[72.998449] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.008362] Starting dynamic subtest: pipe-D-eDP-1
[73.030131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.034297] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[75.205326] [005/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[75.327821] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[82.480422] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.154s)
[82.607308] [006/133] (937s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[82.712394] Starting subtest: disable-crc-after-crtc
[82.714890] Starting dynamic subtest: pipe-A-eDP-1
[84.411560] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.700s)
[84.420754] Starting dynamic subtest: pipe-B-eDP-1
[86.750244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.337s)
[86.759641] Starting dynamic subtest: pipe-C-eDP-1
[88.993614] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.243s)
[89.002943] Starting dynamic subtest: pipe-D-eDP-1
[91.255842] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.260s)
[91.258266] Subtest disable-crc-after-crtc: SUCCESS (8.544s)
[92.094994] [007/133] (927s left) kms_properties (get_properties-sanity-atomic)
[92.192129] Starting subtest: get_properties-sanity-atomic
[92.194472] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[92.262673] [008/133] (927s left) perf_pmu (busy-accuracy-2)
[92.307737] Starting subtest: busy-accuracy-2
[92.309904] Starting dynamic subtest: rcs0
[95.355426] Dynamic subtest rcs0: SUCCESS (3.044s)
[95.365445] Starting dynamic subtest: bcs0
[98.464215] Dynamic subtest bcs0: SUCCESS (3.056s)
[98.476679] Starting dynamic subtest: vcs0
[101.507501] Dynamic subtest vcs0: SUCCESS (3.045s)
[101.517225] Starting dynamic subtest: vcs1
[104.554455] Dynamic subtest vcs1: SUCCESS (3.045s)
[104.564373] Starting dynamic subtest: vecs0
[107.603634] Dynamic subtest vecs0: SUCCESS (3.048s)
[107.614163] Starting dynamic subtest: ccs0
[110.662719] Dynamic subtest ccs0: SUCCESS (3.058s)
[110.664934] Subtest busy-accuracy-2: SUCCESS (18.304s)
[110.727499] [009/133] (909s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[110.836829] Starting subtest: yf-tiled-64bpp-rotate-0
[110.840794] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[110.928700] [010/133] (909s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[111.026428] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[111.030910] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[111.110211] [011/133] (909s left) kms_pm_rpm (package-g7)
[113.090054] Starting subtest: package-g7
[113.095104] Subtest package-g7: SKIP (0.000s)
[113.460171] [012/133] (906s left) gem_ctx_sseu (invalid-args)
[113.520311] Subtest invalid-args: SKIP (0.000s)
[113.591395] [013/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[113.692358] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[113.696480] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[113.770741] [014/133] (906s left) drm_read (short-buffer-nonblock)
[113.914051] Starting subtest: short-buffer-nonblock
[113.916558] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[114.026196] [015/133] (906s left) syncobj_wait (single-wait-for-submit-submitted)
[114.077063] Starting subtest: single-wait-for-submit-submitted
[114.178561] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[114.253698] [016/133] (906s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[114.300697] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[114.303034] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[114.385108] [017/133] (905s left) gem_exec_schedule (submit-late-slice)
[114.462857] Starting subtest: submit-late-slice
[114.464994] Starting dynamic subtest: rcs0
[114.491474] Dynamic subtest rcs0: SUCCESS (0.035s)
[114.504921] Starting dynamic subtest: bcs0
[114.525742] Dynamic subtest bcs0: SUCCESS (0.034s)
[114.536845] Starting dynamic subtest: vcs0
[114.564943] Dynamic subtest vcs0: SUCCESS (0.039s)
[114.573379] Starting dynamic subtest: vcs1
[114.595955] Dynamic subtest vcs1: SUCCESS (0.030s)
[114.607880] Starting dynamic subtest: vecs0
[114.626036] Dynamic subtest vecs0: SUCCESS (0.029s)
[114.634826] Starting dynamic subtest: ccs0
[114.655683] Dynamic subtest ccs0: SUCCESS (0.029s)
[114.657901] Subtest submit-late-slice: SUCCESS (0.200s)
[116.032458] [018/133] (904s left) device_reset (cold-reset-bound)
[116.083231] Starting subtest: cold-reset-bound
[116.087679] Subtest cold-reset-bound: SKIP (0.000s)
[116.155969] [019/133] (904s left) gem_eio (in-flight-10ms)
[116.389362] Starting subtest: in-flight-10ms
[124.838192] Subtest in-flight-10ms: SUCCESS (8.450s)
[125.025315] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[125.028394] [020/133] (895s left) kms_addfb_basic (addfb25-4-tiled)
[125.122555] Starting subtest: addfb25-4-tiled
[125.124545] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[125.265211] [021/133] (895s left) kms_psr (pr-sprite-render)
[125.371204] Starting subtest: pr-sprite-render
[125.375448] Subtest pr-sprite-render: SKIP (0.000s)
[125.454949] [022/133] (895s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[125.542902] Starting subtest: fbc-psr-sprite-mmap-gtt
[125.545212] Starting dynamic subtest: eDP-1
[125.549487] Dynamic subtest eDP-1: SKIP (0.000s)
[125.553855] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[125.612237] [023/133] (895s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[125.707149] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[125.719523] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[125.825525] [024/133] (894s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[125.936739] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[130.127701] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.195s)
[131.264682] [025/133] (889s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[131.364028] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[131.366364] Starting dynamic subtest: pipe-A-eDP-1
[131.389333] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.400770] Starting dynamic subtest: pipe-B-eDP-1
[131.422060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.429762] Starting dynamic subtest: pipe-C-eDP-1
[131.450731] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.458709] Starting dynamic subtest: pipe-D-eDP-1
[131.480143] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.484296] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[133.534803] [026/133] (887s left) gem_partial_pwrite_pread (reads)
[133.603066] Subtest reads: SKIP (0.000s)
[133.676084] [027/133] (887s left) kms_content_protection (uevent)
[133.827137] Starting subtest: uevent
[133.831741] Subtest uevent: SKIP (0.000s)
[133.958879] [028/133] (886s left) kms_frontbuffer_tracking (psr-slowdraw)
[134.052470] Starting subtest: psr-slowdraw
[159.248512] Subtest psr-slowdraw: SUCCESS (25.196s)
[159.396753] [029/133] (861s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[159.527350] Starting subtest: cursorA-vs-flipA-atomic-transitions
[170.692308] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.162s)
[171.498473] [030/133] (849s left) gem_mmap_wc (coherency)
[171.571038] Subtest coherency: SKIP (0.000s)
[171.627600] [031/133] (849s left) kms_atomic_interruptible (legacy-cursor)
[171.720057] Starting subtest: legacy-cursor
[171.722342] Starting dynamic subtest: pipe-A-eDP-1
[179.099139] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.376s)
[179.101479] Subtest legacy-cursor: SUCCESS (7.378s)
[179.955654] [032/133] (841s left) kms_flip (2x-flip-vs-dpms)
[180.061585] Starting subtest: 2x-flip-vs-dpms
[180.072845] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[180.166899] [033/133] (840s left) gem_ctx_param (invalid-get-engines)
[180.219999] Starting subtest: invalid-get-engines
[180.222456] Subtest invalid-get-engines: SUCCESS (0.001s)
[180.346815] [034/133] (840s left) kms_atomic (test-only)
[180.441083] Starting subtest: test-only
[180.486406] Starting dynamic subtest: pipe-A-eDP-1
[183.053926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.564s)
[183.055908] Subtest test-only: SUCCESS (2.613s)
[183.867249] [035/133] (837s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[184.256187] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[185.054417] [036/133] (836s left) gem_ctx_persistence (saturated-hostile)
[185.118424] Starting subtest: saturated-hostile
[185.120426] Starting dynamic subtest: rcs0
[185.943285] Dynamic subtest rcs0: SUCCESS (0.827s)
[185.955187] Starting dynamic subtest: bcs0
[186.735330] Dynamic subtest bcs0: SUCCESS (0.789s)
[186.746790] Starting dynamic subtest: vcs0
[187.531080] Dynamic subtest vcs0: SUCCESS (0.794s)
[187.542068] Starting dynamic subtest: vcs1
[188.308984] Dynamic subtest vcs1: SUCCESS (0.776s)
[188.320468] Starting dynamic subtest: vecs0
[189.108444] Dynamic subtest vecs0: SUCCESS (0.797s)
[189.119995] Starting dynamic subtest: ccs0
[189.955757] Dynamic subtest ccs0: SUCCESS (0.845s)
[189.958832] Subtest saturated-hostile: SUCCESS (4.841s)
[190.095952] [037/133] (831s left) gem_userptr_blits (relocations)
[190.152014] Starting subtest: relocations
[190.156333] Subtest relocations: SKIP (0.000s)
[190.263010] [038/133] (831s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[190.388390] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[190.392792] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[190.532955] [039/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[190.629847] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[190.633986] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[190.727451] [040/133] (830s left) kms_color (ctm-blue-to-red)
[190.812740] Starting subtest: ctm-blue-to-red
[190.815125] Starting dynamic subtest: pipe-A-eDP-1
[191.559227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[191.570466] Starting dynamic subtest: pipe-B-eDP-1
[192.969414] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s)
[192.978638] Starting dynamic subtest: pipe-C-eDP-1
[194.357973] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[194.367329] Starting dynamic subtest: pipe-D-eDP-1
[195.688635] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[195.691046] Subtest ctm-blue-to-red: SUCCESS (4.876s)
[196.504505] [041/133] (824s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[196.558124] Starting subtest: multi-wait-for-submit-available-signaled
[196.560537] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[196.682305] [042/133] (824s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[196.780354] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[196.784669] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[197.925279] [043/133] (823s left) gem_fence_thrash (bo-write-verify-threaded-x)
[197.966872] Starting subtest: bo-write-verify-threaded-x
[197.999052] Subtest bo-write-verify-threaded-x: SKIP (0.029s)
[198.066234] [044/133] (823s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[198.166300] Starting subtest: plane-upscale-20x20-with-modifiers
[198.168515] Starting dynamic subtest: pipe-A
[198.501325] Dynamic subtest pipe-A: SUCCESS (0.338s)
[198.510748] Starting dynamic subtest: pipe-B
[199.915389] Dynamic subtest pipe-B: SUCCESS (1.413s)
[199.929789] Starting dynamic subtest: pipe-C
[201.346839] Dynamic subtest pipe-C: SUCCESS (1.431s)
[201.359956] Starting dynamic subtest: pipe-D
[202.771462] Dynamic subtest pipe-D: SUCCESS (1.424s)
[202.773803] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.609s)
[203.946828] [045/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[204.048221] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[204.052804] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[204.137681] [046/133] (817s left) gem_busy (semaphore)
[204.322092] Subtest semaphore: SKIP (0.000s)
[204.547325] [047/133] (817s left) kms_flip (flip-vs-dpms-on-nop)
[204.655206] Starting subtest: flip-vs-dpms-on-nop
[204.660736] Starting dynamic subtest: A-eDP1
[206.543975] Dynamic subtest A-eDP1: SUCCESS (1.885s)
[206.555544] Starting dynamic subtest: B-eDP1
[208.381584] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[208.398829] Starting dynamic subtest: C-eDP1
[210.206985] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[210.218843] Starting dynamic subtest: D-eDP1
[212.047817] Dynamic subtest D-eDP1: SUCCESS (1.837s)
[212.050341] Subtest flip-vs-dpms-on-nop: SUCCESS (7.395s)
[213.237216] [048/133] (808s left) gem_gpgpu_fill (offset-16x16)
[213.301307] Starting subtest: offset-16x16
[213.306407] Subtest offset-16x16: SUCCESS (0.007s)
[213.449540] [049/133] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[213.545692] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[213.550079] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.664463] [050/133] (808s left) api_intel_bb (crc32)
[213.727221] Starting subtest: crc32
[213.729387] Starting dynamic subtest: rcs0-smem0
[214.021881] Dynamic subtest rcs0-smem0: SUCCESS (0.293s)
[214.034592] Starting dynamic subtest: bcs0-smem0
[214.356494] Dynamic subtest bcs0-smem0: SUCCESS (0.332s)
[214.368439] Starting dynamic subtest: vcs0-smem0
[214.691866] Dynamic subtest vcs0-smem0: SUCCESS (0.333s)
[214.702109] Starting dynamic subtest: vcs1-smem0
[215.039790] Dynamic subtest vcs1-smem0: SUCCESS (0.344s)
[215.051932] Starting dynamic subtest: vecs0-smem0
[215.373382] Dynamic subtest vecs0-smem0: SUCCESS (0.331s)
[215.385057] Starting dynamic subtest: ccs0-smem0
[215.717359] Dynamic subtest ccs0-smem0: SUCCESS (0.341s)
[215.720034] Subtest crc32: SUCCESS (1.992s)
[215.828901] [051/133] (806s left) kms_cursor_crc (cursor-random-128x42)
[216.057773] Starting subtest: cursor-random-128x42
[216.108220] Subtest cursor-random-128x42: SKIP (0.043s)
[216.318617] [052/133] (805s left) kms_cursor_edge_walk (128x128-top-edge)
[216.412674] Starting subtest: 128x128-top-edge
[216.414830] Starting dynamic subtest: pipe-A-eDP-1
[219.890393] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[219.899781] Starting dynamic subtest: pipe-D-eDP-1
[223.017914] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[223.020222] Subtest 128x128-top-edge: SUCCESS (6.607s)
[223.826343] [053/133] (798s left) kms_lease (lease-again)
[223.937789] Starting subtest: lease-again
[223.940046] Starting dynamic subtest: pipe-A-eDP-1
[223.942337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[223.952557] Starting dynamic subtest: pipe-B-eDP-1
[223.954471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[223.962940] Starting dynamic subtest: pipe-C-eDP-1
[223.964790] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[223.973206] Starting dynamic subtest: pipe-D-eDP-1
[223.975025] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[223.976923] Subtest lease-again: SUCCESS (0.014s)
[224.080043] [054/133] (797s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[224.172114] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[224.174300] Starting dynamic subtest: pipe-A-eDP-1
[224.198770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.209401] Starting dynamic subtest: pipe-B-eDP-1
[224.233160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.241986] Starting dynamic subtest: pipe-C-eDP-1
[224.265293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.273447] Starting dynamic subtest: pipe-D-eDP-1
[224.298308] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.302849] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[226.418783] [055/133] (795s left) i915_drm_fdinfo (memory-info-idle)
[226.461567] Starting subtest: memory-info-idle
[226.463870] Starting dynamic subtest: smem0
[226.505102] Dynamic subtest smem0: SUCCESS (0.044s)
[226.507693] Subtest memory-info-idle: SUCCESS (0.045s)
[226.600530] [056/133] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[226.713487] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[226.717579] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[226.806077] [057/133] (795s left) gem_userptr_blits (create-destroy-sync)
[226.874452] Starting subtest: create-destroy-sync
[231.956150] Subtest create-destroy-sync: SUCCESS (5.020s)
[232.013269] [058/133] (790s left) kms_plane_lowres (tiling-4)
[232.114061] Starting subtest: tiling-4
[232.116310] Starting dynamic subtest: pipe-A-eDP-1
[232.120907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.412944] Starting dynamic subtest: pipe-B-eDP-1
[232.418162] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.432870] Starting dynamic subtest: pipe-C-eDP-1
[232.437721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.446153] Starting dynamic subtest: pipe-D-eDP-1
[232.450182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.454157] Subtest tiling-4: SKIP (0.296s)
[233.249963] [059/133] (788s left) gem_userptr_blits (stress-purge)
[233.325367] Starting subtest: stress-purge
[238.736327] Subtest stress-purge: SUCCESS (5.413s)
[238.893884] [060/133] (783s left) gem_close (many-handles-one-vma)
[238.992579] Starting subtest: many-handles-one-vma
[239.035908] Subtest many-handles-one-vma: SUCCESS (0.043s)
[239.122977] [061/133] (783s left) kms_psr (psr2-suspend)
[239.221204] Starting subtest: psr2-suspend
[239.223463] Starting dynamic subtest: eDP-1
[257.005592] Dynamic subtest eDP-1: SUCCESS (2.993s)
[257.007901] Subtest psr2-suspend: SUCCESS (2.994s)
[257.806052] [062/133] (764s left) kms_feature_discovery (display-3x)
[257.912041] Starting subtest: display-3x
[257.916074] Subtest display-3x: SKIP (0.000s)
[257.992754] [063/133] (764s left) gem_create (create-size-update)
[258.059376] Starting subtest: create-size-update
[258.061713] Subtest create-size-update: SUCCESS (0.000s)
[258.273735] [064/133] (764s left) gem_media_vme
[258.404551] [065/133] (764s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[258.465374] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[258.569177] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[258.663475] [066/133] (763s left) gem_pxp (create-regular-context-1)
[258.780688] Starting subtest: create-regular-context-1
[258.783391] Subtest create-regular-context-1: SUCCESS (0.002s)
[258.902881] [067/133] (763s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[259.028118] Starting subtest: 2x-cursor-vs-flip-legacy
[259.032481] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[259.175635] [068/133] (763s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[259.275841] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[259.279683] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[259.346852] [069/133] (763s left) i915_selftest (live)
[262.694458] Starting subtest: live
[262.697095] Starting dynamic subtest: sanitycheck
[267.110825] Dynamic subtest sanitycheck: SUCCESS (4.419s)
[267.121680] Starting dynamic subtest: uncore
[271.435340] Dynamic subtest uncore: SUCCESS (4.326s)
[271.445745] Starting dynamic subtest: workarounds
[274.538151] Dynamic subtest workarounds: SUCCESS (3.103s)
[274.548656] Starting dynamic subtest: gt_engines
[277.594202] Dynamic subtest gt_engines: SUCCESS (3.055s)
[277.604712] Starting dynamic subtest: gt_timelines
[292.661150] Dynamic subtest gt_timelines: SUCCESS (15.067s)
[292.672406] Starting dynamic subtest: gt_contexts
[297.054950] Dynamic subtest gt_contexts: SUCCESS (4.393s)
[297.065134] Starting dynamic subtest: gt_lrc
[301.397245] Dynamic subtest gt_lrc: SUCCESS (4.340s)
[301.407898] Starting dynamic subtest: gt_mocs
[304.338661] Dynamic subtest gt_mocs: SUCCESS (2.940s)
[304.349551] Starting dynamic subtest: gt_pm
[311.112670] Dynamic subtest gt_pm: SUCCESS (6.771s)
[311.128768] Starting dynamic subtest: gt_heartbeat
[315.460913] Dynamic subtest gt_heartbeat: SUCCESS (4.346s)
[315.470036] Starting dynamic subtest: gt_tlb
[325.311550] Dynamic subtest gt_tlb: SUCCESS (9.848s)
[325.321708] Starting dynamic subtest: requests
[337.313864] Dynamic subtest requests: SUCCESS (12.000s)
[337.324385] Starting dynamic subtest: migrate
[345.095143] Dynamic subtest migrate: SUCCESS (7.780s)
[345.105903] Starting dynamic subtest: active
[349.463678] Dynamic subtest active: SUCCESS (4.368s)
[349.479827] Starting dynamic subtest: objects
[354.141862] Dynamic subtest objects: SUCCESS (4.676s)
[354.155591] Starting dynamic subtest: mman
[358.976857] Dynamic subtest mman: SUCCESS (4.832s)
[358.986626] Starting dynamic subtest: dmabuf
[363.344800] Dynamic subtest dmabuf: SUCCESS (4.366s)
[363.355634] Starting dynamic subtest: vma
[367.711511] Dynamic subtest vma: SUCCESS (4.363s)
[367.722333] Starting dynamic subtest: coherency
[371.371711] Dynamic subtest coherency: SUCCESS (3.658s)
[371.390355] Starting dynamic subtest: gtt
[383.395799] Dynamic subtest gtt: SUCCESS (12.017s)
[383.406672] Starting dynamic subtest: gem
[391.428874] Dynamic subtest gem: SUCCESS (8.030s)
[391.439575] Starting dynamic subtest: evict
[396.873750] Dynamic subtest evict: SUCCESS (5.443s)
[396.885506] Starting dynamic subtest: hugepages
[408.233278] Dynamic subtest hugepages: SUCCESS (11.355s)
[408.243870] Starting dynamic subtest: gem_contexts
[435.895107] Dynamic subtest gem_contexts: SUCCESS (27.658s)
[435.905679] Starting dynamic subtest: client
[440.250059] Dynamic subtest client: SUCCESS (4.354s)
[440.259327] Starting dynamic subtest: gem_migrate
[444.822905] Dynamic subtest gem_migrate: SUCCESS (4.571s)
[444.834085] Starting dynamic subtest: reset
[447.534429] Dynamic subtest reset: SUCCESS (2.709s)
[447.545460] Starting dynamic subtest: memory_region
[451.928051] Dynamic subtest memory_region: SUCCESS (4.392s)
[451.940188] Starting dynamic subtest: hangcheck
[467.640900] Dynamic subtest hangcheck: SUCCESS (15.711s)
[467.651572] Starting dynamic subtest: execlists
[471.961106] Dynamic subtest execlists: SUCCESS (4.318s)
[471.970809] Starting dynamic subtest: ring_submission
[476.316585] Dynamic subtest ring_submission: SUCCESS (4.354s)
[476.332845] Starting dynamic subtest: perf
[479.106839] Dynamic subtest perf: SUCCESS (2.788s)
[479.117465] Starting dynamic subtest: slpc
[493.713508] Dynamic subtest slpc: SUCCESS (14.604s)
[493.723047] Starting dynamic subtest: guc
[497.687797] Dynamic subtest guc: SUCCESS (3.972s)
[497.697467] Starting dynamic subtest: guc_multi_lrc
[502.017728] Dynamic subtest guc_multi_lrc: SUCCESS (4.327s)
[502.028320] Starting dynamic subtest: guc_hang
[506.895684] Dynamic subtest guc_hang: SUCCESS (4.877s)
[506.905814] Starting dynamic subtest: late_gt_pm
[511.274149] Dynamic subtest late_gt_pm: SUCCESS (4.377s)
[511.276773] Subtest live: SUCCESS (248.575s)
[511.310053] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[511.310825] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[511.314047] [070/133] (511s left) gem_exec_fence (submit67)
[512.974435] Starting subtest: submit67
[512.978965] Subtest submit67: SKIP (0.000s)
[514.786217] [FACT gem_exec_fence (submit67)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[514.787430] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.i915: true
[514.791202] [071/133] (507s left) gem_exec_whisper (basic-normal-all)
[514.863244] Starting subtest: basic-normal-all
[517.931678] Subtest basic-normal-all: SUCCESS (3.066s)
[518.109546] [072/133] (504s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[518.226374] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[518.927434] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.703s)
[519.091219] [073/133] (503s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[519.193253] Starting subtest: pr-plane-move-sf-dmg-area
[519.197205] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[519.263352] [074/133] (503s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[519.360896] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[519.364925] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[519.476153] [075/133] (503s left) i915_pm_rpm (debugfs-forcewake-user)
[529.558105] Starting subtest: debugfs-forcewake-user
[540.948840] Subtest debugfs-forcewake-user: SUCCESS (11.391s)
[541.333181] [076/133] (481s left) syncobj_wait (single-wait-signaled)
[541.390004] Starting subtest: single-wait-signaled
[541.392376] Subtest single-wait-signaled: SUCCESS (0.000s)
[541.486492] [077/133] (481s left) kms_psr (fbc-pr-suspend)
[541.584209] Starting subtest: fbc-pr-suspend
[541.588657] Subtest fbc-pr-suspend: SKIP (0.000s)
[541.662266] [078/133] (481s left) gem_exec_params (invalid-ring)
[541.721814] Starting subtest: invalid-ring
[541.724071] Subtest invalid-ring: SUCCESS (0.000s)
[541.813266] [079/133] (481s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[541.904859] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[541.931627] Starting dynamic subtest: pipe-A-plane-0
[542.375608] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[542.386447] Starting dynamic subtest: pipe-A-plane-3
[542.631446] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[542.643321] Starting dynamic subtest: pipe-A-plane-5
[542.647025] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[543.782112] Starting dynamic subtest: pipe-B-plane-0
[544.219282] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[544.229435] Starting dynamic subtest: pipe-B-plane-3
[544.473640] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[544.484055] Starting dynamic subtest: pipe-B-plane-5
[544.488399] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[544.789001] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.882s)
[545.674885] [080/133] (477s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[545.728953] Starting subtest: etime-multi-wait-all-for-submit-submitted
[545.833829] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[545.911261] [081/133] (477s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[546.011411] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[547.034834] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.024s)
[547.174531] [082/133] (476s left) vgem_basic (unload)
[547.214284] Starting subtest: unload
[576.303922] Subtest unload: SUCCESS (29.094s)
[576.406190] [083/133] (446s left) gem_pxp (protected-raw-src-copy-not-readible)
[576.525479] Starting subtest: protected-raw-src-copy-not-readible
[576.582298] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[576.728622] [084/133] (446s left) syncobj_timeline (invalid-wait-illegal-handle)
[576.797538] Starting subtest: invalid-wait-illegal-handle
[576.799555] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[576.913956] [085/133] (446s left) kms_frontbuffer_tracking (psr-2p-rte)
[577.012139] Starting subtest: psr-2p-rte
[577.016644] Subtest psr-2p-rte: SKIP (0.000s)
[577.120178] [086/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[577.217749] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[577.221938] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[577.316966] [087/133] (446s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[577.417342] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[577.419215] Starting dynamic subtest: pipe-A-eDP-1
[577.493578] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[577.504149] Starting dynamic subtest: pipe-B-eDP-1
[578.644614] Dynamic subtest pipe-B-eDP-1: SKIP (1.149s)
[578.649725] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.230s)
[579.834608] [088/133] (443s left) syncobj_wait (invalid-wait-illegal-handle)
[579.902661] Starting subtest: invalid-wait-illegal-handle
[579.905149] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[580.023535] [089/133] (443s left) gem_ringfill (legacy-basic)
[585.698332] Starting subtest: legacy-basic
[585.700935] Starting dynamic subtest: default
[585.756501] Dynamic subtest default: SUCCESS (0.058s)
[585.770710] Starting dynamic subtest: render
[585.800556] Dynamic subtest render: SUCCESS (0.042s)
[585.811590] Starting dynamic subtest: bsd
[585.841625] Dynamic subtest bsd: SUCCESS (0.040s)
[585.852065] Starting dynamic subtest: bsd1
[585.886335] Dynamic subtest bsd1: SUCCESS (0.043s)
[585.911368] Starting dynamic subtest: bsd2
[585.931379] Dynamic subtest bsd2: SUCCESS (0.041s)
[585.944634] Starting dynamic subtest: blt
[585.974803] Dynamic subtest blt: SUCCESS (0.041s)
[585.988047] Starting dynamic subtest: vebox
[586.017864] Dynamic subtest vebox: SUCCESS (0.040s)
[586.020207] Subtest legacy-basic: SUCCESS (0.322s)
[586.111957] [090/133] (437s left) gem_exec_balancer (full-late-pulse)
[586.188430] Starting subtest: full-late-pulse
[590.604593] Subtest full-late-pulse: SUCCESS (4.416s)
[590.931556] [091/133] (432s left) i915_drm_fdinfo (virtual-busy-idle-all)
[590.978830] Starting subtest: virtual-busy-idle-all
[590.983157] Subtest virtual-busy-idle-all: SKIP (0.000s)
[591.043258] [092/133] (432s left) kms_rotation_crc (cursor-rotation-180)
[591.123894] Starting subtest: cursor-rotation-180
[592.847355] Subtest cursor-rotation-180: SUCCESS (1.725s)
[594.043240] [093/133] (429s left) gem_ctx_bad_destroy (double-destroy)
[594.103612] Starting subtest: double-destroy
[594.105873] Subtest double-destroy: SUCCESS (0.000s)
[594.185249] [094/133] (429s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[594.283200] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[594.973968] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[595.145398] [095/133] (428s left) syncobj_timeline (wait-all-for-submit-complex)
[595.201467] Starting subtest: wait-all-for-submit-complex
[595.413875] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[595.490636] [096/133] (428s left) gem_exec_params (sol-reset-not-gen7)
[595.548424] Starting subtest: sol-reset-not-gen7
[595.552900] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[595.677095] [097/133] (428s left) prime_self_import (basic-llseek-size)
[595.713329] Starting subtest: basic-llseek-size
[595.736150] Subtest basic-llseek-size: SUCCESS (0.023s)
[595.844387] [098/133] (428s left) kms_cursor_crc (cursor-offscreen-32x10)
[596.021594] Starting subtest: cursor-offscreen-32x10
[596.070184] Subtest cursor-offscreen-32x10: SKIP (0.048s)
[596.365837] [099/133] (427s left) kms_flip (2x-absolute-wf_vblank)
[596.462072] Starting subtest: 2x-absolute-wf_vblank
[596.471186] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[596.549739] [100/133] (427s left) vgem_basic (dmabuf-fence)
[596.590818] Starting subtest: dmabuf-fence
[596.592490] Subtest dmabuf-fence: SUCCESS (0.001s)
[596.672623] [101/133] (427s left) gem_tiled_blits (normal)
[596.737406] Subtest normal: SKIP (0.000s)
[596.823359] [102/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[596.922948] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[596.926260] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[597.034031] [103/133] (427s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[597.132836] Starting subtest: plane-downscale-factor-0-5-with-rotation
[597.134797] Starting dynamic subtest: pipe-A
[597.154119] Dynamic subtest pipe-A: SKIP (0.017s)
[597.164627] Starting dynamic subtest: pipe-B
[597.186245] Dynamic subtest pipe-B: SKIP (0.031s)
[597.196404] Starting dynamic subtest: pipe-C
[597.220340] Dynamic subtest pipe-C: SKIP (0.035s)
[597.230307] Starting dynamic subtest: pipe-D
[597.256558] Dynamic subtest pipe-D: SKIP (0.035s)
[597.259623] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.120s)
[597.357409] [104/133] (426s left) kms_invalid_mode (bad-hsync-start)
[597.447270] Starting subtest: bad-hsync-start
[597.449195] Starting dynamic subtest: pipe-A-eDP-1
[598.485599] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.035s)
[598.498280] Starting dynamic subtest: pipe-B-eDP-1
[598.500619] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[598.510448] Starting dynamic subtest: pipe-C-eDP-1
[598.512563] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[598.522529] Starting dynamic subtest: pipe-D-eDP-1
[598.524813] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[598.527166] Subtest bad-hsync-start: SUCCESS (1.051s)
[598.955536] [105/133] (425s left) api_intel_bb (object-reloc-keep-cache)
[599.017442] Starting subtest: object-reloc-keep-cache
[599.022186] Subtest object-reloc-keep-cache: SKIP (0.004s)
[599.151740] [106/133] (425s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[599.253052] Starting subtest: psr-rgb101010-draw-mmap-wc
[606.429366] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.179s)
[606.570558] [107/133] (417s left) gem_eio (in-flight-suspend)
[606.816599] Starting subtest: in-flight-suspend
[648.920870] Subtest in-flight-suspend: SUCCESS (12.960s)
[649.059716] [108/133] (375s left) gem_exec_flush (basic-batch-kernel-default-uc)
[649.133901] Starting subtest: basic-batch-kernel-default-uc
[656.785080] Subtest basic-batch-kernel-default-uc: SUCCESS (7.641s)
[656.980569] [109/133] (367s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[657.079881] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[664.458987] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.378s)
[664.586116] [110/133] (359s left) prime_busy (hang-wait)
[664.651930] Starting subtest: hang-wait
[664.654571] Starting dynamic subtest: rcs0
[690.329697] Dynamic subtest rcs0: SUCCESS (25.665s)
[690.341434] Starting dynamic subtest: bcs0
[697.477205] Dynamic subtest bcs0: SUCCESS (7.153s)
[697.490114] Starting dynamic subtest: vcs0
[704.517253] Dynamic subtest vcs0: SUCCESS (7.038s)
[704.530277] Starting dynamic subtest: vcs1
[711.495193] Dynamic subtest vcs1: SUCCESS (6.975s)
[711.506247] Starting dynamic subtest: vecs0
[718.469069] Dynamic subtest vecs0: SUCCESS (6.972s)
[718.480228] Starting dynamic subtest: ccs0
[732.304086] Dynamic subtest ccs0: SUCCESS (13.831s)
[732.307132] Subtest hang-wait: SUCCESS (67.647s)
[732.429989] [111/133] (292s left) gem_exec_schedule (implicit-boths)
[732.512828] Starting subtest: implicit-boths
[732.515109] Starting dynamic subtest: rcs0
[732.696785] Dynamic subtest rcs0: SUCCESS (0.193s)
[732.710204] Starting dynamic subtest: vcs0
[732.812576] Dynamic subtest vcs0: SUCCESS (0.116s)
[732.825331] Starting dynamic subtest: vcs1
[732.928528] Dynamic subtest vcs1: SUCCESS (0.113s)
[732.942735] Starting dynamic subtest: vecs0
[733.041477] Dynamic subtest vecs0: SUCCESS (0.112s)
[733.055012] Starting dynamic subtest: ccs0
[733.179195] Dynamic subtest ccs0: SUCCESS (0.137s)
[733.182146] Subtest implicit-boths: SUCCESS (0.678s)
[733.904569] [112/133] (290s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[734.009483] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[734.014071] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[734.105251] [113/133] (290s left) gen9_exec_parse (basic-rejected-ctx-param)
[734.169031] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[734.249244] [114/133] (290s left) kms_getfb (getfb-repeated-different-handles)
[734.349347] Starting subtest: getfb-repeated-different-handles
[734.351983] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[734.458011] [115/133] (290s left) kms_addfb_basic (bad-pitch-0)
[734.511952] Starting subtest: bad-pitch-0
[734.514689] Subtest bad-pitch-0: SUCCESS (0.000s)
[734.648070] [116/133] (290s left) vgem_basic (busy-fence)
[734.696942] Starting subtest: busy-fence
[734.699375] Subtest busy-fence: SUCCESS (0.000s)
[734.755680] [117/133] (289s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[735.141953] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[735.924975] [118/133] (288s left) gem_exec_schedule (preempt)
[735.995998] Starting subtest: preempt
[735.998671] Starting dynamic subtest: rcs0
[736.011400] Dynamic subtest rcs0: SUCCESS (0.026s)
[736.024713] Starting dynamic subtest: bcs0
[736.037205] Dynamic subtest bcs0: SUCCESS (0.026s)
[736.048036] Starting dynamic subtest: vcs0
[736.058872] Dynamic subtest vcs0: SUCCESS (0.021s)
[736.070220] Starting dynamic subtest: vcs1
[736.088813] Dynamic subtest vcs1: SUCCESS (0.029s)
[736.099734] Starting dynamic subtest: vecs0
[736.113726] Dynamic subtest vecs0: SUCCESS (0.025s)
[736.126961] Starting dynamic subtest: ccs0
[736.140146] Dynamic subtest ccs0: SUCCESS (0.025s)
[736.143003] Subtest preempt: SUCCESS (0.156s)
[738.091026] [119/133] (286s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[738.230984] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[738.235898] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[738.352775] [120/133] (286s left) perf_pmu (gt-awake)
[738.406585] Starting subtest: gt-awake
[746.871575] Subtest gt-awake: SUCCESS (8.465s)
[746.976069] [121/133] (277s left) kms_vblank (query-idle)
[747.077006] Starting subtest: query-idle
[747.079229] Starting dynamic subtest: pipe-A-eDP-1
[748.825687] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[748.842371] Starting dynamic subtest: pipe-D-eDP-1
[751.267855] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[751.270224] Subtest query-idle: SUCCESS (4.194s)
[752.151259] [122/133] (272s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[752.275958] Starting subtest: fbcpsr-modesetfrombusy
[758.463664] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.195s)
[758.595639] [123/133] (266s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[758.687119] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[758.689679] Starting dynamic subtest: pipe-A-eDP-1
[758.743928] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[758.754793] Starting dynamic subtest: pipe-B-eDP-1
[758.813121] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[758.826479] Starting dynamic subtest: pipe-C-eDP-1
[758.891293] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[758.902922] Starting dynamic subtest: pipe-D-eDP-1
[758.956941] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[758.961216] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[760.932738] [124/133] (264s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[761.025227] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[761.031084] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[761.130569] [125/133] (264s left) gem_exec_fence (basic-await)
[761.310188] Starting subtest: basic-await
[761.313017] Starting dynamic subtest: rcs0
[761.386427] Dynamic subtest rcs0: SUCCESS (0.076s)
[761.399751] Starting dynamic subtest: bcs0
[761.460415] Dynamic subtest bcs0: SUCCESS (0.071s)
[761.474408] Starting dynamic subtest: vcs0
[761.534374] Dynamic subtest vcs0: SUCCESS (0.072s)
[761.548520] Starting dynamic subtest: vcs1
[761.607540] Dynamic subtest vcs1: SUCCESS (0.072s)
[761.621070] Starting dynamic subtest: vecs0
[761.681466] Dynamic subtest vecs0: SUCCESS (0.072s)
[761.695774] Starting dynamic subtest: ccs0
[761.755728] Dynamic subtest ccs0: SUCCESS (0.073s)
[761.758866] Subtest basic-await: SUCCESS (0.447s)
[763.888935] [126/133] (261s left) gem_softpin (full)
[763.954448] Starting subtest: full
[763.972769] Subtest full: SUCCESS (0.021s)
[764.107531] [127/133] (261s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[764.211031] Starting subtest: multiplane-rotation-cropping-bottom
[781.812639] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.605s)
[781.922372] [128/133] (243s left) kms_selftest (drm_cmdline_parser)
[781.960810] Starting subtest: drm_cmdline_parser
[781.976060] Starting dynamic subtest: drm_test_cmdline_force_d_only
[782.055498] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.079s)
[782.067235] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[782.152080] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.096s)
[782.165199] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[782.231671] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.077s)
[782.243525] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[782.334206] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.102s)
[782.346674] Starting dynamic subtest: drm_test_cmdline_force_e_only
[782.416226] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.081s)
[782.428219] Starting dynamic subtest: drm_test_cmdline_res
[782.499457] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.082s)
[782.511007] Starting dynamic subtest: drm_test_cmdline_res_vesa
[782.592960] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s)
[782.603187] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[782.680012] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.086s)
[782.690885] Starting dynamic subtest: drm_test_cmdline_res_rblank
[782.770486] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.088s)
[782.782358] Starting dynamic subtest: drm_test_cmdline_res_bpp
[782.854999] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.085s)
[782.866695] Starting dynamic subtest: drm_test_cmdline_res_refresh
[782.954050] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.098s)
[782.965765] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[783.049639] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.093s)
[783.062237] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[783.132240] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.083s)
[783.144360] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[783.215934] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.082s)
[783.228390] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[783.303655] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.087s)
[783.315669] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[783.389828] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.084s)
[783.402448] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[783.477329] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.089s)
[783.494177] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[783.569024] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.088s)
[783.581879] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[783.650008] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.081s)
[783.660984] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[783.733489] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.083s)
[783.744218] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[783.824827] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.088s)
[783.844052] Starting dynamic subtest: drm_test_cmdline_name
[783.912642] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.088s)
[783.924015] Starting dynamic subtest: drm_test_cmdline_name_bpp
[784.009311] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.094s)
[784.022610] Starting dynamic subtest: drm_test_cmdline_name_option
[784.101973] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.090s)
[784.115036] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[784.185956] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.086s)
[784.197980] Starting dynamic subtest: drm_test_cmdline_rotate_0
[784.271851] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.085s)
[784.283876] Starting dynamic subtest: drm_test_cmdline_rotate_90
[784.363828] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.090s)
[784.375641] Starting dynamic subtest: drm_test_cmdline_rotate_180
[784.464044] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.100s)
[784.476014] Starting dynamic subtest: drm_test_cmdline_rotate_270
[784.554009] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.089s)
[784.567035] Starting dynamic subtest: drm_test_cmdline_hmirror
[784.641584] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.087s)
[784.653970] Starting dynamic subtest: drm_test_cmdline_vmirror
[784.728463] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.084s)
[784.740714] Starting dynamic subtest: drm_test_cmdline_margin_options
[784.815752] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.087s)
[784.828042] Starting dynamic subtest: drm_test_cmdline_multiple_options
[784.902516] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.086s)
[784.914660] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[784.988714] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.088s)
[785.000260] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[785.085086] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.095s)
[785.096731] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[785.182008] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.096s)
[785.195005] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[785.274107] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.091s)
[785.286408] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[785.367613] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s)
[785.379644] Starting dynamic subtest: drm_test_cmdline_invalid
[785.458125] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.090s)
[785.469354] Starting dynamic subtest: drm_test_cmdline_tv_options
[785.551860] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.091s)
[785.554051] Subtest drm_cmdline_parser: SUCCESS (3.590s)
[785.701566] [129/133] (239s left) kms_addfb_basic (invalid-set-prop)
[785.758845] Starting subtest: invalid-set-prop
[785.760749] Subtest invalid-set-prop: SUCCESS (0.000s)
[785.886436] [130/133] (239s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[785.981010] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[785.985825] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[786.077210] [131/133] (239s left) gem_mmap_gtt (pf-nonblock)
[786.134835] Subtest pf-nonblock: SKIP (0.000s)
[786.198661] [132/133] (239s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[786.301097] Starting subtest: psr2-overlay-plane-move-continuous-sf
[786.303108] Starting dynamic subtest: pipe-A-eDP-1
[792.302977] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.004s)
[792.314378] Starting dynamic subtest: pipe-B-eDP-1
[799.032799] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.727s)
[799.035206] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.734s)
[799.896112] [133/133] (225s left) kms_pm_backlight (fade)
[800.008177] Starting subtest: fade
[800.060128] Starting dynamic subtest: eDP-1
[802.551390] Dynamic subtest eDP-1: SUCCESS (2.494s)
[802.553898] Subtest fade: SUCCESS (2.546s)
[803.422394] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_wc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_properties
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: gem_ctx_sseu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: drm_read
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: device_reset
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_atomic_interruptible
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_ctx_param
results: parsing output: 33/ for test: kms_atomic
results: parsing output: 34/ for test: kms_chamelium_edid
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_fence_thrash
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_busy
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_gpgpu_fill
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_plane_lowres
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_close
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_feature_discovery
results: parsing output: 62/ for test: gem_create
results: parsing output: 63/ for test: gem_media_vme
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: i915_selftest
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_ctx_bad_destroy
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: prime_self_import
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: gem_tiled_blits
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: prime_busy
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_getfb
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: vgem_basic
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_selftest
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_pm_backlight
Done.