[64.803724] Initializing watchdogs
[64.803788]   /dev/watchdog0
[64.818767] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[64.824365] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.826738] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.829015] [001/133] (960s left) gem_create (busy-create)
[64.868227] Starting subtest: busy-create
[64.868964] Starting dynamic subtest: smem0
[97.121627] Dynamic subtest smem0: SUCCESS (32.259s)
[97.122818] Subtest busy-create: SUCCESS (32.260s)
[97.306648] [002/133] (928s left) kms_vrr (seamless-rr-switch-vrr)
[97.394539] Starting subtest: seamless-rr-switch-vrr
[97.396642] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[97.450715] [003/133] (927s left) kms_fb_coherency (memset-crc)
[97.536388] Starting subtest: memset-crc
[97.537137] Starting dynamic subtest: mmap-gtt
[97.812485] Dynamic subtest mmap-gtt: SUCCESS (0.276s)
[97.885841] Starting dynamic subtest: mmap-offset-wc
[98.111486] Dynamic subtest mmap-offset-wc: SUCCESS (0.230s)
[98.183675] Starting dynamic subtest: mmap-offset-uc
[98.756742] Dynamic subtest mmap-offset-uc: SUCCESS (0.578s)
[98.819303] Starting dynamic subtest: mmap-legacy-wc
[99.016447] Dynamic subtest mmap-legacy-wc: SUCCESS (0.201s)
[99.083875] Subtest memset-crc: SUCCESS (1.548s)
[99.206252] [004/133] (926s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[99.296393] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[99.297157] Starting dynamic subtest: pipe-A-valid-mode
[100.314080] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.017s)
[100.314880] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.018s)
[100.437810] [005/133] (925s left) gem_render_copy (yf-tiled-to-vebox-linear)
[100.481159] Starting subtest: yf-tiled-to-vebox-linear
[100.481865] Starting dynamic subtest: smem
[100.544610] Dynamic subtest smem: SUCCESS (0.063s)
[100.545330] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.064s)
[100.739954] [006/133] (924s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[100.773262] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[100.881511] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[100.947393] [007/133] (924s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[101.035641] Starting subtest: nonblocking-crc-frame-sequence
[101.037154] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.403734] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.367s)
[101.409893] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.734350] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.329s)
[101.741232] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.084954] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.348s)
[102.091083] Starting dynamic subtest: pipe-D-HDMI-A-1
[102.428592] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.342s)
[102.429357] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.393s)
[102.531778] [008/133] (923s left) gem_exec_schedule (preempt-engines)
[102.584482] Starting subtest: preempt-engines
[102.585184] Starting dynamic subtest: rcs0
[102.663831] Dynamic subtest rcs0: SUCCESS (0.079s)
[102.669550] Starting dynamic subtest: bcs0
[102.746681] Dynamic subtest bcs0: SUCCESS (0.082s)
[102.752568] Starting dynamic subtest: vcs0
[102.830227] Dynamic subtest vcs0: SUCCESS (0.083s)
[102.836996] Starting dynamic subtest: vcs1
[102.912262] Dynamic subtest vcs1: SUCCESS (0.082s)
[102.919148] Starting dynamic subtest: vecs0
[102.995278] Dynamic subtest vecs0: SUCCESS (0.083s)
[102.996205] Subtest preempt-engines: SUCCESS (0.411s)
[103.288371] [009/133] (922s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[103.386810] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[103.388260] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[103.469263] [010/133] (922s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[103.589378] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[103.624740] [011/133] (922s left) gem_wait (write-wait)
[103.671871] Starting subtest: write-wait
[103.672632] Starting dynamic subtest: all-engines
[104.734233] Dynamic subtest all-engines: SUCCESS (1.062s)
[104.744397] Starting dynamic subtest: rcs0
[105.766207] Dynamic subtest rcs0: SUCCESS (1.031s)
[105.774810] Starting dynamic subtest: bcs0
[106.795236] Dynamic subtest bcs0: SUCCESS (1.029s)
[106.803866] Starting dynamic subtest: vcs0
[107.822439] Dynamic subtest vcs0: SUCCESS (1.026s)
[107.830817] Starting dynamic subtest: vcs1
[108.856458] Dynamic subtest vcs1: SUCCESS (1.033s)
[108.864894] Starting dynamic subtest: vecs0
[109.885326] Dynamic subtest vecs0: SUCCESS (1.028s)
[109.886570] Subtest write-wait: SUCCESS (6.214s)
[110.071411] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[110.073959] [012/133] (915s left) kms_plane_multiple (2x-tiling-4)
[110.163552] Starting subtest: 2x-tiling-4
[110.164989] Subtest 2x-tiling-4: SKIP (0.000s)
[110.225856] [013/133] (915s left) kms_chamelium_hpd (dp-hpd-fast)
[110.365934] Subtest dp-hpd-fast: SKIP (0.000s)
[110.454671] [014/133] (915s left) prime_self_import (export-vs-gem_close-race)
[110.489601] Starting subtest: export-vs-gem_close-race
[115.534528] Subtest export-vs-gem_close-race: SUCCESS (5.045s)
[115.637195] [015/133] (910s left) kms_joiner (invalid-modeset-force-big-joiner)
[115.724674] Starting subtest: invalid-modeset-force-big-joiner
[115.726098] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[115.780822] [016/133] (910s left) i915_selftest (perf)
[116.613432] Starting subtest: perf
[116.614189] Starting dynamic subtest: engine_cs
[117.825628] Dynamic subtest engine_cs: SUCCESS (1.212s)
[117.831347] Starting dynamic subtest: request
[122.046798] Dynamic subtest request: SUCCESS (4.220s)
[122.055943] Starting dynamic subtest: migrate
[123.344922] Dynamic subtest migrate: SUCCESS (1.297s)
[123.352128] Starting dynamic subtest: region
[125.514552] Dynamic subtest region: SUCCESS (2.169s)
[125.515426] Subtest perf: SUCCESS (8.902s)
[125.545608] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[125.546403] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[125.550436] [017/133] (900s left) kms_rotation_crc (bad-tiling)
[126.600754] Starting subtest: bad-tiling
[128.032527] Subtest bad-tiling: SUCCESS (1.432s)
[128.189078] [FACT kms_rotation_crc (bad-tiling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[128.190435] [FACT kms_rotation_crc (bad-tiling)] new: kernel.kmod_is_loaded.i915: true
[128.193274] [018/133] (897s left) kms_pm_rpm (modeset-lpsp)
[139.638419] Starting subtest: modeset-lpsp
[140.928039] Subtest modeset-lpsp: SUCCESS (1.289s)
[141.042167] [019/133] (884s left) perf_pmu (init-busy)
[141.081300] Starting subtest: init-busy
[141.082037] Starting dynamic subtest: rcs0
[141.083684] Dynamic subtest rcs0: SUCCESS (0.001s)
[141.091675] Starting dynamic subtest: bcs0
[141.092440] Dynamic subtest bcs0: SUCCESS (0.000s)
[141.099068] Starting dynamic subtest: vcs0
[141.099823] Dynamic subtest vcs0: SUCCESS (0.001s)
[141.105519] Starting dynamic subtest: vcs1
[141.106246] Dynamic subtest vcs1: SUCCESS (0.001s)
[141.111868] Starting dynamic subtest: vecs0
[141.112566] Dynamic subtest vecs0: SUCCESS (0.001s)
[141.113254] Subtest init-busy: SUCCESS (0.008s)
[141.170952] [020/133] (884s left) kms_chamelium_frames (dp-frame-dump)
[141.306132] Subtest dp-frame-dump: SKIP (0.000s)
[141.389107] [021/133] (884s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[141.475075] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[141.512166] [022/133] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[141.601643] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[141.603077] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[141.696130] [023/133] (884s left) api_intel_allocator (reopen-fork)
[141.728440] Starting subtest: reopen-fork
[145.032902] Subtest reopen-fork: SUCCESS (3.270s)
[145.072136] [024/133] (881s left) syncobj_timeline (wait-all-complex)
[145.105697] Starting subtest: wait-all-complex
[145.330314] Subtest wait-all-complex: SUCCESS (0.215s)
[145.397719] [025/133] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[145.490914] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[145.492362] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.580967] [026/133] (880s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[145.665825] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[145.666529] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.672987] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[145.678917] Starting dynamic subtest: pipe-B-HDMI-A-1
[145.685373] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[145.691111] Starting dynamic subtest: pipe-C-HDMI-A-1
[145.697591] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[145.703283] Starting dynamic subtest: pipe-D-HDMI-A-1
[145.709934] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[145.711292] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[145.901620] [027/133] (880s left) vgem_slow (nohang)
[145.936258] Starting subtest: nohang
[156.257908] Subtest nohang: SUCCESS (10.316s)
[156.312673] [028/133] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[156.404708] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[156.406141] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[156.467414] [029/133] (869s left) kms_psr (psr-no-drrs)
[156.553434] Subtest psr-no-drrs: SKIP (0.000s)
[156.596657] [030/133] (869s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[156.682471] Starting subtest: 2x-flip-vs-modeset-vs-hang
[156.691014] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.009s)
[156.764597] [031/133] (869s left) kms_rotation_crc (exhaust-fences)
[156.849744] Starting subtest: exhaust-fences
[157.975997] Subtest exhaust-fences: SUCCESS (1.126s)
[158.081385] [032/133] (868s left) gem_userptr_blits (access-control)
[158.133510] Starting subtest: access-control
[158.134978] Subtest access-control: SKIP (0.000s)
[158.228407] [033/133] (868s left) kms_content_protection (lic-type-0)
[158.323098] Starting subtest: lic-type-0
[158.336436] Subtest lic-type-0: SKIP (0.012s)
[158.436961] [034/133] (868s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[158.530043] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[158.875419] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.345s)
[159.016724] [035/133] (867s left) prime_self_import (basic-with_two_bos)
[159.048967] Starting subtest: basic-with_two_bos
[159.051645] Subtest basic-with_two_bos: SUCCESS (0.004s)
[159.143055] [036/133] (867s left) gem_ctx_isolation (clean)
[159.184415] Starting subtest: clean
[159.185151] Starting dynamic subtest: rcs0
[159.209284] Dynamic subtest rcs0: SUCCESS (0.024s)
[159.216330] Starting dynamic subtest: bcs0
[159.277808] Dynamic subtest bcs0: SUCCESS (0.067s)
[159.283898] Starting dynamic subtest: vcs0
[159.349395] Dynamic subtest vcs0: SUCCESS (0.071s)
[159.356482] Starting dynamic subtest: vcs1
[159.415020] Dynamic subtest vcs1: SUCCESS (0.064s)
[159.421115] Starting dynamic subtest: vecs0
[159.487084] Dynamic subtest vecs0: SUCCESS (0.071s)
[159.487840] Subtest clean: SUCCESS (0.303s)
[159.663713] [037/133] (867s left) gem_exec_whisper (basic-sync-all)
[159.706270] Starting subtest: basic-sync-all
[161.369936] Subtest basic-sync-all: SUCCESS (1.663s)
[161.546223] [038/133] (865s left) gem_mmap_offset (partial-mmap)
[161.578556] Starting subtest: partial-mmap
[161.579297] Starting dynamic subtest: smem0
[161.581828] Dynamic subtest smem0: SUCCESS (0.003s)
[161.582561] Subtest partial-mmap: SUCCESS (0.004s)
[161.688363] [039/133] (865s left) gem_exec_params (cliprects-invalid)
[161.725424] Starting subtest: cliprects-invalid
[161.726167] Subtest cliprects-invalid: SUCCESS (0.000s)
[161.811537] [040/133] (864s left) kms_pm_lpsp (kms-lpsp)
[172.950421] Starting subtest: kms-lpsp
[172.951803] Subtest kms-lpsp: SKIP (0.000s)
[173.010180] [041/133] (853s left) gem_workarounds (suspend-resume-fd)
[173.056821] Starting subtest: suspend-resume-fd
[189.520240] Subtest suspend-resume-fd: SUCCESS (1.313s)
[197.646486] [042/133] (837s left) kms_chamelium_color (ctm-green-to-red)
[197.735444] Subtest ctm-green-to-red: SKIP (0.000s)
[197.777710] [043/133] (837s left) kms_cursor_crc (cursor-random-64x64)
[197.863823] Starting subtest: cursor-random-64x64
[197.868249] Starting dynamic subtest: pipe-A-HDMI-A-1
[199.768917] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.914s)
[199.801873] Starting dynamic subtest: pipe-D-HDMI-A-1
[201.656225] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.871s)
[201.656932] Subtest cursor-random-64x64: SUCCESS (3.817s)
[201.786456] [044/133] (833s left) kms_flip (flip-vs-blocking-wf-vblank)
[201.873559] Starting subtest: flip-vs-blocking-wf-vblank
[201.875858] Starting dynamic subtest: A-HDMI-A1
[209.762655] Dynamic subtest A-HDMI-A1: SUCCESS (7.892s)
[209.770130] Starting dynamic subtest: B-HDMI-A1
[217.629267] Dynamic subtest B-HDMI-A1: SUCCESS (7.869s)
[217.636539] Starting dynamic subtest: C-HDMI-A1
[225.506707] Dynamic subtest C-HDMI-A1: SUCCESS (7.882s)
[225.516269] Starting dynamic subtest: D-HDMI-A1
[233.273240] Dynamic subtest D-HDMI-A1: SUCCESS (7.788s)
[233.273999] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.439s)
[233.447638] [045/133] (801s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[233.539435] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[233.584369] [046/133] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[233.676148] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[233.677616] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[233.769611] [047/133] (801s left) kms_lease (atomic-implicit-crtc)
[233.856354] Starting subtest: atomic-implicit-crtc
[233.857092] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.860454] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[233.868770] Starting dynamic subtest: pipe-B-HDMI-A-1
[233.872295] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.011s)
[233.881732] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.885211] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.008s)
[233.892873] Starting dynamic subtest: pipe-D-HDMI-A-1
[233.896138] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.008s)
[233.896801] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[233.978886] [048/133] (801s left) syncobj_basic (bad-pad-handle-to-fd)
[234.012311] Starting subtest: bad-pad-handle-to-fd
[234.013124] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[234.073093] [049/133] (801s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[234.106599] Starting subtest: etime-multi-wait-all-available-unsubmitted
[234.215181] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.107s)
[234.283245] [050/133] (800s left) i915_drm_fdinfo (virtual-idle)
[234.319010] Starting subtest: virtual-idle
[236.847944] Subtest virtual-idle: SUCCESS (2.519s)
[236.906607] [051/133] (798s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[236.999872] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[237.001283] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[237.092195] [052/133] (798s left) kms_cursor_edge_walk (256x256-top-bottom)
[237.178807] Starting subtest: 256x256-top-bottom
[237.179512] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.925038] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.745s)
[238.933613] Starting dynamic subtest: pipe-D-HDMI-A-1
[240.585232] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.658s)
[240.585938] Subtest 256x256-top-bottom: SUCCESS (3.407s)
[240.689307] [053/133] (794s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[240.778296] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[240.780402] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.798141] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[240.807469] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.825210] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[240.834163] Starting dynamic subtest: pipe-C-HDMI-A-1
[240.851304] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[240.858450] Starting dynamic subtest: pipe-D-HDMI-A-1
[240.875716] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[240.877051] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.014s)
[241.018926] [054/133] (794s left) dmabuf_sync_file (export-multiwait)
[241.054096] Starting subtest: export-multiwait
[241.054853] Subtest export-multiwait: SUCCESS (0.001s)
[241.135995] [055/133] (794s left) gem_exec_params (invalid-ring2)
[241.172515] Starting subtest: invalid-ring2
[241.173287] Subtest invalid-ring2: SUCCESS (0.000s)
[241.273008] [056/133] (794s left) gem_mmap_gtt (basic-write-read-distinct)
[241.306063] Starting subtest: basic-write-read-distinct
[241.309243] Subtest basic-write-read-distinct: SUCCESS (0.003s)
[241.398800] [057/133] (794s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[241.489874] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[242.821214] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.331s)
[242.945961] [058/133] (792s left) gem_ccs (block-copy-uncompressed)
[242.983711] Starting subtest: block-copy-uncompressed
[242.985565] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[243.004047] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[243.012443] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[243.021981] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[243.022741] Subtest block-copy-uncompressed: SUCCESS (0.039s)
[243.134283] [059/133] (792s left) gem_exec_params (dr1-dirt)
[243.172236] Starting subtest: DR1-dirt
[243.172962] Subtest DR1-dirt: SUCCESS (0.000s)
[243.255562] [060/133] (792s left) gem_eio (create)
[243.299701] Starting subtest: create
[243.332036] Subtest create: SUCCESS (0.031s)
[243.449677] [061/133] (792s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[243.536073] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[243.537823] Starting dynamic subtest: pipe-A-HDMI-A-1
[259.608734] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.349s)
[259.617404] Starting dynamic subtest: pipe-B-HDMI-A-1
[276.572890] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.310s)
[276.586116] Starting dynamic subtest: pipe-C-HDMI-A-1
[292.578972] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.336s)
[292.591230] Starting dynamic subtest: pipe-D-HDMI-A-1
[309.574946] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.308s)
[309.575718] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (5.312s)
[318.815532] [062/133] (725s left) i915_drm_fdinfo (busy-idle-check-all)
[318.861422] Starting subtest: busy-idle-check-all
[318.862140] Starting dynamic subtest: rcs0
[319.480203] Dynamic subtest rcs0: SUCCESS (0.620s)
[319.491117] Starting dynamic subtest: bcs0
[320.103874] Dynamic subtest bcs0: SUCCESS (0.627s)
[320.113575] Starting dynamic subtest: vcs0
[320.726663] Dynamic subtest vcs0: SUCCESS (0.625s)
[320.736165] Starting dynamic subtest: vcs1
[321.349183] Dynamic subtest vcs1: SUCCESS (0.623s)
[321.358356] Starting dynamic subtest: vecs0
[321.971847] Dynamic subtest vecs0: SUCCESS (0.625s)
[321.972883] Subtest busy-idle-check-all: SUCCESS (3.132s)
[322.039834] [063/133] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[322.130563] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[322.131949] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[322.212910] [064/133] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[322.300742] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[322.302097] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[322.387717] [065/133] (722s left) gem_exec_balancer (individual)
[322.429858] Starting subtest: individual
[323.966793] Subtest individual: SUCCESS (1.537s)
[324.144701] [066/133] (720s left) gem_userptr_blits (dmabuf-sync)
[324.189436] Starting subtest: dmabuf-sync
[324.192401] Subtest dmabuf-sync: SKIP (0.002s)
[324.326458] [067/133] (720s left) vgem_basic (bad-fence)
[324.360445] Starting subtest: bad-fence
[324.361161] Subtest bad-fence: SUCCESS (0.000s)
[324.419103] [068/133] (720s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[324.505884] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[324.507255] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[324.569981] [069/133] (720s left) i915_pm_rpm (sysfs-read)
[336.005649] Starting subtest: sysfs-read
[337.201859] Subtest sysfs-read: SUCCESS (1.196s)
[337.368998] [070/133] (707s left) gem_mmap_gtt (big-bo)
[337.402439] Starting subtest: big-bo
[337.729608] Subtest big-bo: SUCCESS (0.328s)
[337.842237] [071/133] (707s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[337.987401] Starting subtest: 4-tiled-64bpp-rotate-270
[337.988763] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[338.089808] [072/133] (707s left) gen9_exec_parse (batch-invalid-length)
[338.127579] Subtest batch-invalid-length: SKIP (0.000s)
[338.176259] [073/133] (707s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[338.269652] Starting subtest: x-tiled-32bpp-rotate-180
[339.516544] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.248s)
[339.638092] [074/133] (705s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[339.725574] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[339.772607] [075/133] (705s left) kms_cursor_crc (cursor-offscreen-32x32)
[339.862099] Starting subtest: cursor-offscreen-32x32
[339.923796] Subtest cursor-offscreen-32x32: SKIP (0.060s)
[340.023073] [076/133] (705s left) syncobj_timeline (invalid-signal-illegal-handle)
[340.064761] Starting subtest: invalid-signal-illegal-handle
[340.065472] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[340.131975] [077/133] (705s left) kms_flip (2x-nonexisting-fb)
[340.217560] Starting subtest: 2x-nonexisting-fb
[340.227228] Subtest 2x-nonexisting-fb: SKIP (0.009s)
[340.292852] [078/133] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[340.382712] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[340.384063] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[340.477678] [079/133] (704s left) gem_mmap_gtt (big-bo-tiledy)
[340.512748] Starting subtest: big-bo-tiledY
[340.600211] Subtest big-bo-tiledY: SUCCESS (0.088s)
[340.720710] [080/133] (704s left) gem_exec_schedule (u-submit-late-slice)
[340.814640] Starting subtest: u-submit-late-slice
[340.815376] Starting dynamic subtest: rcs0
[340.840495] Dynamic subtest rcs0: SUCCESS (0.025s)
[340.850439] Starting dynamic subtest: bcs0
[340.873552] Dynamic subtest bcs0: SUCCESS (0.032s)
[340.882375] Starting dynamic subtest: vcs0
[340.902267] Dynamic subtest vcs0: SUCCESS (0.028s)
[340.911920] Starting dynamic subtest: vcs1
[340.934290] Dynamic subtest vcs1: SUCCESS (0.031s)
[340.944493] Starting dynamic subtest: vecs0
[340.963213] Dynamic subtest vecs0: SUCCESS (0.028s)
[340.963950] Subtest u-submit-late-slice: SUCCESS (0.149s)
[341.261132] [081/133] (704s left) gem_close_race (basic-process)
[341.307942] Starting subtest: basic-process
[341.351691] Subtest basic-process: SUCCESS (0.044s)
[341.521935] [082/133] (704s left) kms_atomic (test-only)
[341.613969] Starting subtest: test-only
[341.691066] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.023182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.333s)
[342.023891] Subtest test-only: SUCCESS (0.410s)
[342.190838] [083/133] (703s left) gem_exec_reloc (basic-gtt-read-active)
[342.231780] Starting subtest: basic-gtt-read-active
[342.363805] Subtest basic-gtt-read-active: SUCCESS (0.124s)
[342.477673] [084/133] (703s left) gem_exec_fence (basic-await)
[342.645007] Starting subtest: basic-await
[342.645863] Starting dynamic subtest: rcs0
[342.723688] Dynamic subtest rcs0: SUCCESS (0.079s)
[342.741886] Starting dynamic subtest: bcs0
[342.810000] Dynamic subtest bcs0: SUCCESS (0.084s)
[342.827852] Starting dynamic subtest: vcs0
[342.897258] Dynamic subtest vcs0: SUCCESS (0.085s)
[342.915571] Starting dynamic subtest: vcs1
[342.984729] Dynamic subtest vcs1: SUCCESS (0.085s)
[343.002747] Starting dynamic subtest: vecs0
[343.071424] Dynamic subtest vecs0: SUCCESS (0.084s)
[343.075630] Subtest basic-await: SUCCESS (0.430s)
[343.538852] [085/133] (702s left) kms_psr (fbc-pr-cursor-render)
[343.628528] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[343.673770] [086/133] (702s left) syncobj_wait (single-wait-all-for-submit-submitted)
[343.707150] Starting subtest: single-wait-all-for-submit-submitted
[343.813572] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[343.888878] [087/133] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[343.977677] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[343.978997] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[344.068077] [088/133] (701s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[344.163269] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[344.458056] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.295s)
[344.597074] [089/133] (701s left) gem_spin_batch (user-each)
[344.640152] Starting subtest: user-each
[347.997833] Subtest user-each: SUCCESS (3.342s)
[348.161302] [090/133] (697s left) gem_exec_flush (basic-wb-set-default)
[348.206272] Starting subtest: basic-wb-set-default
[353.639486] Subtest basic-wb-set-default: SUCCESS (5.435s)
[353.845501] [091/133] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[353.936806] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[353.938176] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[354.025750] [092/133] (691s left) perf (i915-ref-count)
[354.103367] Starting subtest: i915-ref-count
[354.131993] Subtest i915-ref-count: SUCCESS (0.029s)
[354.184717] [093/133] (691s left) gem_pwrite (basic-self)
[354.218789] Starting subtest: basic-self
[354.257411] Subtest basic-self: SUCCESS (0.039s)
[354.351939] [094/133] (691s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[354.392928] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[354.393697] Starting dynamic subtest: smem
[354.469160] Dynamic subtest smem: SUCCESS (0.077s)
[354.469895] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.078s)
[354.653148] [095/133] (691s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[354.687161] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[354.687865] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[354.753702] [096/133] (691s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[354.840499] Starting subtest: bad-aux-stride-y-tiled-ccs
[354.841262] Starting dynamic subtest: pipe-A-HDMI-A-1
[354.848081] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[354.858649] Starting dynamic subtest: pipe-B-HDMI-A-1
[354.865478] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[354.875508] Starting dynamic subtest: pipe-C-HDMI-A-1
[354.882293] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[354.892122] Starting dynamic subtest: pipe-D-HDMI-A-1
[354.899033] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[354.900411] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[355.087386] [097/133] (691s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[355.124212] Starting subtest: multi-wait-all-for-submit-signaled
[355.124954] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[355.187313] [098/133] (691s left) kms_psr (psr2-sprite-mmap-cpu)
[355.272300] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[355.321231] [099/133] (690s left) kms_vblank (ts-continuation-dpms-rpm)
[355.409951] Starting subtest: ts-continuation-dpms-rpm
[355.411726] Starting dynamic subtest: pipe-A-HDMI-A-1
[367.012088] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (11.600s)
[367.022880] Starting dynamic subtest: pipe-D-HDMI-A-1
[368.225557] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.210s)
[368.226310] Subtest ts-continuation-dpms-rpm: SUCCESS (12.816s)
[368.376290] [100/133] (677s left) gem_userptr_blits (coherency-unsync)
[368.417201] Subtest coherency-unsync: SKIP (0.000s)
[368.536856] [101/133] (677s left) kms_color (invalid-ctm-matrix-sizes)
[368.623967] Starting subtest: invalid-ctm-matrix-sizes
[368.624718] Starting dynamic subtest: pipe-A
[368.627883] Dynamic subtest pipe-A: SUCCESS (0.004s)
[368.637875] Starting dynamic subtest: pipe-B
[368.638579] Dynamic subtest pipe-B: SUCCESS (0.005s)
[368.654434] Starting dynamic subtest: pipe-C
[368.655204] Dynamic subtest pipe-C: SUCCESS (0.007s)
[368.663442] Starting dynamic subtest: pipe-D
[368.664126] Dynamic subtest pipe-D: SUCCESS (0.007s)
[368.664809] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.026s)
[368.708328] [102/133] (677s left) gem_exec_fence (syncobj-signal)
[369.033869] Starting subtest: syncobj-signal
[369.035377] Subtest syncobj-signal: SUCCESS (0.002s)
[369.336887] [103/133] (677s left) gem_exec_reloc (basic-cpu-gtt)
[369.374129] Starting subtest: basic-cpu-gtt
[369.380400] Subtest basic-cpu-gtt: SUCCESS (0.006s)
[369.491860] [104/133] (677s left) api_intel_bb (object-reloc-keep-cache)
[369.524953] Starting subtest: object-reloc-keep-cache
[369.529066] Subtest object-reloc-keep-cache: SUCCESS (0.004s)
[369.637943] [105/133] (676s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[369.727473] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[369.737079] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.009s)
[369.832712] [106/133] (676s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[369.928723] Starting subtest: y-tiled-16bpp-rotate-90
[371.056538] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.129s)
[371.175018] [107/133] (675s left) gem_exec_fence (syncobj-wait)
[371.489811] Starting subtest: syncobj-wait
[371.510776] Subtest syncobj-wait: SUCCESS (0.021s)
[371.848295] [108/133] (674s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[371.935113] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[371.936005] Starting dynamic subtest: pipe-A
[372.064619] Dynamic subtest pipe-A: SUCCESS (0.130s)
[372.073984] Starting dynamic subtest: pipe-B
[372.199403] Dynamic subtest pipe-B: SUCCESS (0.134s)
[372.209352] Starting dynamic subtest: pipe-C
[372.326053] Dynamic subtest pipe-C: SUCCESS (0.126s)
[372.335872] Starting dynamic subtest: pipe-D
[372.451062] Dynamic subtest pipe-D: SUCCESS (0.124s)
[372.451816] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.518s)
[372.621749] [109/133] (674s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[372.709967] Starting subtest: modeset-atomic-cursor-hotspot
[372.711378] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[372.770714] [110/133] (673s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[372.859564] Starting subtest: fbcpsr-tiling-4
[372.860937] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[372.964810] [111/133] (673s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[372.998712] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[373.043350] [112/133] (673s left) perf_pmu (all-busy-idle-check-all)
[373.079246] Starting subtest: all-busy-idle-check-all
[373.696826] Subtest all-busy-idle-check-all: SUCCESS (0.617s)
[373.771068] [113/133] (673s left) gem_basic (bad-close)
[373.807136] Starting subtest: bad-close
[373.808650] Subtest bad-close: SUCCESS (0.000s)
[373.863865] [114/133] (673s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[373.952468] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[373.991954] [115/133] (672s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[374.026061] Starting subtest: etime-single-wait-for-submit-unsubmitted
[374.134876] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[374.208621] [116/133] (672s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[374.297667] Starting subtest: psr-farfromfence-mmap-gtt
[374.299021] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[374.398965] [117/133] (672s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[374.443466] Starting subtest: map-fixed-invalidate-overlap-busy
[374.444178] Starting dynamic subtest: gtt
[376.028186] Dynamic subtest gtt: SUCCESS (1.576s)
[376.036346] Starting dynamic subtest: wb
[377.541160] Dynamic subtest wb: SUCCESS (1.512s)
[377.549360] Starting dynamic subtest: wc
[379.070177] Dynamic subtest wc: SUCCESS (1.528s)
[379.078793] Starting dynamic subtest: uc
[380.615950] Dynamic subtest uc: SUCCESS (1.545s)
[380.616775] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (6.166s)
[380.733327] [118/133] (666s left) kms_plane (pixel-format-x-tiled-modifier)
[380.825019] Starting subtest: pixel-format-x-tiled-modifier
[380.842797] Starting dynamic subtest: pipe-A-plane-0
[381.292714] Dynamic subtest pipe-A-plane-0: SUCCESS (0.450s)
[381.312518] Starting dynamic subtest: pipe-A-plane-3
[381.667654] Dynamic subtest pipe-A-plane-3: SUCCESS (0.372s)
[381.685937] Starting dynamic subtest: pipe-A-plane-5
[381.959393] Dynamic subtest pipe-A-plane-5: SUCCESS (0.288s)
[381.976292] Starting dynamic subtest: pipe-A-plane-7
[381.977779] Dynamic subtest pipe-A-plane-7: SKIP (0.000s)
[382.082462] Starting dynamic subtest: pipe-B-plane-0
[382.483195] Dynamic subtest pipe-B-plane-0: SUCCESS (0.408s)
[382.494587] Starting dynamic subtest: pipe-B-plane-3
[382.875022] Dynamic subtest pipe-B-plane-3: SUCCESS (0.390s)
[382.893827] Starting dynamic subtest: pipe-B-plane-5
[383.141871] Dynamic subtest pipe-B-plane-5: SUCCESS (0.264s)
[383.166932] Starting dynamic subtest: pipe-B-plane-7
[383.168431] Dynamic subtest pipe-B-plane-7: SKIP (0.000s)
[383.205759] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.382s)
[383.317901] [119/133] (663s left) gem_exec_params (rsvd2-dirt)
[383.360275] Starting subtest: rsvd2-dirt
[383.361703] Subtest rsvd2-dirt: SKIP (0.000s)
[383.449022] [120/133] (663s left) gem_exec_schedule (thriceslice)
[383.492793] Starting subtest: thriceslice
[383.494612] Starting dynamic subtest: rcs0
[383.498344] Dynamic subtest rcs0: SUCCESS (0.005s)
[383.509384] Starting dynamic subtest: bcs0
[383.510104] Dynamic subtest bcs0: SUCCESS (0.005s)
[383.518403] Starting dynamic subtest: vcs0
[383.519110] Dynamic subtest vcs0: SUCCESS (0.004s)
[383.527552] Starting dynamic subtest: vcs1
[383.528246] Dynamic subtest vcs1: SUCCESS (0.005s)
[383.536286] Starting dynamic subtest: vecs0
[383.536985] Dynamic subtest vecs0: SUCCESS (0.005s)
[383.537662] Subtest thriceslice: SUCCESS (0.029s)
[383.833391] [121/133] (663s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[383.924508] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[383.925849] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.020817] [122/133] (663s left) prime_vgem (busy)
[384.093510] Starting subtest: busy
[384.094309] Starting dynamic subtest: rcs0
[384.126517] Dynamic subtest rcs0: SUCCESS (0.032s)
[384.140960] Starting dynamic subtest: bcs0
[384.146757] Dynamic subtest bcs0: SUCCESS (0.019s)
[384.157899] Starting dynamic subtest: vcs0
[384.167175] Dynamic subtest vcs0: SUCCESS (0.019s)
[384.179008] Starting dynamic subtest: vcs1
[384.181661] Dynamic subtest vcs1: SUCCESS (0.013s)
[384.191114] Starting dynamic subtest: vecs0
[384.196892] Dynamic subtest vecs0: SUCCESS (0.014s)
[384.197588] Subtest busy: SUCCESS (0.104s)
[384.313739] [123/133] (662s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[384.401871] Starting subtest: addfb25-yf-tiled-legacy
[384.402557] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[384.494536] [124/133] (662s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[384.582700] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[384.584030] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[384.678989] [125/133] (662s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[384.767992] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[384.769469] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[384.863356] [126/133] (662s left) gem_mmap_gtt (medium-copy-xy)
[384.897708] Starting subtest: medium-copy-XY
[389.970899] Subtest medium-copy-XY: SUCCESS (5.076s)
[390.049101] [127/133] (657s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[390.183846] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[391.267409] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.084s)
[391.389821] [128/133] (656s left) kms_psr (pr-sprite-plane-move)
[391.479568] Subtest pr-sprite-plane-move: SKIP (0.000s)
[391.522555] [129/133] (656s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[391.620332] Starting subtest: yf-tiled-8bpp-rotate-90
[391.621793] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[391.715954] [130/133] (655s left) gem_mmap_gtt (close-race)
[391.749732] Starting subtest: close-race
[411.840472] Subtest close-race: SUCCESS (20.089s)
[411.961218] [131/133] (635s left) kms_flip (dpms-off-confusion-interruptible)
[412.055817] Starting subtest: dpms-off-confusion-interruptible
[412.057616] Starting dynamic subtest: A-HDMI-A1
[419.753430] Dynamic subtest A-HDMI-A1: SUCCESS (7.675s)
[419.761626] Starting dynamic subtest: B-HDMI-A1
[427.383344] Dynamic subtest B-HDMI-A1: SUCCESS (7.640s)
[427.392271] Starting dynamic subtest: C-HDMI-A1
[435.023537] Dynamic subtest C-HDMI-A1: SUCCESS (7.636s)
[435.034854] Starting dynamic subtest: D-HDMI-A1
[442.667109] Dynamic subtest D-HDMI-A1: SUCCESS (7.642s)
[442.669830] Subtest dpms-off-confusion-interruptible: SUCCESS (30.610s)
[442.851004] [132/133] (604s left) gem_ctx_persistence (legacy-engines-hostile)
[442.891699] Starting subtest: legacy-engines-hostile
[442.892456] Starting dynamic subtest: render
[442.927769] Dynamic subtest render: SUCCESS (0.035s)
[442.946335] Starting dynamic subtest: bsd1
[443.028747] Dynamic subtest bsd1: SUCCESS (0.098s)
[443.044559] Starting dynamic subtest: bsd2
[443.127789] Dynamic subtest bsd2: SUCCESS (0.096s)
[443.149302] Starting dynamic subtest: blt
[443.226751] Dynamic subtest blt: SUCCESS (0.096s)
[443.247731] Starting dynamic subtest: vebox
[443.326733] Dynamic subtest vebox: SUCCESS (0.097s)
[443.328068] Subtest legacy-engines-hostile: SUCCESS (0.436s)
[443.400569] [133/133] (604s left) kms_plane (plane-position-covered)
[443.488949] Starting subtest: plane-position-covered
[443.697564] Starting dynamic subtest: pipe-A-plane-1
[443.928488] Dynamic subtest pipe-A-plane-1: SUCCESS (0.231s)
[443.936851] Starting dynamic subtest: pipe-A-plane-2
[444.167242] Dynamic subtest pipe-A-plane-2: SUCCESS (0.238s)
[444.175710] Starting dynamic subtest: pipe-A-plane-3
[444.407224] Dynamic subtest pipe-A-plane-3: SUCCESS (0.238s)
[444.417652] Starting dynamic subtest: pipe-A-plane-4
[444.654719] Dynamic subtest pipe-A-plane-4: SUCCESS (0.247s)
[444.668962] Starting dynamic subtest: pipe-A-plane-5
[444.901781] Dynamic subtest pipe-A-plane-5: SUCCESS (0.247s)
[444.911317] Starting dynamic subtest: pipe-A-plane-6
[445.141363] Dynamic subtest pipe-A-plane-6: SUCCESS (0.238s)
[445.150021] Starting dynamic subtest: pipe-A-plane-7
[445.151366] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[445.330299] Starting dynamic subtest: pipe-B-plane-1
[445.554473] Dynamic subtest pipe-B-plane-1: SUCCESS (0.232s)
[445.563005] Starting dynamic subtest: pipe-B-plane-2
[445.770814] Dynamic subtest pipe-B-plane-2: SUCCESS (0.215s)
[445.779088] Starting dynamic subtest: pipe-B-plane-3
[446.002394] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[446.010901] Starting dynamic subtest: pipe-B-plane-4
[446.235561] Dynamic subtest pipe-B-plane-4: SUCCESS (0.232s)
[446.244765] Starting dynamic subtest: pipe-B-plane-5
[446.469380] Dynamic subtest pipe-B-plane-5: SUCCESS (0.233s)
[446.477961] Starting dynamic subtest: pipe-B-plane-6
[446.701414] Dynamic subtest pipe-B-plane-6: SUCCESS (0.232s)
[446.711078] Starting dynamic subtest: pipe-B-plane-7
[446.712423] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[446.713110] Subtest plane-position-covered: SUCCESS (3.217s)
[446.861083] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: kms_fb_coherency
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_tiled_display
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: kms_plane_multiple
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: prime_self_import
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: i915_selftest
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: vgem_slow
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_self_import
results: parsing output: 35/ for test: gem_ctx_isolation
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_mmap_offset
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_pm_lpsp
results: parsing output: 40/ for test: gem_workarounds
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_lease
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: dmabuf_sync_file
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_ccs
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: i915_pm_rpm
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gen9_exec_parse
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: gem_close_race
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_pwrite
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: gem_exec_fence
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_params
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_plane
Done.