[55.428564] Initializing watchdogs
[55.428611]   /dev/watchdog0
[55.442619] [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]
[55.446977] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.449044] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.450886] [001/131] (960s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[55.580927] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[55.582578] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[55.705960] [002/131] (960s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[55.786709] Starting subtest: compare-crc-sanitycheck-nv12
[55.787718] Starting dynamic subtest: pipe-A-eDP-1
[56.465828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[56.471051] Starting dynamic subtest: pipe-B-eDP-1
[57.748378] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[57.754088] Starting dynamic subtest: pipe-C-eDP-1
[58.945336] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.198s)
[58.950898] Starting dynamic subtest: pipe-D-eDP-1
[60.153024] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[60.154044] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.373s)
[60.993709] [003/131] (955s left) kms_joiner (invalid-modeset-big-joiner)
[61.080786] Starting subtest: invalid-modeset-big-joiner
[61.082473] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[61.138371] [004/131] (954s left) gem_ctx_exec (basic-nohangcheck)
[61.180791] Starting subtest: basic-nohangcheck
[61.444873] Subtest basic-nohangcheck: SUCCESS (0.264s)
[61.575034] [005/131] (954s left) gem_exec_reloc (basic-write-cpu)
[61.633924] Subtest basic-write-cpu: SKIP (0.000s)
[61.696341] [006/131] (954s left) kms_dp_link_training (non-uhbr-sst)
[61.789735] Starting subtest: non-uhbr-sst
[61.793834] Subtest non-uhbr-sst: SKIP (0.000s)
[61.851302] [007/131] (954s left) kms_flip (2x-flip-vs-panning)
[61.931522] Starting subtest: 2x-flip-vs-panning
[61.942599] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[62.008927] [008/131] (954s left) gem_barrier_race (remote-request)
[62.067629] Starting subtest: remote-request
[62.068560] Starting dynamic subtest: rcs0
[67.228706] Dynamic subtest rcs0: SUCCESS (5.166s)
[67.229677] Subtest remote-request: SUCCESS (5.166s)
[67.359835] [009/131] (948s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[67.414724] Starting subtest: map-fixed-invalidate-overlap-busy
[67.417079] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[67.542310] [010/131] (948s left) kms_flip (2x-blocking-wf_vblank)
[67.639512] Starting subtest: 2x-blocking-wf_vblank
[67.650868] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[67.722774] [011/131] (948s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[67.805705] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[67.806800] Starting dynamic subtest: pipe-A-eDP-1
[101.619983] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.735s)
[101.627923] Starting dynamic subtest: pipe-B-eDP-1
[136.521208] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.345s)
[136.527672] Starting dynamic subtest: pipe-C-eDP-1
[171.492570] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.261s)
[171.499530] Starting dynamic subtest: pipe-D-eDP-1
[206.474565] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.163s)
[206.475538] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.507s)
[213.695761] [012/131] (808s left) gem_ppgtt (blt-vs-render-ctxn)
[213.751332] Starting subtest: blt-vs-render-ctxN
[246.670892] Subtest blt-vs-render-ctxN: SUCCESS (32.958s)
[246.813866] [013/131] (775s left) kms_vrr (flip-suspend)
[246.939745] Starting subtest: flip-suspend
[246.942695] Subtest flip-suspend: SKIP (0.000s)
[247.002323] [014/131] (775s left) kms_psr (fbc-psr-primary-render)
[247.102252] Starting subtest: fbc-psr-primary-render
[247.103268] Starting dynamic subtest: eDP-1
[247.105164] Dynamic subtest eDP-1: SKIP (0.000s)
[247.106957] Subtest fbc-psr-primary-render: SKIP (0.000s)
[247.164751] [015/131] (775s left) syncobj_wait (multi-wait-submitted)
[247.210509] Starting subtest: multi-wait-submitted
[247.318003] Subtest multi-wait-submitted: SUCCESS (0.105s)
[247.381244] [016/131] (775s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[252.405243] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[252.407208] Starting dynamic subtest: pipe-A-eDP-1
[253.185811] Dynamic subtest pipe-A-eDP-1: SKIP (0.778s)
[253.193118] Starting dynamic subtest: pipe-B-eDP-1
[254.409079] Dynamic subtest pipe-B-eDP-1: SKIP (1.221s)
[254.410999] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.003s)
[255.582081] [017/131] (766s left) kms_chamelium_audio (hdmi-audio-edid)
[255.952141] Subtest hdmi-audio-edid: SKIP (0.000s)
[256.785938] [018/131] (765s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[256.876907] Starting subtest: fbc-pr-sprite-mmap-gtt
[256.878878] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[256.938921] [019/131] (765s left) kms_joiner (invalid-modeset-ultra-joiner)
[257.027412] Starting subtest: invalid-modeset-ultra-joiner
[257.029205] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[257.090626] [020/131] (765s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[257.190458] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[257.192376] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[257.271559] [021/131] (765s left) gem_mmap_wc (bad-offset)
[257.314091] Subtest bad-offset: SKIP (0.000s)
[257.372134] [022/131] (765s left) gem_userptr_blits (sync-unmap-after-close)
[257.436785] Starting subtest: sync-unmap-after-close
[257.448956] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[257.580231] [023/131] (765s left) syncobj_wait (wait-all-for-submit-complex)
[257.633689] Starting subtest: wait-all-for-submit-complex
[257.848762] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[257.912163] [024/131] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[258.008021] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[264.410947] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.405s)
[264.538494] [025/131] (758s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[264.648825] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[264.650523] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[264.738463] [026/131] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[264.820761] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[264.822526] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[264.912816] [027/131] (757s left) kms_flip (basic-flip-vs-modeset)
[265.001460] Starting subtest: basic-flip-vs-modeset
[265.003679] Starting dynamic subtest: A-eDP1
[267.599524] Dynamic subtest A-eDP1: SUCCESS (2.595s)
[267.606470] Starting dynamic subtest: B-eDP1
[269.737721] Dynamic subtest B-eDP1: SUCCESS (2.137s)
[269.748773] Starting dynamic subtest: C-eDP1
[271.904310] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[271.913184] Starting dynamic subtest: D-eDP1
[274.055081] Dynamic subtest D-eDP1: SUCCESS (2.152s)
[274.058263] Subtest basic-flip-vs-modeset: SUCCESS (9.056s)
[274.838791] [028/131] (747s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[274.935472] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[274.937180] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[275.031973] [029/131] (747s left) gem_exec_schedule (u-fairslice-all)
[275.090566] Starting subtest: u-fairslice-all
[277.150503] Subtest u-fairslice-all: SUCCESS (2.060s)
[279.153216] [030/131] (743s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[279.260678] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[285.878866] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.620s)
[286.017059] [031/131] (736s left) gem_mmap (basic-small-bo)
[286.073386] Subtest basic-small-bo: SKIP (0.000s)
[286.131454] [032/131] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[286.217879] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[286.219770] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[286.314995] [033/131] (736s left) gem_exec_fence (syncobj-channel)
[286.792569] Starting subtest: syncobj-channel
[287.813949] Subtest syncobj-channel: SUCCESS (1.018s)
[288.161913] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[288.163772] [034/131] (734s left) gem_pxp (fail-invalid-protected-context)
[288.267214] Starting subtest: fail-invalid-protected-context
[288.268424] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[288.365963] [035/131] (734s left) syncobj_wait (invalid-wait-illegal-handle)
[288.413088] Starting subtest: invalid-wait-illegal-handle
[288.414142] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[288.520541] [036/131] (734s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[290.276101] Starting subtest: dpms-mode-unset-lpsp
[294.348417] Subtest dpms-mode-unset-lpsp: SUCCESS (4.075s)
[294.715550] [037/131] (728s left) gem_ctx_persistence (heartbeat-stop)
[294.772051] Starting subtest: heartbeat-stop
[294.774088] Subtest heartbeat-stop: SKIP (0.000s)
[294.868582] [038/131] (728s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[294.965847] Starting subtest: 4-tiled-64bpp-rotate-270
[294.985792] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[295.093791] [039/131] (727s left) kms_selftest (drm_format_helper)
[295.124608] Starting subtest: drm_format_helper
[295.130558] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[295.244195] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.113s)
[295.251200] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[295.359975] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.115s)
[295.367931] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[295.470848] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.111s)
[295.478084] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[295.594849] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.121s)
[295.601755] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[295.744936] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.148s)
[295.751905] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[295.865847] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.120s)
[295.872643] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[295.949244] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.083s)
[295.961674] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[296.034473] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.084s)
[296.046064] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[296.111598] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.076s)
[296.119502] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[296.217418] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.105s)
[296.225297] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[296.339593] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.121s)
[296.347094] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[296.446106] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.107s)
[296.454076] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[296.574975] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.129s)
[296.582092] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[296.687855] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.112s)
[296.694643] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[296.812020] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.123s)
[296.821135] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[296.955129] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.141s)
[296.966999] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[297.091533] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.138s)
[297.092478] Subtest drm_format_helper: SUCCESS (1.968s)
[297.261474] [040/131] (725s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[297.318589] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[297.319543] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[297.417668] [041/131] (725s left) gem_exec_balancer (parallel-keep-in-fence)
[297.678685] Starting subtest: parallel-keep-in-fence
[298.762570] Subtest parallel-keep-in-fence: SUCCESS (1.083s)
[298.889396] [042/131] (724s left) prime_vgem (busy)
[298.970428] Starting subtest: busy
[298.971536] Starting dynamic subtest: rcs0
[299.017161] Dynamic subtest rcs0: SUCCESS (0.046s)
[299.024436] Starting dynamic subtest: bcs0
[299.104492] Dynamic subtest bcs0: SUCCESS (0.087s)
[299.111592] Starting dynamic subtest: vcs0
[299.153287] Dynamic subtest vcs0: SUCCESS (0.048s)
[299.161093] Starting dynamic subtest: vcs1
[299.200157] Dynamic subtest vcs1: SUCCESS (0.046s)
[299.207216] Starting dynamic subtest: vecs0
[299.246107] Dynamic subtest vecs0: SUCCESS (0.045s)
[299.253206] Starting dynamic subtest: ccs0
[299.298259] Dynamic subtest ccs0: SUCCESS (0.051s)
[299.299104] Subtest busy: SUCCESS (0.328s)
[299.438884] [043/131] (723s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[299.536696] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[299.537602] Starting dynamic subtest: pipe-A-eDP-1
[299.546856] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.554195] Starting dynamic subtest: pipe-B-eDP-1
[299.563103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.570401] Starting dynamic subtest: pipe-C-eDP-1
[299.578556] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.585551] Starting dynamic subtest: pipe-D-eDP-1
[299.594434] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.596094] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[301.642852] [044/131] (721s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[301.745338] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[301.747136] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[301.854816] [045/131] (721s left) api_intel_bb (object-reloc-purge-cache)
[301.902934] Starting subtest: object-reloc-purge-cache
[301.907063] Subtest object-reloc-purge-cache: SKIP (0.005s)
[302.021420] [046/131] (721s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[302.067902] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[302.069868] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[302.240320] [047/131] (721s left) kms_cursor_crc (cursor-random-64x64)
[302.419645] Starting subtest: cursor-random-64x64
[302.423300] Starting dynamic subtest: pipe-A-eDP-1
[306.318078] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.895s)
[306.350669] Starting dynamic subtest: pipe-D-eDP-1
[310.907253] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.562s)
[310.908439] Subtest cursor-random-64x64: SUCCESS (8.487s)
[311.700822] [048/131] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[311.802917] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[311.804689] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[311.899333] [049/131] (711s left) gen9_exec_parse (unaligned-jump)
[311.945955] Subtest unaligned-jump: SKIP (0.000s)
[312.014070] [050/131] (711s left) syncobj_timeline (device-signal-unordered)
[312.076231] Starting subtest: device-signal-unordered
[312.077423] Subtest device-signal-unordered: SUCCESS (0.001s)
[312.185510] [051/131] (711s left) gem_exec_params (sol-reset-not-gen7)
[312.241154] Starting subtest: sol-reset-not-gen7
[312.244089] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[312.381959] [052/131] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[312.476782] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[312.478676] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[312.585954] [053/131] (710s left) gem_exec_balancer (busy)
[312.643622] Starting subtest: busy
[314.048503] Subtest busy: SUCCESS (1.402s)
[314.373774] [054/131] (709s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-render)
[314.483043] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-render
[321.360414] Subtest fbcpsr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.873s)
[321.510252] [055/131] (702s left) syncobj_timeline (single-wait-available-signaled)
[321.557181] Starting subtest: single-wait-available-signaled
[321.558042] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[321.661433] [056/131] (701s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[321.750488] Starting subtest: fbc-2p-pri-indfb-multidraw
[321.752336] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[321.852706] [057/131] (701s left) syncobj_timeline (invalid-signal-zero-handles)
[321.901610] Starting subtest: invalid-signal-zero-handles
[321.902796] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[322.005104] [058/131] (701s left) gem_mmap_gtt (basic-read)
[322.054768] Subtest basic-read: SKIP (0.000s)
[322.116994] [059/131] (701s left) i915_pm_sseu (full-enable)
[322.168513] Subtest full-enable: SKIP (0.000s)
[322.282520] [060/131] (701s left) perf (blocking-parameterized)
[322.364179] Starting subtest: blocking-parameterized
[342.399269] Subtest blocking-parameterized: SUCCESS (20.030s)
[342.440679] [061/131] (681s left) kms_async_flips (alternate-sync-async-flip)
[342.538587] Starting subtest: alternate-sync-async-flip
[342.910565] Starting dynamic subtest: pipe-A-eDP-1
[343.935587] Dynamic subtest pipe-A-eDP-1: FAIL (0.850s)
[344.118965] Starting dynamic subtest: pipe-B-eDP-1
[346.901000] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s)
[347.276666] Starting dynamic subtest: pipe-C-eDP-1
[350.029777] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[350.391466] Starting dynamic subtest: pipe-D-eDP-1
[353.156845] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[353.158438] Subtest alternate-sync-async-flip: FAIL (10.620s)
[354.306472] [062/131] (669s left) i915_module_load (reload-no-display)
[354.337993] Starting subtest: reload-no-display
[360.307067] Subtest reload-no-display: SUCCESS (5.969s)
[360.326639] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[360.327344] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[360.329116] [063/131] (663s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[361.748044] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[361.749143] Starting dynamic subtest: pipe-A
[362.099493] Dynamic subtest pipe-A: SUCCESS (0.351s)
[362.107869] Starting dynamic subtest: pipe-B
[363.541882] Dynamic subtest pipe-B: SUCCESS (1.441s)
[363.549114] Starting dynamic subtest: pipe-C
[364.983857] Dynamic subtest pipe-C: SUCCESS (1.441s)
[364.992836] Starting dynamic subtest: pipe-D
[366.401882] Dynamic subtest pipe-D: SUCCESS (1.418s)
[366.402948] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.655s)
[367.561376] [FACT kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[367.563265] [FACT kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)] new: kernel.kmod_is_loaded.i915: true
[367.565674] [064/131] (656s left) kms_cursor_crc (cursor-offscreen-512x512)
[367.827241] Starting subtest: cursor-offscreen-512x512
[367.830342] Subtest cursor-offscreen-512x512: SKIP (0.002s)
[368.000992] [065/131] (655s left) perf (oa-formats)
[368.111194] Starting subtest: oa-formats
[368.112122] Starting dynamic subtest: 0-rcs0
[368.131131] Dynamic subtest 0-rcs0: SUCCESS (0.021s)
[368.140570] Starting dynamic subtest: 1-vecs0
[368.164888] Dynamic subtest 1-vecs0: SUCCESS (0.033s)
[368.166152] Subtest oa-formats: SUCCESS (0.055s)
[368.206308] [066/131] (655s left) kms_cursor_crc (cursor-size-change)
[368.294484] Starting subtest: cursor-size-change
[368.295478] Starting dynamic subtest: pipe-A-eDP-1
[369.127826] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[369.136753] Starting dynamic subtest: pipe-D-eDP-1
[370.672944] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[370.674068] Subtest cursor-size-change: SUCCESS (2.380s)
[371.523478] [067/131] (652s left) kms_hdr (brightness-with-hdr)
[371.616894] Starting subtest: brightness-with-hdr
[371.619840] Subtest brightness-with-hdr: SKIP (0.000s)
[371.682575] [068/131] (652s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[371.786356] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[372.875119] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.089s)
[373.089534] [069/131] (650s left) syncobj_wait (wait-all-for-submit-snapshot)
[373.135173] Starting subtest: wait-all-for-submit-snapshot
[373.218376] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[373.289176] [070/131] (650s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[373.379340] Starting subtest: x-tiled-16bpp-rotate-0
[374.824831] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.446s)
[374.964360] [071/131] (649s left) gem_userptr_blits (huge-split)
[375.033147] Starting subtest: huge-split
[375.040402] Subtest huge-split: SUCCESS (0.007s)
[375.162147] [072/131] (648s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[375.539568] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[376.321829] [073/131] (647s left) gem_exec_fence (syncobj-repeat)
[376.742340] Starting subtest: syncobj-repeat
[376.919454] Subtest syncobj-repeat: SUCCESS (0.175s)
[378.159402] [074/131] (646s left) api_intel_allocator (simple-allocator)
[378.204532] Starting subtest: simple-allocator
[378.205511] Starting dynamic subtest: basic
[378.209628] Dynamic subtest basic: SUCCESS (0.005s)
[378.216629] Starting dynamic subtest: parallel-one
[378.373719] Dynamic subtest parallel-one: SUCCESS (0.162s)
[378.380791] Starting dynamic subtest: print
[378.381627] Dynamic subtest print: SUCCESS (0.000s)
[378.388128] Starting dynamic subtest: reuse
[378.389061] Dynamic subtest reuse: SUCCESS (0.000s)
[378.395605] Starting dynamic subtest: reserve
[378.396433] Dynamic subtest reserve: SUCCESS (0.000s)
[378.402791] Starting dynamic subtest: fork-reopen-allocator
[378.403643] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[378.404519] Subtest simple-allocator: SUCCESS (0.183s)
[378.511364] [075/131] (645s left) gem_ctx_persistence (legacy-engines-queued)
[378.567008] Starting subtest: legacy-engines-queued
[378.568168] Starting dynamic subtest: render
[378.641301] Dynamic subtest render: SUCCESS (0.074s)
[378.653233] Starting dynamic subtest: bsd1
[380.018397] Dynamic subtest bsd1: SUCCESS (1.371s)
[380.028426] Starting dynamic subtest: bsd2
[382.063991] Dynamic subtest bsd2: SUCCESS (2.043s)
[382.074679] Starting dynamic subtest: blt
[382.134310] Dynamic subtest blt: SUCCESS (0.070s)
[382.144217] Starting dynamic subtest: vebox
[384.048787] Dynamic subtest vebox: SUCCESS (1.909s)
[384.050334] Subtest legacy-engines-queued: SUCCESS (5.481s)
[384.117746] [076/131] (640s left) kms_properties (get_properties-sanity-atomic)
[384.201843] Starting subtest: get_properties-sanity-atomic
[384.204166] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[384.272818] [077/131] (640s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[384.320909] Starting subtest: y-tiled-to-vebox-yf-tiled
[384.322938] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[384.495220] [078/131] (639s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[384.549099] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[384.616084] [079/131] (639s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[384.696910] Starting subtest: primary-y-tiled-reflect-x-180
[384.757818] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[384.841667] [080/131] (639s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[384.928087] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[384.929041] Starting dynamic subtest: pipe-A-eDP-1
[384.950134] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[384.957176] Starting dynamic subtest: pipe-B-eDP-1
[384.978463] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[384.985284] Starting dynamic subtest: pipe-C-eDP-1
[385.006012] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[385.013227] Starting dynamic subtest: pipe-D-eDP-1
[385.034685] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[385.036430] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[387.091011] [081/131] (637s left) kms_chamelium_edid (dp-edid-resolution-list)
[387.467538] Subtest dp-edid-resolution-list: SKIP (0.000s)
[388.296224] [082/131] (636s left) perf_pmu (faulting-read)
[388.331659] Starting subtest: faulting-read
[388.332802] Starting dynamic subtest: wb
[388.333853] Dynamic subtest wb: SUCCESS (0.001s)
[388.341184] Starting dynamic subtest: wc
[388.342087] Dynamic subtest wc: SUCCESS (0.000s)
[388.348914] Starting dynamic subtest: uc
[388.349882] Dynamic subtest uc: SUCCESS (0.000s)
[388.350893] Subtest faulting-read: SUCCESS (0.003s)
[388.430497] [083/131] (636s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[388.517757] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[388.622751] [084/131] (635s left) perf (missing-sample-flags)
[388.704897] Starting subtest: missing-sample-flags
[388.706069] Subtest missing-sample-flags: SUCCESS (0.000s)
[388.741452] [085/131] (635s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[393.784922] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[393.787789] Starting dynamic subtest: pipe-A-eDP-1
[394.565916] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s)
[394.578006] Starting dynamic subtest: pipe-B-eDP-1
[395.684129] Dynamic subtest pipe-B-eDP-1: SKIP (1.118s)
[395.686123] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.899s)
[396.855472] [086/131] (627s left) gem_exec_whisper (basic-fds-forked)
[396.924109] Starting subtest: basic-fds-forked
[420.548790] Subtest basic-fds-forked: SUCCESS (23.625s)
[420.721817] [087/131] (603s left) core_auth (many-magics)
[420.776727] Starting subtest: many-magics
[421.569179] Subtest many-magics: SUCCESS (0.792s)
[421.773399] [088/131] (602s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[421.826543] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[421.887098] [089/131] (602s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[421.935659] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[422.036878] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[422.105967] [090/131] (602s left) kms_addfb_basic (invalid-set-prop)
[422.158063] Starting subtest: invalid-set-prop
[422.159173] Subtest invalid-set-prop: SUCCESS (0.000s)
[422.294825] [091/131] (602s left) gen9_exec_parse (batch-invalid-length)
[422.352862] Subtest batch-invalid-length: SKIP (0.000s)
[422.413542] [092/131] (602s left) gem_eio (throttle)
[422.630462] Starting subtest: throttle
[422.944147] Subtest throttle: SUCCESS (0.313s)
[423.088915] [093/131] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[423.178245] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[423.179910] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.288771] [094/131] (601s left) gem_exec_reloc (basic-wc-active)
[423.349753] Subtest basic-wc-active: SKIP (0.000s)
[423.440906] [095/131] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[423.537815] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[423.539518] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.637586] [096/131] (601s left) kms_chamelium_hpd (hdmi-hpd-fast)
[424.009211] Subtest hdmi-hpd-fast: SKIP (0.000s)
[424.847549] [097/131] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[424.942569] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[424.944277] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[425.035885] [098/131] (599s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[425.086395] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[425.143540] [099/131] (599s left) gem_exec_schedule (promotion)
[425.201402] Starting subtest: promotion
[425.202626] Starting dynamic subtest: rcs0
[425.310549] Dynamic subtest rcs0: SUCCESS (0.108s)
[425.321251] Starting dynamic subtest: vcs0
[425.393493] Dynamic subtest vcs0: SUCCESS (0.083s)
[425.403820] Starting dynamic subtest: vcs1
[425.477983] Dynamic subtest vcs1: SUCCESS (0.084s)
[425.488347] Starting dynamic subtest: vecs0
[425.563255] Dynamic subtest vecs0: SUCCESS (0.085s)
[425.573749] Starting dynamic subtest: ccs0
[425.659738] Dynamic subtest ccs0: SUCCESS (0.095s)
[425.661075] Subtest promotion: SUCCESS (0.458s)
[427.189289] [100/131] (597s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[427.278070] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[427.279119] Starting dynamic subtest: pipe-A-default-mode
[428.425595] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[428.427669] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.146s)
[428.584629] [101/131] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[428.686827] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[435.276965] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.593s)
[435.413291] [102/131] (589s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[435.460856] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[435.461792] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[435.577377] [103/131] (589s left) gem_userptr_blits (create-destroy-sync)
[435.638966] Starting subtest: create-destroy-sync
[440.646597] Subtest create-destroy-sync: SUCCESS (5.006s)
[440.786667] [104/131] (584s left) kms_busy (basic-hang)
[440.879820] Starting subtest: basic-hang
[440.882532] Starting dynamic subtest: flip-pipe-A
[441.517177] Dynamic subtest flip-pipe-A: SUCCESS (0.636s)
[441.525538] Starting dynamic subtest: modeset-pipe-A
[444.923797] Dynamic subtest modeset-pipe-A: SUCCESS (3.404s)
[444.933771] Starting dynamic subtest: flip-pipe-D
[446.115964] Dynamic subtest flip-pipe-D: SUCCESS (1.189s)
[446.124064] Starting dynamic subtest: modeset-pipe-D
[449.528316] Dynamic subtest modeset-pipe-D: SUCCESS (3.411s)
[449.529421] Subtest basic-hang: SUCCESS (8.645s)
[450.313321] [105/131] (574s left) i915_drm_fdinfo (most-busy-idle-check-all)
[450.349940] Starting subtest: most-busy-idle-check-all
[450.350956] Starting dynamic subtest: rcs0
[450.355646] Dynamic subtest rcs0: SKIP (0.005s)
[450.365268] Starting dynamic subtest: bcs0
[450.366899] Dynamic subtest bcs0: SKIP (0.000s)
[450.374644] Starting dynamic subtest: vcs0
[450.376458] Dynamic subtest vcs0: SKIP (0.000s)
[450.384405] Starting dynamic subtest: vcs1
[450.386142] Dynamic subtest vcs1: SKIP (0.000s)
[450.393697] Starting dynamic subtest: vecs0
[450.395532] Dynamic subtest vecs0: SKIP (0.000s)
[450.403126] Starting dynamic subtest: ccs0
[450.404914] Dynamic subtest ccs0: SKIP (0.000s)
[450.406759] Subtest most-busy-idle-check-all: SKIP (0.010s)
[450.434243] [106/131] (574s left) gem_mmap_gtt (medium-copy-odd)
[450.505628] Subtest medium-copy-odd: SKIP (0.000s)
[450.562471] [107/131] (574s left) prime_mmap (test_forked_cpu_write)
[450.610245] Starting subtest: test_forked_cpu_write
[450.611348] Starting dynamic subtest: test_forked_cpu_write-smem
[450.617438] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[450.618462] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[450.735014] [108/131] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[450.824513] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[450.826376] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[450.917528] [109/131] (574s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[451.014875] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[451.016745] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[451.126296] [110/131] (574s left) gem_ccs (suspend-resume)
[451.176916] Starting subtest: suspend-resume
[451.178864] Subtest suspend-resume: SKIP (0.000s)
[451.289257] [111/131] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[451.389432] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[451.391157] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[451.472017] [112/131] (573s left) gem_lmem_swapping (verify-random)
[451.505635] Subtest verify-random: SKIP (0.000s)
[451.543071] [113/131] (573s left) kms_content_protection (lic-type-0)
[451.709329] Starting subtest: lic-type-0
[454.954671] Subtest lic-type-0: SKIP (3.244s)
[456.123313] [114/131] (569s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[456.222080] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[456.223177] Starting dynamic subtest: pipe-A-eDP-1
[456.232755] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.241319] Starting dynamic subtest: pipe-B-eDP-1
[456.250853] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.258871] Starting dynamic subtest: pipe-C-eDP-1
[456.267635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.275582] Starting dynamic subtest: pipe-D-eDP-1
[456.289057] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.290762] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[458.367316] [115/131] (567s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[458.453837] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[458.454768] Starting dynamic subtest: pipe-A
[459.504539] Dynamic subtest pipe-A: SUCCESS (1.050s)
[459.512631] Starting dynamic subtest: pipe-B
[461.575146] Dynamic subtest pipe-B: SUCCESS (2.069s)
[461.583341] Starting dynamic subtest: pipe-C
[462.762928] Dynamic subtest pipe-C: SUCCESS (1.187s)
[462.772096] Starting dynamic subtest: pipe-D
[463.897168] Dynamic subtest pipe-D: SUCCESS (1.133s)
[463.898130] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.442s)
[465.085701] [116/131] (560s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[465.203993] Starting subtest: cursorB-vs-flipB-varying-size
[465.206009] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[465.295754] [117/131] (560s left) gem_tiled_wb
[465.411369] [118/131] (560s left) kms_psr (pr-primary-page-flip)
[465.497982] Starting subtest: pr-primary-page-flip
[465.499998] Subtest pr-primary-page-flip: SKIP (0.000s)
[465.563445] [119/131] (560s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[465.664595] Starting subtest: fbcpsr-suspend
[506.704028] Subtest fbcpsr-suspend: SUCCESS (10.488s)
[511.853057] [120/131] (518s left) gem_exec_schedule (in-order)
[511.915714] Starting subtest: in-order
[511.916714] Starting dynamic subtest: rcs0
[512.086788] Dynamic subtest rcs0: SUCCESS (0.171s)
[512.095780] Starting dynamic subtest: vcs0
[512.200241] Dynamic subtest vcs0: SUCCESS (0.113s)
[512.211744] Starting dynamic subtest: vcs1
[512.310869] Dynamic subtest vcs1: SUCCESS (0.111s)
[512.321687] Starting dynamic subtest: vecs0
[512.419601] Dynamic subtest vecs0: SUCCESS (0.109s)
[512.430702] Starting dynamic subtest: ccs0
[512.544846] Dynamic subtest ccs0: SUCCESS (0.125s)
[512.546460] Subtest in-order: SUCCESS (0.631s)
[513.735195] [121/131] (516s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[513.826019] Starting subtest: fbc-psr2-sprite-mmap-cpu
[513.826901] Starting dynamic subtest: eDP-1
[513.828520] Dynamic subtest eDP-1: SKIP (0.000s)
[513.830075] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[513.901019] [122/131] (516s left) gem_sync (basic-store-each)
[513.959093] Starting subtest: basic-store-each
[516.226936] Subtest basic-store-each: SUCCESS (2.277s)
[516.406097] [123/131] (514s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[516.513367] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[517.534915] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.025s)
[517.694068] [124/131] (513s left) kms_plane_multiple (tiling-4)
[517.783316] Starting subtest: tiling-4
[517.784761] Starting dynamic subtest: pipe-A-eDP-1
[521.484955] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.707s)
[521.493651] Starting dynamic subtest: pipe-B-eDP-1
[525.788770] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.309s)
[525.802688] Starting dynamic subtest: pipe-C-eDP-1
[530.083726] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.296s)
[530.092375] Starting dynamic subtest: pipe-D-eDP-1
[534.349902] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.270s)
[534.351080] Subtest tiling-4: SUCCESS (16.587s)
[535.166659] [125/131] (495s left) syncobj_timeline (wait-delayed-signal)
[535.217957] Starting subtest: wait-delayed-signal
[535.322576] Subtest wait-delayed-signal: SUCCESS (0.102s)
[535.391947] [126/131] (495s left) kms_vblank (query-busy)
[535.475981] Starting subtest: query-busy
[535.477139] Starting dynamic subtest: pipe-A-eDP-1
[537.371659] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[537.382387] Starting dynamic subtest: pipe-D-eDP-1
[539.919470] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[539.920458] Subtest query-busy: SUCCESS (4.445s)
[540.719312] [127/131] (490s left) kms_prop_blob (blob-prop-validate)
[540.770939] Starting subtest: blob-prop-validate
[540.771812] Subtest blob-prop-validate: SUCCESS (0.000s)
[540.873559] [128/131] (490s left) gem_eio (hibernate)
[541.100147] Starting subtest: hibernate
[555.458628] Subtest hibernate: SUCCESS (14.366s)
[562.617004] [129/131] (475s left) kms_feature_discovery (psr1)
[562.708659] Starting subtest: psr1
[562.709752] Subtest psr1: SUCCESS (0.000s)
[562.773463] [130/131] (475s left) kms_psr (psr-cursor-blt)
[562.859111] Starting subtest: psr-cursor-blt
[562.860273] Starting dynamic subtest: eDP-1
[564.566651] Dynamic subtest eDP-1: SUCCESS (1.705s)
[564.567800] Subtest psr-cursor-blt: SUCCESS (1.706s)
[565.418987] [131/131] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[565.514914] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[565.516869] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[565.603998] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_pipe_crc_basic
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: gem_ctx_exec
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_dp_link_training
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_barrier_race
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_ppgtt
results: parsing output: 12/ for test: kms_vrr
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_chamelium_audio
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_joiner
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_mmap
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_selftest
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gen9_exec_parse
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: i915_pm_sseu
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: i915_module_load
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_hdr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: gem_exec_fence
results: parsing output: 73/ for test: api_intel_allocator
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_properties
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_chamelium_edid
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: core_auth
results: parsing output: 87/ for test: kms_pipe_b_c_ivb
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: gem_eio
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: prime_mmap
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_tiled_wb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: gem_sync
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_plane_multiple
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_prop_blob
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_feature_discovery
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.