[62.533578] Initializing watchdogs
[62.533634]   /dev/watchdog0
[62.548270] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750]
[62.552664] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.554912] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.557345] [001/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[62.652535] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[62.654042] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.804809] [002/156] (960s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt)
[62.897621] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt
[62.899119] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.024478] [003/156] (960s left) kms_psr (fbc-psr-cursor-blt)
[63.114478] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[63.161725] [004/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[63.254158] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[63.255559] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[63.374945] [005/156] (959s left) sriov_basic (enable-vfs-bind-unbind-each)
[63.405509] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[63.444810] [006/156] (959s left) syncobj_wait (wait-all-for-submit-snapshot)
[63.473946] Starting subtest: wait-all-for-submit-snapshot
[63.557810] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[63.658855] [007/156] (959s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[63.751065] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[63.753386] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.002s)
[63.887842] [008/156] (959s left) gem_eio (wait-10ms)
[63.928127] Starting subtest: wait-10ms
[64.097590] Subtest wait-10ms: SUCCESS (0.170s)
[64.285563] [009/156] (959s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[64.315540] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[64.419944] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[64.535464] [010/156] (958s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[64.565033] Starting subtest: multi-wait-all-for-submit-signaled
[64.565727] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[64.698399] [011/156] (958s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[64.789420] Starting subtest: psr-shrfb-scaledprimary
[64.790903] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[64.913807] [012/156] (958s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[65.007907] Starting subtest: cursor-rapid-movement-512x170
[65.009351] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[65.134633] [013/156] (958s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[65.226483] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[65.227896] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[65.351735] [014/156] (958s left) sysfs_heartbeat_interval (idempotent)
[65.384047] Starting subtest: idempotent
[65.384801] Starting dynamic subtest: vecs0
[65.385504] Dynamic subtest vecs0: SUCCESS (0.001s)
[65.390871] Starting dynamic subtest: vcs0
[65.391715] Dynamic subtest vcs0: SUCCESS (0.001s)
[65.397972] Starting dynamic subtest: bcs0
[65.398694] Dynamic subtest bcs0: SUCCESS (0.001s)
[65.404054] Starting dynamic subtest: rcs0
[65.404762] Dynamic subtest rcs0: SUCCESS (0.001s)
[65.405459] Subtest idempotent: SUCCESS (0.006s)
[65.472581] [015/156] (958s left) gem_render_copy (y-tiled)
[65.507538] Starting subtest: y-tiled
[65.508327] Starting dynamic subtest: smem
[65.610670] Dynamic subtest smem: SUCCESS (0.103s)
[65.611413] Subtest y-tiled: SUCCESS (0.103s)
[65.827296] [016/156] (957s left) kms_busy (basic-hang)
[65.916861] Starting subtest: basic-hang
[65.917648] Starting dynamic subtest: flip-pipe-A
[66.511812] Dynamic subtest flip-pipe-A: SUCCESS (0.593s)
[66.518327] Starting dynamic subtest: modeset-pipe-A
[67.225985] Dynamic subtest modeset-pipe-A: SUCCESS (0.712s)
[67.234300] Starting dynamic subtest: flip-pipe-C
[67.602086] Dynamic subtest flip-pipe-C: SUCCESS (0.373s)
[67.608352] Starting dynamic subtest: modeset-pipe-C
[68.133881] Dynamic subtest modeset-pipe-C: SUCCESS (0.530s)
[68.134662] Subtest basic-hang: SUCCESS (2.214s)
[68.312367] [017/156] (955s left) kms_psr (psr2-cursor-plane-onoff)
[68.400732] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[68.439832] [018/156] (955s left) gem_exec_schedule (u-semaphore-user)
[68.479548] Starting subtest: u-semaphore-user
[68.486455] Subtest u-semaphore-user: SUCCESS (0.007s)
[68.818108] [019/156] (954s left) kms_atomic (atomic-plane-damage)
[68.905604] Starting subtest: atomic-plane-damage
[68.967685] Starting dynamic subtest: pipe-A-HDMI-A-2
[69.241133] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.273s)
[69.242152] Subtest atomic-plane-damage: SUCCESS (0.335s)
[69.417203] [020/156] (954s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[69.448308] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[69.449100] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[69.546576] [021/156] (954s left) kms_invalid_mode (zero-clock)
[69.633997] Starting subtest: zero-clock
[69.634751] Starting dynamic subtest: pipe-A-HDMI-A-2
[69.677321] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.043s)
[69.685034] Starting dynamic subtest: pipe-B-HDMI-A-2
[69.685811] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[69.693404] Starting dynamic subtest: pipe-C-HDMI-A-2
[69.694167] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.001s)
[69.694913] Subtest zero-clock: SUCCESS (0.047s)
[69.851796] [022/156] (954s left) kms_content_protection (lic-type-0-hdcp14)
[69.944412] Starting subtest: lic-type-0-hdcp14
[69.947808] Subtest lic-type-0-hdcp14: SKIP (0.002s)
[70.060937] [023/156] (953s left) kms_vblank (ts-continuation-modeset-rpm)
[70.147308] Starting subtest: ts-continuation-modeset-rpm
[70.148061] Starting dynamic subtest: pipe-A-HDMI-A-2
[71.825386] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.675s)
[71.836744] Starting dynamic subtest: pipe-C-HDMI-A-2
[72.352740] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.524s)
[72.353517] Subtest ts-continuation-modeset-rpm: SUCCESS (2.203s)
[72.536063] [024/156] (951s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-pwrite)
[72.628253] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-pwrite
[72.629759] Subtest hdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[72.752320] [025/156] (951s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[72.844700] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[72.846126] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[72.961787] [026/156] (951s left) gem_eio (reset-stress)
[72.997411] Starting subtest: reset-stress
[72.998127] Starting dynamic subtest: render
[75.975242] Dynamic subtest render: SUCCESS (2.973s)
[75.985752] Starting dynamic subtest: bsd
[78.953385] Dynamic subtest bsd: SUCCESS (2.976s)
[78.962981] Starting dynamic subtest: blt
[81.946904] Dynamic subtest blt: SUCCESS (2.992s)
[81.952939] Starting dynamic subtest: vebox
[85.013118] Dynamic subtest vebox: SUCCESS (3.064s)
[85.014228] Subtest reset-stress: SUCCESS (12.010s)
[85.182838] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[85.184416] [027/156] (938s left) gem_mmap_gtt (basic-small-bo)
[85.214205] Starting subtest: basic-small-bo
[85.533565] Subtest basic-small-bo: SUCCESS (0.319s)
[85.698259] [028/156] (938s left) perf (gen12-group-concurrent-oa-buffer-read)
[85.891249] Starting subtest: gen12-group-concurrent-oa-buffer-read
[95.941990] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.015s)
[96.013223] [029/156] (928s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[96.135949] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[96.137398] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[96.252681] [030/156] (928s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[96.340826] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[96.341599] Starting dynamic subtest: pipe-A-HDMI-A-2
[96.427185] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.086s)
[96.505047] Starting dynamic subtest: pipe-B-HDMI-A-2
[96.670621] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.174s)
[96.711931] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.371s)
[96.893156] [031/156] (927s left) gem_eio (hibernate)
[96.929784] Starting subtest: hibernate
[109.612246] Subtest hibernate: SUCCESS (12.679s)
[120.780782] [032/156] (914s left) kms_plane_multiple (tiling-none)
[120.873523] Starting subtest: tiling-none
[120.874329] Starting dynamic subtest: pipe-A-HDMI-A-2
[121.594444] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.720s)
[121.606620] Starting dynamic subtest: pipe-B-HDMI-A-2
[122.239133] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.643s)
[122.247271] Starting dynamic subtest: pipe-C-HDMI-A-2
[122.891424] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.651s)
[122.892158] Subtest tiling-none: SUCCESS (2.017s)
[123.080596] [033/156] (912s left) gem_ctx_isolation (clean)
[123.116806] Starting subtest: clean
[123.117545] Starting dynamic subtest: rcs0
[123.137279] Dynamic subtest rcs0: SUCCESS (0.020s)
[123.145275] Starting dynamic subtest: bcs0
[123.200296] Dynamic subtest bcs0: SUCCESS (0.063s)
[123.208295] Starting dynamic subtest: vcs0
[123.272842] Dynamic subtest vcs0: SUCCESS (0.072s)
[123.280796] Starting dynamic subtest: vecs0
[123.337684] Dynamic subtest vecs0: SUCCESS (0.064s)
[123.338421] Subtest clean: SUCCESS (0.221s)
[123.561882] [034/156] (911s left) api_intel_bb (blit-noreloc-purge-cache)
[123.592610] Starting subtest: blit-noreloc-purge-cache
[123.597366] Subtest blit-noreloc-purge-cache: SUCCESS (0.005s)
[123.720547] [035/156] (911s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[123.812532] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[127.245100] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.433s)
[127.403499] [036/156] (908s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-blt)
[127.494459] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-blt
[127.495889] Subtest hdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[127.640967] [037/156] (907s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[127.729830] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[127.766657] [038/156] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[127.857496] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[127.858901] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[128.002166] [039/156] (907s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[128.089651] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[128.091112] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[128.188843] [040/156] (907s left) kms_dsc (dsc-with-output-formats-with-bpc)
[128.276639] Starting subtest: dsc-with-output-formats-with-bpc
[128.298851] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[128.367486] [041/156] (907s left) syncobj_wait (wait-any-interrupted)
[128.398877] Starting subtest: wait-any-interrupted
[128.507027] Subtest wait-any-interrupted: SUCCESS (0.108s)
[128.627589] [042/156] (907s left) gem_exec_fence (syncobj-timeline-signal)
[129.074911] Starting subtest: syncobj-timeline-signal
[129.075725] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[129.318436] [043/156] (906s left) gem_close_race (multigpu-basic-threads)
[129.354368] Starting subtest: multigpu-basic-threads
[129.355793] Subtest multigpu-basic-threads: SKIP (0.000s)
[129.576981] [044/156] (906s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[129.667818] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[129.669278] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.837607] [045/156] (906s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[129.926197] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[129.926884] Starting dynamic subtest: pipe-A
[130.034119] Dynamic subtest pipe-A: SUCCESS (0.107s)
[130.054902] Starting dynamic subtest: pipe-B
[130.189274] Dynamic subtest pipe-B: SUCCESS (0.153s)
[130.209647] Starting dynamic subtest: pipe-C
[130.365040] Dynamic subtest pipe-C: SUCCESS (0.175s)
[130.366430] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.439s)
[130.583882] [046/156] (905s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[130.672153] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[130.672877] Starting dynamic subtest: pipe-A-HDMI-A-2
[130.679997] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[130.687982] Starting dynamic subtest: pipe-B-HDMI-A-2
[130.695128] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[130.702998] Starting dynamic subtest: pipe-C-HDMI-A-2
[130.710058] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[130.711434] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[130.960522] [047/156] (905s left) gem_userptr_blits (create-destroy-unsync)
[130.994527] Subtest create-destroy-unsync: SKIP (0.000s)
[131.152803] [048/156] (904s left) gem_exec_reloc (basic-write-gtt)
[131.184701] Subtest basic-write-gtt: SKIP (0.000s)
[131.294384] [049/156] (904s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[131.381831] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[132.466031] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.084s)
[132.636928] [050/156] (903s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[132.728599] Starting subtest: hdr-rgb565-draw-render
[132.730081] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[132.866694] [051/156] (903s left) perf_pmu (semaphore-wait)
[132.897237] Starting subtest: semaphore-wait
[132.897996] Starting dynamic subtest: rcs0
[133.415815] Dynamic subtest rcs0: SUCCESS (0.509s)
[133.429285] Starting dynamic subtest: bcs0
[133.926716] Dynamic subtest bcs0: SUCCESS (0.509s)
[133.939801] Starting dynamic subtest: vcs0
[134.438310] Dynamic subtest vcs0: SUCCESS (0.510s)
[134.450963] Starting dynamic subtest: vecs0
[134.949054] Dynamic subtest vecs0: SUCCESS (0.510s)
[134.949949] Subtest semaphore-wait: SUCCESS (2.043s)
[135.026905] [052/156] (901s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[135.114782] Starting subtest: compare-crc-sanitycheck-xr24
[135.115552] Starting dynamic subtest: pipe-A-HDMI-A-2
[135.569328] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.453s)
[135.581825] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.923980] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.353s)
[135.932888] Starting dynamic subtest: pipe-C-HDMI-A-2
[136.276657] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.352s)
[136.277435] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.161s)
[136.461763] [053/156] (899s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[136.553772] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[136.555269] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[136.691175] [054/156] (899s left) syncobj_timeline (single-wait-available-signaled)
[136.721856] Starting subtest: single-wait-available-signaled
[136.722621] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[136.820168] [055/156] (899s left) kms_chamelium_color (ctm-limited-range)
[136.907953] Subtest ctm-limited-range: SKIP (0.000s)
[136.949204] [056/156] (899s left) gem_ctx_persistence (smoketest)
[136.983217] Starting subtest: smoketest
[175.472340] Subtest smoketest: SUCCESS (38.484s)
[175.592818] [057/156] (860s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[175.698717] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[175.700196] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[175.837624] [058/156] (860s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[175.925739] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[175.962782] [059/156] (860s left) kms_invalid_mode (bad-hsync-start)
[176.051882] Starting subtest: bad-hsync-start
[176.052938] Starting dynamic subtest: pipe-A-HDMI-A-2
[176.091499] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.039s)
[176.101716] Starting dynamic subtest: pipe-B-HDMI-A-2
[176.102479] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[176.112068] Starting dynamic subtest: pipe-C-HDMI-A-2
[176.112816] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[176.113513] Subtest bad-hsync-start: SUCCESS (0.044s)
[176.281679] [060/156] (860s left) gem_lmem_swapping (massive)
[176.315253] Subtest massive: SKIP (0.000s)
[176.351218] [061/156] (860s left) gem_exec_balancer (parallel-contexts)
[176.498119] Subtest parallel-contexts: SKIP (0.000s)
[176.625440] [062/156] (860s left) kms_async_flips (async-flip-dpms)
[176.712619] Starting subtest: async-flip-dpms
[176.871452] Starting dynamic subtest: pipe-A-HDMI-A-2
[179.319826] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.448s)
[179.541458] Starting dynamic subtest: pipe-B-HDMI-A-2
[181.612139] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.070s)
[181.750724] Starting dynamic subtest: pipe-C-HDMI-A-2
[183.857053] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.105s)
[183.857825] Subtest async-flip-dpms: SUCCESS (7.136s)
[184.135657] [063/156] (852s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[184.228471] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[184.229907] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[184.354640] [064/156] (852s left) kms_setmode (basic)
[184.384410] Starting subtest: basic
[184.439431] Starting dynamic subtest: pipe-A-HDMI-A-2
[186.811369] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.362s)
[186.878549] Starting dynamic subtest: pipe-B-HDMI-A-2
[189.239717] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.361s)
[189.272087] Subtest basic: SUCCESS (4.886s)
[189.459941] [065/156] (847s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[189.550567] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[189.551988] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[189.689512] [066/156] (847s left) kms_cursor_crc (cursor-offscreen-512x170)
[189.780694] Starting subtest: cursor-offscreen-512x170
[189.782177] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[189.916515] [067/156] (847s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[190.008199] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[190.009645] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[190.143453] [068/156] (846s left) kms_flip (nonblocking-read)
[190.232955] Starting subtest: nonblocking-read
[190.233756] Subtest nonblocking-read: SUCCESS (0.000s)
[190.371796] [069/156] (846s left) gem_pxp (create-regular-buffer)
[190.469484] Starting subtest: create-regular-buffer
[190.470794] Subtest create-regular-buffer: SUCCESS (0.000s)
[190.599770] [070/156] (846s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[190.687506] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[190.714729] Starting dynamic subtest: pipe-A-plane-0
[191.340830] Dynamic subtest pipe-A-plane-0: SUCCESS (0.626s)
[191.364878] Starting dynamic subtest: pipe-A-plane-3
[191.815466] Dynamic subtest pipe-A-plane-3: SUCCESS (0.472s)
[192.001689] Starting dynamic subtest: pipe-B-plane-0
[192.472639] Dynamic subtest pipe-B-plane-0: SUCCESS (0.492s)
[192.496470] Starting dynamic subtest: pipe-B-plane-3
[192.928120] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s)
[192.967964] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (2.279s)
[193.166978] [071/156] (843s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[193.255716] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[193.256475] Starting dynamic subtest: pipe-A-HDMI-A-2
[193.263555] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[193.272171] Starting dynamic subtest: pipe-B-HDMI-A-2
[193.279603] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[193.288081] Starting dynamic subtest: pipe-C-HDMI-A-2
[193.294905] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[193.296322] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[193.555484] [072/156] (843s left) gem_eio (in-flight-internal-10ms)
[193.590267] Starting subtest: in-flight-internal-10ms
[193.856637] Subtest in-flight-internal-10ms: SUCCESS (0.266s)
[194.049136] [073/156] (843s left) gem_ccs (ctrl-surf-copy)
[194.081498] Starting subtest: ctrl-surf-copy
[194.082931] Subtest ctrl-surf-copy: SKIP (0.000s)
[194.201333] [074/156] (843s left) kms_flip (plain-flip-ts-check-interruptible)
[194.292631] Starting subtest: plain-flip-ts-check-interruptible
[194.294263] Starting dynamic subtest: A-HDMI-A2
[204.816297] Dynamic subtest A-HDMI-A2: SUCCESS (10.521s)
[204.828931] Starting dynamic subtest: B-HDMI-A2
[215.315482] Dynamic subtest B-HDMI-A2: SUCCESS (10.480s)
[215.324429] Starting dynamic subtest: C-HDMI-A2
[225.775323] Dynamic subtest C-HDMI-A2: SUCCESS (10.471s)
[225.777093] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.482s)
[225.985846] [075/156] (811s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[226.073615] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[226.074300] Starting dynamic subtest: pipe-A-HDMI-A-2
[226.081035] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[226.089839] Starting dynamic subtest: pipe-B-HDMI-A-2
[226.096388] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[226.105029] Starting dynamic subtest: pipe-C-HDMI-A-2
[226.111549] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[226.112843] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.003s)
[226.374228] [076/156] (810s left) kms_flip (absolute-wf_vblank-interruptible)
[226.465694] Starting subtest: absolute-wf_vblank-interruptible
[226.467240] Starting dynamic subtest: A-HDMI-A2
[236.705980] Dynamic subtest A-HDMI-A2: SUCCESS (10.236s)
[236.717406] Starting dynamic subtest: B-HDMI-A2
[246.913806] Dynamic subtest B-HDMI-A2: SUCCESS (10.188s)
[246.923444] Starting dynamic subtest: C-HDMI-A2
[257.108986] Dynamic subtest C-HDMI-A2: SUCCESS (10.186s)
[257.109772] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.624s)
[257.323612] [077/156] (780s left) kms_chamelium_edid (hdmi-edid-read)
[257.457886] Subtest hdmi-edid-read: SKIP (0.000s)
[257.564156] [078/156] (779s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move)
[257.656451] Starting subtest: hdr-1p-primscrn-cur-indfb-move
[257.657783] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[257.803525] [079/156] (779s left) gem_pipe_control_store_loop (fresh-buffer)
[257.835949] Starting subtest: fresh-buffer
[259.994180] Subtest fresh-buffer: SUCCESS (2.149s)
[260.129359] [080/156] (777s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[260.163708] Starting subtest: x-tiled-to-vebox-y-tiled
[260.164441] Starting dynamic subtest: smem
[260.263962] Dynamic subtest smem: SUCCESS (0.100s)
[260.264714] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.100s)
[260.493887] [081/156] (777s left) syncobj_timeline (invalid-query-zero-handles)
[260.525608] Starting subtest: invalid-query-zero-handles
[260.526312] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[260.670200] [082/156] (776s left) core_getstats (basic)
[260.699238] Starting subtest: basic
[260.699982] Subtest basic: SUCCESS (0.000s)
[260.800722] [083/156] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[260.891855] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[260.893302] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[261.030336] [084/156] (776s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[261.118733] Starting subtest: plane-lut1d-ctm3x4
[261.299988] Starting dynamic subtest: pipe-A-plane-0
[261.486748] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[261.502420] Starting dynamic subtest: pipe-A-plane-1
[261.657052] Dynamic subtest pipe-A-plane-1: SUCCESS (0.168s)
[261.679192] Starting dynamic subtest: pipe-A-plane-2
[261.827716] Dynamic subtest pipe-A-plane-2: SUCCESS (0.168s)
[262.080513] Starting dynamic subtest: pipe-B-plane-0
[262.238081] Dynamic subtest pipe-B-plane-0: SUCCESS (0.170s)
[262.255038] Starting dynamic subtest: pipe-B-plane-1
[262.409642] Dynamic subtest pipe-B-plane-1: SUCCESS (0.169s)
[262.430525] Starting dynamic subtest: pipe-B-plane-2
[262.580394] Dynamic subtest pipe-B-plane-2: SUCCESS (0.168s)
[262.861268] Starting dynamic subtest: pipe-C-plane-0
[263.012366] Dynamic subtest pipe-C-plane-0: SUCCESS (0.170s)
[263.033488] Starting dynamic subtest: pipe-C-plane-1
[263.182904] Dynamic subtest pipe-C-plane-1: SUCCESS (0.168s)
[263.203978] Starting dynamic subtest: pipe-C-plane-2
[263.353503] Dynamic subtest pipe-C-plane-2: SUCCESS (0.168s)
[263.394808] Subtest plane-lut1d-ctm3x4: SUCCESS (2.276s)
[263.565137] [085/156] (774s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[263.654726] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[263.655413] Starting dynamic subtest: pipe-A-valid-mode
[264.328083] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.673s)
[264.328764] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.674s)
[264.513758] [086/156] (773s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[264.611134] Starting subtest: y-tiled-32bpp-rotate-270
[266.270259] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.650s)
[266.479399] [087/156] (771s left) prime_mmap (test_map_unmap)
[266.508883] Starting subtest: test_map_unmap
[266.509648] Starting dynamic subtest: test_map_unmap-smem
[266.554832] Dynamic subtest test_map_unmap-smem: SUCCESS (0.045s)
[266.555619] Subtest test_map_unmap: SUCCESS (0.046s)
[266.697231] [088/156] (771s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[266.789541] Starting subtest: fbchdr-tiling-y
[266.790971] Subtest fbchdr-tiling-y: SKIP (0.000s)
[266.904916] [089/156] (771s left) gem_spin_batch (engines)
[266.941222] Starting subtest: engines
[266.942110] Starting dynamic subtest: rcs0
[270.296966] Dynamic subtest rcs0: SUCCESS (3.319s)
[270.310339] Starting dynamic subtest: bcs0
[273.620369] Dynamic subtest bcs0: SUCCESS (3.320s)
[273.633482] Starting dynamic subtest: vcs0
[276.945487] Dynamic subtest vcs0: SUCCESS (3.322s)
[276.958453] Starting dynamic subtest: vecs0
[280.270746] Dynamic subtest vecs0: SUCCESS (3.322s)
[280.272082] Subtest engines: SUCCESS (13.294s)
[280.445893] [090/156] (757s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[280.534152] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[280.580803] [091/156] (757s left) gem_exec_gttfill (multigpu-basic)
[280.738570] Starting subtest: multigpu-basic
[291.514060] Subtest multigpu-basic: SUCCESS (10.775s)
[291.614500] [092/156] (746s left) gem_lmem_swapping (verify-random-ccs)
[291.730454] Subtest verify-random-ccs: SKIP (0.000s)
[291.776876] [093/156] (746s left) syncobj_timeline (reset-signaled)
[291.807827] Starting subtest: reset-signaled
[291.808527] Subtest reset-signaled: SUCCESS (0.001s)
[291.910135] [094/156] (746s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[291.942373] Subtest writes-after-reads: SKIP (0.000s)
[292.033917] [095/156] (746s left) gem_exec_nop (basic-series)
[292.071160] Starting subtest: basic-series
[295.109896] Subtest basic-series: SUCCESS (3.029s)
[295.345537] [096/156] (742s left) gen9_exec_parse (bb-chained)
[295.379513] Subtest bb-chained: SKIP (0.000s)
[295.417824] [097/156] (742s left) syncobj_wait (wait-delayed-signal)
[295.448824] Starting subtest: wait-delayed-signal
[295.551430] Subtest wait-delayed-signal: SUCCESS (0.102s)
[295.672590] [098/156] (742s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[295.704369] Starting subtest: no-spare-fences-interruptible
[297.858456] Subtest no-spare-fences-interruptible: SUCCESS (2.153s)
[298.004912] [099/156] (740s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[298.108763] Starting subtest: x-tiled-16bpp-rotate-90
[298.175085] Subtest x-tiled-16bpp-rotate-90: SKIP (0.066s)
[298.347821] [100/156] (740s left) kms_big_fb (linear-32bpp-rotate-90)
[298.445415] Starting subtest: linear-32bpp-rotate-90
[298.523267] Subtest linear-32bpp-rotate-90: SKIP (0.077s)
[298.689528] [101/156] (739s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.781807] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[298.783274] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.895676] [102/156] (739s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[298.987756] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[298.989162] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[299.125506] [103/156] (739s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[299.217862] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[299.219349] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[299.353054] [104/156] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[299.444855] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[299.446294] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[299.580036] [105/156] (739s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[299.676047] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[299.677595] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[299.828286] [106/156] (738s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[299.920811] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[299.922225] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[300.035091] [107/156] (738s left) gem_ctx_param (invalid-param-set)
[300.067310] Starting subtest: invalid-param-set
[300.068067] Subtest invalid-param-set: SUCCESS (0.000s)
[300.166569] [108/156] (738s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[300.258748] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[300.260229] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[300.397273] [109/156] (738s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[300.429834] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[300.514919] [110/156] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[300.605238] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[300.606707] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[300.717823] [111/156] (738s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[300.813720] Starting subtest: yf-tiled-16bpp-rotate-0
[300.815282] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[300.925939] [112/156] (738s left) syncobj_wait (single-wait-for-submit-submitted)
[300.956822] Starting subtest: single-wait-for-submit-submitted
[301.059177] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[301.175713] [113/156] (737s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[301.267582] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[301.268982] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[301.402390] [114/156] (737s left) kms_psr (psr2-primary-mmap-cpu)
[301.491374] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[301.550681] [115/156] (737s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[301.642741] Starting subtest: psrhdr-indfb-scaledprimary
[301.644140] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[301.761458] [116/156] (737s left) gem_eio (kms)
[301.858046] Starting subtest: kms
[324.939639] Subtest kms: SUCCESS (23.080s)
[325.115747] [117/156] (714s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[325.204763] Starting subtest: cursorB-vs-flipB-atomic
[325.206218] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[325.303084] [118/156] (714s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[325.337164] Starting subtest: y-tiled-to-vebox-x-tiled
[325.337912] Starting dynamic subtest: smem
[325.428133] Dynamic subtest smem: SUCCESS (0.090s)
[325.428918] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.091s)
[325.648395] [119/156] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[325.740850] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[325.742338] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[325.857378] [120/156] (713s left) gen9_exec_parse (unaligned-access)
[325.889197] Subtest unaligned-access: SKIP (0.000s)
[325.953062] [121/156] (713s left) gem_exec_schedule (noreorder-corked)
[326.120050] Starting subtest: noreorder-corked
[326.120966] Starting dynamic subtest: rcs0
[327.231699] Dynamic subtest rcs0: SUCCESS (1.111s)
[327.244874] Starting dynamic subtest: bcs0
[328.352951] Dynamic subtest bcs0: SUCCESS (1.119s)
[328.368200] Starting dynamic subtest: vcs0
[329.474928] Dynamic subtest vcs0: SUCCESS (1.119s)
[329.490149] Starting dynamic subtest: vecs0
[330.598143] Dynamic subtest vecs0: SUCCESS (1.120s)
[330.602127] Subtest noreorder-corked: SUCCESS (4.479s)
[330.801475] [122/156] (708s left) kms_plane (plane-position-covered)
[330.889415] Starting subtest: plane-position-covered
[331.239574] Starting dynamic subtest: pipe-A-plane-1
[331.591875] Dynamic subtest pipe-A-plane-1: SUCCESS (0.352s)
[331.604420] Starting dynamic subtest: pipe-A-plane-2
[331.931785] Dynamic subtest pipe-A-plane-2: SUCCESS (0.337s)
[331.944324] Starting dynamic subtest: pipe-A-plane-3
[332.267248] Dynamic subtest pipe-A-plane-3: SUCCESS (0.335s)
[332.280973] Starting dynamic subtest: pipe-A-plane-4
[332.598728] Dynamic subtest pipe-A-plane-4: SUCCESS (0.330s)
[332.609173] Starting dynamic subtest: pipe-A-plane-5
[332.610676] Dynamic subtest pipe-A-plane-5: SUCCESS (0.002s)
[332.871312] Starting dynamic subtest: pipe-B-plane-1
[333.171081] Dynamic subtest pipe-B-plane-1: SUCCESS (0.312s)
[333.180483] Starting dynamic subtest: pipe-B-plane-2
[333.484387] Dynamic subtest pipe-B-plane-2: SUCCESS (0.312s)
[333.493751] Starting dynamic subtest: pipe-B-plane-3
[333.797307] Dynamic subtest pipe-B-plane-3: SUCCESS (0.312s)
[333.806531] Starting dynamic subtest: pipe-B-plane-4
[334.110417] Dynamic subtest pipe-B-plane-4: SUCCESS (0.312s)
[334.120112] Starting dynamic subtest: pipe-B-plane-5
[334.121535] Dynamic subtest pipe-B-plane-5: SUCCESS (0.002s)
[334.122326] Subtest plane-position-covered: SUCCESS (3.223s)
[334.297264] [123/156] (705s left) kms_pm_dc (dc5-dpms-negative)
[335.397401] Starting subtest: dc5-dpms-negative
[339.654082] Subtest dc5-dpms-negative: SUCCESS (4.222s)
[339.708273] [124/156] (699s left) gem_mmap_gtt (basic-small-copy-odd)
[339.737623] Starting subtest: basic-small-copy-odd
[341.740062] Subtest basic-small-copy-odd: SUCCESS (2.002s)
[341.837131] [125/156] (697s left) kms_cursor_crc (cursor-sliding-max-size)
[341.997081] Starting subtest: cursor-sliding-max-size
[341.999201] Subtest cursor-sliding-max-size: SKIP (0.000s)
[342.151892] [126/156] (697s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[342.244501] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[342.245853] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[342.379050] [127/156] (697s left) kms_psr (fbc-psr2-primary-render)
[342.468082] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[342.506187] [128/156] (697s left) gem_mmap_wc (fault-concurrent)
[342.536841] Starting subtest: fault-concurrent
[342.609085] Subtest fault-concurrent: SUCCESS (0.073s)
[342.739912] [129/156] (697s left) kms_pm_rpm (pc8-residency)
[344.150589] Starting subtest: pc8-residency
[344.153263] Subtest pc8-residency: SKIP (0.000s)
[344.377373] [130/156] (695s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[344.465754] Starting subtest: multiplane-rotation-cropping-bottom
[397.704936] Subtest multiplane-rotation-cropping-bottom: SUCCESS (53.236s)
[397.854768] [131/156] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[397.949992] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[397.951452] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[398.081107] [132/156] (641s left) i915_hangman (engine-engine-error)
[398.117487] Starting subtest: engine-engine-error
[398.118274] Starting dynamic subtest: rcs0
[398.180686] Dynamic subtest rcs0: SUCCESS (0.062s)
[398.207836] Starting dynamic subtest: bcs0
[398.262549] Dynamic subtest bcs0: SUCCESS (0.078s)
[398.288375] Starting dynamic subtest: vcs0
[398.327639] Dynamic subtest vcs0: SUCCESS (0.061s)
[398.350238] Starting dynamic subtest: vecs0
[398.390590] Dynamic subtest vecs0: SUCCESS (0.059s)
[398.394745] Subtest engine-engine-error: SUCCESS (0.274s)
[398.518427] [133/156] (641s left) gem_exec_whisper (basic-contexts)
[398.555573] Starting subtest: basic-contexts
[400.087181] Subtest basic-contexts: SUCCESS (1.531s)
[400.287885] [134/156] (639s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[400.376798] Starting subtest: basic-flip-before-cursor-varying-size
[401.405567] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.028s)
[401.616337] [135/156] (638s left) syncobj_wait (reset-unsignaled)
[401.664306] Starting subtest: reset-unsignaled
[401.665081] Subtest reset-unsignaled: SUCCESS (0.000s)
[401.763749] [136/156] (638s left) i915_pm_rpm (debugfs-forcewake-user)
[403.153288] Starting subtest: debugfs-forcewake-user
[413.569782] Subtest debugfs-forcewake-user: SUCCESS (10.416s)
[413.777104] [137/156] (626s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[413.868779] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[416.538434] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.670s)
[416.747230] [138/156] (623s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[416.834910] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[416.835668] Starting dynamic subtest: pipe-A-HDMI-A-2
[416.842750] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[416.852171] Starting dynamic subtest: pipe-B-HDMI-A-2
[416.859149] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[416.868215] Starting dynamic subtest: pipe-C-HDMI-A-2
[416.875051] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[416.876453] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[417.158329] [139/156] (623s left) kms_chamelium_hpd (vga-hpd)
[417.303829] Subtest vga-hpd: SKIP (0.000s)
[417.414905] [140/156] (622s left) gem_mmap_gtt (hang-busy)
[417.445722] Starting subtest: hang-busy
[453.215463] Subtest hang-busy: SUCCESS (35.769s)
[453.377733] [141/156] (587s left) kms_addfb_basic (unused-handle)
[453.409090] Starting subtest: unused-handle
[453.409845] Subtest unused-handle: SUCCESS (0.000s)
[453.586990] [142/156] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[453.677710] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[453.679148] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[453.826833] [143/156] (586s left) gem_pipe_control_store_loop (reused-buffer)
[453.860230] Starting subtest: reused-buffer
[456.018305] Subtest reused-buffer: SUCCESS (2.149s)
[456.148783] [144/156] (584s left) dumb_buffer (create-valid-dumb)
[456.179068] Starting subtest: create-valid-dumb
[456.179790] Subtest create-valid-dumb: SUCCESS (0.000s)
[456.297861] [145/156] (584s left) gem_wait (await)
[456.337556] Starting subtest: await
[456.338339] Starting dynamic subtest: all-engines
[457.385023] Dynamic subtest all-engines: SUCCESS (1.046s)
[457.401628] Starting dynamic subtest: rcs0
[458.425815] Dynamic subtest rcs0: SUCCESS (1.037s)
[458.439171] Starting dynamic subtest: bcs0
[459.457832] Dynamic subtest bcs0: SUCCESS (1.028s)
[459.471077] Starting dynamic subtest: vcs0
[460.495093] Dynamic subtest vcs0: SUCCESS (1.034s)
[460.509357] Starting dynamic subtest: vecs0
[461.534743] Dynamic subtest vecs0: SUCCESS (1.036s)
[461.539656] Subtest await: SUCCESS (5.199s)
[461.788805] [146/156] (578s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[461.877822] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[461.878542] Starting dynamic subtest: pipe-A-valid-mode
[462.740311] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.861s)
[462.741076] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.862s)
[462.953679] [147/156] (577s left) i915_selftest (perf)
[463.998832] Starting subtest: perf
[463.999878] Starting dynamic subtest: engine_cs
[466.840604] Dynamic subtest engine_cs: SUCCESS (2.832s)
[466.859242] Starting dynamic subtest: request
[472.619463] Dynamic subtest request: SUCCESS (5.776s)
[472.627832] Starting dynamic subtest: migrate
[475.482211] Dynamic subtest migrate: SUCCESS (2.860s)
[475.490676] Starting dynamic subtest: region
[479.147213] Dynamic subtest region: SUCCESS (3.662s)
[479.148025] Subtest perf: SUCCESS (15.141s)
[479.180222] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[479.180929] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[479.184430] [148/156] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[481.792470] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[481.793791] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[481.965238] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[481.966739] [FACT kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)] new: kernel.kmod_is_loaded.i915: true
[481.968954] [149/156] (558s left) kms_pipe_crc_basic (nonblocking-crc)
[482.057702] Starting subtest: nonblocking-crc
[482.059458] Starting dynamic subtest: pipe-A-HDMI-A-2
[482.695796] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.637s)
[482.705283] Starting dynamic subtest: pipe-B-HDMI-A-2
[483.237101] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.540s)
[483.246564] Starting dynamic subtest: pipe-C-HDMI-A-2
[483.780153] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.541s)
[483.780899] Subtest nonblocking-crc: SUCCESS (1.722s)
[483.928319] [150/156] (556s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[484.016793] Starting subtest: psr-dirtyfb-ioctl
[484.020270] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[484.158284] [151/156] (556s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[484.249954] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[484.251433] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[484.400321] [152/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[484.492480] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[484.493915] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[484.612364] [153/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[484.703768] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[484.705196] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[484.821563] [154/156] (556s left) gem_exec_balancer (parallel-keep-submit-fence)
[484.981387] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[485.111378] [155/156] (555s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[485.204100] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[485.205637] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[485.330764] [156/156] (555s left) kms_vblank (query-forked-busy)
[485.419785] Starting subtest: query-forked-busy
[485.420488] Starting dynamic subtest: pipe-A-HDMI-A-2
[488.230361] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.810s)
[488.263434] Starting dynamic subtest: pipe-C-HDMI-A-2
[490.962400] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.723s)
[490.963501] Subtest query-forked-busy: SUCCESS (5.542s)
[491.178090] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: sriov_basic
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: sysfs_heartbeat_interval
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_busy
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_atomic
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_invalid_mode
results: parsing output: 21/ for test: kms_content_protection
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_atomic_transition
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_plane_multiple
results: parsing output: 32/ for test: gem_ctx_isolation
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_dsc
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_chamelium_color
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: gem_exec_balancer
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_setmode
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: gem_pxp
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gem_ccs
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_flip
results: parsing output: 76/ for test: kms_chamelium_edid
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_pipe_control_store_loop
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: core_getstats
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_color_pipeline
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_gttfill
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 94/ for test: gem_exec_nop
results: parsing output: 95/ for test: gen9_exec_parse
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_eio
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: kms_pm_dc
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_hangman
results: parsing output: 132/ for test: gem_exec_whisper
results: parsing output: 133/ for test: kms_cursor_legacy
results: parsing output: 134/ for test: syncobj_wait
results: parsing output: 135/ for test: i915_pm_rpm
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: kms_chamelium_hpd
results: parsing output: 139/ for test: gem_mmap_gtt
results: parsing output: 140/ for test: kms_addfb_basic
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: gem_pipe_control_store_loop
results: parsing output: 143/ for test: dumb_buffer
results: parsing output: 144/ for test: gem_wait
results: parsing output: 145/ for test: kms_flip_scaled_crc
results: parsing output: 146/ for test: i915_selftest
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_pipe_crc_basic
results: parsing output: 149/ for test: kms_dirtyfb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exec_balancer
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_vblank
Done.