[56.201728] Initializing watchdogs
[56.201776]   /dev/watchdog0
[56.216117] [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]
[56.220731] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.223126] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.226446] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[56.306290] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[56.308628] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[56.426602] [002/133] (960s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[56.532767] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[56.535266] Starting dynamic subtest: pipe-A-eDP-1
[56.560736] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[56.570592] Starting dynamic subtest: pipe-B-eDP-1
[56.594363] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[56.600680] Starting dynamic subtest: pipe-C-eDP-1
[56.624421] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[56.632744] Starting dynamic subtest: pipe-D-eDP-1
[56.657253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[56.661687] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[58.723292] [003/133] (958s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc)
[58.822882] Starting subtest: psr-argb161616f-draw-mmap-wc
[58.827449] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s)
[58.962342] [004/133] (957s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[59.064673] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[59.066818] Starting dynamic subtest: pipe-A-eDP-1
[59.086607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[59.095145] Starting dynamic subtest: pipe-B-eDP-1
[59.114273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[59.120561] Starting dynamic subtest: pipe-C-eDP-1
[59.140057] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[59.147069] Starting dynamic subtest: pipe-D-eDP-1
[59.165677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[59.167554] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[61.373566] [005/133] (955s left) gem_ctx_isolation (nonpriv)
[61.433406] Starting subtest: nonpriv
[61.435824] Starting dynamic subtest: rcs0
[61.697040] Dynamic subtest rcs0: SUCCESS (0.263s)
[61.706765] Starting dynamic subtest: bcs0
[61.989706] Dynamic subtest bcs0: SUCCESS (0.292s)
[61.999610] Starting dynamic subtest: vcs0
[62.276822] Dynamic subtest vcs0: SUCCESS (0.287s)
[62.286424] Starting dynamic subtest: vcs1
[64.156783] Dynamic subtest vcs1: SUCCESS (1.878s)
[64.164547] Starting dynamic subtest: vecs0
[66.198889] Dynamic subtest vecs0: SUCCESS (2.041s)
[66.206038] Starting dynamic subtest: ccs0
[68.263404] Dynamic subtest ccs0: SUCCESS (2.063s)
[68.265774] Subtest nonpriv: SUCCESS (6.826s)
[68.526739] [006/133] (948s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[68.589114] Subtest writes-after-reads-snoop: SKIP (0.000s)
[68.652014] [007/133] (948s left) kms_lease (lease-revoke)
[68.749358] Starting subtest: lease-revoke
[68.751741] Starting dynamic subtest: pipe-A-eDP-1
[68.785955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[68.795245] Starting dynamic subtest: pipe-B-eDP-1
[68.811269] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[68.819213] Starting dynamic subtest: pipe-C-eDP-1
[68.841164] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[68.849995] Starting dynamic subtest: pipe-D-eDP-1
[68.871840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[68.873765] Subtest lease-revoke: SUCCESS (0.121s)
[69.032939] [008/133] (947s left) gem_exec_schedule (thriceslice)
[69.112263] Starting subtest: thriceslice
[69.114505] Starting dynamic subtest: rcs0
[69.133853] Dynamic subtest rcs0: SUCCESS (0.031s)
[69.142530] Starting dynamic subtest: bcs0
[69.162682] Dynamic subtest bcs0: SUCCESS (0.028s)
[69.172650] Starting dynamic subtest: vcs0
[69.212118] Dynamic subtest vcs0: SUCCESS (0.049s)
[69.221606] Starting dynamic subtest: vcs1
[69.242466] Dynamic subtest vcs1: SUCCESS (0.030s)
[69.250334] Starting dynamic subtest: vecs0
[69.270924] Dynamic subtest vecs0: SUCCESS (0.028s)
[69.278377] Starting dynamic subtest: ccs0
[69.303578] Dynamic subtest ccs0: SUCCESS (0.030s)
[69.305966] Subtest thriceslice: SUCCESS (0.199s)
[70.989717] [009/133] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[71.104656] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[71.109070] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[71.229063] [010/133] (945s left) kms_psr (psr-basic)
[71.335717] Starting subtest: psr-basic
[71.338012] Starting dynamic subtest: eDP-1
[72.938083] Dynamic subtest eDP-1: SUCCESS (1.612s)
[72.940490] Subtest psr-basic: SUCCESS (1.612s)
[73.836972] [011/133] (943s left) kms_dirtyfb (default-dirtyfb-ioctl)
[73.932137] Starting subtest: default-dirtyfb-ioctl
[73.934494] Starting dynamic subtest: A-eDP-1
[75.551288] Dynamic subtest A-eDP-1: SUCCESS (1.619s)
[75.553665] Subtest default-dirtyfb-ioctl: SUCCESS (1.620s)
[76.369205] [012/133] (940s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[76.493527] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[76.497574] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.626805] [013/133] (940s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[81.652537] Starting subtest: psr2-overlay-plane-update-continuous-sf
[81.654929] Starting dynamic subtest: pipe-A-eDP-1
[83.379087] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.726s)
[83.387766] Starting dynamic subtest: pipe-B-eDP-1
[85.111430] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.730s)
[85.113799] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (3.460s)
[85.980219] [014/133] (931s left) kms_flip (modeset-vs-vblank-race-interruptible)
[86.094245] Starting subtest: modeset-vs-vblank-race-interruptible
[86.096612] Starting dynamic subtest: A-eDP1
[90.741911] Dynamic subtest A-eDP1: SUCCESS (4.646s)
[90.751873] Starting dynamic subtest: B-eDP1
[95.379976] Dynamic subtest B-eDP1: SUCCESS (4.636s)
[95.390258] Starting dynamic subtest: C-eDP1
[99.898194] Dynamic subtest C-eDP1: SUCCESS (4.516s)
[99.908125] Starting dynamic subtest: D-eDP1
[104.524185] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[104.526539] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.431s)
[105.694955] [015/133] (911s left) api_intel_allocator (fork-simple-stress)
[105.749850] Starting subtest: fork-simple-stress
[111.146741] Subtest fork-simple-stress: SUCCESS (5.397s)
[111.277040] [016/133] (906s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[111.880939] Starting subtest: syncobj-backward-timeline-chain-engines
[112.061855] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.181s)
[113.058782] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[113.062496] [017/133] (904s left) gem_exec_async (concurrent-writes)
[113.119721] Starting subtest: concurrent-writes
[113.121847] Starting dynamic subtest: rcs0
[113.146358] Dynamic subtest rcs0: SUCCESS (0.026s)
[113.156801] Starting dynamic subtest: bcs0
[113.159529] Dynamic subtest bcs0: SUCCESS (0.012s)
[113.168015] Starting dynamic subtest: vcs0
[113.170440] Dynamic subtest vcs0: SUCCESS (0.009s)
[113.178392] Starting dynamic subtest: vcs1
[113.180827] Dynamic subtest vcs1: SUCCESS (0.009s)
[113.189051] Starting dynamic subtest: vecs0
[113.191215] Dynamic subtest vecs0: SUCCESS (0.011s)
[113.199261] Starting dynamic subtest: ccs0
[113.201480] Dynamic subtest ccs0: SUCCESS (0.008s)
[113.203691] Subtest concurrent-writes: SUCCESS (0.078s)
[113.470684] [018/133] (903s left) gem_lmem_swapping (parallel-multi)
[113.519157] Subtest parallel-multi: SKIP (0.000s)
[113.572279] [019/133] (903s left) kms_chamelium_audio (hdmi-audio-edid)
[113.968403] Subtest hdmi-audio-edid: SKIP (0.000s)
[114.782849] [020/133] (902s left) kms_selftest (drm_format)
[114.825839] Starting subtest: drm_format
[114.837103] Starting dynamic subtest: drm_test_format_block_width_invalid
[114.999510] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.161s)
[115.008432] Starting dynamic subtest: drm_test_format_block_width_one_plane
[115.137836] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.136s)
[115.147080] Starting dynamic subtest: drm_test_format_block_width_two_plane
[115.270501] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.132s)
[115.279467] Starting dynamic subtest: drm_test_format_block_width_three_plane
[115.415848] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.145s)
[115.423378] Starting dynamic subtest: drm_test_format_block_width_tiled
[115.573645] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.157s)
[115.582964] Starting dynamic subtest: drm_test_format_block_height_invalid
[115.710213] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.136s)
[115.719450] Starting dynamic subtest: drm_test_format_block_height_one_plane
[115.848418] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.138s)
[115.857899] Starting dynamic subtest: drm_test_format_block_height_two_plane
[115.995528] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.147s)
[116.005469] Starting dynamic subtest: drm_test_format_block_height_three_plane
[116.135640] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.140s)
[116.145030] Starting dynamic subtest: drm_test_format_block_height_tiled
[116.273652] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.137s)
[116.281402] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[116.416092] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.142s)
[116.423656] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[116.573865] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.157s)
[116.582666] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[116.674493] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.102s)
[116.681640] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[116.806752] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.130s)
[116.813850] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[116.942672] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.135s)
[116.951534] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[117.075440] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.132s)
[117.084363] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[117.218102] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.143s)
[117.224911] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[117.364539] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.146s)
[117.366568] Subtest drm_format: SUCCESS (2.537s)
[117.597410] [021/133] (899s left) syncobj_wait (wait-any-complex)
[117.653388] Starting subtest: wait-any-complex
[117.716391] Subtest wait-any-complex: SUCCESS (0.063s)
[117.855964] [022/133] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[117.923193] Starting subtest: etime-multi-wait-all-for-submit-submitted
[118.031660] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[118.131802] [023/133] (899s left) kms_cursor_crc (cursor-onscreen-512x170)
[118.422848] Starting subtest: cursor-onscreen-512x170
[118.427459] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[118.606551] [024/133] (899s left) kms_hdr (bpc-switch)
[118.693428] Starting subtest: bpc-switch
[119.780029] Starting dynamic subtest: pipe-A-eDP-1
[123.281047] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[123.283481] Subtest bpc-switch: SUCCESS (4.587s)
[123.443849] [025/133] (894s left) i915_drm_fdinfo (memory-info-shared)
[123.482365] Starting subtest: memory-info-shared
[123.484783] Starting dynamic subtest: smem0
[123.547075] Dynamic subtest smem0: SUCCESS (0.064s)
[123.549801] Subtest memory-info-shared: SUCCESS (0.064s)
[123.650870] [026/133] (894s left) gem_exec_reloc (basic-wc-cpu)
[123.712781] Subtest basic-wc-cpu: SKIP (0.000s)
[123.799878] [027/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[123.910725] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[123.915143] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[124.045314] [028/133] (893s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[124.134066] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[124.136345] Starting dynamic subtest: pipe-A
[125.181905] Dynamic subtest pipe-A: SUCCESS (1.050s)
[125.189755] Starting dynamic subtest: pipe-B
[127.355724] Dynamic subtest pipe-B: SUCCESS (2.172s)
[127.363922] Starting dynamic subtest: pipe-C
[128.537324] Dynamic subtest pipe-C: SUCCESS (1.179s)
[128.545778] Starting dynamic subtest: pipe-D
[129.778054] Dynamic subtest pipe-D: SUCCESS (1.239s)
[129.780690] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.646s)
[130.986506] [029/133] (886s left) gem_exec_reloc (basic-softpin)
[131.057214] Subtest basic-softpin: SKIP (0.000s)
[131.148957] [030/133] (886s left) kms_flip (blocking-wf_vblank)
[131.251336] Starting subtest: blocking-wf_vblank
[131.253670] Starting dynamic subtest: A-eDP1
[140.213365] Dynamic subtest A-eDP1: SUCCESS (8.963s)
[140.221289] Starting dynamic subtest: B-eDP1
[149.146741] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[149.156764] Starting dynamic subtest: C-eDP1
[158.072721] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[158.081288] Starting dynamic subtest: D-eDP1
[167.008334] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[167.010732] Subtest blocking-wf_vblank: SUCCESS (35.758s)
[168.257475] [031/133] (849s left) syncobj_basic (bad-flags-handle-to-fd)
[168.308061] Starting subtest: bad-flags-handle-to-fd
[168.309999] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[168.447466] [032/133] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[168.545301] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[175.264775] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.721s)
[175.421968] [033/133] (842s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[175.486283] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[175.490736] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[175.693078] [034/133] (842s left) sw_sync (sync_merge_same)
[175.733374] Starting subtest: sync_merge_same
[175.735298] Subtest sync_merge_same: SUCCESS (0.000s)
[175.813863] [035/133] (842s left) gem_tiled_partial_pwrite_pread (writes)
[175.876678] Subtest writes: SKIP (0.000s)
[175.960385] [036/133] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[176.058740] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[176.063212] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[176.173475] [037/133] (842s left) kms_color (ctm-max)
[176.268329] Starting subtest: ctm-max
[176.270162] Starting dynamic subtest: pipe-A-eDP-1
[176.972843] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[176.982343] Starting dynamic subtest: pipe-B-eDP-1
[178.405063] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[178.412775] Starting dynamic subtest: pipe-C-eDP-1
[179.765179] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[179.773726] Starting dynamic subtest: pipe-D-eDP-1
[181.096254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[181.098127] Subtest ctm-max: SUCCESS (4.827s)
[181.929094] [038/133] (836s left) kms_psr (fbc-pr-suspend)
[182.030121] Starting subtest: fbc-pr-suspend
[182.034606] Subtest fbc-pr-suspend: SKIP (0.000s)
[182.127835] [039/133] (836s left) vgem_basic (dmabuf-fence)
[182.177204] Starting subtest: dmabuf-fence
[182.179383] Subtest dmabuf-fence: SUCCESS (0.000s)
[182.258099] [040/133] (836s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[182.353099] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[182.355411] Starting dynamic subtest: pipe-A
[182.376581] Dynamic subtest pipe-A: SKIP (0.019s)
[182.386642] Starting dynamic subtest: pipe-B
[182.410533] Dynamic subtest pipe-B: SKIP (0.034s)
[182.421076] Starting dynamic subtest: pipe-C
[182.443518] Dynamic subtest pipe-C: SKIP (0.032s)
[182.454142] Starting dynamic subtest: pipe-D
[182.475845] Dynamic subtest pipe-D: SKIP (0.032s)
[182.479579] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.120s)
[182.604063] [041/133] (835s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[182.691104] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[182.693630] Starting dynamic subtest: pipe-A-default-mode
[182.991249] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[182.995984] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.299s)
[183.865502] [042/133] (834s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[183.971231] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[191.000627] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.033s)
[191.149324] [043/133] (827s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[191.210262] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[191.272824] [044/133] (827s left) kms_cursor_crc (cursor-random-64x64)
[191.456867] Starting subtest: cursor-random-64x64
[191.459172] Starting dynamic subtest: pipe-A-eDP-1
[194.857935] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.397s)
[194.885901] Starting dynamic subtest: pipe-D-eDP-1
[198.865069] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.984s)
[198.867083] Subtest cursor-random-64x64: SUCCESS (7.408s)
[199.755594] [045/133] (818s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[199.885657] Starting subtest: short-flip-after-cursor-atomic-transitions
[200.836024] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.948s)
[201.680422] [046/133] (816s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[201.800600] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[201.804961] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[201.923167] [047/133] (816s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[202.015694] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[202.018037] Starting dynamic subtest: pipe-A-eDP-1
[202.038313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.048401] Starting dynamic subtest: pipe-B-eDP-1
[202.067635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.075376] Starting dynamic subtest: pipe-C-eDP-1
[202.094617] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.102379] Starting dynamic subtest: pipe-D-eDP-1
[202.122227] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.124421] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[204.351634] [048/133] (814s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[204.483530] Starting subtest: short-flip-after-cursor-toggle
[205.405391] Subtest short-flip-after-cursor-toggle: SUCCESS (0.921s)
[206.277209] [049/133] (812s left) gem_ccs (block-multicopy-compressed)
[206.339378] Starting subtest: block-multicopy-compressed
[206.343632] Subtest block-multicopy-compressed: SKIP (0.000s)
[206.469384] [050/133] (812s left) kms_cursor_edge_walk (256x256-left-edge)
[206.577030] Starting subtest: 256x256-left-edge
[206.579401] Starting dynamic subtest: pipe-A-eDP-1
[210.024378] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[210.033113] Starting dynamic subtest: pipe-D-eDP-1
[213.159980] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s)
[213.162348] Subtest 256x256-left-edge: SUCCESS (6.587s)
[213.979229] [051/133] (804s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[214.074270] Starting subtest: 4-tiled-64bpp-rotate-90
[214.098473] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.023s)
[214.247751] [052/133] (804s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[214.316297] Subtest writes-after-reads: SKIP (0.000s)
[214.399878] [053/133] (804s left) gen7_exec_parse (load-register-reg)
[214.464408] Subtest load-register-reg: SKIP (0.000s)
[214.533740] [054/133] (804s left) gem_exec_schedule (pi-userfault)
[214.714195] Starting subtest: pi-userfault
[214.716544] Starting dynamic subtest: rcs0
[214.722572] Dynamic subtest rcs0: SUCCESS (0.010s)
[214.732011] Starting dynamic subtest: bcs0
[214.734342] Dynamic subtest bcs0: SUCCESS (0.007s)
[214.741964] Starting dynamic subtest: vcs0
[214.743888] Dynamic subtest vcs0: SUCCESS (0.007s)
[214.751905] Starting dynamic subtest: vcs1
[214.754194] Dynamic subtest vcs1: SUCCESS (0.007s)
[214.762047] Starting dynamic subtest: vecs0
[214.764491] Dynamic subtest vecs0: SUCCESS (0.007s)
[214.773430] Starting dynamic subtest: ccs0
[214.775571] Dynamic subtest ccs0: SUCCESS (0.009s)
[214.777673] Subtest pi-userfault: SUCCESS (0.052s)
[214.969184] [055/133] (803s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-pwrite)
[215.074646] Starting subtest: fbcpsr-argb161616f-draw-pwrite
[215.078626] Subtest fbcpsr-argb161616f-draw-pwrite: SKIP (0.000s)
[215.203823] [056/133] (803s left) kms_chamelium_frames (hdmi-crc-single)
[215.585573] Subtest hdmi-crc-single: SKIP (0.000s)
[216.358346] [057/133] (802s left) gem_tiled_partial_pwrite_pread (reads)
[216.424512] Subtest reads: SKIP (0.000s)
[216.500619] [058/133] (802s left) syncobj_eventfd (invalid-illegal-handle)
[216.564327] Starting subtest: invalid-illegal-handle
[216.566595] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[216.672804] [059/133] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[216.787530] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[216.791605] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[216.912723] [060/133] (802s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[216.965045] Starting subtest: single-wait-all-for-submit-available-submitted
[216.967104] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[217.103954] [061/133] (802s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[222.058930] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[222.063552] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[222.931706] [062/133] (796s left) kms_plane_alpha_blend (alpha-7efc)
[223.028101] Starting subtest: alpha-7efc
[223.322080] Starting dynamic subtest: pipe-A-eDP-1
[223.921822] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[223.950133] Starting dynamic subtest: pipe-D-eDP-1
[225.220861] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.277s)
[225.223279] Subtest alpha-7efc: SUCCESS (2.195s)
[226.078339] [063/133] (793s left) kms_plane_multiple (tiling-y)
[226.162206] Starting subtest: tiling-y
[226.166583] Subtest tiling-y: SKIP (0.000s)
[226.257614] [064/133] (793s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[226.381838] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[226.512544] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s)
[226.685915] [065/133] (792s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[226.798324] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[227.821516] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.022s)
[227.977428] [066/133] (791s left) perf (polling-parameterized)
[228.112185] Starting subtest: polling-parameterized
[248.132353] Subtest polling-parameterized: SUCCESS (20.019s)
[248.181379] [067/133] (771s left) gem_exec_gttfill (basic)
[248.251858] Starting subtest: basic
[251.886048] Subtest basic: SUCCESS (3.634s)
[252.100690] [068/133] (767s left) kms_flip (nonexisting-fb)
[252.236434] Starting subtest: nonexisting-fb
[252.238727] Starting dynamic subtest: A-eDP1
[253.452118] Dynamic subtest A-eDP1: SUCCESS (1.215s)
[253.460989] Starting dynamic subtest: B-eDP1
[254.584678] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[254.594058] Starting dynamic subtest: C-eDP1
[255.718179] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[255.729417] Starting dynamic subtest: D-eDP1
[256.941101] Dynamic subtest D-eDP1: SUCCESS (1.219s)
[256.946698] Subtest nonexisting-fb: SUCCESS (4.712s)
[258.243934] [069/133] (761s left) kms_psr (psr-sprite-plane-onoff)
[258.358340] Starting subtest: psr-sprite-plane-onoff
[258.360711] Starting dynamic subtest: eDP-1
[260.172236] Dynamic subtest eDP-1: SUCCESS (1.813s)
[260.174817] Subtest psr-sprite-plane-onoff: SUCCESS (1.814s)
[261.010229] [070/133] (758s left) gem_exec_balancer (waits)
[261.082502] Starting subtest: waits
[267.552707] Subtest waits: SUCCESS (6.468s)
[267.902062] [071/133] (751s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[268.011986] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[268.014303] Starting dynamic subtest: pipe-A-default-mode
[268.325257] Dynamic subtest pipe-A-default-mode: SKIP (0.311s)
[268.329861] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s)
[269.144426] [072/133] (750s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[269.208919] Starting subtest: x-tiled-to-vebox-yf-tiled
[269.213240] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[269.415340] [073/133] (750s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[269.499279] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[269.501492] Starting dynamic subtest: pipe-A-eDP-1
[269.510475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.521042] Starting dynamic subtest: pipe-B-eDP-1
[269.529947] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.538173] Starting dynamic subtest: pipe-C-eDP-1
[269.546406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.554635] Starting dynamic subtest: pipe-D-eDP-1
[269.563561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.567951] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[271.809493] [074/133] (747s left) gem_exec_params (sol-reset-invalid)
[271.875430] Starting subtest: sol-reset-invalid
[271.877726] Subtest sol-reset-invalid: SUCCESS (0.002s)
[274.062342] [075/133] (745s left) kms_vblank (wait-idle-hang)
[274.164214] Starting subtest: wait-idle-hang
[274.166538] Starting dynamic subtest: pipe-A-eDP-1
[300.701953] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.535s)
[300.715903] Starting dynamic subtest: pipe-D-eDP-1
[325.650990] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s)
[325.653211] Subtest wait-idle-hang: SUCCESS (51.487s)
[326.477248] [076/133] (693s left) i915_pm_freq_mult (media-freq)
[326.543974] Starting subtest: media-freq
[326.546287] Starting dynamic subtest: gt0
[326.550564] Dynamic subtest gt0: SKIP (0.000s)
[326.562553] Starting dynamic subtest: gt1
[326.566752] Dynamic subtest gt1: SKIP (0.000s)
[326.570979] Subtest media-freq: SKIP (0.002s)
[326.681095] [077/133] (693s left) gem_softpin (safe-alignment)
[326.742310] Starting subtest: safe-alignment
[326.764710] Subtest safe-alignment: SUCCESS (0.022s)
[327.954995] [078/133] (691s left) gem_caching (reads)
[328.033512] Subtest reads: SKIP (0.000s)
[328.125037] [079/133] (691s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[328.214250] Starting subtest: fbc-psr-sprite-mmap-cpu
[328.216355] Starting dynamic subtest: eDP-1
[328.220615] Dynamic subtest eDP-1: SKIP (0.000s)
[328.224848] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[328.310726] [080/133] (691s left) gem_exec_reloc (basic-gtt-read)
[328.380377] Subtest basic-gtt-read: SKIP (0.000s)
[328.460888] [081/133] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[328.562372] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[328.566559] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[328.704563] [082/133] (691s left) gem_exec_whisper (basic-forked)
[328.776640] Starting subtest: basic-forked
[336.057244] Subtest basic-forked: SUCCESS (7.278s)
[336.271359] [083/133] (683s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[336.385323] Starting subtest: psr-rgb565-draw-pwrite
[343.375181] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.991s)
[343.516303] [084/133] (676s left) kms_atomic (plane-invalid-params)
[343.623213] Starting subtest: plane-invalid-params
[343.625446] Starting dynamic subtest: pipe-A-eDP-1
[344.016700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[344.019078] Subtest plane-invalid-params: SUCCESS (0.396s)
[344.846277] [085/133] (675s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[344.907644] Starting subtest: invalid-bsd1-flag-on-vebox
[344.910056] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[345.045631] [086/133] (675s left) gem_exec_reloc (basic-write-wc-noreloc)
[345.106052] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[345.174563] [087/133] (675s left) kms_pm_rpm (pm-caching)
[347.010664] Starting subtest: pm-caching
[347.015484] Subtest pm-caching: SKIP (0.000s)
[347.483857] [088/133] (672s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-wc)
[347.591367] Starting subtest: fbc-abgr161616f-draw-mmap-wc
[347.595818] Subtest fbc-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[347.724123] [089/133] (672s left) gem_workarounds (basic-read-context)
[347.820682] Starting subtest: basic-read-context
[347.832285] Subtest basic-read-context: SUCCESS (0.011s)
[348.002118] [090/133] (672s left) gem_flink_basic (flink-lifetime)
[348.064945] Starting subtest: flink-lifetime
[348.069558] Subtest flink-lifetime: SUCCESS (0.003s)
[348.198561] [091/133] (672s left) kms_content_protection (legacy)
[348.340038] Starting subtest: legacy
[348.344472] Subtest legacy: SKIP (0.000s)
[348.495885] [092/133] (671s left) kms_addfb_basic (bo-too-small)
[348.588712] Starting subtest: bo-too-small
[348.590726] Subtest bo-too-small: SUCCESS (0.000s)
[348.705078] [093/133] (671s left) kms_psr (fbc-psr2-sprite-plane-move)
[348.800579] Starting subtest: fbc-psr2-sprite-plane-move
[348.802402] Starting dynamic subtest: eDP-1
[348.805751] Dynamic subtest eDP-1: SKIP (0.000s)
[348.809163] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[348.897859] [094/133] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[348.992073] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[352.609985] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.620s)
[353.768950] [095/133] (666s left) gem_tiled_pread_pwrite
[353.888530] [096/133] (666s left) kms_big_fb (linear-64bpp-rotate-180)
[353.992426] Starting subtest: linear-64bpp-rotate-180
[355.593728] Subtest linear-64bpp-rotate-180: SUCCESS (1.601s)
[355.809122] [097/133] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[355.907650] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[355.911718] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[356.040520] [098/133] (664s left) kms_invalid_mode (int-max-clock)
[356.132178] Starting subtest: int-max-clock
[356.134380] Starting dynamic subtest: pipe-A-eDP-1
[356.426821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[356.436244] Starting dynamic subtest: pipe-B-eDP-1
[356.438161] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[356.446359] Starting dynamic subtest: pipe-C-eDP-1
[356.448761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.457013] Starting dynamic subtest: pipe-D-eDP-1
[356.459234] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.461487] Subtest int-max-clock: SUCCESS (0.301s)
[357.297358] [099/133] (663s left) api_intel_bb (reset-bb)
[357.357212] Starting subtest: reset-bb
[357.361832] Subtest reset-bb: SUCCESS (0.004s)
[357.529175] [100/133] (663s left) kms_async_flips (alternate-sync-async-flip-atomic)
[357.624092] Starting subtest: alternate-sync-async-flip-atomic
[358.007531] Starting dynamic subtest: pipe-A-eDP-1
[360.756039] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[361.147410] Starting dynamic subtest: pipe-B-eDP-1
[363.886103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[364.264629] Starting dynamic subtest: pipe-C-eDP-1
[367.026626] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[367.390914] Starting dynamic subtest: pipe-D-eDP-1
[370.162906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.779s)
[370.165384] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.541s)
[371.350244] [101/133] (649s left) gem_exec_reloc (basic-gtt-cpu)
[371.421703] Subtest basic-gtt-cpu: SKIP (0.000s)
[371.505075] [102/133] (649s left) gem_mmap_gtt (fault-concurrent-y)
[371.561167] Subtest fault-concurrent-Y: SKIP (0.000s)
[371.628371] [103/133] (649s left) kms_chamelium_hpd (dp-hpd)
[372.025504] Subtest dp-hpd: SKIP (0.000s)
[372.839557] [104/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[372.947078] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[372.951075] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[373.062885] [105/133] (647s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[373.166194] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[373.175638] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[373.281566] [106/133] (647s left) gem_exec_balancer (bonded-semaphore)
[373.350977] Starting subtest: bonded-semaphore
[373.354964] Subtest bonded-semaphore: SKIP (0.000s)
[373.667826] [107/133] (647s left) gem_readwrite (new-obj)
[373.735644] Subtest new-obj: SKIP (0.000s)
[373.804599] [108/133] (647s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[378.859570] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[378.864242] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[379.709598] [109/133] (641s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[379.817129] Starting subtest: yf-tiled-8bpp-rotate-0
[379.821598] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[379.938643] [110/133] (641s left) kms_vblank (invalid)
[380.036240] Starting subtest: invalid
[380.038097] Starting dynamic subtest: pipe-A-eDP-1
[380.435161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[380.437333] Subtest invalid: SUCCESS (0.399s)
[381.335684] [111/133] (639s left) kms_flip (nonexisting-fb-interruptible)
[381.423158] Starting subtest: nonexisting-fb-interruptible
[381.425329] Starting dynamic subtest: A-eDP1
[382.611741] Dynamic subtest A-eDP1: SUCCESS (1.187s)
[382.621455] Starting dynamic subtest: B-eDP1
[383.735678] Dynamic subtest B-eDP1: SUCCESS (1.123s)
[383.744547] Starting dynamic subtest: C-eDP1
[384.872188] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[384.881066] Starting dynamic subtest: D-eDP1
[386.005854] Dynamic subtest D-eDP1: SUCCESS (1.133s)
[386.010770] Subtest nonexisting-fb-interruptible: SUCCESS (4.587s)
[387.225879] [112/133] (634s left) kms_feature_discovery (psr1)
[387.332066] Starting subtest: psr1
[387.334190] Subtest psr1: SUCCESS (0.000s)
[387.428662] [113/133] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[387.528353] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[387.532611] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[387.669366] [114/133] (633s left) perf_pmu (busy-check-all)
[387.708508] Starting subtest: busy-check-all
[387.710394] Starting dynamic subtest: rcs0
[388.276737] Dynamic subtest rcs0: SUCCESS (0.569s)
[388.289507] Starting dynamic subtest: bcs0
[388.828566] Dynamic subtest bcs0: SUCCESS (0.550s)
[388.840314] Starting dynamic subtest: vcs0
[390.931794] Dynamic subtest vcs0: SUCCESS (2.099s)
[390.943687] Starting dynamic subtest: vcs1
[392.915988] Dynamic subtest vcs1: SUCCESS (1.981s)
[392.927729] Starting dynamic subtest: vecs0
[394.900040] Dynamic subtest vecs0: SUCCESS (1.981s)
[394.911995] Starting dynamic subtest: ccs0
[395.454078] Dynamic subtest ccs0: SUCCESS (0.553s)
[395.456506] Subtest busy-check-all: SUCCESS (7.748s)
[395.597515] [115/133] (625s left) kms_rmfb (close-fd)
[395.701106] Starting subtest: close-fd
[395.703336] Starting dynamic subtest: pipe-A-eDP-1
[395.810397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[395.820603] Starting dynamic subtest: pipe-B-eDP-1
[396.960704] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[396.970978] Starting dynamic subtest: pipe-C-eDP-1
[398.069844] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[398.078522] Starting dynamic subtest: pipe-D-eDP-1
[399.212170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[399.214594] Subtest close-fd: SUCCESS (3.513s)
[400.450264] [116/133] (621s left) dumb_buffer (invalid-bpp)
[400.514972] Starting subtest: invalid-bpp
[400.516871] Subtest invalid-bpp: SUCCESS (0.000s)
[400.647248] [117/133] (620s left) syncobj_wait (wait-all-complex)
[400.703587] Starting subtest: wait-all-complex
[400.917423] Subtest wait-all-complex: SUCCESS (0.212s)
[401.017623] [118/133] (620s left) gem_exec_schedule (fairslice-all)
[401.090890] Starting subtest: fairslice-all
[403.147165] Subtest fairslice-all: SUCCESS (2.062s)
[405.003850] [119/133] (616s left) syncobj_timeline (invalid-wait-illegal-handle)
[405.068578] Starting subtest: invalid-wait-illegal-handle
[405.071201] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[405.194426] [120/133] (616s left) i915_query (hwconfig_table)
[405.248300] Starting subtest: hwconfig_table
[405.547190] Subtest hwconfig_table: SUCCESS (0.001s)
[405.589371] [121/133] (616s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[405.730016] Starting subtest: yf-tiled-16bpp-rotate-270
[405.734875] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[405.887350] [122/133] (615s left) gem_cs_tlb (engines)
[405.952222] Starting subtest: engines
[405.954095] Starting dynamic subtest: rcs0
[408.108682] Dynamic subtest rcs0: SUCCESS (2.152s)
[408.120144] Starting dynamic subtest: bcs0
[410.260396] Dynamic subtest bcs0: SUCCESS (2.151s)
[410.268786] Starting dynamic subtest: vcs0
[412.413836] Dynamic subtest vcs0: SUCCESS (2.151s)
[412.422619] Starting dynamic subtest: vcs1
[414.566862] Dynamic subtest vcs1: SUCCESS (2.152s)
[414.578337] Starting dynamic subtest: vecs0
[416.718655] Dynamic subtest vecs0: SUCCESS (2.151s)
[416.729732] Starting dynamic subtest: ccs0
[418.872567] Dynamic subtest ccs0: SUCCESS (2.153s)
[418.874949] Subtest engines: SUCCESS (12.916s)
[419.044128] [123/133] (602s left) syncobj_wait (wait-zero-handles)
[419.106388] Starting subtest: wait-zero-handles
[419.108594] Subtest wait-zero-handles: SUCCESS (0.000s)
[419.247784] [124/133] (602s left) gem_wait (await)
[419.299709] Starting subtest: await
[419.302083] Starting dynamic subtest: all-engines
[420.462866] Dynamic subtest all-engines: SUCCESS (1.162s)
[420.475062] Starting dynamic subtest: rcs0
[421.532255] Dynamic subtest rcs0: SUCCESS (1.067s)
[421.547675] Starting dynamic subtest: bcs0
[422.596210] Dynamic subtest bcs0: SUCCESS (1.062s)
[422.612849] Starting dynamic subtest: vcs0
[423.653653] Dynamic subtest vcs0: SUCCESS (1.055s)
[423.670163] Starting dynamic subtest: vcs1
[424.709769] Dynamic subtest vcs1: SUCCESS (1.054s)
[424.726035] Starting dynamic subtest: vecs0
[425.762331] Dynamic subtest vecs0: SUCCESS (1.050s)
[425.778232] Starting dynamic subtest: ccs0
[426.819170] Dynamic subtest ccs0: SUCCESS (1.055s)
[426.821689] Subtest await: SUCCESS (7.520s)
[427.040257] [125/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[427.150914] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[450.688275] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.540s)
[450.836202] [126/133] (571s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[450.958676] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[450.962454] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[451.074982] [127/133] (570s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[451.172060] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[451.175331] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[451.291490] [128/133] (570s left) i915_module_load (resize-bar)
[451.328248] Starting subtest: resize-bar
[451.333818] Subtest resize-bar: SKIP (0.006s)
[451.380640] [129/133] (570s left) sw_sync (alloc_fence_invalid_timeline)
[451.413871] Starting subtest: alloc_fence_invalid_timeline
[451.415645] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[451.494993] [130/133] (570s left) gem_eio (hibernate)
[451.720020] Starting subtest: hibernate
[466.500360] Subtest hibernate: SUCCESS (14.779s)
[473.734512] [131/133] (555s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[473.886270] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[478.367967] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.484s)
[479.520295] [132/133] (549s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[479.636863] Starting subtest: psr-rgb565-draw-mmap-gtt
[479.640826] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[479.778319] [133/133] (549s left) gem_ctx_persistence (legacy-engines-cleanup)
[479.856380] Starting subtest: legacy-engines-cleanup
[479.858928] Starting dynamic subtest: render
[479.996322] Dynamic subtest render: SUCCESS (0.139s)
[480.009734] Starting dynamic subtest: bsd1
[480.054596] Dynamic subtest bsd1: SUCCESS (0.056s)
[480.068926] Starting dynamic subtest: bsd2
[480.119510] Dynamic subtest bsd2: SUCCESS (0.062s)
[480.135414] Starting dynamic subtest: blt
[480.175834] Dynamic subtest blt: SUCCESS (0.053s)
[480.187638] Starting dynamic subtest: vebox
[480.236779] Dynamic subtest vebox: SUCCESS (0.058s)
[480.239287] Subtest legacy-engines-cleanup: SUCCESS (0.382s)
[480.340196] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: gem_partial_pwrite_pread
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_dirtyfb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: gem_exec_async
results: parsing output: 17/ for test: gem_lmem_swapping
results: parsing output: 18/ for test: kms_chamelium_audio
results: parsing output: 19/ for test: kms_selftest
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: i915_drm_fdinfo
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: syncobj_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_color
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: gem_ccs
results: parsing output: 49/ for test: kms_cursor_edge_walk
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 52/ for test: gen7_exec_parse
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_plane_alpha_blend
results: parsing output: 62/ for test: kms_plane_multiple
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: gem_exec_gttfill
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_vblank
results: parsing output: 75/ for test: i915_pm_freq_mult
results: parsing output: 76/ for test: gem_softpin
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_whisper
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_atomic
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_workarounds
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_tiled_pread_pwrite
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_invalid_mode
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_chamelium_hpd
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: gem_readwrite
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_feature_discovery
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_rmfb
results: parsing output: 115/ for test: dumb_buffer
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_cs_tlb
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_wait
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: i915_module_load
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_ctx_persistence
Done.