[57.673613] Initializing watchdogs
[57.673733]   /dev/watchdog0
[57.688790] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.693625] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.695838] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.699129] [001/133] (960s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[57.829729] Starting subtest: y-tiled-8bpp-rotate-180
[57.833870] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[57.907999] [002/133] (960s left) gem_eio (hibernate)
[58.049107] Starting subtest: hibernate
[72.727342] Subtest hibernate: SUCCESS (14.679s)
[80.055813] [003/133] (945s left) kms_content_protection (uevent-hdcp14)
[80.214776] Starting subtest: uevent-hdcp14
[80.219387] Subtest uevent-hdcp14: SKIP (0.000s)
[80.336652] [004/133] (944s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[80.389925] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[80.392536] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[80.504682] [005/133] (944s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[80.556831] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[80.618931] [006/133] (944s left) kms_color (ctm-0-50)
[80.700679] Starting subtest: ctm-0-50
[80.703035] Starting dynamic subtest: pipe-A-eDP-1
[84.126490] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.424s)
[84.137344] Starting dynamic subtest: pipe-B-eDP-1
[88.456457] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.332s)
[88.469215] Starting dynamic subtest: pipe-C-eDP-1
[92.498196] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.038s)
[92.511287] Starting dynamic subtest: pipe-D-eDP-1
[96.502289] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.005s)
[96.504322] Subtest ctm-0-50: SUCCESS (15.800s)
[97.327016] [007/133] (928s left) gem_ccs (block-copy-compressed)
[97.387993] Starting subtest: block-copy-compressed
[97.392523] Subtest block-copy-compressed: SKIP (0.000s)
[97.507235] [008/133] (927s left) gem_ctx_isolation (nonpriv)
[97.568981] Starting subtest: nonpriv
[97.571331] Starting dynamic subtest: rcs0
[97.824134] Dynamic subtest rcs0: SUCCESS (0.255s)
[97.835699] Starting dynamic subtest: bcs0
[98.087183] Dynamic subtest bcs0: SUCCESS (0.263s)
[98.098565] Starting dynamic subtest: vcs0
[98.344325] Dynamic subtest vcs0: SUCCESS (0.257s)
[98.355061] Starting dynamic subtest: vcs1
[99.482247] Dynamic subtest vcs1: SUCCESS (1.137s)
[99.493190] Starting dynamic subtest: vecs0
[101.553850] Dynamic subtest vecs0: SUCCESS (2.071s)
[101.565289] Starting dynamic subtest: ccs0
[103.579847] Dynamic subtest ccs0: SUCCESS (2.026s)
[103.582307] Subtest nonpriv: SUCCESS (6.011s)
[103.832755] [009/133] (921s left) kms_plane (pixel-format-linear-modifier)
[103.933083] Starting subtest: pixel-format-linear-modifier
[103.958519] Starting dynamic subtest: pipe-A-plane-0
[107.647129] Dynamic subtest pipe-A-plane-0: SUCCESS (3.689s)
[107.658733] Starting dynamic subtest: pipe-A-plane-3
[109.336120] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[109.346099] Starting dynamic subtest: pipe-A-plane-5
[109.548112] Dynamic subtest pipe-A-plane-5: SUCCESS (0.211s)
[110.614414] Starting dynamic subtest: pipe-B-plane-0
[114.117227] Dynamic subtest pipe-B-plane-0: SUCCESS (3.511s)
[114.131624] Starting dynamic subtest: pipe-B-plane-3
[115.883598] Dynamic subtest pipe-B-plane-3: SUCCESS (1.765s)
[115.892425] Starting dynamic subtest: pipe-B-plane-5
[116.094472] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[116.410458] Subtest pixel-format-linear-modifier: SUCCESS (12.478s)
[117.269698] [010/133] (908s left) kms_big_fb (4-tiled-addfb-size-overflow)
[117.373394] Starting subtest: 4-tiled-addfb-size-overflow
[117.375359] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[117.464823] [011/133] (908s left) kms_cursor_crc (cursor-onscreen-64x64)
[117.657065] Starting subtest: cursor-onscreen-64x64
[117.662366] Starting dynamic subtest: pipe-A-eDP-1
[119.779904] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[119.808801] Starting dynamic subtest: pipe-D-eDP-1
[122.654510] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.851s)
[122.656497] Subtest cursor-onscreen-64x64: SUCCESS (4.994s)
[123.526413] [012/133] (902s left) kms_psr (psr-no-drrs)
[123.626129] Starting subtest: psr-no-drrs
[123.628374] Starting dynamic subtest: eDP-1
[125.201314] Dynamic subtest eDP-1: SUCCESS (1.576s)
[125.203651] Subtest psr-no-drrs: SUCCESS (1.576s)
[126.083850] [013/133] (899s left) gem_eio (in-flight-internal-1us)
[126.307745] Starting subtest: in-flight-internal-1us
[127.374145] Subtest in-flight-internal-1us: SUCCESS (1.064s)
[127.515298] [014/133] (898s left) sysfs_timeslice_duration (duration)
[127.568707] Starting subtest: duration
[127.571410] Starting dynamic subtest: vecs0
[141.221793] Dynamic subtest vecs0: SUCCESS (13.651s)
[141.236838] Starting dynamic subtest: ccs0
[154.366868] Dynamic subtest ccs0: SUCCESS (13.145s)
[154.379400] Starting dynamic subtest: vcs0
[168.229064] Dynamic subtest vcs0: SUCCESS (13.859s)
[168.241878] Starting dynamic subtest: bcs0
[181.384169] Dynamic subtest bcs0: SUCCESS (13.154s)
[181.400495] Starting dynamic subtest: rcs0
[194.526386] Dynamic subtest rcs0: SUCCESS (13.141s)
[194.538909] Starting dynamic subtest: vcs1
[208.229048] Dynamic subtest vcs1: SUCCESS (13.699s)
[208.232068] Subtest duration: SUCCESS (80.661s)
[208.310081] [015/133] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[208.413649] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[208.418146] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[208.518074] [016/133] (817s left) gem_mmap_gtt (zero-extend)
[208.585241] Subtest zero-extend: SKIP (0.000s)
[208.646278] [017/133] (817s left) perf_pmu (rc6-all-gts)
[208.691055] Starting subtest: rc6-all-gts
[215.074504] Subtest rc6-all-gts: SUCCESS (6.383s)
[215.953169] [018/133] (809s left) syncobj_timeline (invalid-query-illegal-handle)
[216.020385] Starting subtest: invalid-query-illegal-handle
[216.022767] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[216.129524] [019/133] (809s left) syncobj_wait (wait-all-for-submit-snapshot)
[216.186632] Starting subtest: wait-all-for-submit-snapshot
[216.266947] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[216.341695] [020/133] (809s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[216.448488] Starting subtest: yf-tiled-addfb-size-overflow
[216.452018] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[216.546855] [021/133] (809s left) gem_exec_balancer (busy)
[216.609376] Starting subtest: busy
[218.310373] Subtest busy: SUCCESS (1.698s)
[218.660151] [022/133] (807s left) kms_plane_scaling (invalid-num-scalers)
[218.763163] Starting subtest: invalid-num-scalers
[218.765573] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[218.779834] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[218.789789] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[218.811570] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[218.821089] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[218.842126] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[218.851165] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[218.874714] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[218.877063] Subtest invalid-num-scalers: SUCCESS (0.112s)
[218.986776] [023/133] (807s left) gem_ctx_persistence (hang)
[219.050861] Starting subtest: hang
[219.055606] Subtest hang: SKIP (0.000s)
[219.171903] [024/133] (806s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[219.252239] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[219.256222] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[219.350929] [025/133] (806s left) kms_dsc (dsc-with-bpc)
[219.445512] Starting subtest: dsc-with-bpc
[219.475596] Subtest dsc-with-bpc: SKIP (0.001s)
[219.514709] [026/133] (806s left) kms_psr (fbc-pr-sprite-plane-onoff)
[219.602515] Starting subtest: fbc-pr-sprite-plane-onoff
[219.606174] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[219.672339] [027/133] (806s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[219.781503] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[219.783367] Starting dynamic subtest: pipe-A-eDP-1
[219.804700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[219.816059] Starting dynamic subtest: pipe-B-eDP-1
[219.834156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[219.842614] Starting dynamic subtest: pipe-C-eDP-1
[219.862027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[219.870759] Starting dynamic subtest: pipe-D-eDP-1
[219.890139] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[219.893704] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[221.942905] [028/133] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[222.036603] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[222.040740] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[222.142580] [029/133] (804s left) syncobj_wait (wait-any-snapshot)
[222.204832] Starting subtest: wait-any-snapshot
[222.286488] Subtest wait-any-snapshot: SUCCESS (0.082s)
[222.374204] [030/133] (803s left) gem_exec_schedule (semaphore-power)
[222.563682] Subtest semaphore-power: SKIP (0.000s)
[222.738976] [031/133] (803s left) syncobj_wait (reset-during-wait-for-submit)
[222.794917] Starting subtest: reset-during-wait-for-submit
[222.897481] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[222.978292] [032/133] (803s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[223.037109] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[223.104977] [033/133] (803s left) i915_suspend (fence-restore-tiled2untiled)
[223.164416] Starting subtest: fence-restore-tiled2untiled
[223.168905] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[223.280315] [034/133] (803s left) kms_flip (flip-vs-rmfb)
[223.374276] Starting subtest: flip-vs-rmfb
[223.376531] Starting dynamic subtest: A-eDP1
[232.026796] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[232.038701] Starting dynamic subtest: B-eDP1
[240.673885] Dynamic subtest B-eDP1: SUCCESS (8.645s)
[240.685553] Starting dynamic subtest: C-eDP1
[249.301217] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[249.312971] Starting dynamic subtest: D-eDP1
[257.931811] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[257.936144] Subtest flip-vs-rmfb: SUCCESS (34.561s)
[259.118589] [035/133] (767s left) gem_exec_params (sol-reset-not-gen7)
[259.188425] Starting subtest: sol-reset-not-gen7
[259.193886] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[259.313321] [036/133] (767s left) gem_wait (wait)
[259.372080] Starting subtest: wait
[259.374392] Starting dynamic subtest: all-engines
[261.318465] Dynamic subtest all-engines: SUCCESS (1.944s)
[261.331527] Starting dynamic subtest: rcs0
[262.365110] Dynamic subtest rcs0: SUCCESS (1.045s)
[262.379722] Starting dynamic subtest: bcs0
[263.413770] Dynamic subtest bcs0: SUCCESS (1.046s)
[263.424153] Starting dynamic subtest: vcs0
[264.459722] Dynamic subtest vcs0: SUCCESS (1.043s)
[264.471433] Starting dynamic subtest: vcs1
[265.505155] Dynamic subtest vcs1: SUCCESS (1.043s)
[265.517729] Starting dynamic subtest: vecs0
[266.550417] Dynamic subtest vecs0: SUCCESS (1.043s)
[266.562335] Starting dynamic subtest: ccs0
[267.596498] Dynamic subtest ccs0: SUCCESS (1.045s)
[267.599032] Subtest wait: SUCCESS (8.225s)
[267.795897] [037/133] (758s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[267.902097] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[267.904273] Starting dynamic subtest: pipe-A-eDP-1
[279.228413] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.332s)
[279.239216] Starting dynamic subtest: pipe-B-eDP-1
[291.232458] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.004s)
[291.234669] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.338s)
[292.075820] [038/133] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[292.171470] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[292.175641] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[292.264399] [039/133] (734s left) kms_lease (lease-uevent)
[292.355323] Starting subtest: lease-uevent
[293.374332] Subtest lease-uevent: SUCCESS (1.018s)
[293.470048] [040/133] (733s left) kms_addfb_basic (bad-pitch-999)
[293.534107] Starting subtest: bad-pitch-999
[293.536493] Subtest bad-pitch-999: SUCCESS (0.000s)
[293.655808] [041/133] (733s left) gem_exec_flush (basic-uc-ro-default)
[293.720949] Starting subtest: basic-uc-ro-default
[299.174218] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[299.365235] [042/133] (727s left) kms_addfb_basic (small-bo)
[299.460930] Starting subtest: small-bo
[299.463226] Subtest small-bo: SUCCESS (0.000s)
[299.572758] [043/133] (727s left) kms_pwrite_crc
[301.202974] [044/133] (725s left) gem_madvise (dontneed-before-mmap)
[301.243678] Starting subtest: dontneed-before-mmap
[301.267922] Subtest dontneed-before-mmap: SUCCESS (0.025s)
[301.356450] [045/133] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[301.443343] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[301.447326] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[301.540180] [046/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[301.639348] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[309.099046] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.462s)
[309.231974] [047/133] (717s left) gen3_render_linear_blits
[309.340999] [048/133] (717s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[309.450138] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[309.454316] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[309.522552] [049/133] (717s left) kms_flip (2x-flip-vs-wf_vblank)
[309.620457] Starting subtest: 2x-flip-vs-wf_vblank
[309.645104] Subtest 2x-flip-vs-wf_vblank: SKIP (0.025s)
[309.722644] [050/133] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[309.822729] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[317.224841] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.405s)
[317.376453] [051/133] (709s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[317.448074] Starting subtest: invalid-bsd1-flag-on-vebox
[317.450393] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[317.559031] [052/133] (709s left) gem_readwrite (read-bad-handle)
[317.610459] Subtest read-bad-handle: SKIP (0.000s)
[317.662717] [053/133] (709s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[317.717377] Starting subtest: mixed-tiled-to-y-tiled-ccs
[317.721580] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[317.897246] [054/133] (709s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[318.000244] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[318.002455] Starting dynamic subtest: pipe-A-default-mode
[319.130468] Dynamic subtest pipe-A-default-mode: SKIP (1.125s)
[319.134843] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.127s)
[319.284038] [055/133] (708s left) gem_exec_balancer (parallel-keep-submit-fence)
[319.550853] Starting subtest: parallel-keep-submit-fence
[320.841341] Subtest parallel-keep-submit-fence: SUCCESS (1.291s)
[320.937973] [056/133] (706s left) kms_cursor_crc (cursor-random-64x64)
[321.119271] Starting subtest: cursor-random-64x64
[321.124140] Starting dynamic subtest: pipe-A-eDP-1
[324.499848] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s)
[324.528843] Starting dynamic subtest: pipe-D-eDP-1
[328.542049] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.021s)
[328.544556] Subtest cursor-random-64x64: SUCCESS (7.423s)
[329.362206] [057/133] (698s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[329.422059] Subtest writes-after-reads-snoop: SKIP (0.000s)
[329.481495] [058/133] (698s left) kms_pm_rpm (modeset-lpsp-stress)
[331.503461] Starting subtest: modeset-lpsp-stress
[347.058797] Subtest modeset-lpsp-stress: SUCCESS (15.559s)
[347.145047] [059/133] (680s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[347.249896] Starting subtest: psr-rgb565-draw-mmap-cpu
[353.981047] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.734s)
[354.102919] [060/133] (673s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[354.216547] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[354.220872] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[354.322789] [061/133] (673s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[354.418281] Starting subtest: bo-too-small-due-to-tiling
[354.422305] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[354.507971] [062/133] (673s left) kms_big_fb (linear-32bpp-rotate-0)
[354.611185] Starting subtest: linear-32bpp-rotate-0
[356.089889] Subtest linear-32bpp-rotate-0: SUCCESS (1.479s)
[356.215183] [063/133] (671s left) gem_exec_params (invalid-flag)
[356.271916] Starting subtest: invalid-flag
[356.273845] Subtest invalid-flag: SUCCESS (0.000s)
[356.369838] [064/133] (671s left) gem_spin_batch (resubmit-all)
[356.440981] Starting subtest: resubmit-all
[356.442716] Starting dynamic subtest: rcs0
[356.450124] Dynamic subtest rcs0: SUCCESS (0.012s)
[356.463500] Starting dynamic subtest: bcs0
[356.465379] Dynamic subtest bcs0: SUCCESS (0.002s)
[356.476369] Starting dynamic subtest: vcs0
[356.477927] Dynamic subtest vcs0: SUCCESS (0.002s)
[356.486804] Starting dynamic subtest: vcs1
[356.488370] Dynamic subtest vcs1: SUCCESS (0.002s)
[356.497184] Starting dynamic subtest: vecs0
[356.498731] Dynamic subtest vecs0: SUCCESS (0.002s)
[356.507720] Starting dynamic subtest: ccs0
[356.509311] Dynamic subtest ccs0: SUCCESS (0.002s)
[356.510857] Subtest resubmit-all: SUCCESS (0.026s)
[358.392024] [065/133] (669s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[358.497636] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[358.502208] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[359.666907] [066/133] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[359.773037] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[366.552250] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.783s)
[366.698136] [067/133] (661s left) kms_flip (blocking-wf_vblank)
[366.789159] Starting subtest: blocking-wf_vblank
[366.791299] Starting dynamic subtest: A-eDP1
[375.760990] Dynamic subtest A-eDP1: SUCCESS (8.973s)
[375.777928] Starting dynamic subtest: B-eDP1
[384.683576] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[384.700896] Starting dynamic subtest: C-eDP1
[393.613801] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[393.625317] Starting dynamic subtest: D-eDP1
[402.544772] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[402.550665] Subtest blocking-wf_vblank: SUCCESS (35.762s)
[403.777470] [068/133] (624s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[403.871492] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[403.873804] Starting dynamic subtest: pipe-A-eDP-1
[403.897368] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[403.911277] Starting dynamic subtest: pipe-B-eDP-1
[403.933439] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[403.943544] Starting dynamic subtest: pipe-C-eDP-1
[403.965075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[403.974925] Starting dynamic subtest: pipe-D-eDP-1
[403.997072] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[404.001572] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[406.067406] [069/133] (621s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[406.179256] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[407.082101] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s)
[407.244381] [070/133] (620s left) kms_plane_scaling (planes-downscale-factor-0-75)
[407.327270] Starting subtest: planes-downscale-factor-0-75
[407.329576] Starting dynamic subtest: pipe-A
[407.347881] Dynamic subtest pipe-A: SKIP (0.017s)
[407.361606] Starting dynamic subtest: pipe-B
[407.376609] Dynamic subtest pipe-B: SKIP (0.029s)
[407.386666] Starting dynamic subtest: pipe-C
[407.408824] Dynamic subtest pipe-C: SKIP (0.030s)
[407.418687] Starting dynamic subtest: pipe-D
[407.438231] Dynamic subtest pipe-D: SKIP (0.029s)
[407.442295] Subtest planes-downscale-factor-0-75: SKIP (0.108s)
[407.541477] [071/133] (620s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[407.599493] Starting subtest: yf-tiled-to-vebox-yf-tiled
[407.603927] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[407.783513] [072/133] (620s left) kms_plane_lowres (tiling-x)
[407.867450] Starting subtest: tiling-x
[407.869732] Starting dynamic subtest: pipe-A-eDP-1
[407.874320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.163243] Starting dynamic subtest: pipe-B-eDP-1
[408.167758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.179378] Starting dynamic subtest: pipe-C-eDP-1
[408.183807] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.193605] Starting dynamic subtest: pipe-D-eDP-1
[408.197890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.202114] Subtest tiling-x: SKIP (0.296s)
[408.985873] [073/133] (619s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[409.086530] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[416.087772] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.004s)
[416.211808] [074/133] (611s left) syncobj_wait (wait-all-for-submit-complex)
[416.277946] Starting subtest: wait-all-for-submit-complex
[416.493470] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[416.571182] [075/133] (611s left) i915_pm_rps (fence-order)
[416.627705] Starting subtest: fence-order
[419.537267] Subtest fence-order: SUCCESS (2.909s)
[419.645894] [076/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[419.747702] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[419.751835] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[419.831775] [077/133] (608s left) kms_psr (psr2-no-drrs)
[419.917056] Starting subtest: psr2-no-drrs
[419.919326] Starting dynamic subtest: eDP-1
[421.562407] Dynamic subtest eDP-1: SUCCESS (1.645s)
[421.564732] Subtest psr2-no-drrs: SUCCESS (1.646s)
[422.366537] [078/133] (605s left) kms_atomic_transition (plane-all-transition)
[422.473648] Starting subtest: plane-all-transition
[422.476261] Starting dynamic subtest: pipe-A-eDP-1
[424.967083] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[425.284804] Starting dynamic subtest: pipe-B-eDP-1
[428.487868] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.214s)
[428.799715] Subtest plane-all-transition: SUCCESS (6.328s)
[429.620373] [079/133] (598s left) gem_ctx_sseu (engines)
[429.688075] Subtest engines: SKIP (0.000s)
[429.761273] [080/133] (598s left) kms_pm_backlight (fade)
[429.852135] Starting subtest: fade
[429.899764] Starting dynamic subtest: eDP-1
[432.881202] Dynamic subtest eDP-1: SUCCESS (2.979s)
[432.883511] Subtest fade: SUCCESS (3.029s)
[433.754409] [081/133] (594s left) kms_async_flips (test-time-stamp-atomic)
[433.855663] Starting subtest: test-time-stamp-atomic
[434.227339] Starting dynamic subtest: pipe-A-eDP-1
[435.054635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.825s)
[435.437178] Starting dynamic subtest: pipe-B-eDP-1
[436.189938] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[436.567112] Starting dynamic subtest: pipe-C-eDP-1
[437.315825] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[437.687779] Starting dynamic subtest: pipe-D-eDP-1
[438.443301] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.762s)
[438.445785] Subtest test-time-stamp-atomic: SUCCESS (4.587s)
[439.602031] [082/133] (588s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[439.721121] Starting subtest: flip-vs-cursor-crc-legacy
[440.378543] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.658s)
[441.241812] [083/133] (587s left) tools_test (sysfs_l3_parity)
[441.292391] Starting subtest: sysfs_l3_parity
[441.369034] Subtest sysfs_l3_parity: SKIP (0.088s)
[441.424860] [084/133] (587s left) gem_fence_thrash (bo-write-verify-x)
[441.459524] Starting subtest: bo-write-verify-x
[441.483223] Subtest bo-write-verify-x: SKIP (0.019s)
[441.541206] [085/133] (587s left) i915_hangman (error-state-basic)
[441.615801] Starting subtest: error-state-basic
[441.749556] Subtest error-state-basic: SUCCESS (0.134s)
[441.821756] [086/133] (586s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[441.869740] Starting subtest: single-wait-all-for-submit-available-submitted
[441.871950] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[441.958652] [087/133] (586s left) kms_invalid_mode (zero-hdisplay)
[442.069939] Starting subtest: zero-hdisplay
[442.072147] Starting dynamic subtest: pipe-A-eDP-1
[442.352920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[442.362978] Starting dynamic subtest: pipe-B-eDP-1
[442.364851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[442.374656] Starting dynamic subtest: pipe-C-eDP-1
[442.376782] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[442.386338] Starting dynamic subtest: pipe-D-eDP-1
[442.388519] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[442.390798] Subtest zero-hdisplay: SUCCESS (0.291s)
[443.170742] [088/133] (585s left) perf_pmu (busy-accuracy-50)
[443.215107] Starting subtest: busy-accuracy-50
[443.217317] Starting dynamic subtest: rcs0
[444.746562] Dynamic subtest rcs0: SUCCESS (1.532s)
[444.759184] Starting dynamic subtest: bcs0
[446.287057] Dynamic subtest bcs0: SUCCESS (1.539s)
[446.299793] Starting dynamic subtest: vcs0
[447.830261] Dynamic subtest vcs0: SUCCESS (1.541s)
[447.842903] Starting dynamic subtest: vcs1
[449.373662] Dynamic subtest vcs1: SUCCESS (1.540s)
[449.384382] Starting dynamic subtest: vecs0
[450.914091] Dynamic subtest vecs0: SUCCESS (1.538s)
[450.926696] Starting dynamic subtest: ccs0
[452.460507] Dynamic subtest ccs0: SUCCESS (1.544s)
[452.462980] Subtest busy-accuracy-50: SUCCESS (9.248s)
[452.577722] [089/133] (576s left) api_intel_bb (object-reloc-purge-cache)
[452.636178] Starting subtest: object-reloc-purge-cache
[452.643388] Subtest object-reloc-purge-cache: SKIP (0.006s)
[452.765466] [090/133] (576s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[452.855024] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[452.857376] Starting dynamic subtest: pipe-A-eDP-1
[452.880819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[452.891394] Starting dynamic subtest: pipe-B-eDP-1
[452.912934] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[452.922508] Starting dynamic subtest: pipe-C-eDP-1
[452.944019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[452.953523] Starting dynamic subtest: pipe-D-eDP-1
[452.975371] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.979792] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[455.128867] [091/133] (573s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[455.218664] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[461.754307] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.537s)
[461.891717] [092/133] (566s left) gen7_exec_parse (cmd-crossing-page)
[461.956989] Subtest cmd-crossing-page: SKIP (0.000s)
[462.022904] [093/133] (566s left) core_sysfs (read-all-entries)
[462.070115] Starting subtest: read-all-entries
[462.072500] Subtest read-all-entries: SUCCESS (0.003s)
[462.174754] [094/133] (566s left) kms_rotation_crc (sprite-rotation-90)
[462.274867] Starting subtest: sprite-rotation-90
[462.279512] Subtest sprite-rotation-90: SKIP (0.001s)
[462.366702] [095/133] (566s left) kms_chamelium_frames (dp-crc-fast)
[462.751830] Subtest dp-crc-fast: SKIP (0.000s)
[463.580284] [096/133] (565s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[464.182560] Starting subtest: syncobj-timeline-invalid-wait
[464.184754] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[465.347692] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[465.351087] [097/133] (563s left) api_intel_bb (blit-reloc-purge-cache)
[465.408080] Starting subtest: blit-reloc-purge-cache
[465.412056] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[465.517204] [098/133] (563s left) syncobj_eventfd (timeline-wait)
[465.575983] Starting subtest: timeline-wait
[465.584819] Subtest timeline-wait: SUCCESS (0.010s)
[465.689315] [099/133] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[465.783165] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[465.787164] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[465.893938] [100/133] (563s left) kms_tiled_display (basic-test-pattern)
[466.004809] Subtest basic-test-pattern: SKIP (0.000s)
[466.052642] [101/133] (563s left) gem_exec_flush (basic-wb-rw-before-default)
[466.123606] Starting subtest: basic-wb-rw-before-default
[471.584744] Subtest basic-wb-rw-before-default: SUCCESS (5.461s)
[471.798837] [102/133] (557s left) syncobj_basic (test-valid-cycle)
[471.851451] Starting subtest: test-valid-cycle
[471.853382] Subtest test-valid-cycle: SUCCESS (0.000s)
[471.961315] [103/133] (557s left) kms_addfb_basic (addfb25-4-tiled)
[472.056077] Starting subtest: addfb25-4-tiled
[472.058197] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[472.169502] [104/133] (557s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[472.227904] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[472.331091] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[472.411381] [105/133] (557s left) gem_exec_whisper (basic-fds-all)
[472.469396] Starting subtest: basic-fds-all
[482.281828] Subtest basic-fds-all: SUCCESS (9.807s)
[482.478105] [106/133] (547s left) kms_cursor_edge_walk (128x128-left-edge)
[482.581021] Starting subtest: 128x128-left-edge
[482.583323] Starting dynamic subtest: pipe-A-eDP-1
[486.061583] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s)
[486.072839] Starting dynamic subtest: pipe-D-eDP-1
[489.192997] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[489.195196] Subtest 128x128-left-edge: SUCCESS (6.613s)
[490.016533] [107/133] (539s left) gem_pread (uncached)
[490.088803] Subtest uncached: SKIP (0.000s)
[490.163026] [108/133] (539s left) kms_pipe_crc_basic (hang-read-crc)
[490.251303] Starting subtest: hang-read-crc
[490.253226] Starting dynamic subtest: pipe-A-eDP-1
[492.380541] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.128s)
[492.391820] Starting dynamic subtest: pipe-B-eDP-1
[495.061103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.679s)
[495.071576] Starting dynamic subtest: pipe-C-eDP-1
[497.670779] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[497.681912] Starting dynamic subtest: pipe-D-eDP-1
[500.327285] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[500.329696] Subtest hang-read-crc: SUCCESS (10.076s)
[501.177895] [109/133] (528s left) gem_exec_schedule (pi-ringfull)
[501.362348] Starting subtest: pi-ringfull
[501.364443] Starting dynamic subtest: rcs0
[501.398808] Dynamic subtest rcs0: SUCCESS (0.041s)
[501.410694] Starting dynamic subtest: bcs0
[501.442062] Dynamic subtest bcs0: SUCCESS (0.042s)
[501.452903] Starting dynamic subtest: vcs0
[501.478660] Dynamic subtest vcs0: SUCCESS (0.036s)
[501.489185] Starting dynamic subtest: vcs1
[501.514598] Dynamic subtest vcs1: SUCCESS (0.035s)
[501.528139] Starting dynamic subtest: vecs0
[501.546341] Dynamic subtest vecs0: SUCCESS (0.031s)
[501.561186] Starting dynamic subtest: ccs0
[501.574101] Dynamic subtest ccs0: SUCCESS (0.027s)
[501.576365] Subtest pi-ringfull: SUCCESS (0.217s)
[501.815513] [110/133] (527s left) kms_vblank (query-forked)
[501.906321] Starting subtest: query-forked
[501.908219] Starting dynamic subtest: pipe-A-eDP-1
[503.754521] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.847s)
[503.770535] Starting dynamic subtest: pipe-D-eDP-1
[506.293113] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[506.295509] Subtest query-forked: SUCCESS (4.389s)
[507.141703] [111/133] (522s left) kms_busy (extended-pageflip-hang-newfb)
[507.246270] Starting subtest: extended-pageflip-hang-newfb
[507.248529] Starting dynamic subtest: pipe-A
[535.122507] Dynamic subtest pipe-A: SUCCESS (27.874s)
[535.133064] Starting dynamic subtest: pipe-D
[560.085725] Dynamic subtest pipe-D: SUCCESS (24.957s)
[560.087886] Subtest extended-pageflip-hang-newfb: SUCCESS (52.836s)
[560.896410] [112/133] (468s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[561.004635] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[561.008955] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[561.106849] [113/133] (468s left) gem_lmem_swapping (parallel-random)
[561.150787] Subtest parallel-random: SKIP (0.000s)
[561.199940] [114/133] (468s left) gem_eio (wait-1us)
[561.389099] Starting subtest: wait-1us
[561.709460] Subtest wait-1us: SUCCESS (0.323s)
[561.828979] [115/133] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[561.931689] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[561.935476] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[562.045978] [116/133] (467s left) i915_drm_fdinfo (context-close-stress)
[562.088571] Starting subtest: context-close-stress
[572.835560] Subtest context-close-stress: SUCCESS (10.746s)
[572.924617] [117/133] (457s left) prime_vgem (busy)
[573.153754] Starting subtest: busy
[573.155793] Starting dynamic subtest: rcs0
[573.226636] Dynamic subtest rcs0: SUCCESS (0.074s)
[573.241614] Starting dynamic subtest: bcs0
[573.294097] Dynamic subtest bcs0: SUCCESS (0.067s)
[573.306863] Starting dynamic subtest: vcs0
[573.342347] Dynamic subtest vcs0: SUCCESS (0.045s)
[573.352643] Starting dynamic subtest: vcs1
[573.392340] Dynamic subtest vcs1: SUCCESS (0.049s)
[573.402522] Starting dynamic subtest: vecs0
[573.436700] Dynamic subtest vecs0: SUCCESS (0.043s)
[573.446962] Starting dynamic subtest: ccs0
[573.489340] Dynamic subtest ccs0: SUCCESS (0.052s)
[573.491506] Subtest busy: SUCCESS (0.339s)
[573.631607] [118/133] (456s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[573.729633] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[573.731974] Starting dynamic subtest: pipe-A-default-mode
[576.459948] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[576.462413] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.731s)
[577.308200] [119/133] (452s left) kms_cursor_legacy (torture-move)
[577.434550] Starting subtest: torture-move
[577.436698] Starting dynamic subtest: pipe-A
[583.604298] Dynamic subtest pipe-A: SUCCESS (6.166s)
[583.616993] Starting dynamic subtest: pipe-B
[589.986100] Dynamic subtest pipe-B: SUCCESS (6.379s)
[589.999568] Starting dynamic subtest: pipe-C
[596.934801] Dynamic subtest pipe-C: SUCCESS (6.946s)
[596.948694] Starting dynamic subtest: pipe-D
[603.828282] Dynamic subtest pipe-D: SUCCESS (6.891s)
[603.842077] Starting dynamic subtest: all-pipes
[610.568934] Dynamic subtest all-pipes: SUCCESS (6.740s)
[610.571467] Subtest torture-move: SUCCESS (33.133s)
[610.728980] [120/133] (419s left) gem_exec_schedule (deep)
[610.920566] Starting subtest: deep
[610.923196] Starting dynamic subtest: rcs0
[616.333041] Dynamic subtest rcs0: SKIP (5.410s)
[616.346580] Starting dynamic subtest: vcs0
[627.025535] Dynamic subtest vcs0: SUCCESS (10.692s)
[627.040936] Starting dynamic subtest: vcs1
[639.188720] Dynamic subtest vcs1: SUCCESS (12.162s)
[639.204807] Starting dynamic subtest: vecs0
[651.092507] Dynamic subtest vecs0: SUCCESS (11.902s)
[651.105718] Starting dynamic subtest: ccs0
[663.602116] Dynamic subtest ccs0: SUCCESS (12.507s)
[663.604582] Subtest deep: SUCCESS (52.679s)
[665.037534] [121/133] (365s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[665.140518] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[665.144850] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[665.271581] [122/133] (364s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[665.376607] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[665.381077] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[665.484519] [123/133] (364s left) gem_ppgtt (shrink-vs-evict-any)
[665.539115] Starting subtest: shrink-vs-evict-any
[672.322602] Subtest shrink-vs-evict-any: SUCCESS (6.776s)
[672.410336] [124/133] (357s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[672.511063] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[672.513297] Starting dynamic subtest: pipe-A-eDP-1
[672.522234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[672.533905] Starting dynamic subtest: pipe-B-eDP-1
[672.542916] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[672.554294] Starting dynamic subtest: pipe-C-eDP-1
[672.563040] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[672.573245] Starting dynamic subtest: pipe-D-eDP-1
[672.581892] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[672.586210] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[674.761420] [125/133] (355s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[675.159380] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[675.981653] [126/133] (354s left) kms_psr (fbc-psr-sprite-plane-onoff)
[676.073438] Starting subtest: fbc-psr-sprite-plane-onoff
[676.075341] Starting dynamic subtest: eDP-1
[676.079409] Dynamic subtest eDP-1: SKIP (0.000s)
[676.083630] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[676.162423] [127/133] (354s left) gem_ctx_engines (execute-oneforall)
[676.222137] Starting subtest: execute-oneforall
[676.874880] Subtest execute-oneforall: SUCCESS (0.651s)
[678.413877] [128/133] (352s left) perf_pmu (frequency)
[678.457663] Starting subtest: frequency
[678.459895] Starting dynamic subtest: gt0
[680.592212] Dynamic subtest gt0: SUCCESS (2.129s)
[680.605065] Starting dynamic subtest: idle-gt0
[681.096543] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[681.110166] Starting dynamic subtest: gt1
[685.299090] Dynamic subtest gt1: SUCCESS (4.198s)
[685.309731] Starting dynamic subtest: idle-gt1
[685.821822] Dynamic subtest idle-gt1: SUCCESS (0.522s)
[685.823967] Subtest frequency: SUCCESS (7.370s)
[685.932975] [129/133] (344s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[686.031377] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[690.454220] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.426s)
[691.602139] [130/133] (338s left) gem_exec_alignment (single)
[691.664836] Starting subtest: single
[691.667241] Subtest single: SUCCESS (0.002s)
[691.804685] [131/133] (338s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[691.896274] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[691.900221] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[692.006293] [132/133] (338s left) kms_panel_fitting (legacy)
[692.103834] Starting subtest: legacy
[692.106222] Starting dynamic subtest: pipe-A-eDP-1
[692.674757] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[692.702362] Starting dynamic subtest: pipe-B-eDP-1
[694.257514] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.563s)
[694.285581] Starting dynamic subtest: pipe-C-eDP-1
[695.780349] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[695.808661] Starting dynamic subtest: pipe-D-eDP-1
[697.279391] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s)
[697.281737] Subtest legacy: SUCCESS (5.181s)
[698.525293] [133/133] (332s left) kms_psr (pr-primary-mmap-cpu)
[698.618301] Starting subtest: pr-primary-mmap-cpu
[698.622382] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[698.688327] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: gem_ctx_persistence
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_dsc
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: i915_suspend
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_lease
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_pwrite_crc
results: parsing output: 43/ for test: gem_madvise
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gen3_render_linear_blits
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: gem_readwrite
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_partial_pwrite_pread
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_plane_lowres
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: i915_pm_rps
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_atomic_transition
results: parsing output: 78/ for test: gem_ctx_sseu
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: tools_test
results: parsing output: 83/ for test: gem_fence_thrash
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gen7_exec_parse
results: parsing output: 92/ for test: core_sysfs
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_chamelium_frames
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: syncobj_eventfd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_tiled_display
results: parsing output: 100/ for test: gem_exec_flush
results: parsing output: 101/ for test: syncobj_basic
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: gem_pread
results: parsing output: 107/ for test: kms_pipe_crc_basic
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_busy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ppgtt
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_ctx_engines
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_alignment
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_panel_fitting
results: parsing output: 132/ for test: kms_psr
Done.