[58.403409] Initializing watchdogs
[58.403463]   /dev/watchdog0
[58.418302] [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]
[58.423556] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.425791] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.429457] [001/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[58.559661] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[58.563995] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[58.646326] [002/156] (960s left) kms_selftest (drm_format)
[58.683285] Starting subtest: drm_format
[58.689976] Starting dynamic subtest: drm_test_format_block_width_invalid
[58.793072] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.102s)
[58.800248] Starting dynamic subtest: drm_test_format_block_width_one_plane
[58.887328] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.091s)
[58.894092] Starting dynamic subtest: drm_test_format_block_width_two_plane
[58.984584] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.095s)
[58.993039] Starting dynamic subtest: drm_test_format_block_width_three_plane
[59.071559] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.086s)
[59.078562] Starting dynamic subtest: drm_test_format_block_width_tiled
[59.173162] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.099s)
[59.181879] Starting dynamic subtest: drm_test_format_block_height_invalid
[59.267977] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.094s)
[59.276280] Starting dynamic subtest: drm_test_format_block_height_one_plane
[59.355038] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.084s)
[59.363298] Starting dynamic subtest: drm_test_format_block_height_two_plane
[59.454846] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.099s)
[59.461467] Starting dynamic subtest: drm_test_format_block_height_three_plane
[59.542071] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.086s)
[59.550725] Starting dynamic subtest: drm_test_format_block_height_tiled
[59.655585] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.111s)
[59.664554] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[59.747897] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.090s)
[59.756539] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[59.856848] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.107s)
[59.864785] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[59.945863] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.088s)
[59.952675] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[60.057071] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.109s)
[60.065565] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[60.137989] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.079s)
[60.145065] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[60.228966] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s)
[60.236064] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[60.331077] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.100s)
[60.338076] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[60.433157] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.100s)
[60.435067] Subtest drm_format: SUCCESS (1.728s)
[60.583238] [003/156] (958s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[60.678993] Starting subtest: plane-upscale-20x20-with-pixel-format
[60.681185] Starting dynamic subtest: pipe-A
[61.749077] Dynamic subtest pipe-A: SUCCESS (1.061s)
[61.757300] Starting dynamic subtest: pipe-B
[63.921171] Dynamic subtest pipe-B: SUCCESS (2.153s)
[63.930047] Starting dynamic subtest: pipe-C
[65.128074] Dynamic subtest pipe-C: SUCCESS (1.198s)
[65.135992] Starting dynamic subtest: pipe-D
[66.371321] Dynamic subtest pipe-D: SUCCESS (1.236s)
[66.373513] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.649s)
[67.576283] [004/156] (951s left) kms_psr (psr-primary-blt)
[67.680307] Starting subtest: psr-primary-blt
[67.682650] Starting dynamic subtest: eDP-1
[69.494252] Dynamic subtest eDP-1: SUCCESS (1.807s)
[69.496199] Subtest psr-primary-blt: SUCCESS (1.807s)
[70.363631] [005/156] (948s left) gem_render_copy_redux (flink)
[70.423311] Starting subtest: flink
[71.176546] Subtest flink: SUCCESS (0.751s)
[71.289845] [006/156] (947s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[71.381650] Starting subtest: pr-overlay-plane-move-continuous-sf
[71.385230] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[71.450657] [007/156] (947s left) kms_cursor_crc (cursor-size-change)
[71.547020] Starting subtest: cursor-size-change
[71.548630] Starting dynamic subtest: pipe-A-eDP-1
[72.350451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.801s)
[72.359823] Starting dynamic subtest: pipe-D-eDP-1
[73.840390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[73.842638] Subtest cursor-size-change: SUCCESS (2.289s)
[74.724628] [008/156] (944s left) gem_exec_schedule (wide)
[74.907252] Starting subtest: wide
[74.909917] Starting dynamic subtest: rcs0
[84.783678] Dynamic subtest rcs0: SUCCESS (9.865s)
[84.794651] Starting dynamic subtest: vcs0
[94.833773] Dynamic subtest vcs0: SUCCESS (10.043s)
[94.846074] Starting dynamic subtest: vcs1
[105.321923] Dynamic subtest vcs1: SUCCESS (10.485s)
[105.330281] Starting dynamic subtest: vecs0
[117.819693] Dynamic subtest vecs0: SUCCESS (12.494s)
[117.830011] Starting dynamic subtest: ccs0
[130.341230] Dynamic subtest ccs0: SUCCESS (12.519s)
[130.343917] Subtest wide: SUCCESS (55.408s)
[132.139683] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[132.143065] [009/156] (887s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[132.241125] Starting subtest: 4-tiled-16bpp-rotate-270
[132.264594] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[132.363849] [010/156] (886s left) gem_exec_reloc (basic-cpu-read)
[132.419711] Subtest basic-cpu-read: SKIP (0.000s)
[132.486478] [011/156] (886s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt)
[132.577249] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt
[132.581165] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[132.670256] [012/156] (886s left) i915_drm_fdinfo (virtual-busy-hang)
[132.713090] Starting subtest: virtual-busy-hang
[132.717179] Subtest virtual-busy-hang: SKIP (0.000s)
[132.777293] [013/156] (886s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen)
[132.873272] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen
[132.877491] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[132.975168] [014/156] (886s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[133.070860] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[133.073220] Starting dynamic subtest: pipe-A-eDP-1
[133.094035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[133.104241] Starting dynamic subtest: pipe-B-eDP-1
[133.121898] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[133.129536] Starting dynamic subtest: pipe-C-eDP-1
[133.147293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[133.156233] Starting dynamic subtest: pipe-D-eDP-1
[133.174855] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[133.178517] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[135.322779] [015/156] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[135.431890] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[135.436223] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[135.518969] [016/156] (883s left) gem_caching (read-writes)
[135.579456] Subtest read-writes: SKIP (0.000s)
[135.656287] [017/156] (883s left) api_intel_bb (reset-flags)
[135.709856] Starting subtest: reset-flags
[135.717680] Subtest reset-flags: SUCCESS (0.010s)
[135.840380] [018/156] (883s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[135.944647] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[135.948700] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[136.037792] [019/156] (883s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[136.097522] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[136.099504] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[136.195560] [020/156] (883s left) gem_ctx_exec (basic-norecovery)
[136.250629] Starting subtest: basic-norecovery
[136.578466] Subtest basic-norecovery: SUCCESS (0.327s)
[136.711508] [021/156] (882s left) kms_psr (fbc-pr-cursor-blt)
[136.803050] Starting subtest: fbc-pr-cursor-blt
[136.806478] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[136.874222] [022/156] (882s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[136.971989] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc
[136.975961] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[137.053335] [023/156] (882s left) perf_pmu (semaphore-wait-idle)
[137.092874] Starting subtest: semaphore-wait-idle
[137.094999] Starting dynamic subtest: rcs0
[137.608823] Dynamic subtest rcs0: SUCCESS (0.513s)
[137.621064] Starting dynamic subtest: bcs0
[138.122074] Dynamic subtest bcs0: SUCCESS (0.512s)
[138.134056] Starting dynamic subtest: vcs0
[138.636121] Dynamic subtest vcs0: SUCCESS (0.512s)
[138.647060] Starting dynamic subtest: vcs1
[139.147682] Dynamic subtest vcs1: SUCCESS (0.512s)
[139.161623] Starting dynamic subtest: vecs0
[139.660781] Dynamic subtest vecs0: SUCCESS (0.511s)
[139.672207] Starting dynamic subtest: ccs0
[140.179921] Dynamic subtest ccs0: SUCCESS (0.518s)
[140.182625] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[141.383227] [024/156] (878s left) perf (whitelisted-registers-userspace-config)
[141.494778] Starting subtest: whitelisted-registers-userspace-config
[141.497125] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[141.537308] [025/156] (878s left) kms_chamelium_edid (hdmi-edid-read)
[142.669141] Subtest hdmi-edid-read: SKIP (0.000s)
[142.988350] [026/156] (876s left) gem_flink_basic (double-flink)
[143.037662] Starting subtest: double-flink
[143.039931] Subtest double-flink: SUCCESS (0.000s)
[143.156555] [027/156] (876s left) gem_exec_flush (basic-wb-set-default)
[143.209805] Starting subtest: basic-wb-set-default
[148.668479] Subtest basic-wb-set-default: SUCCESS (5.459s)
[148.853721] [028/156] (871s left) gem_tiled_wc
[148.973927] [029/156] (871s left) prime_mmap (test_correct_cpu_write)
[149.029220] Starting subtest: test_correct_cpu_write
[149.031663] Starting dynamic subtest: test_correct_cpu_write-smem
[149.034034] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[149.036286] Subtest test_correct_cpu_write: SUCCESS (0.000s)
[149.143099] [030/156] (870s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[149.249569] Starting subtest: fbcpsrhdr-tiling-linear
[149.254078] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[149.346843] [031/156] (870s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[149.445301] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[149.449498] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[149.557898] [032/156] (870s left) kms_legacy_colorkey (basic)
[149.657434] Starting subtest: basic
[149.659648] Starting dynamic subtest: pipe-A
[149.703425] Dynamic subtest pipe-A: SUCCESS (0.045s)
[149.718064] Starting dynamic subtest: pipe-B
[149.720283] Dynamic subtest pipe-B: SUCCESS (0.001s)
[149.728920] Starting dynamic subtest: pipe-C
[149.730815] Dynamic subtest pipe-C: SUCCESS (0.001s)
[149.739554] Starting dynamic subtest: pipe-D
[149.741478] Dynamic subtest pipe-D: SUCCESS (0.000s)
[149.743390] Subtest basic: SUCCESS (0.050s)
[149.778301] [033/156] (870s left) gem_userptr_blits (forbidden-operations)
[149.833542] Starting subtest: forbidden-operations
[149.837339] Subtest forbidden-operations: SKIP (0.000s)
[149.952620] [034/156] (870s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[150.075859] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[150.209803] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[150.332302] [035/156] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[150.417525] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[150.419471] Starting dynamic subtest: pipe-A-default-mode
[153.176282] Dynamic subtest pipe-A-default-mode: SUCCESS (2.758s)
[153.178238] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.759s)
[154.013587] [036/156] (866s left) prime_busy (hang)
[154.064227] Starting subtest: hang
[154.066069] Starting dynamic subtest: rcs0
[179.802926] Dynamic subtest rcs0: SUCCESS (25.740s)
[179.812101] Starting dynamic subtest: bcs0
[186.950237] Dynamic subtest bcs0: SUCCESS (7.147s)
[186.959246] Starting dynamic subtest: vcs0
[193.925957] Dynamic subtest vcs0: SUCCESS (6.972s)
[193.934645] Starting dynamic subtest: vcs1
[200.965809] Dynamic subtest vcs1: SUCCESS (7.041s)
[200.975286] Starting dynamic subtest: vecs0
[207.939416] Dynamic subtest vecs0: SUCCESS (6.970s)
[207.948173] Starting dynamic subtest: ccs0
[221.782323] Dynamic subtest ccs0: SUCCESS (13.841s)
[221.784832] Subtest hang: SUCCESS (67.716s)
[221.923220] [037/156] (798s left) kms_addfb_basic (bad-pitch-65536)
[221.979682] Starting subtest: bad-pitch-65536
[221.981807] Subtest bad-pitch-65536: SUCCESS (0.000s)
[222.154758] [038/156] (798s left) kms_joiner (invalid-modeset-big-joiner)
[222.257406] Starting subtest: invalid-modeset-big-joiner
[222.261734] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[222.322127] [039/156] (798s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[222.370822] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[222.373110] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[222.454617] [040/156] (798s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[222.512307] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[222.582905] [041/156] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[222.678804] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[222.682389] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[222.772566] [042/156] (797s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[222.865180] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[222.868990] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[222.940426] [043/156] (797s left) gem_exec_params (sol-reset-not-gen7)
[223.007428] Starting subtest: sol-reset-not-gen7
[223.011424] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[223.131582] [044/156] (797s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[223.256099] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[224.214638] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[225.056860] [045/156] (795s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[225.156089] Starting subtest: x-tiled-8bpp-rotate-180
[226.391033] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.236s)
[226.512689] [046/156] (794s left) gem_ctx_engines (execute-allforone)
[226.580548] Starting subtest: execute-allforone
[226.593126] Subtest execute-allforone: SUCCESS (0.013s)
[228.347833] [047/156] (792s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[228.440987] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[228.445461] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[228.525816] [048/156] (792s left) kms_cursor_crc (cursor-sliding-256x256)
[228.763926] Starting subtest: cursor-sliding-256x256
[228.768614] Starting dynamic subtest: pipe-A-eDP-1
[232.011367] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s)
[232.042067] Starting dynamic subtest: pipe-D-eDP-1
[235.969365] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.933s)
[235.971321] Subtest cursor-sliding-256x256: SUCCESS (7.202s)
[236.821578] [049/156] (784s left) kms_flip (flip-vs-suspend)
[236.920479] Starting subtest: flip-vs-suspend
[236.922709] Starting dynamic subtest: A-eDP1
[382.055400] Dynamic subtest A-eDP1: SUCCESS (11.999s)
[382.058157] Subtest flip-vs-suspend: SUCCESS (12.001s)
[382.213769] [050/156] (638s left) kms_feature_discovery (chamelium)
[382.321203] Starting subtest: chamelium
[382.326544] Subtest chamelium: SKIP (0.000s)
[382.403002] [051/156] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[382.509182] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[382.514289] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.606505] [052/156] (638s left) kms_hdr (brightness-with-hdr)
[382.702398] Starting subtest: brightness-with-hdr
[382.705299] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[382.710446] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[382.721417] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[382.726530] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[382.732304] Subtest brightness-with-hdr: SKIP (0.002s)
[382.778897] [053/156] (638s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[382.875231] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[387.182787] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.197s)
[388.401674] [054/156] (632s left) kms_vrr (seamless-rr-switch-vrr)
[388.495552] Starting subtest: seamless-rr-switch-vrr
[388.503445] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[388.567238] [055/156] (632s left) gem_mmap_gtt (flink-race)
[388.615534] Subtest flink-race: SKIP (0.000s)
[388.683997] [056/156] (632s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt)
[388.778430] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt
[388.782776] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[388.859513] [057/156] (632s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[388.954981] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[396.366672] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.339s)
[396.481363] [058/156] (624s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[396.572166] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[403.425321] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.830s)
[403.539283] [059/156] (617s left) gem_ctx_create (basic-files)
[403.605234] Starting subtest: basic-files
[405.876297] Subtest basic-files: SUCCESS (2.265s)
[407.469728] [060/156] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[407.567325] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[407.572521] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[407.645418] [061/156] (613s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[407.748574] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[407.753442] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[407.835229] [062/156] (613s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[407.919368] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[407.922032] Starting dynamic subtest: pipe-A-eDP-1
[407.946588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[407.957161] Starting dynamic subtest: pipe-B-eDP-1
[407.982483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[407.992244] Starting dynamic subtest: pipe-C-eDP-1
[408.017537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.027230] Starting dynamic subtest: pipe-D-eDP-1
[408.054352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.059265] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[410.240678] [063/156] (611s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[410.296450] Starting subtest: etime-multi-wait-for-submit-submitted
[410.396039] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[410.471461] [064/156] (611s left) kms_big_fb (linear-32bpp-rotate-270)
[410.575252] Starting subtest: linear-32bpp-rotate-270
[410.594333] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[410.709391] [065/156] (610s left) gem_exec_balancer (parallel)
[410.980536] Starting subtest: parallel
[411.916482] Subtest parallel: SUCCESS (0.938s)
[412.465189] [066/156] (609s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[412.528340] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[412.604618] [067/156] (609s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[412.704269] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[412.709207] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[412.812455] [068/156] (608s left) gem_mmap_wc (set-cache-level)
[412.868370] Subtest set-cache-level: SKIP (0.000s)
[412.926386] [069/156] (608s left) kms_cursor_edge_walk (64x64-top-edge)
[413.021925] Starting subtest: 64x64-top-edge
[413.024265] Starting dynamic subtest: pipe-A-eDP-1
[416.526478] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[416.536828] Starting dynamic subtest: pipe-D-eDP-1
[419.667319] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[419.670043] Subtest 64x64-top-edge: SUCCESS (6.643s)
[420.461886] [070/156] (601s left) kms_prime (basic-crc-hybrid)
[420.542808] Subtest basic-crc-hybrid: SKIP (0.000s)
[420.635151] [071/156] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[420.730562] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[420.736216] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.840061] [072/156] (601s left) gem_userptr_blits (vma-merge)
[420.913229] Starting subtest: vma-merge
[420.954952] Subtest vma-merge: SUCCESS (0.041s)
[421.093459] [073/156] (600s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[421.198244] Starting subtest: basic-flip-before-cursor-atomic
[422.114558] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[422.989897] [074/156] (598s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt)
[423.092136] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt
[423.097277] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[423.193245] [075/156] (598s left) kms_pm_rpm (drm-resources-equal)
[424.738370] Starting subtest: drm-resources-equal
[430.137895] Subtest drm-resources-equal: SUCCESS (5.400s)
[430.226890] [076/156] (591s left) kms_frontbuffer_tracking (hdr-shrfb-scaledprimary)
[430.330381] Starting subtest: hdr-shrfb-scaledprimary
[430.335187] Subtest hdr-shrfb-scaledprimary: SKIP (0.000s)
[430.425152] [077/156] (591s left) kms_fbcon_fbt (psr)
[430.482734] Starting subtest: psr
[437.892594] Subtest psr: SUCCESS (7.402s)
[437.976780] [078/156] (584s left) kms_chamelium_color (ctm-0-25)
[438.070867] Subtest ctm-0-25: SKIP (0.000s)
[438.116679] [079/156] (584s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render)
[438.209470] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render
[438.214823] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[438.328600] [080/156] (583s left) kms_vrr (negative-basic)
[438.432447] Starting subtest: negative-basic
[438.439459] Starting dynamic subtest: pipe-A-eDP-1
[444.471458] Dynamic subtest pipe-A-eDP-1: FAIL (5.426s)
[444.473666] Subtest negative-basic: FAIL (5.712s)
[445.033972] [081/156] (577s left) kms_cursor_crc (cursor-offscreen-32x10)
[445.192600] Starting subtest: cursor-offscreen-32x10
[445.238480] Subtest cursor-offscreen-32x10: SKIP (0.040s)
[445.498790] [082/156] (576s left) syncobj_timeline (signal-array)
[445.563360] Starting subtest: signal-array
[445.565917] Subtest signal-array: SUCCESS (0.000s)
[445.671603] [083/156] (576s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[445.768210] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[445.773142] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[445.855704] [084/156] (576s left) api_intel_bb (blit-reloc-keep-cache)
[445.905957] Starting subtest: blit-reloc-keep-cache
[445.910975] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[446.019317] [085/156] (576s left) kms_dp_link_training (uhbr-mst)
[446.107540] Starting subtest: uhbr-mst
[446.116323] Subtest uhbr-mst: SKIP (0.000s)
[446.183230] [086/156] (576s left) gem_lmem_swapping (random)
[446.220530] Subtest random: SKIP (0.000s)
[446.269295] [087/156] (576s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[446.375584] Starting subtest: fbchdr-rgb101010-draw-blt
[446.380178] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[446.473910] [088/156] (576s left) gem_mmap_gtt (big-bo-tiledy)
[446.524658] Subtest big-bo-tiledY: SKIP (0.000s)
[446.584878] [089/156] (576s left) gem_exec_schedule (out-order)
[446.646032] Starting subtest: out-order
[446.648165] Starting dynamic subtest: rcs0
[446.750463] Dynamic subtest rcs0: SUCCESS (0.112s)
[446.762420] Starting dynamic subtest: vcs0
[446.845464] Dynamic subtest vcs0: SUCCESS (0.095s)
[446.860909] Starting dynamic subtest: vcs1
[446.932708] Dynamic subtest vcs1: SUCCESS (0.087s)
[446.943025] Starting dynamic subtest: vecs0
[447.012332] Dynamic subtest vecs0: SUCCESS (0.079s)
[447.026420] Starting dynamic subtest: ccs0
[447.100244] Dynamic subtest ccs0: SUCCESS (0.086s)
[447.103188] Subtest out-order: SUCCESS (0.463s)
[448.483078] [090/156] (574s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[448.588291] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[448.593356] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[448.699478] [091/156] (573s left) kms_sequence (queue-busy)
[448.793712] Starting subtest: queue-busy
[448.796536] Starting dynamic subtest: pipe-A-eDP-1
[450.719537] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[450.731172] Starting dynamic subtest: pipe-B-eDP-1
[453.345876] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.624s)
[453.357550] Starting dynamic subtest: pipe-C-eDP-1
[455.961489] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[455.972201] Starting dynamic subtest: pipe-D-eDP-1
[458.582321] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[458.585095] Subtest queue-busy: SUCCESS (9.786s)
[459.474033] [092/156] (563s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[459.580564] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[459.586117] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[459.673824] [093/156] (563s left) i915_suspend (basic-s2idle-without-i915)
[459.711379] Starting subtest: basic-s2idle-without-i915
[478.513279] Subtest basic-s2idle-without-i915: SUCCESS (4.038s)
[478.653482] [094/156] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[478.772618] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[478.777185] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[478.879837] [095/156] (543s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[478.987133] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[478.991318] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[479.091703] [096/156] (543s left) gem_exec_schedule (u-semaphore-codependency)
[479.157960] Starting subtest: u-semaphore-codependency
[479.176307] Subtest u-semaphore-codependency: SUCCESS (0.019s)
[479.522558] [097/156] (543s left) syncobj_timeline (transfer-timeline-point)
[479.573798] Starting subtest: transfer-timeline-point
[479.575824] Subtest transfer-timeline-point: SUCCESS (0.000s)
[479.681790] [098/156] (543s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[480.087703] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[480.918633] [099/156] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[481.019296] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[481.023914] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[481.101321] [100/156] (541s left) kms_content_protection (uevent)
[481.250581] Starting subtest: uevent
[481.255063] Subtest uevent: SKIP (0.000s)
[481.383639] [101/156] (541s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-msflip-blt)
[481.486730] Starting subtest: hdr-2p-primscrn-shrfb-msflip-blt
[481.490936] Subtest hdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[481.583949] [102/156] (541s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[481.678869] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[481.682904] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[481.781059] [103/156] (541s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[481.871364] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[481.874757] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[481.979126] [104/156] (541s left) core_setmaster (master-drop-set-shared-fd)
[482.055055] Starting subtest: master-drop-set-shared-fd
[482.074162] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[482.116073] [105/156] (541s left) kms_psr (fbc-psr2-cursor-plane-move)
[482.208647] Starting subtest: fbc-psr2-cursor-plane-move
[482.210560] Starting dynamic subtest: eDP-1
[482.214428] Dynamic subtest eDP-1: SKIP (0.000s)
[482.218226] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[482.278537] [106/156] (541s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[482.381598] Starting subtest: primary-x-tiled-reflect-x-0
[489.398635] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.926s)
[490.628021] [107/156] (532s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[490.722275] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[490.724590] Starting dynamic subtest: pipe-A
[490.745431] Dynamic subtest pipe-A: SKIP (0.018s)
[490.755737] Starting dynamic subtest: pipe-B
[490.779420] Dynamic subtest pipe-B: SKIP (0.033s)
[490.788676] Starting dynamic subtest: pipe-C
[490.816411] Dynamic subtest pipe-C: SKIP (0.037s)
[490.825688] Starting dynamic subtest: pipe-D
[490.854084] Dynamic subtest pipe-D: SKIP (0.037s)
[490.858247] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.127s)
[490.932705] [108/156] (532s left) gen9_exec_parse (bb-oversize)
[490.994695] Subtest bb-oversize: SKIP (0.000s)
[491.070742] [109/156] (532s left) i915_hangman (engine-engine-hang)
[491.132480] Starting subtest: engine-engine-hang
[491.134326] Starting dynamic subtest: rcs0
[493.108993] Dynamic subtest rcs0: SUCCESS (1.963s)
[493.121362] Starting dynamic subtest: bcs0
[495.090323] Dynamic subtest bcs0: SUCCESS (1.969s)
[495.103430] Starting dynamic subtest: vcs0
[497.137710] Dynamic subtest vcs0: SUCCESS (2.037s)
[497.150244] Starting dynamic subtest: vcs1
[499.122656] Dynamic subtest vcs1: SUCCESS (1.976s)
[499.134293] Starting dynamic subtest: vecs0
[501.105072] Dynamic subtest vecs0: SUCCESS (1.976s)
[501.118482] Starting dynamic subtest: ccs0
[503.090453] Dynamic subtest ccs0: SUCCESS (1.978s)
[503.093766] Subtest engine-engine-hang: SUCCESS (11.915s)
[503.241341] [110/156] (520s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[503.339927] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[503.343950] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[503.412038] [111/156] (520s left) i915_pm_rc6_residency (rc6-fence)
[503.471201] Starting subtest: rc6-fence
[503.506464] Starting dynamic subtest: gt0
[515.839165] Dynamic subtest gt0: SUCCESS (12.322s)
[515.849530] Starting dynamic subtest: gt1
[531.091810] Dynamic subtest gt1: SUCCESS (15.244s)
[531.094501] Subtest rc6-fence: SUCCESS (27.607s)
[531.182303] [112/156] (492s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[531.287347] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[531.291602] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[531.411460] [113/156] (492s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[531.468383] Starting subtest: y-tiled-ccs-to-x-tiled
[531.473074] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[531.655431] [114/156] (491s left) kms_async_flips (crc-atomic)
[531.749734] Starting subtest: crc-atomic
[532.123847] Starting dynamic subtest: pipe-A-eDP-1
[535.008431] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.883s)
[535.405955] Starting dynamic subtest: pipe-B-eDP-1
[538.345581] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.954s)
[538.716209] Starting dynamic subtest: pipe-C-eDP-1
[541.639151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.931s)
[542.013400] Starting dynamic subtest: pipe-D-eDP-1
[544.865565] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s)
[544.867746] Subtest crc-atomic: SUCCESS (13.111s)
[546.055799] [115/156] (477s left) gem_eio (suspend)
[546.253164] Starting subtest: suspend
[559.110664] Subtest suspend: SUCCESS (12.851s)
[559.255346] [116/156] (464s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[559.361703] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[559.365875] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[559.443354] [117/156] (464s left) sysfs_heartbeat_interval (nopreempt)
[559.499993] Starting subtest: nopreempt
[559.502186] Starting dynamic subtest: vecs0
[569.166140] Dynamic subtest vecs0: SUCCESS (9.668s)
[569.178573] Starting dynamic subtest: ccs0
[573.072981] Dynamic subtest ccs0: SUCCESS (3.907s)
[573.085733] Starting dynamic subtest: vcs0
[582.162474] Dynamic subtest vcs0: SUCCESS (9.086s)
[582.174065] Starting dynamic subtest: bcs0
[586.085992] Dynamic subtest bcs0: SUCCESS (3.924s)
[586.098716] Starting dynamic subtest: rcs0
[590.091510] Dynamic subtest rcs0: SUCCESS (4.004s)
[590.102761] Starting dynamic subtest: vcs1
[600.140742] Dynamic subtest vcs1: SUCCESS (10.045s)
[600.143214] Subtest nopreempt: SUCCESS (40.645s)
[600.219671] [118/156] (423s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[600.338330] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[600.342771] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[600.436615] [119/156] (423s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-pwrite)
[600.536645] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-pwrite
[600.540736] Subtest fbchdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[600.645306] [120/156] (423s left) gem_exec_reloc (basic-write-gtt-noreloc)
[600.700137] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[600.772221] [121/156] (423s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[600.868171] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[600.870498] Starting dynamic subtest: pipe-A-eDP-1
[600.928462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[601.236704] Starting dynamic subtest: pipe-B-eDP-1
[602.036774] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.811s)
[602.348083] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.480s)
[603.195046] [122/156] (420s left) gem_lmem_swapping (basic)
[603.239776] Subtest basic: SKIP (0.000s)
[603.287440] [123/156] (420s left) kms_color (invalid-gamma-lut-sizes)
[603.380255] Starting subtest: invalid-gamma-lut-sizes
[603.382398] Starting dynamic subtest: pipe-A
[603.676704] Dynamic subtest pipe-A: SUCCESS (0.298s)
[603.687460] Starting dynamic subtest: pipe-B
[603.689818] Dynamic subtest pipe-B: SUCCESS (0.000s)
[603.699474] Starting dynamic subtest: pipe-C
[603.701836] Dynamic subtest pipe-C: SUCCESS (0.000s)
[603.711502] Starting dynamic subtest: pipe-D
[603.713426] Dynamic subtest pipe-D: SUCCESS (0.000s)
[603.715352] Subtest invalid-gamma-lut-sizes: SUCCESS (0.301s)
[604.538412] [124/156] (419s left) gem_ctx_shared (detached-shared-gtt)
[604.595463] Starting subtest: detached-shared-gtt
[606.750899] Subtest detached-shared-gtt: SUCCESS (2.153s)
[607.038900] [125/156] (417s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[607.140063] Starting subtest: y-tiled-addfb-size-offset-overflow
[607.144488] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[607.229929] [126/156] (416s left) gem_exec_schedule (implicit-boths)
[607.297665] Starting subtest: implicit-boths
[607.299835] Starting dynamic subtest: rcs0
[607.411062] Dynamic subtest rcs0: SUCCESS (0.123s)
[607.423615] Starting dynamic subtest: vcs0
[607.496682] Dynamic subtest vcs0: SUCCESS (0.084s)
[607.510159] Starting dynamic subtest: vcs1
[607.582500] Dynamic subtest vcs1: SUCCESS (0.085s)
[607.597890] Starting dynamic subtest: vecs0
[607.660833] Dynamic subtest vecs0: SUCCESS (0.078s)
[607.674044] Starting dynamic subtest: ccs0
[607.750171] Dynamic subtest ccs0: SUCCESS (0.088s)
[607.752963] Subtest implicit-boths: SUCCESS (0.463s)
[609.247169] [127/156] (414s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[609.338453] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[609.343455] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[610.467616] [128/156] (413s left) gem_eio (context-create)
[610.680732] Starting subtest: context-create
[610.992370] Subtest context-create: SUCCESS (0.311s)
[611.115618] [129/156] (413s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[611.206334] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[611.208590] Starting dynamic subtest: pipe-A-eDP-1
[611.231322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[611.242898] Starting dynamic subtest: pipe-B-eDP-1
[611.264896] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[611.274979] Starting dynamic subtest: pipe-C-eDP-1
[611.297074] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[611.306908] Starting dynamic subtest: pipe-D-eDP-1
[611.329146] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[611.333508] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[613.531859] [130/156] (410s left) gem_ccs (block-copy-uncompressed)
[613.579321] Starting subtest: block-copy-uncompressed
[613.581706] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[613.602253] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[613.613724] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[613.619506] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[613.629781] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[613.635960] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[613.645584] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[613.652619] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[613.654955] Subtest block-copy-uncompressed: SUCCESS (0.073s)
[613.765081] [131/156] (410s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[613.828523] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[613.936554] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[614.025507] [132/156] (410s left) gem_exec_balancer (parallel-out-fence)
[614.290959] Starting subtest: parallel-out-fence
[615.516759] Subtest parallel-out-fence: SUCCESS (1.226s)
[615.642341] [133/156] (408s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[615.738880] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[615.743289] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.838247] [134/156] (408s left) gem_exec_fence (keep-in-fence)
[616.020379] Starting subtest: keep-in-fence
[616.022850] Starting dynamic subtest: rcs0
[616.073893] Dynamic subtest rcs0: SUCCESS (0.054s)
[616.086707] Starting dynamic subtest: bcs0
[616.127130] Dynamic subtest bcs0: SUCCESS (0.051s)
[616.141020] Starting dynamic subtest: vcs0
[618.135157] Dynamic subtest vcs0: SUCCESS (2.004s)
[618.149072] Starting dynamic subtest: vcs1
[620.180178] Dynamic subtest vcs1: SUCCESS (2.042s)
[620.196675] Starting dynamic subtest: vecs0
[622.164476] Dynamic subtest vecs0: SUCCESS (1.981s)
[622.178288] Starting dynamic subtest: ccs0
[622.407170] Dynamic subtest ccs0: SUCCESS (0.241s)
[622.409977] Subtest keep-in-fence: SUCCESS (6.388s)
[624.238246] [135/156] (400s left) kms_flip (blocking-wf_vblank)
[624.337266] Starting subtest: blocking-wf_vblank
[624.339586] Starting dynamic subtest: A-eDP1
[633.268664] Dynamic subtest A-eDP1: SUCCESS (8.931s)
[633.282056] Starting dynamic subtest: B-eDP1
[642.206117] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[642.217840] Starting dynamic subtest: C-eDP1
[651.125399] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[651.142544] Starting dynamic subtest: D-eDP1
[660.059987] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[660.062778] Subtest blocking-wf_vblank: SUCCESS (35.719s)
[661.284824] [136/156] (363s left) gem_exec_suspend (basic-s3)
[661.354658] Starting subtest: basic-S3
[661.356578] Starting dynamic subtest: smem
[681.959482] Dynamic subtest smem: SUCCESS (6.761s)
[681.964235] Subtest basic-S3: SUCCESS (6.762s)
[682.131965] [137/156] (342s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[682.246455] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[682.250789] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[682.345473] [138/156] (342s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[682.446297] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[682.450465] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[682.540310] [139/156] (342s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[682.643111] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[682.647406] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[682.741212] [140/156] (342s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[682.859383] Starting subtest: cursor-vs-flip-legacy
[712.847115] Subtest cursor-vs-flip-legacy: SUCCESS (29.692s)
[713.737065] [141/156] (311s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[713.840837] Starting subtest: yf-tiled-32bpp-rotate-270
[713.845311] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[713.938566] [142/156] (310s left) syncobj_wait (invalid-reset-bad-pad)
[713.987531] Starting subtest: invalid-reset-bad-pad
[713.989797] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[714.080654] [143/156] (310s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[714.168800] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[714.173316] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[714.265532] [144/156] (310s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[714.361951] Starting subtest: fbc-psr-cursor-mmap-gtt
[714.364119] Starting dynamic subtest: eDP-1
[714.368003] Dynamic subtest eDP-1: SKIP (0.000s)
[714.371880] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[714.437608] [145/156] (310s left) kms_psr (psr2-cursor-plane-onoff)
[714.526793] Starting subtest: psr2-cursor-plane-onoff
[714.529033] Starting dynamic subtest: eDP-1
[716.214396] Dynamic subtest eDP-1: SUCCESS (1.683s)
[716.217071] Subtest psr2-cursor-plane-onoff: SUCCESS (1.687s)
[717.098614] [146/156] (307s left) gem_spin_batch (resubmit-new-all)
[717.155618] Starting subtest: resubmit-new-all
[717.157810] Starting dynamic subtest: rcs0
[717.171903] Dynamic subtest rcs0: SUCCESS (0.015s)
[717.182392] Starting dynamic subtest: bcs0
[717.185357] Dynamic subtest bcs0: SUCCESS (0.013s)
[717.202929] Starting dynamic subtest: vcs0
[717.205137] Dynamic subtest vcs0: SUCCESS (0.008s)
[717.215679] Starting dynamic subtest: vcs1
[717.217602] Dynamic subtest vcs1: SUCCESS (0.008s)
[717.228077] Starting dynamic subtest: vecs0
[717.230298] Dynamic subtest vecs0: SUCCESS (0.008s)
[717.240290] Starting dynamic subtest: ccs0
[717.242462] Dynamic subtest ccs0: SUCCESS (0.010s)
[717.244650] Subtest resubmit-new-all: SUCCESS (0.067s)
[719.037107] [147/156] (306s left) kms_properties (colorop-properties-atomic)
[719.128015] Starting subtest: colorop-properties-atomic
[719.130316] Starting dynamic subtest: pipe-A-eDP-1
[719.486498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[719.498459] Starting dynamic subtest: pipe-B-eDP-1
[720.566752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.078s)
[720.580457] Starting dynamic subtest: pipe-C-eDP-1
[721.613128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.046s)
[721.626077] Starting dynamic subtest: pipe-D-eDP-1
[722.656217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.040s)
[722.658457] Subtest colorop-properties-atomic: SUCCESS (3.528s)
[723.553961] [148/156] (301s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[723.660088] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[723.664534] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[723.758388] [149/156] (301s left) gem_ringfill (basic-all)
[728.978603] Starting subtest: basic-all
[730.143020] Subtest basic-all: SUCCESS (1.163s)
[730.263612] [150/156] (294s left) gem_partial_pwrite_pread (reads-snoop)
[730.321802] Subtest reads-snoop: SKIP (0.000s)
[730.397079] [151/156] (294s left) gem_render_copy (linear-to-vebox-yf-tiled)
[730.454972] Starting subtest: linear-to-vebox-yf-tiled
[730.459640] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[730.641421] [152/156] (294s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[730.736913] Starting subtest: 4-tiled-64bpp-rotate-90
[730.761845] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.022s)
[730.889077] [153/156] (294s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[730.986957] Starting subtest: stress-xrgb8888-4tiled
[736.805261] Subtest stress-xrgb8888-4tiled: SUCCESS (5.816s)
[736.855993] [154/156] (288s left) gem_exec_reloc (basic-cpu-active)
[736.914848] Subtest basic-cpu-active: SKIP (0.000s)
[736.986788] [155/156] (288s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[737.084235] Starting subtest: plane-use-after-nonblocking-unbind
[737.086208] Starting dynamic subtest: pipe-A-eDP-1
[737.145370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[737.448321] Starting dynamic subtest: pipe-B-eDP-1
[738.254574] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.818s)
[738.559790] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.474s)
[739.425539] [156/156] (285s left) gem_ctx_bad_destroy (invalid-default-ctx)
[739.483703] Starting subtest: invalid-default-ctx
[739.486189] Subtest invalid-default-ctx: SUCCESS (0.000s)
[739.569335] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_selftest
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_render_copy_redux
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_caching
results: parsing output: 16/ for test: api_intel_bb
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_chamelium_edid
results: parsing output: 25/ for test: gem_flink_basic
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: gem_tiled_wc
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_legacy_colorkey
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: prime_busy
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_joiner
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_vrr
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_ctx_create
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_fenced_exec_thrash
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_fbcon_fbt
results: parsing output: 77/ for test: kms_chamelium_color
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_vrr
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_dp_link_training
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_sequence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: i915_suspend
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: core_setmaster
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: i915_hangman
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: i915_pm_rc6_residency
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sysfs_heartbeat_interval
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: kms_color
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_ccs
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_fence
results: parsing output: 134/ for test: kms_flip
results: parsing output: 135/ for test: gem_exec_suspend
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: gem_spin_batch
results: parsing output: 146/ for test: kms_properties
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_ringfill
results: parsing output: 149/ for test: gem_partial_pwrite_pread
results: parsing output: 150/ for test: gem_render_copy
results: parsing output: 151/ for test: kms_big_fb
results: parsing output: 152/ for test: kms_pipe_stress
results: parsing output: 153/ for test: gem_exec_reloc
results: parsing output: 154/ for test: kms_atomic_transition
results: parsing output: 155/ for test: gem_ctx_bad_destroy
Done.