[57.884084] Initializing watchdogs
[57.884234]   /dev/watchdog0
[57.900674] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.904982] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.907555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.910825] [001/133] (960s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[59.049245] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[59.354564] [002/133] (959s left) gem_exec_params (sol-reset-invalid)
[59.414859] Starting subtest: sol-reset-invalid
[59.419679] Subtest sol-reset-invalid: SUCCESS (0.003s)
[60.987711] [003/133] (957s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[61.091171] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[62.226346] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.134s)
[62.371314] [004/133] (956s left) kms_flip (2x-plain-flip)
[62.463479] Starting subtest: 2x-plain-flip
[62.474904] Subtest 2x-plain-flip: SKIP (0.011s)
[62.564901] [005/133] (955s left) api_intel_allocator (reloc-allocator)
[62.626377] Starting subtest: reloc-allocator
[62.628122] Starting dynamic subtest: basic
[62.631782] Dynamic subtest basic: SUCCESS (0.006s)
[62.638353] Starting dynamic subtest: parallel-one
[62.639920] Dynamic subtest parallel-one: SUCCESS (0.008s)
[62.646791] Starting dynamic subtest: print
[62.648655] Dynamic subtest print: SUCCESS (0.000s)
[62.656235] Starting dynamic subtest: reuse
[62.657874] Dynamic subtest reuse: SUCCESS (0.000s)
[62.665868] Starting dynamic subtest: fork-reopen-allocator
[62.667495] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[62.669262] Subtest reloc-allocator: SUCCESS (0.026s)
[62.769856] [006/133] (955s left) i915_drm_fdinfo (busy-idle-check-all)
[62.807585] Starting subtest: busy-idle-check-all
[62.809513] Starting dynamic subtest: rcs0
[62.813087] Dynamic subtest rcs0: SKIP (0.004s)
[62.819809] Starting dynamic subtest: bcs0
[62.823203] Dynamic subtest bcs0: SKIP (0.000s)
[62.830224] Starting dynamic subtest: vcs0
[62.834101] Dynamic subtest vcs0: SKIP (0.000s)
[62.840519] Starting dynamic subtest: vcs1
[62.843585] Dynamic subtest vcs1: SKIP (0.000s)
[62.849714] Starting dynamic subtest: vecs0
[62.853053] Dynamic subtest vecs0: SKIP (0.000s)
[62.859312] Starting dynamic subtest: ccs0
[62.862736] Dynamic subtest ccs0: SKIP (0.000s)
[62.866090] Subtest busy-idle-check-all: SKIP (0.006s)
[62.901679] [007/133] (955s left) gem_set_tiling_vs_gtt
[63.063420] [008/133] (955s left) sysfs_preempt_timeout (invalid)
[63.126379] Starting subtest: invalid
[63.128499] Starting dynamic subtest: vecs0
[63.130428] Dynamic subtest vecs0: SUCCESS (0.000s)
[63.139451] Starting dynamic subtest: ccs0
[63.141203] Dynamic subtest ccs0: SUCCESS (0.000s)
[63.147876] Starting dynamic subtest: vcs0
[63.149453] Dynamic subtest vcs0: SUCCESS (0.000s)
[63.155693] Starting dynamic subtest: bcs0
[63.157281] Dynamic subtest bcs0: SUCCESS (0.000s)
[63.163457] Starting dynamic subtest: rcs0
[63.165058] Dynamic subtest rcs0: SUCCESS (0.000s)
[63.171353] Starting dynamic subtest: vcs1
[63.172909] Dynamic subtest vcs1: SUCCESS (0.000s)
[63.174492] Subtest invalid: SUCCESS (0.003s)
[63.254775] [009/133] (955s left) i915_query (hwconfig_table)
[63.314290] Starting subtest: hwconfig_table
[63.560725] Subtest hwconfig_table: SUCCESS (0.001s)
[63.594094] [010/133] (955s left) kms_flip (2x-blocking-absolute-wf_vblank)
[63.691515] Starting subtest: 2x-blocking-absolute-wf_vblank
[63.702684] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[63.814296] [011/133] (954s left) gem_ctx_param (invalid-param-set)
[63.875668] Starting subtest: invalid-param-set
[63.877968] Subtest invalid-param-set: SUCCESS (0.000s)
[63.971923] [012/133] (954s left) gem_mmap_gtt (medium-copy-odd)
[64.039852] Subtest medium-copy-odd: SKIP (0.000s)
[64.099232] [013/133] (954s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[64.203035] Starting subtest: 4-tiled-8bpp-rotate-0
[65.396407] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[65.551340] [014/133] (953s left) sw_sync (sync_random_merge)
[65.586965] Starting subtest: sync_random_merge
[65.627228] Subtest sync_random_merge: SUCCESS (0.041s)
[65.694606] [015/133] (953s left) gem_ctx_create (basic)
[65.764156] Starting subtest: basic
[65.766059] Subtest basic: SUCCESS (0.000s)
[65.954477] [016/133] (952s left) kms_chamelium_frames (dp-crc-multiple)
[66.347137] Subtest dp-crc-multiple: SKIP (0.000s)
[67.227655] [017/133] (951s left) syncobj_wait (single-wait-for-submit-signaled)
[67.350235] Starting subtest: single-wait-for-submit-signaled
[67.352844] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[67.622176] [018/133] (951s left) kms_cursor_crc (cursor-random-max-size)
[68.011950] Starting subtest: cursor-random-max-size
[68.019088] Subtest cursor-random-max-size: SKIP (0.000s)
[68.260874] [019/133] (950s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[68.359523] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[75.041057] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.681s)
[75.212079] [020/133] (943s left) gem_lmem_swapping (random)
[75.258651] Subtest random: SKIP (0.000s)
[75.295452] [021/133] (943s left) kms_plane_cursor (primary)
[75.397270] Starting subtest: primary
[75.401342] Starting dynamic subtest: pipe-A-eDP-1-size-64
[77.949817] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[77.971158] Starting dynamic subtest: pipe-A-eDP-1-size-128
[80.505124] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[80.529496] Starting dynamic subtest: pipe-A-eDP-1-size-256
[83.096393] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[83.414985] Starting dynamic subtest: pipe-B-eDP-1-size-64
[86.641885] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.235s)
[86.666962] Starting dynamic subtest: pipe-B-eDP-1-size-128
[89.222538] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.563s)
[89.243849] Starting dynamic subtest: pipe-B-eDP-1-size-256
[91.812531] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[92.129953] Starting dynamic subtest: pipe-C-eDP-1-size-64
[94.974167] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.855s)
[94.999425] Starting dynamic subtest: pipe-C-eDP-1-size-128
[97.174275] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[97.199675] Starting dynamic subtest: pipe-C-eDP-1-size-256
[99.374270] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[99.698325] Starting dynamic subtest: pipe-D-eDP-1-size-64
[102.571822] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.883s)
[102.596926] Starting dynamic subtest: pipe-D-eDP-1-size-128
[104.816083] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.225s)
[104.844881] Starting dynamic subtest: pipe-D-eDP-1-size-256
[107.016078] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[107.322934] Subtest primary: SUCCESS (31.923s)
[108.126899] [022/133] (911s left) perf_pmu (most-busy-idle-check-all)
[108.168462] Starting subtest: most-busy-idle-check-all
[108.170820] Starting dynamic subtest: rcs0
[109.910471] Dynamic subtest rcs0: SUCCESS (1.740s)
[109.922590] Starting dynamic subtest: bcs0
[111.894575] Dynamic subtest bcs0: SUCCESS (1.981s)
[111.906364] Starting dynamic subtest: vcs0
[113.878228] Dynamic subtest vcs0: SUCCESS (1.980s)
[113.889766] Starting dynamic subtest: vcs1
[115.861901] Dynamic subtest vcs1: SUCCESS (1.981s)
[115.873298] Starting dynamic subtest: vecs0
[117.910924] Dynamic subtest vecs0: SUCCESS (2.046s)
[117.921630] Starting dynamic subtest: ccs0
[119.894578] Dynamic subtest ccs0: SUCCESS (1.980s)
[119.897801] Subtest most-busy-idle-check-all: SUCCESS (11.726s)
[120.018910] [023/133] (899s left) gem_ctx_persistence (legacy-engines-cleanup)
[120.093081] Starting subtest: legacy-engines-cleanup
[120.095437] Starting dynamic subtest: render
[120.210994] Dynamic subtest render: SUCCESS (0.117s)
[120.221710] Starting dynamic subtest: bsd1
[120.284373] Dynamic subtest bsd1: SUCCESS (0.070s)
[120.294729] Starting dynamic subtest: bsd2
[120.361968] Dynamic subtest bsd2: SUCCESS (0.075s)
[120.371869] Starting dynamic subtest: blt
[120.388498] Dynamic subtest blt: SUCCESS (0.024s)
[120.397283] Starting dynamic subtest: vebox
[120.476371] Dynamic subtest vebox: SUCCESS (0.086s)
[120.479065] Subtest legacy-engines-cleanup: SUCCESS (0.384s)
[120.566442] [024/133] (898s left) gem_partial_pwrite_pread (writes-after-reads-display)
[120.619617] Subtest writes-after-reads-display: SKIP (0.000s)
[120.722682] [025/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[120.829232] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[120.833497] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[120.954105] [026/133] (898s left) gem_close_race (multigpu-basic-threads)
[121.041187] Starting subtest: multigpu-basic-threads
[121.044678] Subtest multigpu-basic-threads: SKIP (0.000s)
[121.313964] [027/133] (898s left) gem_userptr_blits (unsync-unmap-after-close)
[121.389719] Subtest unsync-unmap-after-close: SKIP (0.000s)
[121.523500] [028/133] (897s left) kms_psr (psr-no-drrs)
[121.617104] Starting subtest: psr-no-drrs
[121.619361] Starting dynamic subtest: eDP-1
[123.195915] Dynamic subtest eDP-1: SUCCESS (1.577s)
[123.198361] Subtest psr-no-drrs: SUCCESS (1.579s)
[124.080752] [029/133] (895s left) kms_big_fb (linear-32bpp-rotate-0)
[124.214158] Starting subtest: linear-32bpp-rotate-0
[125.771062] Subtest linear-32bpp-rotate-0: SUCCESS (1.556s)
[125.937884] [030/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[126.040731] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[126.044272] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[126.160653] [031/133] (893s left) syncobj_timeline (host-signal-points)
[126.219162] Starting subtest: host-signal-points
[126.221155] Subtest host-signal-points: SUCCESS (0.004s)
[126.347049] [032/133] (893s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[126.459799] Starting subtest: fbcpsr-indfb-scaledprimary
[132.288348] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.831s)
[132.467801] [033/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[132.568575] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[139.336385] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.770s)
[139.492792] [034/133] (880s left) kms_vblank (wait-busy)
[139.606121] Starting subtest: wait-busy
[139.608311] Starting dynamic subtest: pipe-A-eDP-1
[141.491344] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[141.506029] Starting dynamic subtest: pipe-D-eDP-1
[144.106215] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[144.108492] Subtest wait-busy: SUCCESS (4.502s)
[144.931724] [035/133] (874s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[145.034871] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[145.037899] Starting dynamic subtest: pipe-A-eDP-1
[145.059873] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.068228] Starting dynamic subtest: pipe-B-eDP-1
[145.088144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.095233] Starting dynamic subtest: pipe-C-eDP-1
[145.115657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.122867] Starting dynamic subtest: pipe-D-eDP-1
[145.143726] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.147897] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[147.191166] [036/133] (872s left) kms_vrr (flip-suspend)
[147.285855] Starting subtest: flip-suspend
[147.291954] Subtest flip-suspend: SKIP (0.000s)
[147.367823] [037/133] (872s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[147.472566] Starting subtest: fbcpsr-slowdraw
[172.731628] Subtest fbcpsr-slowdraw: SUCCESS (25.257s)
[172.919369] [038/133] (846s left) gem_exec_flush (basic-wb-ro-default)
[172.972262] Starting subtest: basic-wb-ro-default
[178.435340] Subtest basic-wb-ro-default: SUCCESS (5.463s)
[178.632470] [039/133] (841s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[178.747985] Starting subtest: fbc-psr2-cursor-plane-update-sf
[178.750276] Starting dynamic subtest: pipe-A-eDP-1
[178.821358] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[178.831164] Starting dynamic subtest: pipe-B-eDP-1
[179.986156] Dynamic subtest pipe-B-eDP-1: SKIP (1.163s)
[179.990514] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.243s)
[181.170041] [040/133] (838s left) gem_exec_params (rel-constants-invalid-ring)
[181.237884] Starting subtest: rel-constants-invalid-ring
[181.240074] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[181.347201] [041/133] (838s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[181.416582] Starting subtest: single-wait-all-for-submit-available-submitted
[181.418969] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[181.533334] [042/133] (838s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[181.637572] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[185.846241] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.212s)
[187.074658] [043/133] (833s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[187.201382] Starting subtest: 2x-long-cursor-vs-flip-legacy
[187.206098] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[187.367397] [044/133] (832s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[187.473098] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[187.477376] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[187.592995] [045/133] (832s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[187.698903] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[187.703046] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[187.835695] [046/133] (832s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[187.895234] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[188.002412] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[188.087694] [047/133] (832s left) i915_hangman (gt-error-state-capture)
[188.157832] Starting subtest: gt-error-state-capture
[188.160254] Starting dynamic subtest: rcs0
[199.860574] Dynamic subtest rcs0: SUCCESS (11.700s)
[199.872094] Starting dynamic subtest: bcs0
[211.891078] Dynamic subtest bcs0: SUCCESS (12.027s)
[211.902475] Starting dynamic subtest: vcs0
[223.796059] Dynamic subtest vcs0: SUCCESS (11.902s)
[223.808455] Starting dynamic subtest: vcs1
[234.804651] Dynamic subtest vcs1: SUCCESS (11.005s)
[234.816085] Starting dynamic subtest: vecs0
[245.812322] Dynamic subtest vecs0: SUCCESS (11.004s)
[245.823097] Starting dynamic subtest: ccs0
[256.885039] Dynamic subtest ccs0: SUCCESS (11.069s)
[256.887879] Subtest gt-error-state-capture: SUCCESS (68.723s)
[256.983431] [048/133] (763s left) gem_exec_async (concurrent-writes)
[257.061079] Starting subtest: concurrent-writes
[257.063448] Starting dynamic subtest: rcs0
[257.087621] Dynamic subtest rcs0: SUCCESS (0.027s)
[257.099386] Starting dynamic subtest: bcs0
[257.101464] Dynamic subtest bcs0: SUCCESS (0.010s)
[257.110611] Starting dynamic subtest: vcs0
[257.113038] Dynamic subtest vcs0: SUCCESS (0.007s)
[257.122046] Starting dynamic subtest: vcs1
[257.123920] Dynamic subtest vcs1: SUCCESS (0.009s)
[257.132189] Starting dynamic subtest: vecs0
[257.134265] Dynamic subtest vecs0: SUCCESS (0.008s)
[257.142163] Starting dynamic subtest: ccs0
[257.143941] Dynamic subtest ccs0: SUCCESS (0.009s)
[257.145770] Subtest concurrent-writes: SUCCESS (0.074s)
[257.404477] [049/133] (762s left) gem_eio (in-flight-suspend)
[257.603393] Starting subtest: in-flight-suspend
[300.693865] Subtest in-flight-suspend: SUCCESS (13.593s)
[300.854694] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[300.858216] [050/133] (719s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[300.975511] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[300.977752] Starting dynamic subtest: pipe-A-default-mode
[303.674516] Dynamic subtest pipe-A-default-mode: SUCCESS (2.677s)
[303.676526] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.678s)
[304.541164] [051/133] (715s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[304.666320] Starting subtest: crc-primary-suspend-y-tiled-ccs
[304.668632] Starting dynamic subtest: pipe-A-eDP-1
[304.677954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[304.688608] Starting dynamic subtest: pipe-B-eDP-1
[304.698031] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[304.707650] Starting dynamic subtest: pipe-C-eDP-1
[304.716288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[304.725276] Starting dynamic subtest: pipe-D-eDP-1
[304.733704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[304.737888] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[306.836111] [052/133] (713s left) kms_selftest (drm_plane_helper)
[306.875030] Starting subtest: drm_plane_helper
[306.883052] Starting dynamic subtest: drm_test_check_plane_state
[307.027451] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.142s)
[307.038023] Starting dynamic subtest: drm_test_check_invalid_plane_state
[307.170106] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.142s)
[307.172544] Subtest drm_plane_helper: SUCCESS (0.292s)
[307.385633] [053/133] (713s left) gem_fence_thrash (bo-write-verify-threaded-none)
[307.420610] Starting subtest: bo-write-verify-threaded-none
[307.446256] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[307.515012] [054/133] (713s left) gem_mmap_wc (read-write)
[307.577085] Subtest read-write: SKIP (0.000s)
[307.649958] [055/133] (712s left) kms_rmfb (rmfb-ioctl)
[307.745954] Starting subtest: rmfb-ioctl
[307.748106] Starting dynamic subtest: pipe-A-eDP-1
[307.849720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[307.861261] Starting dynamic subtest: pipe-B-eDP-1
[309.004413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[309.015336] Starting dynamic subtest: pipe-C-eDP-1
[310.127083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[310.138018] Starting dynamic subtest: pipe-D-eDP-1
[311.253364] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[311.255790] Subtest rmfb-ioctl: SUCCESS (3.496s)
[312.496153] [056/133] (708s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[312.590276] Starting subtest: fbc-psr2-sprite-mmap-cpu
[312.592509] Starting dynamic subtest: eDP-1
[312.596947] Dynamic subtest eDP-1: SKIP (0.000s)
[312.601268] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[312.675928] [057/133] (708s left) gem_exec_suspend (basic-s3)
[312.730606] Starting subtest: basic-S3
[312.733223] Starting dynamic subtest: smem
[333.082399] Dynamic subtest smem: SUCCESS (6.678s)
[333.085633] Subtest basic-S3: SUCCESS (6.680s)
[333.281019] [058/133] (687s left) kms_psr (psr-cursor-mmap-cpu)
[333.390178] Starting subtest: psr-cursor-mmap-cpu
[333.392426] Starting dynamic subtest: eDP-1
[335.145696] Dynamic subtest eDP-1: SUCCESS (1.743s)
[335.148263] Subtest psr-cursor-mmap-cpu: SUCCESS (1.744s)
[336.040946] [059/133] (684s left) gem_vm_create (create-ext)
[336.110532] Starting subtest: create-ext
[336.112585] Subtest create-ext: SUCCESS (0.005s)
[336.251737] [060/133] (684s left) gem_flink_basic (flink-lifetime)
[336.302255] Starting subtest: flink-lifetime
[336.304560] Subtest flink-lifetime: SUCCESS (0.002s)
[336.427136] [061/133] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[336.515878] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[336.520160] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[336.616837] [062/133] (684s left) gem_exec_reloc (basic-wc-gtt-active)
[336.679392] Subtest basic-wc-gtt-active: SKIP (0.000s)
[336.748865] [063/133] (684s left) prime_busy (before-wait)
[336.819595] Starting subtest: before-wait
[336.821875] Starting dynamic subtest: rcs0
[336.872559] Dynamic subtest rcs0: SUCCESS (0.051s)
[336.884337] Starting dynamic subtest: bcs0
[336.947621] Dynamic subtest bcs0: SUCCESS (0.073s)
[336.963532] Starting dynamic subtest: vcs0
[336.987821] Dynamic subtest vcs0: SUCCESS (0.038s)
[336.998239] Starting dynamic subtest: vcs1
[337.027407] Dynamic subtest vcs1: SUCCESS (0.039s)
[337.036407] Starting dynamic subtest: vecs0
[337.067259] Dynamic subtest vecs0: SUCCESS (0.039s)
[337.076895] Starting dynamic subtest: ccs0
[337.107907] Dynamic subtest ccs0: SUCCESS (0.040s)
[337.214827] Subtest before-wait: SUCCESS (0.393s)
[337.298088] [064/133] (683s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[337.380120] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[337.382401] Starting dynamic subtest: pipe-A-eDP-1
[337.404363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[337.414498] Starting dynamic subtest: pipe-B-eDP-1
[337.435459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[337.444574] Starting dynamic subtest: pipe-C-eDP-1
[337.465540] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.474500] Starting dynamic subtest: pipe-D-eDP-1
[337.496318] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.500672] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[339.626250] [065/133] (681s left) gem_exec_whisper (basic-queues)
[339.684672] Starting subtest: basic-queues
[345.096002] Subtest basic-queues: SUCCESS (5.393s)
[345.296118] [066/133] (675s left) kms_dp_linktrain_fallback (dsc-fallback)
[345.409094] Starting subtest: dsc-fallback
[345.415746] Subtest dsc-fallback: SKIP (0.000s)
[345.494054] [067/133] (675s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[345.596715] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[352.728209] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.123s)
[352.857638] [068/133] (668s left) gem_ctx_param (get-priority-new-ctx)
[352.911522] Starting subtest: get-priority-new-ctx
[352.913906] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[353.053228] [069/133] (668s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[353.153837] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[353.158283] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.295387] [070/133] (667s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[353.421262] Starting subtest: flip-vs-cursor-legacy
[360.551569] Subtest flip-vs-cursor-legacy: SUCCESS (7.125s)
[361.440838] [071/133] (659s left) sw_sync (timeline_closed)
[361.481573] Starting subtest: timeline_closed
[361.483634] Subtest timeline_closed: SUCCESS (0.000s)
[361.548759] [072/133] (659s left) kms_cursor_crc (cursor-sliding-64x21)
[361.743683] Starting subtest: cursor-sliding-64x21
[361.792487] Subtest cursor-sliding-64x21: SKIP (0.044s)
[362.028412] [073/133] (659s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[362.134250] Starting subtest: cursorB-vs-flipA-varying-size
[362.138773] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[362.291444] [074/133] (659s left) gem_exec_schedule (fairslice-all)
[362.366293] Starting subtest: fairslice-all
[364.424173] Subtest fairslice-all: SUCCESS (2.060s)
[366.030909] [075/133] (655s left) syncobj_timeline (invalid-query-bad-pad)
[366.100889] Starting subtest: invalid-query-bad-pad
[366.103606] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[366.209100] [076/133] (655s left) gem_exec_schedule (out-order)
[366.275998] Starting subtest: out-order
[366.277869] Starting dynamic subtest: rcs0
[366.434991] Dynamic subtest rcs0: SUCCESS (0.165s)
[366.447223] Starting dynamic subtest: vcs0
[366.535736] Dynamic subtest vcs0: SUCCESS (0.099s)
[366.545430] Starting dynamic subtest: vcs1
[366.653705] Dynamic subtest vcs1: SUCCESS (0.117s)
[366.666029] Starting dynamic subtest: vecs0
[366.754090] Dynamic subtest vecs0: SUCCESS (0.099s)
[366.766923] Starting dynamic subtest: ccs0
[366.879024] Dynamic subtest ccs0: SUCCESS (0.124s)
[366.881901] Subtest out-order: SUCCESS (0.611s)
[368.159099] [077/133] (653s left) kms_getfb (getfb2-into-addfb2)
[368.274012] Starting subtest: getfb2-into-addfb2
[368.276419] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[368.402478] [078/133] (653s left) gem_exec_balancer (parallel-balancer)
[368.669481] Starting subtest: parallel-balancer
[369.581019] Subtest parallel-balancer: SUCCESS (0.893s)
[369.697631] [079/133] (651s left) kms_atomic (plane-immutable-zpos)
[369.803766] Starting subtest: plane-immutable-zpos
[369.806054] Starting dynamic subtest: pipe-A-eDP-1
[370.439407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[370.441712] Subtest plane-immutable-zpos: SUCCESS (0.638s)
[371.263338] [080/133] (650s left) api_intel_bb (purge-bb)
[371.332448] Starting subtest: purge-bb
[371.337406] Subtest purge-bb: SUCCESS (0.004s)
[371.490479] [081/133] (650s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[371.591073] Starting subtest: plane-lut1d-ctm3x4-lut1d
[371.603753] Starting dynamic subtest: pipe-A-eDP-1
[372.288794] Dynamic subtest pipe-A-eDP-1: FAIL (0.312s)
[373.024508] Starting dynamic subtest: pipe-B-eDP-1
[373.813141] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[374.363264] Starting dynamic subtest: pipe-C-eDP-1
[375.186160] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[375.694623] Starting dynamic subtest: pipe-D-eDP-1
[376.543420] Dynamic subtest pipe-D-eDP-1: FAIL (0.267s)
[376.545756] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.673s)
[377.084866] [082/133] (644s left) kms_pm_rpm (pm-caching)
[379.224470] Starting subtest: pm-caching
[379.229155] Subtest pm-caching: SKIP (0.000s)
[379.618072] [083/133] (642s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[379.717450] Starting subtest: stress-xrgb8888-yftiled
[379.721709] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[379.808640] [084/133] (642s left) gen9_exec_parse (bb-large)
[379.883307] Subtest bb-large: SKIP (0.000s)
[379.975410] [085/133] (641s left) kms_lease (cursor-implicit-plane)
[380.066686] Starting subtest: cursor-implicit-plane
[380.069016] Starting dynamic subtest: pipe-A-eDP-1
[380.523166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[380.533463] Starting dynamic subtest: pipe-B-eDP-1
[381.611662] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[381.624039] Starting dynamic subtest: pipe-C-eDP-1
[382.729768] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[382.742561] Starting dynamic subtest: pipe-D-eDP-1
[383.848183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[383.850482] Subtest cursor-implicit-plane: SUCCESS (3.782s)
[384.724448] [086/133] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[384.827409] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[392.181280] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.355s)
[392.364684] [087/133] (629s left) gem_pxp (hw-rejects-pxp-context)
[392.482116] Starting subtest: hw-rejects-pxp-context
[392.486643] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[392.618211] [088/133] (629s left) kms_content_protection (lic-type-1)
[392.766920] Starting subtest: lic-type-1
[392.771566] Subtest lic-type-1: SKIP (0.000s)
[392.912360] [089/133] (629s left) kms_addfb_basic (tile-pitch-mismatch)
[392.961268] Starting subtest: tile-pitch-mismatch
[392.965493] Subtest tile-pitch-mismatch: SKIP (0.000s)
[393.127127] [090/133] (628s left) gem_exec_endless (dispatch)
[393.189317] Starting subtest: dispatch
[393.191407] Starting dynamic subtest: rcs0
[393.197785] Dynamic subtest rcs0: SUCCESS (0.005s)
[393.210368] Starting dynamic subtest: bcs0
[393.213993] Dynamic subtest bcs0: SUCCESS (0.004s)
[393.223986] Starting dynamic subtest: vcs0
[393.227751] Dynamic subtest vcs0: SUCCESS (0.005s)
[393.236624] Starting dynamic subtest: vcs1
[393.239980] Dynamic subtest vcs1: SUCCESS (0.005s)
[393.248731] Starting dynamic subtest: vecs0
[393.252212] Dynamic subtest vecs0: SUCCESS (0.006s)
[393.261137] Starting dynamic subtest: ccs0
[393.264487] Dynamic subtest ccs0: SUCCESS (0.004s)
[393.266145] Subtest dispatch: SUCCESS (0.036s)
[395.090035] [091/133] (627s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[395.194172] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[395.198090] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[395.329288] [092/133] (626s left) kms_atomic_interruptible (universal-setplane-primary)
[395.419677] Starting subtest: universal-setplane-primary
[395.422002] Starting dynamic subtest: pipe-A-eDP-1
[402.856701] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.433s)
[402.858594] Subtest universal-setplane-primary: SUCCESS (7.434s)
[403.720034] [093/133] (618s left) gem_ccs (block-multicopy-compressed)
[403.777010] Starting subtest: block-multicopy-compressed
[403.781296] Subtest block-multicopy-compressed: SKIP (0.000s)
[403.918915] [094/133] (618s left) gem_ringfill (engines-basic)
[410.077741] Starting subtest: engines-basic
[410.080477] Starting dynamic subtest: rcs0
[410.141996] Dynamic subtest rcs0: SUCCESS (0.064s)
[410.154551] Starting dynamic subtest: bcs0
[410.187206] Dynamic subtest bcs0: SUCCESS (0.043s)
[410.198793] Starting dynamic subtest: vcs0
[410.229079] Dynamic subtest vcs0: SUCCESS (0.040s)
[410.239662] Starting dynamic subtest: vcs1
[410.272701] Dynamic subtest vcs1: SUCCESS (0.041s)
[410.283799] Starting dynamic subtest: vecs0
[410.317881] Dynamic subtest vecs0: SUCCESS (0.043s)
[410.328875] Starting dynamic subtest: ccs0
[410.361783] Dynamic subtest ccs0: SUCCESS (0.042s)
[410.364646] Subtest engines-basic: SUCCESS (0.286s)
[410.455814] [095/133] (611s left) prime_udl
[410.545982] [096/133] (611s left) gem_mmap_gtt (hang-user)
[410.600911] Subtest hang-user: SKIP (0.000s)
[410.673606] [097/133] (611s left) kms_psr2_su (frontbuffer-xrgb8888)
[410.733376] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[410.793414] [098/133] (611s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[410.904012] Starting subtest: plane-upscale-20x20-with-rotation
[410.906283] Starting dynamic subtest: pipe-A
[411.128159] Dynamic subtest pipe-A: SUCCESS (0.226s)
[411.138084] Starting dynamic subtest: pipe-B
[412.381434] Dynamic subtest pipe-B: SUCCESS (1.252s)
[412.391833] Starting dynamic subtest: pipe-C
[413.709083] Dynamic subtest pipe-C: SUCCESS (1.326s)
[413.719733] Starting dynamic subtest: pipe-D
[415.034656] Dynamic subtest pipe-D: SUCCESS (1.324s)
[415.037019] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.131s)
[416.222923] [099/133] (606s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[416.282520] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[416.284957] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[416.394815] [100/133] (606s left) kms_feature_discovery (psr2)
[416.493232] Starting subtest: psr2
[416.495080] Subtest psr2: SUCCESS (0.000s)
[416.582329] [101/133] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[416.695216] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[416.699241] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[416.799380] [102/133] (605s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[416.905249] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[416.907673] Starting dynamic subtest: pipe-A-default-mode
[418.084688] Dynamic subtest pipe-A-default-mode: SKIP (1.176s)
[418.089446] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.178s)
[418.280530] [103/133] (604s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[418.394769] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[418.397121] Starting dynamic subtest: pipe-A-eDP-1
[429.382359] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.991s)
[429.392898] Starting dynamic subtest: pipe-B-eDP-1
[441.071167] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.690s)
[441.073570] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.684s)
[441.950295] [104/133] (580s left) gem_exec_schedule (semaphore-noskip)
[442.038013] Starting subtest: semaphore-noskip
[442.456965] Subtest semaphore-noskip: SUCCESS (0.423s)
[442.841164] [105/133] (579s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[442.949789] Starting subtest: yf-tiled-64bpp-rotate-180
[442.954186] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[443.084682] [106/133] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[443.195364] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[443.199568] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.307403] [107/133] (579s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[443.369212] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[443.477533] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[443.570043] [108/133] (579s left) drm_read (invalid-buffer)
[443.722602] Starting subtest: invalid-buffer
[443.724961] Subtest invalid-buffer: SUCCESS (0.000s)
[443.870894] [109/133] (579s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[443.964883] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[443.967104] Starting dynamic subtest: pipe-A-eDP-1
[444.025547] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[444.037794] Starting dynamic subtest: pipe-B-eDP-1
[444.093992] Dynamic subtest pipe-B-eDP-1: SKIP (0.004s)
[444.104829] Starting dynamic subtest: pipe-C-eDP-1
[444.161732] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[444.172336] Starting dynamic subtest: pipe-D-eDP-1
[444.228357] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[444.232869] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.021s)
[446.313138] [110/133] (576s left) kms_invalid_mode (bad-vtotal)
[446.410072] Starting subtest: bad-vtotal
[446.412206] Starting dynamic subtest: pipe-A-eDP-1
[446.694964] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[446.705173] Starting dynamic subtest: pipe-B-eDP-1
[446.707021] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[446.715751] Starting dynamic subtest: pipe-C-eDP-1
[446.717985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[446.727044] Starting dynamic subtest: pipe-D-eDP-1
[446.729338] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[446.731476] Subtest bad-vtotal: SUCCESS (0.290s)
[447.535945] [111/133] (575s left) kms_pm_rpm (cursor-dpms)
[449.262972] Starting subtest: cursor-dpms
[449.268068] Subtest cursor-dpms: SKIP (0.000s)
[449.860868] [112/133] (573s left) kms_psr (pr-cursor-plane-move)
[449.957999] Starting subtest: pr-cursor-plane-move
[449.962073] Subtest pr-cursor-plane-move: SKIP (0.000s)
[450.058052] [113/133] (573s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[450.156047] Starting subtest: y-tiled-16bpp-rotate-180
[450.160445] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[450.287099] [114/133] (572s left) gem_ctx_isolation (preservation-s3)
[450.350507] Starting subtest: preservation-S3
[450.352918] Starting dynamic subtest: rcs0
[466.189015] Dynamic subtest rcs0: SUCCESS (1.307s)
[466.199539] Starting dynamic subtest: bcs0
[482.208878] Dynamic subtest bcs0: SUCCESS (1.329s)
[482.220863] Starting dynamic subtest: vcs0
[498.198932] Dynamic subtest vcs0: SUCCESS (3.045s)
[498.209283] Starting dynamic subtest: vcs1
[516.213217] Dynamic subtest vcs1: SUCCESS (5.027s)
[516.223383] Starting dynamic subtest: vecs0
[534.194421] Dynamic subtest vecs0: SUCCESS (4.959s)
[534.205183] Starting dynamic subtest: ccs0
[552.203601] Dynamic subtest ccs0: SUCCESS (3.181s)
[552.206320] Subtest preservation-S3: SUCCESS (18.853s)
[552.473519] [115/133] (470s left) kms_cursor_crc (cursor-onscreen-32x32)
[552.627295] Starting subtest: cursor-onscreen-32x32
[552.674121] Subtest cursor-onscreen-32x32: SKIP (0.040s)
[552.975968] [116/133] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[553.076713] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[553.081838] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[553.209807] [117/133] (470s left) kms_addfb_basic (basic-y-tiled-legacy)
[553.277218] Starting subtest: basic-y-tiled-legacy
[553.282725] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[553.442666] [118/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[553.550578] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[553.554056] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[553.662080] [119/133] (469s left) kms_psr (fbc-psr-primary-mmap-gtt)
[553.748930] Starting subtest: fbc-psr-primary-mmap-gtt
[553.750885] Starting dynamic subtest: eDP-1
[553.755023] Dynamic subtest eDP-1: SKIP (0.000s)
[553.759039] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[553.835123] [120/133] (469s left) syncobj_wait (single-wait-submitted)
[553.898058] Starting subtest: single-wait-submitted
[553.999500] Subtest single-wait-submitted: SUCCESS (0.100s)
[554.091518] [121/133] (469s left) i915_pm_rc6_residency (rc6-fence)
[554.147155] Starting subtest: rc6-fence
[554.167171] Starting dynamic subtest: gt0
[566.541221] Dynamic subtest gt0: SUCCESS (12.315s)
[566.553943] Starting dynamic subtest: gt1
[579.897781] Dynamic subtest gt1: SUCCESS (13.337s)
[579.900596] Subtest rc6-fence: SUCCESS (25.678s)
[579.989661] [122/133] (443s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[580.096139] Starting subtest: fbc-modesetfrombusy
[583.967028] Subtest fbc-modesetfrombusy: SUCCESS (3.873s)
[585.225549] [123/133] (438s left) gem_ctx_param (set-priority-not-supported)
[585.274562] Starting subtest: set-priority-not-supported
[585.279808] Subtest set-priority-not-supported: SKIP (0.000s)
[585.362154] [124/133] (438s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[585.464167] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[585.489695] Starting dynamic subtest: pipe-A-plane-0
[585.495018] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[585.505956] Starting dynamic subtest: pipe-A-plane-3
[585.510638] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[585.520453] Starting dynamic subtest: pipe-A-plane-5
[585.525006] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[586.621479] Starting dynamic subtest: pipe-B-plane-0
[586.627143] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[586.637093] Starting dynamic subtest: pipe-B-plane-3
[586.642347] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[586.652209] Starting dynamic subtest: pipe-B-plane-5
[586.657220] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[586.921133] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (1.457s)
[587.799851] [125/133] (435s left) gem_exercise_blt (fast-copy)
[587.865578] Starting subtest: fast-copy
[587.868211] Starting dynamic subtest: linear-smem-smem
[587.889244] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[587.899351] Starting dynamic subtest: xmajor-smem-smem
[587.907006] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[587.916862] Starting dynamic subtest: tile4-smem-smem
[587.924763] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[587.934616] Starting dynamic subtest: tile64-smem-smem
[587.941770] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[587.944373] Subtest fast-copy: SUCCESS (0.077s)
[588.083812] [126/133] (435s left) dmabuf_sync_file (import-multiple-read-write)
[588.129660] Starting subtest: import-multiple-read-write
[588.132095] Subtest import-multiple-read-write: SUCCESS (0.003s)
[588.196281] [127/133] (435s left) gem_softpin (allocator-fork)
[588.256800] Starting subtest: allocator-fork
[590.470783] Subtest allocator-fork: SUCCESS (2.213s)
[590.627294] [128/133] (433s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[590.735048] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[590.761057] Starting dynamic subtest: pipe-A-plane-0
[591.049430] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[591.059889] Starting dynamic subtest: pipe-A-plane-3
[591.282874] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[591.295079] Starting dynamic subtest: pipe-A-plane-5
[591.300970] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[592.366708] Starting dynamic subtest: pipe-B-plane-0
[592.669536] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[592.680220] Starting dynamic subtest: pipe-B-plane-3
[592.902913] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[592.913213] Starting dynamic subtest: pipe-B-plane-5
[592.918788] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[593.214220] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.483s)
[594.061700] [129/133] (429s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[594.180843] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[594.982569] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[595.160770] [130/133] (428s left) kms_chamelium_color (ctm-blue-to-red)
[595.279663] Subtest ctm-blue-to-red: SKIP (0.000s)
[595.327679] [131/133] (428s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[595.436282] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[595.441744] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[595.559077] [132/133] (428s left) gem_exec_fence (syncobj-channel)
[596.025071] Starting subtest: syncobj-channel
[597.040226] Subtest syncobj-channel: SUCCESS (1.015s)
[597.996649] [133/133] (425s left) gem_pread (exhaustion)
[598.061509] Subtest exhaustion: SKIP (0.000s)
[598.126617] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: i915_drm_fdinfo
results: parsing output: 6/ for test: gem_set_tiling_vs_gtt
results: parsing output: 7/ for test: sysfs_preempt_timeout
results: parsing output: 8/ for test: i915_query
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: sw_sync
results: parsing output: 14/ for test: gem_ctx_create
results: parsing output: 15/ for test: kms_chamelium_frames
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: kms_plane_cursor
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: gem_ctx_persistence
results: parsing output: 23/ for test: gem_partial_pwrite_pread
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_close_race
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_flush
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: i915_hangman
results: parsing output: 47/ for test: gem_exec_async
results: parsing output: 48/ for test: gem_eio
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_selftest
results: parsing output: 52/ for test: gem_fence_thrash
results: parsing output: 53/ for test: gem_mmap_wc
results: parsing output: 54/ for test: kms_rmfb
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: gem_exec_suspend
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_vm_create
results: parsing output: 59/ for test: gem_flink_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: prime_busy
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: kms_dp_linktrain_fallback
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_getfb
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_color_pipeline
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: kms_pipe_stress
results: parsing output: 83/ for test: gen9_exec_parse
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: gem_exec_endless
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_atomic_interruptible
results: parsing output: 92/ for test: gem_ccs
results: parsing output: 93/ for test: gem_ringfill
results: parsing output: 94/ for test: prime_udl
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_psr2_su
results: parsing output: 97/ for test: kms_plane_scaling
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_feature_discovery
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: kms_pm_rpm
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: i915_pm_rc6_residency
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: gem_exercise_blt
results: parsing output: 125/ for test: dmabuf_sync_file
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: gem_pread
Done.