[58.145693] Initializing watchdogs
[58.145741]   /dev/watchdog0
[58.160461] [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]
[58.165097] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.167278] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.170585] [001/134] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[63.225115] Starting subtest: pr-overlay-plane-move-continuous-sf
[63.229509] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[64.081050] [002/134] (954s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[64.175554] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[64.180126] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[64.296834] [003/134] (954s left) kms_getfb (getfb-reject-nv12)
[64.394043] Starting subtest: getfb-reject-nv12
[64.396395] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[64.511981] [004/134] (954s left) kms_cursor_crc (cursor-offscreen-512x170)
[64.793580] Starting subtest: cursor-offscreen-512x170
[64.797340] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[64.956079] [005/134] (953s left) gem_exec_params (dr1-dirt)
[65.032571] Starting subtest: DR1-dirt
[65.034580] Subtest DR1-dirt: SUCCESS (0.000s)
[65.150435] [006/134] (953s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[65.212873] Subtest writes-after-reads: SKIP (0.000s)
[65.306869] [007/134] (953s left) kms_psr (pr-sprite-blt)
[65.398260] Starting subtest: pr-sprite-blt
[65.401929] Subtest pr-sprite-blt: SKIP (0.000s)
[65.489559] [008/134] (953s left) i915_query (query-regions-unallocated)
[65.546052] Starting subtest: query-regions-unallocated
[65.547800] Subtest query-regions-unallocated: SUCCESS (0.000s)
[65.663771] [009/134] (953s left) gem_exec_suspend (basic-s0)
[65.739299] Starting subtest: basic-S0
[65.741193] Starting dynamic subtest: smem
[85.929271] Dynamic subtest smem: SUCCESS (6.154s)
[85.932222] Subtest basic-S0: SUCCESS (6.155s)
[95.152224] [010/134] (932s left) i915_drm_fdinfo (memory-info-purgeable)
[95.212421] Starting subtest: memory-info-purgeable
[95.214843] Starting dynamic subtest: smem0
[97.811772] Dynamic subtest smem0: SUCCESS (2.599s)
[97.813771] Subtest memory-info-purgeable: SUCCESS (2.599s)
[97.905131] [011/134] (930s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-mmap-cpu)
[98.031765] Starting subtest: fbcpsr-abgr161616f-draw-mmap-cpu
[98.035182] Subtest fbcpsr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[98.171503] [012/134] (929s left) kms_prime (d3hot)
[98.252602] Subtest D3hot: SKIP (0.000s)
[98.413379] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[98.415958] [013/134] (929s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[98.512472] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[98.514242] Starting dynamic subtest: pipe-A-eDP-1
[98.803133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.267s)
[98.810995] Starting dynamic subtest: pipe-B-eDP-1
[100.109896] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s)
[100.118643] Starting dynamic subtest: pipe-C-eDP-1
[101.311480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[101.320002] Starting dynamic subtest: pipe-D-eDP-1
[102.536736] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[102.539327] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.994s)
[103.678224] [014/134] (924s left) perf_pmu (most-busy-idle-check-all)
[103.725174] Starting subtest: most-busy-idle-check-all
[103.727365] Starting dynamic subtest: rcs0
[104.937413] Dynamic subtest rcs0: SUCCESS (1.211s)
[104.949548] Starting dynamic subtest: bcs0
[106.922268] Dynamic subtest bcs0: SUCCESS (1.983s)
[106.933357] Starting dynamic subtest: vcs0
[108.969136] Dynamic subtest vcs0: SUCCESS (2.046s)
[108.980557] Starting dynamic subtest: vcs1
[110.954127] Dynamic subtest vcs1: SUCCESS (1.984s)
[110.965370] Starting dynamic subtest: vecs0
[112.937517] Dynamic subtest vecs0: SUCCESS (1.982s)
[112.948903] Starting dynamic subtest: ccs0
[114.922463] Dynamic subtest ccs0: SUCCESS (1.984s)
[114.925507] Subtest most-busy-idle-check-all: SUCCESS (11.196s)
[115.055499] [015/134] (913s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[115.102466] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[115.104553] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[115.232754] [016/134] (913s left) syncobj_wait (invalid-signal-one-illegal-handle)
[115.299636] Starting subtest: invalid-signal-one-illegal-handle
[115.301951] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[115.436713] [017/134] (912s left) perf_pmu (frequency)
[115.478713] Starting subtest: frequency
[115.483256] Starting dynamic subtest: gt0
[117.669077] Dynamic subtest gt0: SUCCESS (2.183s)
[117.678932] Starting dynamic subtest: idle-gt0
[118.205701] Dynamic subtest idle-gt0: SUCCESS (0.536s)
[118.216777] Starting dynamic subtest: gt1
[122.906614] Dynamic subtest gt1: SUCCESS (4.696s)
[122.916846] Starting dynamic subtest: idle-gt1
[123.449215] Dynamic subtest idle-gt1: SUCCESS (0.542s)
[123.452313] Subtest frequency: SUCCESS (7.969s)
[123.577167] [018/134] (904s left) prime_mmap (test_forked_cpu_write)
[123.632510] Starting subtest: test_forked_cpu_write
[123.634917] Starting dynamic subtest: test_forked_cpu_write-smem
[123.639508] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[123.641885] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[123.778435] [019/134] (904s left) kms_flip (basic-flip-vs-wf_vblank)
[123.895837] Starting subtest: basic-flip-vs-wf_vblank
[123.898244] Starting dynamic subtest: A-eDP1
[125.815481] Dynamic subtest A-eDP1: SUCCESS (1.918s)
[125.823774] Starting dynamic subtest: B-eDP1
[127.750960] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[127.760916] Starting dynamic subtest: C-eDP1
[129.673270] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[129.683791] Starting dynamic subtest: D-eDP1
[131.609726] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[131.615126] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.718s)
[132.869396] [020/134] (895s left) gem_mmap_gtt (basic-small-bo)
[132.932307] Subtest basic-small-bo: SKIP (0.000s)
[133.003115] [021/134] (895s left) i915_hangman (hangcheck-unterminated)
[133.071015] Starting subtest: hangcheck-unterminated
[144.842069] Subtest hangcheck-unterminated: SUCCESS (11.767s)
[144.990791] [022/134] (883s left) kms_setmode (invalid-clone-single-crtc-stealing)
[145.055145] Starting subtest: invalid-clone-single-crtc-stealing
[145.061725] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[145.196997] [023/134] (883s left) kms_frontbuffer_tracking (fbc-suspend)
[145.324968] Starting subtest: fbc-suspend
[183.935232] Subtest fbc-suspend: SUCCESS (8.297s)
[192.222028] [024/134] (843s left) syncobj_timeline (invalid-transfer-non-existent-point)
[192.296302] Starting subtest: invalid-transfer-non-existent-point
[192.298656] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[192.423127] [025/134] (843s left) kms_psr (fbc-pr-cursor-render)
[192.519995] Starting subtest: fbc-pr-cursor-render
[192.524064] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[192.617884] [026/134] (843s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[192.711111] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[192.713449] Starting dynamic subtest: pipe-A-eDP-1
[192.736598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.747646] Starting dynamic subtest: pipe-B-eDP-1
[192.769181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.777885] Starting dynamic subtest: pipe-C-eDP-1
[192.799443] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.807925] Starting dynamic subtest: pipe-D-eDP-1
[192.829629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.833514] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[195.000446] [027/134] (840s left) kms_pm_rpm (pm-tiling)
[196.526142] Starting subtest: pm-tiling
[196.531049] Subtest pm-tiling: SKIP (0.000s)
[197.255491] [028/134] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[197.360528] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[197.364681] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[197.498953] [029/134] (838s left) kms_atomic (crtc-invalid-params)
[197.594080] Starting subtest: crtc-invalid-params
[197.596460] Starting dynamic subtest: pipe-A-eDP-1
[197.969507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[197.971820] Subtest crtc-invalid-params: SUCCESS (0.377s)
[198.795888] [030/134] (837s left) i915_pm_rpm (gem-pread)
[200.419757] Starting subtest: gem-pread
[202.696004] Subtest gem-pread: SUCCESS (2.276s)
[202.837507] [031/134] (833s left) kms_draw_crc (draw-method-render)
[202.933403] Starting subtest: draw-method-render
[202.935638] Starting dynamic subtest: xrgb8888-untiled
[203.209977] Dynamic subtest xrgb8888-untiled: SUCCESS (0.277s)
[203.220472] Starting dynamic subtest: rgb565-untiled
[203.442936] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[203.452042] Starting dynamic subtest: xrgb2101010-untiled
[203.676555] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[203.685871] Starting dynamic subtest: xbgr16161616f-untiled
[203.920622] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[203.930011] Starting dynamic subtest: xrgb8888-xtiled
[204.054068] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[204.062552] Starting dynamic subtest: rgb565-xtiled
[204.176528] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[204.186393] Starting dynamic subtest: xrgb2101010-xtiled
[204.298794] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[204.308734] Starting dynamic subtest: xbgr16161616f-xtiled
[204.432191] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[204.441914] Starting dynamic subtest: xrgb8888-4tiled
[204.565517] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[204.574558] Starting dynamic subtest: rgb565-4tiled
[204.687769] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[204.697025] Starting dynamic subtest: xrgb2101010-4tiled
[204.810117] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[204.818713] Starting dynamic subtest: xbgr16161616f-4tiled
[204.943969] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[204.946127] Subtest draw-method-render: SUCCESS (2.011s)
[205.109644] [032/134] (830s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[205.221395] Starting subtest: fbc-rgb565-draw-mmap-wc
[209.303268] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.082s)
[210.479830] [033/134] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[210.593483] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[210.597809] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[210.729257] [034/134] (825s left) kms_psr (fbc-psr2-primary-render)
[210.831790] Starting subtest: fbc-psr2-primary-render
[210.833923] Starting dynamic subtest: eDP-1
[210.837860] Dynamic subtest eDP-1: SKIP (0.000s)
[210.841836] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[210.929397] [035/134] (825s left) perf (low-oa-exponent-permissions)
[211.063385] Starting subtest: low-oa-exponent-permissions
[211.098490] Subtest low-oa-exponent-permissions: SUCCESS (0.034s)
[211.147742] [036/134] (825s left) gem_exec_schedule (noreorder)
[211.327282] Starting subtest: noreorder
[211.329773] Starting dynamic subtest: rcs0
[211.419982] Dynamic subtest rcs0: SUCCESS (0.091s)
[211.431962] Starting dynamic subtest: vcs0
[213.250188] Dynamic subtest vcs0: SUCCESS (1.827s)
[213.262144] Starting dynamic subtest: vcs1
[215.236120] Dynamic subtest vcs1: SUCCESS (1.983s)
[215.247918] Starting dynamic subtest: vecs0
[217.302660] Dynamic subtest vecs0: SUCCESS (2.012s)
[217.312396] Starting dynamic subtest: ccs0
[217.353297] Dynamic subtest ccs0: SUCCESS (0.103s)
[217.355979] Subtest noreorder: SUCCESS (6.025s)
[217.566199] [037/134] (818s left) gem_exec_capture (userptr)
[217.631144] Starting subtest: userptr
[218.477872] Subtest userptr: SUCCESS (0.843s)
[218.657202] [038/134] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[218.756695] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[218.761150] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[218.907240] [039/134] (817s left) syncobj_wait (single-wait-signaled)
[218.961124] Starting subtest: single-wait-signaled
[218.963728] Subtest single-wait-signaled: SUCCESS (0.000s)
[219.095171] [040/134] (817s left) gem_exec_reloc (basic-cpu-read-noreloc)
[219.159156] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[219.234002] [041/134] (817s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[219.330246] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[219.338949] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[219.486138] [042/134] (816s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[219.611644] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[219.615481] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[219.783103] [043/134] (816s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[219.839773] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[219.944232] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[220.043107] [044/134] (816s left) gem_huc_copy (huc-copy)
[220.111199] Starting subtest: huc-copy
[220.113899] Subtest huc-copy: SUCCESS (0.003s)
[220.285244] [045/134] (816s left) gem_exec_balancer (individual)
[220.357051] Starting subtest: individual
[222.271160] Subtest individual: SUCCESS (1.916s)
[222.636615] [046/134] (813s left) kms_selftest (drm_plane_helper)
[222.679089] Starting subtest: drm_plane_helper
[222.690538] Starting dynamic subtest: drm_test_check_plane_state
[222.814633] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.122s)
[222.825291] Starting dynamic subtest: drm_test_check_invalid_plane_state
[222.949995] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.136s)
[222.952285] Subtest drm_plane_helper: SUCCESS (0.271s)
[223.174866] [047/134] (813s left) kms_big_fb (linear-16bpp-rotate-180)
[223.288539] Starting subtest: linear-16bpp-rotate-180
[224.612292] Subtest linear-16bpp-rotate-180: SUCCESS (1.323s)
[224.782313] [048/134] (811s left) syncobj_timeline (wait-zero-handles)
[224.829757] Starting subtest: wait-zero-handles
[224.831820] Subtest wait-zero-handles: SUCCESS (0.000s)
[224.954770] [049/134] (811s left) gem_spin_batch (legacy-resubmit-new)
[225.023689] Starting subtest: legacy-resubmit-new
[225.025644] Starting dynamic subtest: default
[225.032383] Dynamic subtest default: SUCCESS (0.008s)
[225.041112] Starting dynamic subtest: render
[225.042650] Dynamic subtest render: SUCCESS (0.003s)
[225.051515] Starting dynamic subtest: bsd
[225.053344] Dynamic subtest bsd: SUCCESS (0.003s)
[225.062158] Starting dynamic subtest: bsd1
[225.063867] Dynamic subtest bsd1: SUCCESS (0.004s)
[225.072105] Starting dynamic subtest: bsd2
[225.073849] Dynamic subtest bsd2: SUCCESS (0.002s)
[225.082062] Starting dynamic subtest: blt
[225.083789] Dynamic subtest blt: SUCCESS (0.005s)
[225.091864] Starting dynamic subtest: vebox
[225.093591] Dynamic subtest vebox: SUCCESS (0.004s)
[225.095287] Subtest legacy-resubmit-new: SUCCESS (0.033s)
[226.322272] [050/134] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[226.425360] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[226.429339] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[226.566164] [051/134] (810s left) kms_vblank (query-idle)
[226.662542] Starting subtest: query-idle
[226.664478] Starting dynamic subtest: pipe-A-eDP-1
[228.406520] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.744s)
[228.421550] Starting dynamic subtest: pipe-D-eDP-1
[230.882422] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.472s)
[230.884990] Subtest query-idle: SUCCESS (4.220s)
[231.734876] [052/134] (805s left) gem_ctx_exec (basic-invalid-context)
[231.796418] Starting subtest: basic-invalid-context
[231.801188] Subtest basic-invalid-context: SUCCESS (0.005s)
[231.975529] [053/134] (804s left) kms_flip (2x-flip-vs-panning-interruptible)
[232.074463] Starting subtest: 2x-flip-vs-panning-interruptible
[232.086297] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[232.230523] [054/134] (804s left) kms_pm_dc (dc6-psr)
[233.339305] Starting subtest: dc6-psr
[236.219844] Subtest dc6-psr: SUCCESS (2.878s)
[237.059877] [055/134] (799s left) kms_color (invalid-degamma-lut-sizes)
[237.175005] Starting subtest: invalid-degamma-lut-sizes
[237.177314] Starting dynamic subtest: pipe-A
[237.461312] Dynamic subtest pipe-A: SUCCESS (0.288s)
[237.471154] Starting dynamic subtest: pipe-B
[237.473551] Dynamic subtest pipe-B: SUCCESS (0.000s)
[237.482708] Starting dynamic subtest: pipe-C
[237.485104] Dynamic subtest pipe-C: SUCCESS (0.000s)
[237.494088] Starting dynamic subtest: pipe-D
[237.496233] Dynamic subtest pipe-D: SUCCESS (0.000s)
[237.498202] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[238.295266] [056/134] (798s left) kms_plane_lowres (tiling-yf)
[238.394148] Starting subtest: tiling-yf
[238.398577] Subtest tiling-yf: SKIP (0.000s)
[238.495372] [057/134] (798s left) syncobj_wait (wait-for-submit-complex)
[238.569612] Starting subtest: wait-for-submit-complex
[238.631896] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[238.733583] [058/134] (798s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[238.798704] Starting subtest: single-wait-all-for-submit-signaled
[238.800708] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[238.914143] [059/134] (798s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[239.021879] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[245.537597] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.516s)
[245.690537] [060/134] (791s left) syncobj_wait (single-wait-all-for-submit-signaled)
[245.755446] Starting subtest: single-wait-all-for-submit-signaled
[245.757673] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[245.879013] [061/134] (791s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[245.984065] Starting subtest: yf-tiled-addfb-size-overflow
[245.988507] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[246.115538] [062/134] (791s left) kms_cursor_crc (cursor-random-128x128)
[246.359135] Starting subtest: cursor-random-128x128
[246.361398] Starting dynamic subtest: pipe-A-eDP-1
[249.712794] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[249.745399] Starting dynamic subtest: pipe-D-eDP-1
[253.690047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.953s)
[253.692394] Subtest cursor-random-128x128: SUCCESS (7.332s)
[254.573351] [063/134] (782s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[254.672980] Starting subtest: primary-yf-tiled-reflect-x-0
[254.733372] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[254.859140] [064/134] (782s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[259.908990] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[259.911228] Starting dynamic subtest: pipe-A-eDP-1
[271.948543] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.038s)
[271.957529] Starting dynamic subtest: pipe-B-eDP-1
[283.964375] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.010s)
[283.966604] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.054s)
[284.839393] [065/134] (752s left) gem_eio (in-flight-external)
[285.078712] Starting subtest: in-flight-external
[286.298702] Subtest in-flight-external: SUCCESS (1.218s)
[286.452053] [066/134] (751s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[286.550770] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[286.555107] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[286.681419] [067/134] (750s left) kms_content_protection (mei-interface)
[286.820979] Starting subtest: mei-interface
[286.825598] Subtest mei-interface: SKIP (0.001s)
[286.996976] [068/134] (750s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[287.089987] Starting subtest: plane-primary-toggle-with-vblank-wait
[287.092268] Starting dynamic subtest: pipe-A-eDP-1
[287.262646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[287.569570] Starting dynamic subtest: pipe-B-eDP-1
[288.513684] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.954s)
[288.820068] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.729s)
[289.692585] [069/134] (747s left) gem_render_copy (yf-tiled-ccs-to-linear)
[289.748976] Starting subtest: yf-tiled-ccs-to-linear
[289.753717] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[289.959443] [070/134] (747s left) kms_flip (2x-plain-flip-interruptible)
[290.068549] Starting subtest: 2x-plain-flip-interruptible
[290.080309] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[290.176353] [071/134] (747s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[290.270272] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[290.272193] Starting dynamic subtest: pipe-A-eDP-1
[291.015237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[291.026289] Starting dynamic subtest: pipe-B-eDP-1
[292.803480] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.787s)
[292.813224] Starting dynamic subtest: pipe-C-eDP-1
[294.632417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.827s)
[294.642727] Starting dynamic subtest: pipe-D-eDP-1
[296.461866] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.827s)
[296.463899] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.184s)
[297.613188] [072/134] (740s left) gem_exec_balancer (parallel-ordering)
[297.878931] Starting subtest: parallel-ordering
[298.792680] Subtest parallel-ordering: SUCCESS (0.914s)
[298.977028] [073/134] (738s left) prime_vgem (basic-fence-read)
[299.092868] Starting subtest: basic-fence-read
[299.109052] Subtest basic-fence-read: SKIP (0.014s)
[299.247621] [074/134] (738s left) gem_wait (write-wait)
[299.328606] Starting subtest: write-wait
[299.330818] Starting dynamic subtest: all-engines
[300.480515] Dynamic subtest all-engines: SUCCESS (1.154s)
[300.500184] Starting dynamic subtest: rcs0
[301.539747] Dynamic subtest rcs0: SUCCESS (1.057s)
[301.558028] Starting dynamic subtest: bcs0
[302.597890] Dynamic subtest bcs0: SUCCESS (1.056s)
[302.617115] Starting dynamic subtest: vcs0
[303.653697] Dynamic subtest vcs0: SUCCESS (1.053s)
[303.671087] Starting dynamic subtest: vcs1
[304.708504] Dynamic subtest vcs1: SUCCESS (1.052s)
[304.726498] Starting dynamic subtest: vecs0
[305.762895] Dynamic subtest vecs0: SUCCESS (1.052s)
[305.781182] Starting dynamic subtest: ccs0
[306.820431] Dynamic subtest ccs0: SUCCESS (1.055s)
[306.823005] Subtest write-wait: SUCCESS (7.495s)
[307.043627] [075/134] (730s left) kms_atomic_interruptible (legacy-pageflip)
[307.148063] Starting subtest: legacy-pageflip
[307.150313] Starting dynamic subtest: pipe-A-eDP-1
[314.612687] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.463s)
[314.615053] Subtest legacy-pageflip: SUCCESS (7.465s)
[315.457543] [076/134] (722s left) gem_partial_pwrite_pread (reads-snoop)
[315.533787] Subtest reads-snoop: SKIP (0.000s)
[315.603910] [077/134] (722s left) gen9_exec_parse (bb-start-far)
[315.657130] Subtest bb-start-far: SKIP (0.000s)
[315.725048] [078/134] (722s left) perf (unprivileged-single-ctx-counters)
[315.827063] Starting subtest: unprivileged-single-ctx-counters
[315.831695] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[315.872156] [079/134] (722s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[316.280991] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[317.057385] [080/134] (721s left) kms_lease (lease-again)
[317.146917] Starting subtest: lease-again
[317.149057] Starting dynamic subtest: pipe-A-eDP-1
[317.151511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.005s)
[317.162825] Starting dynamic subtest: pipe-B-eDP-1
[317.164718] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[317.173556] Starting dynamic subtest: pipe-C-eDP-1
[317.175420] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[317.184030] Starting dynamic subtest: pipe-D-eDP-1
[317.185845] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[317.187721] Subtest lease-again: SUCCESS (0.016s)
[317.324488] [081/134] (720s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[317.459859] Starting subtest: cursorA-vs-flipB-legacy
[317.464396] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[317.629493] [082/134] (720s left) kms_pipe_crc_basic (suspend-read-crc)
[317.729374] Starting subtest: suspend-read-crc
[317.731828] Starting dynamic subtest: pipe-A-eDP-1
[335.372505] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.982s)
[335.384060] Starting dynamic subtest: pipe-B-eDP-1
[354.390544] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.520s)
[354.404397] Starting dynamic subtest: pipe-C-eDP-1
[373.336136] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.528s)
[373.346988] Starting dynamic subtest: pipe-D-eDP-1
[392.333695] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.436s)
[392.335953] Subtest suspend-read-crc: SUCCESS (13.473s)
[401.207714] [083/134] (645s left) gem_busy (extended)
[401.419186] Starting subtest: extended
[401.421912] Starting dynamic subtest: rcs0
[401.537885] Dynamic subtest rcs0: SUCCESS (0.119s)
[401.550156] Starting dynamic subtest: bcs0
[401.583983] Dynamic subtest bcs0: SUCCESS (0.044s)
[401.594892] Starting dynamic subtest: vcs0
[403.358365] Dynamic subtest vcs0: SUCCESS (1.765s)
[403.371062] Starting dynamic subtest: vcs1
[405.458691] Dynamic subtest vcs1: SUCCESS (2.040s)
[405.470876] Starting dynamic subtest: vecs0
[407.390011] Dynamic subtest vecs0: SUCCESS (1.977s)
[407.402433] Starting dynamic subtest: ccs0
[407.433997] Dynamic subtest ccs0: SUCCESS (0.043s)
[407.436407] Subtest extended: SUCCESS (6.003s)
[407.720625] [084/134] (638s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[408.112874] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[408.887590] [085/134] (637s left) gem_exec_reloc (basic-write-read-active)
[408.941684] Subtest basic-write-read-active: SKIP (0.000s)
[409.030678] [086/134] (637s left) gem_ctx_shared (single-timeline)
[409.090603] Starting subtest: single-timeline
[409.111410] Subtest single-timeline: SUCCESS (0.014s)
[409.392240] [087/134] (637s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[409.501762] Starting subtest: psr-abgr161616f-draw-mmap-wc
[409.505886] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[409.612235] [088/134] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[409.712547] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[409.716895] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[409.834550] [089/134] (636s left) gem_tiled_blits (normal)
[409.903578] Subtest normal: SKIP (0.000s)
[409.992586] [090/134] (636s left) gem_ccs (large-ctrl-surf-copy)
[410.049479] Starting subtest: large-ctrl-surf-copy
[410.054173] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[410.176631] [091/134] (636s left) kms_plane (plane-panning-top-left)
[410.271399] Starting subtest: plane-panning-top-left
[410.272957] Starting dynamic subtest: pipe-A
[411.984589] Dynamic subtest pipe-A: SUCCESS (1.710s)
[411.995959] Starting dynamic subtest: pipe-B
[414.337468] Dynamic subtest pipe-B: SUCCESS (2.350s)
[414.339878] Subtest plane-panning-top-left: SUCCESS (4.063s)
[415.196704] [092/134] (631s left) gem_exec_fence (syncobj-channel)
[415.633446] Starting subtest: syncobj-channel
[416.649650] Subtest syncobj-channel: SUCCESS (1.015s)
[417.500549] [093/134] (629s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[417.620567] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[417.624815] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[417.783984] [094/134] (628s left) perf_pmu (interrupts)
[417.830864] Starting subtest: interrupts
[418.932561] Subtest interrupts: SUCCESS (1.100s)
[419.086355] [095/134] (627s left) kms_cursor_edge_walk (64x64-top-edge)
[419.188972] Starting subtest: 64x64-top-edge
[419.191239] Starting dynamic subtest: pipe-A-eDP-1
[422.639479] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[422.653169] Starting dynamic subtest: pipe-D-eDP-1
[425.767251] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[425.769521] Subtest 64x64-top-edge: SUCCESS (6.575s)
[426.591548] [096/134] (620s left) syncobj_eventfd (invalid-bad-flags)
[426.662861] Starting subtest: invalid-bad-flags
[426.665300] Subtest invalid-bad-flags: SUCCESS (0.000s)
[426.782620] [097/134] (620s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[426.876034] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[426.878286] Starting dynamic subtest: pipe-A-default-mode
[427.174904] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[427.179361] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.298s)
[428.021450] [098/134] (618s left) vgem_basic (bad-fence)
[428.069559] Starting subtest: bad-fence
[428.071796] Subtest bad-fence: SUCCESS (0.000s)
[428.154032] [099/134] (618s left) kms_flip (flip-vs-panning)
[428.243488] Starting subtest: flip-vs-panning
[428.245795] Starting dynamic subtest: A-eDP1
[437.006431] Dynamic subtest A-eDP1: SUCCESS (8.763s)
[437.033828] Starting dynamic subtest: B-eDP1
[445.730069] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[445.742171] Starting dynamic subtest: C-eDP1
[454.457954] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[454.468076] Starting dynamic subtest: D-eDP1
[463.196483] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[463.200988] Subtest flip-vs-panning: SUCCESS (34.958s)
[464.387228] [100/134] (582s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[464.505424] Starting subtest: 4-tiled-32bpp-rotate-180
[465.986577] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.481s)
[466.172587] [101/134] (580s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[466.278163] Starting subtest: yf-tiled-16bpp-rotate-0
[466.281997] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[466.413066] [102/134] (580s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[466.519405] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[466.521227] Starting dynamic subtest: pipe-A
[466.541607] Dynamic subtest pipe-A: SKIP (0.019s)
[466.551704] Starting dynamic subtest: pipe-B
[466.576217] Dynamic subtest pipe-B: SKIP (0.033s)
[466.585674] Starting dynamic subtest: pipe-C
[466.610961] Dynamic subtest pipe-C: SKIP (0.033s)
[466.620307] Starting dynamic subtest: pipe-D
[466.642786] Dynamic subtest pipe-D: SKIP (0.033s)
[466.646024] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.121s)
[466.783513] [103/134] (580s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[466.890406] Starting subtest: x-tiled-8bpp-rotate-90
[466.913007] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[467.064477] [104/134] (580s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[467.160467] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[471.425608] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.267s)
[472.592659] [105/134] (574s left) gem_media_fill (media-fill)
[472.665047] Subtest media-fill: SKIP (0.000s)
[472.805916] [106/134] (574s left) gem_exec_schedule (semaphore-user)
[472.888121] Starting subtest: semaphore-user
[472.941113] Subtest semaphore-user: SUCCESS (0.058s)
[474.461226] [107/134] (572s left) prime_self_import (basic-with_one_bo_two_files)
[474.499809] Starting subtest: basic-with_one_bo_two_files
[474.532378] Subtest basic-with_one_bo_two_files: SUCCESS (0.033s)
[474.685983] [108/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[474.795410] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[482.128409] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.332s)
[482.289061] [109/134] (565s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[482.351541] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[482.356171] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[482.556373] [110/134] (564s left) gem_mmap_offset (clear-via-pagefault)
[482.613564] Starting subtest: clear-via-pagefault
[482.615779] Starting dynamic subtest: smem0
[662.665148] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[667.466303] Closing watchdogs
[667.467491] Initializing watchdogs
[667.467522]   /dev/watchdog0
[667.486927] [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]
[667.493024] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[667.494615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[667.495053] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[667.498083] [111/134] (380s left) syncobj_wait (single-wait-all-submitted)
[667.570624] Starting subtest: single-wait-all-submitted
[667.674163] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[667.777664] [112/134] (379s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[667.883851] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[667.888025] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[668.014359] [113/134] (379s left) kms_display_modes (extended-mode-basic)
[668.120363] Starting subtest: extended-mode-basic
[668.124766] Subtest extended-mode-basic: SKIP (0.000s)
[668.167111] [114/134] (379s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[668.260092] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[672.499200] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.243s)
[673.736809] [115/134] (373s left) gem_sync (basic-all)
[673.814421] Starting subtest: basic-all
[677.342176] Subtest basic-all: SUCCESS (3.535s)
[677.546948] [116/134] (370s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[677.643190] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[677.645377] Starting dynamic subtest: pipe-A-eDP-1
[677.667543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[677.682749] Starting dynamic subtest: pipe-B-eDP-1
[677.703568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[677.712821] Starting dynamic subtest: pipe-C-eDP-1
[677.734145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[677.743059] Starting dynamic subtest: pipe-D-eDP-1
[677.764743] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[677.768787] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[679.906854] [117/134] (367s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[680.003917] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[680.008544] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[681.131435] [118/134] (366s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[681.224314] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[681.226748] Starting dynamic subtest: pipe-A-default-mode
[682.370255] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[682.374730] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.146s)
[682.550397] [119/134] (365s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[682.636796] Starting subtest: multiplane-rotation-cropping-bottom
[700.043777] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.405s)
[700.206802] [120/134] (347s left) gem_madvise (dontneed-before-exec)
[700.254117] Starting subtest: dontneed-before-exec
[700.273065] Subtest dontneed-before-exec: SKIP (0.018s)
[700.361488] [121/134] (347s left) gem_ctx_persistence (legacy-engines-persistence)
[700.422031] Starting subtest: legacy-engines-persistence
[700.424047] Starting dynamic subtest: render
[701.241020] Dynamic subtest render: SUCCESS (0.818s)
[701.256507] Starting dynamic subtest: bsd1
[702.030173] Dynamic subtest bsd1: SUCCESS (0.786s)
[702.042449] Starting dynamic subtest: bsd2
[702.858188] Dynamic subtest bsd2: SUCCESS (0.825s)
[702.870024] Starting dynamic subtest: blt
[703.742075] Dynamic subtest blt: SUCCESS (0.881s)
[703.757103] Starting dynamic subtest: vebox
[704.523961] Dynamic subtest vebox: SUCCESS (0.779s)
[704.526479] Subtest legacy-engines-persistence: SUCCESS (4.102s)
[704.687365] [122/134] (343s left) kms_psr (psr2-cursor-mmap-cpu)
[704.799097] Starting subtest: psr2-cursor-mmap-cpu
[704.801347] Starting dynamic subtest: eDP-1
[706.533703] Dynamic subtest eDP-1: SUCCESS (1.734s)
[706.535950] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.735s)
[707.360693] [123/134] (340s left) core_getclient (basic)
[707.421851] Starting subtest: basic
[707.423907] Subtest basic: SUCCESS (0.000s)
[707.534759] [124/134] (340s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[707.632806] Starting subtest: psr-rgb101010-draw-pwrite
[715.309186] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.679s)
[715.447875] [125/134] (332s left) gem_mmap_wc (bad-size)
[715.515086] Subtest bad-size: SKIP (0.000s)
[715.586566] [126/134] (332s left) api_intel_allocator (default-alignment)
[715.646793] Starting subtest: default-alignment
[715.649218] Subtest default-alignment: SUCCESS (0.003s)
[715.781032] [127/134] (332s left) kms_busy (basic-hang)
[715.891844] Starting subtest: basic-hang
[715.894007] Starting dynamic subtest: flip-pipe-A
[716.491249] Dynamic subtest flip-pipe-A: SUCCESS (0.599s)
[716.502492] Starting dynamic subtest: modeset-pipe-A
[719.877985] Dynamic subtest modeset-pipe-A: SUCCESS (3.384s)
[719.888029] Starting dynamic subtest: flip-pipe-D
[721.134730] Dynamic subtest flip-pipe-D: SUCCESS (1.255s)
[721.144578] Starting dynamic subtest: modeset-pipe-D
[724.618689] Dynamic subtest modeset-pipe-D: SUCCESS (3.482s)
[724.621079] Subtest basic-hang: SUCCESS (8.727s)
[725.449002] [128/134] (322s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[725.555689] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[725.560041] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[725.686493] [129/134] (322s left) prime_busy (after-wait)
[725.749908] Starting subtest: after-wait
[725.755726] Starting dynamic subtest: rcs0
[725.800798] Dynamic subtest rcs0: SUCCESS (0.048s)
[725.812658] Starting dynamic subtest: bcs0
[725.871235] Dynamic subtest bcs0: SUCCESS (0.069s)
[725.889696] Starting dynamic subtest: vcs0
[725.911947] Dynamic subtest vcs0: SUCCESS (0.040s)
[725.923581] Starting dynamic subtest: vcs1
[725.953984] Dynamic subtest vcs1: SUCCESS (0.041s)
[725.969790] Starting dynamic subtest: vecs0
[725.994892] Dynamic subtest vecs0: SUCCESS (0.039s)
[726.006280] Starting dynamic subtest: ccs0
[726.035547] Dynamic subtest ccs0: SUCCESS (0.040s)
[726.144350] Subtest after-wait: SUCCESS (0.392s)
[726.248240] [130/134] (322s left) core_setmaster (master-drop-set-user)
[726.336673] Starting subtest: master-drop-set-user
[726.350417] Subtest master-drop-set-user: SUCCESS (0.013s)
[726.389101] [131/134] (321s left) intel_hwmon (hwmon-write)
[726.452797] Subtest hwmon-write: SKIP (0.000s)
[726.524598] [132/134] (321s left) gem_exec_parallel (engines)
[726.592417] Starting subtest: engines
[726.594665] Starting dynamic subtest: basic
[728.350675] Dynamic subtest basic: SUCCESS (1.758s)
[728.362898] Starting dynamic subtest: contexts
[732.671574] Dynamic subtest contexts: SUCCESS (4.317s)
[732.683819] Starting dynamic subtest: fds
[736.531165] Dynamic subtest fds: SUCCESS (3.856s)
[736.543696] Starting dynamic subtest: userptr
[738.335021] Dynamic subtest userptr: SUCCESS (1.801s)
[738.337461] Subtest engines: SUCCESS (11.742s)
[738.556651] [133/134] (309s left) kms_addfb_basic (tile-pitch-mismatch)
[738.610729] Starting subtest: tile-pitch-mismatch
[738.614779] Subtest tile-pitch-mismatch: SKIP (0.000s)
[738.772380] [134/134] (309s left) kms_vrr (flip-basic-fastset)
[738.858902] Starting subtest: flip-basic-fastset
[738.865400] Subtest flip-basic-fastset: SKIP (0.000s)
[738.954866] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_getfb
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: i915_query
results: parsing output: 8/ for test: gem_exec_suspend
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_prime
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: i915_hangman
results: parsing output: 21/ for test: kms_setmode
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_atomic
results: parsing output: 29/ for test: i915_pm_rpm
results: parsing output: 30/ for test: kms_draw_crc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: gem_exec_capture
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_huc_copy
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_selftest
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_ctx_exec
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_pm_dc
results: parsing output: 54/ for test: kms_color
results: parsing output: 55/ for test: kms_plane_lowres
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_rotation_crc
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_atomic_transition
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: kms_atomic_interruptible
results: parsing output: 75/ for test: gem_partial_pwrite_pread
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_pipe_crc_basic
results: parsing output: 82/ for test: gem_busy
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: gem_ctx_shared
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_tiled_blits
results: parsing output: 89/ for test: gem_ccs
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_cursor_edge_walk
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_media_fill
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: prime_self_import
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_display_modes
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_sync
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: gem_madvise
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: core_getclient
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_mmap_wc
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: prime_busy
results: parsing output: 129/ for test: core_setmaster
results: parsing output: 130/ for test: intel_hwmon
results: parsing output: 131/ for test: gem_exec_parallel
results: parsing output: 132/ for test: kms_addfb_basic
results: parsing output: 133/ for test: kms_vrr
Done.