[57.781772] Initializing watchdogs
[57.781818]   /dev/watchdog0
[57.796591] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.801108] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.803350] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.806659] [001/133] (960s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[57.979948] Starting subtest: dp-mst-type-0-suspend-resume
[57.984707] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[58.120930] [002/133] (960s left) kms_force_connector_basic (force-edid)
[58.204492] Starting subtest: force-edid
[58.577575] Subtest force-edid: SUCCESS (0.371s)
[58.708331] [003/133] (959s left) gem_ctx_persistence (engines-queued)
[58.773479] Starting subtest: engines-queued
[58.775466] Starting dynamic subtest: rcs0
[58.834728] Dynamic subtest rcs0: SUCCESS (0.060s)
[58.844301] Starting dynamic subtest: bcs0
[58.874327] Dynamic subtest bcs0: SUCCESS (0.039s)
[58.884205] Starting dynamic subtest: vcs0
[60.855375] Dynamic subtest vcs0: SUCCESS (1.972s)
[60.866187] Starting dynamic subtest: vcs1
[62.903122] Dynamic subtest vcs1: SUCCESS (2.041s)
[62.913921] Starting dynamic subtest: vecs0
[64.886095] Dynamic subtest vecs0: SUCCESS (1.977s)
[64.896481] Starting dynamic subtest: ccs0
[65.098908] Dynamic subtest ccs0: SUCCESS (0.214s)
[65.101641] Subtest engines-queued: SUCCESS (6.309s)
[65.177505] [004/133] (953s left) gem_ctx_param (invalid-size-set)
[65.225978] Starting subtest: invalid-size-set
[65.228449] Subtest invalid-size-set: SUCCESS (0.001s)
[65.344899] [005/133] (953s left) kms_pm_dc (dc9-dpms)
[66.460789] Starting subtest: dc9-dpms
[70.764731] Subtest dc9-dpms: SUCCESS (4.299s)
[70.835434] [006/133] (947s left) gem_bad_reloc (negative-reloc-lut)
[70.894063] Subtest negative-reloc-lut: SKIP (0.000s)
[70.960550] [007/133] (947s left) gem_exec_whisper (basic-forked)
[71.019659] Starting subtest: basic-forked
[78.321564] Subtest basic-forked: SUCCESS (7.296s)
[78.503340] [008/133] (940s left) gem_mmap_gtt (basic-write-read-distinct)
[78.561875] Subtest basic-write-read-distinct: SKIP (0.000s)
[78.624360] [009/133] (940s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[78.739275] Starting subtest: 4-tiled-32bpp-rotate-180
[80.152340] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.412s)
[80.282940] [010/133] (938s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[80.383050] Starting subtest: psr2-plane-move-sf-dmg-area
[80.385120] Starting dynamic subtest: pipe-A-eDP-1
[84.849553] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.469s)
[84.858579] Starting dynamic subtest: pipe-B-eDP-1
[90.048071] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.193s)
[90.050610] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.666s)
[90.879616] [011/133] (927s left) kms_chamelium_hpd (dp-hpd-storm)
[91.263965] Subtest dp-hpd-storm: SKIP (0.000s)
[92.060898] [012/133] (926s left) gem_exec_params (secure-non-master)
[92.113873] Starting subtest: secure-non-master
[92.118470] Subtest secure-non-master: SKIP (0.000s)
[92.214043] [013/133] (926s left) kms_cursor_edge_walk (128x128-top-edge)
[92.315717] Starting subtest: 128x128-top-edge
[92.318169] Starting dynamic subtest: pipe-A-eDP-1
[95.806651] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[95.819206] Starting dynamic subtest: pipe-D-eDP-1
[99.021606] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.212s)
[99.024038] Subtest 128x128-top-edge: SUCCESS (6.703s)
[99.875931] [014/133] (918s left) gem_exec_schedule (preempt-engines)
[99.953019] Starting subtest: preempt-engines
[99.955240] Starting dynamic subtest: rcs0
[102.231456] Dynamic subtest rcs0: SUCCESS (2.277s)
[102.243203] Starting dynamic subtest: bcs0
[104.556293] Dynamic subtest bcs0: SUCCESS (2.324s)
[104.567474] Starting dynamic subtest: vcs0
[106.830669] Dynamic subtest vcs0: SUCCESS (2.273s)
[106.839387] Starting dynamic subtest: vcs1
[109.118364] Dynamic subtest vcs1: SUCCESS (2.287s)
[109.128714] Starting dynamic subtest: vecs0
[111.409228] Dynamic subtest vecs0: SUCCESS (2.289s)
[111.419960] Starting dynamic subtest: ccs0
[113.710551] Dynamic subtest ccs0: SUCCESS (2.300s)
[113.712466] Subtest preempt-engines: SUCCESS (13.756s)
[114.007012] [015/133] (904s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[114.114654] Starting subtest: yf-tiled-addfb-size-overflow
[114.118719] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[114.209463] [016/133] (904s left) gem_exercise_blt (fast-copy)
[114.273455] Starting subtest: fast-copy
[114.275726] Starting dynamic subtest: linear-smem-smem
[114.294823] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[114.306024] Starting dynamic subtest: xmajor-smem-smem
[114.312710] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[114.322861] Starting dynamic subtest: tile4-smem-smem
[114.333601] Dynamic subtest tile4-smem-smem: SUCCESS (0.020s)
[114.343744] Starting dynamic subtest: tile64-smem-smem
[114.351235] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[114.353530] Subtest fast-copy: SUCCESS (0.080s)
[114.457844] [017/133] (904s left) gem_exec_reloc (basic-active)
[114.512769] Subtest basic-active: SKIP (0.000s)
[114.577788] [018/133] (904s left) perf (gen12-invalid-class-instance)
[114.690829] Starting subtest: gen12-invalid-class-instance
[114.701946] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[114.740985] [019/133] (904s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[114.841904] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[122.073761] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.234s)
[122.199653] [020/133] (896s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[122.256435] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[122.321746] [021/133] (896s left) kms_draw_crc (draw-method-mmap-cpu)
[122.410837] Starting subtest: draw-method-mmap-cpu
[122.412686] Starting dynamic subtest: xrgb8888-untiled
[122.678347] Dynamic subtest xrgb8888-untiled: SUCCESS (0.269s)
[122.687430] Starting dynamic subtest: rgb565-untiled
[122.922417] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[122.939733] Starting dynamic subtest: xrgb2101010-untiled
[123.144051] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[123.153124] Starting dynamic subtest: xbgr16161616f-untiled
[123.377628] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[123.386740] Starting dynamic subtest: xrgb8888-xtiled
[123.522420] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[123.531346] Starting dynamic subtest: rgb565-xtiled
[123.655487] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[123.664616] Starting dynamic subtest: xrgb2101010-xtiled
[123.788605] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[123.796947] Starting dynamic subtest: xbgr16161616f-xtiled
[123.921832] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[123.930514] Starting dynamic subtest: xrgb8888-4tiled
[124.066549] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[124.075198] Starting dynamic subtest: rgb565-4tiled
[124.210919] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[124.219200] Starting dynamic subtest: xrgb2101010-4tiled
[124.355506] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[124.364102] Starting dynamic subtest: xbgr16161616f-4tiled
[124.499932] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[124.501973] Subtest draw-method-mmap-cpu: SUCCESS (2.092s)
[124.595022] [022/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[124.691070] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[124.694751] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[124.797211] [023/133] (894s left) gem_softpin (evict-snoop)
[124.864931] Starting subtest: evict-snoop
[124.868944] Subtest evict-snoop: SKIP (0.000s)
[124.973485] [024/133] (894s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[125.029760] Starting subtest: yf-tiled-to-vebox-x-tiled
[125.033577] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[125.210799] [025/133] (894s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[125.318863] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[125.330945] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[125.418212] [026/133] (893s left) kms_lease (lease-invalid-crtc)
[125.515406] Starting subtest: lease-invalid-crtc
[125.517727] Starting dynamic subtest: pipe-A-eDP-1
[125.520082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[125.529755] Starting dynamic subtest: pipe-B-eDP-1
[125.531769] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[125.539801] Starting dynamic subtest: pipe-C-eDP-1
[125.542076] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[125.549878] Starting dynamic subtest: pipe-D-eDP-1
[125.551803] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[125.553708] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[125.587651] [027/133] (893s left) gem_exec_create (madvise)
[125.662090] Starting subtest: madvise
[125.664484] Starting dynamic subtest: smem
[145.943716] Dynamic subtest smem: SUCCESS (20.281s)
[145.946614] Subtest madvise: SUCCESS (20.282s)
[146.792623] [028/133] (872s left) prime_self_import (export-vs-gem_close-race)
[146.838018] Starting subtest: export-vs-gem_close-race
[151.940111] Subtest export-vs-gem_close-race: SUCCESS (5.102s)
[152.017495] [029/133] (867s left) kms_prop_blob (invalid-get-prop)
[152.080829] Starting subtest: invalid-get-prop
[152.083140] Subtest invalid-get-prop: SUCCESS (0.000s)
[152.168347] [030/133] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[152.268811] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[159.567502] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.301s)
[159.709429] [031/133] (859s left) kms_chamelium_color (ctm-negative)
[159.807170] Subtest ctm-negative: SKIP (0.000s)
[159.850559] [032/133] (859s left) gem_lmem_swapping (parallel-random-verify)
[159.889746] Subtest parallel-random-verify: SKIP (0.000s)
[159.929674] [033/133] (859s left) kms_properties (crtc-properties-atomic)
[160.028438] Starting subtest: crtc-properties-atomic
[160.030744] Starting dynamic subtest: pipe-A-eDP-1
[160.478858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[160.495201] Starting dynamic subtest: pipe-B-eDP-1
[161.607404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[161.617341] Starting dynamic subtest: pipe-C-eDP-1
[162.789612] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[162.799337] Starting dynamic subtest: pipe-D-eDP-1
[163.912626] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[163.914590] Subtest crtc-properties-atomic: SUCCESS (3.885s)
[164.782251] [034/133] (854s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[164.896512] Starting subtest: cursorA-vs-flipB-atomic-transitions
[164.901140] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[165.035745] [035/133] (854s left) sriov_basic (bind-unbind-vf)
[165.085899] Starting subtest: bind-unbind-vf
[165.088647] Starting dynamic subtest: vf-1
[165.163610] Dynamic subtest vf-1: FAIL (0.019s)
[165.179631] Starting dynamic subtest: vf-2
[165.253142] Dynamic subtest vf-2: FAIL (0.004s)
[165.271401] Starting dynamic subtest: vf-3
[165.348761] Dynamic subtest vf-3: FAIL (0.004s)
[165.367372] Starting dynamic subtest: vf-4
[165.442422] Dynamic subtest vf-4: FAIL (0.004s)
[165.461858] Starting dynamic subtest: vf-5
[165.541202] Dynamic subtest vf-5: FAIL (0.004s)
[165.559431] Starting dynamic subtest: vf-6
[165.635971] Dynamic subtest vf-6: FAIL (0.004s)
[165.654917] Starting dynamic subtest: vf-7
[165.728410] Dynamic subtest vf-7: FAIL (0.004s)
[165.744230] Starting dynamic subtest: vf-random
[165.804851] Dynamic subtest vf-random: FAIL (0.004s)
[165.820929] Starting dynamic subtest: vf-last
[165.883262] Dynamic subtest vf-last: FAIL (0.582s)
[165.885128] Subtest bind-unbind-vf: FAIL (0.634s)
[165.966574] [036/133] (853s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[166.088855] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[166.090545] Starting dynamic subtest: pipe-A-eDP-1
[166.580590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[166.597269] Starting dynamic subtest: pipe-B-eDP-1
[168.049029] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[168.065781] Starting dynamic subtest: pipe-C-eDP-1
[169.458294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s)
[169.475201] Starting dynamic subtest: pipe-D-eDP-1
[170.852074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.395s)
[170.854064] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.736s)
[171.977380] [037/133] (847s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[172.076963] Starting subtest: plane-lut1d-ctm3x4-lut1d
[172.233669] Starting dynamic subtest: pipe-A-plane-0
[172.619077] Dynamic subtest pipe-A-plane-0: FAIL (0.197s)
[172.627255] Starting dynamic subtest: pipe-A-plane-1
[172.850371] Dynamic subtest pipe-A-plane-1: FAIL (0.177s)
[172.860464] Starting dynamic subtest: pipe-A-plane-2
[173.082631] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[173.986146] Starting dynamic subtest: pipe-B-plane-0
[174.440425] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[174.450513] Starting dynamic subtest: pipe-B-plane-1
[174.771964] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[174.780877] Starting dynamic subtest: pipe-B-plane-2
[175.078548] Dynamic subtest pipe-B-plane-2: FAIL (0.620s)
[176.131448] Starting dynamic subtest: pipe-C-plane-0
[176.657749] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[176.668454] Starting dynamic subtest: pipe-C-plane-1
[177.078534] Dynamic subtest pipe-C-plane-1: FAIL (0.628s)
[177.088151] Starting dynamic subtest: pipe-C-plane-2
[177.480682] Dynamic subtest pipe-C-plane-2: FAIL (0.172s)
[178.228170] Starting dynamic subtest: pipe-D-plane-0
[178.851675] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[178.863623] Starting dynamic subtest: pipe-D-plane-1
[179.357088] Dynamic subtest pipe-D-plane-1: FAIL (0.627s)
[179.367221] Starting dynamic subtest: pipe-D-plane-2
[179.832150] Dynamic subtest pipe-D-plane-2: FAIL (0.577s)
[179.876136] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.801s)
[180.663365] [038/133] (839s left) i915_hangman (engine-error-state-capture)
[180.722230] Starting subtest: engine-error-state-capture
[180.724583] Starting dynamic subtest: rcs0
[183.861106] Dynamic subtest rcs0: SUCCESS (3.139s)
[183.873402] Starting dynamic subtest: bcs0
[189.877402] Dynamic subtest bcs0: SUCCESS (6.012s)
[189.889456] Starting dynamic subtest: vcs0
[195.829380] Dynamic subtest vcs0: SUCCESS (5.949s)
[195.841041] Starting dynamic subtest: vcs1
[200.820373] Dynamic subtest vcs1: SUCCESS (4.988s)
[200.831874] Starting dynamic subtest: vecs0
[205.813401] Dynamic subtest vecs0: SUCCESS (4.991s)
[205.824187] Starting dynamic subtest: ccs0
[210.869615] Dynamic subtest ccs0: SUCCESS (5.053s)
[210.872895] Subtest engine-error-state-capture: SUCCESS (30.148s)
[211.005303] [039/133] (808s left) kms_invalid_mode (zero-clock)
[211.121703] Starting subtest: zero-clock
[211.123872] Starting dynamic subtest: pipe-A-eDP-1
[211.408296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[211.417261] Starting dynamic subtest: pipe-B-eDP-1
[211.419156] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[211.426508] Starting dynamic subtest: pipe-C-eDP-1
[211.428595] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[211.437839] Starting dynamic subtest: pipe-D-eDP-1
[211.440789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[211.443828] Subtest zero-clock: SUCCESS (0.298s)
[212.275339] [040/133] (807s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[212.368930] Starting subtest: fbc-rgb565-draw-mmap-wc
[216.358557] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.994s)
[217.498745] [041/133] (802s left) kms_flip (2x-blocking-wf_vblank)
[217.591677] Starting subtest: 2x-blocking-wf_vblank
[217.601614] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[217.715579] [042/133] (802s left) gem_exec_fence (keep-in-fence)
[217.900346] Starting subtest: keep-in-fence
[217.902550] Starting dynamic subtest: rcs0
[217.956858] Dynamic subtest rcs0: SUCCESS (0.055s)
[217.965184] Starting dynamic subtest: bcs0
[218.009083] Dynamic subtest bcs0: SUCCESS (0.051s)
[218.019836] Starting dynamic subtest: vcs0
[219.864155] Dynamic subtest vcs0: SUCCESS (1.852s)
[219.874259] Starting dynamic subtest: vcs1
[221.912931] Dynamic subtest vcs1: SUCCESS (2.046s)
[221.924406] Starting dynamic subtest: vecs0
[223.894736] Dynamic subtest vecs0: SUCCESS (1.979s)
[223.906116] Starting dynamic subtest: ccs0
[224.127714] Dynamic subtest ccs0: SUCCESS (0.232s)
[224.130463] Subtest keep-in-fence: SUCCESS (6.228s)
[225.962515] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[225.965925] [043/133] (794s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[226.079765] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[226.084098] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[226.158584] [044/133] (793s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[226.261367] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[227.052058] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[227.224494] [045/133] (792s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[227.312707] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[227.316844] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[227.387825] [046/133] (792s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[227.477825] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[227.482083] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[227.548445] [047/133] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[227.653304] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[227.657256] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[227.756643] [048/133] (792s left) kms_cursor_crc (cursor-onscreen-256x85)
[228.023014] Starting subtest: cursor-onscreen-256x85
[228.078650] Subtest cursor-onscreen-256x85: SKIP (0.052s)
[228.247785] [049/133] (792s left) gem_pxp (regular-baseline-src-copy-readible)
[228.376946] Starting subtest: regular-baseline-src-copy-readible
[228.437012] Subtest regular-baseline-src-copy-readible: SUCCESS (0.062s)
[228.542787] [050/133] (791s left) gem_spin_batch (legacy-resubmit-new)
[228.602134] Starting subtest: legacy-resubmit-new
[228.604104] Starting dynamic subtest: default
[228.609107] Dynamic subtest default: SUCCESS (0.006s)
[228.617782] Starting dynamic subtest: render
[228.619693] Dynamic subtest render: SUCCESS (0.003s)
[228.627487] Starting dynamic subtest: bsd
[228.629448] Dynamic subtest bsd: SUCCESS (0.004s)
[228.637124] Starting dynamic subtest: bsd1
[228.638651] Dynamic subtest bsd1: SUCCESS (0.004s)
[228.646340] Starting dynamic subtest: bsd2
[228.648091] Dynamic subtest bsd2: SUCCESS (0.004s)
[228.656065] Starting dynamic subtest: blt
[228.657773] Dynamic subtest blt: SUCCESS (0.003s)
[228.665259] Starting dynamic subtest: vebox
[228.666970] Dynamic subtest vebox: SUCCESS (0.005s)
[228.668744] Subtest legacy-resubmit-new: SUCCESS (0.037s)
[229.948514] [051/133] (790s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[230.050192] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[230.054171] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[230.147756] [052/133] (790s left) kms_psr (pr-cursor-plane-move)
[230.245939] Starting subtest: pr-cursor-plane-move
[230.250151] Subtest pr-cursor-plane-move: SKIP (0.000s)
[230.320324] [053/133] (790s left) syncobj_wait (signal)
[230.375978] Starting subtest: signal
[230.378286] Subtest signal: SUCCESS (0.000s)
[230.460065] [054/133] (790s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[230.552273] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[230.556133] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[230.636217] [055/133] (789s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[230.737024] Starting subtest: fbc-1p-pri-indfb-multidraw
[243.971528] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.237s)
[245.404356] [056/133] (775s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[245.485617] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[245.488082] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[245.588012] [057/133] (775s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[245.693552] Starting subtest: x-tiled-64bpp-rotate-180
[247.283912] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[247.439138] [058/133] (773s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[247.504116] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[247.611826] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[247.684719] [059/133] (772s left) gem_ppgtt (blt-vs-render-ctx0)
[247.752487] Starting subtest: blt-vs-render-ctx0
[280.735404] Subtest blt-vs-render-ctx0: SUCCESS (32.982s)
[280.860105] [060/133] (739s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[280.996749] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[281.001160] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[282.174199] [061/133] (738s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[282.268155] Starting subtest: plane-scaler-unity-scaling-with-rotation
[282.270583] Starting dynamic subtest: pipe-A
[282.494365] Dynamic subtest pipe-A: SUCCESS (0.228s)
[282.504167] Starting dynamic subtest: pipe-B
[283.819724] Dynamic subtest pipe-B: SUCCESS (1.324s)
[283.828988] Starting dynamic subtest: pipe-C
[285.123537] Dynamic subtest pipe-C: SUCCESS (1.302s)
[285.132881] Starting dynamic subtest: pipe-D
[286.433273] Dynamic subtest pipe-D: SUCCESS (1.308s)
[286.435540] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.168s)
[287.586580] [062/133] (733s left) gem_ctx_sseu (engines)
[287.648414] Subtest engines: SKIP (0.000s)
[287.716612] [063/133] (733s left) perf_pmu (rc6)
[287.761415] Starting subtest: rc6
[287.763596] Starting dynamic subtest: gt0
[294.133676] Dynamic subtest gt0: SUCCESS (6.369s)
[294.146042] Starting dynamic subtest: runtime-pm-gt0
[301.857256] Dynamic subtest runtime-pm-gt0: SUCCESS (7.721s)
[301.869264] Starting dynamic subtest: runtime-pm-long-gt0
[314.305956] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.446s)
[314.317890] Starting dynamic subtest: other-idle-gt0
[320.649260] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[320.661540] Starting dynamic subtest: gt1
[326.990101] Dynamic subtest gt1: SUCCESS (6.338s)
[327.001949] Starting dynamic subtest: runtime-pm-gt1
[334.502888] Dynamic subtest runtime-pm-gt1: SUCCESS (7.510s)
[334.514865] Starting dynamic subtest: runtime-pm-long-gt1
[347.008647] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.503s)
[347.018667] Starting dynamic subtest: other-idle-gt1
[353.351571] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[353.354263] Subtest rc6: SUCCESS (65.588s)
[354.476194] [064/133] (666s left) prime_mmap (test_correct)
[354.528335] Starting subtest: test_correct
[354.530582] Starting dynamic subtest: test_correct-smem
[354.558964] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[354.561535] Subtest test_correct: SUCCESS (0.034s)
[354.642880] [065/133] (666s left) gem_exec_balancer (parallel-contexts)
[354.899669] Starting subtest: parallel-contexts
[358.095698] Subtest parallel-contexts: SUCCESS (3.196s)
[358.972586] [066/133] (662s left) perf_pmu (render-node-busy-idle)
[359.044786] Starting subtest: render-node-busy-idle
[359.047381] Starting dynamic subtest: rcs0
[359.718235] Dynamic subtest rcs0: SUCCESS (0.673s)
[359.728524] Starting dynamic subtest: bcs0
[360.394337] Dynamic subtest bcs0: SUCCESS (0.674s)
[360.406496] Starting dynamic subtest: vcs0
[361.943083] Dynamic subtest vcs0: SUCCESS (1.545s)
[361.955584] Starting dynamic subtest: vcs1
[363.863337] Dynamic subtest vcs1: SUCCESS (1.916s)
[363.876029] Starting dynamic subtest: vecs0
[365.910609] Dynamic subtest vecs0: SUCCESS (2.044s)
[365.922119] Starting dynamic subtest: ccs0
[366.572326] Dynamic subtest ccs0: SUCCESS (0.660s)
[366.574866] Subtest render-node-busy-idle: SUCCESS (7.529s)
[366.629268] [067/133] (654s left) kms_psr (psr-sprite-mmap-gtt)
[366.729877] Starting subtest: psr-sprite-mmap-gtt
[366.732371] Starting dynamic subtest: eDP-1
[368.158205] Dynamic subtest eDP-1: SKIP (1.424s)
[368.163059] Subtest psr-sprite-mmap-gtt: SKIP (1.427s)
[368.274922] [068/133] (652s left) kms_vblank (invalid)
[368.371914] Starting subtest: invalid
[368.373734] Starting dynamic subtest: pipe-A-eDP-1
[368.769547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[368.771979] Subtest invalid: SUCCESS (0.400s)
[369.547905] [069/133] (651s left) gen7_exec_parse (basic-allocation)
[369.608656] Subtest basic-allocation: SKIP (0.000s)
[369.681580] [070/133] (651s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[369.774075] Starting subtest: fbcpsr-tiling-linear
[376.261797] Subtest fbcpsr-tiling-linear: SUCCESS (6.490s)
[376.376816] [071/133] (644s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[376.478483] Starting subtest: fbc-indfb-scaledprimary
[379.372829] Subtest fbc-indfb-scaledprimary: SUCCESS (2.898s)
[380.545558] [072/133] (640s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[380.645667] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[380.650086] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[380.695667] [073/133] (640s left) kms_getfb (getfb2-handle-closed)
[380.795849] Starting subtest: getfb2-handle-closed
[380.798098] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[380.866257] [074/133] (640s left) kms_vblank (wait-forked)
[380.954338] Starting subtest: wait-forked
[380.956506] Starting dynamic subtest: pipe-A-eDP-1
[382.763431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[382.777464] Starting dynamic subtest: pipe-D-eDP-1
[385.232058] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[385.233878] Subtest wait-forked: SUCCESS (4.276s)
[386.044112] [075/133] (635s left) gem_reg_read (timestamp-moving)
[386.103049] Starting subtest: timestamp-moving
[387.103821] Subtest timestamp-moving: SUCCESS (1.001s)
[387.156814] [076/133] (634s left) kms_chamelium_frames (hdmi-aspect-ratio)
[387.541528] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[388.333953] [077/133] (633s left) prime_mmap (test_map_unmap)
[388.395876] Starting subtest: test_map_unmap
[388.398200] Starting dynamic subtest: test_map_unmap-smem
[388.428947] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[388.431427] Subtest test_map_unmap: SUCCESS (0.035s)
[388.543719] [078/133] (632s left) kms_async_flips (alternate-sync-async-flip)
[388.647168] Starting subtest: alternate-sync-async-flip
[389.032559] Starting dynamic subtest: pipe-A-eDP-1
[391.819756] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.788s)
[392.203904] Starting dynamic subtest: pipe-B-eDP-1
[395.010676] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.814s)
[395.392484] Starting dynamic subtest: pipe-C-eDP-1
[398.122138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.742s)
[398.490059] Starting dynamic subtest: pipe-D-eDP-1
[401.319215] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.836s)
[401.321245] Subtest alternate-sync-async-flip: SUCCESS (12.675s)
[402.543679] [079/133] (619s left) kms_pipe_crc_basic (read-crc)
[402.643371] Starting subtest: read-crc
[402.645710] Starting dynamic subtest: pipe-A-eDP-1
[403.356879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[403.368296] Starting dynamic subtest: pipe-B-eDP-1
[404.710582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s)
[404.719885] Starting dynamic subtest: pipe-C-eDP-1
[406.070549] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[406.080339] Starting dynamic subtest: pipe-D-eDP-1
[407.373766] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[407.376064] Subtest read-crc: SUCCESS (4.731s)
[408.146978] [080/133] (613s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[408.206092] Starting subtest: invalid-signal-one-illegal-handle
[408.208511] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[408.275620] [081/133] (613s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[408.364907] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[408.367128] Starting dynamic subtest: pipe-A-eDP-1
[408.389537] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.400943] Starting dynamic subtest: pipe-B-eDP-1
[408.422068] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.431134] Starting dynamic subtest: pipe-C-eDP-1
[408.452272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.461209] Starting dynamic subtest: pipe-D-eDP-1
[408.483156] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.487225] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[410.640249] [082/133] (611s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[410.690518] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[410.692668] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[410.777401] [083/133] (610s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[410.865732] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[410.868263] Starting dynamic subtest: pipe-A-eDP-1
[410.890595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[410.901261] Starting dynamic subtest: pipe-B-eDP-1
[410.921289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[410.930279] Starting dynamic subtest: pipe-C-eDP-1
[410.950978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[410.959596] Starting dynamic subtest: pipe-D-eDP-1
[410.982207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[410.986752] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[413.139473] [084/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[413.228420] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[413.232831] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[413.297939] [085/133] (608s left) kms_flip (2x-plain-flip-fb-recreate)
[413.399361] Starting subtest: 2x-plain-flip-fb-recreate
[413.411073] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[413.468943] [086/133] (608s left) gem_mmap_gtt (basic-read-write)
[413.531668] Subtest basic-read-write: SKIP (0.000s)
[413.595871] [087/133] (608s left) gem_exec_schedule (preempt-user)
[413.684437] Starting subtest: preempt-user
[413.686613] Starting dynamic subtest: rcs0
[413.732324] Dynamic subtest rcs0: SUCCESS (0.049s)
[413.744844] Starting dynamic subtest: bcs0
[413.755953] Dynamic subtest bcs0: SUCCESS (0.023s)
[413.764857] Starting dynamic subtest: vcs0
[413.775668] Dynamic subtest vcs0: SUCCESS (0.019s)
[413.784482] Starting dynamic subtest: vcs1
[413.796717] Dynamic subtest vcs1: SUCCESS (0.020s)
[413.808560] Starting dynamic subtest: vecs0
[413.816815] Dynamic subtest vecs0: SUCCESS (0.019s)
[413.825466] Starting dynamic subtest: ccs0
[413.836954] Dynamic subtest ccs0: SUCCESS (0.019s)
[413.839226] Subtest preempt-user: SUCCESS (0.156s)
[414.926069] [088/133] (607s left) api_intel_allocator (two-level-inception-interruptible)
[414.993642] Starting subtest: two-level-inception-interruptible
[420.402660] Subtest two-level-inception-interruptible: SUCCESS (5.410s)
[420.511219] [089/133] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[420.617126] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[420.621160] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[420.713435] [090/133] (601s left) gem_exec_nop (basic-series)
[420.791901] Starting subtest: basic-series
[436.889995] Subtest basic-series: SUCCESS (16.106s)
[437.087467] [091/133] (584s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[437.136230] Starting subtest: multi-wait-all-for-submit-signaled
[437.138486] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[437.211870] [092/133] (584s left) gem_readwrite (read-write)
[437.276741] Subtest read-write: SKIP (0.000s)
[437.347128] [093/133] (584s left) dmabuf (all-tests)
[437.383613] Starting subtest: all-tests
[437.385805] Starting dynamic subtest: sanitycheck
[437.540975] Dynamic subtest sanitycheck: SUCCESS (0.155s)
[437.553266] Starting dynamic subtest: dma_fence
[437.742060] Dynamic subtest dma_fence: SUCCESS (0.199s)
[437.754630] Starting dynamic subtest: dma_fence_chain
[446.989672] Dynamic subtest dma_fence_chain: SUCCESS (9.244s)
[447.001622] Starting dynamic subtest: dma_fence_unwrap
[447.072738] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s)
[447.085078] Starting dynamic subtest: dma_resv
[447.154558] Dynamic subtest dma_resv: SUCCESS (0.080s)
[447.157089] Subtest all-tests: SUCCESS (9.771s)
[447.198988] [094/133] (574s left) i915_drm_fdinfo (idle)
[447.244758] Starting subtest: idle
[447.247052] Starting dynamic subtest: rcs0
[447.807331] Dynamic subtest rcs0: SUCCESS (0.563s)
[447.819908] Starting dynamic subtest: bcs0
[448.314318] Dynamic subtest bcs0: SUCCESS (0.503s)
[448.325916] Starting dynamic subtest: vcs0
[448.819949] Dynamic subtest vcs0: SUCCESS (0.503s)
[448.830794] Starting dynamic subtest: vcs1
[449.325106] Dynamic subtest vcs1: SUCCESS (0.503s)
[449.336075] Starting dynamic subtest: vecs0
[449.830946] Dynamic subtest vecs0: SUCCESS (0.503s)
[449.842697] Starting dynamic subtest: ccs0
[450.337467] Dynamic subtest ccs0: SUCCESS (0.503s)
[450.340243] Subtest idle: SUCCESS (3.094s)
[450.393804] [095/133] (571s left) kms_cursor_crc (cursor-sliding-128x128)
[450.598201] Starting subtest: cursor-sliding-128x128
[450.600484] Starting dynamic subtest: pipe-A-eDP-1
[453.844991] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.242s)
[453.875460] Starting dynamic subtest: pipe-D-eDP-1
[457.721889] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.854s)
[457.724159] Subtest cursor-sliding-128x128: SUCCESS (7.122s)
[458.530881] [096/133] (563s left) i915_pm_rc6_residency (rc6-fence)
[458.595164] Starting subtest: rc6-fence
[458.617052] Starting dynamic subtest: gt0
[471.899020] Dynamic subtest gt0: SUCCESS (13.281s)
[471.911310] Starting dynamic subtest: gt1
[485.910036] Dynamic subtest gt1: SUCCESS (14.008s)
[485.913212] Subtest rc6-fence: SUCCESS (27.317s)
[485.971025] [097/133] (536s left) gem_pxp (fail-invalid-protected-context)
[486.077609] Starting subtest: fail-invalid-protected-context
[486.079988] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[486.165257] [098/133] (536s left) gen9_exec_parse (bb-oversize)
[486.243752] Subtest bb-oversize: SKIP (0.000s)
[486.332933] [099/133] (536s left) gem_userptr_blits (map-fixed-invalidate)
[486.400690] Starting subtest: map-fixed-invalidate
[486.404865] Subtest map-fixed-invalidate: SKIP (0.000s)
[486.513720] [100/133] (535s left) sw_sync (alloc_fence)
[486.558071] Starting subtest: alloc_fence
[486.560391] Subtest alloc_fence: SUCCESS (0.000s)
[486.601924] [101/133] (535s left) kms_atomic_interruptible (legacy-cursor)
[486.706973] Starting subtest: legacy-cursor
[486.709402] Starting dynamic subtest: pipe-A-eDP-1
[494.131696] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.424s)
[494.134125] Subtest legacy-cursor: SUCCESS (7.426s)
[494.927955] [102/133] (527s left) gem_pread (snoop)
[494.988882] Subtest snoop: SKIP (0.000s)
[495.064291] [103/133] (527s left) syncobj_timeline (signal-point-0)
[495.123969] Starting subtest: signal-point-0
[495.126066] Subtest signal-point-0: SUCCESS (0.000s)
[495.207271] [104/133] (527s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[495.304884] Starting subtest: pr-primary-plane-update-sf-dmg-area
[495.309014] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[495.351122] [105/133] (527s left) i915_suspend (fence-restore-tiled2untiled)
[495.407353] Starting subtest: fence-restore-tiled2untiled
[495.411693] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[495.481415] [106/133] (527s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[495.578429] Starting subtest: psr-rgb565-draw-render
[502.564558] Subtest psr-rgb565-draw-render: SUCCESS (6.988s)
[502.676855] [107/133] (520s left) vgem_basic (busy-fence)
[502.719951] Starting subtest: busy-fence
[502.722040] Subtest busy-fence: SUCCESS (0.000s)
[502.763958] [108/133] (520s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[502.881498] Starting subtest: cursorB-vs-flipA-legacy
[502.886063] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[503.003528] [109/133] (519s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[503.105859] Starting subtest: fbc-pr-sprite-mmap-gtt
[503.110260] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[503.156967] [110/133] (519s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[503.268238] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[507.224163] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.960s)
[508.325746] [111/133] (514s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[508.439211] Starting subtest: yf-tiled-32bpp-rotate-180
[508.443680] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[508.499447] [112/133] (514s left) kms_async_flips (test-cursor)
[508.608244] Starting subtest: test-cursor
[508.984506] Starting dynamic subtest: pipe-A-eDP-1
[509.807056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[510.188104] Starting dynamic subtest: pipe-B-eDP-1
[511.002445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.824s)
[511.382298] Starting dynamic subtest: pipe-C-eDP-1
[512.205422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.830s)
[512.576043] Starting dynamic subtest: pipe-D-eDP-1
[513.324739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.756s)
[513.326901] Subtest test-cursor: SUCCESS (4.718s)
[514.528104] [113/133] (508s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[514.599743] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[514.666523] [114/133] (508s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[514.774531] Starting subtest: cursor-vs-flip-legacy
[544.192289] Subtest cursor-vs-flip-legacy: SUCCESS (29.415s)
[545.021185] [115/133] (478s left) gem_exec_params (dr4-dirt)
[545.086399] Starting subtest: DR4-dirt
[545.088595] Subtest DR4-dirt: SUCCESS (0.000s)
[545.160464] [116/133] (477s left) kms_pm_rpm (pm-tiling)
[547.094632] Starting subtest: pm-tiling
[547.099567] Subtest pm-tiling: SKIP (0.000s)
[547.439683] [117/133] (475s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[547.541888] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[547.546369] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[547.626589] [118/133] (475s left) kms_psr (fbc-psr-primary-mmap-gtt)
[547.719669] Starting subtest: fbc-psr-primary-mmap-gtt
[547.721795] Starting dynamic subtest: eDP-1
[547.725721] Dynamic subtest eDP-1: SKIP (0.000s)
[547.729665] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[547.769847] [119/133] (475s left) api_intel_bb (destroy-bb)
[547.832180] Starting subtest: destroy-bb
[547.841339] Subtest destroy-bb: SUCCESS (0.010s)
[547.966912] [120/133] (475s left) kms_rotation_crc (exhaust-fences)
[548.077633] Starting subtest: exhaust-fences
[548.082094] Subtest exhaust-fences: SKIP (0.000s)
[548.126458] [121/133] (475s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[548.214472] Starting subtest: y-tiled-16bpp-rotate-90
[548.218715] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[548.287901] [122/133] (475s left) gem_ctx_persistence (smoketest)
[548.338321] Starting subtest: smoketest
[588.853525] Subtest smoketest: SUCCESS (40.511s)
[588.907948] [123/133] (434s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[589.005024] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[589.007427] Starting dynamic subtest: pipe-A
[589.340709] Dynamic subtest pipe-A: SUCCESS (0.338s)
[589.350433] Starting dynamic subtest: pipe-B
[590.793975] Dynamic subtest pipe-B: SUCCESS (1.453s)
[590.804457] Starting dynamic subtest: pipe-C
[592.199396] Dynamic subtest pipe-C: SUCCESS (1.404s)
[592.209706] Starting dynamic subtest: pipe-D
[593.601596] Dynamic subtest pipe-D: SUCCESS (1.401s)
[593.603860] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.600s)
[594.734410] [124/133] (428s left) syncobj_timeline (etime-single-wait-all-submitted)
[594.794667] Starting subtest: etime-single-wait-all-submitted
[594.898384] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[594.954394] [125/133] (428s left) gem_exec_balancer (parallel)
[595.230500] Starting subtest: parallel
[596.169798] Subtest parallel: SUCCESS (0.939s)
[596.911513] [126/133] (426s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[597.023760] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[604.486154] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.467s)
[604.600081] [127/133] (418s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[604.706555] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[604.710710] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[604.777255] [128/133] (418s left) gem_mmap_offset (clear-via-pagefault)
[604.830090] Starting subtest: clear-via-pagefault
[604.832018] Starting dynamic subtest: smem0
[784.869602] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[843.661055] Closing watchdogs
[843.662308] Initializing watchdogs
[843.662337]   /dev/watchdog0
[843.678279] [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]
[843.684108] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[843.685286] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[843.685700] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[843.689583] [129/133] (179s left) kms_psr (psr2-cursor-render)
[843.800834] Starting subtest: psr2-cursor-render
[843.803189] Starting dynamic subtest: eDP-1
[845.454559] Dynamic subtest eDP-1: SUCCESS (1.652s)
[845.456809] Subtest psr2-cursor-render: SUCCESS (1.653s)
[846.304388] [130/133] (177s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[846.400085] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[846.404162] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[846.459877] [131/133] (177s left) gem_create (create-ext-cpu-access-sanity-check)
[846.637457] Starting subtest: create-ext-cpu-access-sanity-check
[846.642103] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[846.685651] [132/133] (177s left) gem_userptr_blits (readonly-pwrite-unsync)
[846.753051] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[846.840787] [133/133] (177s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[846.928962] Starting subtest: fb-8bpc-vs-panel-6bpc
[846.931275] Starting dynamic subtest: pipe-A-eDP-1
[848.356762] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.427s)
[848.358738] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.428s)
[849.188780] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_force_connector_basic
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_pm_dc
results: parsing output: 5/ for test: gem_bad_reloc
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_cursor_edge_walk
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_exercise_blt
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_draw_crc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_exec_create
results: parsing output: 27/ for test: prime_self_import
results: parsing output: 28/ for test: kms_prop_blob
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: gem_lmem_swapping
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: sriov_basic
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_color_pipeline
results: parsing output: 37/ for test: i915_hangman
results: parsing output: 38/ for test: kms_invalid_mode
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_plane
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: kms_plane
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: gem_spin_batch
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_ppgtt
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_plane_scaling
results: parsing output: 61/ for test: gem_ctx_sseu
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: prime_mmap
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_getfb
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: gem_reg_read
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_async_flips
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: api_intel_allocator
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_nop
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_readwrite
results: parsing output: 92/ for test: dmabuf
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: i915_pm_rc6_residency
results: parsing output: 96/ for test: gem_pxp
results: parsing output: 97/ for test: gen9_exec_parse
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: gem_pread
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: i915_suspend
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: vgem_basic
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: gem_mmap_wc
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: kms_pm_rpm
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_create
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: kms_dither
Done.