[57.291347] Initializing watchdogs
[57.291388]   /dev/watchdog0
[57.304367] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.308638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.310767] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.314117] [001/133] (960s left) perf_pmu (busy-start)
[57.372985] Starting subtest: busy-start
[57.375230] Starting dynamic subtest: rcs0
[59.927193] Dynamic subtest rcs0: SUCCESS (2.554s)
[59.937081] Starting dynamic subtest: bcs0
[62.476744] Dynamic subtest bcs0: SUCCESS (2.548s)
[62.485571] Starting dynamic subtest: vcs0
[65.940645] Dynamic subtest vcs0: SUCCESS (3.463s)
[65.949574] Starting dynamic subtest: vcs1
[69.908230] Dynamic subtest vcs1: SUCCESS (3.966s)
[69.918005] Starting dynamic subtest: vecs0
[73.940930] Dynamic subtest vecs0: SUCCESS (4.031s)
[73.950419] Starting dynamic subtest: ccs0
[76.488780] Dynamic subtest ccs0: SUCCESS (2.549s)
[76.491391] Subtest busy-start: SUCCESS (19.117s)
[76.597040] [002/133] (941s left) gem_exec_flush (basic-wb-rw-before-default)
[76.671396] Starting subtest: basic-wb-rw-before-default
[82.137734] Subtest basic-wb-rw-before-default: SUCCESS (5.466s)
[82.338106] [003/133] (935s left) kms_lease (lessee-list)
[82.432068] Starting subtest: lessee-list
[82.434444] Starting dynamic subtest: pipe-A-eDP-1
[82.436746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[82.445072] Starting dynamic subtest: pipe-B-eDP-1
[82.447270] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[82.454159] Starting dynamic subtest: pipe-C-eDP-1
[82.456272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[82.463193] Starting dynamic subtest: pipe-D-eDP-1
[82.465350] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[82.467514] Subtest lessee-list: SUCCESS (0.010s)
[82.566184] [004/133] (935s left) i915_drm_fdinfo (virtual-busy-hang-all)
[82.604834] Starting subtest: virtual-busy-hang-all
[82.609019] Subtest virtual-busy-hang-all: SKIP (0.000s)
[82.683807] [005/133] (935s left) kms_atomic_interruptible (legacy-setmode)
[82.789632] Starting subtest: legacy-setmode
[82.791938] Starting dynamic subtest: pipe-A-eDP-1
[89.657749] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.867s)
[89.660916] Subtest legacy-setmode: SUCCESS (6.868s)
[90.463263] [006/133] (927s left) kms_color (ctm-max)
[90.562077] Starting subtest: ctm-max
[90.564465] Starting dynamic subtest: pipe-A-eDP-1
[91.302030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[91.309996] Starting dynamic subtest: pipe-B-eDP-1
[92.678169] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s)
[92.686890] Starting dynamic subtest: pipe-C-eDP-1
[94.051656] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[94.060471] Starting dynamic subtest: pipe-D-eDP-1
[95.384846] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[95.387149] Subtest ctm-max: SUCCESS (4.820s)
[96.194532] [007/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[96.304483] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[100.545198] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.245s)
[101.699881] [008/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[101.803802] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[101.808350] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.934415] [009/133] (916s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[102.030067] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[102.032425] Starting dynamic subtest: pipe-A
[102.050073] Dynamic subtest pipe-A: SKIP (0.017s)
[102.058503] Starting dynamic subtest: pipe-B
[102.080253] Dynamic subtest pipe-B: SKIP (0.029s)
[102.087718] Starting dynamic subtest: pipe-C
[102.109676] Dynamic subtest pipe-C: SKIP (0.030s)
[102.117075] Starting dynamic subtest: pipe-D
[102.138296] Dynamic subtest pipe-D: SKIP (0.030s)
[102.141970] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.107s)
[102.261744] [010/133] (915s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[102.373815] Starting subtest: y-tiled-64bpp-rotate-180
[102.378350] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[102.498039] [011/133] (915s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[102.596967] Starting subtest: primary-x-tiled-reflect-x-180
[109.634643] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.039s)
[110.847772] [012/133] (907s left) kms_flip (2x-flip-vs-expired-vblank)
[110.934158] Starting subtest: 2x-flip-vs-expired-vblank
[110.942247] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[111.072180] [013/133] (907s left) api_intel_allocator (fork-simple-stress)
[111.127590] Starting subtest: fork-simple-stress
[116.525998] Subtest fork-simple-stress: SUCCESS (5.400s)
[116.660744] [014/133] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[116.767708] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[123.253871] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.491s)
[123.410166] [015/133] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[123.519724] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[123.524105] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[123.640031] [016/133] (894s left) gem_mmap (bad-size)
[123.704068] Subtest bad-size: SKIP (0.000s)
[123.773352] [017/133] (894s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[123.834232] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[123.838225] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[124.025591] [018/133] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[124.134807] Starting subtest: psr-2p-primscrn-cur-indfb-move
[124.139383] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[124.245895] [019/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[124.355740] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[130.832133] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.481s)
[130.957275] [020/133] (887s left) syncobj_timeline (wait-all-snapshot)
[131.018677] Starting subtest: wait-all-snapshot
[131.098716] Subtest wait-all-snapshot: SUCCESS (0.081s)
[131.195279] [021/133] (887s left) gem_partial_pwrite_pread (reads)
[131.268607] Subtest reads: SKIP (0.000s)
[131.330802] [022/133] (887s left) syncobj_basic (create-signaled)
[131.384180] Starting subtest: create-signaled
[131.386532] Subtest create-signaled: SUCCESS (0.000s)
[131.513770] [023/133] (887s left) kms_chamelium_frames (dp-crc-multiple)
[131.897548] Subtest dp-crc-multiple: SKIP (0.000s)
[132.683786] [024/133] (885s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[132.808458] Starting subtest: cursorA-vs-flipA-varying-size
[143.975878] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.166s)
[144.841762] [025/133] (873s left) gem_ctx_persistence (hang)
[144.910059] Starting subtest: hang
[144.914501] Subtest hang: SKIP (0.000s)
[145.022169] [026/133] (873s left) kms_psr (pr-primary-page-flip)
[145.113937] Starting subtest: pr-primary-page-flip
[145.118117] Subtest pr-primary-page-flip: SKIP (0.000s)
[145.194698] [027/133] (873s left) gem_lmem_swapping (heavy-random)
[145.237492] Subtest heavy-random: SKIP (0.000s)
[145.282165] [028/133] (873s left) kms_addfb_basic (master-rmfb)
[145.341895] Starting subtest: master-rmfb
[145.344070] Subtest master-rmfb: SUCCESS (0.001s)
[145.492685] [029/133] (873s left) kms_addfb_basic (invalid-get-prop-any)
[145.550742] Starting subtest: invalid-get-prop-any
[145.553232] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[145.699632] [030/133] (873s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[145.786211] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[145.788375] Starting dynamic subtest: pipe-A-eDP-1
[145.809042] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.818816] Starting dynamic subtest: pipe-B-eDP-1
[145.837568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.844713] Starting dynamic subtest: pipe-C-eDP-1
[145.863517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.870562] Starting dynamic subtest: pipe-D-eDP-1
[145.890036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.893393] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[148.030647] [031/133] (870s left) gem_exec_basic (basic)
[148.085981] Starting subtest: basic
[148.088323] Starting dynamic subtest: rcs0-smem
[148.090705] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[148.099816] Starting dynamic subtest: bcs0-smem
[148.101736] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[148.108837] Starting dynamic subtest: vcs0-smem
[148.110756] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[148.117801] Starting dynamic subtest: vcs1-smem
[148.119738] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[148.126790] Starting dynamic subtest: vecs0-smem
[148.128661] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[148.135762] Starting dynamic subtest: ccs0-smem
[148.137723] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[148.139647] Subtest basic: SUCCESS (0.012s)
[149.955013] [032/133] (869s left) gem_mmap_offset (oob-read)
[150.009195] Starting subtest: oob-read
[150.011445] Subtest oob-read: SUCCESS (0.001s)
[150.126247] [033/133] (868s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[150.219872] Starting subtest: bad-pixel-format-yf-tiled-ccs
[150.222045] Starting dynamic subtest: pipe-A-eDP-1
[150.243477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[150.251580] Starting dynamic subtest: pipe-B-eDP-1
[150.272192] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[150.279599] Starting dynamic subtest: pipe-C-eDP-1
[150.300337] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[150.308089] Starting dynamic subtest: pipe-D-eDP-1
[150.330722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[150.334911] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[152.494729] [034/133] (866s left) kms_cursor_crc (cursor-random-64x21)
[152.666868] Starting subtest: cursor-random-64x21
[152.711283] Subtest cursor-random-64x21: SKIP (0.039s)
[152.958993] [035/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[153.054573] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[153.058896] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[153.175208] [036/133] (865s left) kms_plane_alpha_blend (constant-alpha-max)
[153.268057] Starting subtest: constant-alpha-max
[153.552120] Starting dynamic subtest: pipe-A-eDP-1
[154.473317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.918s)
[154.481271] Starting dynamic subtest: pipe-D-eDP-1
[156.084049] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.609s)
[156.086382] Subtest constant-alpha-max: SUCCESS (2.816s)
[156.949183] [037/133] (862s left) gem_exec_fence (keep-in-fence)
[157.123484] Starting subtest: keep-in-fence
[157.125888] Starting dynamic subtest: rcs0
[157.215393] Dynamic subtest rcs0: SUCCESS (0.091s)
[157.224997] Starting dynamic subtest: bcs0
[157.269045] Dynamic subtest bcs0: SUCCESS (0.052s)
[157.278382] Starting dynamic subtest: vcs0
[158.933964] Dynamic subtest vcs0: SUCCESS (1.662s)
[158.942804] Starting dynamic subtest: vcs1
[160.917070] Dynamic subtest vcs1: SUCCESS (1.981s)
[160.927967] Starting dynamic subtest: vecs0
[162.901054] Dynamic subtest vecs0: SUCCESS (1.982s)
[162.911653] Starting dynamic subtest: ccs0
[163.154723] Dynamic subtest ccs0: SUCCESS (0.253s)
[163.157831] Subtest keep-in-fence: SUCCESS (6.032s)
[165.057604] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[165.060985] [038/133] (854s left) i915_pm_rps (min-max-config-idle)
[165.133162] Starting subtest: min-max-config-idle
[165.137815] Subtest min-max-config-idle: SKIP (0.001s)
[165.261535] [039/133] (853s left) dumb_buffer (map-invalid-size)
[165.323257] Starting subtest: map-invalid-size
[165.325341] Subtest map-invalid-size: SUCCESS (0.000s)
[165.445396] [040/133] (853s left) gem_mmap_gtt (basic-write-gtt)
[165.505327] Subtest basic-write-gtt: SKIP (0.000s)
[165.592495] [041/133] (853s left) gem_userptr_blits (set-cache-level)
[165.651630] Starting subtest: set-cache-level
[165.655726] Subtest set-cache-level: SKIP (0.000s)
[165.831218] [042/133] (853s left) kms_psr (psr-primary-render)
[165.928798] Starting subtest: psr-primary-render
[165.931123] Starting dynamic subtest: eDP-1
[167.628404] Dynamic subtest eDP-1: SUCCESS (1.699s)
[167.630604] Subtest psr-primary-render: SUCCESS (1.700s)
[168.501932] [043/133] (850s left) gem_create (create-ext-placement-sanity-check)
[168.673648] Starting subtest: create-ext-placement-sanity-check
[168.676365] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[168.814845] [044/133] (850s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[168.912432] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[168.922727] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[169.010385] [045/133] (850s left) gem_exec_schedule (u-lateslice)
[169.098615] Starting subtest: u-lateslice
[169.100681] Starting dynamic subtest: rcs0
[169.109362] Dynamic subtest rcs0: SUCCESS (0.021s)
[169.119115] Starting dynamic subtest: bcs0
[169.128719] Dynamic subtest bcs0: SUCCESS (0.019s)
[169.136232] Starting dynamic subtest: vcs0
[169.146979] Dynamic subtest vcs0: SUCCESS (0.018s)
[169.154875] Starting dynamic subtest: vcs1
[169.164655] Dynamic subtest vcs1: SUCCESS (0.017s)
[169.171992] Starting dynamic subtest: vecs0
[169.182325] Dynamic subtest vecs0: SUCCESS (0.017s)
[169.189596] Starting dynamic subtest: ccs0
[169.200665] Dynamic subtest ccs0: SUCCESS (0.018s)
[169.202802] Subtest u-lateslice: SUCCESS (0.113s)
[171.031073] [046/133] (848s left) kms_flip (dpms-off-confusion-interruptible)
[171.126701] Starting subtest: dpms-off-confusion-interruptible
[171.129102] Starting dynamic subtest: A-eDP1
[179.788050] Dynamic subtest A-eDP1: SUCCESS (8.660s)
[179.796317] Starting dynamic subtest: B-eDP1
[188.427244] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[188.436734] Starting dynamic subtest: C-eDP1
[197.051877] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[197.062926] Starting dynamic subtest: D-eDP1
[205.690027] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[205.695410] Subtest dpms-off-confusion-interruptible: SUCCESS (34.567s)
[206.873464] [047/133] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[206.975614] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[213.769595] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.796s)
[213.954565] [048/133] (805s left) kms_plane (plane-position-hole)
[214.050383] Starting subtest: plane-position-hole
[214.564080] Starting dynamic subtest: pipe-A-plane-1
[215.917233] Dynamic subtest pipe-A-plane-1: SUCCESS (1.354s)
[215.926150] Starting dynamic subtest: pipe-A-plane-2
[217.229293] Dynamic subtest pipe-A-plane-2: SUCCESS (1.310s)
[217.237664] Starting dynamic subtest: pipe-A-plane-3
[218.546557] Dynamic subtest pipe-A-plane-3: SUCCESS (1.319s)
[218.555671] Starting dynamic subtest: pipe-A-plane-4
[219.781183] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[219.790038] Starting dynamic subtest: pipe-A-plane-5
[219.804199] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[220.926994] Starting dynamic subtest: pipe-B-plane-1
[222.147918] Dynamic subtest pipe-B-plane-1: SUCCESS (1.228s)
[222.163372] Starting dynamic subtest: pipe-B-plane-2
[223.388905] Dynamic subtest pipe-B-plane-2: SUCCESS (1.239s)
[223.397892] Starting dynamic subtest: pipe-B-plane-3
[224.616316] Dynamic subtest pipe-B-plane-3: SUCCESS (1.225s)
[224.624960] Starting dynamic subtest: pipe-B-plane-4
[225.880865] Dynamic subtest pipe-B-plane-4: SUCCESS (1.264s)
[225.889669] Starting dynamic subtest: pipe-B-plane-5
[225.905735] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[225.907885] Subtest plane-position-hole: SUCCESS (11.856s)
[226.766064] [049/133] (792s left) kms_draw_crc (draw-method-mmap-cpu)
[226.875923] Starting subtest: draw-method-mmap-cpu
[226.877813] Starting dynamic subtest: xrgb8888-untiled
[227.083306] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[227.091502] Starting dynamic subtest: rgb565-untiled
[227.283315] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[227.291735] Starting dynamic subtest: xrgb2101010-untiled
[227.483106] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[227.491064] Starting dynamic subtest: xbgr16161616f-untiled
[227.705060] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[227.712836] Starting dynamic subtest: xrgb8888-xtiled
[227.827207] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[227.835156] Starting dynamic subtest: rgb565-xtiled
[227.949812] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[227.957531] Starting dynamic subtest: xrgb2101010-xtiled
[228.071936] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[228.081127] Starting dynamic subtest: xbgr16161616f-xtiled
[228.182996] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[228.190759] Starting dynamic subtest: xrgb8888-4tiled
[228.316306] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[228.323908] Starting dynamic subtest: rgb565-4tiled
[228.449694] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[228.457456] Starting dynamic subtest: xrgb2101010-4tiled
[228.571961] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[228.579981] Starting dynamic subtest: xbgr16161616f-4tiled
[228.705252] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[228.706938] Subtest draw-method-mmap-cpu: SUCCESS (1.834s)
[228.809132] [050/133] (790s left) gem_mmap_gtt (medium-copy-xy)
[228.868064] Subtest medium-copy-XY: SKIP (0.000s)
[228.928063] [051/133] (790s left) vgem_basic (bad-flag)
[228.974079] Starting subtest: bad-flag
[228.975626] Subtest bad-flag: SUCCESS (0.000s)
[229.044794] [052/133] (790s left) gem_ctx_persistence (engines-hostile-preempt)
[229.114316] Starting subtest: engines-hostile-preempt
[229.116201] Starting dynamic subtest: rcs0
[229.196591] Dynamic subtest rcs0: SUCCESS (0.085s)
[229.207223] Starting dynamic subtest: bcs0
[229.224189] Dynamic subtest bcs0: SUCCESS (0.026s)
[229.231481] Starting dynamic subtest: vcs0
[230.842784] Dynamic subtest vcs0: SUCCESS (1.615s)
[230.852905] Starting dynamic subtest: vcs1
[232.931135] Dynamic subtest vcs1: SUCCESS (2.086s)
[232.942019] Starting dynamic subtest: vecs0
[234.922923] Dynamic subtest vecs0: SUCCESS (1.989s)
[234.933840] Starting dynamic subtest: ccs0
[235.005461] Dynamic subtest ccs0: SUCCESS (0.080s)
[235.008541] Subtest engines-hostile-preempt: SUCCESS (5.895s)
[235.099526] [053/133] (784s left) kms_sequence (queue-idle)
[235.210769] Starting subtest: queue-idle
[235.212633] Starting dynamic subtest: pipe-A-eDP-1
[237.011457] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[237.019556] Starting dynamic subtest: pipe-B-eDP-1
[239.530387] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.515s)
[239.539474] Starting dynamic subtest: pipe-C-eDP-1
[241.976858] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.447s)
[241.985168] Starting dynamic subtest: pipe-D-eDP-1
[244.473261] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.497s)
[244.475555] Subtest queue-idle: SUCCESS (9.265s)
[245.295200] [054/133] (774s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[245.401992] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[245.404341] Starting dynamic subtest: pipe-A-eDP-1
[245.477971] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[245.486957] Starting dynamic subtest: pipe-B-eDP-1
[246.578521] Dynamic subtest pipe-B-eDP-1: SKIP (1.101s)
[246.582580] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.182s)
[247.778651] [055/133] (772s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[247.891812] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[247.896269] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[248.008452] [056/133] (771s left) kms_atomic (atomic-plane-damage)
[248.105128] Starting subtest: atomic-plane-damage
[248.155345] Starting dynamic subtest: pipe-A-eDP-1
[248.694786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[248.697100] Subtest atomic-plane-damage: SUCCESS (0.590s)
[249.507302] [057/133] (770s left) kms_big_fb (linear-16bpp-rotate-90)
[249.602818] Starting subtest: linear-16bpp-rotate-90
[249.621505] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[249.760040] [058/133] (770s left) perf (stress-open-close)
[249.879140] Starting subtest: stress-open-close
[249.881384] Starting dynamic subtest: 0-rcs0
[252.048112] Dynamic subtest 0-rcs0: SUCCESS (2.170s)
[252.057104] Starting dynamic subtest: 1-vcs0
[254.215927] Dynamic subtest 1-vcs0: SUCCESS (2.167s)
[254.218201] Subtest stress-open-close: SUCCESS (4.339s)
[254.265297] [059/133] (765s left) gem_workarounds (basic-read-fd)
[254.336382] Starting subtest: basic-read-fd
[254.350946] Subtest basic-read-fd: SUCCESS (0.015s)
[254.491285] [060/133] (765s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[254.590127] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[255.603789] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.013s)
[255.781909] [061/133] (764s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[255.884839] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[255.888539] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[255.997670] [062/133] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[256.091981] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[256.095368] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[256.235018] [063/133] (763s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[256.324915] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[256.328631] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[256.440595] [064/133] (763s left) kms_cursor_crc (cursor-offscreen-32x10)
[256.599375] Starting subtest: cursor-offscreen-32x10
[256.642454] Subtest cursor-offscreen-32x10: SKIP (0.039s)
[256.927833] [065/133] (763s left) kms_psr (psr2-primary-render)
[257.029402] Starting subtest: psr2-primary-render
[257.031172] Starting dynamic subtest: eDP-1
[258.771919] Dynamic subtest eDP-1: SUCCESS (1.742s)
[258.774403] Subtest psr2-primary-render: SUCCESS (1.743s)
[259.653185] [066/133] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[259.762257] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[259.766322] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[259.868673] [067/133] (760s left) gem_exec_schedule (noreorder-priority)
[260.055068] Starting subtest: noreorder-priority
[260.057491] Starting dynamic subtest: rcs0
[261.216066] Dynamic subtest rcs0: SUCCESS (1.161s)
[261.230939] Starting dynamic subtest: vcs0
[262.961409] Dynamic subtest vcs0: SUCCESS (1.742s)
[262.972672] Starting dynamic subtest: vcs1
[264.925485] Dynamic subtest vcs1: SUCCESS (1.961s)
[264.936718] Starting dynamic subtest: vecs0
[266.903557] Dynamic subtest vecs0: SUCCESS (1.975s)
[266.915355] Starting dynamic subtest: ccs0
[268.060837] Dynamic subtest ccs0: SUCCESS (1.156s)
[268.063540] Subtest noreorder-priority: SUCCESS (8.008s)
[268.263150] [068/133] (752s left) gem_softpin (allocator-evict)
[268.330193] Starting subtest: allocator-evict
[268.333047] Starting dynamic subtest: rcs0
[292.601175] Dynamic subtest rcs0: SUCCESS (24.269s)
[292.613063] Starting dynamic subtest: bcs0
[316.184947] Dynamic subtest bcs0: SUCCESS (23.582s)
[316.193869] Starting dynamic subtest: vcs0
[339.703861] Dynamic subtest vcs0: SUCCESS (23.517s)
[339.718866] Starting dynamic subtest: vcs1
[363.380821] Dynamic subtest vcs1: SUCCESS (23.674s)
[363.398766] Starting dynamic subtest: vecs0
[386.841518] Dynamic subtest vecs0: SUCCESS (23.457s)
[386.850897] Starting dynamic subtest: ccs0
[410.345261] Dynamic subtest ccs0: SUCCESS (23.501s)
[410.347888] Subtest allocator-evict: SUCCESS (142.010s)
[410.445131] [069/133] (610s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[410.590665] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[415.353476] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.766s)
[416.564815] [070/133] (603s left) gem_exec_reloc (basic-cpu-gtt-active)
[416.650684] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[416.741538] [071/133] (603s left) gem_ctx_shared (single-timeline)
[416.803063] Starting subtest: single-timeline
[416.822233] Subtest single-timeline: SUCCESS (0.015s)
[417.090448] [072/133] (603s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[417.161524] Starting subtest: etime-multi-wait-all-for-submit-submitted
[417.263827] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[417.351178] [073/133] (603s left) syncobj_timeline (etime-single-wait-all-submitted)
[417.407787] Starting subtest: etime-single-wait-all-submitted
[417.512997] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[417.600189] [074/133] (603s left) kms_chamelium_hpd (dp-hpd-storm)
[418.005844] Subtest dp-hpd-storm: SKIP (0.000s)
[418.837166] [075/133] (601s left) kms_flip (2x-flip-vs-suspend)
[418.953441] Starting subtest: 2x-flip-vs-suspend
[418.962047] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[419.073762] [076/133] (601s left) kms_psr (fbc-psr2-sprite-plane-move)
[419.178217] Starting subtest: fbc-psr2-sprite-plane-move
[419.180412] Starting dynamic subtest: eDP-1
[419.184752] Dynamic subtest eDP-1: SKIP (0.000s)
[419.188682] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[419.263395] [077/133] (601s left) gem_exec_params (mmapped)
[419.334020] Starting subtest: mmapped
[419.339563] Subtest mmapped: SUCCESS (0.003s)
[419.495975] [078/133] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[419.599628] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[419.603768] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[419.721087] [079/133] (601s left) sw_sync (sync_merge_invalid)
[419.757574] Starting subtest: sync_merge_invalid
[419.791025] Subtest sync_merge_invalid: SUCCESS (0.031s)
[419.878737] [080/133] (601s left) perf_pmu (busy)
[419.926428] Starting subtest: busy
[419.928293] Starting dynamic subtest: rcs0
[420.525530] Dynamic subtest rcs0: SUCCESS (0.600s)
[420.536546] Starting dynamic subtest: bcs0
[421.101930] Dynamic subtest bcs0: SUCCESS (0.574s)
[421.113029] Starting dynamic subtest: vcs0
[422.932098] Dynamic subtest vcs0: SUCCESS (1.827s)
[422.942191] Starting dynamic subtest: vcs1
[424.916035] Dynamic subtest vcs1: SUCCESS (1.981s)
[424.927976] Starting dynamic subtest: vecs0
[426.901197] Dynamic subtest vecs0: SUCCESS (1.981s)
[426.913035] Starting dynamic subtest: ccs0
[427.467234] Dynamic subtest ccs0: SUCCESS (0.564s)
[427.469712] Subtest busy: SUCCESS (7.544s)
[427.598965] [081/133] (593s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[427.663074] Starting subtest: multi-wait-for-submit-submitted-signaled
[427.665359] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[427.781295] [082/133] (593s left) gem_mmap_wc (write-wc-read-gtt)
[427.851500] Subtest write-wc-read-gtt: SKIP (0.000s)
[427.910306] [083/133] (593s left) kms_hdmi_inject (inject-audio)
[428.286040] Starting subtest: inject-audio
[428.563666] Subtest inject-audio: SUCCESS (0.280s)
[429.139085] [084/133] (591s left) kms_flip (2x-blocking-wf_vblank)
[429.236900] Starting subtest: 2x-blocking-wf_vblank
[429.249436] Subtest 2x-blocking-wf_vblank: SKIP (0.012s)
[429.360155] [085/133] (591s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[429.462814] Starting subtest: plane-all-transition-nonblocking-fencing
[429.465071] Starting dynamic subtest: pipe-A-eDP-1
[431.956791] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[432.274238] Starting dynamic subtest: pipe-B-eDP-1
[435.495482] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.229s)
[435.793778] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.329s)
[436.612470] [086/133] (584s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[436.770832] Starting subtest: flip-vs-cursor-crc-legacy
[437.451021] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.679s)
[438.304020] [087/133] (582s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[438.409106] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[438.413258] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[438.487961] [088/133] (582s left) gem_exec_params (invalid-ring2)
[438.550076] Starting subtest: invalid-ring2
[438.551964] Subtest invalid-ring2: SUCCESS (0.000s)
[438.675404] [089/133] (582s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[438.771936] Starting subtest: fbcpsr-slowdraw
[463.950115] Subtest fbcpsr-slowdraw: SUCCESS (25.180s)
[464.120973] [090/133] (557s left) kms_joiner (basic-force-ultra-joiner)
[464.238669] Starting subtest: basic-force-ultra-joiner
[464.243173] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[464.325672] [091/133] (557s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[464.433238] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[464.459839] Starting dynamic subtest: pipe-A-plane-0
[464.759674] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[464.773456] Starting dynamic subtest: pipe-A-plane-3
[465.005189] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[466.156301] Starting dynamic subtest: pipe-B-plane-0
[466.471724] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[466.480473] Starting dynamic subtest: pipe-B-plane-3
[466.705686] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[467.017670] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.585s)
[467.908747] [092/133] (553s left) kms_vblank (query-forked-busy-hang)
[468.008748] Starting subtest: query-forked-busy-hang
[468.010892] Starting dynamic subtest: pipe-A-eDP-1
[494.684192] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.676s)
[494.698432] Starting dynamic subtest: pipe-D-eDP-1
[519.693753] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.004s)
[519.695887] Subtest query-forked-busy-hang: SUCCESS (51.684s)
[520.507782] [093/133] (500s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[520.601602] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[520.605687] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[520.717878] [094/133] (500s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[520.823346] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[521.424853] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[521.632866] [095/133] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[521.723143] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[521.725601] Starting dynamic subtest: pipe-A-default-mode
[524.454329] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[524.456215] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.728s)
[525.292126] [096/133] (496s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[525.356493] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[525.465671] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[525.575464] [097/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[525.682067] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[525.686394] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[525.819899] [098/133] (495s left) gem_exec_whisper (basic-fds-forked)
[525.883390] Starting subtest: basic-fds-forked
[550.115061] Subtest basic-fds-forked: SUCCESS (24.226s)
[550.321568] [099/133] (471s left) kms_addfb_basic (bad-pitch-999)
[550.385671] Starting subtest: bad-pitch-999
[550.387645] Subtest bad-pitch-999: SUCCESS (0.000s)
[550.558494] [100/133] (471s left) kms_prop_blob (basic)
[550.611523] Starting subtest: basic
[550.613896] Subtest basic: SUCCESS (0.000s)
[550.740358] [101/133] (471s left) syncobj_basic (bad-pad-fd-to-handle)
[550.789513] Starting subtest: bad-pad-fd-to-handle
[550.791505] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[550.895334] [102/133] (470s left) kms_cursor_crc (cursor-sliding-256x256)
[551.118904] Starting subtest: cursor-sliding-256x256
[551.123999] Starting dynamic subtest: pipe-A-eDP-1
[554.351746] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.229s)
[554.389977] Starting dynamic subtest: pipe-D-eDP-1
[558.244981] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.866s)
[558.247165] Subtest cursor-sliding-256x256: SUCCESS (7.123s)
[559.097675] [103/133] (462s left) gem_busy (busy)
[559.159801] Starting subtest: busy
[559.162283] Starting dynamic subtest: all-engines
[559.236226] Dynamic subtest all-engines: SUCCESS (0.076s)
[559.247577] Starting dynamic subtest: rcs0
[560.860900] Dynamic subtest rcs0: SUCCESS (1.623s)
[560.872336] Starting dynamic subtest: bcs0
[560.932068] Dynamic subtest bcs0: SUCCESS (0.069s)
[560.942902] Starting dynamic subtest: vcs0
[560.972090] Dynamic subtest vcs0: SUCCESS (0.038s)
[560.982074] Starting dynamic subtest: vcs1
[562.905931] Dynamic subtest vcs1: SUCCESS (1.931s)
[562.916906] Starting dynamic subtest: vecs0
[564.891168] Dynamic subtest vecs0: SUCCESS (1.983s)
[564.902176] Starting dynamic subtest: ccs0
[566.937919] Dynamic subtest ccs0: SUCCESS (2.047s)
[566.940252] Subtest busy: SUCCESS (7.775s)
[567.326277] [104/133] (454s left) i915_pm_rps (thresholds)
[567.393087] Starting subtest: thresholds
[567.397693] Subtest thresholds: SKIP (0.002s)
[567.534991] [105/133] (454s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[567.646315] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[567.649052] Starting dynamic subtest: pipe-A-eDP-1
[567.672830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.686066] Starting dynamic subtest: pipe-B-eDP-1
[567.707795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.721964] Starting dynamic subtest: pipe-C-eDP-1
[567.745928] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.755992] Starting dynamic subtest: pipe-D-eDP-1
[567.777873] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.781997] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[569.901460] [106/133] (452s left) gem_softpin (evict-snoop-interruptible)
[569.961962] Starting subtest: evict-snoop-interruptible
[569.966403] Subtest evict-snoop-interruptible: SKIP (0.000s)
[570.084417] [107/133] (451s left) gem_mmap_gtt (big-bo)
[570.146916] Subtest big-bo: SKIP (0.000s)
[570.217618] [108/133] (451s left) gem_partial_pwrite_pread (write-display)
[570.293362] Subtest write-display: SKIP (0.000s)
[570.375972] [109/133] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[570.475194] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[570.477419] Starting dynamic subtest: pipe-A-eDP-1
[570.500190] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[570.512061] Starting dynamic subtest: pipe-B-eDP-1
[570.534473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[570.543021] Starting dynamic subtest: pipe-C-eDP-1
[570.564508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[570.573024] Starting dynamic subtest: pipe-D-eDP-1
[570.594834] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[570.598906] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[572.694660] [110/133] (449s left) kms_psr (fbc-pr-cursor-blt)
[572.795165] Starting subtest: fbc-pr-cursor-blt
[572.799623] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[572.877895] [111/133] (449s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[572.940359] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[572.942241] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[573.061611] [112/133] (449s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[573.121512] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[573.125751] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[573.313961] [113/133] (448s left) gem_mmap (basic)
[573.368671] Subtest basic: SKIP (0.000s)
[573.434153] [114/133] (448s left) gem_exec_gttfill (basic)
[573.491922] Starting subtest: basic
[575.859562] Subtest basic: SUCCESS (2.369s)
[576.059628] [115/133] (446s left) kms_addfb_basic (size-max)
[576.205043] Starting subtest: size-max
[576.207349] Subtest size-max: SUCCESS (0.000s)
[576.317908] [116/133] (446s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[576.412123] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[576.414298] Starting dynamic subtest: pipe-A-eDP-1
[576.436959] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.448113] Starting dynamic subtest: pipe-B-eDP-1
[576.469633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.478087] Starting dynamic subtest: pipe-C-eDP-1
[576.499757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.508064] Starting dynamic subtest: pipe-D-eDP-1
[576.529739] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.533782] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[578.713850] [117/133] (443s left) api_intel_bb (purge-bb)
[578.773419] Starting subtest: purge-bb
[578.775599] Subtest purge-bb: SUCCESS (0.003s)
[578.935056] [118/133] (443s left) kms_cursor_legacy (forked-move)
[579.055270] Starting subtest: forked-move
[579.057701] Starting dynamic subtest: pipe-A
[584.520846] Dynamic subtest pipe-A: SUCCESS (5.462s)
[584.532114] Starting dynamic subtest: pipe-B
[590.004375] Dynamic subtest pipe-B: SUCCESS (5.479s)
[590.015823] Starting dynamic subtest: pipe-C
[595.473939] Dynamic subtest pipe-C: SUCCESS (5.468s)
[595.484745] Starting dynamic subtest: pipe-D
[600.949246] Dynamic subtest pipe-D: SUCCESS (5.474s)
[600.960721] Starting dynamic subtest: all-pipes
[606.449293] Dynamic subtest all-pipes: SUCCESS (5.497s)
[606.451737] Subtest forked-move: SUCCESS (27.391s)
[606.616871] [119/133] (415s left) gen9_exec_parse (bb-chained)
[606.695240] Subtest bb-chained: SKIP (0.000s)
[606.798693] [120/133] (415s left) kms_concurrent (multi-plane-atomic-lowres)
[606.901806] Starting subtest: multi-plane-atomic-lowres
[606.903898] Starting dynamic subtest: pipe-A-eDP-1
[607.392690] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s)
[607.395031] Subtest multi-plane-atomic-lowres: SUCCESS (0.489s)
[608.214234] [121/133] (414s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[608.270081] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[608.355437] [122/133] (414s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[608.426969] Starting subtest: multi-wait-available-unsubmitted-submitted
[608.429152] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[608.571961] [123/133] (414s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[608.671165] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[613.027214] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.359s)
[614.201145] [124/133] (408s left) kms_pm_dc (dc3co-vpb-simulation)
[615.300222] Starting subtest: dc3co-vpb-simulation
[623.802104] Subtest dc3co-vpb-simulation: SKIP (8.499s)
[623.980690] [125/133] (398s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[624.085585] Starting subtest: x-tiled-8bpp-rotate-90
[624.106047] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[624.255831] [126/133] (398s left) kms_plane_multiple (2x-tiling-none)
[624.343312] Starting subtest: 2x-tiling-none
[624.347276] Subtest 2x-tiling-none: SKIP (0.000s)
[624.426997] [127/133] (398s left) gem_exec_balancer (bonded-false-hang)
[624.698061] Starting subtest: bonded-false-hang
[624.702860] Subtest bonded-false-hang: SKIP (0.000s)
[624.808484] [128/133] (398s left) i915_drm_fdinfo (idle)
[624.851711] Starting subtest: idle
[624.853929] Starting dynamic subtest: rcs0
[625.424331] Dynamic subtest rcs0: SUCCESS (0.575s)
[625.435613] Starting dynamic subtest: bcs0
[625.932415] Dynamic subtest bcs0: SUCCESS (0.503s)
[625.944269] Starting dynamic subtest: vcs0
[626.438308] Dynamic subtest vcs0: SUCCESS (0.503s)
[626.450039] Starting dynamic subtest: vcs1
[626.943028] Dynamic subtest vcs1: SUCCESS (0.503s)
[626.954871] Starting dynamic subtest: vecs0
[627.449910] Dynamic subtest vecs0: SUCCESS (0.503s)
[627.461656] Starting dynamic subtest: ccs0
[627.955488] Dynamic subtest ccs0: SUCCESS (0.503s)
[627.958230] Subtest idle: SUCCESS (3.106s)
[628.044225] [129/133] (394s left) kms_getfb (getfb2-handle-closed)
[628.151795] Starting subtest: getfb2-handle-closed
[628.153956] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[628.256776] [130/133] (394s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[628.329337] Starting subtest: invalid-bsd1-flag-on-vebox
[628.331649] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[628.454562] [131/133] (394s left) kms_psr (fbc-pr-suspend)
[628.544046] Starting subtest: fbc-pr-suspend
[628.548380] Subtest fbc-pr-suspend: SKIP (0.000s)
[628.629721] [132/133] (394s left) gem_softpin (overlap)
[628.704260] Starting subtest: overlap
[629.529505] Subtest overlap: SUCCESS (0.826s)
[629.691414] [133/133] (393s left) gem_madvise (dontneed-before-mmap)
[629.732787] Starting subtest: dontneed-before-mmap
[629.765439] Subtest dontneed-before-mmap: SUCCESS (0.036s)
[629.897760] 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.