[106.342881] Initializing watchdogs
[106.342926]   /dev/watchdog0
[106.357067] [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]
[106.361664] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[106.363986] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[106.367373] [001/134] (960s left) kms_pm_rpm (i2c)
[108.059098] Starting subtest: i2c
[113.639320] Subtest i2c: SUCCESS (5.583s)
[113.735017] [002/134] (953s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[113.830291] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[113.834604] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[113.931703] [003/134] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[114.029837] Starting subtest: fbcpsr-1p-rte
[121.066870] Subtest fbcpsr-1p-rte: SUCCESS (7.040s)
[121.243585] [004/134] (945s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[121.305805] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[121.409430] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.102s)
[121.498361] [005/134] (945s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[121.600315] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[121.604456] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[121.706953] [006/134] (945s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[121.807952] Starting subtest: async-flip-with-page-flip-events-tiled
[122.186472] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[124.922341] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[124.930897] Starting dynamic subtest: pipe-A-eDP-1-4
[127.109355] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.186s)
[127.121642] Starting dynamic subtest: pipe-A-eDP-1-4
[129.119878] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[129.128434] Starting dynamic subtest: pipe-A-eDP-1-x
[131.297923] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[131.675997] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[134.447310] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.778s)
[134.457995] Starting dynamic subtest: pipe-B-eDP-1-4
[136.623660] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.175s)
[136.633775] Starting dynamic subtest: pipe-B-eDP-1-4
[138.633023] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[138.641676] Starting dynamic subtest: pipe-B-eDP-1-x
[140.835213] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[141.212596] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[143.981655] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[143.991655] Starting dynamic subtest: pipe-C-eDP-1-4
[146.156679] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[146.164464] Starting dynamic subtest: pipe-C-eDP-1-4
[148.167080] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[148.177638] Starting dynamic subtest: pipe-C-eDP-1-x
[150.345624] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[150.705550] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[153.518125] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[153.529571] Starting dynamic subtest: pipe-D-eDP-1-4
[155.692634] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[155.701762] Starting dynamic subtest: pipe-D-eDP-1-4
[157.703424] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[157.711188] Starting dynamic subtest: pipe-D-eDP-1-x
[159.881853] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[159.884507] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.072s)
[161.113665] [007/134] (905s left) sriov_basic (bind-unbind-vf)
[161.169971] Starting subtest: bind-unbind-vf
[161.172454] Starting dynamic subtest: vf-1
[161.246260] Dynamic subtest vf-1: FAIL (0.019s)
[161.255477] Starting dynamic subtest: vf-2
[161.329024] Dynamic subtest vf-2: FAIL (0.004s)
[161.338903] Starting dynamic subtest: vf-3
[161.412293] Dynamic subtest vf-3: FAIL (0.004s)
[161.420991] Starting dynamic subtest: vf-4
[161.492702] Dynamic subtest vf-4: FAIL (0.004s)
[161.502207] Starting dynamic subtest: vf-5
[161.575265] Dynamic subtest vf-5: FAIL (0.004s)
[161.583682] Starting dynamic subtest: vf-6
[161.656420] Dynamic subtest vf-6: FAIL (0.004s)
[161.665058] Starting dynamic subtest: vf-7
[161.737401] Dynamic subtest vf-7: FAIL (0.004s)
[161.746094] Starting dynamic subtest: vf-random
[161.818336] Dynamic subtest vf-random: FAIL (0.004s)
[161.827293] Starting dynamic subtest: vf-last
[161.900164] Dynamic subtest vf-last: FAIL (0.505s)
[161.903106] Subtest bind-unbind-vf: FAIL (0.553s)
[161.938678] [008/134] (905s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[162.040843] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[162.044329] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[162.155161] [009/134] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[162.248793] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[162.252420] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[162.356142] [010/134] (904s left) kms_flip (plain-flip-interruptible)
[162.453413] Starting subtest: plain-flip-interruptible
[162.455473] Starting dynamic subtest: A-eDP1
[164.097356] Dynamic subtest A-eDP1: SUCCESS (1.642s)
[164.108206] Starting dynamic subtest: B-eDP1
[165.733052] Dynamic subtest B-eDP1: SUCCESS (1.635s)
[165.742889] Starting dynamic subtest: C-eDP1
[167.348743] Dynamic subtest C-eDP1: SUCCESS (1.614s)
[167.358428] Starting dynamic subtest: D-eDP1
[168.975831] Dynamic subtest D-eDP1: SUCCESS (1.626s)
[168.978182] Subtest plain-flip-interruptible: SUCCESS (6.525s)
[170.158223] [011/134] (897s left) prime_vgem (fence-flip-hang)
[170.279221] Subtest fence-flip-hang: SKIP (0.000s)
[170.393514] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[170.396609] [012/134] (896s left) gem_exec_schedule (preempt-queue)
[170.473418] Subtest preempt-queue: SKIP (0.000s)
[170.773754] [013/134] (896s left) i915_pm_rpm (debugfs-read)
[173.007975] Starting subtest: debugfs-read
[174.172815] Subtest debugfs-read: SUCCESS (1.164s)
[174.577702] [014/134] (892s left) i915_hangman (gt-engine-hang)
[174.651349] Starting subtest: gt-engine-hang
[174.653609] Starting dynamic subtest: rcs0
[175.862232] Dynamic subtest rcs0: SUCCESS (1.210s)
[175.877765] Starting dynamic subtest: bcs0
[177.907443] Dynamic subtest bcs0: SUCCESS (2.044s)
[177.921323] Starting dynamic subtest: vcs0
[179.891328] Dynamic subtest vcs0: SUCCESS (1.982s)
[179.901847] Starting dynamic subtest: vcs1
[181.811626] Dynamic subtest vcs1: SUCCESS (1.919s)
[181.822780] Starting dynamic subtest: vecs0
[182.899777] Dynamic subtest vecs0: SUCCESS (1.087s)
[182.910775] Starting dynamic subtest: ccs0
[184.883056] Dynamic subtest ccs0: SUCCESS (1.982s)
[184.885960] Subtest gt-engine-hang: SUCCESS (10.232s)
[184.976106] [015/134] (882s left) gem_softpin (evict-active)
[185.049703] Starting subtest: evict-active
[185.057598] Subtest evict-active: SUCCESS (0.008s)
[185.228156] [016/134] (882s left) gem_mmap_gtt (cpuset-basic-small-copy)
[185.291312] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[185.362509] [017/134] (882s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[185.488754] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[185.493143] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[185.655825] [018/134] (881s left) gem_sync (basic-each)
[185.737622] Starting subtest: basic-each
[188.038488] Subtest basic-each: SUCCESS (2.313s)
[188.233057] [019/134] (879s left) kms_addfb_basic (unused-modifier)
[188.287799] Starting subtest: unused-modifier
[188.289711] Subtest unused-modifier: SUCCESS (0.000s)
[188.464700] [020/134] (879s left) syncobj_wait (reset-during-wait-for-submit)
[188.523689] Starting subtest: reset-during-wait-for-submit
[188.626759] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[188.713829] [021/134] (878s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[188.861387] Starting subtest: cursor-rapid-movement-32x32
[188.910574] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[189.205753] [022/134] (878s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[189.305873] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[189.308219] Starting dynamic subtest: pipe-A-eDP-1
[189.366308] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[189.375434] Starting dynamic subtest: pipe-B-eDP-1
[189.432089] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[189.441827] Starting dynamic subtest: pipe-C-eDP-1
[189.501690] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[189.510055] Starting dynamic subtest: pipe-D-eDP-1
[189.567678] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[189.571894] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[191.624811] [023/134] (876s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[191.726406] Starting subtest: fbc-rgb565-draw-blt
[195.927313] Subtest fbc-rgb565-draw-blt: SUCCESS (4.206s)
[197.117035] [024/134] (870s left) gem_gpgpu_fill (basic)
[197.173889] Starting subtest: basic
[197.176123] Starting dynamic subtest: smem
[197.181086] Dynamic subtest smem: SUCCESS (0.006s)
[197.183065] Subtest basic: SUCCESS (0.007s)
[197.331262] [025/134] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[197.428927] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[197.433137] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[197.568425] [026/134] (870s left) gem_exec_params (invalid-batch-start-offset)
[197.621240] Starting subtest: invalid-batch-start-offset
[197.623483] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[197.777796] [027/134] (870s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[197.887442] Starting subtest: y-tiled-64bpp-rotate-0
[197.891523] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[198.014802] [028/134] (869s left) sw_sync (alloc_timeline)
[198.055327] Starting subtest: alloc_timeline
[198.056902] Subtest alloc_timeline: SUCCESS (0.000s)
[198.120713] [029/134] (869s left) api_intel_bb (offset-control)
[198.179158] Starting subtest: offset-control
[198.184529] Subtest offset-control: SUCCESS (0.007s)
[198.293965] [030/134] (869s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[198.394769] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[198.398200] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.520742] [031/134] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[198.619586] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[198.622815] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[198.741626] [032/134] (869s left) gem_pxp (create-regular-context-2)
[198.857176] Starting subtest: create-regular-context-2
[198.859094] Subtest create-regular-context-2: SUCCESS (0.002s)
[198.972273] [033/134] (869s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[199.078981] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[205.973390] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.895s)
[206.135282] [034/134] (862s left) gem_partial_pwrite_pread (writes-after-reads)
[206.200588] Subtest writes-after-reads: SKIP (0.000s)
[206.275213] [035/134] (861s left) gem_mmap_gtt (big-copy-odd)
[206.336059] Subtest big-copy-odd: SKIP (0.000s)
[206.402621] [036/134] (861s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[206.496017] Starting subtest: plane-primary-overlay-mutable-zpos
[209.971169] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.473s)
[211.171282] [037/134] (857s left) gem_flink_basic (bad-flink)
[211.232040] Starting subtest: bad-flink
[211.233975] Subtest bad-flink: SUCCESS (0.000s)
[211.358880] [038/134] (856s left) i915_drm_fdinfo (all-busy-check-all)
[211.399419] Starting subtest: all-busy-check-all
[211.404225] Subtest all-busy-check-all: SKIP (0.003s)
[211.475147] [039/134] (856s left) kms_chamelium_hpd (hdmi-hpd-fast)
[211.911023] Subtest hdmi-hpd-fast: SKIP (0.000s)
[212.804372] [040/134] (855s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[212.861582] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[212.864063] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[212.998375] [041/134] (855s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[215.129891] Starting subtest: modeset-non-lpsp-stress-no-wait
[215.178174] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[215.515789] [042/134] (853s left) gem_create (create-size-update)
[215.573352] Starting subtest: create-size-update
[215.575340] Subtest create-size-update: SUCCESS (0.000s)
[215.800185] [043/134] (852s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[215.905770] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[216.973495] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s)
[217.130995] [044/134] (851s left) perf_pmu (semaphore-busy)
[217.171455] Starting subtest: semaphore-busy
[217.173480] Starting dynamic subtest: rcs0
[218.827513] Dynamic subtest rcs0: SUCCESS (1.651s)
[218.836709] Starting dynamic subtest: bcs0
[220.459255] Dynamic subtest bcs0: SUCCESS (1.629s)
[220.467632] Starting dynamic subtest: vcs0
[224.399563] Dynamic subtest vcs0: SUCCESS (3.937s)
[224.410360] Starting dynamic subtest: vcs1
[230.414803] Dynamic subtest vcs1: SUCCESS (6.013s)
[230.423584] Starting dynamic subtest: vecs0
[236.430711] Dynamic subtest vecs0: SUCCESS (6.014s)
[236.441179] Starting dynamic subtest: ccs0
[239.503382] Dynamic subtest ccs0: SUCCESS (3.071s)
[239.505906] Subtest semaphore-busy: SUCCESS (22.328s)
[239.657217] [045/134] (828s left) kms_rotation_crc (sprite-rotation-270)
[239.760834] Starting subtest: sprite-rotation-270
[239.765313] Subtest sprite-rotation-270: SKIP (0.001s)
[239.845717] [046/134] (828s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[239.909212] Starting subtest: multi-wait-all-available-submitted-signaled
[239.911600] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[240.029071] [047/134] (828s left) kms_psr (psr-primary-mmap-gtt)
[240.124151] Starting subtest: psr-primary-mmap-gtt
[240.126395] Starting dynamic subtest: eDP-1
[241.595440] Dynamic subtest eDP-1: SKIP (1.468s)
[241.600213] Subtest psr-primary-mmap-gtt: SKIP (1.470s)
[241.810292] [048/134] (826s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[242.199883] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[243.032776] [049/134] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[243.143572] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[243.147818] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[243.302328] [050/134] (825s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[243.383864] Starting subtest: fbc-psr2-cursor-mmap-gtt
[243.386106] Starting dynamic subtest: eDP-1
[243.390251] Dynamic subtest eDP-1: SKIP (0.000s)
[243.394243] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[243.469931] [051/134] (825s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[243.579339] Starting subtest: 4-tiled-8bpp-rotate-0
[244.790964] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.213s)
[244.947079] [052/134] (823s left) gem_exec_alignment (single)
[245.021571] Starting subtest: single
[245.026200] Subtest single: SUCCESS (0.003s)
[245.176165] [053/134] (823s left) gen7_exec_parse (basic-allocation)
[245.226544] Subtest basic-allocation: SKIP (0.000s)
[245.309132] [054/134] (823s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[245.375282] Starting subtest: legacy-engines-hostile-preempt
[245.377308] Starting dynamic subtest: render
[245.491328] Dynamic subtest render: SUCCESS (0.115s)
[245.502035] Starting dynamic subtest: bsd1
[246.907530] Dynamic subtest bsd1: SUCCESS (1.412s)
[246.921718] Starting dynamic subtest: bsd2
[248.901395] Dynamic subtest bsd2: SUCCESS (1.991s)
[248.911055] Starting dynamic subtest: blt
[249.014848] Dynamic subtest blt: SUCCESS (0.112s)
[249.025703] Starting dynamic subtest: vebox
[250.886417] Dynamic subtest vebox: SUCCESS (1.868s)
[250.889092] Subtest legacy-engines-hostile-preempt: SUCCESS (5.510s)
[250.988472] [055/134] (818s left) kms_psr (fbc-pr-cursor-plane-onoff)
[251.091312] Starting subtest: fbc-pr-cursor-plane-onoff
[251.095724] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[251.176065] [056/134] (817s left) gem_exec_await (wide-contexts)
[251.367245] Starting subtest: wide-contexts
[274.992538] Subtest wide-contexts: SUCCESS (23.625s)
[275.198486] [057/134] (793s left) syncobj_wait (signal)
[275.292677] Starting subtest: signal
[275.295088] Subtest signal: SUCCESS (0.000s)
[275.432022] [058/134] (793s left) syncobj_wait (multi-wait-submitted)
[275.503437] Starting subtest: multi-wait-submitted
[275.608559] Subtest multi-wait-submitted: SUCCESS (0.104s)
[275.700200] [059/134] (793s left) sw_sync (sync_merge)
[275.735154] Starting subtest: sync_merge
[275.737646] Subtest sync_merge: SUCCESS (0.000s)
[275.796778] [060/134] (793s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[275.899025] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[275.917077] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.016s)
[276.016893] [061/134] (793s left) kms_plane_alpha_blend (constant-alpha-mid)
[276.114187] Starting subtest: constant-alpha-mid
[276.420421] Starting dynamic subtest: pipe-A-eDP-1
[277.366279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.943s)
[277.375988] Starting dynamic subtest: pipe-D-eDP-1
[278.867665] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[278.870079] Subtest constant-alpha-mid: SUCCESS (2.757s)
[279.723812] [062/134] (789s left) kms_vblank (crtc-id)
[279.835985] Starting subtest: crtc-id
[279.837913] Starting dynamic subtest: pipe-A-eDP-1
[280.280147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[280.294508] Starting dynamic subtest: pipe-D-eDP-1
[281.434458] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.151s)
[281.436735] Subtest crtc-id: SUCCESS (1.599s)
[282.292320] [063/134] (787s left) gem_softpin (evict-prime)
[282.357590] Starting subtest: evict-prime
[282.359946] Starting dynamic subtest: rcs0
[283.548931] Dynamic subtest rcs0: SUCCESS (1.191s)
[283.560828] Starting dynamic subtest: bcs0
[284.703084] Dynamic subtest bcs0: SUCCESS (1.152s)
[284.714522] Starting dynamic subtest: vcs0
[285.873480] Dynamic subtest vcs0: SUCCESS (1.168s)
[285.884612] Starting dynamic subtest: vcs1
[287.931635] Dynamic subtest vcs1: SUCCESS (2.055s)
[287.943725] Starting dynamic subtest: vecs0
[289.961730] Dynamic subtest vecs0: SUCCESS (2.028s)
[289.972069] Starting dynamic subtest: ccs0
[291.121395] Dynamic subtest ccs0: SUCCESS (1.159s)
[291.133736] Starting dynamic subtest: all
[292.916627] Dynamic subtest all: SUCCESS (1.792s)
[292.919494] Subtest evict-prime: SUCCESS (10.558s)
[293.008764] [064/134] (776s left) kms_plane_scaling (planes-downscale-factor-0-75)
[293.117915] Starting subtest: planes-downscale-factor-0-75
[293.120251] Starting dynamic subtest: pipe-A
[293.140537] Dynamic subtest pipe-A: SKIP (0.018s)
[293.150155] Starting dynamic subtest: pipe-B
[293.173854] Dynamic subtest pipe-B: SKIP (0.032s)
[293.187900] Starting dynamic subtest: pipe-C
[293.207171] Dynamic subtest pipe-C: SKIP (0.033s)
[293.215829] Starting dynamic subtest: pipe-D
[293.240180] Dynamic subtest pipe-D: SKIP (0.033s)
[293.244287] Subtest planes-downscale-factor-0-75: SKIP (0.119s)
[293.380275] [065/134] (776s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[293.499875] Starting subtest: extended-pageflip-modeset-hang-oldfb
[293.501690] Starting dynamic subtest: pipe-A
[301.430743] Dynamic subtest pipe-A: SUCCESS (7.929s)
[301.440378] Starting dynamic subtest: pipe-D
[310.076808] Dynamic subtest pipe-D: SUCCESS (8.644s)
[310.079100] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.577s)
[310.934878] [066/134] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[311.044823] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[311.049079] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.188791] [067/134] (758s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[311.301623] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[311.306435] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[311.424034] [068/134] (758s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[311.485222] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[311.489606] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[311.679958] [069/134] (758s left) kms_psr (pr-dpms)
[311.779249] Starting subtest: pr-dpms
[311.783552] Subtest pr-dpms: SKIP (0.000s)
[311.865449] [070/134] (757s left) kms_draw_crc (draw-method-mmap-cpu)
[311.972300] Starting subtest: draw-method-mmap-cpu
[311.974193] Starting dynamic subtest: xrgb8888-untiled
[312.215216] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[312.224965] Starting dynamic subtest: rgb565-untiled
[312.415056] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[312.424632] Starting dynamic subtest: xrgb2101010-untiled
[312.636828] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[312.645876] Starting dynamic subtest: xbgr16161616f-untiled
[312.870300] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[312.879179] Starting dynamic subtest: xrgb8888-xtiled
[313.015994] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[313.024576] Starting dynamic subtest: rgb565-xtiled
[313.148030] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[313.157203] Starting dynamic subtest: xrgb2101010-xtiled
[313.281884] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[313.293643] Starting dynamic subtest: xbgr16161616f-xtiled
[313.414826] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[313.424255] Starting dynamic subtest: xrgb8888-4tiled
[313.559254] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.142s)
[313.568509] Starting dynamic subtest: rgb565-4tiled
[313.703487] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s)
[313.713126] Starting dynamic subtest: xrgb2101010-4tiled
[313.825797] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[313.834413] Starting dynamic subtest: xbgr16161616f-4tiled
[313.970228] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[313.972088] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[314.079191] [071/134] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[314.195251] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[320.789641] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.595s)
[320.924903] [072/134] (748s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[325.930464] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[325.934850] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[326.793053] [073/134] (743s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[326.908101] Starting subtest: x-tiled-64bpp-rotate-270
[326.927944] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[327.075866] [074/134] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[327.180533] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[327.184693] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[327.307612] [075/134] (742s left) gem_softpin (evict-snoop-interruptible)
[327.376045] Starting subtest: evict-snoop-interruptible
[327.380238] Subtest evict-snoop-interruptible: SKIP (0.000s)
[327.531626] [076/134] (742s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[327.636279] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[327.638415] Starting dynamic subtest: pipe-A-eDP-1
[327.660046] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.670566] Starting dynamic subtest: pipe-B-eDP-1
[327.691163] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.700062] Starting dynamic subtest: pipe-C-eDP-1
[327.718533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.726756] Starting dynamic subtest: pipe-D-eDP-1
[327.744779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.748118] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[329.965820] [077/134] (740s left) perf_pmu (busy-idle-no-semaphores)
[330.011942] Starting subtest: busy-idle-no-semaphores
[330.014271] Starting dynamic subtest: rcs0
[330.678339] Dynamic subtest rcs0: SUCCESS (0.666s)
[330.689525] Starting dynamic subtest: bcs0
[331.330926] Dynamic subtest bcs0: SUCCESS (0.650s)
[331.341334] Starting dynamic subtest: vcs0
[331.983134] Dynamic subtest vcs0: SUCCESS (0.650s)
[331.994772] Starting dynamic subtest: vcs1
[333.500397] Dynamic subtest vcs1: SUCCESS (1.515s)
[333.511808] Starting dynamic subtest: vecs0
[335.551410] Dynamic subtest vecs0: SUCCESS (2.048s)
[335.563678] Starting dynamic subtest: ccs0
[337.533049] Dynamic subtest ccs0: SUCCESS (1.979s)
[337.536051] Subtest busy-idle-no-semaphores: SUCCESS (7.522s)
[337.664124] [078/134] (732s left) gem_mmap_offset (open-flood)
[337.725079] Starting subtest: open-flood
[359.213135] Subtest open-flood: SUCCESS (21.489s)
[359.347807] [079/134] (710s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[359.413476] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[359.520997] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[359.611546] [080/134] (710s left) gen9_exec_parse (allowed-single)
[359.673875] Subtest allowed-single: SKIP (0.000s)
[359.753102] [081/134] (710s left) gem_render_copy (linear-to-vebox-yf-tiled)
[359.825762] Starting subtest: linear-to-vebox-yf-tiled
[359.830094] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[360.023229] [082/134] (710s left) kms_vblank (wait-busy-hang)
[360.135814] Starting subtest: wait-busy-hang
[360.138049] Starting dynamic subtest: pipe-A-eDP-1
[386.650913] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.512s)
[386.666142] Starting dynamic subtest: pipe-D-eDP-1
[401.701885] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.047s)
[401.704151] Subtest wait-busy-hang: SUCCESS (41.565s)
[402.515105] [083/134] (667s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[402.634649] Starting subtest: 2x-long-flip-vs-cursor-legacy
[402.641607] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[402.791534] [084/134] (667s left) syncobj_timeline (single-wait-all-available-submitted)
[402.863469] Starting subtest: single-wait-all-available-submitted
[402.865641] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[403.006397] [085/134] (667s left) kms_chamelium_audio (dp-audio-edid)
[403.399914] Subtest dp-audio-edid: SKIP (0.000s)
[404.214037] [086/134] (666s left) kms_frontbuffer_tracking (psr-suspend)
[404.308048] Starting subtest: psr-suspend
[443.508046] Subtest psr-suspend: SUCCESS (8.107s)
[443.683666] [087/134] (626s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[444.232698] Starting subtest: syncobj-stationary-timeline-chain-engines
[444.332050] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.103s)
[446.206978] [088/134] (624s left) gem_exec_schedule (u-semaphore-user)
[446.288631] Starting subtest: u-semaphore-user
[446.348344] Subtest u-semaphore-user: SUCCESS (0.065s)
[448.121819] [089/134] (622s left) gem_ctx_isolation (preservation-reset)
[448.298414] Starting subtest: preservation-reset
[448.300666] Starting dynamic subtest: rcs0
[448.604808] Dynamic subtest rcs0: SUCCESS (0.313s)
[448.615198] Starting dynamic subtest: bcs0
[448.973544] Dynamic subtest bcs0: SUCCESS (0.375s)
[448.986209] Starting dynamic subtest: vcs0
[449.319521] Dynamic subtest vcs0: SUCCESS (0.352s)
[449.332202] Starting dynamic subtest: vcs1
[451.387556] Dynamic subtest vcs1: SUCCESS (2.097s)
[451.397538] Starting dynamic subtest: vecs0
[453.380939] Dynamic subtest vecs0: SUCCESS (2.014s)
[453.393950] Starting dynamic subtest: ccs0
[455.383803] Dynamic subtest ccs0: SUCCESS (2.019s)
[455.386245] Subtest preservation-reset: SUCCESS (7.178s)
[455.552257] [090/134] (614s left) kms_cursor_crc (cursor-onscreen-512x512)
[455.847304] Starting subtest: cursor-onscreen-512x512
[455.851570] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[456.054300] [091/134] (614s left) gem_exec_fence (basic-wait)
[456.226616] Starting subtest: basic-wait
[456.228859] Starting dynamic subtest: rcs0
[456.333340] Dynamic subtest rcs0: SUCCESS (0.107s)
[456.346813] Starting dynamic subtest: bcs0
[456.400687] Dynamic subtest bcs0: SUCCESS (0.065s)
[456.412780] Starting dynamic subtest: vcs0
[456.462546] Dynamic subtest vcs0: SUCCESS (0.060s)
[456.474984] Starting dynamic subtest: vcs1
[456.522989] Dynamic subtest vcs1: SUCCESS (0.059s)
[456.534281] Starting dynamic subtest: vecs0
[456.575283] Dynamic subtest vecs0: SUCCESS (0.051s)
[456.586224] Starting dynamic subtest: ccs0
[456.626377] Dynamic subtest ccs0: SUCCESS (0.050s)
[456.628662] Subtest basic-wait: SUCCESS (0.403s)
[458.185779] [092/134] (612s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[458.289789] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[458.317756] Starting dynamic subtest: pipe-A-plane-0
[458.322312] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[458.332733] Starting dynamic subtest: pipe-A-plane-3
[458.337413] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[458.349909] Starting dynamic subtest: pipe-A-plane-5
[458.354416] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[459.435676] Starting dynamic subtest: pipe-B-plane-0
[459.440113] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[459.450456] Starting dynamic subtest: pipe-B-plane-3
[459.454385] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[459.463960] Starting dynamic subtest: pipe-B-plane-5
[459.468114] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[459.734789] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (1.449s)
[460.604715] [093/134] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[460.716144] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[460.720351] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[460.848601] [094/134] (609s left) kms_psr (psr2-sprite-plane-onoff)
[460.958223] Starting subtest: psr2-sprite-plane-onoff
[460.960411] Starting dynamic subtest: eDP-1
[462.686827] Dynamic subtest eDP-1: SUCCESS (1.734s)
[462.689047] Subtest psr2-sprite-plane-onoff: SUCCESS (1.735s)
[463.546623] [095/134] (607s left) gem_workarounds (suspend-resume-context)
[463.625572] Starting subtest: suspend-resume-context
[479.999791] Subtest suspend-resume-context: SUCCESS (1.190s)
[480.147176] [096/134] (590s left) gem_exec_params (cliprects_ptr-dirt)
[480.219780] Starting subtest: cliprects_ptr-dirt
[480.222456] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[480.337681] [097/134] (590s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[480.438715] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[480.443736] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[480.559415] [098/134] (590s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[480.662866] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[480.665340] Starting dynamic subtest: pipe-A-default-mode
[481.834817] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[481.840730] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.170s)
[482.066471] [099/134] (588s left) gem_exec_suspend (basic-s0)
[482.141678] Starting subtest: basic-S0
[482.144357] Starting dynamic subtest: smem
[502.890722] Dynamic subtest smem: SUCCESS (7.098s)
[502.893322] Subtest basic-S0: SUCCESS (7.100s)
[503.086479] [100/134] (567s left) gem_exec_reloc (basic-cpu-active)
[503.166057] Subtest basic-cpu-active: SKIP (0.000s)
[503.239317] [101/134] (567s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[503.285617] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[503.287779] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[503.397685] [102/134] (567s left) gem_exec_reloc (basic-wc-gtt-active)
[503.461364] Subtest basic-wc-gtt-active: SKIP (0.000s)
[503.550863] [103/134] (567s left) kms_plane (plane-position-hole-dpms)
[503.658622] Starting subtest: plane-position-hole-dpms
[504.181846] Starting dynamic subtest: pipe-A-plane-1
[506.538221] Dynamic subtest pipe-A-plane-1: SUCCESS (2.414s)
[506.549041] Starting dynamic subtest: pipe-A-plane-2
[508.968186] Dynamic subtest pipe-A-plane-2: SUCCESS (2.471s)
[508.978608] Starting dynamic subtest: pipe-A-plane-3
[511.385383] Dynamic subtest pipe-A-plane-3: SUCCESS (2.446s)
[511.396595] Starting dynamic subtest: pipe-A-plane-4
[513.736213] Dynamic subtest pipe-A-plane-4: SUCCESS (2.372s)
[513.747056] Starting dynamic subtest: pipe-A-plane-5
[513.760325] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[514.910517] Starting dynamic subtest: pipe-B-plane-1
[517.266165] Dynamic subtest pipe-B-plane-1: SUCCESS (2.380s)
[517.277052] Starting dynamic subtest: pipe-B-plane-2
[519.686201] Dynamic subtest pipe-B-plane-2: SUCCESS (2.431s)
[519.697090] Starting dynamic subtest: pipe-B-plane-3
[522.043846] Dynamic subtest pipe-B-plane-3: SUCCESS (2.365s)
[522.054290] Starting dynamic subtest: pipe-B-plane-4
[524.392464] Dynamic subtest pipe-B-plane-4: SUCCESS (2.355s)
[524.403657] Starting dynamic subtest: pipe-B-plane-5
[524.419404] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[524.421736] Subtest plane-position-hole-dpms: SUCCESS (20.977s)
[525.208792] [104/134] (545s left) kms_content_protection (lic-type-0)
[525.362802] Starting subtest: lic-type-0
[525.367391] Subtest lic-type-0: SKIP (0.000s)
[525.529544] [105/134] (545s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[525.636189] Starting subtest: psr-rgb565-draw-blt
[532.654133] Subtest psr-rgb565-draw-blt: SUCCESS (7.029s)
[532.825370] [106/134] (538s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[532.926059] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[532.930490] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[534.057136] [107/134] (537s left) gem_ctx_shared (create-shared-gtt)
[534.133369] Starting subtest: create-shared-gtt
[536.287274] Subtest create-shared-gtt: SUCCESS (2.151s)
[536.703932] [108/134] (534s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[536.802515] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[537.881538] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.079s)
[538.029194] [109/134] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[538.127064] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[538.130465] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[538.260570] [110/134] (533s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[538.353455] Starting subtest: plane-primary-toggle-with-vblank-wait
[538.355355] Starting dynamic subtest: pipe-A-eDP-1
[538.526678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[538.832393] Starting dynamic subtest: pipe-B-eDP-1
[539.736074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.912s)
[540.044183] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.691s)
[540.909915] [111/134] (530s left) fbdev (unaligned-write)
[540.956445] Starting subtest: unaligned-write
[541.057831] Subtest unaligned-write: SUCCESS (0.100s)
[541.136515] [112/134] (530s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[546.179557] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[546.184069] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[547.058067] [113/134] (524s left) i915_query (engine-info-invalid)
[547.111988] Starting subtest: engine-info-invalid
[547.113824] Subtest engine-info-invalid: SUCCESS (0.000s)
[547.221333] [114/134] (524s left) gem_exec_create (forked)
[547.284945] Starting subtest: forked
[547.287212] Starting dynamic subtest: smem
[568.939165] Dynamic subtest smem: SUCCESS (21.659s)
[568.941834] Subtest forked: SUCCESS (21.661s)
[569.143226] [115/134] (502s left) gem_userptr_blits (access-control)
[569.222439] Starting subtest: access-control
[569.227550] Subtest access-control: SKIP (0.000s)
[569.376096] [116/134] (502s left) kms_color_pipeline (plane-lut1d-lut1d)
[569.481779] Starting subtest: plane-lut1d-lut1d
[569.495402] Starting dynamic subtest: pipe-A-eDP-1
[570.196095] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[570.911895] Starting dynamic subtest: pipe-B-eDP-1
[571.771222] Dynamic subtest pipe-B-eDP-1: FAIL (0.344s)
[572.335701] Starting dynamic subtest: pipe-C-eDP-1
[573.175219] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[573.670236] Starting dynamic subtest: pipe-D-eDP-1
[574.481021] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[574.483063] Subtest plane-lut1d-lut1d: FAIL (4.728s)
[575.068450] [117/134] (496s left) kms_cursor_crc (cursor-suspend)
[575.212460] Starting subtest: cursor-suspend
[575.214735] Starting dynamic subtest: pipe-A-eDP-1
[608.478306] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.165s)
[608.493852] Starting dynamic subtest: pipe-D-eDP-1
[642.433604] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.783s)
[642.436185] Subtest cursor-suspend: SUCCESS (6.951s)
[643.283043] [118/134] (428s left) gem_exec_balancer (invalid-bonds)
[643.361152] Starting subtest: invalid-bonds
[643.366038] Subtest invalid-bonds: SKIP (0.000s)
[643.692013] [119/134] (428s left) perf (non-sampling-read-error)
[643.819737] Starting subtest: non-sampling-read-error
[643.829482] Subtest non-sampling-read-error: SUCCESS (0.010s)
[643.871425] [120/134] (428s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[643.981725] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[643.986857] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[644.104313] [121/134] (427s left) sw_sync (sync_multi_producer_single_consumer)
[644.149431] Starting subtest: sync_multi_producer_single_consumer
[645.185550] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[645.246522] [122/134] (426s left) kms_universal_plane (cursor-fb-leak)
[645.344883] Starting subtest: cursor-fb-leak
[645.346878] Starting dynamic subtest: pipe-A-eDP-1
[645.692590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.360s)
[645.707929] Starting dynamic subtest: pipe-B-eDP-1
[647.021779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[647.033608] Starting dynamic subtest: pipe-C-eDP-1
[648.406323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s)
[648.419157] Starting dynamic subtest: pipe-D-eDP-1
[649.816721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[649.819393] Subtest cursor-fb-leak: SUCCESS (4.586s)
[651.054019] [123/134] (420s left) dmabuf (all-tests)
[651.100968] Starting subtest: all-tests
[651.103436] Starting dynamic subtest: sanitycheck
[651.228885] Dynamic subtest sanitycheck: SUCCESS (0.132s)
[651.244922] Starting dynamic subtest: dma_fence
[651.530054] Dynamic subtest dma_fence: SUCCESS (0.302s)
[651.543915] Starting dynamic subtest: dma_fence_chain
[659.739873] Dynamic subtest dma_fence_chain: SUCCESS (8.280s)
[659.753934] Starting dynamic subtest: dma_fence_unwrap
[659.866452] Dynamic subtest dma_fence_unwrap: SUCCESS (0.125s)
[659.880919] Starting dynamic subtest: dma_resv
[660.011163] Dynamic subtest dma_resv: SUCCESS (0.143s)
[660.014181] Subtest all-tests: SUCCESS (8.994s)
[660.090398] [124/134] (411s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[660.187936] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[660.190900] Starting dynamic subtest: pipe-A-default-mode
[660.486720] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[660.491902] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.299s)
[661.296413] [125/134] (410s left) gem_exec_reloc (basic-write-wc)
[661.361201] Subtest basic-write-wc: SKIP (0.000s)
[661.443818] [126/134] (410s left) sysfs_preempt_timeout (invalid)
[661.525944] Starting subtest: invalid
[661.528632] Starting dynamic subtest: vecs0
[661.531172] Dynamic subtest vecs0: SUCCESS (0.000s)
[661.542753] Starting dynamic subtest: ccs0
[661.544985] Dynamic subtest ccs0: SUCCESS (0.000s)
[661.555212] Starting dynamic subtest: vcs0
[661.557642] Dynamic subtest vcs0: SUCCESS (0.000s)
[661.567193] Starting dynamic subtest: bcs0
[661.569691] Dynamic subtest bcs0: SUCCESS (0.000s)
[661.579596] Starting dynamic subtest: rcs0
[661.581952] Dynamic subtest rcs0: SUCCESS (0.000s)
[661.592219] Starting dynamic subtest: vcs1
[661.594954] Dynamic subtest vcs1: SUCCESS (0.000s)
[661.597674] Subtest invalid: SUCCESS (0.008s)
[661.661464] [127/134] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[661.759372] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[668.574086] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.836s)
[668.727439] [128/134] (403s left) kms_lease (lease-uevent)
[668.828213] Starting subtest: lease-uevent
[669.838819] Subtest lease-uevent: SUCCESS (1.013s)
[669.925500] [129/134] (402s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[670.028154] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[670.033957] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[671.132987] [130/134] (401s left) kms_plane_multiple (2x-tiling-y)
[671.248083] Starting subtest: 2x-tiling-y
[671.254035] Subtest 2x-tiling-y: SKIP (0.000s)
[671.352376] [131/134] (401s left) kms_getfb (getfb2-into-addfb2)
[671.456173] Starting subtest: getfb2-into-addfb2
[671.459085] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[671.577965] [132/134] (400s left) kms_joiner (basic-max-non-joiner)
[671.685211] Starting subtest: basic-max-non-joiner
[671.689926] Subtest basic-max-non-joiner: SKIP (0.000s)
[671.755414] [133/134] (400s left) kms_psr (fbc-psr-basic)
[671.845869] Starting subtest: fbc-psr-basic
[671.848223] Starting dynamic subtest: eDP-1
[671.853569] Dynamic subtest eDP-1: SKIP (0.000s)
[671.858313] Subtest fbc-psr-basic: SKIP (0.001s)
[671.929565] [134/134] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[672.039999] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[676.285364] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.255s)
[677.435785] 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.