[58.608323] Initializing watchdogs
[58.608397]   /dev/watchdog0
[58.626676] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.631577] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.633887] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.637219] [001/133] (960s left) gem_exec_whisper (basic-contexts-all)
[58.722420] Starting subtest: basic-contexts-all
[70.664566] Subtest basic-contexts-all: SUCCESS (11.984s)
[70.847557] [002/133] (948s left) gem_linear_blits (interruptible)
[71.245840] Starting subtest: interruptible
[76.410700] Subtest interruptible: SUCCESS (5.170s)
[76.561858] [003/133] (942s left) gem_exec_params (secure-non-root)
[76.658106] Starting subtest: secure-non-root
[76.662389] Subtest secure-non-root: SKIP (0.000s)
[76.756186] [004/133] (942s left) kms_busy (extended-pageflip-hang-oldfb)
[76.862131] Starting subtest: extended-pageflip-hang-oldfb
[76.864474] Starting dynamic subtest: pipe-A
[77.337634] Dynamic subtest pipe-A: SUCCESS (0.471s)
[77.347255] Starting dynamic subtest: pipe-D
[78.457926] Dynamic subtest pipe-D: SUCCESS (1.122s)
[78.460181] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.597s)
[79.319093] [005/133] (939s left) device_reset (unbind-reset-rebind)
[79.368322] Starting subtest: unbind-reset-rebind
[82.791931] Subtest unbind-reset-rebind: SUCCESS (3.419s)
[82.834131] [006/133] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[82.945630] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[82.950193] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[83.050215] [007/133] (936s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[83.158520] Starting subtest: crc-primary-basic-yf-tiled-ccs
[83.161072] Starting dynamic subtest: pipe-A-eDP-1
[83.184715] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.196598] Starting dynamic subtest: pipe-B-eDP-1
[83.218591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.228598] Starting dynamic subtest: pipe-C-eDP-1
[83.249826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.258696] Starting dynamic subtest: pipe-D-eDP-1
[83.279574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.283805] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s)
[85.322182] [008/133] (934s left) gem_caching (read-writes)
[85.400718] Subtest read-writes: SKIP (0.000s)
[85.465444] [009/133] (933s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[85.575168] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[85.579620] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[85.671568] [010/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[85.771128] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[85.775221] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[85.863094] [011/133] (933s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[85.975562] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[85.980208] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[86.118150] [012/133] (933s left) gem_exec_parallel (contexts)
[86.182723] Starting subtest: contexts
[86.184679] Starting dynamic subtest: rcs0
[89.330052] Dynamic subtest rcs0: SUCCESS (3.147s)
[89.342284] Starting dynamic subtest: bcs0
[92.600060] Dynamic subtest bcs0: SUCCESS (3.267s)
[92.611887] Starting dynamic subtest: vcs0
[96.472862] Dynamic subtest vcs0: SUCCESS (3.873s)
[96.484848] Starting dynamic subtest: vcs1
[100.387938] Dynamic subtest vcs1: SUCCESS (3.914s)
[100.399530] Starting dynamic subtest: vecs0
[104.395032] Dynamic subtest vecs0: SUCCESS (4.006s)
[104.405763] Starting dynamic subtest: ccs0
[108.115679] Dynamic subtest ccs0: SUCCESS (3.720s)
[108.118263] Subtest contexts: SUCCESS (21.933s)
[108.313688] [013/133] (911s left) kms_selftest (drm_format)
[108.357158] Starting subtest: drm_format
[108.425633] Starting dynamic subtest: drm_test_format_block_width_invalid
[108.532199] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.107s)
[108.542950] Starting dynamic subtest: drm_test_format_block_width_one_plane
[108.624459] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.092s)
[108.634941] Starting dynamic subtest: drm_test_format_block_width_two_plane
[108.708834] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.085s)
[108.719214] Starting dynamic subtest: drm_test_format_block_width_three_plane
[108.800741] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.091s)
[108.811117] Starting dynamic subtest: drm_test_format_block_width_tiled
[108.893824] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.093s)
[108.904555] Starting dynamic subtest: drm_test_format_block_height_invalid
[108.970331] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.077s)
[108.980766] Starting dynamic subtest: drm_test_format_block_height_one_plane
[109.050519] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.078s)
[109.061104] Starting dynamic subtest: drm_test_format_block_height_two_plane
[109.139395] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[109.149943] Starting dynamic subtest: drm_test_format_block_height_three_plane
[109.235916] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.096s)
[109.244692] Starting dynamic subtest: drm_test_format_block_height_tiled
[109.324970] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.088s)
[109.333676] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[109.414566] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.091s)
[109.424453] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[109.502362] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.087s)
[109.513065] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[109.598847] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.095s)
[109.607221] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[109.691300] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.092s)
[109.699390] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[109.778685] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.086s)
[109.792788] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[109.866865] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s)
[109.881935] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[109.962052] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.095s)
[109.972240] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[110.066773] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.103s)
[110.068846] Subtest drm_format: SUCCESS (1.709s)
[110.223889] [014/133] (909s left) gem_eio (create-ext)
[110.468297] Starting subtest: create-ext
[110.834210] Subtest create-ext: SUCCESS (0.365s)
[110.980724] [015/133] (908s left) kms_flip (nonexisting-fb-interruptible)
[111.072755] Starting subtest: nonexisting-fb-interruptible
[111.074546] Starting dynamic subtest: A-eDP1
[112.212653] Dynamic subtest A-eDP1: SUCCESS (1.138s)
[112.225436] Starting dynamic subtest: B-eDP1
[113.349616] Dynamic subtest B-eDP1: SUCCESS (1.137s)
[113.360829] Starting dynamic subtest: C-eDP1
[114.476524] Dynamic subtest C-eDP1: SUCCESS (1.125s)
[114.487769] Starting dynamic subtest: D-eDP1
[115.609596] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[115.614581] Subtest nonexisting-fb-interruptible: SUCCESS (4.539s)
[116.769174] [016/133] (902s left) kms_mmap_write_crc (main)
[116.857784] Starting subtest: main
[116.860169] Starting dynamic subtest: pipe-A-eDP-1
[120.442367] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.580s)
[120.444997] Subtest main: SUCCESS (3.581s)
[121.298612] [017/133] (898s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[121.692881] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[122.500472] [018/133] (897s left) i915_pm_rpm (gem-execbuf)
[124.045187] Starting subtest: gem-execbuf
[124.047627] Starting dynamic subtest: smem0
[126.305235] Dynamic subtest smem0: SUCCESS (2.260s)
[126.307637] Subtest gem-execbuf: SUCCESS (2.261s)
[126.401489] [019/133] (893s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[126.506190] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[130.616041] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.113s)
[131.762056] [020/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[131.860920] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[131.865205] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[131.964220] [021/133] (887s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[132.057373] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[132.061474] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[132.152836] [022/133] (887s left) gem_exec_fence (submit67)
[132.333955] Starting subtest: submit67
[132.338655] Subtest submit67: SKIP (0.000s)
[133.987199] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[133.990417] [023/133] (886s left) kms_psr2_su (page_flip-nv12)
[134.048053] Subtest page_flip-NV12: SKIP (0.000s)
[134.105524] [024/133] (885s left) gem_ctx_shared (create-shared-gtt)
[134.169268] Starting subtest: create-shared-gtt
[136.325635] Subtest create-shared-gtt: SUCCESS (2.155s)
[136.607618] [025/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[136.713878] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[159.874309] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.159s)
[160.025290] [026/133] (860s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[160.128894] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[160.130881] Starting dynamic subtest: pipe-A-eDP-1
[160.149859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.160690] Starting dynamic subtest: pipe-B-eDP-1
[160.179502] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.188564] Starting dynamic subtest: pipe-C-eDP-1
[160.206213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.215130] Starting dynamic subtest: pipe-D-eDP-1
[160.233097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.236531] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.013s)
[162.442946] [027/133] (857s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[162.543394] Starting subtest: fbc-rgb101010-draw-blt
[167.160478] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.621s)
[168.281946] [028/133] (851s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[168.378040] Starting subtest: flip-primary-invalidate-overlay
[180.046683] Subtest flip-primary-invalidate-overlay: SUCCESS (11.668s)
[180.197277] [029/133] (840s left) kms_dp_aux_dev (basic)
[180.252023] Starting subtest: basic
[180.476814] Subtest basic: SUCCESS (0.222s)
[180.552825] [030/133] (839s left) gem_bad_reloc (negative-reloc)
[180.611811] Subtest negative-reloc: SKIP (0.000s)
[180.692546] [031/133] (839s left) kms_prop_blob (invalid-set-prop-any)
[180.747416] Starting subtest: invalid-set-prop-any
[180.749314] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[180.847668] [032/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[180.947487] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[180.951523] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[181.045220] [033/133] (839s left) i915_drm_fdinfo (all-busy-check-all)
[181.087754] Starting subtest: all-busy-check-all
[181.095267] Subtest all-busy-check-all: SKIP (0.005s)
[181.176874] [034/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[181.306977] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[188.361200] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.056s)
[188.463903] [035/133] (832s left) kms_vblank (ts-continuation-modeset-rpm)
[188.558945] Starting subtest: ts-continuation-modeset-rpm
[188.561084] Starting dynamic subtest: pipe-A-eDP-1
[191.107190] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.547s)
[191.122224] Starting dynamic subtest: pipe-D-eDP-1
[193.356145] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.245s)
[193.358030] Subtest ts-continuation-modeset-rpm: SUCCESS (4.796s)
[194.150806] [036/133] (826s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[194.237054] Starting subtest: async-flip-with-page-flip-events-linear
[194.609099] Starting dynamic subtest: pipe-A-eDP-1
[197.425502] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s)
[197.809749] Starting dynamic subtest: pipe-B-eDP-1
[200.551273] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[200.927620] Starting dynamic subtest: pipe-C-eDP-1
[203.681664] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[204.047265] Starting dynamic subtest: pipe-D-eDP-1
[206.816353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[206.818948] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.579s)
[207.997937] [037/133] (812s left) gem_mmap_gtt (basic-small-copy)
[208.055662] Subtest basic-small-copy: SKIP (0.000s)
[208.122083] [038/133] (812s left) gem_exec_reloc (basic-gtt-cpu-active)
[208.180253] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[208.246800] [039/133] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[208.351040] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[215.749386] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.401s)
[215.865859] [040/133] (804s left) gem_exec_schedule (u-lateslice)
[215.941846] Starting subtest: u-lateslice
[215.943771] Starting dynamic subtest: rcs0
[215.953895] Dynamic subtest rcs0: SUCCESS (0.021s)
[215.963753] Starting dynamic subtest: bcs0
[215.973738] Dynamic subtest bcs0: SUCCESS (0.019s)
[215.983201] Starting dynamic subtest: vcs0
[215.993380] Dynamic subtest vcs0: SUCCESS (0.019s)
[216.003210] Starting dynamic subtest: vcs1
[216.011925] Dynamic subtest vcs1: SUCCESS (0.018s)
[216.025145] Starting dynamic subtest: vecs0
[216.032431] Dynamic subtest vecs0: SUCCESS (0.019s)
[216.041746] Starting dynamic subtest: ccs0
[216.052796] Dynamic subtest ccs0: SUCCESS (0.020s)
[216.054945] Subtest u-lateslice: SUCCESS (0.121s)
[217.959017] [041/133] (802s left) gem_wait (await)
[218.017880] Starting subtest: await
[218.020167] Starting dynamic subtest: all-engines
[219.131520] Dynamic subtest all-engines: SUCCESS (1.112s)
[219.151059] Starting dynamic subtest: rcs0
[220.190286] Dynamic subtest rcs0: SUCCESS (1.057s)
[220.209365] Starting dynamic subtest: bcs0
[221.248270] Dynamic subtest bcs0: SUCCESS (1.055s)
[221.265479] Starting dynamic subtest: vcs0
[222.302858] Dynamic subtest vcs0: SUCCESS (1.052s)
[222.320249] Starting dynamic subtest: vcs1
[223.356981] Dynamic subtest vcs1: SUCCESS (1.052s)
[223.374401] Starting dynamic subtest: vecs0
[224.410464] Dynamic subtest vecs0: SUCCESS (1.051s)
[224.428050] Starting dynamic subtest: ccs0
[225.468581] Dynamic subtest ccs0: SUCCESS (1.056s)
[225.470955] Subtest await: SUCCESS (7.451s)
[225.665386] [042/133] (795s left) kms_rotation_crc (primary-rotation-90)
[225.771973] Starting subtest: primary-rotation-90
[225.776130] Subtest primary-rotation-90: SKIP (0.001s)
[225.858872] [043/133] (795s left) i915_pm_rps (thresholds-idle)
[225.917134] Starting subtest: thresholds-idle
[225.921579] Subtest thresholds-idle: SKIP (0.001s)
[226.025563] [044/133] (794s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[226.107332] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[226.111631] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[226.189747] [045/133] (794s left) api_intel_allocator (gem-pool)
[226.240616] Starting subtest: gem-pool
[226.245847] Subtest gem-pool: SUCCESS (0.008s)
[226.375251] [046/133] (794s left) kms_chamelium_frames (hdmi-crc-multiple)
[226.785992] Subtest hdmi-crc-multiple: SKIP (0.000s)
[227.572179] [047/133] (793s left) gem_ctx_persistence (engines-hostile-preempt)
[227.627402] Starting subtest: engines-hostile-preempt
[227.629780] Starting dynamic subtest: rcs0
[227.700777] Dynamic subtest rcs0: SUCCESS (0.073s)
[227.713416] Starting dynamic subtest: bcs0
[227.765912] Dynamic subtest bcs0: SUCCESS (0.063s)
[227.778157] Starting dynamic subtest: vcs0
[228.878325] Dynamic subtest vcs0: SUCCESS (1.109s)
[228.891815] Starting dynamic subtest: vcs1
[230.908573] Dynamic subtest vcs1: SUCCESS (2.027s)
[230.922386] Starting dynamic subtest: vecs0
[232.895032] Dynamic subtest vecs0: SUCCESS (1.983s)
[232.911690] Starting dynamic subtest: ccs0
[232.987206] Dynamic subtest ccs0: SUCCESS (0.091s)
[232.990071] Subtest engines-hostile-preempt: SUCCESS (5.360s)
[233.072860] [048/133] (788s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[233.176971] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[233.179224] Starting dynamic subtest: pipe-A-eDP-1
[233.236686] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[233.247113] Starting dynamic subtest: pipe-B-eDP-1
[233.303217] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[233.314094] Starting dynamic subtest: pipe-C-eDP-1
[233.371983] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[233.385521] Starting dynamic subtest: pipe-D-eDP-1
[233.443653] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[233.447746] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[235.467117] [049/133] (785s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[235.582264] Starting subtest: yf-tiled-16bpp-rotate-270
[235.586745] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[235.668661] [050/133] (785s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[235.772058] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[235.776236] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[235.862144] [051/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[235.965453] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[235.969527] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[236.065677] [052/133] (785s left) vgem_slow (nohang)
[236.116651] Starting subtest: nohang
[246.387617] Subtest nohang: SUCCESS (10.271s)
[246.464000] [053/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[246.570150] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[250.285036] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.717s)
[251.459946] [054/133] (769s left) kms_atomic (test-only)
[251.551884] Starting subtest: test-only
[251.606665] Starting dynamic subtest: pipe-A-eDP-1
[254.192241] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.586s)
[254.194509] Subtest test-only: SUCCESS (2.642s)
[255.061801] [055/133] (766s left) kms_invalid_mode (bad-vtotal)
[255.156197] Starting subtest: bad-vtotal
[255.158299] Starting dynamic subtest: pipe-A-eDP-1
[255.439175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[255.450041] Starting dynamic subtest: pipe-B-eDP-1
[255.452227] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[255.461753] Starting dynamic subtest: pipe-C-eDP-1
[255.463929] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[255.473429] Starting dynamic subtest: pipe-D-eDP-1
[255.475745] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[255.478044] Subtest bad-vtotal: SUCCESS (0.291s)
[256.276991] [056/133] (765s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[256.370966] Starting subtest: plane-downscale-factor-0-75-with-rotation
[256.373173] Starting dynamic subtest: pipe-A
[256.598910] Dynamic subtest pipe-A: SUCCESS (0.230s)
[256.608912] Starting dynamic subtest: pipe-B
[257.861287] Dynamic subtest pipe-B: SUCCESS (1.261s)
[257.871736] Starting dynamic subtest: pipe-C
[259.229382] Dynamic subtest pipe-C: SUCCESS (1.367s)
[259.239612] Starting dynamic subtest: pipe-D
[260.525761] Dynamic subtest pipe-D: SUCCESS (1.295s)
[260.528063] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.158s)
[261.726749] [057/133] (759s left) sriov_basic (enable-vfs-autoprobe-on)
[261.786388] Starting subtest: enable-vfs-autoprobe-on
[261.788774] Starting dynamic subtest: numvfs-1
[261.872767] Dynamic subtest numvfs-1: FAIL (0.028s)
[261.883789] Starting dynamic subtest: numvfs-2
[261.956777] Dynamic subtest numvfs-2: FAIL (0.004s)
[261.968525] Starting dynamic subtest: numvfs-3
[262.041635] Dynamic subtest numvfs-3: FAIL (0.004s)
[262.052373] Starting dynamic subtest: numvfs-4
[262.125357] Dynamic subtest numvfs-4: FAIL (0.004s)
[262.135926] Starting dynamic subtest: numvfs-5
[262.208535] Dynamic subtest numvfs-5: FAIL (0.004s)
[262.219824] Starting dynamic subtest: numvfs-6
[262.292873] Dynamic subtest numvfs-6: FAIL (0.004s)
[262.303472] Starting dynamic subtest: numvfs-7
[262.376737] Dynamic subtest numvfs-7: FAIL (0.004s)
[262.386463] Starting dynamic subtest: numvfs-random
[262.458227] Dynamic subtest numvfs-random: FAIL (0.003s)
[262.468729] Starting dynamic subtest: numvfs-all
[262.541858] Dynamic subtest numvfs-all: FAIL (0.518s)
[262.543872] Subtest enable-vfs-autoprobe-on: FAIL (0.581s)
[262.584943] [058/133] (758s left) gem_exec_reloc (basic-wc-read)
[262.638118] Subtest basic-wc-read: SKIP (0.000s)
[262.714165] [059/133] (758s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[262.794465] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[262.796285] Starting dynamic subtest: pipe-A-eDP-1
[262.814700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.830918] Starting dynamic subtest: pipe-B-eDP-1
[262.848300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.857935] Starting dynamic subtest: pipe-C-eDP-1
[262.875155] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.884040] Starting dynamic subtest: pipe-D-eDP-1
[262.901690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.905042] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[265.066555] [060/133] (756s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[265.159860] Starting subtest: fbcpsr-tiling-y
[265.164151] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[265.272576] [061/133] (756s left) syncobj_wait (single-wait-for-submit-signaled)
[265.324849] Starting subtest: single-wait-for-submit-signaled
[265.327157] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[265.413842] [062/133] (756s left) gem_ctx_engines (invalid-engines)
[265.475892] Starting subtest: invalid-engines
[265.483740] Subtest invalid-engines: SUCCESS (0.008s)
[265.732999] [063/133] (755s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[265.835947] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[265.840272] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[265.914829] [064/133] (755s left) kms_pm_rpm (system-suspend-idle)
[268.050741] Starting subtest: system-suspend-idle
[291.673224] Subtest system-suspend-idle: SUCCESS (8.376s)
[296.073919] [065/133] (729s left) gem_userptr_blits (sync-unmap-after-close)
[296.170094] Starting subtest: sync-unmap-after-close
[296.182993] Subtest sync-unmap-after-close: SUCCESS (0.014s)
[296.315884] [066/133] (729s left) kms_plane_scaling (planes-scaler-unity-scaling)
[296.400923] Starting subtest: planes-scaler-unity-scaling
[296.403135] Starting dynamic subtest: pipe-A
[296.460695] Dynamic subtest pipe-A: SUCCESS (0.064s)
[296.472326] Starting dynamic subtest: pipe-B
[297.613031] Dynamic subtest pipe-B: SUCCESS (1.186s)
[297.625922] Starting dynamic subtest: pipe-C
[298.689903] Dynamic subtest pipe-C: SUCCESS (1.103s)
[298.700586] Starting dynamic subtest: pipe-D
[299.801259] Dynamic subtest pipe-D: SUCCESS (1.135s)
[299.803545] Subtest planes-scaler-unity-scaling: SUCCESS (3.493s)
[300.949147] [067/133] (724s left) kms_hdr (bpc-switch-dpms)
[301.040549] Starting subtest: bpc-switch-dpms
[302.094492] Starting dynamic subtest: pipe-A-eDP-1
[306.604755] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.563s)
[306.607130] Subtest bpc-switch-dpms: SUCCESS (5.637s)
[306.714759] [068/133] (719s left) gem_exec_schedule (noreorder-corked)
[306.898310] Starting subtest: noreorder-corked
[306.900621] Starting dynamic subtest: rcs0
[308.019092] Dynamic subtest rcs0: SUCCESS (1.133s)
[308.037859] Starting dynamic subtest: vcs0
[309.154300] Dynamic subtest vcs0: SUCCESS (1.141s)
[309.168129] Starting dynamic subtest: vcs1
[311.139615] Dynamic subtest vcs1: SUCCESS (1.993s)
[311.154045] Starting dynamic subtest: vecs0
[313.122309] Dynamic subtest vecs0: SUCCESS (1.988s)
[313.136130] Starting dynamic subtest: ccs0
[314.268952] Dynamic subtest ccs0: SUCCESS (1.149s)
[314.271791] Subtest noreorder-corked: SUCCESS (7.415s)
[314.472762] [069/133] (711s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[314.571389] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[314.575737] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[314.670801] [070/133] (711s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[314.793943] Starting subtest: flip-vs-cursor-varying-size
[323.756084] Subtest flip-vs-cursor-varying-size: SUCCESS (8.978s)
[324.655493] [071/133] (701s left) kms_flip (flip-vs-blocking-wf-vblank)
[324.748848] Starting subtest: flip-vs-blocking-wf-vblank
[324.751056] Starting dynamic subtest: A-eDP1
[333.687674] Dynamic subtest A-eDP1: SUCCESS (8.946s)
[333.699786] Starting dynamic subtest: B-eDP1
[342.611679] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[342.624545] Starting dynamic subtest: C-eDP1
[351.534354] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[351.544998] Starting dynamic subtest: D-eDP1
[360.462819] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[360.468322] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.741s)
[361.708120] [072/133] (664s left) template (b)
[361.778942] Starting subtest: B
[361.781292] Subtest B: SUCCESS (0.000s)
[361.892951] [073/133] (664s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[361.991365] Starting subtest: fbc-psr2-sprite-mmap-gtt
[361.993578] Starting dynamic subtest: eDP-1
[361.997540] Dynamic subtest eDP-1: SKIP (0.000s)
[362.001592] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[362.073174] [074/133] (664s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[362.186714] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[362.191024] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[362.257062] [075/133] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[362.357822] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[367.124328] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.772s)
[368.290623] [076/133] (658s left) kms_psr (psr2-sprite-plane-onoff)
[368.386107] Starting subtest: psr2-sprite-plane-onoff
[368.389181] Starting dynamic subtest: eDP-1
[370.080146] Dynamic subtest eDP-1: SUCCESS (1.694s)
[370.082425] Subtest psr2-sprite-plane-onoff: SUCCESS (1.696s)
[370.957979] [077/133] (655s left) kms_addfb_basic (bad-pitch-999)
[371.012575] Starting subtest: bad-pitch-999
[371.014954] Subtest bad-pitch-999: SUCCESS (0.000s)
[371.151171] [078/133] (655s left) kms_color (ctm-blue-to-red)
[371.244324] Starting subtest: ctm-blue-to-red
[371.246577] Starting dynamic subtest: pipe-A-eDP-1
[371.927971] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[371.939411] Starting dynamic subtest: pipe-B-eDP-1
[373.352834] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[373.363638] Starting dynamic subtest: pipe-C-eDP-1
[374.711697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[374.722189] Starting dynamic subtest: pipe-D-eDP-1
[376.064856] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[376.067029] Subtest ctm-blue-to-red: SUCCESS (4.823s)
[376.871399] [079/133] (649s left) api_intel_bb (render)
[376.931483] Starting subtest: render
[376.933800] Starting dynamic subtest: render-none-512
[377.030552] Dynamic subtest render-none-512: SUCCESS (0.101s)
[377.043822] Starting dynamic subtest: render-none-1024
[377.421737] Dynamic subtest render-none-1024: SUCCESS (0.389s)
[377.434833] Starting dynamic subtest: render-x-512
[377.544099] Dynamic subtest render-x-512: SUCCESS (0.121s)
[377.556857] Starting dynamic subtest: render-x-1024
[377.894923] Dynamic subtest render-x-1024: SUCCESS (0.350s)
[377.908132] Starting dynamic subtest: render-y-512
[377.980316] Dynamic subtest render-y-512: SUCCESS (0.085s)
[377.993202] Starting dynamic subtest: render-y-1024
[378.346688] Dynamic subtest render-y-1024: SUCCESS (0.365s)
[378.349611] Subtest render: SUCCESS (1.418s)
[378.446054] [080/133] (648s left) kms_plane_multiple (2x-tiling-yf)
[378.543468] Starting subtest: 2x-tiling-yf
[378.547628] Subtest 2x-tiling-yf: SKIP (0.000s)
[378.617502] [081/133] (647s left) gem_exec_reloc (basic-write-read-noreloc)
[378.677168] Subtest basic-write-read-noreloc: SKIP (0.000s)
[378.747849] [082/133] (647s left) syncobj_basic (bad-flags-handle-to-fd)
[378.799978] Starting subtest: bad-flags-handle-to-fd
[378.801942] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[378.892237] [083/133] (647s left) gem_lmem_swapping (smem-oom)
[378.937514] Subtest smem-oom: SKIP (0.000s)
[378.979421] [084/133] (647s left) syncobj_timeline (wait-all-for-submit-complex)
[379.033396] Starting subtest: wait-all-for-submit-complex
[379.247872] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[379.323218] [085/133] (647s left) kms_big_fb (4-tiled-addfb)
[379.421048] Starting subtest: 4-tiled-addfb
[379.423403] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[379.507624] [086/133] (647s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[379.572292] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[379.576934] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[379.770406] [087/133] (647s left) gem_exec_balancer (bonded-sync)
[379.831522] Starting subtest: bonded-sync
[379.836009] Subtest bonded-sync: SKIP (0.000s)
[380.149223] [088/133] (646s left) gem_mmap_offset (clear-via-pagefault)
[380.207010] Starting subtest: clear-via-pagefault
[380.209178] Starting dynamic subtest: smem0
[414.572825] Dynamic subtest smem0: SUCCESS (34.348s)
[414.575246] Subtest clear-via-pagefault: SUCCESS (34.351s)
[414.710527] [089/133] (612s left) gem_partial_pwrite_pread (write-display)
[414.777940] Subtest write-display: SKIP (0.000s)
[414.843650] [090/133] (612s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[414.903772] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[415.009698] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[415.090241] [091/133] (611s left) gem_pxp (create-regular-context-2)
[415.213813] Starting subtest: create-regular-context-2
[415.216403] Subtest create-regular-context-2: SUCCESS (0.002s)
[415.339839] [092/133] (611s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[415.399594] Subtest no-spare-fences-busy: SKIP (0.000s)
[415.473742] [093/133] (611s left) gen7_exec_parse (load-register-reg)
[415.548777] Subtest load-register-reg: SKIP (0.000s)
[415.613886] [094/133] (611s left) i915_module_load (reload-no-display)
[415.655089] Starting subtest: reload-no-display
[419.997395] Subtest reload-no-display: SUCCESS (4.342s)
[420.029772] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[420.030499] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[420.034288] [095/133] (607s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[421.632321] Starting subtest: primary-y-tiled-reflect-x-270
[421.636693] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[421.743602] [FACT kms_rotation_crc (primary-y-tiled-reflect-x-270)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[421.745448] [FACT kms_rotation_crc (primary-y-tiled-reflect-x-270)] new: kernel.kmod_is_loaded.i915: true
[421.749152] [096/133] (605s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[421.805523] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[421.807825] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[421.904473] [097/133] (605s left) kms_lease (page-flip-implicit-plane)
[421.993712] Starting subtest: page-flip-implicit-plane
[421.995967] Starting dynamic subtest: pipe-A-eDP-1
[422.502494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.508s)
[422.512212] Starting dynamic subtest: pipe-B-eDP-1
[423.619667] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.115s)
[423.630101] Starting dynamic subtest: pipe-C-eDP-1
[424.738086] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[424.748413] Starting dynamic subtest: pipe-D-eDP-1
[425.878424] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[425.880365] Subtest page-flip-implicit-plane: SUCCESS (3.884s)
[426.718385] [098/133] (600s left) syncobj_wait (multi-wait-signaled)
[426.780238] Starting subtest: multi-wait-signaled
[426.782489] Subtest multi-wait-signaled: SUCCESS (0.000s)
[426.883758] [099/133] (600s left) gem_exec_whisper (basic-queues-forked-all)
[426.993914] Starting subtest: basic-queues-forked-all
[446.455285] Subtest basic-queues-forked-all: SUCCESS (19.462s)
[446.639642] [100/133] (580s left) perf_pmu (rc6-all-gts)
[446.696657] Starting subtest: rc6-all-gts
[453.078422] Subtest rc6-all-gts: SUCCESS (6.381s)
[453.937076] [101/133] (573s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[454.042048] Starting subtest: y-tiled-64bpp-rotate-180
[454.046483] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[454.130880] [102/133] (573s left) kms_psr (fbc-psr2-cursor-blt)
[454.225169] Starting subtest: fbc-psr2-cursor-blt
[454.227199] Starting dynamic subtest: eDP-1
[454.230753] Dynamic subtest eDP-1: SKIP (0.000s)
[454.234304] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[454.300308] [103/133] (573s left) sysfs_preempt_timeout (timeout)
[454.355607] Starting subtest: timeout
[454.357506] Starting dynamic subtest: vecs0
[464.102989] Dynamic subtest vecs0: SUCCESS (9.744s)
[464.116356] Starting dynamic subtest: ccs0
[465.377471] Dynamic subtest ccs0: SUCCESS (1.275s)
[465.389920] Starting dynamic subtest: vcs0
[475.169064] Dynamic subtest vcs0: SUCCESS (9.790s)
[475.180165] Starting dynamic subtest: bcs0
[476.405753] Dynamic subtest bcs0: SUCCESS (1.236s)
[476.422367] Starting dynamic subtest: rcs0
[477.610925] Dynamic subtest rcs0: SUCCESS (1.204s)
[477.624694] Starting dynamic subtest: vcs1
[487.139605] Dynamic subtest vcs1: SUCCESS (9.528s)
[487.142083] Subtest timeout: SUCCESS (32.791s)
[487.219737] [104/133] (540s left) kms_big_fb (linear-8bpp-rotate-90)
[487.321777] Starting subtest: linear-8bpp-rotate-90
[487.343629] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[487.447179] [105/133] (540s left) gem_pread (snoop)
[487.492440] Subtest snoop: SKIP (0.000s)
[487.550972] [106/133] (540s left) kms_psr (fbc-psr-suspend)
[487.644393] Starting subtest: fbc-psr-suspend
[487.646524] Starting dynamic subtest: eDP-1
[487.650451] Dynamic subtest eDP-1: SKIP (0.000s)
[487.654477] Subtest fbc-psr-suspend: SKIP (0.001s)
[487.719120] [107/133] (539s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[487.843312] Starting subtest: cursorA-vs-flipA-legacy
[498.986479] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.146s)
[499.837168] [108/133] (527s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[499.933084] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[499.937546] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[500.047924] [109/133] (527s left) syncobj_wait (invalid-reset-one-illegal-handle)
[500.112235] Starting subtest: invalid-reset-one-illegal-handle
[500.114580] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[500.210558] [110/133] (527s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[500.306964] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[500.311144] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[500.401746] [111/133] (527s left) gem_exec_fence (syncobj-wait)
[500.849067] Starting subtest: syncobj-wait
[502.196803] Subtest syncobj-wait: SUCCESS (1.350s)
[502.546765] [112/133] (525s left) gem_exec_balancer (parallel-contexts)
[502.837016] Starting subtest: parallel-contexts
[506.720310] Subtest parallel-contexts: SUCCESS (3.887s)
[506.830474] [113/133] (521s left) kms_draw_crc (draw-method-mmap-cpu)
[506.918524] Starting subtest: draw-method-mmap-cpu
[506.920430] Starting dynamic subtest: xrgb8888-untiled
[507.218816] Dynamic subtest xrgb8888-untiled: SUCCESS (0.302s)
[507.228741] Starting dynamic subtest: rgb565-untiled
[507.463044] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[507.473241] Starting dynamic subtest: xrgb2101010-untiled
[507.685472] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[507.695797] Starting dynamic subtest: xbgr16161616f-untiled
[507.929447] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[507.939218] Starting dynamic subtest: xrgb8888-xtiled
[508.073870] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[508.085624] Starting dynamic subtest: rgb565-xtiled
[508.219645] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[508.231918] Starting dynamic subtest: xrgb2101010-xtiled
[508.351510] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[508.363266] Starting dynamic subtest: xbgr16161616f-xtiled
[508.484995] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[508.494776] Starting dynamic subtest: xrgb8888-4tiled
[508.629098] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[508.639004] Starting dynamic subtest: rgb565-4tiled
[508.762404] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[508.771963] Starting dynamic subtest: xrgb2101010-4tiled
[508.895801] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[508.908790] Starting dynamic subtest: xbgr16161616f-4tiled
[509.040289] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.142s)
[509.042281] Subtest draw-method-mmap-cpu: SUCCESS (2.125s)
[509.137272] [114/133] (518s left) syncobj_timeline (invalid-query-zero-handles)
[509.190435] Starting subtest: invalid-query-zero-handles
[509.192236] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[509.282453] [115/133] (518s left) gem_softpin (full)
[509.344858] Starting subtest: full
[509.353867] Subtest full: SUCCESS (0.009s)
[509.474788] [116/133] (518s left) kms_cursor_crc (cursor-sliding-512x512)
[509.759586] Starting subtest: cursor-sliding-512x512
[509.763302] Subtest cursor-sliding-512x512: SKIP (0.001s)
[509.908649] [117/133] (518s left) kms_vrr (negative-basic)
[509.994762] Starting subtest: negative-basic
[510.000610] Starting dynamic subtest: pipe-A-eDP-1
[515.913216] Dynamic subtest pipe-A-eDP-1: FAIL (5.408s)
[515.914972] Subtest negative-basic: FAIL (5.710s)
[516.558248] [118/133] (511s left) gem_pxp (verify-pxp-stale-buf-execution)
[516.671909] Starting subtest: verify-pxp-stale-buf-execution
[517.734350] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[517.852211] [119/133] (510s left) syncobj_timeline (32bits-limit)
[517.899204] Starting subtest: 32bits-limit
[517.901465] Subtest 32bits-limit: SUCCESS (0.001s)
[517.990546] [120/133] (510s left) gem_exec_reloc (basic-cpu-read)
[518.053557] Subtest basic-cpu-read: SKIP (0.000s)
[518.131440] [121/133] (510s left) gem_exec_params (rsvd2-dirt)
[518.194133] Starting subtest: rsvd2-dirt
[518.198711] Subtest rsvd2-dirt: SKIP (0.000s)
[518.302780] [122/133] (510s left) kms_cursor_crc (cursor-size-hints)
[518.435295] Starting subtest: cursor-size-hints
[518.437481] Starting dynamic subtest: pipe-A-eDP-1
[519.043330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[519.053829] Starting dynamic subtest: pipe-D-eDP-1
[520.344028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[520.346391] Subtest cursor-size-hints: SUCCESS (1.907s)
[521.222217] [123/133] (507s left) kms_flip (nonblocking-read)
[521.313697] Starting subtest: nonblocking-read
[521.315953] Subtest nonblocking-read: SUCCESS (0.000s)
[521.424504] [124/133] (506s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[521.516632] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[521.520708] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[521.622144] [125/133] (506s left) gem_exec_params (invalid-bsd2-flag-on-render)
[521.685783] Starting subtest: invalid-bsd2-flag-on-render
[521.688182] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[521.785286] [126/133] (506s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[521.889815] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[521.894186] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[521.984191] [127/133] (506s left) kms_content_protection (legacy)
[522.143360] Starting subtest: legacy
[522.148253] Subtest legacy: SKIP (0.000s)
[522.251997] [128/133] (506s left) core_auth (many-magics)
[522.294782] Starting subtest: many-magics
[523.098945] Subtest many-magics: SUCCESS (0.805s)
[523.273327] [129/133] (505s left) kms_properties (crtc-properties-legacy)
[523.371920] Starting subtest: crtc-properties-legacy
[523.373978] Starting dynamic subtest: pipe-A-eDP-1
[523.810986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[523.823002] Starting dynamic subtest: pipe-B-eDP-1
[524.983140] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[524.994282] Starting dynamic subtest: pipe-C-eDP-1
[526.101582] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[526.111854] Starting dynamic subtest: pipe-D-eDP-1
[527.243958] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[527.245856] Subtest crtc-properties-legacy: SUCCESS (3.871s)
[528.057809] [130/133] (500s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[528.172959] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[528.177460] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[528.321064] [131/133] (500s left) kms_chamelium_audio (dp-audio-edid)
[528.702499] Subtest dp-audio-edid: SKIP (0.000s)
[529.476576] [132/133] (499s left) kms_pm_dc (dc5-dpms-negative)
[530.575459] Starting subtest: dc5-dpms-negative
[530.579927] Subtest dc5-dpms-negative: SKIP (0.000s)
[530.652725] [133/133] (498s left) kms_cursor_crc (cursor-offscreen-32x32)
[530.807054] Starting subtest: cursor-offscreen-32x32
[530.851467] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[531.131903] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_whisper
results: parsing output: 1/ for test: gem_linear_blits
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: device_reset
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_caching
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_parallel
results: parsing output: 12/ for test: kms_selftest
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_mmap_write_crc
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: i915_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_psr2_su
results: parsing output: 23/ for test: gem_ctx_shared
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr_stress_test
results: parsing output: 28/ for test: kms_dp_aux_dev
results: parsing output: 29/ for test: gem_bad_reloc
results: parsing output: 30/ for test: kms_prop_blob
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_drm_fdinfo
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_wait
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: i915_pm_rps
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: api_intel_allocator
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: vgem_slow
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_atomic
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: sriov_basic
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_ctx_engines
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_hdr
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: template
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: kms_plane_multiple
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: syncobj_basic
results: parsing output: 82/ for test: gem_lmem_swapping
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: gem_partial_pwrite_pread
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: gem_fenced_exec_thrash
results: parsing output: 92/ for test: gen7_exec_parse
results: parsing output: 93/ for test: i915_module_load
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_lease
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_exec_whisper
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: sysfs_preempt_timeout
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pread
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_exec_balancer
results: parsing output: 112/ for test: kms_draw_crc
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_vrr
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_content_protection
results: parsing output: 127/ for test: core_auth
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_chamelium_audio
results: parsing output: 131/ for test: kms_pm_dc
results: parsing output: 132/ for test: kms_cursor_crc
Done.