[60.079052] Initializing watchdogs
[60.079099]   /dev/watchdog0
[60.093524] [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.098039] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.100372] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.103628] [001/133] (960s left) perf_pmu (busy-start)
[60.164428] Starting subtest: busy-start
[60.166749] Starting dynamic subtest: rcs0
[62.721188] Dynamic subtest rcs0: SUCCESS (2.570s)
[62.731442] Starting dynamic subtest: bcs0
[65.267841] Dynamic subtest bcs0: SUCCESS (2.557s)
[65.277373] Starting dynamic subtest: vcs0
[68.883442] Dynamic subtest vcs0: SUCCESS (3.622s)
[68.892637] Starting dynamic subtest: vcs1
[72.916528] Dynamic subtest vcs1: SUCCESS (4.038s)
[72.925203] Starting dynamic subtest: vecs0
[76.884340] Dynamic subtest vecs0: SUCCESS (3.970s)
[76.895117] Starting dynamic subtest: ccs0
[79.429547] Dynamic subtest ccs0: SUCCESS (2.548s)
[79.432039] Subtest busy-start: SUCCESS (19.311s)
[79.574212] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[79.639775] Starting subtest: basic-wb-rw-before-default
[85.105392] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[85.305067] [003/133] (935s left) kms_lease (lessee-list)
[85.406720] Starting subtest: lessee-list
[85.409093] Starting dynamic subtest: pipe-A-eDP-1
[85.411380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[85.419092] Starting dynamic subtest: pipe-B-eDP-1
[85.421287] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[85.428429] Starting dynamic subtest: pipe-C-eDP-1
[85.430721] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[85.438038] Starting dynamic subtest: pipe-D-eDP-1
[85.440403] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[85.442721] Subtest lessee-list: SUCCESS (0.007s)
[85.549942] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[85.593808] Starting subtest: virtual-busy-hang-all
[85.598214] Subtest virtual-busy-hang-all: SKIP (0.000s)
[85.671830] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[85.757738] Starting subtest: legacy-setmode
[85.760255] Starting dynamic subtest: pipe-A-eDP-1
[92.633595] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.877s)
[92.636053] Subtest legacy-setmode: SUCCESS (6.878s)
[93.438797] [006/133] (927s left) kms_color (ctm-max)
[93.537361] Starting subtest: ctm-max
[93.539531] Starting dynamic subtest: pipe-A-eDP-1
[94.294779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[94.302833] Starting dynamic subtest: pipe-B-eDP-1
[95.755195] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[95.764868] Starting dynamic subtest: pipe-C-eDP-1
[97.117553] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[97.125501] Starting dynamic subtest: pipe-D-eDP-1
[98.445748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[98.448161] Subtest ctm-max: SUCCESS (4.910s)
[99.256648] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[99.358518] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[103.620912] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.265s)
[104.769738] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[104.867664] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[104.872111] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[105.004396] [009/133] (915s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[105.107351] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[105.109564] Starting dynamic subtest: pipe-A
[105.131842] Dynamic subtest pipe-A: SKIP (0.019s)
[105.140074] Starting dynamic subtest: pipe-B
[105.163552] Dynamic subtest pipe-B: SKIP (0.032s)
[105.171277] Starting dynamic subtest: pipe-C
[105.196298] Dynamic subtest pipe-C: SKIP (0.031s)
[105.203823] Starting dynamic subtest: pipe-D
[105.226556] Dynamic subtest pipe-D: SKIP (0.031s)
[105.230349] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.115s)
[105.343462] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[105.450076] Starting subtest: y-tiled-64bpp-rotate-180
[105.454171] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[105.572061] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[105.672591] Starting subtest: primary-x-tiled-reflect-x-180
[112.723275] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.050s)
[113.905982] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[114.018628] Starting subtest: 2x-flip-vs-expired-vblank
[114.027723] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[114.169203] [013/133] (906s left) api_intel_allocator (fork-simple-stress)
[114.239080] Starting subtest: fork-simple-stress
[119.641298] Subtest fork-simple-stress: SUCCESS (5.403s)
[119.779692] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[119.910720] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[126.443057] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.536s)
[126.588159] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[126.691144] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[126.695136] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[126.815328] [016/133] (894s left) gem_mmap (bad-size)
[126.876757] Subtest bad-size: SKIP (0.000s)
[126.946808] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[127.002209] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[127.006260] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[127.192903] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[127.288836] Starting subtest: psr-2p-primscrn-cur-indfb-move
[127.293211] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[127.400414] [019/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[127.512498] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[134.032845] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.524s)
[134.181830] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[134.245204] Starting subtest: wait-all-snapshot
[134.325674] Subtest wait-all-snapshot: SUCCESS (0.081s)
[134.411993] [021/133] (886s left) gem_partial_pwrite_pread (reads)
[134.474595] Subtest reads: SKIP (0.000s)
[134.538906] [022/133] (886s left) syncobj_basic (create-signaled)
[134.605076] Starting subtest: create-signaled
[134.607482] Subtest create-signaled: SUCCESS (0.000s)
[134.744329] [023/133] (886s left) kms_chamelium_frames (dp-crc-multiple)
[135.123855] Subtest dp-crc-multiple: SKIP (0.000s)
[135.927869] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[136.049439] Starting subtest: cursorA-vs-flipA-varying-size
[147.208757] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.156s)
[148.091496] [025/133] (873s left) gem_ctx_persistence (hang)
[148.158508] Starting subtest: hang
[148.163704] Subtest hang: SKIP (0.000s)
[148.268806] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[148.376177] Starting subtest: pr-primary-page-flip
[148.380337] Subtest pr-primary-page-flip: SKIP (0.000s)
[148.456969] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[148.503903] Subtest heavy-random: SKIP (0.000s)
[148.545320] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[148.601067] Starting subtest: master-rmfb
[148.603299] Subtest master-rmfb: SUCCESS (0.001s)
[148.754973] [029/133] (872s left) kms_addfb_basic (invalid-get-prop-any)
[148.816270] Starting subtest: invalid-get-prop-any
[148.818211] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[148.968100] [030/133] (872s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[149.058464] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[149.060473] Starting dynamic subtest: pipe-A-eDP-1
[149.081997] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.092043] Starting dynamic subtest: pipe-B-eDP-1
[149.112870] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.120320] Starting dynamic subtest: pipe-C-eDP-1
[149.140035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.147608] Starting dynamic subtest: pipe-D-eDP-1
[149.168952] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.172583] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[151.367718] [031/133] (870s left) gem_exec_basic (basic)
[151.423526] Starting subtest: basic
[151.425851] Starting dynamic subtest: rcs0-smem
[151.428174] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[151.437153] Starting dynamic subtest: bcs0-smem
[151.439101] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[151.446287] Starting dynamic subtest: vcs0-smem
[151.448141] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[151.455661] Starting dynamic subtest: vcs1-smem
[151.457840] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[151.467256] Starting dynamic subtest: vecs0-smem
[151.469130] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[151.476188] Starting dynamic subtest: ccs0-smem
[151.478310] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[151.480281] Subtest basic: SUCCESS (0.013s)
[152.962852] [032/133] (868s left) gem_mmap_offset (oob-read)
[153.019208] Starting subtest: oob-read
[153.021383] Subtest oob-read: SUCCESS (0.000s)
[153.138291] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[153.256252] Starting subtest: bad-pixel-format-yf-tiled-ccs
[153.258541] Starting dynamic subtest: pipe-A-eDP-1
[153.281694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.292073] Starting dynamic subtest: pipe-B-eDP-1
[153.313820] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.322045] Starting dynamic subtest: pipe-C-eDP-1
[153.344290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.353073] Starting dynamic subtest: pipe-D-eDP-1
[153.375277] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.379339] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[155.456206] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[155.650955] Starting subtest: cursor-random-64x21
[155.695917] Subtest cursor-random-64x21: SKIP (0.043s)
[155.960032] [035/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[156.070106] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[156.074288] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[156.185548] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[156.280295] Starting subtest: constant-alpha-max
[156.560476] Starting dynamic subtest: pipe-A-eDP-1
[157.524076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.961s)
[157.532075] Starting dynamic subtest: pipe-D-eDP-1
[159.197251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.669s)
[159.199786] Subtest constant-alpha-max: SUCCESS (2.915s)
[160.065462] [037/133] (861s left) gem_exec_fence (keep-in-fence)
[160.262767] Starting subtest: keep-in-fence
[160.264987] Starting dynamic subtest: rcs0
[160.331663] Dynamic subtest rcs0: SUCCESS (0.072s)
[160.342196] Starting dynamic subtest: bcs0
[160.383751] Dynamic subtest bcs0: SUCCESS (0.051s)
[160.394442] Starting dynamic subtest: vcs0
[161.879496] Dynamic subtest vcs0: SUCCESS (1.492s)
[161.890867] Starting dynamic subtest: vcs1
[163.926714] Dynamic subtest vcs1: SUCCESS (2.045s)
[163.937663] Starting dynamic subtest: vecs0
[165.909627] Dynamic subtest vecs0: SUCCESS (1.980s)
[165.920856] Starting dynamic subtest: ccs0
[166.144052] Dynamic subtest ccs0: SUCCESS (0.233s)
[166.147251] Subtest keep-in-fence: SUCCESS (5.885s)
[168.007890] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[168.011487] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[168.072212] Starting subtest: min-max-config-idle
[168.077118] Subtest min-max-config-idle: SKIP (0.001s)
[168.186904] [039/133] (853s left) dumb_buffer (map-invalid-size)
[168.240733] Starting subtest: map-invalid-size
[168.243051] Subtest map-invalid-size: SUCCESS (0.000s)
[168.354861] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[168.421828] Subtest basic-write-gtt: SKIP (0.000s)
[168.482045] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[168.540314] Starting subtest: set-cache-level
[168.544309] Subtest set-cache-level: SKIP (0.000s)
[168.709345] [042/133] (853s left) kms_psr (psr-primary-render)
[168.814701] Starting subtest: psr-primary-render
[168.817411] Starting dynamic subtest: eDP-1
[170.526680] Dynamic subtest eDP-1: SUCCESS (1.714s)
[170.529112] Subtest psr-primary-render: SUCCESS (1.715s)
[171.386218] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[171.555082] Starting subtest: create-ext-placement-sanity-check
[171.561863] Subtest create-ext-placement-sanity-check: SUCCESS (0.005s)
[171.688571] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[171.793370] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[171.803183] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[171.894071] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[171.972275] Starting subtest: u-lateslice
[171.974671] Starting dynamic subtest: rcs0
[171.982517] Dynamic subtest rcs0: SUCCESS (0.021s)
[171.990595] Starting dynamic subtest: bcs0
[172.001677] Dynamic subtest bcs0: SUCCESS (0.019s)
[172.009886] Starting dynamic subtest: vcs0
[172.021499] Dynamic subtest vcs0: SUCCESS (0.019s)
[172.029500] Starting dynamic subtest: vcs1
[172.039240] Dynamic subtest vcs1: SUCCESS (0.017s)
[172.047070] Starting dynamic subtest: vecs0
[172.056297] Dynamic subtest vecs0: SUCCESS (0.017s)
[172.064276] Starting dynamic subtest: ccs0
[172.074574] Dynamic subtest ccs0: SUCCESS (0.018s)
[172.076941] Subtest u-lateslice: SUCCESS (0.114s)
[174.022100] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[174.118872] Starting subtest: dpms-off-confusion-interruptible
[174.121290] Starting dynamic subtest: A-eDP1
[182.782462] Dynamic subtest A-eDP1: SUCCESS (8.662s)
[182.791773] Starting dynamic subtest: B-eDP1
[191.424121] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[191.435500] Starting dynamic subtest: C-eDP1
[200.045676] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[200.056198] Starting dynamic subtest: D-eDP1
[208.674583] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[208.680468] Subtest dpms-off-confusion-interruptible: SUCCESS (34.560s)
[209.859187] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[209.969628] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[216.858531] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.892s)
[217.018877] [048/133] (805s left) kms_plane (plane-position-hole)
[217.108317] Starting subtest: plane-position-hole
[217.646380] Starting dynamic subtest: pipe-A-plane-1
[218.970702] Dynamic subtest pipe-A-plane-1: SUCCESS (1.324s)
[218.979684] Starting dynamic subtest: pipe-A-plane-2
[220.197878] Dynamic subtest pipe-A-plane-2: SUCCESS (1.228s)
[220.206155] Starting dynamic subtest: pipe-A-plane-3
[221.433554] Dynamic subtest pipe-A-plane-3: SUCCESS (1.235s)
[221.442107] Starting dynamic subtest: pipe-A-plane-4
[222.656648] Dynamic subtest pipe-A-plane-4: SUCCESS (1.219s)
[222.665840] Starting dynamic subtest: pipe-A-plane-5
[222.681653] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[223.843142] Starting dynamic subtest: pipe-B-plane-1
[225.146979] Dynamic subtest pipe-B-plane-1: SUCCESS (1.312s)
[225.155919] Starting dynamic subtest: pipe-B-plane-2
[226.471123] Dynamic subtest pipe-B-plane-2: SUCCESS (1.324s)
[226.483488] Starting dynamic subtest: pipe-B-plane-3
[227.748125] Dynamic subtest pipe-B-plane-3: SUCCESS (1.275s)
[227.756961] Starting dynamic subtest: pipe-B-plane-4
[229.084651] Dynamic subtest pipe-B-plane-4: SUCCESS (1.337s)
[229.092759] Starting dynamic subtest: pipe-B-plane-5
[229.111420] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[229.113765] Subtest plane-position-hole: SUCCESS (12.004s)
[229.939816] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[230.041136] Starting subtest: draw-method-mmap-cpu
[230.043348] Starting dynamic subtest: xrgb8888-untiled
[230.283510] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[230.291947] Starting dynamic subtest: rgb565-untiled
[230.505644] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[230.514080] Starting dynamic subtest: xrgb2101010-untiled
[230.728234] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[230.736686] Starting dynamic subtest: xbgr16161616f-untiled
[230.950037] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[230.959058] Starting dynamic subtest: xrgb8888-xtiled
[231.094644] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[231.102504] Starting dynamic subtest: rgb565-xtiled
[231.227743] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[231.235185] Starting dynamic subtest: xrgb2101010-xtiled
[231.350089] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[231.359205] Starting dynamic subtest: xbgr16161616f-xtiled
[231.472299] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[231.480095] Starting dynamic subtest: xrgb8888-4tiled
[231.616709] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[231.624464] Starting dynamic subtest: rgb565-4tiled
[231.761341] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[231.769075] Starting dynamic subtest: xrgb2101010-4tiled
[231.894787] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[231.902564] Starting dynamic subtest: xbgr16161616f-4tiled
[232.027975] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[232.029898] Subtest draw-method-mmap-cpu: SUCCESS (1.989s)
[232.132812] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[232.194752] Subtest medium-copy-XY: SKIP (0.000s)
[232.252771] [051/133] (790s left) vgem_basic (bad-flag)
[232.298024] Starting subtest: bad-flag
[232.299744] Subtest bad-flag: SUCCESS (0.000s)
[232.363713] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[232.419018] Starting subtest: engines-hostile-preempt
[232.420722] Starting dynamic subtest: rcs0
[232.524600] Dynamic subtest rcs0: SUCCESS (0.107s)
[232.535891] Starting dynamic subtest: bcs0
[232.592588] Dynamic subtest bcs0: SUCCESS (0.066s)
[232.602278] Starting dynamic subtest: vcs0
[233.946804] Dynamic subtest vcs0: SUCCESS (1.351s)
[233.957870] Starting dynamic subtest: vcs1
[235.908308] Dynamic subtest vcs1: SUCCESS (1.959s)
[235.918809] Starting dynamic subtest: vecs0
[237.891913] Dynamic subtest vecs0: SUCCESS (1.981s)
[237.903538] Starting dynamic subtest: ccs0
[238.001457] Dynamic subtest ccs0: SUCCESS (0.108s)
[238.004149] Subtest engines-hostile-preempt: SUCCESS (5.584s)
[238.096109] [053/133] (784s left) kms_sequence (queue-idle)
[238.191780] Starting subtest: queue-idle
[238.193674] Starting dynamic subtest: pipe-A-eDP-1
[239.997259] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.803s)
[240.006387] Starting dynamic subtest: pipe-B-eDP-1
[242.502850] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[242.511941] Starting dynamic subtest: pipe-C-eDP-1
[244.906791] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.401s)
[244.915124] Starting dynamic subtest: pipe-D-eDP-1
[247.351503] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.443s)
[247.353640] Subtest queue-idle: SUCCESS (9.159s)
[248.173013] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[248.280076] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[248.282427] Starting dynamic subtest: pipe-A-eDP-1
[248.355481] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[248.364887] Starting dynamic subtest: pipe-B-eDP-1
[249.445726] Dynamic subtest pipe-B-eDP-1: SKIP (1.088s)
[249.449828] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.168s)
[250.748492] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[250.849538] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[250.853976] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[250.978578] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[251.082528] Starting subtest: atomic-plane-damage
[251.130762] Starting dynamic subtest: pipe-A-eDP-1
[251.661080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[251.663483] Subtest atomic-plane-damage: SUCCESS (0.579s)
[252.483095] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[252.591853] Starting subtest: linear-16bpp-rotate-90
[252.611528] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[252.750098] [058/133] (770s left) perf (stress-open-close)
[252.893546] Starting subtest: stress-open-close
[252.895613] Starting dynamic subtest: 0-rcs0
[255.059138] Dynamic subtest 0-rcs0: SUCCESS (2.167s)
[255.068043] Starting dynamic subtest: 1-vcs1
[257.224136] Dynamic subtest 1-vcs1: SUCCESS (2.164s)
[257.225943] Subtest stress-open-close: SUCCESS (4.333s)
[257.271905] [059/133] (765s left) gem_workarounds (basic-read-fd)
[257.345676] Starting subtest: basic-read-fd
[257.361973] Subtest basic-read-fd: SUCCESS (0.016s)
[257.532946] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[257.654063] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[258.688364] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.033s)
[258.836807] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[258.943867] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[258.947237] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[259.060196] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[259.155970] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[259.159447] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[259.273853] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[259.372507] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[259.375884] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[259.497154] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[259.653314] Starting subtest: cursor-offscreen-32x10
[259.699108] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[259.971512] [065/133] (763s left) kms_psr (psr2-primary-render)
[260.055370] Starting subtest: psr2-primary-render
[260.057219] Starting dynamic subtest: eDP-1
[261.769463] Dynamic subtest eDP-1: SUCCESS (1.713s)
[261.771712] Subtest psr2-primary-render: SUCCESS (1.714s)
[262.651811] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[262.755789] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[262.759689] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[262.874525] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[263.049229] Starting subtest: noreorder-priority
[263.051720] Starting dynamic subtest: rcs0
[264.205672] Dynamic subtest rcs0: SUCCESS (1.156s)
[264.216641] Starting dynamic subtest: vcs0
[265.908838] Dynamic subtest vcs0: SUCCESS (1.700s)
[265.919966] Starting dynamic subtest: vcs1
[267.946030] Dynamic subtest vcs1: SUCCESS (2.035s)
[267.957037] Starting dynamic subtest: vecs0
[269.922970] Dynamic subtest vecs0: SUCCESS (1.974s)
[269.934127] Starting dynamic subtest: ccs0
[271.106973] Dynamic subtest ccs0: SUCCESS (1.182s)
[271.109657] Subtest noreorder-priority: SUCCESS (8.059s)
[271.306606] [068/133] (751s left) gem_softpin (allocator-evict)
[271.373100] Starting subtest: allocator-evict
[271.376250] Starting dynamic subtest: rcs0
[295.170757] Dynamic subtest rcs0: SUCCESS (23.796s)
[295.180067] Starting dynamic subtest: bcs0
[318.847224] Dynamic subtest bcs0: SUCCESS (23.673s)
[318.858706] Starting dynamic subtest: vcs0
[342.768436] Dynamic subtest vcs0: SUCCESS (23.919s)
[342.780098] Starting dynamic subtest: vcs1
[366.420585] Dynamic subtest vcs1: SUCCESS (23.649s)
[366.431220] Starting dynamic subtest: vecs0
[390.054132] Dynamic subtest vecs0: SUCCESS (23.632s)
[390.066104] Starting dynamic subtest: ccs0
[413.757769] Dynamic subtest ccs0: SUCCESS (23.700s)
[413.760818] Subtest allocator-evict: SUCCESS (142.379s)
[413.853254] [069/133] (609s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[413.998032] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[418.986968] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.994s)
[420.129763] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[420.198162] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[420.275195] [071/133] (603s left) gem_ctx_shared (single-timeline)
[420.327180] Starting subtest: single-timeline
[420.348421] Subtest single-timeline: SUCCESS (0.015s)
[420.619309] [072/133] (602s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[420.678838] Starting subtest: etime-multi-wait-all-for-submit-submitted
[420.783432] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[420.870917] [073/133] (602s left) syncobj_timeline (etime-single-wait-all-submitted)
[420.932212] Starting subtest: etime-single-wait-all-submitted
[421.039923] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[421.124898] [074/133] (602s left) kms_chamelium_hpd (dp-hpd-storm)
[421.506303] Subtest dp-hpd-storm: SKIP (0.000s)
[422.319869] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[422.424993] Starting subtest: 2x-flip-vs-suspend
[422.434438] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[422.554822] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[422.641095] Starting subtest: fbc-psr2-sprite-plane-move
[422.643382] Starting dynamic subtest: eDP-1
[422.647629] Dynamic subtest eDP-1: SKIP (0.000s)
[422.651794] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[422.725836] [077/133] (600s left) gem_exec_params (mmapped)
[422.794480] Starting subtest: mmapped
[422.796745] Subtest mmapped: SUCCESS (0.002s)
[422.958446] [078/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[423.059408] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[423.063312] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[423.180180] [079/133] (600s left) sw_sync (sync_merge_invalid)
[423.223303] Starting subtest: sync_merge_invalid
[423.248587] Subtest sync_merge_invalid: SUCCESS (0.026s)
[423.320178] [080/133] (600s left) perf_pmu (busy)
[423.358563] Starting subtest: busy
[423.360308] Starting dynamic subtest: rcs0
[423.961908] Dynamic subtest rcs0: SUCCESS (0.603s)
[423.976678] Starting dynamic subtest: bcs0
[424.536494] Dynamic subtest bcs0: SUCCESS (0.573s)
[424.548071] Starting dynamic subtest: vcs0
[425.877110] Dynamic subtest vcs0: SUCCESS (1.337s)
[425.888820] Starting dynamic subtest: vcs1
[427.925394] Dynamic subtest vcs1: SUCCESS (2.045s)
[427.937516] Starting dynamic subtest: vecs0
[429.909457] Dynamic subtest vecs0: SUCCESS (1.981s)
[429.921649] Starting dynamic subtest: ccs0
[430.483218] Dynamic subtest ccs0: SUCCESS (0.573s)
[430.485673] Subtest busy: SUCCESS (7.126s)
[430.618137] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[430.670992] Starting subtest: multi-wait-for-submit-submitted-signaled
[430.673279] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[430.806212] [082/133] (593s left) gem_mmap_wc (write-wc-read-gtt)
[430.878752] Subtest write-wc-read-gtt: SKIP (0.000s)
[430.952688] [083/133] (592s left) kms_hdmi_inject (inject-audio)
[431.317934] Starting subtest: inject-audio
[431.597207] Subtest inject-audio: SUCCESS (0.281s)
[432.233057] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[432.334303] Starting subtest: 2x-blocking-wf_vblank
[432.344243] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[432.437233] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[432.536450] Starting subtest: plane-all-transition-nonblocking-fencing
[432.538725] Starting dynamic subtest: pipe-A-eDP-1
[435.030612] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[435.349664] Starting dynamic subtest: pipe-B-eDP-1
[438.578329] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.237s)
[438.881608] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.345s)
[439.690356] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[439.822528] Starting subtest: flip-vs-cursor-crc-legacy
[440.560615] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.737s)
[441.384461] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[441.492922] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[441.497167] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[441.571258] [088/133] (582s left) gem_exec_params (invalid-ring2)
[441.637614] Starting subtest: invalid-ring2
[441.639936] Subtest invalid-ring2: SUCCESS (0.000s)
[441.791603] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[441.894601] Starting subtest: fbcpsr-slowdraw
[467.057076] Subtest fbcpsr-slowdraw: SUCCESS (25.165s)
[467.229943] [090/133] (556s left) kms_joiner (basic-force-ultra-joiner)
[467.341534] Starting subtest: basic-force-ultra-joiner
[467.345602] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[467.418956] [091/133] (556s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[467.518120] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[467.544081] Starting dynamic subtest: pipe-A-plane-0
[467.832016] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[467.840608] Starting dynamic subtest: pipe-A-plane-3
[468.065612] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[469.130511] Starting dynamic subtest: pipe-B-plane-0
[469.423118] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[469.432333] Starting dynamic subtest: pipe-B-plane-3
[469.656772] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[469.971837] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.455s)
[470.784827] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[470.878924] Starting subtest: query-forked-busy-hang
[470.881064] Starting dynamic subtest: pipe-A-eDP-1
[497.684100] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.802s)
[497.698379] Starting dynamic subtest: pipe-D-eDP-1
[522.652927] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.968s)
[522.655143] Subtest query-forked-busy-hang: SUCCESS (51.775s)
[523.483664] [093/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[523.599445] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[523.603447] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[523.709156] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[523.813108] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[524.415103] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[524.589578] [095/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[524.686437] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[524.688715] Starting dynamic subtest: pipe-A-default-mode
[527.334937] Dynamic subtest pipe-A-default-mode: SUCCESS (2.648s)
[527.337334] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.650s)
[528.178799] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[528.237171] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[528.345064] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[528.433251] [097/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[528.538087] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[528.542368] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[528.665979] [098/133] (495s left) gem_exec_whisper (basic-fds-forked)
[528.726714] Starting subtest: basic-fds-forked
[553.009914] Subtest basic-fds-forked: SUCCESS (24.279s)
[553.207185] [099/133] (471s left) kms_addfb_basic (bad-pitch-999)
[553.270767] Starting subtest: bad-pitch-999
[553.273037] Subtest bad-pitch-999: SUCCESS (0.000s)
[553.436254] [100/133] (471s left) kms_prop_blob (basic)
[553.491915] Starting subtest: basic
[553.494279] Subtest basic: SUCCESS (0.000s)
[553.604097] [101/133] (471s left) syncobj_basic (bad-pad-fd-to-handle)
[553.666029] Starting subtest: bad-pad-fd-to-handle
[553.668407] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[553.796631] [102/133] (470s left) kms_cursor_crc (cursor-sliding-256x256)
[554.031658] Starting subtest: cursor-sliding-256x256
[554.036325] Starting dynamic subtest: pipe-A-eDP-1
[557.311031] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.275s)
[557.340480] Starting dynamic subtest: pipe-D-eDP-1
[561.233231] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.898s)
[561.235460] Subtest cursor-sliding-256x256: SUCCESS (7.199s)
[562.077848] [103/133] (462s left) gem_busy (busy)
[562.151585] Starting subtest: busy
[562.153979] Starting dynamic subtest: all-engines
[562.232729] Dynamic subtest all-engines: SUCCESS (0.081s)
[562.243880] Starting dynamic subtest: rcs0
[563.931798] Dynamic subtest rcs0: SUCCESS (1.698s)
[563.942076] Starting dynamic subtest: bcs0
[564.008775] Dynamic subtest bcs0: SUCCESS (0.074s)
[564.018801] Starting dynamic subtest: vcs0
[564.046707] Dynamic subtest vcs0: SUCCESS (0.038s)
[564.054781] Starting dynamic subtest: vcs1
[565.913732] Dynamic subtest vcs1: SUCCESS (1.863s)
[565.923904] Starting dynamic subtest: vecs0
[567.898790] Dynamic subtest vecs0: SUCCESS (1.983s)
[567.908036] Starting dynamic subtest: ccs0
[569.944888] Dynamic subtest ccs0: SUCCESS (2.046s)
[569.947306] Subtest busy: SUCCESS (7.792s)
[570.322704] [104/133] (454s left) i915_pm_rps (thresholds)
[570.380932] Starting subtest: thresholds
[570.385563] Subtest thresholds: SKIP (0.001s)
[570.523259] [105/133] (454s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[570.614782] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[570.616983] Starting dynamic subtest: pipe-A-eDP-1
[570.638414] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.648664] Starting dynamic subtest: pipe-B-eDP-1
[570.669487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.677677] Starting dynamic subtest: pipe-C-eDP-1
[570.698318] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.706266] Starting dynamic subtest: pipe-D-eDP-1
[570.727713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.732066] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[572.871924] [106/133] (451s left) gem_softpin (evict-snoop-interruptible)
[572.936802] Starting subtest: evict-snoop-interruptible
[572.941369] Subtest evict-snoop-interruptible: SKIP (0.000s)
[573.063047] [107/133] (451s left) gem_mmap_gtt (big-bo)
[573.116729] Subtest big-bo: SKIP (0.000s)
[573.180451] [108/133] (451s left) gem_partial_pwrite_pread (write-display)
[573.240150] Subtest write-display: SKIP (0.000s)
[573.311458] [109/133] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[573.396862] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[573.399122] Starting dynamic subtest: pipe-A-eDP-1
[573.421155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[573.430228] Starting dynamic subtest: pipe-B-eDP-1
[573.450497] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[573.459082] Starting dynamic subtest: pipe-C-eDP-1
[573.480306] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[573.488782] Starting dynamic subtest: pipe-D-eDP-1
[573.510136] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[573.514404] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[575.685938] [110/133] (449s left) kms_psr (fbc-pr-cursor-blt)
[575.787773] Starting subtest: fbc-pr-cursor-blt
[575.792145] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[575.885831] [111/133] (449s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[575.948588] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[575.950916] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[576.074743] [112/133] (449s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[576.144612] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[576.148707] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[576.344255] [113/133] (448s left) gem_mmap (basic)
[576.415805] Subtest basic: SKIP (0.000s)
[576.482859] [114/133] (448s left) gem_exec_gttfill (basic)
[576.550542] Starting subtest: basic
[579.096881] Subtest basic: SUCCESS (2.546s)
[579.303471] [115/133] (445s left) kms_addfb_basic (size-max)
[579.468140] Starting subtest: size-max
[579.470296] Subtest size-max: SUCCESS (0.000s)
[579.593330] [116/133] (445s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[579.685052] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[579.687174] Starting dynamic subtest: pipe-A-eDP-1
[579.709166] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[579.719422] Starting dynamic subtest: pipe-B-eDP-1
[579.740744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[579.749427] Starting dynamic subtest: pipe-C-eDP-1
[579.770171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[579.778450] Starting dynamic subtest: pipe-D-eDP-1
[579.800683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[579.804718] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[581.977204] [117/133] (443s left) api_intel_bb (purge-bb)
[582.034893] Starting subtest: purge-bb
[582.037109] Subtest purge-bb: SUCCESS (0.004s)
[582.198471] [118/133] (443s left) kms_cursor_legacy (forked-move)
[582.321443] Starting subtest: forked-move
[582.323762] Starting dynamic subtest: pipe-A
[587.774435] Dynamic subtest pipe-A: SUCCESS (5.451s)
[587.785431] Starting dynamic subtest: pipe-B
[593.239206] Dynamic subtest pipe-B: SUCCESS (5.462s)
[593.249789] Starting dynamic subtest: pipe-C
[598.771983] Dynamic subtest pipe-C: SUCCESS (5.530s)
[598.787162] Starting dynamic subtest: pipe-D
[604.270941] Dynamic subtest pipe-D: SUCCESS (5.497s)
[604.285867] Starting dynamic subtest: all-pipes
[609.787245] Dynamic subtest all-pipes: SUCCESS (5.514s)
[609.789757] Subtest forked-move: SUCCESS (27.463s)
[609.964462] [119/133] (415s left) gen9_exec_parse (bb-chained)
[610.037063] Subtest bb-chained: SKIP (0.000s)
[610.133792] [120/133] (415s left) kms_concurrent (multi-plane-atomic-lowres)
[610.238016] Starting subtest: multi-plane-atomic-lowres
[610.240250] Starting dynamic subtest: pipe-A-eDP-1
[610.729440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[610.731882] Subtest multi-plane-atomic-lowres: SUCCESS (0.492s)
[611.589315] [121/133] (413s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[611.649511] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[611.726333] [122/133] (413s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[611.799485] Starting subtest: multi-wait-available-unsubmitted-submitted
[611.801724] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[611.911134] [123/133] (413s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[612.007284] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[616.500800] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.496s)
[617.683715] [124/133] (407s left) kms_pm_dc (dc3co-vpb-simulation)
[618.791412] Starting subtest: dc3co-vpb-simulation
[627.742939] Subtest dc3co-vpb-simulation: SKIP (8.948s)
[627.906165] [125/133] (397s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[628.033394] Starting subtest: x-tiled-8bpp-rotate-90
[628.057157] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[628.211045] [126/133] (397s left) kms_plane_multiple (2x-tiling-none)
[628.309853] Starting subtest: 2x-tiling-none
[628.314269] Subtest 2x-tiling-none: SKIP (0.000s)
[628.410356] [127/133] (397s left) gem_exec_balancer (bonded-false-hang)
[628.677375] Starting subtest: bonded-false-hang
[628.682757] Subtest bonded-false-hang: SKIP (0.000s)
[628.790254] [128/133] (396s left) i915_drm_fdinfo (idle)
[628.830793] Starting subtest: idle
[628.832782] Starting dynamic subtest: rcs0
[629.443372] Dynamic subtest rcs0: SUCCESS (0.613s)
[629.455397] Starting dynamic subtest: bcs0
[629.950281] Dynamic subtest bcs0: SUCCESS (0.503s)
[629.962318] Starting dynamic subtest: vcs0
[630.456321] Dynamic subtest vcs0: SUCCESS (0.503s)
[630.466916] Starting dynamic subtest: vcs1
[630.961781] Dynamic subtest vcs1: SUCCESS (0.503s)
[630.974401] Starting dynamic subtest: vecs0
[631.467789] Dynamic subtest vecs0: SUCCESS (0.503s)
[631.479652] Starting dynamic subtest: ccs0
[631.973096] Dynamic subtest ccs0: SUCCESS (0.503s)
[631.975796] Subtest idle: SUCCESS (3.143s)
[632.061322] [129/133] (393s left) kms_getfb (getfb2-handle-closed)
[632.163835] Starting subtest: getfb2-handle-closed
[632.166124] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[632.305342] [130/133] (393s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[632.376719] Starting subtest: invalid-bsd1-flag-on-vebox
[632.378812] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[632.502671] [131/133] (393s left) kms_psr (fbc-pr-suspend)
[632.601416] Starting subtest: fbc-pr-suspend
[632.605718] Subtest fbc-pr-suspend: SKIP (0.000s)
[632.702178] [132/133] (393s left) gem_softpin (overlap)
[632.767184] Starting subtest: overlap
[633.644638] Subtest overlap: SUCCESS (0.876s)
[633.797688] [133/133] (392s left) gem_madvise (dontneed-before-mmap)
[633.830165] Starting subtest: dontneed-before-mmap
[633.851352] Subtest dontneed-before-mmap: SUCCESS (0.021s)
[633.982310] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: i915_drm_fdinfo
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: syncobj_basic
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_exec_basic
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane_alpha_blend
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: i915_pm_rps
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: kms_draw_crc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: vgem_basic
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_sequence
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_atomic
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_softpin
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_ctx_shared
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_hdmi_inject
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_addfb_basic
results: parsing output: 99/ for test: kms_prop_blob
results: parsing output: 100/ for test: syncobj_basic
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_busy
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_partial_pwrite_pread
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: gem_exec_gttfill
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_concurrent
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pm_dc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gem_madvise
Done.