[57.301052] Initializing watchdogs
[57.301103]   /dev/watchdog0
[57.315220] [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.319532] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.321697] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.324997] [001/133] (960s left) kms_lease (possible-crtcs-filtering)
[57.438635] Starting subtest: possible-crtcs-filtering
[57.442799] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[57.555882] [002/133] (960s left) kms_psr (fbc-psr2-primary-blt)
[57.644458] Starting subtest: fbc-psr2-primary-blt
[57.646595] Starting dynamic subtest: eDP-1
[57.650697] Dynamic subtest eDP-1: SKIP (0.000s)
[57.654787] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[57.726335] [003/133] (960s left) syncobj_wait (invalid-wait-illegal-handle)
[57.794084] Starting subtest: invalid-wait-illegal-handle
[57.796340] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[57.908946] [004/133] (960s left) kms_psr (fbc-psr-no-drrs)
[58.000118] Starting subtest: fbc-psr-no-drrs
[58.002048] Starting dynamic subtest: eDP-1
[58.006095] Dynamic subtest eDP-1: SKIP (0.000s)
[58.010264] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[58.067209] [005/133] (959s left) prime_busy (before-wait)
[58.127464] Starting subtest: before-wait
[58.129412] Starting dynamic subtest: rcs0
[58.154583] Dynamic subtest rcs0: SUCCESS (0.026s)
[58.160909] Starting dynamic subtest: bcs0
[58.202268] Dynamic subtest bcs0: SUCCESS (0.047s)
[58.209802] Starting dynamic subtest: vcs0
[58.240129] Dynamic subtest vcs0: SUCCESS (0.038s)
[58.246483] Starting dynamic subtest: vcs1
[58.278885] Dynamic subtest vcs1: SUCCESS (0.039s)
[58.285298] Starting dynamic subtest: vecs0
[58.318579] Dynamic subtest vecs0: SUCCESS (0.039s)
[58.325070] Starting dynamic subtest: ccs0
[58.358356] Dynamic subtest ccs0: SUCCESS (0.038s)
[58.466673] Subtest before-wait: SUCCESS (0.340s)
[58.537544] [006/133] (959s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[58.636069] Starting subtest: sprite-rotation-90-pos-100-0
[58.640359] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[58.718578] [007/133] (959s left) gem_exec_balancer (full-late-pulse)
[58.785667] Starting subtest: full-late-pulse
[63.831649] Subtest full-late-pulse: SUCCESS (5.050s)
[64.152977] [008/133] (953s left) gem_ctx_persistence (engines-mixed-process)
[64.201728] Starting subtest: engines-mixed-process
[64.203913] Starting dynamic subtest: rcs0
[65.867139] Dynamic subtest rcs0: SUCCESS (1.668s)
[65.876445] Starting dynamic subtest: bcs0
[67.845326] Dynamic subtest bcs0: SUCCESS (1.978s)
[67.855335] Starting dynamic subtest: vcs0
[69.926833] Dynamic subtest vcs0: SUCCESS (2.084s)
[69.937028] Starting dynamic subtest: vcs1
[71.924116] Dynamic subtest vcs1: SUCCESS (1.995s)
[71.933290] Starting dynamic subtest: vecs0
[73.893294] Dynamic subtest vecs0: SUCCESS (1.970s)
[73.901690] Starting dynamic subtest: ccs0
[75.927080] Dynamic subtest ccs0: SUCCESS (2.034s)
[75.929578] Subtest engines-mixed-process: SUCCESS (11.733s)
[76.004321] [009/133] (942s left) gem_lmem_swapping (verify)
[76.048688] Subtest verify: SKIP (0.000s)
[76.109465] [010/133] (942s left) vgem_basic (sysfs)
[76.178807] Starting subtest: sysfs
[76.181339] Subtest sysfs: SUCCESS (0.001s)
[76.233997] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[76.236944] [011/133] (941s left) kms_atomic (test-only)
[76.329871] Starting subtest: test-only
[76.426754] Starting dynamic subtest: pipe-A-eDP-1
[78.893737] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.468s)
[78.896081] Subtest test-only: SUCCESS (2.564s)
[79.700297] [012/133] (938s left) kms_flip (plain-flip-ts-check)
[79.795165] Starting subtest: plain-flip-ts-check
[79.797452] Starting dynamic subtest: A-eDP1
[88.686879] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[88.697350] Starting dynamic subtest: B-eDP1
[97.615671] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[97.626989] Starting dynamic subtest: C-eDP1
[106.536088] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[106.544281] Starting dynamic subtest: D-eDP1
[115.354560] Dynamic subtest D-eDP1: SUCCESS (8.815s)
[115.356522] Subtest plain-flip-ts-check: SUCCESS (35.568s)
[116.541364] [013/133] (901s left) gem_ctx_shared (single-timeline)
[116.608104] Starting subtest: single-timeline
[116.629742] Subtest single-timeline: SUCCESS (0.014s)
[116.860837] [014/133] (901s left) gem_watchdog (default-virtual)
[116.927680] Starting subtest: default-virtual
[123.205197] Subtest default-virtual: SUCCESS (6.286s)
[123.288796] [015/133] (895s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[123.382124] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[123.384537] Starting dynamic subtest: pipe-A-eDP-1
[124.266778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s)
[124.274651] Starting dynamic subtest: pipe-B-eDP-1
[125.872067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.601s)
[125.882700] Starting dynamic subtest: pipe-C-eDP-1
[127.403405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[127.413227] Starting dynamic subtest: pipe-D-eDP-1
[128.970450] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s)
[128.972744] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.579s)
[130.178073] [016/133] (888s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[130.290959] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[130.295446] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[130.357255] [017/133] (888s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[130.451250] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[130.455188] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[130.522256] [018/133] (887s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[130.627727] Starting subtest: y-tiled-64bpp-rotate-180
[130.632326] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[130.719453] [019/133] (887s left) gem_mmap_gtt (basic-small-copy-xy)
[130.787901] Subtest basic-small-copy-XY: SKIP (0.000s)
[130.850359] [020/133] (887s left) gem_exec_schedule (pi-shared-iova)
[131.039650] Starting subtest: pi-shared-iova
[131.042040] Starting dynamic subtest: rcs0
[131.116219] Dynamic subtest rcs0: SUCCESS (0.078s)
[131.127285] Starting dynamic subtest: vcs0
[131.171648] Dynamic subtest vcs0: SUCCESS (0.056s)
[131.181608] Starting dynamic subtest: vcs1
[131.225930] Dynamic subtest vcs1: SUCCESS (0.054s)
[131.235913] Starting dynamic subtest: vecs0
[131.280720] Dynamic subtest vecs0: SUCCESS (0.054s)
[131.291241] Starting dynamic subtest: ccs0
[131.339989] Dynamic subtest ccs0: SUCCESS (0.059s)
[131.342460] Subtest pi-shared-iova: SUCCESS (0.303s)
[132.974231] [021/133] (885s left) gem_spin_batch (spin-all-new)
[133.024832] Starting subtest: spin-all-new
[133.042212] Subtest spin-all-new: SUCCESS (0.017s)
[134.909861] [022/133] (883s left) gem_exec_schedule (fifo)
[134.992904] Starting subtest: fifo
[134.995332] Starting dynamic subtest: rcs0
[135.161614] Dynamic subtest rcs0: SUCCESS (0.176s)
[135.172762] Starting dynamic subtest: vcs0
[135.257572] Dynamic subtest vcs0: SUCCESS (0.097s)
[135.268713] Starting dynamic subtest: vcs1
[135.370723] Dynamic subtest vcs1: SUCCESS (0.113s)
[135.382097] Starting dynamic subtest: vecs0
[135.481636] Dynamic subtest vecs0: SUCCESS (0.109s)
[135.490867] Starting dynamic subtest: ccs0
[135.620901] Dynamic subtest ccs0: SUCCESS (0.139s)
[135.623759] Subtest fifo: SUCCESS (0.636s)
[137.010135] [023/133] (881s left) kms_busy (basic)
[137.127973] Starting subtest: basic
[137.130321] Starting dynamic subtest: flip
[137.722248] Dynamic subtest flip: SUCCESS (0.594s)
[137.730933] Starting dynamic subtest: modeset
[141.356060] Dynamic subtest modeset: SUCCESS (3.633s)
[141.358808] Subtest basic: SUCCESS (4.229s)
[142.152837] [024/133] (876s left) kms_pm_rpm (i2c)
[143.993196] Starting subtest: i2c
[149.332097] Subtest i2c: SUCCESS (5.338s)
[149.452752] [025/133] (869s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[149.554131] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[156.409327] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.857s)
[156.570060] [026/133] (862s left) gem_ctx_persistence (heartbeat-hang)
[156.635814] Starting subtest: heartbeat-hang
[156.640313] Subtest heartbeat-hang: SKIP (0.000s)
[156.738624] [027/133] (862s left) gen9_exec_parse (batch-zero-length)
[156.817928] Subtest batch-zero-length: SKIP (0.000s)
[156.894744] [028/133] (862s left) gem_userptr_blits (create-destroy-sync)
[156.968973] Starting subtest: create-destroy-sync
[161.993275] Subtest create-destroy-sync: SUCCESS (5.023s)
[162.123780] [029/133] (856s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[162.239453] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[171.710425] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.470s)
[171.832604] [030/133] (847s left) gem_exec_schedule (reorder-wide)
[172.012735] Subtest reorder-wide: SKIP (0.000s)
[172.197567] [031/133] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[172.296204] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[179.664273] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.370s)
[179.822210] [032/133] (839s left) gem_workarounds (suspend-resume-context)
[179.907079] Starting subtest: suspend-resume-context
[195.927651] Subtest suspend-resume-context: SUCCESS (1.287s)
[196.079472] [033/133] (823s left) gem_ctx_engines (none)
[196.157764] Starting subtest: none
[196.160159] Subtest none: SUCCESS (0.002s)
[196.343286] [034/133] (822s left) gem_exec_fence (submit)
[196.526709] Starting subtest: submit
[196.531180] Subtest submit: SKIP (0.000s)
[198.695949] [035/133] (820s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[198.812294] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[198.816420] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[198.877313] [036/133] (820s left) core_debugfs (read-all-entries)
[198.935772] Starting subtest: read-all-entries
[199.029398] Subtest read-all-entries: SUCCESS (0.094s)
[199.110341] [037/133] (820s left) gem_mmap_gtt (basic-write)
[199.184070] Subtest basic-write: SKIP (0.000s)
[199.244887] [038/133] (820s left) i915_suspend (fence-restore-tiled2untiled)
[199.307598] Starting subtest: fence-restore-tiled2untiled
[199.312343] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[199.429781] [039/133] (819s left) sysfs_heartbeat_interval (nopreempt)
[199.506586] Starting subtest: nopreempt
[199.508509] Starting dynamic subtest: vecs0
[208.677377] Dynamic subtest vecs0: SUCCESS (9.185s)
[208.690227] Starting dynamic subtest: ccs0
[212.667267] Dynamic subtest ccs0: SUCCESS (3.994s)
[212.679134] Starting dynamic subtest: vcs0
[222.622882] Dynamic subtest vcs0: SUCCESS (9.958s)
[222.633337] Starting dynamic subtest: bcs0
[226.618879] Dynamic subtest bcs0: SUCCESS (3.998s)
[226.629242] Starting dynamic subtest: rcs0
[230.694837] Dynamic subtest rcs0: SUCCESS (4.075s)
[230.706924] Starting dynamic subtest: vcs1
[240.672218] Dynamic subtest vcs1: SUCCESS (9.976s)
[240.674696] Subtest nopreempt: SUCCESS (41.194s)
[240.750484] [040/133] (778s left) kms_flip (2x-flip-vs-expired-vblank)
[240.857548] Starting subtest: 2x-flip-vs-expired-vblank
[240.869033] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[240.950146] [041/133] (778s left) i915_pm_rps (reset)
[241.008943] Starting subtest: reset
[249.458153] Subtest reset: SUCCESS (8.447s)
[249.573207] [042/133] (769s left) syncobj_eventfd (timeline-wait-before-signal)
[249.624451] Starting subtest: timeline-wait-before-signal
[249.655644] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[249.737543] [043/133] (769s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[249.786595] Starting subtest: multi-wait-for-submit-available-submitted
[249.788926] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[249.883460] [044/133] (769s left) fbdev (unaligned-write)
[249.922562] Starting subtest: unaligned-write
[250.033556] Subtest unaligned-write: SUCCESS (0.111s)
[250.101584] [045/133] (769s left) kms_addfb_basic (bad-pitch-1024)
[250.161911] Starting subtest: bad-pitch-1024
[250.163730] Subtest bad-pitch-1024: SUCCESS (0.000s)
[250.322404] [046/133] (769s left) kms_cursor_crc (cursor-random-256x256)
[250.577155] Starting subtest: cursor-random-256x256
[250.581263] Starting dynamic subtest: pipe-A-eDP-1
[253.973108] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.392s)
[254.013297] Starting dynamic subtest: pipe-D-eDP-1
[257.959022] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.957s)
[257.961172] Subtest cursor-random-256x256: SUCCESS (7.382s)
[258.803282] [047/133] (760s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[258.903485] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[258.905694] Starting dynamic subtest: pipe-A-eDP-1
[258.930573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.941089] Starting dynamic subtest: pipe-B-eDP-1
[258.965289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.975609] Starting dynamic subtest: pipe-C-eDP-1
[258.998111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.007151] Starting dynamic subtest: pipe-D-eDP-1
[259.029973] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.034061] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[261.162573] [048/133] (758s left) syncobj_basic (bad-flags-handle-to-fd)
[261.216276] Starting subtest: bad-flags-handle-to-fd
[261.218570] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[261.335579] [049/133] (758s left) kms_chamelium_color (gamma)
[261.422623] Subtest gamma: SKIP (0.000s)
[261.471971] [050/133] (758s left) kms_invalid_mode (bad-hsync-start)
[261.574769] Starting subtest: bad-hsync-start
[261.577048] Starting dynamic subtest: pipe-A-eDP-1
[261.860030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[261.870539] Starting dynamic subtest: pipe-B-eDP-1
[261.872571] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[261.882204] Starting dynamic subtest: pipe-C-eDP-1
[261.884713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[261.893763] Starting dynamic subtest: pipe-D-eDP-1
[261.895682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[261.897618] Subtest bad-hsync-start: SUCCESS (0.293s)
[262.686372] [051/133] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[262.782082] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[262.786392] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[262.885758] [052/133] (757s left) kms_flip (flip-vs-panning-interruptible)
[262.976494] Starting subtest: flip-vs-panning-interruptible
[262.978747] Starting dynamic subtest: A-eDP1
[271.688507] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[271.699472] Starting dynamic subtest: B-eDP1
[280.422388] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[280.435303] Starting dynamic subtest: C-eDP1
[289.146565] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[289.159099] Starting dynamic subtest: D-eDP1
[297.870863] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[297.875395] Subtest flip-vs-panning-interruptible: SUCCESS (34.906s)
[299.040302] [053/133] (720s left) kms_pm_lpsp (kms-lpsp)
[300.148796] Starting subtest: kms-lpsp
[300.151062] Starting dynamic subtest: pipe-A-eDP-1
[300.320928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.172s)
[300.617889] Subtest kms-lpsp: SUCCESS (0.469s)
[301.479234] [054/133] (718s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[301.576922] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[301.581402] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[301.709630] [055/133] (718s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[301.810625] Starting subtest: psr-rgb101010-draw-mmap-cpu
[308.883373] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.075s)
[308.997066] [056/133] (711s left) gem_exec_params (invalid-bsd2-flag-on-render)
[309.060954] Starting subtest: invalid-bsd2-flag-on-render
[309.063147] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[309.173688] [057/133] (710s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[309.245046] Starting subtest: mixed-tiled-to-y-tiled-ccs
[309.249238] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[309.431263] [058/133] (710s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[309.523703] Starting subtest: bad-pixel-format-y-tiled-ccs
[309.525985] Starting dynamic subtest: pipe-A-eDP-1
[309.548363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.560031] Starting dynamic subtest: pipe-B-eDP-1
[309.581311] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.590979] Starting dynamic subtest: pipe-C-eDP-1
[309.613111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.623487] Starting dynamic subtest: pipe-D-eDP-1
[309.645305] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.649852] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.006s)
[311.679665] [059/133] (708s left) perf (gen12-invalid-class-instance)
[311.818541] Starting subtest: gen12-invalid-class-instance
[311.828468] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[311.881208] [060/133] (708s left) kms_pipe_crc_basic (suspend-read-crc)
[311.982526] Starting subtest: suspend-read-crc
[311.984735] Starting dynamic subtest: pipe-A-eDP-1
[329.818147] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.570s)
[329.832685] Starting dynamic subtest: pipe-B-eDP-1
[347.833254] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s)
[347.844012] Starting dynamic subtest: pipe-C-eDP-1
[365.781572] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.109s)
[365.792985] Starting dynamic subtest: pipe-D-eDP-1
[383.784845] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.057s)
[383.787207] Subtest suspend-read-crc: SUCCESS (11.995s)
[384.604011] [061/133] (635s left) gem_eio (wait-wedge-1us)
[384.850132] Starting subtest: wait-wedge-1us
[386.543076] Subtest wait-wedge-1us: SUCCESS (1.695s)
[386.663367] [062/133] (633s left) kms_pipe_crc_basic (bad-source)
[386.755026] Starting subtest: bad-source
[386.757251] Subtest bad-source: SUCCESS (0.000s)
[386.841971] [063/133] (633s left) kms_vblank (ts-continuation-dpms-rpm)
[386.933212] Starting subtest: ts-continuation-dpms-rpm
[386.935509] Starting dynamic subtest: pipe-A-eDP-1
[389.479980] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.550s)
[389.494935] Starting dynamic subtest: pipe-D-eDP-1
[391.729248] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s)
[391.731577] Subtest ts-continuation-dpms-rpm: SUCCESS (4.804s)
[392.525268] [064/133] (627s left) syncobj_timeline (invalid-wait-illegal-handle)
[392.589792] Starting subtest: invalid-wait-illegal-handle
[392.592212] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[392.680179] [065/133] (627s left) kms_big_fb (linear-64bpp-rotate-270)
[392.781132] Starting subtest: linear-64bpp-rotate-270
[392.802432] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[392.918641] [066/133] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[393.010750] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[399.648256] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.646s)
[399.774520] [067/133] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[399.870854] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[404.372719] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.508s)
[405.550789] [068/133] (615s left) gem_pread (self)
[405.624454] Subtest self: SKIP (0.000s)
[405.689995] [069/133] (614s left) kms_universal_plane (universal-plane-sanity)
[405.775524] Starting subtest: universal-plane-sanity
[405.777897] Starting dynamic subtest: pipe-A-eDP-1
[406.380396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[406.390954] Starting dynamic subtest: pipe-B-eDP-1
[407.575969] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[407.587270] Starting dynamic subtest: pipe-C-eDP-1
[408.788708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[408.799953] Starting dynamic subtest: pipe-D-eDP-1
[410.017991] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[410.020229] Subtest universal-plane-sanity: SUCCESS (4.243s)
[410.876312] [070/133] (609s left) kms_cursor_crc (cursor-alpha-opaque)
[410.987648] Starting subtest: cursor-alpha-opaque
[410.989951] Starting dynamic subtest: pipe-A-eDP-1
[411.638252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.650s)
[411.649056] Starting dynamic subtest: pipe-D-eDP-1
[412.876339] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[412.878684] Subtest cursor-alpha-opaque: SUCCESS (1.893s)
[413.687114] [071/133] (607s left) syncobj_timeline (wait-all-delayed-signal)
[413.756512] Starting subtest: wait-all-delayed-signal
[413.858495] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[413.936738] [072/133] (606s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[414.024949] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[414.027090] Starting dynamic subtest: pipe-A
[414.046392] Dynamic subtest pipe-A: SKIP (0.018s)
[414.056426] Starting dynamic subtest: pipe-B
[414.081514] Dynamic subtest pipe-B: SKIP (0.035s)
[414.091318] Starting dynamic subtest: pipe-C
[414.115914] Dynamic subtest pipe-C: SKIP (0.033s)
[414.125594] Starting dynamic subtest: pipe-D
[414.150371] Dynamic subtest pipe-D: SKIP (0.033s)
[414.153995] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.123s)
[414.302250] [073/133] (606s left) kms_plane (plane-panning-top-left)
[414.393413] Starting subtest: plane-panning-top-left
[414.395603] Starting dynamic subtest: pipe-A
[416.076682] Dynamic subtest pipe-A: SUCCESS (1.683s)
[416.087736] Starting dynamic subtest: pipe-B
[418.500049] Dynamic subtest pipe-B: SUCCESS (2.420s)
[418.502395] Subtest plane-panning-top-left: SUCCESS (4.106s)
[419.326025] [074/133] (601s left) gem_gpgpu_fill (offset-16x16)
[419.389820] Starting subtest: offset-16x16
[419.395523] Subtest offset-16x16: SUCCESS (0.008s)
[419.545985] [075/133] (601s left) gem_exec_flush (basic-wb-prw-default)
[419.612665] Starting subtest: basic-wb-prw-default
[425.078387] Subtest basic-wb-prw-default: SUCCESS (5.467s)
[425.275350] [076/133] (595s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[425.384535] Starting subtest: 4-tiled-64bpp-rotate-270
[425.405407] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[425.528365] [077/133] (595s left) kms_setmode (invalid-clone-single-crtc-stealing)
[425.577013] Starting subtest: invalid-clone-single-crtc-stealing
[425.583332] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[425.670210] [078/133] (595s left) drm_read (short-buffer-block)
[425.810043] Starting subtest: short-buffer-block
[425.812366] Subtest short-buffer-block: SUCCESS (0.000s)
[425.936880] [079/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[426.046882] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[426.051201] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[426.141578] [080/133] (595s left) perf_pmu (pmu-read)
[426.178109] Starting subtest: pmu-read
[426.183817] Subtest pmu-read: SUCCESS (0.003s)
[426.290337] [081/133] (594s left) kms_cursor_edge_walk (256x256-right-edge)
[426.387730] Starting subtest: 256x256-right-edge
[426.389905] Starting dynamic subtest: pipe-A-eDP-1
[429.893117] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[429.904254] Starting dynamic subtest: pipe-D-eDP-1
[433.007385] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[433.009625] Subtest 256x256-right-edge: SUCCESS (6.620s)
[433.815900] [082/133] (587s left) i915_getparams_basic (basic-subslice-total)
[433.866886] Starting subtest: basic-subslice-total
[433.870943] Subtest basic-subslice-total: SUCCESS (0.000s)
[433.977413] [083/133] (587s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[434.068538] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[434.072592] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[434.178729] [084/133] (587s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[434.274869] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[434.277040] Starting dynamic subtest: pipe-A-default-mode
[437.056345] Dynamic subtest pipe-A-default-mode: SUCCESS (2.780s)
[437.058661] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.783s)
[437.919993] [085/133] (583s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[437.980906] Starting subtest: y-tiled-to-vebox-y-tiled
[437.985341] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[438.179427] [086/133] (583s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[438.291447] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[438.316789] Starting dynamic subtest: pipe-A-plane-0
[438.616396] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[438.628211] Starting dynamic subtest: pipe-A-plane-3
[438.852457] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[439.917369] Starting dynamic subtest: pipe-B-plane-0
[440.209115] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[440.220241] Starting dynamic subtest: pipe-B-plane-3
[440.442556] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[440.759864] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.469s)
[441.595203] [087/133] (579s left) gem_exec_schedule (u-submit-golden-slice)
[441.661623] Starting subtest: u-submit-golden-slice
[441.663653] Starting dynamic subtest: rcs0
[441.688468] Dynamic subtest rcs0: SUCCESS (0.035s)
[441.698730] Starting dynamic subtest: bcs0
[441.736617] Dynamic subtest bcs0: SUCCESS (0.047s)
[441.747592] Starting dynamic subtest: vcs0
[441.774029] Dynamic subtest vcs0: SUCCESS (0.036s)
[441.784939] Starting dynamic subtest: vcs1
[441.810108] Dynamic subtest vcs1: SUCCESS (0.035s)
[441.819759] Starting dynamic subtest: vecs0
[441.846335] Dynamic subtest vecs0: SUCCESS (0.035s)
[441.855974] Starting dynamic subtest: ccs0
[441.880194] Dynamic subtest ccs0: SUCCESS (0.033s)
[441.882339] Subtest u-submit-golden-slice: SUCCESS (0.228s)
[443.550869] [088/133] (577s left) kms_cursor_legacy (single-move)
[443.679595] Starting subtest: single-move
[443.681804] Starting dynamic subtest: pipe-A
[449.060608] Dynamic subtest pipe-A: SUCCESS (5.380s)
[449.072753] Starting dynamic subtest: pipe-B
[454.440603] Dynamic subtest pipe-B: SUCCESS (5.379s)
[454.452444] Starting dynamic subtest: pipe-C
[459.819962] Dynamic subtest pipe-C: SUCCESS (5.379s)
[459.831906] Starting dynamic subtest: pipe-D
[465.199661] Dynamic subtest pipe-D: SUCCESS (5.379s)
[465.211879] Starting dynamic subtest: all-pipes
[470.585458] Dynamic subtest all-pipes: SUCCESS (5.386s)
[470.587971] Subtest single-move: SUCCESS (26.915s)
[470.730725] [089/133] (550s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[470.823429] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[470.827313] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[470.927851] [090/133] (550s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[471.027182] Starting subtest: multiplane-rotation-cropping-bottom
[488.464529] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.438s)
[488.569146] [091/133] (533s left) gem_exec_endless (dispatch)
[488.643269] Starting subtest: dispatch
[488.645267] Starting dynamic subtest: rcs0
[488.651723] Dynamic subtest rcs0: SUCCESS (0.005s)
[488.664104] Starting dynamic subtest: bcs0
[488.668101] Dynamic subtest bcs0: SUCCESS (0.004s)
[488.679277] Starting dynamic subtest: vcs0
[488.682625] Dynamic subtest vcs0: SUCCESS (0.004s)
[488.691904] Starting dynamic subtest: vcs1
[488.695338] Dynamic subtest vcs1: SUCCESS (0.005s)
[488.704575] Starting dynamic subtest: vecs0
[488.707979] Dynamic subtest vecs0: SUCCESS (0.004s)
[488.717010] Starting dynamic subtest: ccs0
[488.720414] Dynamic subtest ccs0: SUCCESS (0.005s)
[488.721979] Subtest dispatch: SUCCESS (0.032s)
[490.502215] [092/133] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[490.615968] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[490.620382] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[490.722044] [093/133] (530s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[491.136623] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[491.991586] [094/133] (529s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[492.086101] Starting subtest: fbc-pr-cursor-mmap-cpu
[492.090271] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[492.165036] [095/133] (529s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[492.288706] Starting subtest: basic-flip-after-cursor-legacy
[493.222903] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.932s)
[494.041418] [096/133] (527s left) kms_color (invalid-gamma-lut-sizes)
[494.135228] Starting subtest: invalid-gamma-lut-sizes
[494.137710] Starting dynamic subtest: pipe-A
[494.424607] Dynamic subtest pipe-A: SUCCESS (0.290s)
[494.435097] Starting dynamic subtest: pipe-B
[494.437428] Dynamic subtest pipe-B: SUCCESS (0.000s)
[494.447429] Starting dynamic subtest: pipe-C
[494.449710] Dynamic subtest pipe-C: SUCCESS (0.000s)
[494.466901] Starting dynamic subtest: pipe-D
[494.469307] Dynamic subtest pipe-D: SUCCESS (0.000s)
[494.471611] Subtest invalid-gamma-lut-sizes: SUCCESS (0.294s)
[495.272762] [097/133] (526s left) api_intel_bb (blit-reloc-purge-cache)
[495.331385] Starting subtest: blit-reloc-purge-cache
[495.335920] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[495.446344] [098/133] (526s left) gem_ctx_create (basic)
[495.508858] Starting subtest: basic
[495.511342] Subtest basic: SUCCESS (0.000s)
[495.705039] [099/133] (526s left) gem_fence_thrash (bo-write-verify-threaded-y)
[495.746353] Starting subtest: bo-write-verify-threaded-y
[495.770999] Subtest bo-write-verify-threaded-y: SKIP (0.021s)
[495.836319] [100/133] (526s left) core_getversion (basic)
[495.878909] Starting subtest: basic
[495.883388] Subtest basic: SUCCESS (0.000s)
[495.939024] [101/133] (526s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[496.041514] Starting subtest: yf-tiled-32bpp-rotate-270
[496.045959] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[496.142702] [102/133] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[496.236742] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[496.240872] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[496.325147] [103/133] (525s left) gem_mmap_gtt (big-copy-odd)
[496.390956] Subtest big-copy-odd: SKIP (0.000s)
[496.457362] [104/133] (525s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[496.558722] Starting subtest: fbc-rgb565-draw-render
[500.765623] Subtest fbc-rgb565-draw-render: SUCCESS (4.207s)
[501.915462] [105/133] (520s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[502.021261] Starting subtest: async-flip-with-page-flip-events-tiled
[502.410293] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[505.161646] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.749s)
[505.175222] Starting dynamic subtest: pipe-A-eDP-1-4
[507.348200] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[507.361095] Starting dynamic subtest: pipe-A-eDP-1-4
[509.357725] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[509.367407] Starting dynamic subtest: pipe-A-eDP-1-x
[511.593195] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.233s)
[511.965377] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[514.685715] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.726s)
[514.696212] Starting dynamic subtest: pipe-B-eDP-1-4
[516.871693] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[516.884730] Starting dynamic subtest: pipe-B-eDP-1-4
[518.881677] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[518.892678] Starting dynamic subtest: pipe-B-eDP-1-x
[521.071333] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[521.436131] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[524.218521] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.789s)
[524.232377] Starting dynamic subtest: pipe-C-eDP-1-4
[526.393103] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[526.406058] Starting dynamic subtest: pipe-C-eDP-1-4
[528.403059] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[528.413990] Starting dynamic subtest: pipe-C-eDP-1-x
[530.581560] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[530.963477] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[533.742448] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[533.756282] Starting dynamic subtest: pipe-D-eDP-1-4
[535.916223] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[535.928858] Starting dynamic subtest: pipe-D-eDP-1-4
[537.925282] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[537.938644] Starting dynamic subtest: pipe-D-eDP-1-x
[540.137170] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.211s)
[540.139628] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.118s)
[541.316755] [106/133] (480s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[541.417862] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[541.421932] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[541.513999] [107/133] (480s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[541.614182] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[541.616178] Starting dynamic subtest: pipe-A-eDP-1
[542.367994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[542.380072] Starting dynamic subtest: pipe-B-eDP-1
[544.160276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.792s)
[544.170093] Starting dynamic subtest: pipe-C-eDP-1
[545.996608] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s)
[546.007342] Starting dynamic subtest: pipe-D-eDP-1
[547.851676] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.854s)
[547.853675] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.234s)
[549.062691] [108/133] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[549.178217] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[552.768801] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.596s)
[553.966726] [109/133] (468s left) gem_exec_reloc (basic-write-read-noreloc)
[554.030500] Subtest basic-write-read-noreloc: SKIP (0.000s)
[554.110736] [110/133] (468s left) kms_psr (psr2-sprite-plane-onoff)
[554.206674] Starting subtest: psr2-sprite-plane-onoff
[554.208968] Starting dynamic subtest: eDP-1
[556.001127] Dynamic subtest eDP-1: SUCCESS (1.793s)
[556.003122] Subtest psr2-sprite-plane-onoff: SUCCESS (1.795s)
[556.843407] [111/133] (465s left) kms_dsc (dsc-basic)
[556.944578] Starting subtest: dsc-basic
[556.957452] Subtest dsc-basic: SKIP (0.000s)
[557.018964] [112/133] (465s left) i915_drm_fdinfo (memory-info-purgeable)
[557.059879] Starting subtest: memory-info-purgeable
[557.061876] Starting dynamic subtest: smem0
[559.789263] Dynamic subtest smem0: SUCCESS (2.732s)
[559.791763] Subtest memory-info-purgeable: SUCCESS (2.733s)
[559.866544] [113/133] (462s left) gem_mmap_gtt (hang-user)
[559.932649] Subtest hang-user: SKIP (0.000s)
[559.996833] [114/133] (462s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[560.098005] Starting subtest: x-tiled-32bpp-rotate-0
[561.521857] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.423s)
[561.657114] [115/133] (461s left) gem_fence_thrash (bo-write-verify-none)
[561.697743] Starting subtest: bo-write-verify-none
[561.711954] Subtest bo-write-verify-none: SKIP (0.014s)
[561.772309] [116/133] (460s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[561.831364] Starting subtest: single-wait-for-submit-unsubmitted
[561.938129] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[562.027799] [117/133] (460s left) gem_exec_params (invalid-ring)
[562.083556] Starting subtest: invalid-ring
[562.085981] Subtest invalid-ring: SUCCESS (0.000s)
[562.186640] [118/133] (460s left) kms_psr (pr-sprite-mmap-cpu)
[562.274955] Starting subtest: pr-sprite-mmap-cpu
[562.279250] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[562.349006] [119/133] (460s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[562.402970] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[562.505494] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[562.596208] [120/133] (460s left) gen3_render_tiledx_blits
[562.713581] [121/133] (460s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[562.810013] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[566.390096] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.586s)
[567.532406] [122/133] (455s left) gem_mmap_gtt (coherency)
[567.591440] Subtest coherency: SKIP (0.000s)
[567.657477] [123/133] (455s left) syncobj_basic (bad-handle-to-fd)
[567.719994] Starting subtest: bad-handle-to-fd
[567.722182] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[567.818590] [124/133] (455s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[567.913356] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[567.915630] Starting dynamic subtest: pipe-A-eDP-1
[567.935935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[567.947939] Starting dynamic subtest: pipe-B-eDP-1
[567.968223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[567.979395] Starting dynamic subtest: pipe-C-eDP-1
[567.998374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[568.007320] Starting dynamic subtest: pipe-D-eDP-1
[568.026412] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[568.028284] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[570.176645] [125/133] (452s left) kms_flip (plain-flip-interruptible)
[570.281229] Starting subtest: plain-flip-interruptible
[570.283687] Starting dynamic subtest: A-eDP1
[571.990755] Dynamic subtest A-eDP1: SUCCESS (1.709s)
[572.003898] Starting dynamic subtest: B-eDP1
[573.617983] Dynamic subtest B-eDP1: SUCCESS (1.625s)
[573.630119] Starting dynamic subtest: C-eDP1
[575.245852] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[575.256026] Starting dynamic subtest: D-eDP1
[576.868143] Dynamic subtest D-eDP1: SUCCESS (1.622s)
[576.873086] Subtest plain-flip-interruptible: SUCCESS (6.595s)
[578.034786] [126/133] (445s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[578.141532] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[578.145853] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[578.239077] [127/133] (444s left) syncobj_wait (wait-all-delayed-signal)
[578.291911] Starting subtest: wait-all-delayed-signal
[578.393996] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[578.487790] [128/133] (444s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[578.586873] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[582.817440] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.235s)
[583.942993] [129/133] (439s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[584.043538] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[584.047949] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[584.115771] [130/133] (439s left) kms_content_protection (lic-type-0-hdcp14)
[584.257937] Starting subtest: lic-type-0-hdcp14
[584.262454] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[584.424775] [131/133] (438s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[584.518879] Starting subtest: psr-shrfb-scaledprimary
[590.317719] Subtest psr-shrfb-scaledprimary: SUCCESS (5.803s)
[590.450029] [132/133] (432s left) gem_eio (in-flight-internal-1us)
[590.682223] Starting subtest: in-flight-internal-1us
[592.554507] Subtest in-flight-internal-1us: SUCCESS (1.872s)
[592.698641] [133/133] (430s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[592.803739] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[592.807850] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[592.901188] Closing watchdogs
results: parsing output: 0/ for test: kms_lease
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: prime_busy
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: gem_ctx_persistence
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: vgem_basic
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_ctx_shared
results: parsing output: 13/ for test: gem_watchdog
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: gem_spin_batch
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_busy
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gen9_exec_parse
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_workarounds
results: parsing output: 32/ for test: gem_ctx_engines
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: core_debugfs
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: sysfs_heartbeat_interval
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: syncobj_eventfd
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: fbdev
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: syncobj_basic
results: parsing output: 48/ for test: kms_chamelium_color
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_pm_lpsp
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_pipe_crc_basic
results: parsing output: 60/ for test: gem_eio
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_vblank
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_pread
results: parsing output: 68/ for test: kms_universal_plane
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: gem_gpgpu_fill
results: parsing output: 74/ for test: gem_exec_flush
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_setmode
results: parsing output: 77/ for test: drm_read
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_cursor_edge_walk
results: parsing output: 81/ for test: i915_getparams_basic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: gem_exec_endless
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: gem_ctx_create
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: core_getversion
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_dsc
results: parsing output: 111/ for test: i915_drm_fdinfo
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_fence_thrash
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gen3_render_tiledx_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: syncobj_basic
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_eio
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.