[59.177379] Initializing watchdogs
[59.177425]   /dev/watchdog0
[59.195483] [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.199941] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.202163] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.204119] [001/133] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[59.293556] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[59.295378] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[59.356800] [002/133] (960s left) syncobj_timeline (single-wait-signaled)
[59.407108] Starting subtest: single-wait-signaled
[59.408175] Subtest single-wait-signaled: SUCCESS (0.000s)
[59.503528] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[59.605195] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[60.661914] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s)
[60.798997] [004/133] (958s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[60.852621] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[60.961570] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[61.031046] [005/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[61.122287] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[61.124283] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[61.206005] [006/133] (958s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[61.285180] Starting subtest: fbc-pr-cursor-mmap-cpu
[61.287442] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[61.360451] [007/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[61.468372] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[68.094693] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.588s)
[68.212528] [008/133] (951s left) kms_sequence (get-forked-busy)
[68.305434] Starting subtest: get-forked-busy
[68.306458] Starting dynamic subtest: pipe-A-eDP-1
[70.245359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[70.251868] Starting dynamic subtest: pipe-B-eDP-1
[72.827080] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.574s)
[72.833538] Starting dynamic subtest: pipe-C-eDP-1
[75.441945] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.610s)
[75.448054] Starting dynamic subtest: pipe-D-eDP-1
[78.077152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[78.078056] Subtest get-forked-busy: SUCCESS (9.752s)
[78.860161] [009/133] (941s left) i915_drm_fdinfo (memory-info-purgeable)
[78.907819] Starting subtest: memory-info-purgeable
[78.908758] Starting dynamic subtest: smem0
[81.594109] Dynamic subtest smem0: SUCCESS (2.683s)
[81.595648] Subtest memory-info-purgeable: SUCCESS (2.683s)
[81.662376] [010/133] (938s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[81.710180] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[81.711089] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[81.822385] [011/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[81.906045] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[81.907915] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[82.012580] [012/133] (938s left) gem_lmem_swapping (verify-ccs)
[82.053888] Subtest verify-ccs: SKIP (0.000s)
[82.092481] [013/133] (937s left) perf_pmu (busy-idle-check-all)
[82.133917] Starting subtest: busy-idle-check-all
[82.134889] Starting dynamic subtest: rcs0
[82.786051] Dynamic subtest rcs0: SUCCESS (0.651s)
[82.795341] Starting dynamic subtest: bcs0
[83.437321] Dynamic subtest bcs0: SUCCESS (0.649s)
[83.446650] Starting dynamic subtest: vcs0
[84.895090] Dynamic subtest vcs0: SUCCESS (1.445s)
[84.903558] Starting dynamic subtest: vcs1
[86.877953] Dynamic subtest vcs1: SUCCESS (1.980s)
[86.886535] Starting dynamic subtest: vecs0
[88.926711] Dynamic subtest vecs0: SUCCESS (2.046s)
[88.934807] Starting dynamic subtest: ccs0
[89.575855] Dynamic subtest ccs0: SUCCESS (0.658s)
[89.576912] Subtest busy-idle-check-all: SUCCESS (7.435s)
[89.677438] [014/133] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[89.776934] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[89.778961] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[89.878382] [015/133] (930s left) gem_exec_flush (basic-wb-ro-default)
[89.937948] Starting subtest: basic-wb-ro-default
[95.395359] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[95.583071] [016/133] (924s left) kms_psr (psr2-sprite-plane-move)
[95.675963] Starting subtest: psr2-sprite-plane-move
[95.676848] Starting dynamic subtest: eDP-1
[97.411432] Dynamic subtest eDP-1: SUCCESS (1.734s)
[97.412383] Subtest psr2-sprite-plane-move: SUCCESS (1.735s)
[98.243755] [017/133] (921s left) syncobj_eventfd (binary-wait-signaled)
[98.301164] Starting subtest: binary-wait-signaled
[98.302073] Subtest binary-wait-signaled: SUCCESS (0.000s)
[98.405240] [018/133] (921s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[98.490866] Starting subtest: fbc-psr2-sprite-plane-onoff
[98.491816] Starting dynamic subtest: eDP-1
[98.493443] Dynamic subtest eDP-1: SKIP (0.000s)
[98.495098] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[98.556828] [019/133] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[98.642895] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[98.644513] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.732280] [020/133] (921s left) kms_flip (2x-flip-vs-panning-interruptible)
[98.819591] Starting subtest: 2x-flip-vs-panning-interruptible
[98.832338] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[98.899843] [021/133] (921s left) gem_pxp (reject-modify-context-protection-on)
[99.013807] Starting subtest: reject-modify-context-protection-on
[99.016462] Subtest reject-modify-context-protection-on: SUCCESS (0.003s)
[99.114082] [022/133] (921s left) kms_chamelium_frames (dp-frame-dump)
[99.483881] Subtest dp-frame-dump: SKIP (0.000s)
[100.245878] [023/133] (920s left) syncobj_basic (bad-pad-handle-to-fd)
[100.297592] Starting subtest: bad-pad-handle-to-fd
[100.298709] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[100.393912] [024/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[100.480891] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[104.475659] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.992s)
[105.710225] [025/133] (914s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[107.245995] Starting subtest: dpms-mode-unset-lpsp
[111.310297] Subtest dpms-mode-unset-lpsp: SUCCESS (4.063s)
[111.686929] [026/133] (908s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[111.775403] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[111.777901] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[111.862665] [027/133] (908s left) kms_addfb_basic (bad-pitch-0)
[111.915702] Starting subtest: bad-pitch-0
[111.916812] Subtest bad-pitch-0: SUCCESS (0.000s)
[112.035570] [028/133] (908s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[112.129268] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[112.130928] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[112.212210] [029/133] (908s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[112.308090] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[112.309849] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[112.421148] [030/133] (908s left) gem_mmap_gtt (basic-wc)
[112.473037] Subtest basic-wc: SKIP (0.000s)
[112.528058] [031/133] (908s left) kms_async_flips (test-cursor)
[112.606061] Starting subtest: test-cursor
[112.607877] Subtest test-cursor: SKIP (0.000s)
[113.802709] [032/133] (906s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[113.902045] Starting subtest: 2x-flip-vs-modeset-vs-hang
[113.913080] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[113.985987] [033/133] (906s left) gem_exec_schedule (u-semaphore-user)
[114.048193] Starting subtest: u-semaphore-user
[114.106885] Subtest u-semaphore-user: SUCCESS (0.058s)
[115.955818] [034/133] (904s left) kms_big_fb (x-tiled-addfb-size-overflow)
[116.045458] Starting subtest: x-tiled-addfb-size-overflow
[116.046383] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[116.141174] [035/133] (904s left) kms_vblank (wait-forked-hang)
[116.234299] Starting subtest: wait-forked-hang
[116.235358] Starting dynamic subtest: pipe-A-eDP-1
[142.676852] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.435s)
[142.686307] Starting dynamic subtest: pipe-D-eDP-1
[157.664332] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.987s)
[157.665289] Subtest wait-forked-hang: SUCCESS (41.426s)
[158.460068] [036/133] (862s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[158.550279] Starting subtest: psr-shrfb-scaledprimary
[164.366430] Subtest psr-shrfb-scaledprimary: SUCCESS (5.817s)
[164.509307] [037/133] (856s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[164.579087] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[164.580067] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[164.687883] [038/133] (856s left) perf (blocking-parameterized)
[164.811363] Starting subtest: blocking-parameterized
[184.884057] Subtest blocking-parameterized: SUCCESS (20.027s)
[184.913374] [039/133] (835s left) kms_addfb_basic (bad-pitch-256)
[184.978763] Starting subtest: bad-pitch-256
[184.979888] Subtest bad-pitch-256: SUCCESS (0.000s)
[185.106182] [040/133] (835s left) gem_eio (in-flight-contexts-1us)
[185.289729] Starting subtest: in-flight-contexts-1us
[196.898563] Subtest in-flight-contexts-1us: SUCCESS (11.608s)
[197.056363] [041/133] (823s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[197.142474] Starting subtest: fbc-rgb565-draw-mmap-wc
[201.144314] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.002s)
[202.302087] [042/133] (818s left) kms_draw_crc (draw-method-pwrite)
[202.382228] Starting subtest: draw-method-pwrite
[202.383212] Starting dynamic subtest: xrgb8888-untiled
[202.982135] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[202.991163] Starting dynamic subtest: rgb565-untiled
[203.415447] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[203.422414] Starting dynamic subtest: xrgb2101010-untiled
[203.981908] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[203.989221] Starting dynamic subtest: xbgr16161616f-untiled
[204.759931] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[204.767419] Starting dynamic subtest: xrgb8888-xtiled
[206.604611] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.844s)
[206.612423] Starting dynamic subtest: rgb565-xtiled
[207.704460] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s)
[207.711602] Starting dynamic subtest: xrgb2101010-xtiled
[209.539133] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.833s)
[209.546970] Starting dynamic subtest: xbgr16161616f-xtiled
[212.938285] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.399s)
[212.952312] Starting dynamic subtest: xrgb8888-4tiled
[214.071887] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.133s)
[214.080560] Starting dynamic subtest: rgb565-4tiled
[214.649587] Dynamic subtest rgb565-4tiled: SUCCESS (0.576s)
[214.656873] Starting dynamic subtest: xrgb2101010-4tiled
[215.772275] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.122s)
[215.779609] Starting dynamic subtest: xbgr16161616f-4tiled
[218.983632] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.211s)
[218.984539] Subtest draw-method-pwrite: SUCCESS (16.601s)
[219.068254] [043/133] (801s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[219.186261] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[219.187828] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[219.335703] [044/133] (801s left) gem_pipe_control_store_loop (fresh-buffer)
[219.402699] Starting subtest: fresh-buffer
[221.564686] Subtest fresh-buffer: SUCCESS (2.151s)
[221.666359] [045/133] (799s left) syncobj_basic (test-valid-cycle)
[221.718310] Starting subtest: test-valid-cycle
[221.719344] Subtest test-valid-cycle: SUCCESS (0.000s)
[221.805794] [046/133] (799s left) kms_flip (basic-flip-vs-wf_vblank)
[221.903644] Starting subtest: basic-flip-vs-wf_vblank
[221.905752] Starting dynamic subtest: A-eDP1
[223.855117] Dynamic subtest A-eDP1: SUCCESS (1.949s)
[223.868191] Starting dynamic subtest: B-eDP1
[225.794900] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[225.805210] Starting dynamic subtest: C-eDP1
[227.715035] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[227.726446] Starting dynamic subtest: D-eDP1
[229.649863] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[229.653905] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.749s)
[230.865084] [047/133] (790s left) gem_mmap_wc (bad-object)
[230.909924] Subtest bad-object: SKIP (0.000s)
[230.970475] [048/133] (790s left) kms_atomic_interruptible (universal-setplane-cursor)
[231.058265] Starting subtest: universal-setplane-cursor
[231.059167] Starting dynamic subtest: pipe-A-eDP-1
[238.494417] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[238.495256] Subtest universal-setplane-cursor: SUCCESS (7.435s)
[239.341212] [049/133] (781s left) prime_self_import (reimport-vs-gem_close-race)
[239.376966] Starting subtest: reimport-vs-gem_close-race
[244.467413] Subtest reimport-vs-gem_close-race: SUCCESS (5.090s)
[244.549494] [050/133] (776s left) sw_sync (timeline_closed)
[244.587147] Starting subtest: timeline_closed
[244.587948] Subtest timeline_closed: SUCCESS (0.000s)
[244.633312] [051/133] (776s left) kms_psr (pr-primary-blt)
[244.733971] Starting subtest: pr-primary-blt
[244.736057] Subtest pr-primary-blt: SKIP (0.000s)
[244.798397] [052/133] (776s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[244.897777] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[244.899629] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[244.969746] [053/133] (776s left) syncobj_wait (invalid-signal-zero-handles)
[245.024153] Starting subtest: invalid-signal-zero-handles
[245.025065] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[245.132917] [054/133] (776s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[245.227395] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[249.333199] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.106s)
[250.452260] [055/133] (770s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[250.552989] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[251.698364] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.146s)
[251.830030] [056/133] (769s left) gen7_exec_parse (basic-rejected)
[251.882675] Subtest basic-rejected: SKIP (0.000s)
[251.944817] [057/133] (769s left) prime_mmap (test_userptr)
[251.995102] Starting subtest: test_userptr
[251.996116] Starting dynamic subtest: test_userptr-smem
[251.997052] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[251.997934] Subtest test_userptr: SUCCESS (0.001s)
[252.077384] [058/133] (769s left) i915_pm_rc6_residency (media-rc6-accuracy)
[252.136846] Starting subtest: media-rc6-accuracy
[252.138754] Subtest media-rc6-accuracy: SKIP (0.000s)
[252.235820] [059/133] (769s left) gem_softpin (allocator-fork)
[252.291492] Starting subtest: allocator-fork
[254.509685] Subtest allocator-fork: SUCCESS (2.209s)
[254.629014] [060/133] (766s left) gem_busy (busy)
[254.693980] Starting subtest: busy
[254.695293] Starting dynamic subtest: all-engines
[254.742295] Dynamic subtest all-engines: SUCCESS (0.048s)
[254.750217] Starting dynamic subtest: rcs0
[255.907278] Dynamic subtest rcs0: SUCCESS (1.161s)
[255.916077] Starting dynamic subtest: bcs0
[255.960859] Dynamic subtest bcs0: SUCCESS (0.054s)
[255.969857] Starting dynamic subtest: vcs0
[256.000367] Dynamic subtest vcs0: SUCCESS (0.038s)
[256.008089] Starting dynamic subtest: vcs1
[257.953436] Dynamic subtest vcs1: SUCCESS (1.942s)
[257.962103] Starting dynamic subtest: vecs0
[259.938592] Dynamic subtest vecs0: SUCCESS (1.985s)
[259.947052] Starting dynamic subtest: ccs0
[261.921436] Dynamic subtest ccs0: SUCCESS (1.981s)
[261.922379] Subtest busy: SUCCESS (7.219s)
[262.228648] [061/133] (759s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[262.317961] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[262.318847] Starting dynamic subtest: pipe-A-eDP-1
[262.340483] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[262.347786] Starting dynamic subtest: pipe-B-eDP-1
[262.369245] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.376354] Starting dynamic subtest: pipe-C-eDP-1
[262.397673] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.404460] Starting dynamic subtest: pipe-D-eDP-1
[262.426406] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[262.428149] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[264.630717] [062/133] (756s left) drm_read (short-buffer-block)
[264.776650] Starting subtest: short-buffer-block
[264.777721] Subtest short-buffer-block: SUCCESS (0.000s)
[264.908966] [063/133] (756s left) kms_getfb (getfb-handle-not-fb)
[264.987557] Starting subtest: getfb-handle-not-fb
[264.988483] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[265.074684] [064/133] (756s left) kms_pm_rpm (modeset-lpsp-stress)
[267.095278] Starting subtest: modeset-lpsp-stress
[283.255863] Subtest modeset-lpsp-stress: SUCCESS (16.163s)
[283.350407] [065/133] (738s left) i915_drm_fdinfo (virtual-busy-idle-all)
[283.389345] Starting subtest: virtual-busy-idle-all
[283.391332] Subtest virtual-busy-idle-all: SKIP (0.000s)
[283.449189] [066/133] (738s left) gem_workarounds (basic-read)
[283.505697] Starting subtest: basic-read
[283.515997] Subtest basic-read: SUCCESS (0.010s)
[283.644348] [067/133] (738s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[283.773234] Starting subtest: dp-mst-type-0-suspend-resume
[283.774788] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[283.882359] [068/133] (737s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[283.980355] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[283.981876] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[284.048607] [069/133] (737s left) kms_prop_blob (invalid-set-prop)
[284.108191] Starting subtest: invalid-set-prop
[284.109160] Subtest invalid-set-prop: SUCCESS (0.000s)
[284.200861] [070/133] (737s left) kms_hdr (static-toggle-dpms)
[284.289219] Starting subtest: static-toggle-dpms
[284.291708] Subtest static-toggle-dpms: SKIP (0.000s)
[284.366240] [071/133] (737s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[284.447320] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[284.448115] Starting dynamic subtest: pipe-A-eDP-1
[284.456409] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.463811] Starting dynamic subtest: pipe-B-eDP-1
[284.471803] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.478851] Starting dynamic subtest: pipe-C-eDP-1
[284.486609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.493634] Starting dynamic subtest: pipe-D-eDP-1
[284.502318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.503841] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[286.680786] [072/133] (735s left) prime_vgem (shrink)
[286.813278] Starting subtest: shrink
[286.826282] Subtest shrink: SUCCESS (0.012s)
[286.914661] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[286.916725] [073/133] (735s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[286.976363] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[287.040385] [074/133] (734s left) gem_create (busy-create)
[287.091790] Starting subtest: busy-create
[287.092576] Starting dynamic subtest: smem0
[320.940376] Dynamic subtest smem0: SUCCESS (33.840s)
[320.941415] Subtest busy-create: SUCCESS (33.842s)
[321.117195] [075/133] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[321.216998] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[321.218908] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[321.316404] [076/133] (700s left) gem_exec_whisper (basic-contexts-forked)
[321.368698] Starting subtest: basic-contexts-forked
[346.556486] Subtest basic-contexts-forked: SUCCESS (25.139s)
[346.706847] [077/133] (675s left) gem_ctx_persistence (many-contexts)
[346.759853] Starting subtest: many-contexts
[391.983877] Subtest many-contexts: SUCCESS (45.221s)
[392.073724] [078/133] (630s left) gem_softpin (evict-active)
[392.140780] Starting subtest: evict-active
[392.149226] Subtest evict-active: SUCCESS (0.009s)
[392.271149] [079/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[392.369572] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[401.321217] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.953s)
[401.417611] [080/133] (620s left) kms_plane (plane-panning-top-left)
[401.505480] Starting subtest: plane-panning-top-left
[401.506370] Starting dynamic subtest: pipe-A
[403.205466] Dynamic subtest pipe-A: SUCCESS (1.699s)
[403.213054] Starting dynamic subtest: pipe-B
[405.631085] Dynamic subtest pipe-B: SUCCESS (2.424s)
[405.632040] Subtest plane-panning-top-left: SUCCESS (4.125s)
[406.439944] [081/133] (615s left) gem_exec_schedule (preempt-contexts)
[406.499156] Starting subtest: preempt-contexts
[406.499954] Starting dynamic subtest: rcs0
[406.553979] Dynamic subtest rcs0: SUCCESS (0.055s)
[406.565469] Starting dynamic subtest: bcs0
[406.606918] Dynamic subtest bcs0: SUCCESS (0.053s)
[406.618859] Starting dynamic subtest: vcs0
[406.657630] Dynamic subtest vcs0: SUCCESS (0.049s)
[406.666964] Starting dynamic subtest: vcs1
[406.704606] Dynamic subtest vcs1: SUCCESS (0.045s)
[406.712183] Starting dynamic subtest: vecs0
[406.752942] Dynamic subtest vecs0: SUCCESS (0.048s)
[406.760766] Starting dynamic subtest: ccs0
[406.807465] Dynamic subtest ccs0: SUCCESS (0.054s)
[406.808298] Subtest preempt-contexts: SUCCESS (0.310s)
[407.978085] [082/133] (614s left) gem_exec_fence (syncobj-repeat)
[408.462812] Starting subtest: syncobj-repeat
[408.658461] Subtest syncobj-repeat: SUCCESS (0.185s)
[410.018957] [083/133] (612s left) gem_exec_reloc (basic-gtt-cpu)
[410.085482] Subtest basic-gtt-cpu: SKIP (0.000s)
[410.157571] [084/133] (612s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[410.212507] Starting subtest: rel-constants-invalid-rel-gen5
[410.213413] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[410.348109] [085/133] (612s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[410.462411] Starting subtest: plane-upscale-20x20-with-modifiers
[410.463259] Starting dynamic subtest: pipe-A
[410.811520] Dynamic subtest pipe-A: SUCCESS (0.349s)
[410.820078] Starting dynamic subtest: pipe-B
[412.218960] Dynamic subtest pipe-B: SUCCESS (1.406s)
[412.227817] Starting dynamic subtest: pipe-C
[413.651905] Dynamic subtest pipe-C: SUCCESS (1.432s)
[413.659615] Starting dynamic subtest: pipe-D
[415.089294] Dynamic subtest pipe-D: SUCCESS (1.436s)
[415.090196] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.628s)
[416.246594] [086/133] (606s left) gem_exec_fence (syncobj-timeline-unused-fence)
[416.773370] Starting subtest: syncobj-timeline-unused-fence
[416.774284] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[417.947141] [087/133] (604s left) gem_ctx_param (invalid-get-no-zeromap)
[418.003830] Starting subtest: invalid-get-no-zeromap
[418.004763] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[418.110475] [088/133] (604s left) kms_cursor_edge_walk (256x256-right-edge)
[418.205345] Starting subtest: 256x256-right-edge
[418.206163] Starting dynamic subtest: pipe-A-eDP-1
[421.626412] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[421.633844] Starting dynamic subtest: pipe-D-eDP-1
[424.760024] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[424.760919] Subtest 256x256-right-edge: SUCCESS (6.555s)
[425.555473] [089/133] (596s left) core_auth (getclient-simple)
[425.587264] Starting subtest: getclient-simple
[425.599549] Subtest getclient-simple: SUCCESS (0.012s)
[425.688101] [090/133] (596s left) gem_exec_balancer (parallel-keep-in-fence)
[425.946621] Starting subtest: parallel-keep-in-fence
[427.224813] Subtest parallel-keep-in-fence: SUCCESS (1.278s)
[427.312078] [091/133] (595s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[427.399566] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[427.400622] Starting dynamic subtest: pipe-A-eDP-1
[427.409380] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.422364] Starting dynamic subtest: pipe-B-eDP-1
[427.431346] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.439971] Starting dynamic subtest: pipe-C-eDP-1
[427.448824] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.455728] Starting dynamic subtest: pipe-D-eDP-1
[427.465046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.466957] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[429.618261] [092/133] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[429.703035] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[429.704743] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[429.790613] [093/133] (592s left) sw_sync (sync_busy_fork)
[429.830337] Starting subtest: sync_busy_fork
[430.850380] Subtest sync_busy_fork: SUCCESS (1.012s)
[430.896345] [094/133] (591s left) kms_chamelium_color (ctm-max)
[430.983619] Subtest ctm-max: SKIP (0.000s)
[431.023608] [095/133] (591s left) kms_flip (2x-plain-flip-fb-recreate)
[431.106698] Starting subtest: 2x-plain-flip-fb-recreate
[431.119176] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[431.235262] [096/133] (591s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[431.325806] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[438.244070] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.919s)
[438.364101] [097/133] (584s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[438.477189] Starting subtest: 4-tiled-64bpp-rotate-180
[440.133888] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.657s)
[440.312799] [098/133] (582s left) kms_lease (lease-unleased-connector)
[440.392411] Starting subtest: lease-unleased-connector
[440.393332] Starting dynamic subtest: pipe-A-eDP-1
[440.399132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[440.408172] Starting dynamic subtest: pipe-B-eDP-1
[440.408985] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[440.417038] Starting dynamic subtest: pipe-C-eDP-1
[440.417948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[440.425624] Starting dynamic subtest: pipe-D-eDP-1
[440.426444] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[440.427238] Subtest lease-unleased-connector: SUCCESS (0.032s)
[440.524895] [099/133] (582s left) sw_sync (sync_multi_consumer_producer)
[440.559149] Starting subtest: sync_multi_consumer_producer
[440.875419] Subtest sync_multi_consumer_producer: SUCCESS (0.307s)
[440.923562] [100/133] (582s left) kms_cursor_crc (cursor-offscreen-64x64)
[441.098031] Starting subtest: cursor-offscreen-64x64
[441.100264] Starting dynamic subtest: pipe-A-eDP-1
[443.043217] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[443.072091] Starting dynamic subtest: pipe-D-eDP-1
[445.670253] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s)
[445.670996] Subtest cursor-offscreen-64x64: SUCCESS (4.573s)
[446.505446] [101/133] (576s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[446.614714] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[446.625133] Starting dynamic subtest: pipe-A-eDP-1
[446.633894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.642243] Starting dynamic subtest: pipe-B-eDP-1
[446.657482] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.664740] Starting dynamic subtest: pipe-C-eDP-1
[446.672032] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.679039] Starting dynamic subtest: pipe-D-eDP-1
[446.686935] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.688581] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[448.879857] [102/133] (574s left) gem_mmap_gtt (flink-race)
[448.934873] Subtest flink-race: SKIP (0.000s)
[448.991739] [103/133] (574s left) kms_addfb_basic (legacy-format)
[449.040119] Starting subtest: legacy-format
[449.071261] Subtest legacy-format: SUCCESS (0.027s)
[449.208298] [104/133] (573s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[449.315524] Starting subtest: invalidate-primary-flip-overlay
[460.162363] Subtest invalidate-primary-flip-overlay: SUCCESS (10.846s)
[460.271499] [105/133] (562s left) gem_wait (busy)
[460.327971] Starting subtest: busy
[460.328923] Starting dynamic subtest: all-engines
[461.919189] Dynamic subtest all-engines: SUCCESS (1.580s)
[461.929612] Starting dynamic subtest: rcs0
[462.461288] Dynamic subtest rcs0: SUCCESS (0.549s)
[462.471544] Starting dynamic subtest: bcs0
[463.001529] Dynamic subtest bcs0: SUCCESS (0.539s)
[463.012540] Starting dynamic subtest: vcs0
[464.926615] Dynamic subtest vcs0: SUCCESS (1.914s)
[464.936376] Starting dynamic subtest: vcs1
[466.910909] Dynamic subtest vcs1: SUCCESS (1.981s)
[466.920693] Starting dynamic subtest: vecs0
[468.894783] Dynamic subtest vecs0: SUCCESS (1.981s)
[468.904077] Starting dynamic subtest: ccs0
[469.427645] Dynamic subtest ccs0: SUCCESS (0.540s)
[469.428664] Subtest busy: SUCCESS (9.099s)
[469.620701] [106/133] (553s left) api_intel_allocator (reloc-allocator)
[469.672730] Starting subtest: reloc-allocator
[469.673613] Starting dynamic subtest: basic
[469.676015] Dynamic subtest basic: SUCCESS (0.004s)
[469.684970] Starting dynamic subtest: parallel-one
[469.685783] Dynamic subtest parallel-one: SUCCESS (0.007s)
[469.693186] Starting dynamic subtest: print
[469.693948] Dynamic subtest print: SUCCESS (0.000s)
[469.702963] Starting dynamic subtest: reuse
[469.703789] Dynamic subtest reuse: SUCCESS (0.000s)
[469.710783] Starting dynamic subtest: fork-reopen-allocator
[469.711590] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[469.712412] Subtest reloc-allocator: SUCCESS (0.024s)
[469.828770] [107/133] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[469.938498] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[469.940144] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[470.041414] [108/133] (553s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[470.139679] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[470.140524] Starting dynamic subtest: pipe-A-default-mode
[471.351388] Dynamic subtest pipe-A-default-mode: SKIP (1.210s)
[471.353199] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.212s)
[471.480588] [109/133] (551s left) i915_query (hwconfig_table)
[471.532744] Starting subtest: hwconfig_table
[471.649870] Subtest hwconfig_table: SUCCESS (0.001s)
[471.679182] [110/133] (551s left) vgem_basic (bad-flag)
[471.722616] Starting subtest: bad-flag
[471.723460] Subtest bad-flag: SUCCESS (0.000s)
[471.772363] [111/133] (551s left) kms_flip (wf_vblank-ts-check)
[471.872149] Starting subtest: wf_vblank-ts-check
[471.874049] Starting dynamic subtest: A-eDP1
[480.787164] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[480.796801] Starting dynamic subtest: B-eDP1
[489.725638] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[489.734095] Starting dynamic subtest: C-eDP1
[498.665201] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[498.674395] Starting dynamic subtest: D-eDP1
[507.597692] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[507.598636] Subtest wf_vblank-ts-check: SUCCESS (35.692s)
[508.786911] [112/133] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[508.868424] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[508.870034] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[508.946337] [113/133] (514s left) kms_plane_multiple (tiling-none)
[509.033434] Starting subtest: tiling-none
[509.034346] Starting dynamic subtest: pipe-A-eDP-1
[512.724014] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.689s)
[512.731922] Starting dynamic subtest: pipe-B-eDP-1
[517.165631] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.441s)
[517.173567] Starting dynamic subtest: pipe-C-eDP-1
[521.494020] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.327s)
[521.501816] Starting dynamic subtest: pipe-D-eDP-1
[525.814955] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[525.815832] Subtest tiling-none: SUCCESS (16.780s)
[526.631972] [114/133] (496s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[526.746440] Starting subtest: basic-max-pipe-crc-check
[526.748366] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[526.791916] [115/133] (496s left) gem_exec_alignment (many)
[526.853310] Starting subtest: many
[550.978945] Subtest many: SUCCESS (24.080s)
[552.946880] [116/133] (470s left) kms_cursor_legacy (forked-bo)
[553.113823] Starting subtest: forked-bo
[553.114773] Starting dynamic subtest: pipe-A
[558.618477] Dynamic subtest pipe-A: SUCCESS (5.458s)
[558.630851] Starting dynamic subtest: pipe-B
[564.133715] Dynamic subtest pipe-B: SUCCESS (5.513s)
[564.145831] Starting dynamic subtest: pipe-C
[569.615171] Dynamic subtest pipe-C: SUCCESS (5.479s)
[569.624990] Starting dynamic subtest: pipe-D
[575.079405] Dynamic subtest pipe-D: SUCCESS (5.461s)
[575.092599] Starting dynamic subtest: all-pipes
[580.569346] Dynamic subtest all-pipes: SUCCESS (5.487s)
[580.570472] Subtest forked-bo: SUCCESS (27.410s)
[580.663189] [117/133] (442s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[580.722907] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[580.796113] [118/133] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[580.897073] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[585.666339] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.769s)
[586.830149] [119/133] (436s left) kms_rotation_crc (exhaust-fences)
[586.934517] Starting subtest: exhaust-fences
[586.936130] Subtest exhaust-fences: SKIP (0.000s)
[587.001680] [120/133] (436s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[587.103068] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[587.104727] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[587.210110] [121/133] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[587.297783] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[594.408119] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.112s)
[594.503454] [122/133] (429s left) gem_ringfill (legacy-basic)
[599.908961] Starting subtest: legacy-basic
[599.910008] Starting dynamic subtest: default
[599.971825] Dynamic subtest default: SUCCESS (0.064s)
[599.985041] Starting dynamic subtest: render
[600.013649] Dynamic subtest render: SUCCESS (0.040s)
[600.023538] Starting dynamic subtest: bsd
[600.056885] Dynamic subtest bsd: SUCCESS (0.040s)
[600.067330] Starting dynamic subtest: bsd1
[600.102271] Dynamic subtest bsd1: SUCCESS (0.043s)
[600.112592] Starting dynamic subtest: bsd2
[600.143237] Dynamic subtest bsd2: SUCCESS (0.039s)
[600.153236] Starting dynamic subtest: blt
[600.188838] Dynamic subtest blt: SUCCESS (0.043s)
[600.201138] Starting dynamic subtest: vebox
[600.230994] Dynamic subtest vebox: SUCCESS (0.040s)
[600.233902] Subtest legacy-basic: SUCCESS (0.326s)
[600.303571] [123/133] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[600.404897] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[600.406747] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[600.497936] [124/133] (423s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[600.836605] Starting subtest: cursor-rapid-movement-max-size
[600.839123] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[600.960055] [125/133] (422s left) core_getversion (all-cards)
[600.990361] Starting subtest: all-cards
[601.004730] Subtest all-cards: SUCCESS (0.017s)
[601.039208] [126/133] (422s left) gem_exec_reloc (basic-write-gtt)
[601.096236] Subtest basic-write-gtt: SKIP (0.000s)
[601.165805] [127/133] (422s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[601.552143] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[602.366503] [128/133] (421s left) kms_psr (fbc-pr-suspend)
[602.454534] Starting subtest: fbc-pr-suspend
[602.456431] Subtest fbc-pr-suspend: SKIP (0.000s)
[602.529930] [129/133] (421s left) kms_color_pipeline (plane-ctm3x4)
[602.613654] Starting subtest: plane-ctm3x4
[602.760798] Starting dynamic subtest: pipe-A-plane-0
[602.984106] Dynamic subtest pipe-A-plane-0: FAIL (0.162s)
[602.992350] Starting dynamic subtest: pipe-A-plane-1
[603.141458] Dynamic subtest pipe-A-plane-1: FAIL (0.145s)
[603.149572] Starting dynamic subtest: pipe-A-plane-2
[603.315847] Dynamic subtest pipe-A-plane-2: FAIL (0.155s)
[604.390169] Starting dynamic subtest: pipe-B-plane-0
[604.627880] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[604.636074] Starting dynamic subtest: pipe-B-plane-1
[604.769024] Dynamic subtest pipe-B-plane-1: FAIL (0.144s)
[604.776709] Starting dynamic subtest: pipe-B-plane-2
[604.945605] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[606.011750] Starting dynamic subtest: pipe-C-plane-0
[606.242927] Dynamic subtest pipe-C-plane-0: FAIL (0.117s)
[606.250701] Starting dynamic subtest: pipe-C-plane-1
[606.388126] Dynamic subtest pipe-C-plane-1: FAIL (0.121s)
[606.396248] Starting dynamic subtest: pipe-C-plane-2
[606.548460] Dynamic subtest pipe-C-plane-2: FAIL (0.132s)
[607.527023] Starting dynamic subtest: pipe-D-plane-0
[607.786373] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[607.794273] Starting dynamic subtest: pipe-D-plane-1
[607.967991] Dynamic subtest pipe-D-plane-1: FAIL (0.121s)
[607.981388] Starting dynamic subtest: pipe-D-plane-2
[608.160210] Dynamic subtest pipe-D-plane-2: FAIL (0.305s)
[608.353469] Subtest plane-ctm3x4: FAIL (5.741s)
[609.185710] [130/133] (414s left) gem_lmem_swapping (heavy-verify-random-ccs)
[609.225061] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[609.268657] [131/133] (414s left) gem_exec_balancer (bonded-true-hang)
[609.545934] Starting subtest: bonded-true-hang
[609.548411] Subtest bonded-true-hang: SKIP (0.000s)
[609.631892] [132/133] (414s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[609.731434] Starting subtest: y-tiled-16bpp-rotate-270
[609.733351] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[609.826835] [133/133] (414s left) gem_exec_nop (basic-series)
[609.891163] Starting subtest: basic-series
[625.951562] Subtest basic-series: SUCCESS (16.052s)
[626.175893] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_sequence
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_eventfd
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: syncobj_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_draw_crc
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_pipe_control_store_loop
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_atomic_interruptible
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: sw_sync
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: i915_pm_rc6_residency
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_busy
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: drm_read
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: kms_hdr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: core_auth
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_psr_stress_test
results: parsing output: 104/ for test: gem_wait
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: i915_query
results: parsing output: 109/ for test: vgem_basic
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: kms_multipipe_modeset
results: parsing output: 114/ for test: gem_exec_alignment
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ringfill
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: core_getversion
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_nop
Done.