[110.312189] Initializing watchdogs
[110.312395]   /dev/watchdog0
[110.352505] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[110.367389] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[110.374301] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[110.379593] [001/133] (960s left) i915_drm_fdinfo (idle)
[110.513243] Starting subtest: idle
[110.514835] Starting dynamic subtest: rcs0
[111.022591] Dynamic subtest rcs0: SUCCESS (0.509s)
[111.038529] Starting dynamic subtest: bcs0
[111.532891] Dynamic subtest bcs0: SUCCESS (0.507s)
[111.548909] Starting dynamic subtest: vcs0
[112.041205] Dynamic subtest vcs0: SUCCESS (0.506s)
[112.056931] Starting dynamic subtest: vecs0
[112.548893] Dynamic subtest vecs0: SUCCESS (0.508s)
[112.550489] Subtest idle: SUCCESS (2.036s)
[112.690436] [002/133] (958s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[112.879478] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[112.967448] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[113.161060] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[115.372027] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SUCCESS (2.208s)
[115.596967] [004/133] (955s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[115.780157] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[115.781065] Starting dynamic subtest: pipe-A-valid-mode
[116.846995] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.069s)
[116.850200] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (1.073s)
[117.164606] [005/133] (954s left) syncobj_timeline (invalid-transfer-illegal-handle)
[117.274283] Starting subtest: invalid-transfer-illegal-handle
[117.275410] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[117.399184] [006/133] (953s left) gem_exec_await (wide-all)
[117.774300] Starting subtest: wide-all
[139.903274] Subtest wide-all: SUCCESS (22.130s)
[140.153388] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[140.161055] [007/133] (931s left) dmabuf_sync_file (export-basic)
[140.389966] Starting subtest: export-basic
[140.394140] Subtest export-basic: SUCCESS (0.004s)
[140.510840] [008/133] (930s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[140.701078] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[152.047144] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.343s)
[152.393840] [009/133] (919s left) gem_exec_gttfill (all-engines)
[152.556541] Starting subtest: all-engines
[182.402361] Subtest all-engines: SUCCESS (29.850s)
[182.696357] [010/133] (888s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[183.026109] Starting subtest: fbc-rgb101010-draw-mmap-wc
[186.019614] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.992s)
[186.258560] [011/133] (885s left) syncobj_wait (reset-during-wait-for-submit)
[186.374457] Starting subtest: reset-during-wait-for-submit
[186.480371] Subtest reset-during-wait-for-submit: SUCCESS (0.105s)
[186.658781] [012/133] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[186.853246] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[186.862046] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.009659] [013/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[187.230125] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[188.318842] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.089s)
[188.675246] [014/133] (883s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[188.785831] Starting subtest: no-spare-fences-interruptible
[190.983583] Subtest no-spare-fences-interruptible: SUCCESS (2.171s)
[191.109676] [015/133] (880s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[191.210304] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[191.313915] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[191.461987] [016/133] (880s left) kms_feature_discovery (display-1x)
[191.644184] Starting subtest: display-1x
[191.646226] Subtest display-1x: SUCCESS (0.000s)
[191.775677] [017/133] (880s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[191.892960] Starting subtest: y-tiled-ccs-to-x-tiled
[191.897122] Starting dynamic subtest: smem
[192.115807] Dynamic subtest smem: SUCCESS (0.221s)
[192.119397] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.225s)
[192.380234] [018/133] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[192.578720] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[195.855791] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SUCCESS (3.277s)
[196.044792] [019/133] (876s left) gem_userptr_blits (dmabuf-sync)
[196.185832] Starting subtest: dmabuf-sync
[196.197135] Subtest dmabuf-sync: SKIP (0.007s)
[196.380679] [020/133] (876s left) syncobj_timeline (single-wait-all-available-submitted)
[196.482543] Starting subtest: single-wait-all-available-submitted
[196.484513] Subtest single-wait-all-available-submitted: SUCCESS (0.002s)
[196.627852] [021/133] (875s left) dumb_buffer (map-uaf)
[196.725455] Starting subtest: map-uaf
[196.739236] Subtest map-uaf: SUCCESS (0.015s)
[196.896510] [022/133] (875s left) gem_exec_schedule (semaphore-power)
[197.159687] Starting subtest: semaphore-power
[198.037045] Subtest semaphore-power: SUCCESS (0.874s)
[198.297274] [023/133] (874s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[198.414331] Starting subtest: tiled-to-untiled
[198.525519] Subtest tiled-to-untiled: SUCCESS (0.110s)
[198.679625] [024/133] (874s left) kms_chamelium_color (ctm-0-50)
[198.866091] Subtest ctm-0-50: SKIP (0.000s)
[198.968839] [025/133] (874s left) gem_exec_reloc (basic-wc-read)
[199.089665] Starting subtest: basic-wc-read
[199.103619] Subtest basic-wc-read: SUCCESS (0.015s)
[199.330536] [026/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[199.505126] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[199.613640] [027/133] (873s left) api_intel_allocator (gem-pool)
[199.714129] Starting subtest: gem-pool
[199.731058] Subtest gem-pool: SUCCESS (0.015s)
[199.880408] [028/133] (873s left) kms_rotation_crc (bad-pixel-format)
[200.063325] Starting subtest: bad-pixel-format
[204.108886] Subtest bad-pixel-format: SUCCESS (4.045s)
[204.364508] [029/133] (868s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[204.565299] Starting subtest: 4-tiled-8bpp-rotate-0
[204.569286] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[204.712899] [030/133] (868s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[204.909193] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[204.913060] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[205.063552] [031/133] (868s left) gem_fence_thrash (bo-copy)
[205.164681] Starting subtest: bo-copy
[206.436562] Subtest bo-copy: SUCCESS (1.273s)
[206.581256] [032/133] (867s left) gem_softpin (evict-prime-sanity-check)
[206.696806] Starting subtest: evict-prime-sanity-check
[206.697921] Starting dynamic subtest: rcs0
[207.799906] Dynamic subtest rcs0: SUCCESS (1.103s)
[207.829863] Starting dynamic subtest: bcs0
[208.906553] Dynamic subtest bcs0: SUCCESS (1.103s)
[208.932844] Starting dynamic subtest: vcs0
[210.015807] Dynamic subtest vcs0: SUCCESS (1.106s)
[210.045242] Starting dynamic subtest: vecs0
[211.115950] Dynamic subtest vecs0: SUCCESS (1.097s)
[211.139166] Starting dynamic subtest: all
[212.214520] Dynamic subtest all: SUCCESS (1.094s)
[212.216473] Subtest evict-prime-sanity-check: SUCCESS (5.518s)
[212.380891] [033/133] (861s left) i915_selftest (mock)
[214.292937] Starting subtest: mock
[214.294103] Starting dynamic subtest: sanitycheck
[216.114405] Dynamic subtest sanitycheck: SUCCESS (1.820s)
[216.139356] Starting dynamic subtest: shmem
[217.842419] Dynamic subtest shmem: SUCCESS (1.725s)
[217.871236] Starting dynamic subtest: fence
[227.038670] Dynamic subtest fence: SUCCESS (9.192s)
[227.060621] Starting dynamic subtest: scatterlist
[229.777915] Dynamic subtest scatterlist: SUCCESS (2.736s)
[229.801680] Starting dynamic subtest: syncmap
[233.595677] Dynamic subtest syncmap: SUCCESS (3.815s)
[233.617489] Starting dynamic subtest: uncore
[235.333941] Dynamic subtest uncore: SUCCESS (1.735s)
[235.357327] Starting dynamic subtest: ring
[237.068356] Dynamic subtest ring: SUCCESS (1.730s)
[237.089322] Starting dynamic subtest: engine
[238.809761] Dynamic subtest engine: SUCCESS (1.740s)
[238.832589] Starting dynamic subtest: timelines
[248.510213] Dynamic subtest timelines: SUCCESS (9.696s)
[248.535240] Starting dynamic subtest: requests
[252.464722] Dynamic subtest requests: SUCCESS (3.954s)
[252.486591] Starting dynamic subtest: objects
[254.400405] Dynamic subtest objects: SUCCESS (1.930s)
[254.422318] Starting dynamic subtest: phys
[256.333615] Dynamic subtest phys: SUCCESS (1.931s)
[256.355383] Starting dynamic subtest: dmabuf
[258.246223] Dynamic subtest dmabuf: SUCCESS (1.912s)
[258.271351] Starting dynamic subtest: vma
[279.051313] Dynamic subtest vma: SUCCESS (20.803s)
[279.073485] Starting dynamic subtest: evict
[283.189862] Dynamic subtest evict: SUCCESS (4.135s)
[283.213309] Starting dynamic subtest: gtt
[288.846152] Dynamic subtest gtt: SUCCESS (5.653s)
[288.869374] Starting dynamic subtest: hugepages
[291.231864] Dynamic subtest hugepages: SUCCESS (2.383s)
[291.253500] Starting dynamic subtest: memory_region
[299.481743] Dynamic subtest memory_region: SUCCESS (8.245s)
[299.483193] Subtest mock: SUCCESS (85.191s)
[299.554469] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[299.557416] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[299.560844] [034/133] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[302.432844] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[302.442106] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[302.651827] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[302.654771] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)] new: kernel.kmod_is_loaded.i915: true
[302.662757] [035/133] (771s left) gem_softpin (evict-active-interruptible)
[302.796230] Starting subtest: evict-active-interruptible
[302.825148] Subtest evict-active-interruptible: SUCCESS (0.034s)
[302.985567] [036/133] (771s left) kms_pm_rpm (modeset-non-lpsp-stress)
[304.946970] Starting subtest: modeset-non-lpsp-stress
[311.214214] Subtest modeset-non-lpsp-stress: SUCCESS (6.267s)
[311.629338] [037/133] (762s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[311.819074] Starting subtest: cursorB-vs-flipB-legacy
[323.137113] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.321s)
[323.467970] [038/133] (750s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[323.661215] Starting subtest: basic-max-pipe-crc-check
[323.664585] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[323.775236] [039/133] (750s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[323.885368] Starting subtest: multi-wait-all-for-submit-submitted
[323.994706] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[324.135213] [040/133] (750s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[324.312288] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[324.315291] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[324.450912] [041/133] (750s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[324.658087] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[324.664074] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[324.801940] [042/133] (749s left) kms_getfb (getfb2-handle-not-fb)
[324.988144] Starting subtest: getfb2-handle-not-fb
[324.990486] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[325.134855] [043/133] (749s left) kms_psr (psr2-sprite-render)
[325.332483] Subtest psr2-sprite-render: SKIP (0.000s)
[325.442897] [044/133] (749s left) gem_workarounds (reset)
[325.576125] Starting subtest: reset
[325.611062] Subtest reset: SUCCESS (0.033s)
[325.781908] [045/133] (749s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[326.021182] Starting subtest: fbcpsr-rgb101010-draw-render
[326.028402] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[326.186319] [046/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[326.405127] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[326.408566] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[326.553286] [047/133] (748s left) gem_readwrite (beyond-eob)
[326.656180] Starting subtest: beyond-EOB
[326.658191] Subtest beyond-EOB: SUCCESS (0.000s)
[326.803666] [048/133] (748s left) kms_psr (fbc-pr-primary-page-flip)
[326.994124] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[327.107241] [049/133] (748s left) gem_exec_fence (invalid-timeline-fence-array)
[327.800052] Starting subtest: invalid-timeline-fence-array
[327.819154] Subtest invalid-timeline-fence-array: SUCCESS (0.017s)
[328.106288] [050/133] (747s left) gem_userptr_blits (set-cache-level)
[328.227833] Starting subtest: set-cache-level
[328.229127] Subtest set-cache-level: SUCCESS (0.000s)
[328.435904] [051/133] (746s left) kms_vblank (query-forked-hang)
[328.626271] Starting subtest: query-forked-hang
[328.627384] Starting dynamic subtest: pipe-A-HDMI-A-1
[335.883128] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.256s)
[335.928350] Starting dynamic subtest: pipe-A-HDMI-A-2
[342.865764] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.976s)
[342.927829] Starting dynamic subtest: pipe-C-HDMI-A-1
[349.846398] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.967s)
[349.881079] Starting dynamic subtest: pipe-C-HDMI-A-2
[356.857457] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.002s)
[356.859027] Subtest query-forked-hang: SUCCESS (28.237s)
[357.286889] [052/133] (718s left) kms_cursor_crc (cursor-offscreen-64x21)
[357.485097] Starting subtest: cursor-offscreen-64x21
[357.546629] Starting dynamic subtest: pipe-A-HDMI-A-1
[360.452797] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.904s)
[360.571814] Starting dynamic subtest: pipe-C-HDMI-A-1
[363.090381] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.569s)
[363.092795] Subtest cursor-offscreen-64x21: SUCCESS (5.606s)
[363.436247] [053/133] (712s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[363.549501] Starting subtest: single-wait-all-for-submit-unsubmitted
[363.656707] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[363.802124] [054/133] (711s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[363.994414] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[364.110185] [055/133] (711s left) kms_properties (connector-properties-legacy)
[364.309679] Starting subtest: connector-properties-legacy
[364.313126] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.242147] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.928s)
[366.271121] Starting dynamic subtest: pipe-A-HDMI-A-2
[368.087776] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.838s)
[368.095551] Subtest connector-properties-legacy: SUCCESS (3.783s)
[368.394215] [056/133] (707s left) kms_selftest (drm_plane_helper)
[368.513109] Starting subtest: drm_plane_helper
[368.531241] Starting dynamic subtest: drm_test_check_plane_state
[368.607296] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.071s)
[368.630503] Starting dynamic subtest: drm_test_check_invalid_plane_state
[368.664072] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.057s)
[368.669725] Subtest drm_plane_helper: SUCCESS (0.157s)
[368.844467] [057/133] (707s left) kms_chamelium_frames (dp-crc-single)
[369.464696] Subtest dp-crc-single: SKIP (0.000s)
[369.766609] [058/133] (706s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[369.966240] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[369.971239] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[370.132492] [059/133] (706s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[370.327047] Starting subtest: addfb25-y-tiled-legacy
[370.328216] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[370.467233] [060/133] (705s left) sysfs_timeslice_duration (idempotent)
[370.581126] Starting subtest: idempotent
[370.589547] Starting dynamic subtest: vecs0
[370.591562] Dynamic subtest vecs0: SUCCESS (0.002s)
[370.622186] Starting dynamic subtest: vcs0
[370.623209] Dynamic subtest vcs0: SUCCESS (0.002s)
[370.645669] Starting dynamic subtest: bcs0
[370.646934] Dynamic subtest bcs0: SUCCESS (0.002s)
[370.670746] Starting dynamic subtest: rcs0
[370.672103] Dynamic subtest rcs0: SUCCESS (0.002s)
[370.673459] Subtest idempotent: SUCCESS (0.023s)
[370.757576] [061/133] (705s left) sw_sync (alloc_merge_fence)
[370.864168] Starting subtest: alloc_merge_fence
[370.866231] Subtest alloc_merge_fence: SUCCESS (0.001s)
[370.993898] [062/133] (705s left) gem_exec_schedule (preempt-other-chain)
[371.137286] Starting subtest: preempt-other-chain
[371.138978] Starting dynamic subtest: rcs0
[371.225515] Dynamic subtest rcs0: SUCCESS (0.083s)
[371.255336] Starting dynamic subtest: bcs0
[371.313191] Dynamic subtest bcs0: SUCCESS (0.081s)
[371.340137] Starting dynamic subtest: vcs0
[371.387518] Dynamic subtest vcs0: SUCCESS (0.079s)
[371.420256] Starting dynamic subtest: vecs0
[371.469975] Dynamic subtest vecs0: SUCCESS (0.078s)
[371.472183] Subtest preempt-other-chain: SUCCESS (0.333s)
[371.867379] [063/133] (704s left) kms_invalid_mode (zero-clock)
[372.054076] Starting subtest: zero-clock
[372.055833] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.494388] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.442s)
[372.553258] Starting dynamic subtest: pipe-A-HDMI-A-2
[372.558346] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[372.624420] Starting dynamic subtest: pipe-B-HDMI-A-1
[372.629051] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[372.666147] Starting dynamic subtest: pipe-B-HDMI-A-2
[372.667234] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[372.692588] Starting dynamic subtest: pipe-C-HDMI-A-1
[372.693500] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[372.721421] Starting dynamic subtest: pipe-C-HDMI-A-2
[372.724077] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[372.724953] Subtest zero-clock: SUCCESS (0.495s)
[372.832133] [064/133] (703s left) prime_mmap_kms (buffer-sharing)
[373.040527] Starting subtest: buffer-sharing
[373.761504] Subtest buffer-sharing: SUCCESS (0.724s)
[374.076301] [065/133] (702s left) kms_flip (2x-flip-vs-panning-vs-hang)
[374.274087] Starting subtest: 2x-flip-vs-panning-vs-hang
[374.279133] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[387.668796] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (13.385s)
[387.670242] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (13.396s)
[388.143632] [066/133] (688s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[388.342093] Starting subtest: 2x-cursor-vs-flip-atomic
[418.122129] Subtest 2x-cursor-vs-flip-atomic: SUCCESS (29.779s)
[418.497240] [067/133] (658s left) syncobj_timeline (host-signal-ordered)
[418.607650] Starting subtest: host-signal-ordered
[418.611346] Subtest host-signal-ordered: SUCCESS (0.002s)
[418.768479] [068/133] (658s left) gen7_exec_parse (load-register-reg)
[418.879637] Subtest load-register-reg: SKIP (0.000s)
[418.994363] [069/133] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[419.213785] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[419.219134] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[419.367231] [070/133] (657s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[419.552240] Starting subtest: cursor-rapid-movement-64x64
[419.597772] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.515655] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.919s)
[420.690304] Starting dynamic subtest: pipe-C-HDMI-A-1
[421.267162] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.624s)
[421.269089] Subtest cursor-rapid-movement-64x64: SUCCESS (1.717s)
[421.606440] [071/133] (655s left) gem_ringfill (basic-all)
[421.972084] Starting subtest: basic-all
[423.178778] Subtest basic-all: SUCCESS (1.208s)
[423.389763] [072/133] (653s left) kms_lease (lease-unleased-connector)
[423.580121] Starting subtest: lease-unleased-connector
[423.582412] Starting dynamic subtest: pipe-A-HDMI-A-1
[423.667061] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[423.734057] Starting dynamic subtest: pipe-A-HDMI-A-2
[423.786684] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.096s)
[423.838907] Starting dynamic subtest: pipe-B-HDMI-A-1
[423.892062] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.096s)
[423.945485] Starting dynamic subtest: pipe-B-HDMI-A-2
[424.003671] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.096s)
[424.049791] Starting dynamic subtest: pipe-C-HDMI-A-1
[424.107140] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.096s)
[424.156501] Starting dynamic subtest: pipe-C-HDMI-A-2
[424.210390] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.091s)
[424.213143] Subtest lease-unleased-connector: SUCCESS (0.633s)
[424.364119] [073/133] (653s left) gem_mmap_wc (write-prefaulted)
[424.481090] Starting subtest: write-prefaulted
[424.663048] Subtest write-prefaulted: SUCCESS (0.187s)
[424.809511] [074/133] (652s left) i915_hangman (gt-engine-hang)
[424.949342] Starting subtest: gt-engine-hang
[424.954120] Starting dynamic subtest: rcs0
[425.527810] Dynamic subtest rcs0: SUCCESS (0.577s)
[425.554269] Starting dynamic subtest: bcs0
[426.110827] Dynamic subtest bcs0: SUCCESS (0.578s)
[426.137973] Starting dynamic subtest: vcs0
[426.691330] Dynamic subtest vcs0: SUCCESS (0.577s)
[426.719825] Starting dynamic subtest: vecs0
[427.280930] Dynamic subtest vecs0: SUCCESS (0.583s)
[427.282369] Subtest gt-engine-hang: SUCCESS (2.335s)
[427.474195] [075/133] (650s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[427.676047] Starting subtest: plane-lut1d-post-ctm3x4
[429.478234] Subtest plane-lut1d-post-ctm3x4: SKIP (1.803s)
[429.807352] [076/133] (647s left) kms_chamelium_frames (vga-frame-dump)
[430.450344] Subtest vga-frame-dump: SKIP (0.000s)
[430.736324] [077/133] (647s left) gem_ctx_shared (disjoint-timelines)
[430.866605] Starting subtest: disjoint-timelines
[430.891848] Subtest disjoint-timelines: SUCCESS (0.022s)
[431.157280] [078/133] (646s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[431.346095] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[431.354177] Starting dynamic subtest: pipe-A-valid-mode
[432.482413] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.127s)
[432.484365] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.135s)
[432.830491] [079/133] (645s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[433.036057] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[433.283875] Starting dynamic subtest: pipe-A-plane-0
[433.585909] Dynamic subtest pipe-A-plane-0: SUCCESS (0.298s)
[433.608128] Starting dynamic subtest: pipe-A-plane-1
[433.868134] Dynamic subtest pipe-A-plane-1: SUCCESS (0.277s)
[433.889611] Starting dynamic subtest: pipe-A-plane-2
[434.151583] Dynamic subtest pipe-A-plane-2: SUCCESS (0.280s)
[434.173504] Starting dynamic subtest: pipe-A-plane-3
[434.432236] Dynamic subtest pipe-A-plane-3: SUCCESS (0.280s)
[434.854092] Starting dynamic subtest: pipe-B-plane-0
[435.100450] Dynamic subtest pipe-B-plane-0: SUCCESS (0.263s)
[435.124225] Starting dynamic subtest: pipe-B-plane-1
[435.398941] Dynamic subtest pipe-B-plane-1: SUCCESS (0.295s)
[435.424228] Starting dynamic subtest: pipe-B-plane-2
[435.667516] Dynamic subtest pipe-B-plane-2: SUCCESS (0.262s)
[435.689101] Starting dynamic subtest: pipe-B-plane-3
[435.932156] Dynamic subtest pipe-B-plane-3: SUCCESS (0.263s)
[436.166186] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SUCCESS (3.129s)
[436.527697] [080/133] (641s left) gem_exec_schedule (smoketest-all)
[436.675191] Starting subtest: smoketest-all
[468.935612] Subtest smoketest-all: SUCCESS (32.264s)
[469.334260] [081/133] (608s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[469.529108] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[469.641880] [082/133] (608s left) gem_lmem_swapping (heavy-random)
[469.757721] Subtest heavy-random: SKIP (0.000s)
[469.875966] [083/133] (608s left) gem_partial_pwrite_pread (reads-uncached)
[469.991677] Starting subtest: reads-uncached
[476.593396] Subtest reads-uncached: SUCCESS (6.604s)
[476.770643] [084/133] (601s left) gem_wait (invalid-buf)
[476.882936] Starting subtest: invalid-buf
[476.884147] Subtest invalid-buf: SUCCESS (0.000s)
[477.185264] [085/133] (601s left) syncobj_wait (wait-delayed-signal)
[477.289380] Starting subtest: wait-delayed-signal
[477.396533] Subtest wait-delayed-signal: SUCCESS (0.106s)
[477.553857] [086/133] (601s left) gem_ctx_persistence (heartbeat-hostile)
[477.666830] Starting subtest: heartbeat-hostile
[478.852690] Subtest heartbeat-hostile: SUCCESS (1.186s)
[479.030984] [087/133] (599s left) kms_content_protection (atomic-dpms)
[479.246219] Starting subtest: atomic-dpms
[479.298613] Subtest atomic-dpms: SKIP (0.052s)
[479.478693] [088/133] (599s left) perf (gen12-group-exclusive-stream-sample-oa)
[479.783742] Starting subtest: gen12-group-exclusive-stream-sample-oa
[479.786828] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[479.886703] [089/133] (599s left) gem_exec_whisper (basic-contexts)
[480.016566] Starting subtest: basic-contexts
[487.194297] Subtest basic-contexts: SUCCESS (7.178s)
[487.455579] [090/133] (591s left) gem_mmap_gtt (cpuset-big-copy)
[487.560888] Starting subtest: cpuset-big-copy
[503.284078] Subtest cpuset-big-copy: SUCCESS (15.715s)
[503.477618] [091/133] (575s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[503.782070] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[503.785292] Starting dynamic subtest: pipe-A-HDMI-A-1
[503.807063] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[503.857119] Starting dynamic subtest: pipe-A-HDMI-A-2
[503.894576] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[503.936838] Starting dynamic subtest: pipe-B-HDMI-A-1
[503.944777] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[503.968959] Starting dynamic subtest: pipe-B-HDMI-A-2
[503.977048] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[504.000325] Starting dynamic subtest: pipe-C-HDMI-A-1
[504.008772] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[504.031205] Starting dynamic subtest: pipe-C-HDMI-A-2
[504.038988] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[504.040666] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.045s)
[504.902950] [092/133] (574s left) gem_exec_flush (basic-wb-ro-before-default)
[505.040555] Starting subtest: basic-wb-ro-before-default
[510.452871] Subtest basic-wb-ro-before-default: SUCCESS (5.416s)
[510.738790] [093/133] (568s left) perf_pmu (render-node-busy-idle)
[510.877921] Starting subtest: render-node-busy-idle
[510.880158] Starting dynamic subtest: rcs0
[511.510054] Dynamic subtest rcs0: SUCCESS (0.633s)
[511.539395] Starting dynamic subtest: bcs0
[512.146989] Dynamic subtest bcs0: SUCCESS (0.631s)
[512.172133] Starting dynamic subtest: vcs0
[512.783815] Dynamic subtest vcs0: SUCCESS (0.629s)
[512.807998] Starting dynamic subtest: vecs0
[513.411313] Dynamic subtest vecs0: SUCCESS (0.627s)
[513.412840] Subtest render-node-busy-idle: SUCCESS (2.537s)
[513.556280] [094/133] (565s left) kms_prop_blob (blob-prop-validate)
[513.661069] Starting subtest: blob-prop-validate
[513.662754] Subtest blob-prop-validate: SUCCESS (0.000s)
[513.820350] [095/133] (565s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[513.998095] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[514.000366] Starting dynamic subtest: pipe-A-HDMI-A-1
[531.247994] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.461s)
[531.312001] Starting dynamic subtest: pipe-A-HDMI-A-2