[60.594675] Initializing watchdogs
[60.594723]   /dev/watchdog0
[60.612095] [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.616423] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.618584] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.621833] [001/133] (960s left) kms_plane_lowres (tiling-none)
[60.748128] Starting subtest: tiling-none
[60.752221] Starting dynamic subtest: pipe-A-eDP-1
[60.757367] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.050265] Starting dynamic subtest: pipe-B-eDP-1
[61.054943] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.063165] Starting dynamic subtest: pipe-C-eDP-1
[61.067887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.082875] Starting dynamic subtest: pipe-D-eDP-1
[61.087328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.091428] Subtest tiling-none: SKIP (0.301s)
[61.881213] [002/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[61.975072] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[61.979422] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[62.068006] [003/133] (959s left) api_intel_bb (reset-bb)
[62.123888] Starting subtest: reset-bb
[62.126384] Subtest reset-bb: SUCCESS (0.004s)
[62.237940] [004/133] (958s left) gem_exec_reloc (basic-write-cpu-noreloc)
[62.296144] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[62.367634] [005/133] (958s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[62.421881] Starting subtest: etime-single-wait-for-submit-submitted
[62.526882] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.103s)
[62.602482] [006/133] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[62.704837] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[62.709514] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[62.788048] [007/133] (958s left) gem_vm_create (execbuf)
[62.854539] Starting subtest: execbuf
[62.861885] Subtest execbuf: SUCCESS (0.008s)
[62.979930] [008/133] (958s left) kms_properties (colorop-properties-legacy)
[63.080872] Starting subtest: colorop-properties-legacy
[63.083248] Starting dynamic subtest: pipe-A-eDP-1
[63.448339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.365s)
[63.455830] Starting dynamic subtest: pipe-B-eDP-1
[64.564969] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.106s)
[64.573464] Starting dynamic subtest: pipe-C-eDP-1
[65.611266] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.040s)
[65.620256] Starting dynamic subtest: pipe-D-eDP-1
[66.642794] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[66.644858] Subtest colorop-properties-legacy: SUCCESS (3.538s)
[67.438571] [009/133] (953s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[67.529291] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[67.531622] Starting dynamic subtest: pipe-A-eDP-1
[67.554830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[67.563594] Starting dynamic subtest: pipe-B-eDP-1
[67.585400] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[67.592228] Starting dynamic subtest: pipe-C-eDP-1
[67.614316] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[67.620964] Starting dynamic subtest: pipe-D-eDP-1
[67.642941] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[67.647361] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[69.726214] [010/133] (951s left) kms_scaling_modes (scaling-mode-full-aspect)
[69.821051] Starting subtest: scaling-mode-full-aspect
[69.823484] Starting dynamic subtest: pipe-A-eDP-1
[69.918884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[69.927161] Starting dynamic subtest: pipe-B-eDP-1
[71.061935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[71.071667] Starting dynamic subtest: pipe-C-eDP-1
[72.183533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[72.192148] Starting dynamic subtest: pipe-D-eDP-1
[73.323249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[73.326044] Subtest scaling-mode-full-aspect: SUCCESS (3.493s)
[74.579940] [011/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[74.674058] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[78.959067] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.284s)
[80.096516] [012/133] (941s left) kms_hdr (bpc-switch-suspend)
[80.182351] Starting subtest: bpc-switch-suspend
[81.268272] Starting dynamic subtest: pipe-A-eDP-1
[100.053157] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.313s)
[100.055611] Subtest bpc-switch-suspend: SUCCESS (6.400s)
[100.181004] [013/133] (921s left) kms_flip (2x-busy-flip)
[100.288711] Starting subtest: 2x-busy-flip
[100.299838] Subtest 2x-busy-flip: SKIP (0.010s)
[100.378575] [014/133] (921s left) kms_addfb_basic (bad-pitch-999)
[100.432679] Starting subtest: bad-pitch-999
[100.434935] Subtest bad-pitch-999: SUCCESS (0.000s)
[100.593702] [015/133] (921s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[100.690066] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[100.694130] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[100.762279] [016/133] (920s left) kms_cursor_crc (cursor-onscreen-256x85)
[101.013954] Starting subtest: cursor-onscreen-256x85
[101.059499] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[101.236247] [017/133] (920s left) perf_pmu (busy-double-start)
[101.279096] Starting subtest: busy-double-start
[101.281150] Starting dynamic subtest: rcs0
[104.953625] Dynamic subtest rcs0: FAIL (3.554s)
[104.963449] Starting dynamic subtest: bcs0
[108.476925] Dynamic subtest bcs0: SUCCESS (3.535s)
[108.486455] Starting dynamic subtest: vcs0
[112.289581] Dynamic subtest vcs0: SUCCESS (3.784s)
[112.299096] Starting dynamic subtest: vcs1
[116.266715] Dynamic subtest vcs1: SUCCESS (3.958s)
[116.276572] Starting dynamic subtest: vecs0
[120.291729] Dynamic subtest vecs0: SUCCESS (4.012s)
[120.301557] Starting dynamic subtest: ccs0
[123.928778] Dynamic subtest ccs0: FAIL (3.562s)
[123.930710] Subtest busy-double-start: FAIL (22.411s)
[123.968031] [018/133] (897s left) gem_bad_reloc (negative-reloc-bltcopy)
[124.036272] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[124.098288] [019/133] (897s left) kms_vblank (wait-forked-hang)
[124.197797] Starting subtest: wait-forked-hang
[124.200269] Starting dynamic subtest: pipe-A-eDP-1
[150.484241] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.278s)
[150.497736] Starting dynamic subtest: pipe-D-eDP-1
[165.516067] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.023s)
[165.518128] Subtest wait-forked-hang: SUCCESS (41.305s)
[166.387410] [020/133] (855s left) gem_lmem_swapping (massive)
[166.441504] Subtest massive: SKIP (0.000s)
[166.483505] [021/133] (855s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[166.592731] Starting subtest: cursorA-vs-flipB-atomic-transitions
[166.597106] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[166.736404] [022/133] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[166.834580] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[173.799165] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.964s)
[173.945674] [023/133] (848s left) gem_mmap_wc (read)
[173.999312] Subtest read: SKIP (0.000s)
[174.108051] [024/133] (847s left) perf (non-sampling-read-error)
[174.232194] Starting subtest: non-sampling-read-error
[174.241418] Subtest non-sampling-read-error: SUCCESS (0.010s)
[174.287916] [025/133] (847s left) gem_mmap_gtt (basic-small-copy-xy)
[174.346264] Subtest basic-small-copy-XY: SKIP (0.000s)
[174.400107] [026/133] (847s left) gem_ringfill (basic-all)
[179.728962] Starting subtest: basic-all
[180.878148] Subtest basic-all: SUCCESS (1.149s)
[181.012956] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[181.015638] [027/133] (841s left) kms_draw_crc (draw-method-blt)
[181.106249] Starting subtest: draw-method-blt
[181.108488] Starting dynamic subtest: xrgb8888-untiled
[181.337167] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[181.347511] Starting dynamic subtest: rgb565-untiled
[181.570624] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[181.580118] Starting dynamic subtest: xrgb2101010-untiled
[181.792880] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[181.801467] Starting dynamic subtest: xbgr16161616f-untiled
[182.003495] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[182.011897] Starting dynamic subtest: xrgb8888-xtiled
[182.114625] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[182.127416] Starting dynamic subtest: rgb565-xtiled
[182.236765] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[182.246140] Starting dynamic subtest: xrgb2101010-xtiled
[182.359451] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[182.368401] Starting dynamic subtest: xbgr16161616f-xtiled
[182.482078] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[182.496344] Starting dynamic subtest: xrgb8888-4tiled
[182.592722] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.109s)
[182.600970] Starting dynamic subtest: rgb565-4tiled
[182.714979] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[182.723008] Starting dynamic subtest: xrgb2101010-4tiled
[182.814806] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[182.822990] Starting dynamic subtest: xbgr16161616f-4tiled
[182.926088] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[182.927912] Subtest draw-method-blt: SUCCESS (1.821s)
[183.049797] [028/133] (839s left) kms_psr (psr2-cursor-render)
[183.146937] Starting subtest: psr2-cursor-render
[183.148815] Starting dynamic subtest: eDP-1
[184.898570] Dynamic subtest eDP-1: SUCCESS (1.750s)
[184.901053] Subtest psr2-cursor-render: SUCCESS (1.751s)
[185.700709] [029/133] (836s left) kms_big_fb (linear-32bpp-rotate-180)
[185.801414] Starting subtest: linear-32bpp-rotate-180
[187.356980] Subtest linear-32bpp-rotate-180: SUCCESS (1.556s)
[187.478221] [030/133] (834s left) kms_psr (psr2-cursor-blt)
[187.568411] Starting subtest: psr2-cursor-blt
[187.571334] Starting dynamic subtest: eDP-1
[189.265971] Dynamic subtest eDP-1: SUCCESS (1.700s)
[189.268263] Subtest psr2-cursor-blt: SUCCESS (1.701s)
[190.065028] [031/133] (832s left) gem_lmem_swapping (verify)
[190.109929] Subtest verify: SKIP (0.000s)
[190.146728] [032/133] (832s left) kms_plane (plane-position-hole)
[190.249969] Starting subtest: plane-position-hole
[190.753280] Starting dynamic subtest: pipe-A-plane-1
[192.053118] Dynamic subtest pipe-A-plane-1: SUCCESS (1.299s)
[192.063094] Starting dynamic subtest: pipe-A-plane-2
[193.351768] Dynamic subtest pipe-A-plane-2: SUCCESS (1.299s)
[193.361623] Starting dynamic subtest: pipe-A-plane-3
[194.595395] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s)
[194.604953] Starting dynamic subtest: pipe-A-plane-4
[195.841510] Dynamic subtest pipe-A-plane-4: SUCCESS (1.245s)
[195.850417] Starting dynamic subtest: pipe-A-plane-5
[195.864705] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[196.986759] Starting dynamic subtest: pipe-B-plane-1
[198.226707] Dynamic subtest pipe-B-plane-1: SUCCESS (1.249s)
[198.238527] Starting dynamic subtest: pipe-B-plane-2
[199.494788] Dynamic subtest pipe-B-plane-2: SUCCESS (1.268s)
[199.504869] Starting dynamic subtest: pipe-B-plane-3
[200.783772] Dynamic subtest pipe-B-plane-3: SUCCESS (1.290s)
[200.793295] Starting dynamic subtest: pipe-B-plane-4
[202.009329] Dynamic subtest pipe-B-plane-4: SUCCESS (1.224s)
[202.020359] Starting dynamic subtest: pipe-B-plane-5
[202.033267] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[202.035150] Subtest plane-position-hole: SUCCESS (11.785s)
[202.818857] [033/133] (819s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[202.880099] Starting subtest: single-wait-all-for-submit-unsubmitted
[202.985518] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[203.062108] [034/133] (819s left) gem_ctx_param (invalid-set-no-zeromap)
[203.113644] Starting subtest: invalid-set-no-zeromap
[203.115987] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[203.212467] [035/133] (819s left) i915_drm_fdinfo (most-busy-idle-check-all)
[203.252178] Starting subtest: most-busy-idle-check-all
[203.254558] Starting dynamic subtest: rcs0
[203.259184] Dynamic subtest rcs0: SKIP (0.003s)
[203.270648] Starting dynamic subtest: bcs0
[203.274946] Dynamic subtest bcs0: SKIP (0.000s)
[203.283409] Starting dynamic subtest: vcs0
[203.287516] Dynamic subtest vcs0: SKIP (0.000s)
[203.295675] Starting dynamic subtest: vcs1
[203.299984] Dynamic subtest vcs1: SKIP (0.000s)
[203.308072] Starting dynamic subtest: vecs0
[203.312387] Dynamic subtest vecs0: SKIP (0.000s)
[203.320754] Starting dynamic subtest: ccs0
[203.325079] Dynamic subtest ccs0: SKIP (0.000s)
[203.329361] Subtest most-busy-idle-check-all: SKIP (0.008s)
[203.365875] [036/133] (819s left) kms_selftest (drm_dp_mst_helper)
[203.410036] Starting subtest: drm_dp_mst_helper
[203.431027] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[203.535157] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.104s)
[203.543897] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[203.633812] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.097s)
[203.642705] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[203.723578] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.089s)
[203.725949] Subtest drm_dp_mst_helper: SUCCESS (0.315s)
[203.895248] [037/133] (818s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[203.973204] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[204.080741] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[204.167730] [038/133] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[204.265448] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[204.269570] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[204.391684] [039/133] (818s left) kms_pm_rpm (modeset-non-lpsp-stress)
[205.922423] Starting subtest: modeset-non-lpsp-stress
[207.088302] Subtest modeset-non-lpsp-stress: SKIP (1.167s)
[207.474228] [040/133] (815s left) kms_chamelium_frames (vga-frame-dump)
[207.846798] Subtest vga-frame-dump: SKIP (0.000s)
[208.666503] [041/133] (814s left) gem_exec_balancer (full-pulse)
[208.726235] Starting subtest: full-pulse
[213.607571] Subtest full-pulse: SUCCESS (4.882s)
[213.938391] [042/133] (808s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[214.041319] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[218.578858] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.542s)
[219.698364] [043/133] (803s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[219.801200] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[219.803571] Starting dynamic subtest: pipe-A-default-mode
[220.947893] Dynamic subtest pipe-A-default-mode: SKIP (1.145s)
[220.952213] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.147s)
[221.091817] [044/133] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[221.191070] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[221.195211] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.277648] [045/133] (801s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[221.384380] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[229.532416] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (8.152s)
[229.629630] [046/133] (793s left) gen7_exec_parse (chained-batch)
[229.691247] Subtest chained-batch: SKIP (0.000s)
[229.759793] [047/133] (793s left) kms_chamelium_color (ctm-limited-range)
[229.854821] Subtest ctm-limited-range: SKIP (0.000s)
[229.900623] [048/133] (793s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[230.009825] Starting subtest: 4-tiled-8bpp-rotate-0
[231.150374] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.141s)
[231.275278] [049/133] (791s left) syncobj_timeline (invalid-signal-bad-pad)
[231.329251] Starting subtest: invalid-signal-bad-pad
[231.331402] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[231.416509] [050/133] (791s left) gem_render_copy (yf-tiled)
[231.473171] Starting subtest: yf-tiled
[231.476733] Subtest yf-tiled: SKIP (0.000s)
[231.661826] [051/133] (791s left) syncobj_basic (create-signaled)
[231.718529] Starting subtest: create-signaled
[231.720525] Subtest create-signaled: SUCCESS (0.000s)
[231.809676] [052/133] (791s left) syncobj_wait (wait-all-for-submit-snapshot)
[231.869415] Starting subtest: wait-all-for-submit-snapshot
[231.949243] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[232.025319] [053/133] (791s left) kms_cursor_crc (cursor-random-128x128)
[232.229908] Starting subtest: cursor-random-128x128
[232.234611] Starting dynamic subtest: pipe-A-eDP-1
[235.613484] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.378s)
[235.643792] Starting dynamic subtest: pipe-D-eDP-1
[239.696973] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.059s)
[239.699239] Subtest cursor-random-128x128: SUCCESS (7.464s)
[240.516479] [054/133] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[240.607068] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[240.611242] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.697002] [055/133] (782s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[240.809049] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[244.777893] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.972s)
[245.899911] [056/133] (777s left) gem_mmap_wc (bad-object)
[245.959339] Subtest bad-object: SKIP (0.000s)
[246.027299] [057/133] (777s left) perf (polling-small-buf)
[246.125741] Starting subtest: polling-small-buf
[246.215704] Subtest polling-small-buf: SUCCESS (0.087s)
[246.265900] [058/133] (777s left) gem_ctx_sseu (invalid-args)
[246.332714] Subtest invalid-args: SKIP (0.000s)
[246.404527] [059/133] (777s left) perf_pmu (init-sema)
[246.448767] Starting subtest: init-sema
[246.451042] Starting dynamic subtest: rcs0
[246.453147] Dynamic subtest rcs0: SUCCESS (0.002s)
[246.462266] Starting dynamic subtest: bcs0
[246.464364] Dynamic subtest bcs0: SUCCESS (0.001s)
[246.473052] Starting dynamic subtest: vcs0
[246.474848] Dynamic subtest vcs0: SUCCESS (0.001s)
[246.482895] Starting dynamic subtest: vcs1
[246.486911] Dynamic subtest vcs1: SUCCESS (0.001s)
[246.495864] Starting dynamic subtest: vecs0
[246.497984] Dynamic subtest vecs0: SUCCESS (0.001s)
[246.506871] Starting dynamic subtest: ccs0
[246.508852] Dynamic subtest ccs0: SUCCESS (0.001s)
[246.510638] Subtest init-sema: SUCCESS (0.011s)
[246.567434] [060/133] (777s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[246.629138] Starting subtest: single-wait-all-for-submit-available-submitted
[246.631524] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[246.728170] [061/133] (776s left) vgem_basic (bad-pad)
[246.776016] Starting subtest: bad-pad
[246.778159] Subtest bad-pad: SUCCESS (0.000s)
[246.848754] [062/133] (776s left) kms_flip (2x-absolute-wf_vblank)
[246.939480] Starting subtest: 2x-absolute-wf_vblank
[246.950193] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[247.029638] [063/133] (776s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[247.130568] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[247.921988] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.792s)
[248.083487] [064/133] (775s left) fbdev (eof)
[248.138876] Starting subtest: eof
[248.141214] Subtest eof: SUCCESS (0.000s)
[248.215751] [065/133] (775s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[248.305321] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[255.663649] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.360s)
[255.778440] [066/133] (768s left) api_intel_allocator (gem-pool)
[255.836310] Starting subtest: gem-pool
[255.841768] Subtest gem-pool: SUCCESS (0.008s)
[255.966822] [067/133] (767s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[256.068406] Starting subtest: plane-lut1d-ctm3x4-lut1d
[256.203778] Starting dynamic subtest: pipe-A-plane-0
[256.380567] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[256.390385] Starting dynamic subtest: pipe-A-plane-1
[256.569613] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[256.583801] Starting dynamic subtest: pipe-A-plane-2
[256.735882] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[257.884996] Starting dynamic subtest: pipe-B-plane-0
[258.021928] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[258.031783] Starting dynamic subtest: pipe-B-plane-1
[258.155212] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[258.164957] Starting dynamic subtest: pipe-B-plane-2
[258.288720] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[259.541514] Starting dynamic subtest: pipe-C-plane-0
[259.666583] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[259.676498] Starting dynamic subtest: pipe-C-plane-1
[259.811341] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[259.827515] Starting dynamic subtest: pipe-C-plane-2
[259.956021] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[261.172915] Starting dynamic subtest: pipe-D-plane-0
[261.320657] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[261.330166] Starting dynamic subtest: pipe-D-plane-1
[261.454668] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[261.472923] Starting dynamic subtest: pipe-D-plane-2
[261.632145] Dynamic subtest pipe-D-plane-2: SUCCESS (0.175s)
[261.935764] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.867s)
[262.749698] [068/133] (761s left) gem_mmap_gtt (big-copy-xy)
[262.806550] Subtest big-copy-XY: SKIP (0.000s)
[262.866601] [069/133] (761s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[262.965800] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[262.970289] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[263.064443] [070/133] (760s left) gem_softpin (allocator-nopin)
[263.118999] Starting subtest: allocator-nopin
[263.209405] Subtest allocator-nopin: SUCCESS (0.089s)
[263.342225] [071/133] (760s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[263.434763] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[267.311825] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.880s)
[268.462164] [072/133] (755s left) kms_rotation_crc (exhaust-fences)
[268.554953] Starting subtest: exhaust-fences
[268.559093] Subtest exhaust-fences: SKIP (0.000s)
[268.626016] [073/133] (755s left) gem_exec_whisper (basic-fds-priority)
[268.689332] Starting subtest: basic-fds-priority
[292.859240] Subtest basic-fds-priority: SUCCESS (24.160s)
[293.043102] [074/133] (731s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[293.095429] Starting subtest: invalid-multi-wait-unsubmitted
[293.097920] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[293.203206] [075/133] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[293.313348] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[293.317531] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[293.410523] [076/133] (730s left) gem_ctx_param (set-priority-range)
[293.474244] Starting subtest: set-priority-range
[293.488668] Subtest set-priority-range: SUCCESS (0.015s)
[293.610560] [077/133] (730s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[293.677713] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[293.784632] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[293.871352] [078/133] (730s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[293.982521] Starting subtest: basic-busy-flip-before-cursor-varying-size
[293.987132] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[294.142173] [079/133] (730s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[294.238928] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[294.243430] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[294.345203] [080/133] (730s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[294.429268] Starting subtest: 2x-flip-vs-modeset-vs-hang
[294.433740] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[294.545059] [081/133] (729s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[294.675876] Starting subtest: dp-mst-lic-type-0-hdcp14
[294.680399] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[294.786440] [082/133] (729s left) kms_psr (fbc-pr-cursor-plane-move)
[294.872896] Starting subtest: fbc-pr-cursor-plane-move
[294.876205] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[294.950279] [083/133] (729s left) gem_exec_params (sol-reset-invalid)
[295.004414] Starting subtest: sol-reset-invalid
[295.008917] Subtest sol-reset-invalid: SUCCESS (0.003s)
[296.786495] [084/133] (727s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[296.877493] Starting subtest: stress-xrgb8888-4tiled
[302.772338] Subtest stress-xrgb8888-4tiled: SUCCESS (5.894s)
[302.821844] [085/133] (721s left) gem_exec_balancer (smoke)
[302.881898] Starting subtest: smoke
[325.488339] Subtest smoke: SUCCESS (22.599s)
[326.297451] [086/133] (698s left) kms_pm_backlight (fade)
[326.382038] Starting subtest: fade
[326.434004] Starting dynamic subtest: eDP-1
[329.423617] Dynamic subtest eDP-1: SUCCESS (2.993s)
[329.426083] Subtest fade: SUCCESS (3.044s)
[330.293623] [087/133] (694s left) kms_debugfs (display-off-read-all)
[330.383899] Starting subtest: display-off-read-all
[330.674871] Subtest display-off-read-all: SUCCESS (0.293s)
[331.522367] [088/133] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[331.618496] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[331.623001] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[331.709068] [089/133] (693s left) kms_flip (flip-vs-absolute-wf_vblank)
[331.803173] Starting subtest: flip-vs-absolute-wf_vblank
[331.805545] Starting dynamic subtest: A-eDP1
[340.770676] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[340.783904] Starting dynamic subtest: B-eDP1
[349.696456] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[349.707363] Starting dynamic subtest: C-eDP1
[358.618167] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[358.627551] Starting dynamic subtest: D-eDP1
[367.544247] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[367.546597] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.748s)
[368.783471] [090/133] (656s left) gem_exec_fence (syncobj-timeline-repeat)
[369.355047] Starting subtest: syncobj-timeline-repeat
[369.588460] Subtest syncobj-timeline-repeat: SUCCESS (0.233s)
[370.846155] [091/133] (654s left) kms_psr (fbc-psr2-sprite-render)
[370.930137] Starting subtest: fbc-psr2-sprite-render
[370.932392] Starting dynamic subtest: eDP-1
[370.936676] Dynamic subtest eDP-1: SKIP (0.000s)
[370.941034] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[371.004880] [092/133] (653s left) kms_async_flips (test-time-stamp-atomic)
[371.094555] Starting subtest: test-time-stamp-atomic
[371.469818] Starting dynamic subtest: pipe-A-eDP-1
[372.270562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.798s)
[372.635591] Starting dynamic subtest: pipe-B-eDP-1
[373.396267] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[373.771123] Starting dynamic subtest: pipe-C-eDP-1
[374.529699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[374.911244] Starting dynamic subtest: pipe-D-eDP-1
[375.670631] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[375.673070] Subtest test-time-stamp-atomic: SUCCESS (4.575s)
[376.835148] [093/133] (648s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[376.924825] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[376.927051] Starting dynamic subtest: pipe-A-eDP-1
[376.948452] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[376.958952] Starting dynamic subtest: pipe-B-eDP-1
[376.979466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.988386] Starting dynamic subtest: pipe-C-eDP-1
[377.009200] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[377.017705] Starting dynamic subtest: pipe-D-eDP-1
[377.039035] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.043370] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[379.128022] [094/133] (645s left) gem_ctx_param (basic-default)
[379.183224] Starting subtest: basic-default
[379.185561] Subtest basic-default: SUCCESS (0.000s)
[379.273873] [095/133] (645s left) device_reset (cold-reset-bound)
[379.317029] Starting subtest: cold-reset-bound
[379.321584] Subtest cold-reset-bound: SKIP (0.000s)
[379.377102] [096/133] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[379.479965] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[379.483884] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[379.584125] [097/133] (645s left) gem_exec_reloc (basic-gtt-read)
[379.638175] Subtest basic-gtt-read: SKIP (0.000s)
[379.707302] [098/133] (645s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[379.792093] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[379.794390] Starting dynamic subtest: pipe-A-eDP-1
[379.814454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[379.825107] Starting dynamic subtest: pipe-B-eDP-1
[379.844589] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[379.853917] Starting dynamic subtest: pipe-C-eDP-1
[379.873596] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[379.883057] Starting dynamic subtest: pipe-D-eDP-1
[379.902468] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[379.904664] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[381.982351] [099/133] (643s left) gem_exec_schedule (preempt)
[382.060471] Starting subtest: preempt
[382.062528] Starting dynamic subtest: rcs0
[382.074767] Dynamic subtest rcs0: SUCCESS (0.022s)
[382.087238] Starting dynamic subtest: bcs0
[382.093991] Dynamic subtest bcs0: SUCCESS (0.019s)
[382.103758] Starting dynamic subtest: vcs0
[382.114084] Dynamic subtest vcs0: SUCCESS (0.020s)
[382.123695] Starting dynamic subtest: vcs1
[382.141058] Dynamic subtest vcs1: SUCCESS (0.026s)
[382.152213] Starting dynamic subtest: vecs0
[382.163476] Dynamic subtest vecs0: SUCCESS (0.022s)
[382.174525] Starting dynamic subtest: ccs0
[382.188950] Dynamic subtest ccs0: SUCCESS (0.025s)
[382.191151] Subtest preempt: SUCCESS (0.137s)
[383.842328] [100/133] (641s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[383.929705] Starting subtest: fbc-psr2-cursor-mmap-gtt
[383.931957] Starting dynamic subtest: eDP-1
[383.936137] Dynamic subtest eDP-1: SKIP (0.000s)
[383.940328] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[384.002471] [101/133] (641s left) gem_create (create-invalid-size)
[384.052098] Starting subtest: create-invalid-size
[384.054333] Subtest create-invalid-size: SUCCESS (0.000s)
[384.235414] [102/133] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[384.324757] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[384.329129] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[384.422730] [103/133] (640s left) gem_exec_reloc (basic-concurrent16)
[384.480977] Subtest basic-concurrent16: SKIP (0.000s)
[384.553370] [104/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[384.655980] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[384.659891] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[384.749259] [105/133] (640s left) kms_async_flips (crc)
[384.837154] Starting subtest: crc
[385.226320] Starting dynamic subtest: pipe-A-eDP-1
[388.097050] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.869s)
[388.492398] Starting dynamic subtest: pipe-B-eDP-1
[391.437704] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.952s)
[391.818771] Starting dynamic subtest: pipe-C-eDP-1
[394.742451] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.931s)
[395.106976] Starting dynamic subtest: pipe-D-eDP-1
[397.959032] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s)
[397.961310] Subtest crc: SUCCESS (13.121s)
[399.158039] [106/133] (626s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[399.217624] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[399.219716] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[399.305013] [107/133] (626s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[399.426437] Starting subtest: basic-flip-after-cursor-legacy
[400.340893] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.913s)
[401.155236] [108/133] (624s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[401.538110] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[402.366337] [109/133] (623s left) gem_exec_schedule (u-semaphore-codependency)
[402.458508] Starting subtest: u-semaphore-codependency
[402.464515] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[402.832279] [110/133] (622s left) i915_module_load (resize-bar)
[402.879869] Starting subtest: resize-bar
[402.886302] Subtest resize-bar: SKIP (0.006s)
[402.933959] [111/133] (622s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[403.041089] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[403.045109] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[403.132742] [112/133] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[403.227513] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[403.231553] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[403.329521] [113/133] (622s left) i915_selftest (live)
[405.026434] Starting subtest: live
[405.028772] Starting dynamic subtest: sanitycheck
[409.385666] Dynamic subtest sanitycheck: SUCCESS (4.359s)
[409.394205] Starting dynamic subtest: uncore
[413.706399] Dynamic subtest uncore: SUCCESS (4.318s)
[413.716320] Starting dynamic subtest: workarounds
[416.757999] Dynamic subtest workarounds: SUCCESS (3.050s)
[416.767921] Starting dynamic subtest: gt_engines
[419.850160] Dynamic subtest gt_engines: SUCCESS (3.091s)
[419.858196] Starting dynamic subtest: gt_timelines
[437.484983] Dynamic subtest gt_timelines: SUCCESS (17.630s)
[437.494616] Starting dynamic subtest: gt_contexts
[441.849351] Dynamic subtest gt_contexts: SUCCESS (4.361s)
[441.859939] Starting dynamic subtest: gt_lrc
[447.953235] Dynamic subtest gt_lrc: SUCCESS (6.101s)
[447.962255] Starting dynamic subtest: gt_mocs
[450.899432] Dynamic subtest gt_mocs: SUCCESS (2.944s)
[450.909738] Starting dynamic subtest: gt_pm
[457.670896] Dynamic subtest gt_pm: SUCCESS (6.769s)
[457.681109] Starting dynamic subtest: gt_heartbeat
[462.014446] Dynamic subtest gt_heartbeat: SUCCESS (4.340s)
[462.024047] Starting dynamic subtest: gt_tlb
[471.240381] Dynamic subtest gt_tlb: SUCCESS (9.222s)
[471.250729] Starting dynamic subtest: requests
[482.821527] Dynamic subtest requests: SUCCESS (11.578s)
[482.836374] Starting dynamic subtest: migrate
[490.543409] Dynamic subtest migrate: SUCCESS (7.719s)
[490.551811] Starting dynamic subtest: active
[494.806898] Dynamic subtest active: SUCCESS (4.260s)
[494.816965] Starting dynamic subtest: objects
[499.618161] Dynamic subtest objects: SUCCESS (4.809s)
[499.628547] Starting dynamic subtest: mman
[504.437201] Dynamic subtest mman: SUCCESS (4.816s)
[504.447714] Starting dynamic subtest: dmabuf
[508.749082] Dynamic subtest dmabuf: SUCCESS (4.309s)
[508.759228] Starting dynamic subtest: vma
[513.104093] Dynamic subtest vma: SUCCESS (4.353s)
[513.114633] Starting dynamic subtest: coherency
[516.605825] Dynamic subtest coherency: SUCCESS (3.493s)
[516.616490] Starting dynamic subtest: gtt
[526.515071] Dynamic subtest gtt: SUCCESS (9.914s)
[526.524565] Starting dynamic subtest: gem
[532.467216] Dynamic subtest gem: SUCCESS (5.948s)
[532.477384] Starting dynamic subtest: evict
[537.914171] Dynamic subtest evict: SUCCESS (5.444s)
[537.924620] Starting dynamic subtest: hugepages
[548.764595] Dynamic subtest hugepages: SUCCESS (10.846s)
[548.774919] Starting dynamic subtest: gem_contexts
[577.317181] Dynamic subtest gem_contexts: SUCCESS (28.544s)
[577.327398] Starting dynamic subtest: client
[581.675323] Dynamic subtest client: SUCCESS (4.358s)
[581.685402] Starting dynamic subtest: gem_migrate
[586.019261] Dynamic subtest gem_migrate: SUCCESS (4.343s)
[586.029536] Starting dynamic subtest: reset
[588.702132] Dynamic subtest reset: SUCCESS (2.680s)
[588.717537] Starting dynamic subtest: memory_region
[593.036589] Dynamic subtest memory_region: SUCCESS (4.333s)
[593.046382] Starting dynamic subtest: hangcheck
[605.885941] Dynamic subtest hangcheck: SUCCESS (12.849s)
[605.895294] Starting dynamic subtest: execlists
[610.161904] Dynamic subtest execlists: SUCCESS (4.275s)
[610.171763] Starting dynamic subtest: ring_submission
[614.456886] Dynamic subtest ring_submission: SUCCESS (4.294s)
[614.466902] Starting dynamic subtest: perf
[617.188885] Dynamic subtest perf: SUCCESS (2.731s)
[617.198421] Starting dynamic subtest: slpc
[631.215853] Dynamic subtest slpc: SUCCESS (14.026s)
[631.226084] Starting dynamic subtest: guc
[635.045901] Dynamic subtest guc: SUCCESS (3.829s)
[635.060218] Starting dynamic subtest: guc_multi_lrc
[639.378255] Dynamic subtest guc_multi_lrc: SUCCESS (4.329s)
[639.387529] Starting dynamic subtest: guc_hang
[642.770936] Dynamic subtest guc_hang: SUCCESS (3.391s)
[642.781413] Starting dynamic subtest: late_gt_pm
[645.488508] Dynamic subtest late_gt_pm: SUCCESS (2.716s)
[645.490734] Subtest live: SUCCESS (240.436s)
[645.518195] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[645.518973] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[645.522094] [114/133] (380s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[647.055476] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[647.057863] Starting dynamic subtest: pipe-A-eDP-1
[647.080470] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[647.091141] Starting dynamic subtest: pipe-B-eDP-1
[647.112832] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[647.121785] Starting dynamic subtest: pipe-C-eDP-1
[647.143482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[647.153524] Starting dynamic subtest: pipe-D-eDP-1
[647.174299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[647.178465] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[649.410265] [FACT kms_ccs (ccs-on-another-bo-y-tiled-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[649.411404] [FACT kms_ccs (ccs-on-another-bo-y-tiled-ccs)] new: kernel.kmod_is_loaded.i915: true
[649.414953] [115/133] (376s left) gem_ctx_persistence (legacy-engines-cleanup)
[649.480063] Starting subtest: legacy-engines-cleanup
[649.482423] Starting dynamic subtest: render
[649.555862] Dynamic subtest render: SUCCESS (0.074s)
[649.569336] Starting dynamic subtest: bsd1
[649.608582] Dynamic subtest bsd1: SUCCESS (0.050s)
[649.619345] Starting dynamic subtest: bsd2
[649.662409] Dynamic subtest bsd2: SUCCESS (0.051s)
[649.673705] Starting dynamic subtest: blt
[649.723076] Dynamic subtest blt: SUCCESS (0.057s)
[649.734280] Starting dynamic subtest: vebox
[649.769297] Dynamic subtest vebox: SUCCESS (0.044s)
[649.771701] Subtest legacy-engines-cleanup: SUCCESS (0.290s)
[649.850613] [116/133] (376s left) kms_flip (flip-vs-suspend)
[649.935951] Starting subtest: flip-vs-suspend
[649.938282] Starting dynamic subtest: A-eDP1
[794.923080] Dynamic subtest A-eDP1: SUCCESS (11.328s)
[794.925375] Subtest flip-vs-suspend: SUCCESS (11.330s)
[795.057052] [117/133] (230s left) kms_invalid_mode (zero-hdisplay)
[795.147943] Starting subtest: zero-hdisplay
[795.150183] Starting dynamic subtest: pipe-A-eDP-1
[795.438057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[795.447991] Starting dynamic subtest: pipe-B-eDP-1
[795.450200] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[795.458656] Starting dynamic subtest: pipe-C-eDP-1
[795.460941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[795.469467] Starting dynamic subtest: pipe-D-eDP-1
[795.471877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[795.474205] Subtest zero-hdisplay: SUCCESS (0.298s)
[796.294064] [118/133] (229s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[796.413256] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[796.418115] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[796.555154] [119/133] (229s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[796.654998] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[796.659354] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[796.777138] [120/133] (229s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[796.865936] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[796.870295] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[796.939117] [121/133] (229s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[797.045076] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[804.186931] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.145s)
[804.312000] [122/133] (221s left) prime_mmap (test_errors)
[804.365165] Starting subtest: test_errors
[804.370428] Starting dynamic subtest: test_errors-smem
[804.466658] Dynamic subtest test_errors-smem: SUCCESS (0.103s)
[804.469833] Subtest test_errors: SUCCESS (0.104s)
[804.554507] [123/133] (221s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[804.654657] Starting subtest: primary-x-tiled-reflect-x-180
[811.574331] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.922s)
[812.778084] [124/133] (213s left) gem_pipe_control_store_loop (fresh-buffer)
[812.843766] Starting subtest: fresh-buffer
[814.997397] Subtest fresh-buffer: SUCCESS (2.152s)
[815.103438] [125/133] (211s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[815.206329] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[815.210788] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[815.288900] [126/133] (211s left) i915_pm_rc6_residency (rc6-idle)
[815.338514] Starting subtest: rc6-idle
[815.370879] Starting dynamic subtest: gt0-rcs0
[839.657938] Dynamic subtest gt0-rcs0: SUCCESS (24.286s)
[839.667814] Starting dynamic subtest: gt0-bcs0
[863.952346] Dynamic subtest gt0-bcs0: SUCCESS (24.291s)
[863.961974] Starting dynamic subtest: gt0-ccs0
[888.231132] Dynamic subtest gt0-ccs0: SUCCESS (24.275s)
[888.242682] Starting dynamic subtest: gt1-vcs0
[894.405690] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[894.418190] Starting dynamic subtest: gt1-vecs0
[900.577077] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[900.579752] Subtest rc6-idle: SUCCESS (85.237s)
[900.671802] [127/133] (125s left) gem_userptr_blits (sync-overlap)
[900.747214] Starting subtest: sync-overlap
[900.749557] Subtest sync-overlap: SUCCESS (0.000s)
[900.865964] [128/133] (125s left) perf (oa-exponents)
[900.995151] Starting subtest: oa-exponents
[900.997024] Starting dynamic subtest: 0-rcs0
[902.800166] Dynamic subtest 0-rcs0: SUCCESS (1.805s)
[902.811140] Starting dynamic subtest: 1-vcs0
[904.627377] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[904.629689] Subtest oa-exponents: SUCCESS (3.633s)
[904.676744] [129/133] (121s left) gem_create (create-ext-cpu-access-sanity-check)
[904.855265] Starting subtest: create-ext-cpu-access-sanity-check
[904.860574] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[904.959839] [130/133] (121s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[905.057394] Starting subtest: plane-upscale-20x20-with-pixel-format
[905.059666] Starting dynamic subtest: pipe-A
[906.106484] Dynamic subtest pipe-A: SUCCESS (1.050s)
[906.115818] Starting dynamic subtest: pipe-B
[908.187892] Dynamic subtest pipe-B: SUCCESS (2.080s)
[908.198168] Starting dynamic subtest: pipe-C
[909.387128] Dynamic subtest pipe-C: SUCCESS (1.197s)
[909.396813] Starting dynamic subtest: pipe-D
[910.615970] Dynamic subtest pipe-D: SUCCESS (1.225s)
[910.618232] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.559s)
[911.804416] [131/133] (114s left) gem_ctx_bad_destroy (invalid-ctx)
[911.867676] Starting subtest: invalid-ctx
[911.870042] Subtest invalid-ctx: SUCCESS (0.000s)
[911.941717] [132/133] (114s left) gem_mmap_offset (clear)
[911.997396] Starting subtest: clear
[911.999989] Starting dynamic subtest: smem0
[936.444148] Dynamic subtest smem0: SUCCESS (24.441s)
[936.446642] Subtest clear: SUCCESS (24.442s)
[936.558225] [133/133] ( 90s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[936.720306] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[943.458777] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.741s)
[943.584134] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_lowres
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_vm_create
results: parsing output: 7/ for test: kms_properties
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_scaling_modes
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_bad_reloc
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: gem_ringfill
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: kms_selftest
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_chamelium_frames
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: syncobj_basic
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: gem_ctx_sseu
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: fbdev
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_color_pipeline
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_pipe_stress
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_pm_backlight
results: parsing output: 86/ for test: kms_debugfs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: device_reset
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_chamelium_edid
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_module_load
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_selftest
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_invalid_mode
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: gem_pipe_control_store_loop
results: parsing output: 124/ for test: kms_joiner
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: gem_create
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: gem_ctx_bad_destroy
results: parsing output: 131/ for test: gem_mmap_offset
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.