[57.702220] Initializing watchdogs
[57.702269]   /dev/watchdog0
[57.715309] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.719463] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.721615] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.724993] [001/130] (960s left) perf_pmu (gt-awake)
[57.791639] Starting subtest: gt-awake
[66.902816] Subtest gt-awake: SUCCESS (9.111s)
[67.447652] [002/130] (950s left) i915_getparams_basic (basic-eu-total)
[67.556973] Starting subtest: basic-eu-total
[67.561384] Subtest basic-eu-total: SUCCESS (0.000s)
[67.690755] [003/130] (950s left) kms_psr (fbc-psr2-sprite-plane-move)
[67.823158] Starting subtest: fbc-psr2-sprite-plane-move
[67.825655] Starting dynamic subtest: eDP-1
[67.830051] Dynamic subtest eDP-1: SKIP (0.000s)
[67.834347] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[67.918189] [004/130] (950s left) kms_getfb (getfb2-accept-nv12)
[68.123102] Starting subtest: getfb2-accept-nv12
[68.125449] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[68.253141] [005/130] (950s left) syncobj_timeline (etime-single-wait-submitted)
[68.305872] Starting subtest: etime-single-wait-submitted
[68.410559] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[68.505377] [006/130] (949s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[68.606317] Starting subtest: fbcpsr-tiling-4
[75.552844] Subtest fbcpsr-tiling-4: SUCCESS (6.949s)
[75.729330] [007/130] (942s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[75.848291] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[75.852203] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[75.990830] [008/130] (942s left) gem_create (create-size-update)
[76.058124] Starting subtest: create-size-update
[76.060620] Subtest create-size-update: SUCCESS (0.000s)
[76.309768] [009/130] (942s left) gem_exec_nop (basic-parallel)
[76.391072] Starting subtest: basic-parallel
[92.951223] Subtest basic-parallel: SUCCESS (16.571s)
[93.215703] [010/130] (925s left) perf_pmu (rc6)
[93.259641] Starting subtest: rc6
[93.262287] Starting dynamic subtest: gt0
[99.641781] Dynamic subtest gt0: SUCCESS (6.381s)
[99.652310] Starting dynamic subtest: runtime-pm-gt0
[107.375491] Dynamic subtest runtime-pm-gt0: SUCCESS (7.733s)
[107.382965] Starting dynamic subtest: runtime-pm-long-gt0
[119.820221] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.444s)
[119.828496] Starting dynamic subtest: other-idle-gt0
[126.162450] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[126.170831] Starting dynamic subtest: gt1
[132.502812] Dynamic subtest gt1: SUCCESS (6.339s)
[132.511106] Starting dynamic subtest: runtime-pm-gt1
[139.948336] Dynamic subtest runtime-pm-gt1: SUCCESS (7.444s)
[139.958778] Starting dynamic subtest: runtime-pm-long-gt1
[152.409888] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.459s)
[152.420366] Starting dynamic subtest: other-idle-gt1
[158.750986] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[158.753827] Subtest rc6: SUCCESS (65.490s)
[159.892537] [011/130] (858s left) kms_cursor_crc (cursor-sliding-64x64)
[160.079839] Starting subtest: cursor-sliding-64x64
[160.083989] Starting dynamic subtest: pipe-A-eDP-1
[163.315731] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.230s)
[163.345035] Starting dynamic subtest: pipe-D-eDP-1
[167.180036] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.840s)
[167.182406] Subtest cursor-sliding-64x64: SUCCESS (7.098s)
[167.953943] [012/130] (850s left) perf (rc6-disable)
[168.053144] Starting subtest: rc6-disable
[168.233689] Subtest rc6-disable: SUCCESS (0.180s)
[168.285539] [013/130] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[168.341016] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[168.450344] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[168.501297] [014/130] (850s left) gem_workarounds (suspend-resume-fd)
[168.579192] Starting subtest: suspend-resume-fd
[184.488267] Subtest suspend-resume-fd: SUCCESS (5.568s)
[184.618195] [015/130] (834s left) gem_basic (create-close)
[184.683961] Starting subtest: create-close
[184.688424] Subtest create-close: SUCCESS (0.000s)
[184.775916] [016/130] (834s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[184.837550] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[184.943343] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[184.988955] [017/130] (833s left) gen7_exec_parse (basic-allowed)
[185.053719] Subtest basic-allowed: SKIP (0.000s)
[185.132028] [018/130] (833s left) prime_busy (after-wait)
[185.191590] Starting subtest: after-wait
[185.196498] Starting dynamic subtest: rcs0
[185.242326] Dynamic subtest rcs0: SUCCESS (0.048s)
[185.251381] Starting dynamic subtest: bcs0
[185.304480] Dynamic subtest bcs0: SUCCESS (0.061s)
[185.312599] Starting dynamic subtest: vcs0
[185.343548] Dynamic subtest vcs0: SUCCESS (0.039s)
[185.351110] Starting dynamic subtest: vcs1
[185.383138] Dynamic subtest vcs1: SUCCESS (0.039s)
[185.390670] Starting dynamic subtest: vecs0
[185.424644] Dynamic subtest vecs0: SUCCESS (0.041s)
[185.433994] Starting dynamic subtest: ccs0
[185.464860] Dynamic subtest ccs0: SUCCESS (0.040s)
[185.573069] Subtest after-wait: SUCCESS (0.379s)
[185.623290] [019/130] (833s left) i915_query (engine-info-invalid)
[185.674637] Starting subtest: engine-info-invalid
[185.676897] Subtest engine-info-invalid: SUCCESS (0.000s)
[185.769064] [020/130] (833s left) kms_flip (2x-flip-vs-dpms-on-nop)
[185.875153] Starting subtest: 2x-flip-vs-dpms-on-nop
[185.885978] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[185.981091] [021/130] (833s left) gem_eio (in-flight-internal-1us)
[186.230764] Starting subtest: in-flight-internal-1us
[187.338795] Subtest in-flight-internal-1us: SUCCESS (1.106s)
[187.477558] [022/130] (831s left) kms_psr2_su (page_flip-xrgb8888)
[187.538009] Subtest page_flip-XRGB8888: SKIP (0.000s)
[187.609167] [023/130] (831s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[187.666000] Starting subtest: x-tiled-to-vebox-yf-tiled
[187.670359] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[187.832793] [024/130] (831s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[187.936161] Starting subtest: yf-tiled-16bpp-rotate-270
[187.940403] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[188.011589] [025/130] (831s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[188.104390] Starting subtest: bad-pixel-format-y-tiled-ccs
[188.106682] Starting dynamic subtest: pipe-A-eDP-1
[188.128629] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.139138] Starting dynamic subtest: pipe-B-eDP-1
[188.159694] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.167356] Starting dynamic subtest: pipe-C-eDP-1
[188.187623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.195146] Starting dynamic subtest: pipe-D-eDP-1
[188.216041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.220203] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[190.324674] [026/130] (828s left) gem_exec_params (dr1-dirt)
[190.397142] Starting subtest: DR1-dirt
[190.399293] Subtest DR1-dirt: SUCCESS (0.000s)
[190.483912] [027/130] (828s left) kms_color (legacy-gamma)
[190.572700] Starting subtest: legacy-gamma
[190.574856] Starting dynamic subtest: pipe-A-eDP-1
[191.259304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[191.269336] Starting dynamic subtest: pipe-B-eDP-1
[192.646516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s)
[192.656756] Starting dynamic subtest: pipe-C-eDP-1
[193.988420] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[193.997137] Starting dynamic subtest: pipe-D-eDP-1
[195.367559] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s)
[195.369790] Subtest legacy-gamma: SUCCESS (4.795s)
[196.149548] [028/130] (823s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[196.247337] Starting subtest: x-tiled-8bpp-rotate-0
[197.439406] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[197.549209] [029/130] (821s left) prime_mmap (test_correct)
[197.620813] Starting subtest: test_correct
[197.623389] Starting dynamic subtest: test_correct-smem
[197.653896] Dynamic subtest test_correct-smem: SUCCESS (0.034s)
[197.656024] Subtest test_correct: SUCCESS (0.034s)
[197.750465] [030/130] (821s left) kms_pm_backlight (fade-with-suspend)
[197.854050] Starting subtest: fade-with-suspend
[214.512826] Starting dynamic subtest: eDP-1
[217.177026] Dynamic subtest eDP-1: SUCCESS (2.673s)
[217.179566] Subtest fade-with-suspend: SUCCESS (3.921s)
[217.974409] [031/130] (801s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[222.966874] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[222.971808] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[223.814115] [032/130] (795s left) gem_ppgtt (blt-vs-render-ctx0)
[223.877964] Starting subtest: blt-vs-render-ctx0
[256.830118] Subtest blt-vs-render-ctx0: SUCCESS (32.943s)
[256.940436] [033/130] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[257.085976] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[257.088216] Starting dynamic subtest: pipe-A-eDP-1
[257.147088] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.157836] Starting dynamic subtest: pipe-B-eDP-1
[257.215677] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.226081] Starting dynamic subtest: pipe-C-eDP-1
[257.281097] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.290784] Starting dynamic subtest: pipe-D-eDP-1
[257.347982] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[257.352141] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[259.374564] [034/130] (760s left) gem_lmem_swapping (verify-random-ccs)
[259.425353] Subtest verify-random-ccs: SKIP (0.000s)
[259.469382] [035/130] (760s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[259.562616] Starting subtest: plane-primary-toggle-with-vblank-wait
[259.564977] Starting dynamic subtest: pipe-A-eDP-1
[259.734401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[260.041978] Starting dynamic subtest: pipe-B-eDP-1
[260.904533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.872s)
[261.211386] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.651s)
[262.049636] [036/130] (757s left) gem_exec_alignment (pi-isolated)
[262.118356] Starting subtest: pi-isolated
[312.269447] Subtest pi-isolated: SUCCESS (50.138s)
[313.386066] [037/130] (706s left) kms_pm_rpm (modeset-stress-extra-wait)
[314.990607] Starting subtest: modeset-stress-extra-wait
[369.249764] Subtest modeset-stress-extra-wait: SUCCESS (54.262s)
[369.315189] [038/130] (650s left) gem_exec_params (cliprects_ptr-dirt)
[369.370959] Starting subtest: cliprects_ptr-dirt
[369.373614] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[369.448455] [039/130] (650s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[369.554688] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[369.558841] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[369.653540] [040/130] (650s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[369.755430] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[369.757613] Starting dynamic subtest: pipe-A-eDP-1
[369.779133] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[369.788250] Starting dynamic subtest: pipe-B-eDP-1
[369.809309] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[369.823952] Starting dynamic subtest: pipe-C-eDP-1
[369.846642] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[369.857959] Starting dynamic subtest: pipe-D-eDP-1
[369.880387] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[369.884445] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[372.044475] [041/130] (647s left) kms_busy (extended-modeset-hang-newfb)
[372.149928] Starting subtest: extended-modeset-hang-newfb
[372.152539] Starting dynamic subtest: pipe-A
[406.573191] Dynamic subtest pipe-A: SUCCESS (34.420s)
[406.583856] Starting dynamic subtest: pipe-D
[429.547912] Dynamic subtest pipe-D: SUCCESS (22.967s)
[429.550334] Subtest extended-modeset-hang-newfb: SUCCESS (57.394s)
[430.323126] [042/130] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[430.441648] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[430.445843] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[430.534948] [043/130] (589s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[430.599361] Starting subtest: multi-wait-available-unsubmitted-signaled
[430.601500] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[430.693837] [044/130] (589s left) gem_softpin (evict-prime)
[430.759593] Starting subtest: evict-prime
[430.761938] Starting dynamic subtest: rcs0
[431.959448] Dynamic subtest rcs0: SUCCESS (1.199s)
[431.972003] Starting dynamic subtest: bcs0
[433.127218] Dynamic subtest bcs0: SUCCESS (1.165s)
[433.140480] Starting dynamic subtest: vcs0
[434.696846] Dynamic subtest vcs0: SUCCESS (1.566s)
[434.709588] Starting dynamic subtest: vcs1
[436.657693] Dynamic subtest vcs1: SUCCESS (1.959s)
[436.670066] Starting dynamic subtest: vecs0
[438.646608] Dynamic subtest vecs0: SUCCESS (1.987s)
[438.659027] Starting dynamic subtest: ccs0
[439.803706] Dynamic subtest ccs0: SUCCESS (1.157s)
[439.816822] Starting dynamic subtest: all
[441.635735] Dynamic subtest all: SUCCESS (1.828s)
[441.638373] Subtest evict-prime: SUCCESS (10.874s)
[441.690247] [045/130] (578s left) gem_exec_schedule (preempt-queue)
[441.789738] Subtest preempt-queue: SKIP (0.000s)
[442.060860] [046/130] (577s left) gem_userptr_blits (coherency-unsync)
[442.127870] Subtest coherency-unsync: SKIP (0.000s)
[442.245230] [047/130] (577s left) kms_cursor_legacy (single-move)
[442.375852] Starting subtest: single-move
[442.377735] Starting dynamic subtest: pipe-A
[447.758085] Dynamic subtest pipe-A: SUCCESS (5.380s)
[447.770363] Starting dynamic subtest: pipe-B
[453.139882] Dynamic subtest pipe-B: SUCCESS (5.380s)
[453.151770] Starting dynamic subtest: pipe-C
[458.521737] Dynamic subtest pipe-C: SUCCESS (5.380s)
[458.533210] Starting dynamic subtest: pipe-D
[463.903739] Dynamic subtest pipe-D: SUCCESS (5.380s)
[463.916014] Starting dynamic subtest: all-pipes
[469.291991] Dynamic subtest all-pipes: SUCCESS (5.387s)
[469.294490] Subtest single-move: SUCCESS (26.917s)
[469.410433] [048/130] (550s left) kms_vblank (query-forked-busy)
[469.513266] Starting subtest: query-forked-busy
[469.515134] Starting dynamic subtest: pipe-A-eDP-1
[471.391451] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[471.406821] Starting dynamic subtest: pipe-D-eDP-1
[473.984901] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[473.986827] Subtest query-forked-busy: SUCCESS (4.472s)
[474.781020] [049/130] (545s left) gem_pwrite (basic-exhaustion)
[474.849666] Subtest basic-exhaustion: SKIP (0.000s)
[474.936994] [050/130] (545s left) gem_userptr_blits (sync-unmap)
[474.996869] Starting subtest: sync-unmap
[475.007831] Subtest sync-unmap: SUCCESS (0.014s)
[475.123580] [051/130] (545s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[475.222197] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[475.979764] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[476.104653] [052/130] (544s left) perf_pmu (busy-double-start)
[476.143881] Starting subtest: busy-double-start
[476.145758] Starting dynamic subtest: rcs0
[479.785639] Dynamic subtest rcs0: FAIL (3.589s)
[479.796285] Starting dynamic subtest: bcs0
[483.303093] Dynamic subtest bcs0: SUCCESS (3.571s)
[483.315214] Starting dynamic subtest: vcs0
[487.131960] Dynamic subtest vcs0: SUCCESS (3.827s)
[487.141900] Starting dynamic subtest: vcs1
[491.172014] Dynamic subtest vcs1: SUCCESS (4.038s)
[491.183405] Starting dynamic subtest: vecs0
[495.171798] Dynamic subtest vecs0: SUCCESS (3.998s)
[495.183206] Starting dynamic subtest: ccs0
[498.806420] Dynamic subtest ccs0: FAIL (3.566s)
[498.808453] Subtest busy-double-start: FAIL (22.597s)
[498.875510] [053/130] (521s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[498.949243] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[499.052829] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[499.104673] [054/130] (521s left) gem_exec_fence (basic-wait)
[499.286240] Starting subtest: basic-wait
[499.288821] Starting dynamic subtest: rcs0
[499.397768] Dynamic subtest rcs0: SUCCESS (0.112s)
[499.410320] Starting dynamic subtest: bcs0
[499.465207] Dynamic subtest bcs0: SUCCESS (0.065s)
[499.477203] Starting dynamic subtest: vcs0
[499.529234] Dynamic subtest vcs0: SUCCESS (0.062s)
[499.541209] Starting dynamic subtest: vcs1
[499.594218] Dynamic subtest vcs1: SUCCESS (0.063s)
[499.605377] Starting dynamic subtest: vecs0
[499.660086] Dynamic subtest vecs0: SUCCESS (0.064s)
[499.671580] Starting dynamic subtest: ccs0
[499.726866] Dynamic subtest ccs0: SUCCESS (0.065s)
[499.729129] Subtest basic-wait: SUCCESS (0.442s)
[501.727830] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[501.731046] [055/130] (518s left) kms_addfb_basic (addfb25-modifier-no-flag)
[501.822135] Starting subtest: addfb25-modifier-no-flag
[501.824069] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[501.908965] [056/130] (518s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[502.002540] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[502.004845] Starting dynamic subtest: pipe-A-eDP-1
[502.064131] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[502.075365] Starting dynamic subtest: pipe-B-eDP-1
[502.135381] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[502.146135] Starting dynamic subtest: pipe-C-eDP-1
[502.203047] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[502.213618] Starting dynamic subtest: pipe-D-eDP-1
[502.269916] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[502.274238] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[504.133554] [057/130] (516s left) kms_fb_coherency (memset-crc)
[504.230090] Starting subtest: memset-crc
[504.232388] Starting dynamic subtest: mmap-offset-wc
[504.899844] Dynamic subtest mmap-offset-wc: CRASH (0.143s)
[505.390871] Subtest memset-crc: CRASH (0.611s)
[505.428445] [058/130] (515s left) gem_lmem_swapping (massive)
[505.467079] Subtest massive: SKIP (0.000s)
[505.514619] [059/130] (514s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[505.898830] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[506.665115] [060/130] (513s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[506.774304] Starting subtest: async-flip-with-page-flip-events-linear
[507.147803] Starting dynamic subtest: pipe-A-eDP-1
[509.963637] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s)
[510.326648] Starting dynamic subtest: pipe-B-eDP-1
[513.093901] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[513.469755] Starting dynamic subtest: pipe-C-eDP-1
[516.230126] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[516.605295] Starting dynamic subtest: pipe-D-eDP-1
[519.351661] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[519.354251] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.578s)
[520.517840] [061/130] (500s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[520.586705] Starting subtest: stress-mm-invalidate-close-overlap
[522.735527] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[522.865376] [062/130] (497s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[522.969581] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[527.399509] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.433s)
[528.519768] [063/130] (492s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[528.608172] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[528.619047] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[528.720555] [064/130] (491s left) kms_flip (plain-flip-fb-recreate-interruptible)
[528.819729] Starting subtest: plain-flip-fb-recreate-interruptible
[528.821911] Starting dynamic subtest: A-eDP1
[537.625227] Dynamic subtest A-eDP1: SUCCESS (8.805s)
[537.634931] Starting dynamic subtest: B-eDP1
[546.451233] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[546.462015] Starting dynamic subtest: C-eDP1
[555.271039] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[555.290022] Starting dynamic subtest: D-eDP1
[564.093468] Dynamic subtest D-eDP1: SUCCESS (8.819s)
[564.098124] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.275s)
[565.258806] [065/130] (455s left) gem_exec_fence (syncobj-repeat)
[565.671371] Starting subtest: syncobj-repeat
[565.846759] Subtest syncobj-repeat: SUCCESS (0.174s)
[566.661195] [066/130] (454s left) i915_query (query-topology-coherent-slice-mask)
[566.723116] Starting subtest: query-topology-coherent-slice-mask
[566.727445] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[566.805858] [067/130] (454s left) kms_cursor_crc (cursor-onscreen-512x512)
[567.072108] Starting subtest: cursor-onscreen-512x512
[567.076649] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[567.222185] [068/130] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[567.333790] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[567.337887] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[567.430401] [069/130] (453s left) kms_plane_scaling (invalid-num-scalers)
[567.521373] Starting subtest: invalid-num-scalers
[567.523576] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[567.537527] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[567.547243] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[567.569333] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[567.579219] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[567.599463] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[567.608917] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[567.630228] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[567.632365] Subtest invalid-num-scalers: SUCCESS (0.109s)
[567.701143] [070/130] (453s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[567.760586] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[567.835041] [071/130] (453s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[569.763374] Starting subtest: gem-execbuf-stress-pc8
[569.805847] Subtest gem-execbuf-stress-pc8: SKIP (0.043s)
[570.118202] [072/130] (450s left) syncobj_timeline (wait-any-interrupted)
[570.182468] Starting subtest: wait-any-interrupted
[570.283449] Subtest wait-any-interrupted: SUCCESS (0.102s)
[570.334311] [073/130] (450s left) sw_sync (sync_merge_same)
[570.367828] Starting subtest: sync_merge_same
[570.370367] Subtest sync_merge_same: SUCCESS (0.000s)
[570.417345] [074/130] (450s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[570.514536] Starting subtest: psr-2p-pri-indfb-multidraw
[570.518411] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[570.614202] [075/130] (450s left) kms_hdr (bpc-switch-suspend)
[570.710200] Starting subtest: bpc-switch-suspend
[571.806404] Starting dynamic subtest: pipe-A-eDP-1
[591.624458] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.584s)
[591.626875] Subtest bpc-switch-suspend: SUCCESS (5.681s)
[591.727847] [076/130] (429s left) api_intel_bb (blit-noreloc-keep-cache)
[591.800430] Starting subtest: blit-noreloc-keep-cache
[591.808835] Subtest blit-noreloc-keep-cache: SUCCESS (0.009s)
[591.932222] [077/130] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[592.037165] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[592.041406] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[592.135214] [078/130] (429s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[592.228276] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[592.230427] Starting dynamic subtest: pipe-A-default-mode
[592.523277] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[592.527654] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.294s)
[593.304061] [079/130] (428s left) kms_chamelium_frames (hdmi-crc-fast)
[593.681497] Subtest hdmi-crc-fast: SKIP (0.000s)
[594.519039] [080/130] (426s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[594.603823] Starting subtest: primary-4-tiled-reflect-x-0
[601.729690] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.119s)
[602.896463] [081/130] (418s left) sw_sync (sync_merge)
[602.930727] Starting subtest: sync_merge
[602.933168] Subtest sync_merge: SUCCESS (0.000s)
[602.981863] [082/130] (418s left) gem_ctx_persistence (engines-mixed-process)
[603.027637] Starting subtest: engines-mixed-process
[603.030008] Starting dynamic subtest: rcs0
[604.900704] Dynamic subtest rcs0: SUCCESS (1.871s)
[604.912600] Starting dynamic subtest: bcs0
[606.865852] Dynamic subtest bcs0: SUCCESS (1.960s)
[606.875992] Starting dynamic subtest: vcs0
[608.890775] Dynamic subtest vcs0: SUCCESS (2.025s)
[608.902934] Starting dynamic subtest: vcs1
[610.898371] Dynamic subtest vcs1: SUCCESS (2.002s)
[610.908837] Starting dynamic subtest: vecs0
[612.927238] Dynamic subtest vecs0: SUCCESS (2.029s)
[612.938871] Starting dynamic subtest: ccs0
[614.876866] Dynamic subtest ccs0: SUCCESS (1.948s)
[614.879279] Subtest engines-mixed-process: SUCCESS (11.843s)
[614.934298] [083/130] (406s left) gem_exec_parallel (userptr)
[615.002428] Starting subtest: userptr
[615.004616] Starting dynamic subtest: rcs0
[616.575224] Dynamic subtest rcs0: SUCCESS (1.572s)
[616.587225] Starting dynamic subtest: bcs0
[618.074169] Dynamic subtest bcs0: SUCCESS (1.496s)
[618.086709] Starting dynamic subtest: vcs0
[619.828031] Dynamic subtest vcs0: SUCCESS (1.751s)
[619.840129] Starting dynamic subtest: vcs1
[621.855637] Dynamic subtest vcs1: SUCCESS (2.024s)
[621.867829] Starting dynamic subtest: vecs0
[623.864262] Dynamic subtest vecs0: SUCCESS (2.006s)
[623.876736] Starting dynamic subtest: ccs0
[625.387157] Dynamic subtest ccs0: SUCCESS (1.523s)
[625.389574] Subtest userptr: SUCCESS (10.386s)
[625.553155] [084/130] (395s left) kms_flip (absolute-wf_vblank-interruptible)
[625.664975] Starting subtest: absolute-wf_vblank-interruptible
[625.667177] Starting dynamic subtest: A-eDP1
[634.374922] Dynamic subtest A-eDP1: SUCCESS (8.711s)
[634.385141] Starting dynamic subtest: B-eDP1
[643.105104] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[643.114831] Starting dynamic subtest: C-eDP1
[651.826685] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[651.838333] Starting dynamic subtest: D-eDP1
[660.551033] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[660.556772] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.892s)
[661.753648] [085/130] (359s left) kms_force_connector_basic (prune-stale-modes)
[661.836606] Starting subtest: prune-stale-modes
[662.273453] Subtest prune-stale-modes: SUCCESS (0.440s)
[662.387224] [086/130] (359s left) gem_ctx_persistence (processes)
[662.453697] Starting subtest: processes
[663.916609] Subtest processes: SUCCESS (1.462s)
[663.971438] [087/130] (357s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[664.078148] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[671.054309] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.977s)
[671.145361] [088/130] (350s left) gem_exec_flush (basic-uc-ro-default)
[671.213035] Starting subtest: basic-uc-ro-default
[676.664337] Subtest basic-uc-ro-default: SUCCESS (5.451s)
[676.830079] [089/130] (344s left) kms_psr (pr-dpms)
[676.934056] Starting subtest: pr-dpms
[676.938387] Subtest pr-dpms: SKIP (0.000s)
[676.980352] [090/130] (344s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[677.067618] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[677.071983] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[677.155622] [091/130] (344s left) kms_lease (lease-invalid-crtc)
[677.252194] Starting subtest: lease-invalid-crtc
[677.254428] Starting dynamic subtest: pipe-A-eDP-1
[677.256733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[677.267079] Starting dynamic subtest: pipe-B-eDP-1
[677.269345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[677.278183] Starting dynamic subtest: pipe-C-eDP-1
[677.280333] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[677.289348] Starting dynamic subtest: pipe-D-eDP-1
[677.291219] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[677.293099] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[677.329706] [092/130] (344s left) i915_query (query-topology-unsupported)
[677.392857] Starting subtest: query-topology-unsupported
[677.397264] Subtest query-topology-unsupported: SKIP (0.000s)
[677.489374] [093/130] (344s left) prime_self_import (export-vs-gem_close-race)
[677.531399] Starting subtest: export-vs-gem_close-race
[682.637096] Subtest export-vs-gem_close-race: SUCCESS (5.103s)
[682.688055] [094/130] (339s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[682.784398] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[688.094516] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.313s)
[689.275179] [095/130] (332s left) gem_exec_reloc (basic-cpu-active)
[689.346868] Subtest basic-cpu-active: SKIP (0.000s)
[689.427504] [096/130] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[689.526165] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[695.988976] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.467s)
[696.076876] [097/130] (325s left) syncobj_timeline (invalid-transfer-non-existent-point)
[696.141293] Starting subtest: invalid-transfer-non-existent-point
[696.143457] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[696.206331] [098/130] (325s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[696.318662] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[696.323076] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[696.407870] [099/130] (325s left) kms_vblank (query-idle-hang)
[696.502979] Starting subtest: query-idle-hang
[696.505048] Starting dynamic subtest: pipe-A-eDP-1
[723.682600] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.180s)
[723.697661] Starting dynamic subtest: pipe-D-eDP-1
[738.654680] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.966s)
[738.656786] Subtest query-idle-hang: SUCCESS (42.152s)
[739.489558] [100/130] (282s left) i915_drm_fdinfo (busy-idle)
[739.535022] Starting subtest: busy-idle
[739.537280] Starting dynamic subtest: rcs0
[739.569845] Dynamic subtest rcs0: SKIP (0.033s)
[739.580915] Starting dynamic subtest: bcs0
[739.585204] Dynamic subtest bcs0: SKIP (0.000s)
[739.597144] Starting dynamic subtest: vcs0
[739.601486] Dynamic subtest vcs0: SKIP (0.000s)
[739.611202] Starting dynamic subtest: vcs1
[739.615559] Dynamic subtest vcs1: SKIP (0.000s)
[739.625319] Starting dynamic subtest: vecs0
[739.629670] Dynamic subtest vecs0: SKIP (0.000s)
[739.638795] Starting dynamic subtest: ccs0
[739.643117] Dynamic subtest ccs0: SKIP (0.000s)
[739.647339] Subtest busy-idle: SKIP (0.041s)
[739.683331] [101/130] (282s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[739.775219] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[744.184111] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.411s)
[745.376230] [102/130] (276s left) kms_psr (psr-primary-mmap-cpu)
[745.475983] Starting subtest: psr-primary-mmap-cpu
[745.478253] Starting dynamic subtest: eDP-1
[747.252259] Dynamic subtest eDP-1: SUCCESS (1.776s)
[747.254449] Subtest psr-primary-mmap-cpu: SUCCESS (1.777s)
[748.071187] [103/130] (274s left) kms_pm_rpm (dpms-non-lpsp)
[749.991958] Starting subtest: dpms-non-lpsp
[749.997245] Subtest dpms-non-lpsp: SKIP (0.001s)
[750.338775] [104/130] (272s left) device_reset (unbind-reset-rebind)
[750.383722] Starting subtest: unbind-reset-rebind
[756.037985] Subtest unbind-reset-rebind: SUCCESS (5.648s)
[756.081845] [105/130] (266s left) kms_pipe_crc_basic (read-crc)
[756.176326] Starting subtest: read-crc
[756.178777] Starting dynamic subtest: pipe-A-eDP-1
[756.921153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.744s)
[756.932023] Starting dynamic subtest: pipe-B-eDP-1
[758.255909] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[758.266268] Starting dynamic subtest: pipe-C-eDP-1
[759.540256] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[759.550899] Starting dynamic subtest: pipe-D-eDP-1
[760.887235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[760.889768] Subtest read-crc: SUCCESS (4.713s)
[761.697077] [106/130] (260s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[761.813080] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[761.817536] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[761.905477] [107/130] (260s left) kms_async_flips (test-time-stamp)
[761.997993] Starting subtest: test-time-stamp
[762.372712] Starting dynamic subtest: pipe-A-eDP-1
[763.129167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.754s)
[763.495488] Starting dynamic subtest: pipe-B-eDP-1
[764.256307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[764.627989] Starting dynamic subtest: pipe-C-eDP-1
[765.375467] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[765.747548] Starting dynamic subtest: pipe-D-eDP-1
[766.505991] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[766.508435] Subtest test-time-stamp: SUCCESS (4.507s)
[767.681591] [108/130] (254s left) api_intel_bb (reset-bb)
[767.753993] Starting subtest: reset-bb
[767.756367] Subtest reset-bb: SUCCESS (0.003s)
[767.876712] [109/130] (254s left) gem_exec_whisper (basic-normal-all)
[767.936339] Starting subtest: basic-normal-all
[770.306938] Subtest basic-normal-all: SUCCESS (2.367s)
[770.466116] [110/130] (252s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[775.537666] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[775.542336] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[776.368957] [111/130] (246s left) fbdev (eof)
[776.422476] Starting subtest: eof
[776.424867] Subtest eof: SUCCESS (0.000s)
[776.467677] [112/130] (246s left) kms_psr (pr-cursor-blt)
[776.551298] Starting subtest: pr-cursor-blt
[776.555402] Subtest pr-cursor-blt: SKIP (0.000s)
[776.600082] [113/130] (246s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[776.644843] Starting subtest: y-tiled-to-vebox-yf-tiled
[776.649515] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[776.812271] [114/130] (245s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[776.915986] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[776.920159] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[777.015092] [115/130] (245s left) kms_plane (pixel-format-source-clamping)
[777.105384] Starting subtest: pixel-format-source-clamping
[777.131550] Starting dynamic subtest: pipe-A-plane-0
[781.820781] Dynamic subtest pipe-A-plane-0: SUCCESS (4.689s)
[781.830463] Starting dynamic subtest: pipe-A-plane-3
[784.065619] Dynamic subtest pipe-A-plane-3: SUCCESS (2.244s)
[784.075758] Starting dynamic subtest: pipe-A-plane-5
[784.077424] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[785.174361] Starting dynamic subtest: pipe-B-plane-0
[789.797904] Dynamic subtest pipe-B-plane-0: SUCCESS (4.633s)
[789.807307] Starting dynamic subtest: pipe-B-plane-3
[792.175997] Dynamic subtest pipe-B-plane-3: SUCCESS (2.377s)
[792.186794] Starting dynamic subtest: pipe-B-plane-5
[792.188689] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[792.490670] Subtest pixel-format-source-clamping: SUCCESS (15.383s)
[793.322012] [116/130] (229s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[793.421651] Starting subtest: 4-tiled-addfb-size-offset-overflow
[793.424018] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[793.491090] [117/130] (229s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[793.582714] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[793.584923] Starting dynamic subtest: pipe-A-default-mode
[794.708873] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[794.713439] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.125s)
[794.846148] [118/130] (228s left) gem_mmap_offset (oob-read)
[794.906735] Starting subtest: oob-read
[794.909081] Subtest oob-read: SUCCESS (0.000s)
[794.994757] [119/130] (227s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[795.091598] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[795.095787] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[795.190779] [120/130] (227s left) kms_chamelium_color (ctm-blue-to-red)
[795.289082] Subtest ctm-blue-to-red: SKIP (0.000s)
[795.341611] [121/130] (227s left) gem_eio (wait-immediate)
[795.562776] Starting subtest: wait-immediate
[795.930285] Subtest wait-immediate: SUCCESS (0.369s)
[796.059103] [122/130] (227s left) gem_exec_suspend (basic-s3-devices)
[796.117036] Starting subtest: basic-S3-devices
[796.119146] Starting dynamic subtest: smem
[807.905996] Dynamic subtest smem: SUCCESS (11.784s)
[807.909016] Subtest basic-S3-devices: SUCCESS (11.786s)
[811.081406] [123/130] (215s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[811.159549] Starting subtest: invalid-multi-wait-unsubmitted
[811.161696] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[811.252382] [124/130] (214s left) gem_exec_balancer (full-late-pulse)
[811.310939] Starting subtest: full-late-pulse
[815.736756] Subtest full-late-pulse: SUCCESS (4.426s)
[816.097602] [125/130] (210s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[816.213158] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[816.217141] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[816.307266] [126/130] (210s left) syncobj_wait (single-wait-for-submit-submitted)
[816.375312] Starting subtest: single-wait-for-submit-submitted
[816.485298] Subtest single-wait-for-submit-submitted: SUCCESS (0.109s)
[816.538395] [127/130] (209s left) gem_exec_schedule (semaphore-resolve)
[816.624469] Starting subtest: semaphore-resolve
[816.653792] Subtest semaphore-resolve: SUCCESS (0.039s)
[817.003888] [128/130] (209s left) syncobj_basic (bad-pad-handle-to-fd)
[817.067281] Starting subtest: bad-pad-handle-to-fd
[817.069521] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[817.181510] [129/130] (209s left) gen7_exec_parse (chained-batch)
[817.250321] Subtest chained-batch: SKIP (0.000s)
[817.326067] [130/130] (209s left) kms_cursor_crc (cursor-onscreen-256x256)
[817.542846] Starting subtest: cursor-onscreen-256x256
[817.547946] Starting dynamic subtest: pipe-A-eDP-1
[819.676819] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.129s)
[819.705420] Starting dynamic subtest: pipe-D-eDP-1
[822.461483] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[822.464030] Subtest cursor-onscreen-256x256: SUCCESS (4.917s)
[823.235159] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_getfb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_create
results: parsing output: 8/ for test: gem_exec_nop
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_workarounds
results: parsing output: 14/ for test: gem_basic
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: i915_query
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_params
results: parsing output: 26/ for test: kms_color
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_ppgtt
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: gem_exec_alignment
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: gem_pwrite
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_fb_coherency
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: kms_pipe_b_c_ivb
results: parsing output: 70/ for test: i915_pm_rpm
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_force_connector_basic
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: prime_self_import
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: device_reset
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_mmap_offset
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_chamelium_color
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: syncobj_basic
results: parsing output: 128/ for test: gen7_exec_parse
results: parsing output: 129/ for test: kms_cursor_crc
Done.