[56.254213] Initializing watchdogs
[56.254260]   /dev/watchdog0
[56.267497] [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]
[56.271682] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.273891] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.277384] [001/130] (960s left) kms_vrr (flipline)
[56.431107] Starting subtest: flipline
[56.438115] Subtest flipline: SKIP (0.000s)
[56.497914] [002/130] (960s left) syncobj_timeline (wait-any-snapshot)
[56.552389] Starting subtest: wait-any-snapshot
[56.633143] Subtest wait-any-snapshot: SUCCESS (0.080s)
[56.699917] [003/130] (960s left) gem_exec_params (invalid-ring2)
[56.771702] Starting subtest: invalid-ring2
[56.774080] Subtest invalid-ring2: SUCCESS (0.000s)
[56.867296] [004/130] (960s left) kms_content_protection (atomic-dpms)
[57.043441] Starting subtest: atomic-dpms
[60.426678] Subtest atomic-dpms: SKIP (3.338s)
[61.601045] [005/130] (955s left) kms_psr (fbc-psr2-dpms)
[61.698832] Starting subtest: fbc-psr2-dpms
[61.700778] Starting dynamic subtest: eDP-1
[61.704901] Dynamic subtest eDP-1: SKIP (0.000s)
[61.709088] Subtest fbc-psr2-dpms: SKIP (0.000s)
[61.759699] [006/130] (955s left) kms_addfb_basic (addfb25-4-tiled)
[61.859806] Starting subtest: addfb25-4-tiled
[61.862131] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[61.965805] [007/130] (955s left) gem_exec_params (sol-reset-not-gen7)
[62.031376] Starting subtest: sol-reset-not-gen7
[62.033638] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[62.162303] [008/130] (954s left) i915_hangman (detector)
[62.222500] Starting subtest: detector
[62.224857] Starting dynamic subtest: rcs0
[73.865534] Dynamic subtest rcs0: SUCCESS (11.596s)
[73.875161] Starting dynamic subtest: bcs0
[84.873374] Dynamic subtest bcs0: SUCCESS (10.996s)
[84.882751] Starting dynamic subtest: vcs0
[95.817762] Dynamic subtest vcs0: SUCCESS (10.937s)
[95.827428] Starting dynamic subtest: vcs1
[106.824050] Dynamic subtest vcs1: SUCCESS (11.002s)
[106.833558] Starting dynamic subtest: vecs0
[117.832316] Dynamic subtest vecs0: SUCCESS (11.006s)
[117.842583] Starting dynamic subtest: ccs0
[128.904320] Dynamic subtest ccs0: SUCCESS (11.070s)
[128.907252] Subtest detector: SUCCESS (66.611s)
[129.023841] [009/130] (888s left) gem_exec_schedule (semaphore-codependency)
[129.101617] Starting subtest: semaphore-codependency
[129.116850] Subtest semaphore-codependency: SUCCESS (0.021s)
[129.470618] [010/130] (887s left) syncobj_timeline (signal)
[129.525185] Starting subtest: signal
[129.527617] Subtest signal: SUCCESS (0.000s)
[129.622870] [011/130] (887s left) gem_exec_reloc (basic-wc-gtt-active)
[129.682310] Subtest basic-wc-gtt-active: SKIP (0.000s)
[129.760048] [012/130] (887s left) gem_exec_reloc (basic-write-read)
[129.826780] Subtest basic-write-read: SKIP (0.000s)
[129.902970] [013/130] (887s left) kms_prop_blob (blob-prop-core)
[129.966226] Starting subtest: blob-prop-core
[129.968732] Subtest blob-prop-core: SUCCESS (0.000s)
[130.061730] [014/130] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[130.162520] Starting subtest: compare-crc-sanitycheck-nv12
[130.165055] Starting dynamic subtest: pipe-A-eDP-1
[130.820085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.655s)
[130.828501] Starting dynamic subtest: pipe-B-eDP-1
[132.008735] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.186s)
[132.018083] Starting dynamic subtest: pipe-C-eDP-1
[133.205551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[133.213491] Starting dynamic subtest: pipe-D-eDP-1
[134.433307] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[134.436080] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.271s)
[135.267289] [015/130] (882s left) kms_flip (basic-flip-vs-wf_vblank)
[135.362490] Starting subtest: basic-flip-vs-wf_vblank
[135.365139] Starting dynamic subtest: A-eDP1
[137.323984] Dynamic subtest A-eDP1: SUCCESS (1.961s)
[137.336287] Starting dynamic subtest: B-eDP1
[139.249121] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[139.257750] Starting dynamic subtest: C-eDP1
[141.170628] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[141.179580] Starting dynamic subtest: D-eDP1
[143.095523] Dynamic subtest D-eDP1: SUCCESS (1.925s)
[143.100660] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.738s)
[144.311696] [016/130] (873s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[144.436078] Starting subtest: cursor-vs-flip-legacy
[173.422611] Subtest cursor-vs-flip-legacy: SUCCESS (28.984s)
[174.235149] [017/130] (843s left) gem_close_race (multigpu-basic-threads)
[174.305638] Starting subtest: multigpu-basic-threads
[174.310310] Subtest multigpu-basic-threads: SKIP (0.000s)
[174.517625] [018/130] (842s left) gem_exec_create (forked)
[174.579272] Starting subtest: forked
[174.581582] Starting dynamic subtest: smem
[194.774648] Dynamic subtest smem: SUCCESS (20.194s)
[194.776956] Subtest forked: SUCCESS (20.194s)
[194.952295] [019/130] (822s left) gem_userptr_blits (sync-unmap-after-close)
[195.022754] Starting subtest: sync-unmap-after-close
[195.037460] Subtest sync-unmap-after-close: SUCCESS (0.015s)
[195.161268] [020/130] (822s left) gem_exec_fence (basic-busy-all)
[195.227507] Starting subtest: basic-busy-all
[195.297296] Subtest basic-busy-all: SUCCESS (0.070s)
[196.987609] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[196.990903] [021/130] (820s left) kms_cursor_legacy (forked-move)
[197.112633] Starting subtest: forked-move
[197.114692] Starting dynamic subtest: pipe-A
[202.652673] Dynamic subtest pipe-A: SUCCESS (5.482s)
[202.663990] Starting dynamic subtest: pipe-B
[208.159350] Dynamic subtest pipe-B: SUCCESS (5.510s)
[208.167092] Starting dynamic subtest: pipe-C
[213.654096] Dynamic subtest pipe-C: SUCCESS (5.494s)
[213.665556] Starting dynamic subtest: pipe-D
[219.155671] Dynamic subtest pipe-D: SUCCESS (5.501s)
[219.164121] Starting dynamic subtest: all-pipes
[224.688842] Dynamic subtest all-pipes: SUCCESS (5.532s)
[224.691225] Subtest forked-move: SUCCESS (27.521s)
[224.772909] [022/130] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[224.861238] Starting subtest: read-crc-frame-sequence
[224.863622] Starting dynamic subtest: pipe-A-eDP-1
[225.540626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.678s)
[225.548918] Starting dynamic subtest: pipe-B-eDP-1
[226.903608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[226.912876] Starting dynamic subtest: pipe-C-eDP-1
[228.172248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.264s)
[228.180713] Starting dynamic subtest: pipe-D-eDP-1
[229.489189] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[229.491559] Subtest read-crc-frame-sequence: SUCCESS (4.626s)
[230.341174] [023/130] (787s left) drm_fdinfo (virtual-idle)
[230.385275] Starting subtest: virtual-idle
[233.423993] Subtest virtual-idle: SUCCESS (3.037s)
[233.495738] [024/130] (784s left) kms_flip (2x-flip-vs-suspend-interruptible)
[233.601884] Starting subtest: 2x-flip-vs-suspend-interruptible
[233.613552] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[233.721573] [025/130] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[233.828301] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[238.365531] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.541s)
[238.505143] [026/130] (779s left) kms_chamelium_color (ctm-limited-range)
[238.601284] Subtest ctm-limited-range: SKIP (0.000s)
[238.637677] [027/130] (779s left) drm_fdinfo (busy)
[238.676990] Starting subtest: busy
[238.679295] Starting dynamic subtest: rcs0
[238.698878] Dynamic subtest rcs0: SKIP (0.021s)
[238.706734] Starting dynamic subtest: bcs0
[238.710864] Dynamic subtest bcs0: SKIP (0.000s)
[238.717860] Starting dynamic subtest: vcs0
[238.722239] Dynamic subtest vcs0: SKIP (0.000s)
[238.729093] Starting dynamic subtest: vcs1
[238.733276] Dynamic subtest vcs1: SKIP (0.000s)
[238.739685] Starting dynamic subtest: vecs0
[238.743857] Dynamic subtest vecs0: SKIP (0.000s)
[238.750377] Starting dynamic subtest: ccs0
[238.754503] Dynamic subtest ccs0: SKIP (0.000s)
[238.758639] Subtest busy: SKIP (0.023s)
[238.786600] [028/130] (778s left) tools_test (sysfs_l3_parity)
[238.837377] Starting subtest: sysfs_l3_parity
[238.903036] Subtest sysfs_l3_parity: SKIP (0.076s)
[238.950392] [029/130] (778s left) kms_selftest (drm_format)
[238.992162] Starting subtest: drm_format
[238.999085] Starting dynamic subtest: drm_test_format_block_width_invalid
[239.140357] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.141s)
[239.147922] Starting dynamic subtest: drm_test_format_block_width_one_plane
[239.270498] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.129s)
[239.278584] Starting dynamic subtest: drm_test_format_block_width_two_plane
[239.383552] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.113s)
[239.392014] Starting dynamic subtest: drm_test_format_block_width_three_plane
[239.506583] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.123s)
[239.514549] Starting dynamic subtest: drm_test_format_block_width_tiled
[239.627389] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.120s)
[239.635751] Starting dynamic subtest: drm_test_format_block_height_invalid
[239.752760] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.126s)
[239.761940] Starting dynamic subtest: drm_test_format_block_height_one_plane
[239.897279] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.143s)
[239.906196] Starting dynamic subtest: drm_test_format_block_height_two_plane
[240.017624] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.120s)
[240.024277] Starting dynamic subtest: drm_test_format_block_height_three_plane
[240.153072] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.135s)
[240.159889] Starting dynamic subtest: drm_test_format_block_height_tiled
[240.240819] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.088s)
[240.253069] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[240.345591] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.104s)
[240.354290] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[240.448595] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.102s)
[240.457429] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[240.549583] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.101s)
[240.558800] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[240.660519] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.110s)
[240.667388] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[240.782444] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.122s)
[240.789295] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[240.890418] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.108s)
[240.897287] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[241.007490] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.116s)
[241.014531] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[241.106359] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.100s)
[241.108704] Subtest drm_format: SUCCESS (2.116s)
[241.260983] [030/130] (776s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[241.310288] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[241.378032] [031/130] (776s left) perf (buffer-fill)
[241.477034] Starting subtest: buffer-fill
[241.479261] Starting dynamic subtest: 0-rcs0
[243.769576] Dynamic subtest 0-rcs0: SUCCESS (2.293s)
[243.777154] Starting dynamic subtest: 1-vcs1
[248.190924] Dynamic subtest 1-vcs1: SUCCESS (4.421s)
[248.193168] Subtest buffer-fill: SUCCESS (6.714s)
[248.233506] [032/130] (769s left) kms_busy (extended-pageflip-hang-oldfb)
[248.340065] Starting subtest: extended-pageflip-hang-oldfb
[248.342403] Starting dynamic subtest: pipe-A
[248.765718] Dynamic subtest pipe-A: SUCCESS (0.423s)
[248.774329] Starting dynamic subtest: pipe-D
[249.929769] Dynamic subtest pipe-D: SUCCESS (1.162s)
[249.932050] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.589s)
[250.745260] [033/130] (767s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[250.795816] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[250.902431] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[250.970067] [034/130] (767s left) gem_softpin (evict-single-offset)
[251.030078] Starting subtest: evict-single-offset
[277.866065] Subtest evict-single-offset: SUCCESS (26.832s)
[277.941540] [035/130] (740s left) syncobj_wait (wait-all-for-submit-snapshot)
[278.044960] Starting subtest: wait-all-for-submit-snapshot
[278.127073] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[278.197263] [036/130] (739s left) gem_eio (wait-1us)
[278.456844] Starting subtest: wait-1us
[278.865864] Subtest wait-1us: SUCCESS (0.409s)
[278.988226] [037/130] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[279.092493] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[283.500945] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.413s)
[283.622712] [038/130] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[283.730107] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[283.734391] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[283.828525] [039/130] (734s left) gem_mmap_wc (write-wc-read-gtt)
[283.894791] Subtest write-wc-read-gtt: SKIP (0.000s)
[283.957492] [040/130] (734s left) kms_psr (psr-dpms)
[284.062203] Starting subtest: psr-dpms
[284.064591] Starting dynamic subtest: eDP-1
[287.047590] Dynamic subtest eDP-1: SUCCESS (2.984s)
[287.049968] Subtest psr-dpms: SUCCESS (2.985s)
[287.891385] [041/130] (730s left) kms_psr (fbc-psr2-basic)
[287.990319] Starting subtest: fbc-psr2-basic
[287.992692] Starting dynamic subtest: eDP-1
[287.997216] Dynamic subtest eDP-1: SKIP (0.000s)
[288.001741] Subtest fbc-psr2-basic: SKIP (0.000s)
[288.056426] [042/130] (730s left) kms_frontbuffer_tracking (fbc-stridechange)
[288.173089] Starting subtest: fbc-stridechange
[290.420767] Subtest fbc-stridechange: SUCCESS (2.251s)
[290.573920] [043/130] (727s left) perf (mi-rpc)
[290.672336] Starting subtest: mi-rpc
[290.677084] Subtest mi-rpc: SKIP (0.000s)
[290.706846] [044/130] (727s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[290.800993] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[290.803171] Starting dynamic subtest: pipe-A
[290.819839] Dynamic subtest pipe-A: SKIP (0.015s)
[290.828819] Starting dynamic subtest: pipe-B
[290.847438] Dynamic subtest pipe-B: SKIP (0.029s)
[290.854639] Starting dynamic subtest: pipe-C
[290.875541] Dynamic subtest pipe-C: SKIP (0.027s)
[290.883414] Starting dynamic subtest: pipe-D
[290.902809] Dynamic subtest pipe-D: SKIP (0.027s)
[290.906766] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.098s)
[290.990155] [045/130] (727s left) kms_atomic_interruptible (universal-setplane-cursor)
[291.089556] Starting subtest: universal-setplane-cursor
[291.091610] Starting dynamic subtest: pipe-A-eDP-1
[298.446598] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.357s)
[298.449096] Subtest universal-setplane-cursor: SUCCESS (7.358s)
[299.280875] [046/130] (719s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[299.395542] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[303.937314] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.545s)
[304.057568] [047/130] (714s left) api_intel_bb (object-noreloc-keep-cache-simple)
[304.112264] Starting subtest: object-noreloc-keep-cache-simple
[304.117533] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[304.233944] [048/130] (714s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[304.322762] Starting subtest: plane-primary-toggle-with-vblank-wait
[304.324999] Starting dynamic subtest: pipe-A-eDP-1
[304.503501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.181s)
[304.799796] Starting dynamic subtest: pipe-B-eDP-1
[305.729939] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.936s)
[306.016031] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.694s)
[306.871379] [049/130] (711s left) perf_pmu (semaphore-busy)
[306.912881] Starting subtest: semaphore-busy
[306.915008] Starting dynamic subtest: rcs0
[308.562381] Dynamic subtest rcs0: SUCCESS (1.645s)
[308.571274] Starting dynamic subtest: bcs0
[310.191438] Dynamic subtest bcs0: SUCCESS (1.627s)
[310.200273] Starting dynamic subtest: vcs0
[314.520087] Dynamic subtest vcs0: SUCCESS (4.275s)
[314.531246] Starting dynamic subtest: vcs1
[320.421077] Dynamic subtest vcs1: SUCCESS (5.950s)
[320.430233] Starting dynamic subtest: vecs0
[326.435965] Dynamic subtest vecs0: SUCCESS (6.013s)
[326.444885] Starting dynamic subtest: ccs0
[329.509316] Dynamic subtest ccs0: SUCCESS (3.072s)
[329.511843] Subtest semaphore-busy: SUCCESS (22.592s)
[329.619313] [050/130] (688s left) i915_query (engine-info)
[329.677847] Starting subtest: engine-info
[329.680206] Subtest engine-info: SUCCESS (0.006s)
[329.819627] [051/130] (688s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[334.816482] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[334.821973] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[335.672778] [052/130] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[335.770060] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[335.774218] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[335.862395] [053/130] (682s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[335.984478] Starting subtest: cursorB-vs-flipA-toggle
[335.988805] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[336.082013] [054/130] (682s left) gem_lmem_swapping (parallel-random-verify)
[336.123552] Subtest parallel-random-verify: SKIP (0.000s)
[336.162288] [055/130] (682s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[336.256113] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[336.258514] Starting dynamic subtest: pipe-A
[336.329580] Dynamic subtest pipe-A: SUCCESS (0.073s)
[336.339404] Starting dynamic subtest: pipe-B
[337.495478] Dynamic subtest pipe-B: SUCCESS (1.166s)
[337.508958] Starting dynamic subtest: pipe-C
[338.600368] Dynamic subtest pipe-C: SUCCESS (1.104s)
[338.609293] Starting dynamic subtest: pipe-D
[339.746153] Dynamic subtest pipe-D: SUCCESS (1.145s)
[339.748509] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.490s)
[340.888912] [056/130] (677s left) kms_flip (wf_vblank-ts-check-interruptible)
[340.999627] Starting subtest: wf_vblank-ts-check-interruptible
[341.001991] Starting dynamic subtest: A-eDP1
[349.969879] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[349.981021] Starting dynamic subtest: B-eDP1
[358.892814] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[358.904815] Starting dynamic subtest: C-eDP1
[367.812557] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[367.820798] Starting dynamic subtest: D-eDP1
[376.740796] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[376.743408] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.698s)
[377.920835] [057/130] (640s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[378.028669] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[378.033180] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[378.149160] [058/130] (640s left) syncobj_timeline (etime-single-wait-all-submitted)
[378.213042] Starting subtest: etime-single-wait-all-submitted
[378.319869] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[378.388332] [059/130] (640s left) i915_module_load (reload)
[378.426481] Starting subtest: reload
[383.279255] Subtest reload: SUCCESS (4.854s)
[383.312974] [060/130] (635s left) kms_force_connector_basic (force-connector-state)
[384.934579] Starting subtest: force-connector-state
[385.520578] Subtest force-connector-state: SUCCESS (0.586s)
[386.440407] [061/130] (632s left) gem_softpin (32b-excludes-last-page)
[386.508989] Starting subtest: 32b-excludes-last-page
[386.511408] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[386.635698] [062/130] (632s left) kms_color (invalid-ctm-matrix-sizes)
[386.722021] Starting subtest: invalid-ctm-matrix-sizes
[386.724286] Starting dynamic subtest: pipe-A
[386.726458] Dynamic subtest pipe-A: SUCCESS (0.002s)
[386.734621] Starting dynamic subtest: pipe-B
[386.736763] Dynamic subtest pipe-B: SUCCESS (0.003s)
[386.743646] Starting dynamic subtest: pipe-C
[386.745545] Dynamic subtest pipe-C: SUCCESS (0.003s)
[386.752559] Starting dynamic subtest: pipe-D
[386.754816] Dynamic subtest pipe-D: SUCCESS (0.003s)
[386.757081] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[386.798998] [063/130] (632s left) gem_exec_fence (basic-wait)
[386.981564] Starting subtest: basic-wait
[386.984014] Starting dynamic subtest: rcs0
[387.076373] Dynamic subtest rcs0: SUCCESS (0.094s)
[387.085098] Starting dynamic subtest: bcs0
[387.143048] Dynamic subtest bcs0: SUCCESS (0.065s)
[387.152436] Starting dynamic subtest: vcs0
[387.211966] Dynamic subtest vcs0: SUCCESS (0.066s)
[387.221461] Starting dynamic subtest: vcs1
[387.279838] Dynamic subtest vcs1: SUCCESS (0.066s)
[387.289385] Starting dynamic subtest: vecs0
[387.348878] Dynamic subtest vecs0: SUCCESS (0.067s)
[387.357684] Starting dynamic subtest: ccs0
[387.420182] Dynamic subtest ccs0: SUCCESS (0.070s)
[387.422629] Subtest basic-wait: SUCCESS (0.440s)
[388.972956] [064/130] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[389.084083] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[389.088702] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[389.178884] [065/130] (629s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[389.282318] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[389.286335] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[389.371587] [066/130] (629s left) gem_mmap_offset (partial-unmap)
[389.439603] Starting subtest: partial-unmap
[389.441983] Starting dynamic subtest: smem0
[389.948028] Dynamic subtest smem0: SUCCESS (0.508s)
[389.950758] Subtest partial-unmap: SUCCESS (0.509s)
[390.079254] [067/130] (629s left) perf_pmu (busy-accuracy-50)
[390.118673] Starting subtest: busy-accuracy-50
[390.120742] Starting dynamic subtest: rcs0
[391.654725] Dynamic subtest rcs0: SUCCESS (1.535s)
[391.665056] Starting dynamic subtest: bcs0
[393.202981] Dynamic subtest bcs0: SUCCESS (1.546s)
[393.210408] Starting dynamic subtest: vcs0
[394.746788] Dynamic subtest vcs0: SUCCESS (1.541s)
[394.754850] Starting dynamic subtest: vcs1
[396.290281] Dynamic subtest vcs1: SUCCESS (1.542s)
[396.297771] Starting dynamic subtest: vecs0
[397.832846] Dynamic subtest vecs0: SUCCESS (1.541s)
[397.842305] Starting dynamic subtest: ccs0
[399.377497] Dynamic subtest ccs0: SUCCESS (1.544s)
[399.379931] Subtest busy-accuracy-50: SUCCESS (9.258s)
[399.483329] [068/130] (619s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[404.528756] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[404.531099] Starting dynamic subtest: pipe-A-eDP-1
[416.201419] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.670s)
[416.209184] Starting dynamic subtest: pipe-B-eDP-1
[427.898942] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.694s)
[427.901393] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.367s)
[428.729878] [069/130] (590s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[428.861088] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[428.904120] [070/130] (590s left) kms_addfb_basic (tile-pitch-mismatch)
[428.965784] Starting subtest: tile-pitch-mismatch
[428.970415] Subtest tile-pitch-mismatch: SKIP (0.000s)
[429.103272] [071/130] (590s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[429.198282] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[429.200604] Starting dynamic subtest: pipe-A-default-mode
[429.487993] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[429.492704] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.284s)
[430.326129] [072/130] (588s left) gem_exec_reloc (basic-write-wc-active)
[430.382714] Subtest basic-write-wc-active: SKIP (0.000s)
[430.437039] [073/130] (588s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[430.547085] Starting subtest: y-tiled-8bpp-rotate-90
[430.551680] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[430.638603] [074/130] (588s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[430.751764] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[430.755955] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[430.845375] [075/130] (588s left) gem_ctx_exec (basic-nohangcheck)
[430.916902] Starting subtest: basic-nohangcheck
[431.159048] Subtest basic-nohangcheck: SUCCESS (0.245s)
[431.289863] [076/130] (588s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[431.536533] Starting subtest: cursor-rapid-movement-512x170
[431.540967] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[431.693939] [077/130] (587s left) kms_chamelium_hpd (common-hpd-after-suspend)
[432.084585] Subtest common-hpd-after-suspend: SKIP (0.000s)
[432.908231] [078/130] (586s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[433.016604] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[435.598280] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.586s)
[435.716550] [079/130] (583s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[435.821430] Starting subtest: dsc-fractional-bpp-with-bpc
[435.846540] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[435.890379] [080/130] (583s left) kms_pm_rpm (dpms-non-lpsp)
[438.127813] Starting subtest: dpms-non-lpsp
[438.133590] Subtest dpms-non-lpsp: SKIP (0.001s)
[438.489729] [081/130] (581s left) kms_rotation_crc (primary-rotation-90)
[438.583358] Starting subtest: primary-rotation-90
[438.588193] Subtest primary-rotation-90: SKIP (0.001s)
[438.650156] [082/130] (580s left) gem_exec_async (forked-writes)
[438.716389] Starting subtest: forked-writes
[438.718837] Starting dynamic subtest: rcs0
[438.749309] Dynamic subtest rcs0: SUCCESS (0.033s)
[438.757787] Starting dynamic subtest: bcs0
[438.775212] Dynamic subtest bcs0: SUCCESS (0.025s)
[438.784450] Starting dynamic subtest: vcs0
[438.800533] Dynamic subtest vcs0: SUCCESS (0.025s)
[438.808519] Starting dynamic subtest: vcs1
[438.828955] Dynamic subtest vcs1: SUCCESS (0.028s)
[438.837346] Starting dynamic subtest: vecs0
[438.855389] Dynamic subtest vecs0: SUCCESS (0.026s)
[438.864712] Starting dynamic subtest: ccs0
[438.885905] Dynamic subtest ccs0: SUCCESS (0.029s)
[438.888121] Subtest forked-writes: SUCCESS (0.170s)
[439.124405] [083/130] (580s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[439.222921] Starting subtest: psr-rgb565-draw-blt
[444.188503] Subtest psr-rgb565-draw-blt: SUCCESS (4.966s)
[444.328047] [084/130] (575s left) kms_big_fb (linear-8bpp-rotate-90)
[444.434933] Starting subtest: linear-8bpp-rotate-90
[444.455120] Subtest linear-8bpp-rotate-90: SKIP (0.019s)
[444.573571] [085/130] (575s left) gem_mmap_gtt (medium-copy-xy)
[444.633627] Subtest medium-copy-XY: SKIP (0.000s)
[444.683480] [086/130] (575s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[444.799661] Starting subtest: flip-vs-cursor-toggle
[452.465757] Subtest flip-vs-cursor-toggle: SUCCESS (7.661s)
[453.328472] [087/130] (566s left) syncobj_eventfd (timeline-wait-before-signal)
[453.391786] Starting subtest: timeline-wait-before-signal
[453.421599] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[453.492403] [088/130] (566s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[453.592951] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[453.595205] Starting dynamic subtest: pipe-A-default-mode
[453.879561] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[453.884353] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.284s)
[454.727499] [089/130] (565s left) gem_exec_balancer (parallel-ordering)
[454.977627] Starting subtest: parallel-ordering
[455.755419] Subtest parallel-ordering: SUCCESS (0.778s)
[455.890942] [090/130] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[455.992440] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[455.996842] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[456.094370] [091/130] (563s left) syncobj_wait (invalid-reset-bad-pad)
[456.145594] Starting subtest: invalid-reset-bad-pad
[456.147944] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[456.232102] [092/130] (563s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[456.341890] Starting subtest: 4-tiled-16bpp-rotate-0
[457.575058] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.233s)
[457.766278] [093/130] (562s left) gem_mmap_gtt (basic-wc)
[457.824334] Subtest basic-wc: SKIP (0.000s)
[457.882814] [094/130] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[457.991920] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[457.995908] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.094617] [095/130] (561s left) kms_atomic (crtc-invalid-params-fence)
[458.191091] Starting subtest: crtc-invalid-params-fence
[458.193327] Starting dynamic subtest: pipe-A-eDP-1
[458.588770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[458.590707] Subtest crtc-invalid-params-fence: SUCCESS (0.396s)
[459.428376] [096/130] (560s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[459.546895] Starting subtest: cursorB-vs-flipB-varying-size
[459.551290] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[459.641413] [097/130] (560s left) gem_exec_schedule (in-order)
[459.711934] Starting subtest: in-order
[459.714206] Starting dynamic subtest: rcs0
[459.805123] Dynamic subtest rcs0: SUCCESS (0.101s)
[459.816743] Starting dynamic subtest: vcs0
[459.879257] Dynamic subtest vcs0: SUCCESS (0.073s)
[459.891121] Starting dynamic subtest: vcs1
[459.950062] Dynamic subtest vcs1: SUCCESS (0.071s)
[459.962939] Starting dynamic subtest: vecs0
[460.024773] Dynamic subtest vecs0: SUCCESS (0.074s)
[460.032943] Starting dynamic subtest: ccs0
[460.107632] Dynamic subtest ccs0: SUCCESS (0.082s)
[460.110088] Subtest in-order: SUCCESS (0.404s)
[461.018000] [098/130] (559s left) gem_exec_fence (syncobj-timeline-signal)
[461.554662] Starting subtest: syncobj-timeline-signal
[461.560112] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[463.048236] [099/130] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[463.150577] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[467.591225] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.443s)
[467.723596] [100/130] (552s left) kms_cursor_crc (cursor-onscreen-128x128)
[467.915750] Starting subtest: cursor-onscreen-128x128
[467.918147] Starting dynamic subtest: pipe-A-eDP-1
[470.159820] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.241s)
[470.182628] Starting dynamic subtest: pipe-D-eDP-1
[473.131036] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.955s)
[473.133058] Subtest cursor-onscreen-128x128: SUCCESS (5.216s)
[473.925085] [101/130] (546s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[474.034897] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[474.047640] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[474.151465] [102/130] (546s left) gem_ctx_persistence (legacy-engines-mixed)
[474.213350] Starting subtest: legacy-engines-mixed
[474.215828] Starting dynamic subtest: render
[474.296301] Dynamic subtest render: SUCCESS (0.081s)
[474.307661] Starting dynamic subtest: bsd1
[474.348549] Dynamic subtest bsd1: SUCCESS (0.051s)
[474.359517] Starting dynamic subtest: bsd2
[474.400698] Dynamic subtest bsd2: SUCCESS (0.050s)
[474.410834] Starting dynamic subtest: blt
[474.459889] Dynamic subtest blt: SUCCESS (0.057s)
[474.469825] Starting dynamic subtest: vebox
[474.520609] Dynamic subtest vebox: SUCCESS (0.058s)
[474.523070] Subtest legacy-engines-mixed: SUCCESS (0.308s)
[474.593820] [103/130] (545s left) kms_invalid_mode (zero-clock)
[474.686193] Starting subtest: zero-clock
[474.688511] Starting dynamic subtest: pipe-A-eDP-1
[474.967342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[474.976964] Starting dynamic subtest: pipe-B-eDP-1
[474.979565] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[474.987179] Starting dynamic subtest: pipe-C-eDP-1
[474.989494] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[474.997259] Starting dynamic subtest: pipe-D-eDP-1
[474.999187] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[475.001109] Subtest zero-clock: SUCCESS (0.289s)
[475.825551] [104/130] (544s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[475.885736] Starting subtest: invalid-single-wait-all-unsubmitted
[475.888255] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[475.976845] [105/130] (544s left) syncobj_timeline (invalid-wait-illegal-handle)
[476.032582] Starting subtest: invalid-wait-illegal-handle
[476.034895] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[476.139094] [106/130] (544s left) kms_flip (dpms-off-confusion)
[476.240252] Starting subtest: dpms-off-confusion
[476.242624] Starting dynamic subtest: A-eDP1
[484.940960] Dynamic subtest A-eDP1: SUCCESS (8.664s)
[484.951939] Starting dynamic subtest: B-eDP1
[493.638336] Dynamic subtest B-eDP1: SUCCESS (8.696s)
[493.647272] Starting dynamic subtest: C-eDP1
[502.338345] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[502.349582] Starting dynamic subtest: D-eDP1
[511.037062] Dynamic subtest D-eDP1: SUCCESS (8.697s)
[511.039421] Subtest dpms-off-confusion: SUCCESS (34.752s)
[512.223882] [107/130] (508s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[512.346986] Starting subtest: flip-vs-cursor-crc-legacy
[512.955376] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.607s)
[513.822287] [108/130] (506s left) kms_getfb (getfb-handle-protection)
[513.882689] Starting subtest: getfb-handle-protection
[513.898482] Subtest getfb-handle-protection: SUCCESS (0.017s)
[514.026040] [109/130] (506s left) gem_eio (throttle)
[514.245667] Starting subtest: throttle
[514.569258] Subtest throttle: SUCCESS (0.325s)
[514.716648] [110/130] (505s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[514.781727] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[514.831435] [111/130] (505s left) gem_exec_schedule (submit-early-slice)
[514.904151] Starting subtest: submit-early-slice
[514.905760] Starting dynamic subtest: rcs0
[514.941701] Dynamic subtest rcs0: SUCCESS (0.042s)
[514.951258] Starting dynamic subtest: bcs0
[514.981151] Dynamic subtest bcs0: SUCCESS (0.039s)
[514.989878] Starting dynamic subtest: vcs0
[515.024399] Dynamic subtest vcs0: SUCCESS (0.043s)
[515.037617] Starting dynamic subtest: vcs1
[515.064056] Dynamic subtest vcs1: SUCCESS (0.039s)
[515.074960] Starting dynamic subtest: vecs0
[515.104954] Dynamic subtest vecs0: SUCCESS (0.040s)
[515.114641] Starting dynamic subtest: ccs0
[515.145654] Dynamic subtest ccs0: SUCCESS (0.040s)
[515.147718] Subtest submit-early-slice: SUCCESS (0.246s)
[517.010381] [112/130] (503s left) kms_psr (pr-cursor-plane-move)
[517.098204] Starting subtest: pr-cursor-plane-move
[517.102621] Subtest pr-cursor-plane-move: SKIP (0.000s)
[517.165355] [113/130] (503s left) core_getclient
[517.326796] [114/130] (503s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[517.391718] Starting subtest: mixed-tiled-to-y-tiled-ccs
[517.396490] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[517.567602] [115/130] (503s left) gem_exec_whisper (basic-contexts-forked-all)
[517.629211] Starting subtest: basic-contexts-forked-all
[539.838806] Subtest basic-contexts-forked-all: SUCCESS (22.155s)
[539.964513] [116/130] (480s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[540.077253] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[540.890134] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s)
[541.122169] [117/130] (479s left) api_intel_allocator (fork-simple-stress-signal)
[541.180083] Starting subtest: fork-simple-stress-signal
[546.640544] Subtest fork-simple-stress-signal: SUCCESS (5.410s)
[546.727267] [118/130] (474s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[546.833371] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[546.835758] Starting dynamic subtest: pipe-A-eDP-1
[547.072605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.207s)
[547.083131] Starting dynamic subtest: pipe-B-eDP-1
[548.360643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.284s)
[548.372047] Starting dynamic subtest: pipe-C-eDP-1
[549.533890] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.174s)
[549.545119] Starting dynamic subtest: pipe-D-eDP-1
[550.733807] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[550.735904] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.868s)
[551.914991] [119/130] (468s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[552.009294] Starting subtest: plane-downscale-factor-0-5-with-rotation
[552.011654] Starting dynamic subtest: pipe-A
[552.020936] Dynamic subtest pipe-A: SKIP (0.004s)
[552.030458] Starting dynamic subtest: pipe-B
[552.039897] Dynamic subtest pipe-B: SKIP (0.017s)
[552.048132] Starting dynamic subtest: pipe-C
[552.057414] Dynamic subtest pipe-C: SKIP (0.016s)
[552.065998] Starting dynamic subtest: pipe-D
[552.074277] Dynamic subtest pipe-D: SKIP (0.017s)
[552.078912] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.055s)
[552.161476] [120/130] (468s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[552.259869] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[552.262182] Starting dynamic subtest: pipe-A-eDP-1
[552.286119] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.294729] Starting dynamic subtest: pipe-B-eDP-1
[552.317681] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.326417] Starting dynamic subtest: pipe-C-eDP-1
[552.351027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.361321] Starting dynamic subtest: pipe-D-eDP-1
[552.387107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.391496] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[554.515653] [121/130] (466s left) gem_vm_create (create-ext)
[554.567873] Starting subtest: create-ext
[554.572986] Subtest create-ext: SUCCESS (0.004s)
[554.713285] [122/130] (466s left) gem_ctx_param (invalid-get-ringsize)
[554.772743] Starting subtest: invalid-get-ringsize
[554.775274] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[554.880922] [123/130] (466s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[554.969060] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[554.971369] Starting dynamic subtest: pipe-A-eDP-1
[554.994396] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.004356] Starting dynamic subtest: pipe-B-eDP-1
[555.026475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.034907] Starting dynamic subtest: pipe-C-eDP-1
[555.056594] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.064589] Starting dynamic subtest: pipe-D-eDP-1
[555.086314] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[555.090661] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[557.221028] [124/130] (463s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[557.322161] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[561.628772] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.308s)
[561.745572] [125/130] (459s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[561.848272] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[561.852548] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[561.969864] [126/130] (459s left) kms_psr (psr2-sprite-mmap-gtt)
[562.062637] Starting subtest: psr2-sprite-mmap-gtt
[562.065053] Starting dynamic subtest: eDP-1
[563.491221] Dynamic subtest eDP-1: SKIP (1.423s)
[563.496250] Subtest psr2-sprite-mmap-gtt: SKIP (1.425s)
[563.669769] [127/130] (457s left) syncobj_wait (single-wait-signaled)
[563.727608] Starting subtest: single-wait-signaled
[563.730031] Subtest single-wait-signaled: SUCCESS (0.000s)
[563.844542] [128/130] (457s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[563.957767] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[565.146298] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.190s)
[565.384298] [129/130] (455s left) gem_mmap_gtt (basic-read)
[565.448138] Subtest basic-read: SKIP (0.000s)
[565.507376] [130/130] (455s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[565.608133] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[565.610460] Starting dynamic subtest: pipe-A-eDP-1
[567.755569] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.147s)
[567.764167] Starting dynamic subtest: pipe-B-eDP-1
[569.822237] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.063s)
[569.830933] Starting dynamic subtest: pipe-C-eDP-1
[571.812081] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.990s)
[571.820958] Starting dynamic subtest: pipe-D-eDP-1
[573.807943] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.995s)
[573.810250] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.200s)
[575.017230] Closing watchdogs
results: parsing output: 0/ for test: kms_vrr
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: i915_hangman
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: kms_prop_blob
results: parsing output: 13/ for test: kms_pipe_crc_basic
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_close_race
results: parsing output: 17/ for test: gem_exec_create
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_pipe_crc_basic
results: parsing output: 22/ for test: drm_fdinfo
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_chamelium_color
results: parsing output: 26/ for test: drm_fdinfo
results: parsing output: 27/ for test: tools_test
results: parsing output: 28/ for test: kms_selftest
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_busy
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_softpin
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap_wc
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_atomic_interruptible
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: api_intel_bb
results: parsing output: 47/ for test: kms_atomic_transition
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: i915_query
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_plane_scaling
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: i915_module_load
results: parsing output: 59/ for test: kms_force_connector_basic
results: parsing output: 60/ for test: gem_softpin
results: parsing output: 61/ for test: kms_color
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_tiled_display
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_ctx_exec
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_dsc
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: gem_exec_async
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: syncobj_eventfd
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_invalid_mode
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_getfb
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_pipe_b_c_ivb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: core_getclient
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_vm_create
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_ccs
Done.