[60.907958] Initializing watchdogs
[60.908016]   /dev/watchdog0
[60.922680] [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]
[60.927533] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.929805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.933199] [001/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[61.060058] Starting subtest: x-tiled-8bpp-rotate-90
[61.099361] Subtest x-tiled-8bpp-rotate-90: SKIP (0.039s)
[61.218242] [002/133] (960s left) kms_pm_rpm (pc8-residency)
[63.075401] Starting subtest: pc8-residency
[63.080790] Subtest pc8-residency: SKIP (0.000s)
[63.472260] [003/133] (958s left) vgem_basic (sysfs)
[63.537230] Starting subtest: sysfs
[63.539701] Subtest sysfs: SUCCESS (0.002s)
[63.612185] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[63.615291] [004/133] (957s left) kms_plane_alpha_blend (constant-alpha-mid)
[63.707285] Starting subtest: constant-alpha-mid
[63.999436] Starting dynamic subtest: pipe-A-eDP-1
[64.901187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[64.910886] Starting dynamic subtest: pipe-D-eDP-1
[66.420980] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.517s)
[66.423492] Subtest constant-alpha-mid: SUCCESS (2.712s)
[67.267758] [005/133] (954s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[67.526997] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[67.529489] Starting dynamic subtest: pipe-A-eDP-1
[78.846546] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.320s)
[78.861270] Starting dynamic subtest: pipe-B-eDP-1
[90.853607] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.008s)
[90.856069] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.331s)
[91.692190] [006/133] (929s left) gem_exec_params (batch-first)
[91.768056] Starting subtest: batch-first
[91.770934] Subtest batch-first: SUCCESS (0.005s)
[91.903500] [007/133] (929s left) i915_drm_fdinfo (busy-idle)
[91.950250] Starting subtest: busy-idle
[91.952309] Starting dynamic subtest: rcs0
[91.971339] Dynamic subtest rcs0: SKIP (0.020s)
[91.981381] Starting dynamic subtest: bcs0
[91.985782] Dynamic subtest bcs0: SKIP (0.000s)
[91.993020] Starting dynamic subtest: vcs0
[91.997561] Dynamic subtest vcs0: SKIP (0.000s)
[92.005652] Starting dynamic subtest: vcs1
[92.010086] Dynamic subtest vcs1: SKIP (0.000s)
[92.018203] Starting dynamic subtest: vecs0
[92.022282] Dynamic subtest vecs0: SKIP (0.000s)
[92.029149] Starting dynamic subtest: ccs0
[92.033405] Dynamic subtest ccs0: SKIP (0.000s)
[92.037726] Subtest busy-idle: SKIP (0.023s)
[92.078556] [008/133] (929s left) kms_tv_load_detect (load-detect)
[92.135958] Subtest load-detect: SKIP (0.000s)
[92.196697] [009/133] (929s left) kms_color (ctm-blue-to-red)
[92.279279] Starting subtest: ctm-blue-to-red
[92.281691] Starting dynamic subtest: pipe-A-eDP-1
[92.969052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[92.978085] Starting dynamic subtest: pipe-B-eDP-1
[94.367287] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[94.375983] Starting dynamic subtest: pipe-C-eDP-1
[95.773148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[95.784954] Starting dynamic subtest: pipe-D-eDP-1
[97.083331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.308s)
[97.085388] Subtest ctm-blue-to-red: SUCCESS (4.802s)
[97.909425] [010/133] (923s left) kms_cursor_legacy (single-move)
[98.027617] Starting subtest: single-move
[98.030048] Starting dynamic subtest: pipe-A
[103.410593] Dynamic subtest pipe-A: SUCCESS (5.380s)
[103.419538] Starting dynamic subtest: pipe-B
[108.792713] Dynamic subtest pipe-B: SUCCESS (5.380s)
[108.801206] Starting dynamic subtest: pipe-C
[114.174583] Dynamic subtest pipe-C: SUCCESS (5.380s)
[114.183018] Starting dynamic subtest: pipe-D
[119.555677] Dynamic subtest pipe-D: SUCCESS (5.380s)
[119.563861] Starting dynamic subtest: all-pipes
[124.945660] Dynamic subtest all-pipes: SUCCESS (5.388s)
[124.947892] Subtest single-move: SUCCESS (26.916s)
[125.100539] [011/133] (896s left) kms_vrr (flip-basic-fastset)
[125.193535] Starting subtest: flip-basic-fastset
[125.200178] Subtest flip-basic-fastset: SKIP (0.000s)
[125.273455] [012/133] (896s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[125.341874] Starting subtest: multi-wait-available-unsubmitted-submitted
[125.344314] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[125.455885] [013/133] (896s left) kms_psr (pr-cursor-blt)
[125.545815] Starting subtest: pr-cursor-blt
[125.550281] Subtest pr-cursor-blt: SKIP (0.000s)
[125.615996] [014/133] (896s left) i915_power (sanity)
[125.677886] Starting subtest: sanity
[129.718268] Subtest sanity: SUCCESS (4.035s)
[130.916626] [015/133] (891s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[131.009401] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[131.389661] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[134.172832] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[134.181430] Starting dynamic subtest: pipe-A-eDP-1-4
[136.348308] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[136.358682] Starting dynamic subtest: pipe-A-eDP-1-4
[138.358070] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[138.368928] Starting dynamic subtest: pipe-A-eDP-1-x
[140.559737] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.201s)
[140.922919] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[143.699242] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[143.710560] Starting dynamic subtest: pipe-B-eDP-1-4
[145.885008] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[145.897496] Starting dynamic subtest: pipe-B-eDP-1-4
[147.895691] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[147.904292] Starting dynamic subtest: pipe-B-eDP-1-x
[150.096866] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.202s)
[150.462693] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[153.235844] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.780s)
[153.244296] Starting dynamic subtest: pipe-C-eDP-1-4
[155.421873] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.185s)
[155.434214] Starting dynamic subtest: pipe-C-eDP-1-4
[157.431790] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[157.441948] Starting dynamic subtest: pipe-C-eDP-1-x
[159.610822] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[159.979487] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[162.772936] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s)
[162.783999] Starting dynamic subtest: pipe-D-eDP-1-4
[164.947593] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[164.957396] Starting dynamic subtest: pipe-D-eDP-1-4
[166.956678] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[166.964719] Starting dynamic subtest: pipe-D-eDP-1-x
[169.136349] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[169.138871] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.125s)
[170.359933] [016/133] (851s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[170.452885] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[170.457427] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[170.563660] [017/133] (851s left) gem_userptr_blits (stress-mm-invalidate-close)
[170.633069] Starting subtest: stress-mm-invalidate-close
[172.779969] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[172.895124] [018/133] (849s left) syncobj_basic (bad-flags-handle-to-fd)
[172.942918] Starting subtest: bad-flags-handle-to-fd
[172.945114] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[173.047589] [019/133] (849s left) kms_properties (invalid-properties-atomic)
[173.140791] Starting subtest: invalid-properties-atomic
[173.460644] Subtest invalid-properties-atomic: SUCCESS (0.320s)
[173.532130] [020/133] (848s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[173.591383] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[173.700757] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[173.776987] [021/133] (848s left) i915_pm_rc6_residency (rc6-fence)
[173.828031] Starting subtest: rc6-fence
[173.842631] Starting dynamic subtest: gt0
[186.159875] Dynamic subtest gt0: SUCCESS (12.316s)
[186.169671] Starting dynamic subtest: gt1
[200.921653] Dynamic subtest gt1: SUCCESS (14.758s)
[200.924523] Subtest rc6-fence: SUCCESS (27.094s)
[201.000558] [022/133] (821s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[201.064880] Starting subtest: invalid-multi-wait-unsubmitted
[201.067287] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[201.166920] [023/133] (821s left) gem_mmap_gtt (hang-busy)
[201.221581] Subtest hang-busy: SKIP (0.000s)
[201.281432] [024/133] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[201.386603] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[201.390612] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[201.480767] [025/133] (820s left) syncobj_timeline (single-wait-all-signaled)
[201.529962] Starting subtest: single-wait-all-signaled
[201.532255] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[201.614405] [026/133] (820s left) kms_flip (basic-flip-vs-dpms)
[201.703108] Starting subtest: basic-flip-vs-dpms
[201.705322] Starting dynamic subtest: A-eDP1
[204.249115] Dynamic subtest A-eDP1: SUCCESS (2.543s)
[204.258557] Starting dynamic subtest: B-eDP1
[206.422501] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[206.431690] Starting dynamic subtest: C-eDP1
[208.584384] Dynamic subtest C-eDP1: SUCCESS (2.162s)
[208.592998] Starting dynamic subtest: D-eDP1
[210.665583] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[210.667827] Subtest basic-flip-vs-dpms: SUCCESS (8.962s)
[211.470311] [027/133] (811s left) i915_hangman (hangcheck-unterminated)
[211.542064] Starting subtest: hangcheck-unterminated
[222.903074] Subtest hangcheck-unterminated: SUCCESS (11.360s)
[223.013181] [028/133] (799s left) gem_reg_read (timestamp-moving)
[223.061701] Starting subtest: timestamp-moving
[224.063342] Subtest timestamp-moving: SUCCESS (1.001s)
[224.138278] [029/133] (798s left) kms_invalid_mode (zero-vdisplay)
[224.251183] Starting subtest: zero-vdisplay
[224.253350] Starting dynamic subtest: pipe-A-eDP-1
[224.552516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[224.564745] Starting dynamic subtest: pipe-B-eDP-1
[224.566755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[224.575175] Starting dynamic subtest: pipe-C-eDP-1
[224.577330] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[224.584898] Starting dynamic subtest: pipe-D-eDP-1
[224.586859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[224.588819] Subtest zero-vdisplay: SUCCESS (0.308s)
[225.405847] [030/133] (797s left) syncobj_wait (invalid-signal-illegal-handle)
[225.465388] Starting subtest: invalid-signal-illegal-handle
[225.467796] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[225.588539] [031/133] (797s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[225.701507] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[226.536348] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[226.712977] [032/133] (796s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[226.820353] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[226.824793] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[226.926363] [033/133] (795s left) gem_userptr_blits (process-exit)
[227.003294] Starting subtest: process-exit
[227.011347] Subtest process-exit: SUCCESS (0.011s)
[227.135988] [034/133] (795s left) gem_exec_schedule (u-semaphore-resolve)
[227.202029] Starting subtest: u-semaphore-resolve
[227.234059] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[227.584688] [035/133] (795s left) kms_busy (extended-modeset-hang-oldfb)
[227.687112] Starting subtest: extended-modeset-hang-oldfb
[227.689378] Starting dynamic subtest: pipe-A
[239.578598] Dynamic subtest pipe-A: SUCCESS (11.890s)
[239.588680] Starting dynamic subtest: pipe-D
[251.843443] Dynamic subtest pipe-D: SUCCESS (12.265s)
[251.845863] Subtest extended-modeset-hang-oldfb: SUCCESS (24.159s)
[252.643557] [036/133] (770s left) gem_mmap_wc (bad-object)
[252.698239] Subtest bad-object: SKIP (0.000s)
[252.756369] [037/133] (770s left) kms_pm_lpsp (screens-disabled)
[253.869210] Starting subtest: screens-disabled
[253.873839] Subtest screens-disabled: SKIP (0.000s)
[253.941193] [038/133] (769s left) kms_hdr (brightness-with-hdr)
[254.035959] Starting subtest: brightness-with-hdr
[254.042654] Subtest brightness-with-hdr: SKIP (0.000s)
[254.111310] [039/133] (769s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[254.200891] Starting subtest: fbc-rgb101010-draw-render
[258.866968] Subtest fbc-rgb101010-draw-render: SUCCESS (4.670s)
[260.056990] [040/133] (763s left) kms_content_protection (suspend-resume)
[260.201399] Starting subtest: suspend-resume
[260.205986] Subtest suspend-resume: SKIP (0.000s)
[260.331252] [041/133] (762s left) kms_psr (psr-suspend)
[260.427750] Starting subtest: psr-suspend
[260.430059] Starting dynamic subtest: eDP-1
[278.316388] Dynamic subtest eDP-1: SUCCESS (3.874s)
[278.318406] Subtest psr-suspend: SUCCESS (3.875s)
[279.192854] [042/133] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[279.308980] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[279.313249] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[279.405870] [043/133] (743s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[279.500974] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[279.505427] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[279.587842] [044/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[279.681313] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[279.685450] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[279.782041] [045/133] (743s left) perf (gen12-group-concurrent-oa-buffer-read)
[279.901875] Starting subtest: gen12-group-concurrent-oa-buffer-read
[289.932756] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.025s)
[289.984014] [046/133] (733s left) kms_flip (nonexisting-fb)
[290.080968] Starting subtest: nonexisting-fb
[290.083409] Starting dynamic subtest: A-eDP1
[291.297427] Dynamic subtest A-eDP1: SUCCESS (1.215s)
[291.309391] Starting dynamic subtest: B-eDP1
[292.433411] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[292.446843] Starting dynamic subtest: C-eDP1
[293.576200] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[293.591335] Starting dynamic subtest: D-eDP1
[294.712405] Dynamic subtest D-eDP1: SUCCESS (1.135s)
[294.716974] Subtest nonexisting-fb: SUCCESS (4.635s)
[295.887827] [047/133] (727s left) kms_plane_lowres (tiling-yf)
[295.985382] Starting subtest: tiling-yf
[295.989800] Subtest tiling-yf: SKIP (0.000s)
[296.063590] [048/133] (727s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[296.151634] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[296.177942] Starting dynamic subtest: pipe-A-plane-0
[296.599615] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[296.609439] Starting dynamic subtest: pipe-A-plane-3
[296.855739] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[296.866946] Starting dynamic subtest: pipe-A-plane-5
[296.870858] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[297.982292] Starting dynamic subtest: pipe-B-plane-0
[298.429160] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[298.438927] Starting dynamic subtest: pipe-B-plane-3
[298.684565] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[298.694205] Starting dynamic subtest: pipe-B-plane-5
[298.699222] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[299.001533] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.849s)
[299.850592] [049/133] (723s left) kms_addfb_basic (bad-pitch-63)
[299.912796] Starting subtest: bad-pitch-63
[299.914789] Subtest bad-pitch-63: SUCCESS (0.000s)
[300.045617] [050/133] (723s left) kms_feature_discovery (chamelium)
[300.143911] Starting subtest: chamelium
[300.148291] Subtest chamelium: SKIP (0.000s)
[300.221085] [051/133] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[300.308604] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[300.312920] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[300.402350] [052/133] (723s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[300.490413] Starting subtest: random-ccs-data-y-tiled-ccs
[300.492691] Starting dynamic subtest: pipe-A-eDP-1
[300.517168] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[300.528145] Starting dynamic subtest: pipe-B-eDP-1
[300.552348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[300.561495] Starting dynamic subtest: pipe-C-eDP-1
[300.585253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.594282] Starting dynamic subtest: pipe-D-eDP-1
[300.618788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.623018] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[302.646801] [053/133] (721s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[302.736245] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[302.740982] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[303.885700] [054/133] (719s left) gem_softpin (evict-single-offset)
[303.946272] Starting subtest: evict-single-offset
[331.923969] Subtest evict-single-offset: SUCCESS (27.977s)
[332.007775] [055/133] (691s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[332.178211] Starting subtest: cursorA-vs-flipA-varying-size
[343.355245] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.175s)
[344.219197] [056/133] (679s left) syncobj_wait (wait-zero-handles)
[344.314104] Starting subtest: wait-zero-handles
[344.316536] Subtest wait-zero-handles: SUCCESS (0.000s)
[344.427123] [057/133] (679s left) gem_exec_reloc (basic-wc-read-noreloc)
[344.493591] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[344.564728] [058/133] (679s left) gem_exec_whisper (basic-fds-forked-all)
[344.633722] Starting subtest: basic-fds-forked-all
[364.740910] Subtest basic-fds-forked-all: SUCCESS (20.105s)
[364.926635] [059/133] (659s left) kms_cursor_crc (cursor-onscreen-64x64)
[365.124042] Starting subtest: cursor-onscreen-64x64
[365.129053] Starting dynamic subtest: pipe-A-eDP-1
[367.274617] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.145s)
[367.304650] Starting dynamic subtest: pipe-D-eDP-1
[370.105893] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.807s)
[370.108086] Subtest cursor-onscreen-64x64: SUCCESS (4.979s)
[370.966998] [060/133] (653s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[371.058316] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[371.062632] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[371.130709] [061/133] (652s left) prime_mmap (test_dup)
[371.187951] Starting subtest: test_dup
[371.190250] Starting dynamic subtest: test_dup-smem
[371.219749] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[371.222109] Subtest test_dup: SUCCESS (0.033s)
[371.307929] [062/133] (652s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[371.412448] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[371.416477] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[371.497295] [063/133] (652s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[371.555717] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[371.558088] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[371.666337] [064/133] (652s left) gem_exec_balancer (indices)
[371.725158] Starting subtest: indices
[373.874255] Subtest indices: SUCCESS (2.147s)
[374.197715] [065/133] (650s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[374.285190] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[374.287499] Starting dynamic subtest: pipe-A
[375.458500] Dynamic subtest pipe-A: SUCCESS (1.176s)
[375.468768] Starting dynamic subtest: pipe-B
[377.708103] Dynamic subtest pipe-B: SUCCESS (2.248s)
[377.719254] Starting dynamic subtest: pipe-C
[378.866935] Dynamic subtest pipe-C: SUCCESS (1.157s)
[378.877321] Starting dynamic subtest: pipe-D
[380.101987] Dynamic subtest pipe-D: SUCCESS (1.233s)
[380.104744] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.820s)
[381.287442] [066/133] (642s left) kms_psr (psr2-dpms)
[381.405931] Starting subtest: psr2-dpms
[381.408381] Starting dynamic subtest: eDP-1
[384.312460] Dynamic subtest eDP-1: SUCCESS (2.906s)
[384.314751] Subtest psr2-dpms: SUCCESS (2.907s)
[385.198644] [067/133] (639s left) gem_userptr_blits (sd-probe)
[385.266763] Starting subtest: sd-probe
[385.268972] Subtest sd-probe: SUCCESS (0.000s)
[385.402382] [068/133] (638s left) kms_properties (get_properties-sanity-non-atomic)
[385.502166] Starting subtest: get_properties-sanity-non-atomic
[385.504460] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[385.577395] [069/133] (638s left) gem_fence_thrash (bo-write-verify-threaded-y)
[385.618573] Starting subtest: bo-write-verify-threaded-y
[385.641834] Subtest bo-write-verify-threaded-y: SKIP (0.020s)
[385.703294] [070/133] (638s left) gem_exec_schedule (preempt-other)
[385.775212] Starting subtest: preempt-other
[385.777571] Starting dynamic subtest: rcs0
[385.842553] Dynamic subtest rcs0: SUCCESS (0.075s)
[385.857085] Starting dynamic subtest: bcs0
[385.915237] Dynamic subtest bcs0: SUCCESS (0.073s)
[385.939195] Starting dynamic subtest: vcs0
[385.980783] Dynamic subtest vcs0: SUCCESS (0.065s)
[385.995702] Starting dynamic subtest: vcs1
[386.046100] Dynamic subtest vcs1: SUCCESS (0.063s)
[386.063055] Starting dynamic subtest: vecs0
[386.110541] Dynamic subtest vecs0: SUCCESS (0.064s)
[386.124150] Starting dynamic subtest: ccs0
[386.178779] Dynamic subtest ccs0: SUCCESS (0.068s)
[386.181150] Subtest preempt-other: SUCCESS (0.412s)
[386.976159] [071/133] (637s left) dmabuf_sync_file (export-wait-after-attach)
[387.029107] Starting subtest: export-wait-after-attach
[387.031861] Subtest export-wait-after-attach: SUCCESS (0.002s)
[387.084871] [072/133] (637s left) gem_tiling_max_stride
[387.211915] [073/133] (637s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[387.588329] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[388.389549] [074/133] (636s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[388.483206] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[388.485426] Starting dynamic subtest: pipe-A-eDP-1
[399.466782] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.983s)
[399.477390] Starting dynamic subtest: pipe-B-eDP-1
[411.213056] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.744s)
[411.214926] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.731s)
[412.079865] [075/133] (612s left) kms_big_fb (linear-addfb)
[412.181442] Starting subtest: linear-addfb
[412.183636] Subtest linear-addfb: SUCCESS (0.000s)
[412.274420] [076/133] (612s left) gem_exec_reloc (basic-cpu-gtt)
[412.325416] Subtest basic-cpu-gtt: SKIP (0.000s)
[412.391655] [077/133] (612s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[412.485063] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[412.487387] Starting dynamic subtest: pipe-A-eDP-1
[413.453518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.963s)
[413.465828] Starting dynamic subtest: pipe-B-eDP-1
[415.103591] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.646s)
[415.116532] Starting dynamic subtest: pipe-C-eDP-1
[416.612102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[416.624588] Starting dynamic subtest: pipe-D-eDP-1
[418.133892] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[418.136025] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.644s)
[419.315456] [078/133] (605s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[419.409107] Starting subtest: 2x-plain-flip-ts-check-interruptible
[419.421878] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[419.516881] [079/133] (605s left) perf (buffer-fill)
[419.625131] Starting subtest: buffer-fill
[419.627568] Starting dynamic subtest: 0-rcs0
[421.873792] Dynamic subtest 0-rcs0: SUCCESS (2.247s)
[421.888329] Starting dynamic subtest: 1-vcs0
[426.307831] Dynamic subtest 1-vcs0: SUCCESS (4.433s)
[426.310033] Subtest buffer-fill: SUCCESS (6.683s)
[426.350401] [080/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[426.457227] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[426.461278] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[426.566548] [081/133] (598s left) gem_fenced_exec_thrash (no-spare-fences)
[426.623354] Subtest no-spare-fences: SKIP (0.000s)
[426.687742] [082/133] (598s left) gem_create (create-ext-set-pat)
[426.853890] Starting subtest: create-ext-set-pat
[426.856002] Subtest create-ext-set-pat: SUCCESS (0.001s)
[426.951345] [083/133] (598s left) gen9_exec_parse (bb-start-far)
[427.010927] Subtest bb-start-far: SKIP (0.000s)
[427.079950] [084/133] (597s left) gem_ringfill (basic-all)
[432.854997] Starting subtest: basic-all
[434.024268] Subtest basic-all: SUCCESS (1.169s)
[434.151706] [085/133] (590s left) gem_ctx_persistence (engines-mixed-process)
[434.219557] Starting subtest: engines-mixed-process
[434.222008] Starting dynamic subtest: rcs0
[435.848009] Dynamic subtest rcs0: SUCCESS (1.627s)
[435.859268] Starting dynamic subtest: bcs0
[437.913128] Dynamic subtest bcs0: SUCCESS (2.066s)
[437.925619] Starting dynamic subtest: vcs0
[439.894788] Dynamic subtest vcs0: SUCCESS (1.981s)
[439.907445] Starting dynamic subtest: vcs1
[441.893947] Dynamic subtest vcs1: SUCCESS (1.997s)
[441.907017] Starting dynamic subtest: vecs0
[443.841812] Dynamic subtest vecs0: SUCCESS (1.945s)
[443.853412] Starting dynamic subtest: ccs0
[445.909095] Dynamic subtest ccs0: SUCCESS (2.067s)
[445.911559] Subtest engines-mixed-process: SUCCESS (11.690s)
[445.992304] [086/133] (579s left) kms_psr (fbc-psr-sprite-plane-onoff)
[446.085152] Starting subtest: fbc-psr-sprite-plane-onoff
[446.087461] Starting dynamic subtest: eDP-1
[446.091877] Dynamic subtest eDP-1: SKIP (0.000s)
[446.096569] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[446.163777] [087/133] (579s left) gem_exec_params (invalid-batch-start-offset)
[446.227851] Starting subtest: invalid-batch-start-offset
[446.233165] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[446.352293] [088/133] (578s left) kms_lease (invalid-create-leases)
[446.440590] Starting subtest: invalid-create-leases
[446.445245] Subtest invalid-create-leases: SUCCESS (0.006s)
[446.541129] [089/133] (578s left) gem_exec_create (madvise)
[446.604091] Starting subtest: madvise
[446.606312] Starting dynamic subtest: smem
[466.963063] Dynamic subtest smem: SUCCESS (20.356s)
[466.965297] Subtest madvise: SUCCESS (20.357s)
[468.180327] [090/133] (557s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[468.238084] Starting subtest: multi-wait-all-for-submit-submitted
[468.343470] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[468.422716] [091/133] (556s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[468.492197] Starting subtest: legacy-engines-hostile-preempt
[468.494119] Starting dynamic subtest: render
[468.571046] Dynamic subtest render: SUCCESS (0.080s)
[468.587307] Starting dynamic subtest: bsd1
[469.904264] Dynamic subtest bsd1: SUCCESS (1.329s)
[469.919720] Starting dynamic subtest: bsd2
[471.955271] Dynamic subtest bsd2: SUCCESS (2.048s)
[471.968696] Starting dynamic subtest: blt
[472.007908] Dynamic subtest blt: SUCCESS (0.051s)
[472.019097] Starting dynamic subtest: vebox
[473.935445] Dynamic subtest vebox: SUCCESS (1.924s)
[473.938117] Subtest legacy-engines-hostile-preempt: SUCCESS (5.445s)
[474.024970] [092/133] (551s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[474.093148] Starting subtest: etime-single-wait-for-submit-submitted
[474.199387] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[474.305205] [093/133] (551s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[474.400550] Starting subtest: fbc-psr2-primary-mmap-cpu
[474.402914] Starting dynamic subtest: eDP-1
[474.407206] Dynamic subtest eDP-1: SKIP (0.000s)
[474.411526] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[474.477160] [094/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[474.577808] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[481.163082] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.588s)
[481.282294] [095/133] (544s left) kms_rotation_crc (cursor-rotation-180)
[481.386744] Starting subtest: cursor-rotation-180
[482.902809] Subtest cursor-rotation-180: SUCCESS (1.517s)
[484.084242] [096/133] (541s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[484.178910] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[484.181143] Starting dynamic subtest: pipe-A-default-mode
[485.348111] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[485.352573] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.169s)
[485.501722] [097/133] (540s left) gem_fence_thrash (bo-write-verify-none)
[485.544430] Starting subtest: bo-write-verify-none
[485.561502] Subtest bo-write-verify-none: SKIP (0.017s)
[485.619513] [098/133] (540s left) kms_sequence (get-idle)
[485.713856] Starting subtest: get-idle
[485.716014] Starting dynamic subtest: pipe-A-eDP-1
[487.528524] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s)
[487.539846] Starting dynamic subtest: pipe-B-eDP-1
[489.993162] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.461s)
[490.004102] Starting dynamic subtest: pipe-C-eDP-1
[492.408230] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[492.419739] Starting dynamic subtest: pipe-D-eDP-1
[494.830461] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[494.832821] Subtest get-idle: SUCCESS (9.117s)
[495.662511] [099/133] (530s left) kms_cursor_edge_walk (64x64-top-edge)
[495.760447] Starting subtest: 64x64-top-edge
[495.762733] Starting dynamic subtest: pipe-A-eDP-1
[499.243561] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[499.254864] Starting dynamic subtest: pipe-D-eDP-1
[502.379118] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[502.381262] Subtest 64x64-top-edge: SUCCESS (6.619s)
[503.177653] [100/133] (522s left) perf_pmu (most-busy-idle-check-all)
[503.224307] Starting subtest: most-busy-idle-check-all
[503.226207] Starting dynamic subtest: rcs0
[504.914649] Dynamic subtest rcs0: SUCCESS (1.690s)
[504.928346] Starting dynamic subtest: bcs0
[506.898695] Dynamic subtest bcs0: SUCCESS (1.982s)
[506.910821] Starting dynamic subtest: vcs0
[508.947235] Dynamic subtest vcs0: SUCCESS (2.045s)
[508.959708] Starting dynamic subtest: vcs1
[510.931280] Dynamic subtest vcs1: SUCCESS (1.981s)
[510.944901] Starting dynamic subtest: vecs0
[512.915088] Dynamic subtest vecs0: SUCCESS (1.980s)
[512.928228] Starting dynamic subtest: ccs0
[514.899760] Dynamic subtest ccs0: SUCCESS (1.982s)
[514.902439] Subtest most-busy-idle-check-all: SUCCESS (11.677s)
[515.001329] [101/133] (510s left) prime_busy (hang-wait)
[515.067131] Starting subtest: hang-wait
[515.069072] Starting dynamic subtest: rcs0
[541.364059] Dynamic subtest rcs0: SUCCESS (26.293s)
[541.375119] Starting dynamic subtest: bcs0
[548.583544] Dynamic subtest bcs0: SUCCESS (7.215s)
[548.594941] Starting dynamic subtest: vcs0
[555.555475] Dynamic subtest vcs0: SUCCESS (6.970s)
[555.567505] Starting dynamic subtest: vcs1
[562.530102] Dynamic subtest vcs1: SUCCESS (6.972s)
[562.540545] Starting dynamic subtest: vecs0
[569.566953] Dynamic subtest vecs0: SUCCESS (7.035s)
[569.578858] Starting dynamic subtest: ccs0
[583.408087] Dynamic subtest ccs0: SUCCESS (13.840s)
[583.410651] Subtest hang-wait: SUCCESS (68.341s)
[583.537040] [102/133] (442s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[583.646521] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[583.651078] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[583.770236] [103/133] (442s left) syncobj_basic (bad-flags-fd-to-handle)
[583.847783] Starting subtest: bad-flags-fd-to-handle
[583.850168] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[583.959650] [104/133] (441s left) kms_cursor_crc (cursor-random-512x170)
[584.279139] Starting subtest: cursor-random-512x170
[584.283663] Subtest cursor-random-512x170: SKIP (0.001s)
[584.407000] [105/133] (441s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[584.503132] Starting subtest: plane-upscale-20x20-with-modifiers
[584.505062] Starting dynamic subtest: pipe-A
[584.838334] Dynamic subtest pipe-A: SUCCESS (0.337s)
[584.849416] Starting dynamic subtest: pipe-B
[586.268679] Dynamic subtest pipe-B: SUCCESS (1.428s)
[586.285774] Starting dynamic subtest: pipe-C
[587.683361] Dynamic subtest pipe-C: SUCCESS (1.412s)
[587.695721] Starting dynamic subtest: pipe-D
[589.104153] Dynamic subtest pipe-D: SUCCESS (1.419s)
[589.106420] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.604s)
[590.275723] [106/133] (435s left) kms_atomic (test-only)
[590.373366] Starting subtest: test-only
[590.420629] Starting dynamic subtest: pipe-A-eDP-1
[592.972225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.548s)
[592.974513] Subtest test-only: SUCCESS (2.598s)
[593.773589] [107/133] (432s left) gem_exec_fence (syncobj-channel)
[594.237045] Starting subtest: syncobj-channel
[595.262979] Subtest syncobj-channel: SUCCESS (1.023s)
[595.998902] [108/133] (430s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[596.098285] Starting subtest: bad-rotation-90-y-tiled-ccs
[596.100480] Starting dynamic subtest: pipe-A-eDP-1
[596.122962] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[596.136699] Starting dynamic subtest: pipe-B-eDP-1
[596.158243] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[596.168173] Starting dynamic subtest: pipe-C-eDP-1
[596.189535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[596.199676] Starting dynamic subtest: pipe-D-eDP-1
[596.221600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[596.225567] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[598.259503] [109/133] (427s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[598.649471] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[599.482319] [110/133] (426s left) api_intel_allocator (gem-pool)
[599.545594] Starting subtest: gem-pool
[599.552116] Subtest gem-pool: SUCCESS (0.009s)
[599.642138] [111/133] (426s left) gem_exec_reloc (basic-write-cpu)
[599.708568] Subtest basic-write-cpu: SKIP (0.000s)
[599.794399] [112/133] (426s left) gem_partial_pwrite_pread (reads-snoop)
[599.860860] Subtest reads-snoop: SKIP (0.000s)
[599.938480] [113/133] (426s left) gem_exec_params (invalid-bsd1-flag-on-render)
[599.990255] Starting subtest: invalid-bsd1-flag-on-render
[599.992533] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[600.091688] [114/133] (426s left) gem_busy (parallel)
[600.282957] Starting subtest: parallel
[600.285952] Starting dynamic subtest: rcs0
[601.876510] Dynamic subtest rcs0: SUCCESS (1.591s)
[601.895223] Starting dynamic subtest: bcs0
[603.923291] Dynamic subtest bcs0: SUCCESS (2.044s)
[603.945516] Starting dynamic subtest: vcs0
[605.906650] Dynamic subtest vcs0: SUCCESS (1.981s)
[605.926800] Starting dynamic subtest: vcs1
[607.954652] Dynamic subtest vcs1: SUCCESS (2.045s)
[607.968842] Starting dynamic subtest: vecs0
[609.939747] Dynamic subtest vecs0: SUCCESS (1.982s)
[609.953504] Starting dynamic subtest: ccs0
[611.924037] Dynamic subtest ccs0: SUCCESS (1.980s)
[611.926890] Subtest parallel: SUCCESS (11.641s)
[612.171561] [115/133] (414s left) api_intel_bb (render)
[612.224098] Starting subtest: render
[612.225983] Starting dynamic subtest: render-none-512
[612.337541] Dynamic subtest render-none-512: SUCCESS (0.114s)
[612.351097] Starting dynamic subtest: render-none-1024
[612.719361] Dynamic subtest render-none-1024: SUCCESS (0.380s)
[612.732485] Starting dynamic subtest: render-x-512
[612.806214] Dynamic subtest render-x-512: SUCCESS (0.087s)
[612.819046] Starting dynamic subtest: render-x-1024
[613.147589] Dynamic subtest render-x-1024: SUCCESS (0.339s)
[613.160533] Starting dynamic subtest: render-y-512
[613.240394] Dynamic subtest render-y-512: SUCCESS (0.093s)
[613.253768] Starting dynamic subtest: render-y-1024
[613.584825] Dynamic subtest render-y-1024: SUCCESS (0.342s)
[613.587486] Subtest render: SUCCESS (1.361s)
[613.674311] [116/133] (412s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[613.775459] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[613.779763] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[613.871133] [117/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[613.967082] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[613.971684] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[614.074369] [118/133] (412s left) kms_fence_pin_leak
[614.261621] [119/133] (412s left) gem_exec_async (forked-writes)
[614.321969] Starting subtest: forked-writes
[614.324271] Starting dynamic subtest: rcs0
[614.351659] Dynamic subtest rcs0: SUCCESS (0.029s)
[614.363380] Starting dynamic subtest: bcs0
[614.375529] Dynamic subtest bcs0: SUCCESS (0.023s)
[614.387150] Starting dynamic subtest: vcs0
[614.401299] Dynamic subtest vcs0: SUCCESS (0.025s)
[614.412980] Starting dynamic subtest: vcs1
[614.425739] Dynamic subtest vcs1: SUCCESS (0.023s)
[614.437760] Starting dynamic subtest: vecs0
[614.449745] Dynamic subtest vecs0: SUCCESS (0.024s)
[614.461751] Starting dynamic subtest: ccs0
[614.472423] Dynamic subtest ccs0: SUCCESS (0.022s)
[614.475020] Subtest forked-writes: SUCCESS (0.151s)
[614.712701] [120/133] (411s left) gem_exec_balancer (semaphore)
[614.772653] Starting subtest: semaphore
[615.944559] Subtest semaphore: SUCCESS (1.170s)
[616.264656] [121/133] (410s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[616.371235] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[623.111344] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.743s)
[623.251448] [122/133] (403s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[623.363315] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[623.367477] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[623.468799] [123/133] (403s left) gem_pxp (protected-raw-src-copy-not-readible)
[623.593148] Starting subtest: protected-raw-src-copy-not-readible
[623.652806] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.061s)
[623.782216] [124/133] (403s left) gem_lmem_swapping (heavy-multi)
[623.821484] Subtest heavy-multi: SKIP (0.000s)
[623.866860] [125/133] (403s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[623.940387] Starting subtest: map-fixed-invalidate-overlap-busy
[623.944921] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[624.069852] [126/133] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[624.179473] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[624.182871] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[624.272031] [127/133] (402s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[624.359343] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[624.360892] Starting dynamic subtest: pipe-A-eDP-1
[624.667634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[624.679238] Starting dynamic subtest: pipe-B-eDP-1
[625.925575] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[625.937491] Starting dynamic subtest: pipe-C-eDP-1
[627.122556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[627.135451] Starting dynamic subtest: pipe-D-eDP-1
[628.362480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[628.364618] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.975s)
[629.482660] [128/133] (397s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[629.573511] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[636.475015] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.903s)
[636.631687] [129/133] (390s left) gem_lmem_swapping (verify-ccs)
[636.682327] Subtest verify-ccs: SKIP (0.000s)
[636.731960] [130/133] (390s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[636.833476] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[637.490643] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[637.646393] [131/133] (389s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[637.732539] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[637.744192] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[637.824991] [132/133] (389s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[637.936297] Starting subtest: fbcpsr-slowdraw
[663.179259] Subtest fbcpsr-slowdraw: SUCCESS (25.244s)
[663.352541] [133/133] (363s left) gem_exec_flush (basic-uc-prw-default)
[663.429461] Starting subtest: basic-uc-prw-default
[668.917751] Subtest basic-uc-prw-default: SUCCESS (5.487s)
[669.120395] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: kms_plane_alpha_blend
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: kms_tv_load_detect
results: parsing output: 8/ for test: kms_color
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_vrr
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_power
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: syncobj_basic
results: parsing output: 18/ for test: kms_properties
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: i915_pm_rc6_residency
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: i915_hangman
results: parsing output: 27/ for test: gem_reg_read
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_pm_lpsp
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_plane_lowres
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: prime_mmap
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_properties
results: parsing output: 68/ for test: gem_fence_thrash
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: dmabuf_sync_file
results: parsing output: 71/ for test: gem_tiling_max_stride
results: parsing output: 72/ for test: kms_chamelium_edid
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_fenced_exec_thrash
results: parsing output: 81/ for test: gem_create
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: gem_ringfill
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: gem_exec_create
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_rotation_crc
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: kms_cursor_edge_walk
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: prime_busy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_atomic
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_chamelium_hpd
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_partial_pwrite_pread
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: gem_busy
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_fence_pin_leak
results: parsing output: 118/ for test: gem_exec_async
results: parsing output: 119/ for test: gem_exec_balancer
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_pxp
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_flush
Done.