[60.855153] Initializing watchdogs
[60.855199]   /dev/watchdog0
[60.868836] [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]
[60.873185] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.875371] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.878846] [001/133] (960s left) kms_lease (invalid-create-leases)
[61.006791] Starting subtest: invalid-create-leases
[61.011653] Subtest invalid-create-leases: SUCCESS (0.005s)
[61.129356] [002/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[61.226175] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[61.262324] Starting dynamic subtest: pipe-A-plane-0
[61.696184] Dynamic subtest pipe-A-plane-0: SUCCESS (0.434s)
[61.708330] Starting dynamic subtest: pipe-A-plane-3
[61.962352] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[61.968876] Starting dynamic subtest: pipe-A-plane-5
[61.972529] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[63.120904] Starting dynamic subtest: pipe-B-plane-0
[63.514498] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[63.522272] Starting dynamic subtest: pipe-B-plane-3
[63.770245] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[63.777060] Starting dynamic subtest: pipe-B-plane-5
[63.781242] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[64.102403] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.873s)
[64.917963] [003/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[65.022631] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[65.027279] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[65.144210] [004/133] (956s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[65.235063] Starting subtest: fbc-pr-sprite-mmap-gtt
[65.239166] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[65.323727] [005/133] (956s left) gem_mmap_gtt (cpuset-basic-small-copy)
[65.373595] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[65.430024] [006/133] (956s left) gem_exec_whisper (basic-forked)
[65.502214] Starting subtest: basic-forked
[73.000931] Subtest basic-forked: SUCCESS (7.494s)
[73.191305] [007/133] (948s left) gem_lmem_swapping (parallel-random)
[73.234617] Subtest parallel-random: SKIP (0.000s)
[73.276257] [008/133] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[73.380154] Starting subtest: plane-downscale-factor-0-75-with-rotation
[73.382424] Starting dynamic subtest: pipe-A
[73.608637] Dynamic subtest pipe-A: SUCCESS (0.231s)
[73.617977] Starting dynamic subtest: pipe-B
[74.886636] Dynamic subtest pipe-B: SUCCESS (1.277s)
[74.895926] Starting dynamic subtest: pipe-C
[76.208930] Dynamic subtest pipe-C: SUCCESS (1.322s)
[76.217966] Starting dynamic subtest: pipe-D
[77.542446] Dynamic subtest pipe-D: SUCCESS (1.333s)
[77.544656] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.164s)
[78.733319] [009/133] (942s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[78.851490] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[78.853915] Starting dynamic subtest: pipe-A-eDP-1
[89.528827] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.681s)
[89.538459] Starting dynamic subtest: pipe-B-eDP-1
[100.915609] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.386s)
[100.918058] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.070s)
[101.783679] [010/133] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[101.889865] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[109.150958] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.264s)
[109.295042] [011/133] (912s left) gem_exec_fence (parallel)
[109.481829] Starting subtest: parallel
[109.484249] Starting dynamic subtest: rcs0
[111.631141] Dynamic subtest rcs0: SUCCESS (2.153s)
[111.641131] Starting dynamic subtest: bcs0
[113.782356] Dynamic subtest bcs0: SUCCESS (2.151s)
[113.791706] Starting dynamic subtest: vcs0
[115.936391] Dynamic subtest vcs0: SUCCESS (2.154s)
[115.946318] Starting dynamic subtest: vcs1
[118.085157] Dynamic subtest vcs1: SUCCESS (2.148s)
[118.095277] Starting dynamic subtest: vecs0
[120.234440] Dynamic subtest vecs0: SUCCESS (2.149s)
[120.246360] Starting dynamic subtest: ccs0
[122.382968] Dynamic subtest ccs0: SUCCESS (2.148s)
[122.385089] Subtest parallel: SUCCESS (12.905s)
[123.039844] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[123.042544] [012/133] (898s left) kms_cursor_edge_walk (64x64-right-edge)
[123.151714] Starting subtest: 64x64-right-edge
[123.154047] Starting dynamic subtest: pipe-A-eDP-1
[126.573201] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[126.582090] Starting dynamic subtest: pipe-D-eDP-1
[129.722818] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.149s)
[129.725259] Subtest 64x64-right-edge: SUCCESS (6.572s)
[130.527352] [013/133] (891s left) kms_color (deep-color)
[130.629248] Starting subtest: deep-color
[131.695047] Starting dynamic subtest: pipe-A-eDP-1-gamma
[132.472800] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.779s)
[132.481150] Starting dynamic subtest: pipe-A-eDP-1-degamma
[133.873274] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.400s)
[133.881818] Starting dynamic subtest: pipe-A-eDP-1-ctm
[135.301450] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.427s)
[136.093254] Starting dynamic subtest: pipe-B-eDP-1-gamma
[136.811505] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.726s)
[136.820316] Starting dynamic subtest: pipe-B-eDP-1-degamma
[138.243818] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.431s)
[138.253540] Starting dynamic subtest: pipe-B-eDP-1-ctm
[139.675780] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.430s)
[140.478726] Starting dynamic subtest: pipe-C-eDP-1-gamma
[141.141668] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.670s)
[141.151067] Starting dynamic subtest: pipe-C-eDP-1-degamma
[142.537437] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.395s)
[142.546766] Starting dynamic subtest: pipe-C-eDP-1-ctm
[143.939487] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.403s)
[144.690680] Starting dynamic subtest: pipe-D-eDP-1-gamma
[145.379257] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.693s)
[145.387850] Starting dynamic subtest: pipe-D-eDP-1-degamma
[146.737064] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.359s)
[146.746136] Starting dynamic subtest: pipe-D-eDP-1-ctm
[148.138269] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.399s)
[148.140554] Subtest deep-color: SUCCESS (17.509s)
[148.928446] [014/133] (872s left) gem_ctx_param (set-priority-range)
[148.991143] Starting subtest: set-priority-range
[149.005468] Subtest set-priority-range: SUCCESS (0.014s)
[149.135378] [015/133] (872s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[149.265823] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[149.270278] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[149.434155] [016/133] (872s left) syncobj_wait (invalid-signal-zero-handles)
[149.487876] Starting subtest: invalid-signal-zero-handles
[149.490071] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[149.602749] [017/133] (872s left) kms_flip (2x-flip-vs-wf_vblank)
[149.689223] Starting subtest: 2x-flip-vs-wf_vblank
[149.697665] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[149.785233] [018/133] (872s left) sysfs_preempt_timeout (timeout)
[149.841909] Starting subtest: timeout
[149.843853] Starting dynamic subtest: vecs0
[159.898082] Dynamic subtest vecs0: SUCCESS (10.054s)
[159.911516] Starting dynamic subtest: ccs0
[161.348830] Dynamic subtest ccs0: SUCCESS (1.450s)
[161.359869] Starting dynamic subtest: vcs0
[170.905425] Dynamic subtest vcs0: SUCCESS (9.553s)
[170.917934] Starting dynamic subtest: bcs0
[172.289336] Dynamic subtest bcs0: SUCCESS (1.384s)
[172.299770] Starting dynamic subtest: rcs0
[173.684967] Dynamic subtest rcs0: SUCCESS (1.395s)
[173.696159] Starting dynamic subtest: vcs1
[182.949897] Dynamic subtest vcs1: SUCCESS (9.260s)
[182.952427] Subtest timeout: SUCCESS (33.107s)
[183.050122] [019/133] (839s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[183.166077] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[183.170548] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[183.277015] [020/133] (838s left) kms_getfb (getfb2-handle-zero)
[183.361789] Starting subtest: getfb2-handle-zero
[183.364086] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[183.464924] [021/133] (838s left) kms_plane_multiple (2x-tiling-yf)
[183.559347] Starting subtest: 2x-tiling-yf
[183.563711] Subtest 2x-tiling-yf: SKIP (0.000s)
[183.653380] [022/133] (838s left) kms_force_connector_basic (force-connector-state)
[183.732184] Starting subtest: force-connector-state
[184.342374] Subtest force-connector-state: SUCCESS (0.611s)
[185.295676] [023/133] (836s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[185.393069] Starting subtest: primary-yf-tiled-reflect-x-90
[185.397405] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[185.479576] [024/133] (836s left) kms_psr (psr2-no-drrs)
[185.566806] Starting subtest: psr2-no-drrs
[185.569184] Starting dynamic subtest: eDP-1
[187.190232] Dynamic subtest eDP-1: SUCCESS (1.626s)
[187.192365] Subtest psr2-no-drrs: SUCCESS (1.627s)
[188.056477] [025/133] (834s left) kms_psr2_su (frontbuffer-xrgb8888)
[188.113097] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[188.179502] [026/133] (834s left) kms_chamelium_hpd (dp-hpd-fast)
[188.560276] Subtest dp-hpd-fast: SKIP (0.000s)
[189.334978] [027/133] (833s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[189.463253] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[189.468027] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[189.571794] [028/133] (832s left) gem_ctx_persistence (hostile)
[189.640316] Starting subtest: hostile
[199.793886] Subtest hostile: SUCCESS (10.151s)
[199.942654] [029/133] (822s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[200.034714] Starting subtest: multiplane-rotation-cropping-bottom
[217.391929] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.360s)
[217.538397] [030/133] (804s left) kms_hdr (static-toggle-suspend)
[217.632664] Starting subtest: static-toggle-suspend
[217.638164] Subtest static-toggle-suspend: SKIP (0.000s)
[217.721500] [031/133] (804s left) kms_properties (crtc-properties-atomic)
[217.808750] Starting subtest: crtc-properties-atomic
[217.810547] Starting dynamic subtest: pipe-A-eDP-1
[218.263578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[218.272021] Starting dynamic subtest: pipe-B-eDP-1
[219.387422] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[219.396593] Starting dynamic subtest: pipe-C-eDP-1
[220.564490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.177s)
[220.572911] Starting dynamic subtest: pipe-D-eDP-1
[221.699725] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[221.701884] Subtest crtc-properties-atomic: SUCCESS (3.891s)
[222.558184] [032/133] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[222.656212] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[222.660122] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[222.810496] [033/133] (799s left) gem_userptr_blits (nohangcheck)
[222.882403] Starting subtest: nohangcheck
[223.157234] Subtest nohangcheck: SUCCESS (0.272s)
[223.305654] [034/133] (799s left) kms_dsc (dsc-fractional-bpp)
[223.403979] Starting subtest: dsc-fractional-bpp
[223.417087] Subtest dsc-fractional-bpp: SKIP (0.000s)
[223.486211] [035/133] (799s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[223.569999] Starting subtest: plane-primary-toggle-with-vblank-wait
[223.572185] Starting dynamic subtest: pipe-A-eDP-1
[223.742955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[224.062049] Starting dynamic subtest: pipe-B-eDP-1
[224.925762] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.873s)
[225.242094] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.672s)
[226.058759] [036/133] (796s left) gem_basic (create-close)
[226.129667] Starting subtest: create-close
[226.134227] Subtest create-close: SUCCESS (0.000s)
[226.252967] [037/133] (796s left) gem_close (basic)
[226.328559] Starting subtest: basic
[226.330437] Subtest basic: SUCCESS (0.000s)
[226.440909] [038/133] (796s left) gem_mmap_wc (fault-concurrent)
[226.512667] Subtest fault-concurrent: SKIP (0.000s)
[226.579906] [039/133] (796s left) kms_cursor_crc (cursor-offscreen-512x512)
[226.854053] Starting subtest: cursor-offscreen-512x512
[226.858372] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[227.067234] [040/133] (795s left) drm_read (short-buffer-block)
[227.219723] Starting subtest: short-buffer-block
[227.221603] Subtest short-buffer-block: SUCCESS (0.000s)
[227.386045] [041/133] (795s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[227.448386] Starting subtest: invalid-multi-wait-unsubmitted
[227.450264] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[227.575090] [042/133] (795s left) gem_create (create-invalid-size)
[227.635986] Starting subtest: create-invalid-size
[227.637672] Subtest create-invalid-size: SUCCESS (0.000s)
[227.845734] [043/133] (795s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[228.075019] Starting subtest: cursor-rapid-movement-128x42
[228.134763] Subtest cursor-rapid-movement-128x42: SKIP (0.054s)
[228.361359] [044/133] (794s left) gem_partial_pwrite_pread (write-uncached)
[228.432114] Subtest write-uncached: SKIP (0.000s)
[228.532652] [045/133] (794s left) perf (invalid-oa-metric-set-id)
[228.647991] Starting subtest: invalid-oa-metric-set-id
[228.661508] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[228.698281] [046/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[228.799144] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[235.232436] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.436s)
[235.382561] [047/133] (787s left) kms_prop_blob (invalid-set-prop-any)
[235.456585] Starting subtest: invalid-set-prop-any
[235.458868] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[235.591992] [048/133] (787s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[235.701156] Starting subtest: plane-use-after-nonblocking-unbind
[235.703429] Starting dynamic subtest: pipe-A-eDP-1
[235.762096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[236.068718] Starting dynamic subtest: pipe-B-eDP-1
[236.825648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[237.122383] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.421s)
[237.954575] [049/133] (785s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[238.018590] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[238.020762] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[238.150271] [050/133] (785s left) gem_exec_await (wide-contexts)
[238.338215] Starting subtest: wide-contexts
[261.872423] Subtest wide-contexts: SUCCESS (23.533s)
[262.075619] [051/133] (761s left) gen9_exec_parse (unaligned-jump)
[262.177990] Subtest unaligned-jump: SKIP (0.000s)
[262.266038] [052/133] (761s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[262.386062] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[262.389982] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[262.509222] [053/133] (760s left) gem_ringfill (legacy-basic)
[267.929643] Starting subtest: legacy-basic
[267.932310] Starting dynamic subtest: default
[268.009209] Dynamic subtest default: SUCCESS (0.078s)
[268.020767] Starting dynamic subtest: render
[268.050786] Dynamic subtest render: SUCCESS (0.040s)
[268.060983] Starting dynamic subtest: bsd
[268.093892] Dynamic subtest bsd: SUCCESS (0.041s)
[268.103891] Starting dynamic subtest: bsd1
[268.135816] Dynamic subtest bsd1: SUCCESS (0.039s)
[268.146239] Starting dynamic subtest: bsd2
[268.176037] Dynamic subtest bsd2: SUCCESS (0.038s)
[268.188280] Starting dynamic subtest: blt
[268.221048] Dynamic subtest blt: SUCCESS (0.042s)
[268.235056] Starting dynamic subtest: vebox
[268.265884] Dynamic subtest vebox: SUCCESS (0.041s)
[268.268246] Subtest legacy-basic: SUCCESS (0.338s)
[268.370194] [054/133] (755s left) prime_self_import (basic-with_one_bo_two_files)
[268.408823] Starting subtest: basic-with_one_bo_two_files
[268.444867] Subtest basic-with_one_bo_two_files: SUCCESS (0.035s)
[268.572385] [055/133] (754s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[270.135850] Starting subtest: dpms-mode-unset-non-lpsp
[271.293420] Subtest dpms-mode-unset-non-lpsp: SKIP (1.158s)
[271.676484] [056/133] (751s left) prime_mmap (test_invalid_sync_flags)
[271.745670] Starting subtest: test_invalid_sync_flags
[271.748037] Starting dynamic subtest: test_invalid_sync_flags-smem
[271.750235] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[271.752469] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[271.876307] [057/133] (751s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[272.001567] Starting subtest: 2x-cursor-vs-flip-legacy
[272.006030] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[272.168057] [058/133] (751s left) gem_sync (basic-all)
[272.240780] Starting subtest: basic-all
[275.506258] Subtest basic-all: SUCCESS (3.275s)
[275.715751] [059/133] (747s left) api_intel_bb (render)
[275.772826] Starting subtest: render
[275.775060] Starting dynamic subtest: render-none-512
[275.874839] Dynamic subtest render-none-512: SUCCESS (0.104s)
[275.887302] Starting dynamic subtest: render-none-1024
[276.249766] Dynamic subtest render-none-1024: SUCCESS (0.372s)
[276.261442] Starting dynamic subtest: render-x-512
[276.335332] Dynamic subtest render-x-512: SUCCESS (0.086s)
[276.346140] Starting dynamic subtest: render-x-1024
[276.673551] Dynamic subtest render-x-1024: SUCCESS (0.336s)
[276.684045] Starting dynamic subtest: render-y-512
[276.758555] Dynamic subtest render-y-512: SUCCESS (0.085s)
[276.769548] Starting dynamic subtest: render-y-1024
[277.095257] Dynamic subtest render-y-1024: SUCCESS (0.334s)
[277.098024] Subtest render: SUCCESS (1.325s)
[277.244528] [060/133] (746s left) kms_plane_scaling (planes-scaler-unity-scaling)
[277.343795] Starting subtest: planes-scaler-unity-scaling
[277.345997] Starting dynamic subtest: pipe-A
[277.406682] Dynamic subtest pipe-A: SUCCESS (0.064s)
[277.416062] Starting dynamic subtest: pipe-B
[278.525578] Dynamic subtest pipe-B: SUCCESS (1.117s)
[278.536322] Starting dynamic subtest: pipe-C
[279.604995] Dynamic subtest pipe-C: SUCCESS (1.077s)
[279.615999] Starting dynamic subtest: pipe-D
[280.713336] Dynamic subtest pipe-D: SUCCESS (1.107s)
[280.715674] Subtest planes-scaler-unity-scaling: SUCCESS (3.371s)
[281.857061] [061/133] (741s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[281.959915] Starting subtest: stress-xrgb8888-ytiled
[281.964667] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[282.052419] [062/133] (741s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[282.145050] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[282.149486] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[282.274174] [063/133] (741s left) prime_busy (after-wait)
[282.337319] Starting subtest: after-wait
[282.339688] Starting dynamic subtest: rcs0
[282.384219] Dynamic subtest rcs0: SUCCESS (0.046s)
[282.393709] Starting dynamic subtest: bcs0
[282.440037] Dynamic subtest bcs0: SUCCESS (0.054s)
[282.450762] Starting dynamic subtest: vcs0
[282.478700] Dynamic subtest vcs0: SUCCESS (0.040s)
[282.487656] Starting dynamic subtest: vcs1
[282.519757] Dynamic subtest vcs1: SUCCESS (0.040s)
[282.529131] Starting dynamic subtest: vecs0
[282.563980] Dynamic subtest vecs0: SUCCESS (0.043s)
[282.578062] Starting dynamic subtest: ccs0
[282.606500] Dynamic subtest ccs0: SUCCESS (0.041s)
[282.715780] Subtest after-wait: SUCCESS (0.379s)
[282.816602] [064/133] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[282.904570] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[282.909380] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[283.014343] [065/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[283.113526] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[283.117638] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[283.242501] [066/133] (740s left) gem_exec_schedule (noreorder)
[283.418081] Starting subtest: noreorder
[283.420459] Starting dynamic subtest: rcs0
[283.502104] Dynamic subtest rcs0: SUCCESS (0.083s)
[283.514550] Starting dynamic subtest: vcs0
[284.916491] Dynamic subtest vcs0: SUCCESS (1.411s)
[284.928451] Starting dynamic subtest: vcs1
[286.957123] Dynamic subtest vcs1: SUCCESS (2.039s)
[286.973164] Starting dynamic subtest: vecs0
[288.900209] Dynamic subtest vecs0: SUCCESS (1.940s)
[288.914749] Starting dynamic subtest: ccs0
[288.999711] Dynamic subtest ccs0: SUCCESS (0.098s)
[289.002263] Subtest noreorder: SUCCESS (5.583s)
[289.197380] [067/133] (734s left) kms_psr (fbc-psr2-suspend)
[289.301986] Starting subtest: fbc-psr2-suspend
[289.304452] Starting dynamic subtest: eDP-1
[289.308657] Dynamic subtest eDP-1: SKIP (0.000s)
[289.312850] Subtest fbc-psr2-suspend: SKIP (0.001s)
[289.387030] [068/133] (734s left) gem_exec_params (invalid-bsd2-flag-on-render)
[289.448214] Starting subtest: invalid-bsd2-flag-on-render
[289.450436] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[289.573238] [069/133] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[289.682087] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[289.686469] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[289.798866] [070/133] (734s left) kms_psr (psr2-cursor-blt)
[289.895975] Starting subtest: psr2-cursor-blt
[289.898221] Starting dynamic subtest: eDP-1
[291.592533] Dynamic subtest eDP-1: SUCCESS (1.697s)
[291.594777] Subtest psr2-cursor-blt: SUCCESS (1.698s)
[292.453260] [071/133] (731s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[292.500015] Starting subtest: x-tiled-to-vebox-yf-tiled
[292.504560] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[292.694246] [072/133] (731s left) gem_pread (bench)
[292.764492] Subtest bench: SKIP (0.000s)
[292.837653] [073/133] (731s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[292.911922] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[293.015745] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[293.103351] [074/133] (731s left) gen9_exec_parse (batch-zero-length)
[293.165248] Subtest batch-zero-length: SKIP (0.000s)
[293.256400] [075/133] (731s left) gem_set_tiling_vs_pwrite
[293.385176] [076/133] (730s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[293.479485] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[293.483454] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[293.625142] [077/133] (730s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[293.732120] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[293.734205] Starting dynamic subtest: pipe-A-default-mode
[296.438958] Dynamic subtest pipe-A-default-mode: SUCCESS (2.705s)
[296.441386] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.707s)
[297.246124] [078/133] (727s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[297.354140] Starting subtest: yf-tiled-32bpp-rotate-180
[297.358448] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[297.465684] [079/133] (727s left) fbdev (eof)
[297.505510] Starting subtest: eof
[297.507682] Subtest eof: SUCCESS (0.000s)
[297.585911] [080/133] (726s left) gem_exec_reloc (basic-write-wc-active)
[297.644419] Subtest basic-write-wc-active: SKIP (0.000s)
[297.719495] [081/133] (726s left) dmabuf_sync_file (export-multiwait)
[297.763488] Starting subtest: export-multiwait
[297.765672] Subtest export-multiwait: SUCCESS (0.001s)
[297.830640] [082/133] (726s left) gem_exec_reloc (basic-scanout)
[297.883464] Subtest basic-scanout: SKIP (0.000s)
[297.962747] [083/133] (726s left) gem_softpin (reverse)
[298.040757] Starting subtest: reverse
[298.046929] Subtest reverse: SUCCESS (0.006s)
[298.182265] [084/133] (726s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[298.281163] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[298.283056] Starting dynamic subtest: pipe-A-eDP-1
[298.301277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[298.310962] Starting dynamic subtest: pipe-B-eDP-1
[298.327300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[298.335021] Starting dynamic subtest: pipe-C-eDP-1
[298.351946] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[298.359764] Starting dynamic subtest: pipe-D-eDP-1
[298.377057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[298.380466] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[300.559244] [085/133] (724s left) perf_pmu (busy-hang)
[300.605851] Starting subtest: busy-hang
[300.608218] Starting dynamic subtest: rcs0
[301.928040] Dynamic subtest rcs0: SUCCESS (1.320s)
[301.938163] Starting dynamic subtest: bcs0
[303.174895] Dynamic subtest bcs0: SUCCESS (1.248s)
[303.185754] Starting dynamic subtest: vcs0
[305.440179] Dynamic subtest vcs0: SUCCESS (2.260s)
[305.450450] Starting dynamic subtest: vcs1
[307.422091] Dynamic subtest vcs1: SUCCESS (1.980s)
[307.432057] Starting dynamic subtest: vecs0
[309.406155] Dynamic subtest vecs0: SUCCESS (1.982s)
[309.416648] Starting dynamic subtest: ccs0
[310.659239] Dynamic subtest ccs0: SUCCESS (1.254s)
[310.661800] Subtest busy-hang: SUCCESS (10.056s)
[310.790179] [086/133] (713s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[310.893128] Starting subtest: x-tiled-16bpp-rotate-0
[312.162749] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.269s)
[312.327866] [087/133] (712s left) gem_mmap_gtt (hang-user)
[312.382176] Subtest hang-user: SKIP (0.000s)
[312.443516] [088/133] (712s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[312.545223] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[320.006071] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.463s)
[320.129173] [089/133] (704s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[320.236708] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[320.240734] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.355375] [090/133] (704s left) gem_eio (banned)
[320.580105] Starting subtest: banned
[321.210439] Subtest banned: SUCCESS (0.630s)
[321.386016] [091/133] (703s left) kms_pm_rpm (pm-caching)
[322.972223] Starting subtest: pm-caching
[322.977128] Subtest pm-caching: SKIP (0.000s)
[323.798529] [092/133] (701s left) syncobj_timeline (wait-all-snapshot)
[323.868347] Starting subtest: wait-all-snapshot
[323.947935] Subtest wait-all-snapshot: SUCCESS (0.082s)
[324.035563] [093/133] (701s left) kms_selftest (drm_cmdline_parser)
[324.073339] Starting subtest: drm_cmdline_parser
[324.096548] Starting dynamic subtest: drm_test_cmdline_force_d_only
[324.213998] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.118s)
[324.224081] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[324.314137] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.100s)
[324.324060] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[324.441141] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.125s)
[324.451220] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[324.575192] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.134s)
[324.584926] Starting dynamic subtest: drm_test_cmdline_force_e_only
[324.684400] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.108s)
[324.694315] Starting dynamic subtest: drm_test_cmdline_res
[324.794105] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.110s)
[324.804253] Starting dynamic subtest: drm_test_cmdline_res_vesa
[324.891455] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.096s)
[324.901800] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[325.037187] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.144s)
[325.047258] Starting dynamic subtest: drm_test_cmdline_res_rblank
[325.157214] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.119s)
[325.167122] Starting dynamic subtest: drm_test_cmdline_res_bpp
[325.259863] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.102s)
[325.267869] Starting dynamic subtest: drm_test_cmdline_res_refresh
[325.417212] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.156s)
[325.427180] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[325.517037] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.100s)
[325.527129] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[325.657096] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.138s)
[325.666737] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[325.801211] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.144s)
[325.809975] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[325.954443] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.153s)
[325.962790] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[326.101412] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.146s)
[326.109732] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[326.242275] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.141s)
[326.250385] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[326.342085] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.098s)
[326.350228] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[326.474045] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.130s)
[326.482235] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[326.600482] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.126s)
[326.608549] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[326.742522] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.140s)
[326.755997] Starting dynamic subtest: drm_test_cmdline_name
[326.874158] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.132s)
[326.883992] Starting dynamic subtest: drm_test_cmdline_name_bpp
[327.000925] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.126s)
[327.009629] Starting dynamic subtest: drm_test_cmdline_name_option
[327.091311] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.091s)
[327.099627] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[327.187270] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.096s)
[327.195561] Starting dynamic subtest: drm_test_cmdline_rotate_0
[327.296166] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.107s)
[327.304783] Starting dynamic subtest: drm_test_cmdline_rotate_90
[327.414362] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.117s)
[327.422783] Starting dynamic subtest: drm_test_cmdline_rotate_180
[327.529080] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.113s)
[327.537431] Starting dynamic subtest: drm_test_cmdline_rotate_270
[327.645641] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.116s)
[327.654061] Starting dynamic subtest: drm_test_cmdline_hmirror
[327.756160] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.110s)
[327.764372] Starting dynamic subtest: drm_test_cmdline_vmirror
[327.877184] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.120s)
[327.885792] Starting dynamic subtest: drm_test_cmdline_margin_options
[327.997372] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.119s)
[328.005705] Starting dynamic subtest: drm_test_cmdline_multiple_options
[328.122113] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.122s)
[328.130639] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[328.231443] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.111s)
[328.239312] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[328.383393] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.149s)
[328.392118] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[328.523338] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.139s)
[328.531905] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[328.680921] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.158s)
[328.688995] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[328.825491] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.144s)
[328.833549] Starting dynamic subtest: drm_test_cmdline_invalid
[328.996821] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.171s)
[329.005687] Starting dynamic subtest: drm_test_cmdline_tv_options
[329.147258] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.148s)
[329.149107] Subtest drm_cmdline_parser: SUCCESS (5.071s)
[329.393529] [094/133] (695s left) gem_userptr_blits (unsync-unmap)
[329.475294] Subtest unsync-unmap: SKIP (0.000s)
[329.640289] [095/133] (695s left) kms_addfb_basic (invalid-set-prop)
[329.698607] Starting subtest: invalid-set-prop
[329.700873] Subtest invalid-set-prop: SUCCESS (0.000s)
[329.885475] [096/133] (695s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[329.991019] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[329.993253] Starting dynamic subtest: pipe-A-eDP-1
[330.801068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s)
[330.809770] Starting dynamic subtest: pipe-B-eDP-1
[332.346709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[332.356739] Starting dynamic subtest: pipe-C-eDP-1
[333.889778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.539s)
[333.908931] Starting dynamic subtest: pipe-D-eDP-1
[335.384386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.491s)
[335.386312] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.384s)
[336.567014] [097/133] (688s left) kms_big_fb (linear-addfb)
[336.665453] Starting subtest: linear-addfb
[336.667617] Subtest linear-addfb: SUCCESS (0.000s)
[336.788568] [098/133] (688s left) gem_ppgtt (blt-vs-render-ctx0)
[336.850983] Starting subtest: blt-vs-render-ctx0
[369.651911] Subtest blt-vs-render-ctx0: SUCCESS (32.798s)
[369.828043] [099/133] (655s left) gem_exec_schedule (u-submit-early-slice)
[369.941202] Starting subtest: u-submit-early-slice
[369.943482] Starting dynamic subtest: rcs0
[369.999711] Dynamic subtest rcs0: SUCCESS (0.065s)
[370.011334] Starting dynamic subtest: bcs0
[370.052628] Dynamic subtest bcs0: SUCCESS (0.052s)
[370.064509] Starting dynamic subtest: vcs0
[370.105533] Dynamic subtest vcs0: SUCCESS (0.052s)
[370.117062] Starting dynamic subtest: vcs1
[370.162954] Dynamic subtest vcs1: SUCCESS (0.057s)
[370.175104] Starting dynamic subtest: vecs0
[370.220559] Dynamic subtest vecs0: SUCCESS (0.057s)
[370.229211] Starting dynamic subtest: ccs0
[370.275727] Dynamic subtest ccs0: SUCCESS (0.055s)
[370.278075] Subtest u-submit-early-slice: SUCCESS (0.341s)
[372.056041] [100/133] (653s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[372.167168] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[372.171336] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[372.276354] [101/133] (653s left) gem_create (create-massive)
[372.327575] Starting subtest: create-massive
[372.329866] Subtest create-massive: SUCCESS (0.000s)
[372.523384] [102/133] (652s left) gem_ctx_persistence (engines-queued)
[372.584989] Starting subtest: engines-queued
[372.586952] Starting dynamic subtest: rcs0
[372.654745] Dynamic subtest rcs0: SUCCESS (0.071s)
[372.665758] Starting dynamic subtest: bcs0
[372.768304] Dynamic subtest bcs0: SUCCESS (0.111s)
[372.780624] Starting dynamic subtest: vcs0
[373.875328] Dynamic subtest vcs0: SUCCESS (1.104s)
[373.887334] Starting dynamic subtest: vcs1
[375.859259] Dynamic subtest vcs1: SUCCESS (1.981s)
[375.871414] Starting dynamic subtest: vecs0
[377.845589] Dynamic subtest vecs0: SUCCESS (1.983s)
[377.858031] Starting dynamic subtest: ccs0
[378.084088] Dynamic subtest ccs0: SUCCESS (0.236s)
[378.086795] Subtest engines-queued: SUCCESS (5.501s)
[378.232630] [103/133] (647s left) gem_exec_balancer (full-late)
[378.295095] Starting subtest: full-late
[382.760859] Subtest full-late: SUCCESS (4.465s)
[383.112401] [104/133] (642s left) kms_chamelium_frames (dp-crc-fast)
[383.502605] Subtest dp-crc-fast: SKIP (0.000s)
[384.314392] [105/133] (641s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[384.419342] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[385.386887] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.967s)
[385.520612] [106/133] (640s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[385.569845] Starting subtest: invalid-bsd1-flag-on-blt
[385.572114] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[385.675702] [107/133] (639s left) gem_exec_params (invalid-bsd1-flag-on-render)
[385.722572] Starting subtest: invalid-bsd1-flag-on-render
[385.724521] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[385.846501] [108/133] (639s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[385.945897] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[385.947834] Starting dynamic subtest: pipe-A-eDP-1
[385.965924] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[385.975795] Starting dynamic subtest: pipe-B-eDP-1
[385.993734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.001411] Starting dynamic subtest: pipe-C-eDP-1
[386.018484] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.026246] Starting dynamic subtest: pipe-D-eDP-1
[386.043279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.046680] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[388.236592] [109/133] (637s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[388.343588] Starting subtest: fbc-rgb565-draw-blt
[392.428997] Subtest fbc-rgb565-draw-blt: SUCCESS (4.088s)
[393.590641] [110/133] (632s left) i915_hangman (gt-engine-error)
[393.657540] Starting subtest: gt-engine-error
[393.659763] Starting dynamic subtest: rcs0
[394.868328] Dynamic subtest rcs0: SUCCESS (1.210s)
[394.880213] Starting dynamic subtest: bcs0
[396.851679] Dynamic subtest bcs0: SUCCESS (1.980s)
[396.864913] Starting dynamic subtest: vcs0
[398.898539] Dynamic subtest vcs0: SUCCESS (2.044s)
[398.911177] Starting dynamic subtest: vcs1
[400.883783] Dynamic subtest vcs1: SUCCESS (1.983s)
[400.895708] Starting dynamic subtest: vecs0
[402.866574] Dynamic subtest vecs0: SUCCESS (1.980s)
[402.878681] Starting dynamic subtest: ccs0
[404.850331] Dynamic subtest ccs0: SUCCESS (1.981s)
[404.853107] Subtest gt-engine-error: SUCCESS (11.194s)
[405.021969] [111/133] (620s left) sw_sync (sync_expired_merge)
[405.063907] Starting subtest: sync_expired_merge
[406.138121] Subtest sync_expired_merge: SUCCESS (1.074s)
[406.214748] [112/133] (619s left) perf_pmu (busy-idle)
[406.254938] Starting subtest: busy-idle
[406.256786] Starting dynamic subtest: rcs0
[406.960289] Dynamic subtest rcs0: SUCCESS (0.706s)
[406.970870] Starting dynamic subtest: bcs0
[407.638609] Dynamic subtest bcs0: SUCCESS (0.676s)
[407.650040] Starting dynamic subtest: vcs0
[408.916271] Dynamic subtest vcs0: SUCCESS (1.274s)
[408.926188] Starting dynamic subtest: vcs1
[410.901074] Dynamic subtest vcs1: SUCCESS (1.982s)
[410.913340] Starting dynamic subtest: vecs0
[412.894065] Dynamic subtest vecs0: SUCCESS (1.981s)
[412.903370] Starting dynamic subtest: ccs0
[413.553902] Dynamic subtest ccs0: SUCCESS (0.669s)
[413.556812] Subtest busy-idle: SUCCESS (7.301s)
[413.681753] [113/133] (612s left) kms_async_flips (test-time-stamp)
[413.794716] Starting subtest: test-time-stamp
[414.176525] Starting dynamic subtest: pipe-A-eDP-1
[414.996368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[415.388691] Starting dynamic subtest: pipe-B-eDP-1
[416.196894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.812s)
[416.564480] Starting dynamic subtest: pipe-C-eDP-1
[417.399506] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.840s)
[417.768826] Starting dynamic subtest: pipe-D-eDP-1
[418.608081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.846s)
[418.610408] Subtest test-time-stamp: SUCCESS (4.814s)
[419.846131] [114/133] (606s left) kms_flip (dpms-off-confusion)
[419.956265] Starting subtest: dpms-off-confusion
[419.958567] Starting dynamic subtest: A-eDP1
[428.600443] Dynamic subtest A-eDP1: SUCCESS (8.643s)
[428.610191] Starting dynamic subtest: B-eDP1
[437.297463] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[437.308117] Starting dynamic subtest: C-eDP1
[445.990145] Dynamic subtest C-eDP1: SUCCESS (8.690s)
[445.999789] Starting dynamic subtest: D-eDP1
[454.684143] Dynamic subtest D-eDP1: SUCCESS (8.693s)
[454.686670] Subtest dpms-off-confusion: SUCCESS (34.730s)
[455.928598] [115/133] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[456.032145] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[456.036324] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[456.135224] [116/133] (569s left) i915_pm_rc6_residency (media-rc6-accuracy)
[456.195060] Starting subtest: media-rc6-accuracy
[456.199286] Subtest media-rc6-accuracy: SKIP (0.000s)
[456.299133] [117/133] (569s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[456.401469] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[456.405977] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[457.541863] [118/133] (568s left) kms_flip (wf_vblank-ts-check-interruptible)
[457.644633] Starting subtest: wf_vblank-ts-check-interruptible
[457.646796] Starting dynamic subtest: A-eDP1
[466.533659] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[466.543431] Starting dynamic subtest: B-eDP1
[475.435173] Dynamic subtest B-eDP1: SUCCESS (8.899s)
[475.449438] Starting dynamic subtest: C-eDP1
[484.318586] Dynamic subtest C-eDP1: SUCCESS (8.880s)
[484.331297] Starting dynamic subtest: D-eDP1
[493.220977] Dynamic subtest D-eDP1: SUCCESS (8.900s)
[493.223397] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.579s)
[494.436461] [119/133] (531s left) kms_flip (flip-vs-dpms-on-nop)
[494.534749] Starting subtest: flip-vs-dpms-on-nop
[494.536764] Starting dynamic subtest: A-eDP1
[496.376225] Dynamic subtest A-eDP1: SUCCESS (1.844s)
[496.388021] Starting dynamic subtest: B-eDP1
[498.188230] Dynamic subtest B-eDP1: SUCCESS (1.810s)
[498.199693] Starting dynamic subtest: C-eDP1
[500.069092] Dynamic subtest C-eDP1: SUCCESS (1.878s)
[500.079327] Starting dynamic subtest: D-eDP1
[501.869752] Dynamic subtest D-eDP1: SUCCESS (1.800s)
[501.875067] Subtest flip-vs-dpms-on-nop: SUCCESS (7.343s)
[503.141850] [120/133] (523s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[503.256158] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[503.355431] [121/133] (522s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[503.468539] Starting subtest: basic-flip-before-cursor-legacy
[504.398408] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.929s)
[505.224642] [122/133] (521s left) gem_ctx_shared (exec-shared-gtt)
[505.304038] Starting subtest: exec-shared-gtt
[505.306310] Starting dynamic subtest: rcs0
[505.311308] Dynamic subtest rcs0: SUCCESS (0.005s)
[505.321247] Starting dynamic subtest: bcs0
[505.323493] Dynamic subtest bcs0: SUCCESS (0.004s)
[505.332356] Starting dynamic subtest: vcs0
[505.334118] Dynamic subtest vcs0: SUCCESS (0.006s)
[505.342757] Starting dynamic subtest: vcs1
[505.344909] Dynamic subtest vcs1: SUCCESS (0.007s)
[505.353150] Starting dynamic subtest: vecs0
[505.354983] Dynamic subtest vecs0: SUCCESS (0.007s)
[505.363064] Starting dynamic subtest: ccs0
[505.364840] Dynamic subtest ccs0: SUCCESS (0.006s)
[505.366713] Subtest exec-shared-gtt: SUCCESS (0.040s)
[505.537491] [123/133] (520s left) gem_exec_fence (concurrent)
[505.721229] Starting subtest: concurrent
[505.725137] Subtest concurrent: SKIP (0.000s)
[508.038098] [124/133] (518s left) api_intel_bb (blit-reloc-purge-cache)
[508.098901] Starting subtest: blit-reloc-purge-cache
[508.103370] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[508.249504] [125/133] (518s left) kms_cursor_legacy (single-bo)
[508.371645] Starting subtest: single-bo
[508.373826] Starting dynamic subtest: pipe-A
[513.753687] Dynamic subtest pipe-A: SUCCESS (5.379s)
[513.765445] Starting dynamic subtest: pipe-B
[519.136927] Dynamic subtest pipe-B: SUCCESS (5.380s)
[519.148593] Starting dynamic subtest: pipe-C
[524.519853] Dynamic subtest pipe-C: SUCCESS (5.380s)
[524.531037] Starting dynamic subtest: pipe-D
[529.901081] Dynamic subtest pipe-D: SUCCESS (5.379s)
[529.912655] Starting dynamic subtest: all-pipes
[535.290719] Dynamic subtest all-pipes: SUCCESS (5.386s)
[535.293116] Subtest single-bo: SUCCESS (26.917s)
[535.447358] [126/133] (490s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[535.573526] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[535.577567] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[535.679788] [127/133] (490s left) kms_vblank (wait-busy)
[535.791217] Starting subtest: wait-busy
[535.793450] Starting dynamic subtest: pipe-A-eDP-1
[537.672238] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[537.686620] Starting dynamic subtest: pipe-D-eDP-1
[540.238276] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[540.240572] Subtest wait-busy: SUCCESS (4.448s)
[541.125079] [128/133] (485s left) gem_fence_thrash (bo-write-verify-y)
[541.166779] Starting subtest: bo-write-verify-y
[541.183300] Subtest bo-write-verify-y: SKIP (0.014s)
[541.251227] [129/133] (485s left) i915_pm_rps (waitboost)
[541.314175] Starting subtest: waitboost
[547.417393] Subtest waitboost: SUCCESS (6.103s)
[547.565093] [130/133] (479s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[547.678861] Starting subtest: extended-modeset-hang-oldfb-with-reset
[547.681142] Starting dynamic subtest: pipe-A
[559.834074] Dynamic subtest pipe-A: SUCCESS (12.153s)
[559.844328] Starting dynamic subtest: pipe-D
[572.339535] Dynamic subtest pipe-D: SUCCESS (12.501s)
[572.341755] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.658s)
[573.228396] [131/133] (453s left) syncobj_timeline (reset-signaled)
[573.296758] Starting subtest: reset-signaled
[573.299077] Subtest reset-signaled: SUCCESS (0.000s)
[573.414304] [132/133] (453s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[573.504331] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[573.506463] Starting dynamic subtest: pipe-A-eDP-1
[573.515146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.525325] Starting dynamic subtest: pipe-B-eDP-1
[573.533945] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[573.544970] Starting dynamic subtest: pipe-C-eDP-1
[573.553131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.561063] Starting dynamic subtest: pipe-D-eDP-1
[573.569134] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.572978] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[575.717867] [133/133] (451s left) kms_content_protection (lic-type-0-hdcp14)
[575.865796] Starting subtest: lic-type-0-hdcp14
[575.870387] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[576.030264] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_cursor_edge_walk
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: sysfs_preempt_timeout
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_getfb
results: parsing output: 20/ for test: kms_plane_multiple
results: parsing output: 21/ for test: kms_force_connector_basic
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_psr2_su
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_ctx_persistence
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_hdr
results: parsing output: 30/ for test: kms_properties
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_dsc
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_basic
results: parsing output: 36/ for test: gem_close
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: drm_read
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_prop_blob
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_await
results: parsing output: 50/ for test: gen9_exec_parse
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_ringfill
results: parsing output: 53/ for test: prime_self_import
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_sync
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: kms_plane_scaling
results: parsing output: 60/ for test: kms_pipe_stress
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: prime_busy
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_pread
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gen9_exec_parse
results: parsing output: 74/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: fbdev
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: dmabuf_sync_file
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_selftest
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ppgtt
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_chamelium_frames
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_hangman
results: parsing output: 110/ for test: sw_sync
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_async_flips
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rc6_residency
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: api_intel_bb
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: i915_pm_rps
results: parsing output: 129/ for test: kms_busy
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_content_protection
Done.