[59.962384] Initializing watchdogs
[59.962431]   /dev/watchdog0
[59.977029] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.981621] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.983921] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.987282] [001/134] (960s left) kms_pm_rpm (i2c)
[64.844092] Starting subtest: i2c
[70.246566] Subtest i2c: SUCCESS (5.398s)
[70.362060] [002/134] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[70.477154] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[70.481662] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[70.614897] [003/134] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[70.716552] Starting subtest: fbcpsr-1p-rte
[77.755848] Subtest fbcpsr-1p-rte: SUCCESS (7.041s)
[77.948228] [004/134] (942s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[78.003101] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[78.104078] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s)
[78.190633] [005/134] (942s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[78.298734] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[78.303164] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[78.407348] [006/134] (942s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[78.493615] Starting subtest: async-flip-with-page-flip-events-tiled
[78.879726] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[81.643926] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[81.653448] Starting dynamic subtest: pipe-A-eDP-1-4
[83.819226] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[83.829300] Starting dynamic subtest: pipe-A-eDP-1-4
[85.828646] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[85.835829] Starting dynamic subtest: pipe-A-eDP-1-x
[88.019475] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[88.385057] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[91.175327] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.796s)
[91.183234] Starting dynamic subtest: pipe-B-eDP-1-4
[93.373162] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.197s)
[93.380561] Starting dynamic subtest: pipe-B-eDP-1-4
[95.394307] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[95.401593] Starting dynamic subtest: pipe-B-eDP-1-x
[97.573353] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[97.958064] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[100.708511] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.754s)
[100.716251] Starting dynamic subtest: pipe-C-eDP-1-4
[102.883458] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[102.890903] Starting dynamic subtest: pipe-C-eDP-1-4
[104.892984] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[104.900424] Starting dynamic subtest: pipe-C-eDP-1-x
[107.082991] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[107.447991] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[110.226909] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[110.237229] Starting dynamic subtest: pipe-D-eDP-1-4
[112.423047] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.196s)
[112.432773] Starting dynamic subtest: pipe-D-eDP-1-4
[114.433640] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[114.443239] Starting dynamic subtest: pipe-D-eDP-1-x
[116.612105] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[116.614385] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.118s)
[117.817410] [007/134] (902s left) sriov_basic (bind-unbind-vf)
[117.885955] Starting subtest: bind-unbind-vf
[117.888289] Starting dynamic subtest: vf-1
[117.965157] Dynamic subtest vf-1: FAIL (0.033s)
[117.973810] Starting dynamic subtest: vf-2
[118.045738] Dynamic subtest vf-2: FAIL (0.004s)
[118.054650] Starting dynamic subtest: vf-3
[118.127115] Dynamic subtest vf-3: FAIL (0.003s)
[118.135486] Starting dynamic subtest: vf-4
[118.208279] Dynamic subtest vf-4: FAIL (0.004s)
[118.217808] Starting dynamic subtest: vf-5
[118.290069] Dynamic subtest vf-5: FAIL (0.003s)
[118.298733] Starting dynamic subtest: vf-6
[118.371099] Dynamic subtest vf-6: FAIL (0.004s)
[118.379475] Starting dynamic subtest: vf-7
[118.452138] Dynamic subtest vf-7: FAIL (0.004s)
[118.460284] Starting dynamic subtest: vf-random
[118.530473] Dynamic subtest vf-random: FAIL (0.004s)
[118.539059] Starting dynamic subtest: vf-last
[118.611065] Dynamic subtest vf-last: FAIL (0.501s)
[118.613347] Subtest bind-unbind-vf: FAIL (0.562s)
[118.648312] [008/134] (902s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[118.751369] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[118.754757] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.868366] [009/134] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[118.974512] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[118.977864] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[119.085818] [010/134] (901s left) kms_flip (plain-flip-interruptible)
[119.187088] Starting subtest: plain-flip-interruptible
[119.189079] Starting dynamic subtest: A-eDP1
[120.800804] Dynamic subtest A-eDP1: SUCCESS (1.612s)
[120.810495] Starting dynamic subtest: B-eDP1
[122.441214] Dynamic subtest B-eDP1: SUCCESS (1.640s)
[122.450756] Starting dynamic subtest: C-eDP1
[124.068321] Dynamic subtest C-eDP1: SUCCESS (1.626s)
[124.077656] Starting dynamic subtest: D-eDP1
[125.689378] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[125.691821] Subtest plain-flip-interruptible: SUCCESS (6.504s)
[126.878127] [011/134] (893s left) prime_vgem (fence-flip-hang)
[127.027067] Subtest fence-flip-hang: SKIP (0.000s)
[127.154439] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[127.157460] [012/134] (893s left) gem_exec_schedule (preempt-queue)
[127.226042] Subtest preempt-queue: SKIP (0.000s)
[127.540857] [013/134] (893s left) i915_pm_rpm (debugfs-read)
[129.056680] Starting subtest: debugfs-read
[130.200370] Subtest debugfs-read: SUCCESS (1.144s)
[130.600152] [014/134] (890s left) i915_hangman (gt-engine-hang)
[130.665916] Starting subtest: gt-engine-hang
[130.668216] Starting dynamic subtest: rcs0
[131.891856] Dynamic subtest rcs0: SUCCESS (1.225s)
[131.903454] Starting dynamic subtest: bcs0
[133.874984] Dynamic subtest bcs0: SUCCESS (1.982s)
[133.885231] Starting dynamic subtest: vcs0
[135.858121] Dynamic subtest vcs0: SUCCESS (1.982s)
[135.868087] Starting dynamic subtest: vcs1
[137.843063] Dynamic subtest vcs1: SUCCESS (1.983s)
[137.853705] Starting dynamic subtest: vecs0
[139.826948] Dynamic subtest vecs0: SUCCESS (1.983s)
[139.837427] Starting dynamic subtest: ccs0
[141.876826] Dynamic subtest ccs0: SUCCESS (2.048s)
[141.879744] Subtest gt-engine-hang: SUCCESS (11.210s)
[142.024345] [015/134] (879s left) gem_softpin (evict-active)
[142.089849] Starting subtest: evict-active
[142.098306] Subtest evict-active: SUCCESS (0.008s)
[142.234796] [016/134] (878s left) gem_mmap_gtt (cpuset-basic-small-copy)
[142.291687] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[142.360040] [017/134] (878s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[142.485983] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[142.490252] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[142.651419] [018/134] (878s left) gem_sync (basic-each)
[142.714783] Starting subtest: basic-each
[144.983609] Subtest basic-each: SUCCESS (2.279s)
[145.197980] [019/134] (875s left) kms_addfb_basic (unused-modifier)
[145.260967] Starting subtest: unused-modifier
[145.263346] Subtest unused-modifier: SUCCESS (0.000s)
[145.419244] [020/134] (875s left) syncobj_wait (reset-during-wait-for-submit)
[145.487744] Starting subtest: reset-during-wait-for-submit
[145.590620] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[145.679349] [021/134] (875s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[145.826076] Starting subtest: cursor-rapid-movement-32x32
[145.874825] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[146.183341] [022/134] (875s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[146.292134] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[146.294464] Starting dynamic subtest: pipe-A-eDP-1
[146.353116] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[146.361940] Starting dynamic subtest: pipe-B-eDP-1
[146.419033] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[146.427878] Starting dynamic subtest: pipe-C-eDP-1
[146.486991] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[146.495997] Starting dynamic subtest: pipe-D-eDP-1
[146.553978] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[146.558189] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[148.546609] [023/134] (872s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[148.659147] Starting subtest: fbc-rgb565-draw-blt
[152.844913] Subtest fbc-rgb565-draw-blt: SUCCESS (4.189s)
[154.029178] [024/134] (867s left) gem_gpgpu_fill (basic)
[154.093083] Starting subtest: basic
[154.095555] Starting dynamic subtest: smem
[154.100494] Dynamic subtest smem: SUCCESS (0.008s)
[154.102848] Subtest basic: SUCCESS (0.008s)
[154.268599] [025/134] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[154.365322] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[154.369389] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[154.521212] [026/134] (866s left) gem_exec_params (invalid-batch-start-offset)
[154.580836] Starting subtest: invalid-batch-start-offset
[154.585650] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[154.734099] [027/134] (866s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[154.846336] Starting subtest: y-tiled-64bpp-rotate-0
[154.850340] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[154.983067] [028/134] (866s left) sw_sync (alloc_timeline)
[155.020195] Starting subtest: alloc_timeline
[155.022098] Subtest alloc_timeline: SUCCESS (0.000s)
[155.091854] [029/134] (866s left) api_intel_bb (offset-control)
[155.156600] Starting subtest: offset-control
[155.161494] Subtest offset-control: SUCCESS (0.007s)
[155.278558] [030/134] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[155.382872] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[155.386838] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.495786] [031/134] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[155.603807] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[155.607208] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[155.708920] [032/134] (866s left) gem_pxp (create-regular-context-2)
[155.819357] Starting subtest: create-regular-context-2
[155.821750] Subtest create-regular-context-2: SUCCESS (0.002s)
[155.953829] [033/134] (865s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[156.049133] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[163.008879] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.960s)
[163.179769] [034/134] (858s left) gem_partial_pwrite_pread (writes-after-reads)
[163.233476] Subtest writes-after-reads: SKIP (0.000s)
[163.301487] [035/134] (858s left) gem_mmap_gtt (big-copy-odd)
[163.364240] Subtest big-copy-odd: SKIP (0.000s)
[163.433480] [036/134] (858s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[163.531150] Starting subtest: plane-primary-overlay-mutable-zpos
[167.021437] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.488s)
[168.223734] [037/134] (853s left) gem_flink_basic (bad-flink)
[168.275600] Starting subtest: bad-flink
[168.277460] Subtest bad-flink: SUCCESS (0.000s)
[168.379779] [038/134] (853s left) i915_drm_fdinfo (all-busy-check-all)
[168.416535] Starting subtest: all-busy-check-all
[168.421163] Subtest all-busy-check-all: SKIP (0.004s)
[168.497286] [039/134] (853s left) kms_chamelium_hpd (hdmi-hpd-fast)
[168.934467] Subtest hdmi-hpd-fast: SKIP (0.000s)
[169.713274] [040/134] (852s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[169.771616] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[169.774279] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[169.876834] [041/134] (852s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[172.106041] Starting subtest: modeset-non-lpsp-stress-no-wait
[172.167313] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.062s)
[172.508205] [042/134] (849s left) gem_create (create-size-update)
[172.565809] Starting subtest: create-size-update
[172.568102] Subtest create-size-update: SUCCESS (0.000s)
[172.810506] [043/134] (849s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[172.908058] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[173.964260] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.056s)
[174.143402] [044/134] (848s left) perf_pmu (semaphore-busy)
[174.183651] Starting subtest: semaphore-busy
[174.185533] Starting dynamic subtest: rcs0
[175.854226] Dynamic subtest rcs0: SUCCESS (1.667s)
[175.862999] Starting dynamic subtest: bcs0
[177.482793] Dynamic subtest bcs0: SUCCESS (1.626s)
[177.493879] Starting dynamic subtest: vcs0
[181.392782] Dynamic subtest vcs0: SUCCESS (3.907s)
[181.403805] Starting dynamic subtest: vcs1
[187.406653] Dynamic subtest vcs1: SUCCESS (6.012s)
[187.417901] Starting dynamic subtest: vecs0
[193.424058] Dynamic subtest vecs0: SUCCESS (6.015s)
[193.434962] Starting dynamic subtest: ccs0
[196.498109] Dynamic subtest ccs0: SUCCESS (3.072s)
[196.501418] Subtest semaphore-busy: SUCCESS (22.311s)
[196.623321] [045/134] (825s left) kms_rotation_crc (sprite-rotation-270)
[196.728471] Starting subtest: sprite-rotation-270
[196.733104] Subtest sprite-rotation-270: SKIP (0.002s)
[196.834404] [046/134] (825s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[196.901733] Starting subtest: multi-wait-all-available-submitted-signaled
[196.904074] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[197.037153] [047/134] (825s left) kms_psr (psr-primary-mmap-gtt)
[197.133033] Starting subtest: psr-primary-mmap-gtt
[197.135342] Starting dynamic subtest: eDP-1
[198.598039] Dynamic subtest eDP-1: SKIP (1.462s)
[198.603220] Subtest psr-primary-mmap-gtt: SKIP (1.464s)
[198.800701] [048/134] (823s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[199.198598] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[200.036751] [049/134] (822s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[200.149657] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[200.153629] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[200.263975] [050/134] (822s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[200.365106] Starting subtest: fbc-psr2-cursor-mmap-gtt
[200.367219] Starting dynamic subtest: eDP-1
[200.371507] Dynamic subtest eDP-1: SKIP (0.000s)
[200.375909] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[200.447203] [051/134] (822s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[200.554541] Starting subtest: 4-tiled-8bpp-rotate-0
[201.768490] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[201.925657] [052/134] (820s left) gem_exec_alignment (single)
[201.982629] Starting subtest: single
[201.986768] Subtest single: SUCCESS (0.003s)
[202.148224] [053/134] (820s left) gen7_exec_parse (basic-allocation)
[202.214041] Subtest basic-allocation: SKIP (0.000s)
[202.286519] [054/134] (820s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[202.345094] Starting subtest: legacy-engines-hostile-preempt
[202.347143] Starting dynamic subtest: render
[202.437885] Dynamic subtest render: SUCCESS (0.092s)
[202.448938] Starting dynamic subtest: bsd1
[203.907480] Dynamic subtest bsd1: SUCCESS (1.466s)
[203.918284] Starting dynamic subtest: bsd2
[205.882861] Dynamic subtest bsd2: SUCCESS (1.973s)
[205.893647] Starting dynamic subtest: blt
[205.958509] Dynamic subtest blt: SUCCESS (0.075s)
[205.968314] Starting dynamic subtest: vebox
[207.906651] Dynamic subtest vebox: SUCCESS (1.944s)
[207.909503] Subtest legacy-engines-hostile-preempt: SUCCESS (5.560s)
[208.014812] [055/134] (814s left) kms_psr (fbc-pr-cursor-plane-onoff)
[208.124804] Starting subtest: fbc-pr-cursor-plane-onoff
[208.129100] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[208.207277] [056/134] (814s left) gem_exec_await (wide-contexts)
[208.418233] Starting subtest: wide-contexts
[231.773787] Subtest wide-contexts: SUCCESS (23.354s)
[231.982741] [057/134] (790s left) syncobj_wait (signal)
[232.082277] Starting subtest: signal
[232.084619] Subtest signal: SUCCESS (0.000s)
[232.226562] [058/134] (790s left) syncobj_wait (multi-wait-submitted)
[232.277282] Starting subtest: multi-wait-submitted
[232.385065] Subtest multi-wait-submitted: SUCCESS (0.107s)
[232.474547] [059/134] (790s left) sw_sync (sync_merge)
[232.507976] Starting subtest: sync_merge
[232.510668] Subtest sync_merge: SUCCESS (0.000s)
[232.575754] [060/134] (790s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[232.689218] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[232.701560] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[232.840586] [061/134] (790s left) kms_plane_alpha_blend (constant-alpha-mid)
[232.944353] Starting subtest: constant-alpha-mid
[233.225535] Starting dynamic subtest: pipe-A-eDP-1
[234.168322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.941s)
[234.177780] Starting dynamic subtest: pipe-D-eDP-1
[235.654745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.484s)
[235.657071] Subtest constant-alpha-mid: SUCCESS (2.711s)
[236.528910] [062/134] (786s left) kms_vblank (crtc-id)
[236.642126] Starting subtest: crtc-id
[236.644032] Starting dynamic subtest: pipe-A-eDP-1
[237.083504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[237.097475] Starting dynamic subtest: pipe-D-eDP-1
[238.261182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.174s)
[238.263081] Subtest crtc-id: SUCCESS (1.619s)
[239.095816] [063/134] (783s left) gem_softpin (evict-prime)
[239.176583] Starting subtest: evict-prime
[239.179188] Starting dynamic subtest: rcs0
[240.377539] Dynamic subtest rcs0: SUCCESS (1.200s)
[240.391577] Starting dynamic subtest: bcs0
[241.524177] Dynamic subtest bcs0: SUCCESS (1.145s)
[241.534188] Starting dynamic subtest: vcs0
[242.868567] Dynamic subtest vcs0: SUCCESS (1.341s)
[242.880428] Starting dynamic subtest: vcs1
[244.932245] Dynamic subtest vcs1: SUCCESS (2.062s)
[244.943507] Starting dynamic subtest: vecs0
[246.961451] Dynamic subtest vecs0: SUCCESS (2.027s)
[246.973047] Starting dynamic subtest: ccs0
[248.101933] Dynamic subtest ccs0: SUCCESS (1.140s)
[248.113015] Starting dynamic subtest: all
[249.905344] Dynamic subtest all: SUCCESS (1.800s)
[249.908048] Subtest evict-prime: SUCCESS (10.728s)
[249.999357] [064/134] (773s left) kms_plane_scaling (planes-downscale-factor-0-75)
[250.095946] Starting subtest: planes-downscale-factor-0-75
[250.098281] Starting dynamic subtest: pipe-A
[250.119128] Dynamic subtest pipe-A: SKIP (0.019s)
[250.128348] Starting dynamic subtest: pipe-B
[250.153595] Dynamic subtest pipe-B: SKIP (0.034s)
[250.162754] Starting dynamic subtest: pipe-C
[250.185799] Dynamic subtest pipe-C: SKIP (0.033s)
[250.194245] Starting dynamic subtest: pipe-D
[250.220602] Dynamic subtest pipe-D: SKIP (0.033s)
[250.224941] Subtest planes-downscale-factor-0-75: SKIP (0.122s)
[250.343908] [065/134] (772s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[250.442833] Starting subtest: extended-pageflip-modeset-hang-oldfb
[250.445073] Starting dynamic subtest: pipe-A
[258.370076] Dynamic subtest pipe-A: SUCCESS (7.927s)
[258.379574] Starting dynamic subtest: pipe-D
[266.997537] Dynamic subtest pipe-D: SUCCESS (8.623s)
[266.999787] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.554s)
[267.856698] [066/134] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[267.974712] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[267.978780] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[268.096426] [067/134] (755s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[268.211055] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[268.215576] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[268.336566] [068/134] (754s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[268.395613] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[268.399653] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[268.592618] [069/134] (754s left) kms_psr (pr-dpms)
[268.686328] Starting subtest: pr-dpms
[268.690801] Subtest pr-dpms: SKIP (0.000s)
[268.772269] [070/134] (754s left) kms_draw_crc (draw-method-mmap-cpu)
[268.878146] Starting subtest: draw-method-mmap-cpu
[268.880045] Starting dynamic subtest: xrgb8888-untiled
[269.120839] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[269.130238] Starting dynamic subtest: rgb565-untiled
[269.354226] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[269.363533] Starting dynamic subtest: xrgb2101010-untiled
[269.565152] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[269.573878] Starting dynamic subtest: xbgr16161616f-untiled
[269.798157] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[269.806694] Starting dynamic subtest: xrgb8888-xtiled
[269.920590] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[269.929830] Starting dynamic subtest: rgb565-xtiled
[270.043338] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[270.056336] Starting dynamic subtest: xrgb2101010-xtiled
[270.176044] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[270.184501] Starting dynamic subtest: xbgr16161616f-xtiled
[270.309660] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[270.319633] Starting dynamic subtest: xrgb8888-4tiled
[270.453917] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[270.462022] Starting dynamic subtest: rgb565-4tiled
[270.598222] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[270.607093] Starting dynamic subtest: xrgb2101010-4tiled
[270.731729] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[270.740637] Starting dynamic subtest: xbgr16161616f-4tiled
[270.875849] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[270.877827] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[270.989888] [071/134] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[271.084676] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[277.618740] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.537s)
[277.780915] [072/134] (745s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[282.893582] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[282.901056] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.006s)
[283.740954] [073/134] (739s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[283.846812] Starting subtest: x-tiled-64bpp-rotate-270
[283.870908] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[284.030203] [074/134] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[284.138422] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[284.142712] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[284.267627] [075/134] (739s left) gem_softpin (evict-snoop-interruptible)
[284.335562] Starting subtest: evict-snoop-interruptible
[284.339730] Subtest evict-snoop-interruptible: SKIP (0.000s)
[284.470921] [076/134] (739s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[284.562055] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[284.564341] Starting dynamic subtest: pipe-A-eDP-1
[284.587548] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.596603] Starting dynamic subtest: pipe-B-eDP-1
[284.618558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.627492] Starting dynamic subtest: pipe-C-eDP-1
[284.649157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.657305] Starting dynamic subtest: pipe-D-eDP-1
[284.675620] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.678964] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[286.823895] [077/134] (736s left) perf_pmu (busy-idle-no-semaphores)
[286.867895] Starting subtest: busy-idle-no-semaphores
[286.870094] Starting dynamic subtest: rcs0
[287.533636] Dynamic subtest rcs0: SUCCESS (0.665s)
[287.552577] Starting dynamic subtest: bcs0
[288.187086] Dynamic subtest bcs0: SUCCESS (0.651s)
[288.198609] Starting dynamic subtest: vcs0
[288.842874] Dynamic subtest vcs0: SUCCESS (0.653s)
[288.852731] Starting dynamic subtest: vcs1
[290.492850] Dynamic subtest vcs1: SUCCESS (1.648s)
[290.502932] Starting dynamic subtest: vecs0
[292.544284] Dynamic subtest vecs0: SUCCESS (2.050s)
[292.554478] Starting dynamic subtest: ccs0
[294.526037] Dynamic subtest ccs0: SUCCESS (1.979s)
[294.528844] Subtest busy-idle-no-semaphores: SUCCESS (7.660s)
[294.662638] [078/134] (728s left) gem_mmap_offset (open-flood)
[294.722851] Starting subtest: open-flood
[316.209518] Subtest open-flood: SUCCESS (21.489s)
[316.350966] [079/134] (707s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[316.426220] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[316.536936] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[316.631168] [080/134] (707s left) gen9_exec_parse (allowed-single)
[316.700366] Subtest allowed-single: SKIP (0.000s)
[316.781362] [081/134] (706s left) gem_render_copy (linear-to-vebox-yf-tiled)
[316.839356] Starting subtest: linear-to-vebox-yf-tiled
[316.843848] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[317.035791] [082/134] (706s left) kms_vblank (wait-busy-hang)
[317.145374] Starting subtest: wait-busy-hang
[317.147569] Starting dynamic subtest: pipe-A-eDP-1
[343.708289] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.561s)
[343.723448] Starting dynamic subtest: pipe-D-eDP-1
[368.660262] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s)
[368.662395] Subtest wait-busy-hang: SUCCESS (51.512s)
[369.476459] [083/134] (654s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[369.602407] Starting subtest: 2x-long-flip-vs-cursor-legacy
[369.606971] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[369.775882] [084/134] (654s left) syncobj_timeline (single-wait-all-available-submitted)
[369.832305] Starting subtest: single-wait-all-available-submitted
[369.834273] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[369.948032] [085/134] (653s left) kms_chamelium_audio (dp-audio-edid)
[370.328980] Subtest dp-audio-edid: SKIP (0.000s)
[371.181856] [086/134] (652s left) kms_frontbuffer_tracking (psr-suspend)
[371.280114] Starting subtest: psr-suspend
[410.008202] Subtest psr-suspend: SUCCESS (8.113s)
[410.170461] [087/134] (613s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[410.729999] Starting subtest: syncobj-stationary-timeline-chain-engines
[410.831361] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.101s)
[412.645729] [088/134] (611s left) gem_exec_schedule (u-semaphore-user)
[412.731768] Starting subtest: u-semaphore-user
[412.789535] Subtest u-semaphore-user: SUCCESS (0.064s)
[414.545354] [089/134] (609s left) gem_ctx_isolation (preservation-reset)
[414.716760] Starting subtest: preservation-reset
[414.719096] Starting dynamic subtest: rcs0
[415.029639] Dynamic subtest rcs0: SUCCESS (0.314s)
[415.039685] Starting dynamic subtest: bcs0
[415.423690] Dynamic subtest bcs0: SUCCESS (0.390s)
[415.436693] Starting dynamic subtest: vcs0
[415.799984] Dynamic subtest vcs0: SUCCESS (0.374s)
[415.811125] Starting dynamic subtest: vcs1
[417.812146] Dynamic subtest vcs1: SUCCESS (2.001s)
[417.822087] Starting dynamic subtest: vecs0
[419.753078] Dynamic subtest vecs0: SUCCESS (1.932s)
[419.766065] Starting dynamic subtest: ccs0
[421.856100] Dynamic subtest ccs0: SUCCESS (2.095s)
[421.858524] Subtest preservation-reset: SUCCESS (7.114s)
[422.029170] [090/134] (602s left) kms_cursor_crc (cursor-onscreen-512x512)
[422.323800] Starting subtest: cursor-onscreen-512x512
[422.328278] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[422.492720] [091/134] (601s left) gem_exec_fence (basic-wait)
[422.677858] Starting subtest: basic-wait
[422.680529] Starting dynamic subtest: rcs0
[422.783760] Dynamic subtest rcs0: SUCCESS (0.106s)
[422.795673] Starting dynamic subtest: bcs0
[422.848025] Dynamic subtest bcs0: SUCCESS (0.062s)
[422.859615] Starting dynamic subtest: vcs0
[422.912147] Dynamic subtest vcs0: SUCCESS (0.062s)
[422.923658] Starting dynamic subtest: vcs1
[422.972884] Dynamic subtest vcs1: SUCCESS (0.059s)
[422.983967] Starting dynamic subtest: vecs0
[423.033794] Dynamic subtest vecs0: SUCCESS (0.059s)
[423.045591] Starting dynamic subtest: ccs0
[423.096053] Dynamic subtest ccs0: SUCCESS (0.060s)
[423.098371] Subtest basic-wait: SUCCESS (0.419s)
[424.662177] [092/134] (599s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[424.767713] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[424.794834] Starting dynamic subtest: pipe-A-plane-0
[424.799397] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[424.810481] Starting dynamic subtest: pipe-A-plane-3
[424.815149] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[424.824825] Starting dynamic subtest: pipe-A-plane-5
[424.829476] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[425.882391] Starting dynamic subtest: pipe-B-plane-0
[425.886547] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[425.895857] Starting dynamic subtest: pipe-B-plane-3
[425.899920] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[425.908983] Starting dynamic subtest: pipe-B-plane-5
[425.913310] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[426.200225] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (1.426s)
[427.082604] [093/134] (597s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[427.206074] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[427.210426] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[427.349137] [094/134] (596s left) kms_psr (psr2-sprite-plane-onoff)
[427.445117] Starting subtest: psr2-sprite-plane-onoff
[427.447429] Starting dynamic subtest: eDP-1
[429.194481] Dynamic subtest eDP-1: SUCCESS (1.747s)
[429.196731] Subtest psr2-sprite-plane-onoff: SUCCESS (1.748s)
[430.042950] [095/134] (594s left) gem_workarounds (suspend-resume-context)
[430.133953] Starting subtest: suspend-resume-context
[446.454497] Subtest suspend-resume-context: SUCCESS (1.237s)
[446.604718] [096/134] (577s left) gem_exec_params (cliprects_ptr-dirt)
[446.670657] Starting subtest: cliprects_ptr-dirt
[446.673040] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[446.793234] [097/134] (577s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[446.906848] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[446.912074] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[447.002779] [098/134] (577s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[447.112955] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[447.115792] Starting dynamic subtest: pipe-A-default-mode
[448.298785] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[448.303565] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.173s)
[448.507437] [099/134] (575s left) gem_exec_suspend (basic-s0)
[448.567979] Starting subtest: basic-S0
[448.570855] Starting dynamic subtest: smem
[469.353780] Dynamic subtest smem: SUCCESS (6.932s)
[469.356558] Subtest basic-S0: SUCCESS (6.934s)
[469.577493] [100/134] (554s left) gem_exec_reloc (basic-cpu-active)
[469.653490] Subtest basic-cpu-active: SKIP (0.000s)
[469.716886] [101/134] (554s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[469.773077] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[469.774974] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[469.901984] [102/134] (554s left) gem_exec_reloc (basic-wc-gtt-active)
[469.964189] Subtest basic-wc-gtt-active: SKIP (0.000s)
[470.054380] [103/134] (554s left) kms_plane (plane-position-hole-dpms)
[470.161502] Starting subtest: plane-position-hole-dpms
[470.710569] Starting dynamic subtest: pipe-A-plane-1
[473.099818] Dynamic subtest pipe-A-plane-1: SUCCESS (2.373s)
[473.109373] Starting dynamic subtest: pipe-A-plane-2
[475.553260] Dynamic subtest pipe-A-plane-2: SUCCESS (2.439s)
[475.564006] Starting dynamic subtest: pipe-A-plane-3
[477.955079] Dynamic subtest pipe-A-plane-3: SUCCESS (2.391s)
[477.965353] Starting dynamic subtest: pipe-A-plane-4
[480.369369] Dynamic subtest pipe-A-plane-4: SUCCESS (2.408s)
[480.379367] Starting dynamic subtest: pipe-A-plane-5
[480.396269] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[481.586815] Starting dynamic subtest: pipe-B-plane-1
[484.006319] Dynamic subtest pipe-B-plane-1: SUCCESS (2.422s)
[484.019023] Starting dynamic subtest: pipe-B-plane-2
[486.343315] Dynamic subtest pipe-B-plane-2: SUCCESS (2.331s)
[486.352983] Starting dynamic subtest: pipe-B-plane-3
[488.709876] Dynamic subtest pipe-B-plane-3: SUCCESS (2.363s)
[488.720593] Starting dynamic subtest: pipe-B-plane-4
[491.137972] Dynamic subtest pipe-B-plane-4: SUCCESS (2.425s)
[491.148416] Starting dynamic subtest: pipe-B-plane-5
[491.164184] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[491.166318] Subtest plane-position-hole-dpms: SUCCESS (20.931s)
[491.983958] [104/134] (532s left) kms_content_protection (lic-type-0)
[492.151807] Starting subtest: lic-type-0
[492.156484] Subtest lic-type-0: SKIP (0.000s)
[492.315410] [105/134] (532s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[492.424512] Starting subtest: psr-rgb565-draw-blt
[499.427789] Subtest psr-rgb565-draw-blt: SUCCESS (7.002s)
[499.579353] [106/134] (525s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[499.680876] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[499.685175] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[500.849005] [107/134] (524s left) gem_ctx_shared (create-shared-gtt)
[500.918689] Starting subtest: create-shared-gtt
[503.071616] Subtest create-shared-gtt: SUCCESS (2.152s)
[503.447183] [108/134] (521s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[503.568790] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[504.548098] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.978s)
[504.706041] [109/134] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[504.801409] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[504.805732] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[504.936031] [110/134] (520s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[505.025981] Starting subtest: plane-primary-toggle-with-vblank-wait
[505.027860] Starting dynamic subtest: pipe-A-eDP-1
[505.202960] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[505.524107] Starting dynamic subtest: pipe-B-eDP-1
[506.448203] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.934s)
[506.749561] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.724s)
[507.615283] [111/134] (517s left) fbdev (unaligned-write)
[507.662015] Starting subtest: unaligned-write
[507.763475] Subtest unaligned-write: SUCCESS (0.100s)
[507.841706] [112/134] (517s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[512.889539] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[512.894137] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[513.729948] [113/134] (511s left) i915_query (engine-info-invalid)
[513.793633] Starting subtest: engine-info-invalid
[513.795526] Subtest engine-info-invalid: SUCCESS (0.000s)
[513.913249] [114/134] (511s left) gem_exec_create (forked)
[513.974312] Starting subtest: forked
[513.976653] Starting dynamic subtest: smem
[535.339065] Dynamic subtest smem: SUCCESS (21.357s)
[535.341594] Subtest forked: SUCCESS (21.359s)
[535.549723] [115/134] (489s left) gem_userptr_blits (access-control)
[535.635582] Starting subtest: access-control
[535.640196] Subtest access-control: SKIP (0.000s)
[535.775498] [116/134] (489s left) kms_color_pipeline (plane-lut1d-lut1d)
[535.895699] Starting subtest: plane-lut1d-lut1d
[535.911073] Starting dynamic subtest: pipe-A-eDP-1
[536.601152] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[537.297393] Starting dynamic subtest: pipe-B-eDP-1
[538.141704] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[538.736212] Starting dynamic subtest: pipe-C-eDP-1
[539.610870] Dynamic subtest pipe-C-eDP-1: FAIL (0.290s)
[540.078236] Starting dynamic subtest: pipe-D-eDP-1
[540.907638] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[540.909718] Subtest plane-lut1d-lut1d: FAIL (4.733s)
[541.476716] [117/134] (483s left) kms_cursor_crc (cursor-suspend)
[541.605391] Starting subtest: cursor-suspend
[541.607705] Starting dynamic subtest: pipe-A-eDP-1
[573.967879] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[573.979195] Starting dynamic subtest: pipe-D-eDP-1
[607.914556] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.707s)
[607.916851] Subtest cursor-suspend: SUCCESS (6.931s)
[608.782268] [118/134] (416s left) gem_exec_balancer (invalid-bonds)
[608.869786] Starting subtest: invalid-bonds
[608.874389] Subtest invalid-bonds: SKIP (0.000s)
[609.205672] [119/134] (416s left) perf (non-sampling-read-error)
[609.340281] Starting subtest: non-sampling-read-error
[609.350257] Subtest non-sampling-read-error: SUCCESS (0.010s)
[609.402393] [120/134] (416s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[609.515264] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[609.519572] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[609.627690] [121/134] (415s left) sw_sync (sync_multi_producer_single_consumer)
[609.663811] Starting subtest: sync_multi_producer_single_consumer
[610.746175] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[610.824592] [122/134] (414s left) kms_universal_plane (cursor-fb-leak)
[610.930181] Starting subtest: cursor-fb-leak
[610.932434] Starting dynamic subtest: pipe-A-eDP-1
[611.272116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.340s)
[611.284768] Starting dynamic subtest: pipe-B-eDP-1
[612.636754] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[612.652584] Starting dynamic subtest: pipe-C-eDP-1
[614.051028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s)
[614.062906] Starting dynamic subtest: pipe-D-eDP-1
[615.371230] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[615.373560] Subtest cursor-fb-leak: SUCCESS (4.416s)
[616.564109] [123/134] (408s left) dmabuf (all-tests)
[616.612030] Starting subtest: all-tests
[616.614256] Starting dynamic subtest: sanitycheck
[616.768675] Dynamic subtest sanitycheck: SUCCESS (0.154s)
[616.782122] Starting dynamic subtest: dma_fence
[617.026525] Dynamic subtest dma_fence: SUCCESS (0.255s)
[617.039291] Starting dynamic subtest: dma_fence_chain
[625.450524] Dynamic subtest dma_fence_chain: SUCCESS (8.400s)
[625.462504] Starting dynamic subtest: dma_fence_unwrap
[625.538395] Dynamic subtest dma_fence_unwrap: SUCCESS (0.086s)
[625.550029] Starting dynamic subtest: dma_resv
[625.672788] Dynamic subtest dma_resv: SUCCESS (0.131s)
[625.675680] Subtest all-tests: SUCCESS (9.037s)
[625.763856] [124/134] (399s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[625.858901] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[625.861230] Starting dynamic subtest: pipe-A-default-mode
[626.149456] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[626.154104] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.289s)
[627.008313] [125/134] (398s left) gem_exec_reloc (basic-write-wc)
[627.077310] Subtest basic-write-wc: SKIP (0.000s)
[627.154489] [126/134] (398s left) sysfs_preempt_timeout (invalid)
[627.219590] Starting subtest: invalid
[627.221962] Starting dynamic subtest: vecs0
[627.224386] Dynamic subtest vecs0: SUCCESS (0.000s)
[627.236081] Starting dynamic subtest: ccs0
[627.237983] Dynamic subtest ccs0: SUCCESS (0.000s)
[627.247298] Starting dynamic subtest: vcs0
[627.249172] Dynamic subtest vcs0: SUCCESS (0.000s)
[627.258822] Starting dynamic subtest: bcs0
[627.260757] Dynamic subtest bcs0: SUCCESS (0.000s)
[627.270611] Starting dynamic subtest: rcs0
[627.272832] Dynamic subtest rcs0: SUCCESS (0.000s)
[627.282216] Starting dynamic subtest: vcs1
[627.284117] Dynamic subtest vcs1: SUCCESS (0.000s)
[627.286005] Subtest invalid: SUCCESS (0.006s)
[627.338103] [127/134] (398s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[627.448738] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[634.256329] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.806s)
[634.427661] [128/134] (391s left) kms_lease (lease-uevent)
[634.524297] Starting subtest: lease-uevent
[635.535923] Subtest lease-uevent: SUCCESS (1.012s)
[635.642291] [129/134] (390s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[635.746102] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[635.750469] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[636.894342] [130/134] (388s left) kms_plane_multiple (2x-tiling-y)
[636.993091] Starting subtest: 2x-tiling-y
[636.997140] Subtest 2x-tiling-y: SKIP (0.000s)
[637.097047] [131/134] (388s left) kms_getfb (getfb2-into-addfb2)
[637.190884] Starting subtest: getfb2-into-addfb2
[637.193214] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[637.325149] [132/134] (388s left) kms_joiner (basic-max-non-joiner)
[637.432289] Starting subtest: basic-max-non-joiner
[637.436592] Subtest basic-max-non-joiner: SKIP (0.000s)
[637.514026] [133/134] (388s left) kms_psr (fbc-psr-basic)
[637.613950] Starting subtest: fbc-psr-basic
[637.616245] Starting dynamic subtest: eDP-1
[637.620474] Dynamic subtest eDP-1: SKIP (0.000s)
[637.624663] Subtest fbc-psr-basic: SKIP (0.001s)
[637.712928] [134/134] (388s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[637.810936] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[642.041608] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.234s)
[643.187893] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_async_flips
results: parsing output: 6/ for test: sriov_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: i915_pm_rpm
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_sync
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_gpgpu_fill
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_partial_pwrite_pread
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: kms_atomic
results: parsing output: 36/ for test: gem_flink_basic
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_create
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_alignment
results: parsing output: 52/ for test: gen7_exec_parse
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_await
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_plane_alpha_blend
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: gem_softpin
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_busy
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_render_copy
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_chamelium_audio
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_ctx_isolation
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_workarounds
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: gem_exec_suspend
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_plane
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_ctx_shared
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_atomic_transition
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: gem_exec_create
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: kms_color_pipeline
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: gem_exec_balancer
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: kms_universal_plane
results: parsing output: 122/ for test: dmabuf
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: sysfs_preempt_timeout
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_plane_multiple
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_joiner
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.