[68.420727] Initializing watchdogs
[68.420807]   /dev/watchdog0
[68.447670] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.460291] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.464726] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.467410] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[70.576200] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[70.578048] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[70.761871] [002/131] (958s left) kms_psr (fbc-pr-sprite-plane-move)
[72.754036] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[72.857432] [003/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[74.879885] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[74.881705] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[75.056517] [004/131] (954s left) kms_fbcon_fbt (psr-suspend)
[75.121210] Starting subtest: psr-suspend
[75.123189] Subtest psr-suspend: SKIP (0.000s)
[75.280383] [005/131] (954s left) kms_plane_alpha_blend (alpha-transparent-fb)
[77.272823] Starting subtest: alpha-transparent-fb
[77.527444] Starting dynamic subtest: pipe-A-HDMI-A-4
[77.999968] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.472s)
[78.007921] Starting dynamic subtest: pipe-D-HDMI-A-4
[78.516254] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.515s)
[78.517287] Subtest alpha-transparent-fb: SUCCESS (1.243s)
[78.697362] [006/131] (950s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[80.700150] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[80.755772] [007/131] (948s left) kms_atomic (atomic-invalid-params)
[82.758439] Starting subtest: atomic-invalid-params
[82.759295] Starting dynamic subtest: pipe-A-HDMI-A-4
[83.180869] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.422s)
[83.181861] Subtest atomic-invalid-params: SUCCESS (0.424s)
[83.366547] [008/131] (946s left) kms_big_fb (4-tiled-addfb-size-overflow)
[85.379888] Starting subtest: 4-tiled-addfb-size-overflow
[85.382117] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[85.560946] [009/131] (944s left) api_intel_bb (lot-of-buffers)
[85.616153] Starting subtest: lot-of-buffers
[88.795567] Subtest lot-of-buffers: SUCCESS (3.177s)
[89.045538] [010/131] (940s left) kms_chamelium_hpd (common-hpd-after-suspend)
[91.068079] Subtest common-hpd-after-suspend: SKIP (0.000s)
[91.166214] [011/131] (938s left) kms_vblank (wait-idle-hang)
[93.161231] Starting subtest: wait-idle-hang
[93.162024] Starting dynamic subtest: pipe-A-HDMI-A-4
[119.485096] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.324s)
[119.495369] Starting dynamic subtest: pipe-D-HDMI-A-4
[144.486208] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.997s)
[144.487163] Subtest wait-idle-hang: SUCCESS (51.327s)
[144.661144] [012/131] (885s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[146.659270] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[146.660114] Starting dynamic subtest: pipe-A-HDMI-A-4
[146.663348] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[146.670510] Starting dynamic subtest: pipe-B-HDMI-A-4
[146.673808] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[146.680887] Starting dynamic subtest: pipe-C-HDMI-A-4
[146.684249] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[146.691168] Starting dynamic subtest: pipe-D-HDMI-A-4
[146.694483] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[146.696137] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[146.887871] [013/131] (883s left) prime_mmap (test_invalid_sync_flags)
[146.939476] Starting subtest: test_invalid_sync_flags
[146.940338] Starting dynamic subtest: test_invalid_sync_flags-smem
[146.941223] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[146.948580] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[146.949720] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[146.950887] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[147.073756] [014/131] (882s left) kms_lease (empty-lease)
[149.068227] Starting subtest: empty-lease
[149.069201] Starting dynamic subtest: pipe-A-HDMI-A-4
[149.070172] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s)
[149.078833] Starting dynamic subtest: pipe-B-HDMI-A-4
[149.079972] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[149.087300] Starting dynamic subtest: pipe-C-HDMI-A-4
[149.088310] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[149.095696] Starting dynamic subtest: pipe-D-HDMI-A-4
[149.096700] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[149.097703] Subtest empty-lease: SUCCESS (0.009s)
[149.181937] [015/131] (880s left) syncobj_wait (invalid-signal-bad-pad)
[149.243038] Starting subtest: invalid-signal-bad-pad
[149.243924] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[149.382649] [016/131] (880s left) kms_pm_dc (dc3co-vpb-simulation)
[152.384489] Starting subtest: dc3co-vpb-simulation
[152.386245] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[152.509866] [017/131] (877s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[154.532866] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[154.533829] Starting dynamic subtest: pipe-A-valid-mode
[155.361163] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.828s)
[155.362159] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.829s)
[155.538729] [018/131] (874s left) perf (invalid-oa-metric-set-id)
[155.647900] Starting subtest: invalid-oa-metric-set-id
[155.669827] Subtest invalid-oa-metric-set-id: SUCCESS (0.022s)
[155.733737] [019/131] (874s left) gem_vm_create (isolation)
[155.788289] Starting subtest: isolation
[155.797383] Subtest isolation: SUCCESS (0.009s)
[156.007137] [020/131] (874s left) syncobj_timeline (single-wait-all-signaled)
[156.058624] Starting subtest: single-wait-all-signaled
[156.059582] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[156.153422] [021/131] (874s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[158.146838] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[158.148581] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[158.327739] [022/131] (872s left) i915_pm_rpm (system-suspend-execbuf)
[163.110700] Starting subtest: system-suspend-execbuf
[224.256887] Subtest system-suspend-execbuf: SUCCESS (51.010s)
[224.456915] [023/131] (816s left) kms_cursor_crc (cursor-random-256x256)
[227.464153] Starting subtest: cursor-random-256x256
[227.472761] Starting dynamic subtest: pipe-A-HDMI-A-4
[231.886458] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.417s)
[231.919033] Starting dynamic subtest: pipe-D-HDMI-A-4
[236.264968] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.355s)
[236.266151] Subtest cursor-random-256x256: SUCCESS (8.802s)
[236.614149] [024/131] (804s left) gem_exec_params (secure-non-master)
[236.667730] Starting subtest: secure-non-master
[236.669662] Subtest secure-non-master: SKIP (0.000s)
[236.854461] [025/131] (804s left) kms_flip (flip-vs-rmfb)
[238.853411] Starting subtest: flip-vs-rmfb
[238.860842] Starting dynamic subtest: A-HDMI-A4
[246.589785] Dynamic subtest A-HDMI-A4: SUCCESS (7.728s)
[246.630915] Starting dynamic subtest: B-HDMI-A4
[254.316216] Dynamic subtest B-HDMI-A4: SUCCESS (7.723s)
[254.344144] Starting dynamic subtest: C-HDMI-A4
[262.048612] Dynamic subtest C-HDMI-A4: SUCCESS (7.730s)
[262.076823] Starting dynamic subtest: D-HDMI-A4
[269.782566] Dynamic subtest D-HDMI-A4: SUCCESS (7.731s)
[269.784339] Subtest flip-vs-rmfb: SUCCESS (30.931s)
[269.996504] [026/131] (770s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[271.991308] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[271.992225] Starting dynamic subtest: pipe-A-HDMI-A-4
[271.999806] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.002s)
[272.009585] Starting dynamic subtest: pipe-B-HDMI-A-4
[272.016977] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.002s)
[272.026201] Starting dynamic subtest: pipe-C-HDMI-A-4
[272.033650] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.002s)
[272.042570] Starting dynamic subtest: pipe-D-HDMI-A-4
[272.050053] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.002s)
[272.050955] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.017s)
[272.221751] [027/131] (768s left) gem_mmap_gtt (big-bo-tiledy)
[272.273120] Subtest big-bo-tiledY: SKIP (0.000s)
[272.353721] [028/131] (768s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[272.408140] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[272.503837] [029/131] (768s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[274.514260] Starting subtest: yf-tiled-8bpp-rotate-90
[274.516267] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[274.716133] [030/131] (766s left) kms_atomic_transition (plane-all-transition)
[276.714244] Starting subtest: plane-all-transition
[276.716725] Starting dynamic subtest: pipe-A-HDMI-A-4
[280.536467] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.816s)
[280.590693] Starting dynamic subtest: pipe-B-HDMI-A-4
[284.402988] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.821s)
[284.418122] Subtest plane-all-transition: SUCCESS (7.703s)
[284.583508] [031/131] (756s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[284.643469] Starting subtest: x-tiled-to-vebox-y-tiled
[284.644442] Starting dynamic subtest: smem
[284.724526] Dynamic subtest smem: SUCCESS (0.080s)
[284.735682] Starting dynamic subtest: lmem0
[285.485805] Dynamic subtest lmem0: SUCCESS (0.757s)
[285.487072] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.840s)
[285.755726] [032/131] (755s left) gem_tiled_wb
[285.879021] [033/131] (755s left) api_intel_bb (object-reloc-purge-cache)
[285.929453] Starting subtest: object-reloc-purge-cache
[285.931379] Subtest object-reloc-purge-cache: SKIP (0.002s)
[286.081941] [034/131] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[288.084889] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[288.086479] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[288.324649] [035/131] (753s left) gem_ctx_sseu (mmap-args)
[288.381405] Subtest mmap-args: SKIP (0.000s)
[288.461798] [036/131] (753s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[290.459153] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[290.524562] [037/131] (751s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[292.537586] Starting subtest: y-tiled-8bpp-rotate-90
[292.644366] Subtest y-tiled-8bpp-rotate-90: SKIP (0.105s)
[292.781446] [038/131] (749s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[294.780863] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[294.781856] Starting dynamic subtest: pipe-A-valid-mode
[294.830424] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[294.832313] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.050s)
[294.974505] [039/131] (746s left) gem_lmem_evict (dontneed-evict-race)
[300.363289] Starting subtest: dontneed-evict-race
[302.451356] Subtest dontneed-evict-race: SUCCESS (2.086s)
[303.773659] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[303.776069] [040/131] (738s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[312.524992] Starting subtest: plane-primary-overlay-mutable-zpos
[313.572412] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.047s)
[313.742335] [FACT kms_atomic (plane-primary-overlay-mutable-zpos)] new: kernel.kmod_is_loaded.amdgpu: true
[313.742504] [FACT kms_atomic (plane-primary-overlay-mutable-zpos)] new: kernel.kmod_is_loaded.i915: true
[313.743840] [FACT kms_atomic (plane-primary-overlay-mutable-zpos)] new: kernel.kmod_is_loaded.xe: true
[313.746367] [041/131] (728s left) gem_exec_fence (syncobj-invalid-flags)
[314.188080] Starting subtest: syncobj-invalid-flags
[314.189098] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[314.632938] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[314.635543] [042/131] (727s left) gem_partial_pwrite_pread (write)
[314.692098] Subtest write: SKIP (0.000s)
[314.807074] [043/131] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[316.809624] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[316.811612] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[317.040772] [044/131] (725s left) gem_exec_schedule (fifo)
[317.106422] Starting subtest: fifo
[317.107363] Starting dynamic subtest: rcs0
[317.287685] Dynamic subtest rcs0: SUCCESS (0.178s)
[317.297311] Starting dynamic subtest: bcs0
[317.408744] Dynamic subtest bcs0: SUCCESS (0.123s)
[317.420049] Starting dynamic subtest: vcs0
[317.534341] Dynamic subtest vcs0: SUCCESS (0.124s)
[317.545655] Starting dynamic subtest: vcs1
[317.660425] Dynamic subtest vcs1: SUCCESS (0.125s)
[317.671613] Starting dynamic subtest: vecs0
[317.796502] Dynamic subtest vecs0: SUCCESS (0.135s)
[317.797435] Subtest fifo: SUCCESS (0.691s)
[318.269618] [045/131] (724s left) kms_psr (fbc-psr-primary-page-flip)
[320.268904] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[320.344536] [046/131] (722s left) vgem_basic (second-client)
[320.406483] Starting subtest: second-client
[320.439935] Subtest second-client: SUCCESS (0.033s)
[320.577087] [047/131] (722s left) gem_softpin (evict-single-offset)
[320.633106] Starting subtest: evict-single-offset
[351.957755] Subtest evict-single-offset: SUCCESS (31.322s)
[352.066875] [048/131] (690s left) kms_addfb_basic (unused-offsets)
[352.146875] Starting subtest: unused-offsets
[352.147774] Subtest unused-offsets: SUCCESS (0.000s)
[354.289032] [049/131] (688s left) kms_vblank (wait-busy)
[356.287311] Starting subtest: wait-busy
[356.290004] Starting dynamic subtest: pipe-A-HDMI-A-4
[358.805574] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.516s)
[358.819713] Starting dynamic subtest: pipe-D-HDMI-A-4
[361.161371] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.350s)
[361.162299] Subtest wait-busy: SUCCESS (4.874s)
[361.329753] [050/131] (681s left) perf (gen12-mi-rpc)
[361.593427] Starting subtest: gen12-mi-rpc
[361.594385] Starting dynamic subtest: rcs0
[361.637576] Dynamic subtest rcs0: SUCCESS (0.044s)
[361.638607] Subtest gen12-mi-rpc: SUCCESS (0.045s)
[361.712325] [051/131] (681s left) tools_test (tools_test)
[361.767654] Starting subtest: tools_test
[361.875726] Subtest tools_test: SUCCESS (0.115s)
[361.966455] [052/131] (681s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[362.031851] Starting subtest: etime-single-wait-all-available-unsubmitted
[362.137843] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[362.257999] [053/131] (680s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[364.261349] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[364.263084] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[364.485911] [054/131] (678s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[366.495114] Starting subtest: x-tiled-16bpp-rotate-180
[368.304726] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.805s)
[368.523609] [055/131] (674s left) i915_module_load (reload-no-display)
[368.573589] Starting subtest: reload-no-display
[372.050227] Subtest reload-no-display: SUCCESS (3.473s)
[372.092104] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[372.093788] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[372.096438] [056/131] (671s left) gem_mmap_gtt (big-bo-tiledx)
[376.037060] Subtest big-bo-tiledX: SKIP (0.000s)
[376.178961] [FACT gem_mmap_gtt (big-bo-tiledx)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[376.185098] [FACT gem_mmap_gtt (big-bo-tiledx)] new: kernel.kmod_is_loaded.i915: true
[376.192099] [057/131] (667s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[378.203135] Starting subtest: cursorB-vs-flipB-atomic-transitions
[378.205267] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.002s)
[378.331473] [058/131] (665s left) gem_close (basic)
[378.411659] Starting subtest: basic
[378.412605] Subtest basic: SUCCESS (0.000s)
[378.577453] [059/131] (665s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[380.669535] Starting subtest: cursor-rapid-movement-64x64
[380.685820] Starting dynamic subtest: pipe-A-HDMI-A-4
[381.134212] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.449s)
[381.168426] Starting dynamic subtest: pipe-D-HDMI-A-4
[381.478871] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.318s)
[381.479837] Subtest cursor-rapid-movement-64x64: SUCCESS (0.809s)
[381.949520] [060/131] (661s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[383.954385] Starting subtest: psr-modesetfrombusy
[383.956194] Subtest psr-modesetfrombusy: SKIP (0.000s)
[384.146650] [061/131] (659s left) sysfs_heartbeat_interval (mixed)
[384.203612] Starting subtest: mixed
[384.206371] Starting dynamic subtest: vecs0
[389.471718] Dynamic subtest vecs0: SUCCESS (5.266s)
[389.485290] Starting dynamic subtest: vcs0
[394.719837] Dynamic subtest vcs0: SUCCESS (5.245s)
[394.732654] Starting dynamic subtest: bcs0
[399.985595] Dynamic subtest bcs0: SUCCESS (5.263s)
[400.003065] Starting dynamic subtest: rcs0
[405.228908] Dynamic subtest rcs0: SUCCESS (5.240s)
[405.241943] Starting dynamic subtest: vcs1
[410.512091] Dynamic subtest vcs1: SUCCESS (5.281s)
[410.513311] Subtest mixed: SUCCESS (26.310s)
[410.663327] [062/131] (633s left) gem_exec_reloc (basic-write-read-active)
[410.720361] Subtest basic-write-read-active: SKIP (0.000s)
[410.838732] [063/131] (633s left) gem_lmem_swapping (verify-random-ccs)
[416.036339] Starting subtest: verify-random-ccs
[416.037495] Starting dynamic subtest: lmem0
[416.040270] Dynamic subtest lmem0: SKIP (0.000s)
[416.042346] Subtest verify-random-ccs: SKIP (0.002s)
[417.233514] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[417.234820] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[417.237331] [064/131] (626s left) gem_exec_reloc (basic-write-cpu-noreloc)
[421.178480] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[421.272736] [FACT gem_exec_reloc (basic-write-cpu-noreloc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[421.277144] [FACT gem_exec_reloc (basic-write-cpu-noreloc)] new: kernel.kmod_is_loaded.i915: true
[421.280527] [065/131] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[423.285563] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[423.287342] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[423.497837] [066/131] (620s left) kms_addfb_basic (tile-pitch-mismatch)
[423.558412] Starting subtest: tile-pitch-mismatch
[423.560521] Subtest tile-pitch-mismatch: SKIP (0.000s)
[425.702953] [067/131] (618s left) kms_addfb_basic (basic-x-tiled-legacy)
[425.754010] Starting subtest: basic-x-tiled-legacy
[425.755783] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[427.905746] [068/131] (616s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[429.910985] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[429.912628] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[430.128289] [069/131] (614s left) drm_fdinfo (busy-idle)
[430.181527] Starting subtest: busy-idle
[430.182412] Starting dynamic subtest: rcs0
[430.184221] Dynamic subtest rcs0: SKIP (0.000s)
[430.194064] Starting dynamic subtest: bcs0
[430.196304] Dynamic subtest bcs0: SKIP (0.000s)
[430.205659] Starting dynamic subtest: vcs0
[430.207409] Dynamic subtest vcs0: SKIP (0.000s)
[430.216960] Starting dynamic subtest: vcs1
[430.219200] Dynamic subtest vcs1: SKIP (0.000s)
[430.228729] Starting dynamic subtest: vecs0
[430.230829] Dynamic subtest vecs0: SKIP (0.001s)
[430.233000] Subtest busy-idle: SKIP (0.008s)
[430.300843] [070/131] (614s left) gem_set_tiling_vs_pwrite
[430.428469] [071/131] (614s left) kms_psr (fbc-psr-dpms)
[432.429294] Subtest fbc-psr-dpms: SKIP (0.000s)
[432.496156] [072/131] (612s left) perf_pmu (idle)
[432.553432] Starting subtest: idle
[432.554378] Starting dynamic subtest: rcs0
[433.138452] Dynamic subtest rcs0: SUCCESS (0.581s)
[433.149418] Starting dynamic subtest: bcs0
[433.659229] Dynamic subtest bcs0: SUCCESS (0.512s)
[433.670111] Starting dynamic subtest: vcs0
[434.180315] Dynamic subtest vcs0: SUCCESS (0.520s)
[434.191427] Starting dynamic subtest: vcs1
[434.703220] Dynamic subtest vcs1: SUCCESS (0.514s)
[434.714706] Starting dynamic subtest: vecs0
[435.220911] Dynamic subtest vecs0: SUCCESS (0.513s)
[435.221969] Subtest idle: SUCCESS (2.664s)
[435.362301] [073/131] (609s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[437.360697] Starting subtest: 2x-cursor-vs-flip-atomic
[437.364299] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.003s)
[437.487850] [074/131] (607s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[439.509274] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[439.511128] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[439.698673] [075/131] (605s left) kms_plane (plane-position-covered)
[441.698655] Starting subtest: plane-position-covered
[442.179304] Starting dynamic subtest: pipe-A-plane-1
[442.571205] Dynamic subtest pipe-A-plane-1: SUCCESS (0.392s)
[442.582954] Starting dynamic subtest: pipe-A-plane-2
[442.930475] Dynamic subtest pipe-A-plane-2: SUCCESS (0.358s)
[442.941743] Starting dynamic subtest: pipe-A-plane-3
[443.289480] Dynamic subtest pipe-A-plane-3: SUCCESS (0.357s)
[443.301090] Starting dynamic subtest: pipe-A-plane-4
[443.646435] Dynamic subtest pipe-A-plane-4: SUCCESS (0.357s)
[443.657575] Starting dynamic subtest: pipe-A-plane-5
[444.037840] Dynamic subtest pipe-A-plane-5: SUCCESS (0.389s)
[444.049283] Starting dynamic subtest: pipe-A-plane-6
[444.427491] Dynamic subtest pipe-A-plane-6: SUCCESS (0.389s)
[444.438674] Starting dynamic subtest: pipe-A-plane-7
[444.446214] Dynamic subtest pipe-A-plane-7: SUCCESS (0.018s)
[444.737684] Starting dynamic subtest: pipe-B-plane-1
[445.079055] Dynamic subtest pipe-B-plane-1: SUCCESS (0.354s)
[445.090462] Starting dynamic subtest: pipe-B-plane-2
[445.439238] Dynamic subtest pipe-B-plane-2: SUCCESS (0.360s)
[445.451677] Starting dynamic subtest: pipe-B-plane-3
[445.796767] Dynamic subtest pipe-B-plane-3: SUCCESS (0.355s)
[445.809502] Starting dynamic subtest: pipe-B-plane-4
[446.154488] Dynamic subtest pipe-B-plane-4: SUCCESS (0.357s)
[446.169005] Starting dynamic subtest: pipe-B-plane-5
[446.509433] Dynamic subtest pipe-B-plane-5: SUCCESS (0.353s)
[446.523878] Starting dynamic subtest: pipe-B-plane-6
[446.868387] Dynamic subtest pipe-B-plane-6: SUCCESS (0.357s)
[446.881391] Starting dynamic subtest: pipe-B-plane-7
[446.892386] Dynamic subtest pipe-B-plane-7: SUCCESS (0.022s)
[446.893316] Subtest plane-position-covered: SUCCESS (5.195s)
[447.114154] [076/131] (598s left) kms_plane_scaling (planes-downscale-factor-0-5)
[449.116407] Starting subtest: planes-downscale-factor-0-5
[449.117471] Starting dynamic subtest: pipe-A
[449.275459] Dynamic subtest pipe-A: SUCCESS (0.158s)
[449.290281] Starting dynamic subtest: pipe-B
[449.434526] Dynamic subtest pipe-B: SUCCESS (0.158s)
[449.447028] Starting dynamic subtest: pipe-C
[449.574926] Dynamic subtest pipe-C: SUCCESS (0.139s)
[449.587849] Starting dynamic subtest: pipe-D
[449.716049] Dynamic subtest pipe-D: SUCCESS (0.140s)
[449.717022] Subtest planes-downscale-factor-0-5: SUCCESS (0.601s)
[449.885225] [077/131] (595s left) kms_prime (d3hot)
[451.901322] Subtest D3hot: SKIP (0.000s)
[452.075037] [078/131] (593s left) gem_mmap_wc (write-read-distinct)
[452.130371] Subtest write-read-distinct: SKIP (0.000s)
[452.197640] [079/131] (593s left) gem_exec_schedule (semaphore-codependency)
[452.267044] Starting subtest: semaphore-codependency
[452.291817] Subtest semaphore-codependency: SUCCESS (0.025s)
[452.722130] [080/131] (592s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[454.719979] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[454.721084] Starting dynamic subtest: pipe-A-valid-mode
[454.763300] Dynamic subtest pipe-A-valid-mode: SKIP (0.042s)
[454.765131] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.044s)
[454.907056] [081/131] (590s left) kms_dirtyfb (default-dirtyfb-ioctl)
[456.904849] Starting subtest: default-dirtyfb-ioctl
[456.905778] Starting dynamic subtest: A-HDMI-A-4
[458.328141] Dynamic subtest A-HDMI-A-4: SUCCESS (1.422s)
[458.329121] Subtest default-dirtyfb-ioctl: SUCCESS (1.424s)
[458.500087] [082/131] (587s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[460.502634] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[460.504449] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[460.704806] [083/131] (585s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[462.715263] Starting subtest: extended-modeset-hang-oldfb-with-reset
[462.716705] Starting dynamic subtest: pipe-A
[473.287282] Dynamic subtest pipe-A: SUCCESS (10.570s)
[473.302624] Starting dynamic subtest: pipe-D
[483.991335] Dynamic subtest pipe-D: SUCCESS (10.699s)
[483.992262] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.277s)
[484.189110] [084/131] (561s left) gem_workarounds (basic-read-fd)
[484.262703] Starting subtest: basic-read-fd
[484.290559] Subtest basic-read-fd: SUCCESS (0.027s)
[484.481156] [085/131] (561s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[484.533593] Starting subtest: wait-all-for-submit-delayed-submit
[484.640594] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[484.763604] [086/131] (561s left) prime_self_import (export-vs-gem_close-race)
[484.812740] Starting subtest: export-vs-gem_close-race
[489.847680] Subtest export-vs-gem_close-race: SUCCESS (5.034s)
[489.999758] [087/131] (556s left) gen9_exec_parse (valid-registers)
[490.063423] Subtest valid-registers: SKIP (0.000s)
[490.150543] [088/131] (556s left) fbdev (read)
[490.208281] Starting subtest: read
[491.684126] Subtest read: SUCCESS (1.472s)
[491.768431] [089/131] (554s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[493.767329] Starting subtest: bo-too-small-due-to-tiling
[493.769427] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[493.967896] [090/131] (552s left) gem_exec_create (basic)
[494.033267] Starting subtest: basic
[494.034269] Starting dynamic subtest: smem
[496.129481] Dynamic subtest smem: SUCCESS (2.095s)
[496.144782] Starting dynamic subtest: lmem0
[498.239383] Dynamic subtest lmem0: SUCCESS (2.108s)
[498.240364] Subtest basic: SUCCESS (4.207s)
[498.507379] [091/131] (547s left) kms_psr (psr2-primary-mmap-cpu)
[500.509371] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[500.582697] [092/131] (545s left) gem_softpin (allocator-basic-reserve)
[500.637694] Starting subtest: allocator-basic-reserve
[500.863521] Subtest allocator-basic-reserve: SUCCESS (0.222s)
[501.018147] [093/131] (545s left) kms_flip (flip-vs-absolute-wf_vblank)
[503.014786] Starting subtest: flip-vs-absolute-wf_vblank
[503.021722] Starting dynamic subtest: A-HDMI-A4
[511.210359] Dynamic subtest A-HDMI-A4: SUCCESS (8.188s)
[511.226278] Starting dynamic subtest: B-HDMI-A4
[519.321080] Dynamic subtest B-HDMI-A4: SUCCESS (8.108s)
[519.336076] Starting dynamic subtest: C-HDMI-A4
[527.437135] Dynamic subtest C-HDMI-A4: SUCCESS (8.114s)
[527.452307] Starting dynamic subtest: D-HDMI-A4
[535.552039] Dynamic subtest D-HDMI-A4: SUCCESS (8.113s)
[535.552963] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.540s)
[535.773077] [094/131] (510s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[537.772219] Starting subtest: random-ccs-data-yf-tiled-ccs
[537.773150] Starting dynamic subtest: pipe-A-HDMI-A-4
[537.784060] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[537.796649] Starting dynamic subtest: pipe-B-HDMI-A-4
[537.807247] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[537.819270] Starting dynamic subtest: pipe-C-HDMI-A-4
[537.830403] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[537.842447] Starting dynamic subtest: pipe-D-HDMI-A-4
[537.853304] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[537.857454] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.010s)
[538.016551] [095/131] (508s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[540.019426] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[540.021319] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[540.217830] [096/131] (506s left) gem_pxp (create-regular-context-2)
[542.794684] Starting subtest: create-regular-context-2
[542.796959] Subtest create-regular-context-2: SKIP (0.000s)
[542.911400] [097/131] (504s left) gem_exec_whisper (basic-forked)
[542.977663] Starting subtest: basic-forked
[545.770314] Subtest basic-forked: SUCCESS (2.791s)
[546.028690] [098/131] (500s left) gem_ctx_persistence (many-contexts)
[546.088758] Starting subtest: many-contexts
[584.413428] Subtest many-contexts: SUCCESS (38.326s)
[584.575148] [099/131] (462s left) gem_exec_endless (dispatch)
[584.651381] Starting subtest: dispatch
[584.652302] Starting dynamic subtest: rcs0
[584.659222] Dynamic subtest rcs0: SUCCESS (0.007s)
[584.673934] Starting dynamic subtest: bcs0
[584.675792] Dynamic subtest bcs0: SUCCESS (0.006s)
[584.688622] Starting dynamic subtest: vcs0
[584.690397] Dynamic subtest vcs0: SUCCESS (0.006s)
[584.703835] Starting dynamic subtest: vcs1
[584.705859] Dynamic subtest vcs1: SUCCESS (0.006s)
[584.718697] Starting dynamic subtest: vecs0
[584.720792] Dynamic subtest vecs0: SUCCESS (0.006s)
[584.721900] Subtest dispatch: SUCCESS (0.037s)
[584.811117] [100/131] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[586.811341] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[586.813138] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[587.012252] [101/131] (460s left) gem_ctx_persistence (engines-hang)
[587.068792] Starting subtest: engines-hang
[587.069736] Starting dynamic subtest: rcs0
[587.209030] Dynamic subtest rcs0: SUCCESS (0.138s)
[587.259355] Starting dynamic subtest: bcs0
[587.285486] Dynamic subtest bcs0: SUCCESS (0.071s)
[587.304208] Starting dynamic subtest: vcs0
[587.381094] Dynamic subtest vcs0: SUCCESS (0.092s)
[587.433329] Starting dynamic subtest: vcs1
[587.444518] Dynamic subtest vcs1: SUCCESS (0.058s)
[587.462355] Starting dynamic subtest: vecs0
[587.556938] Dynamic subtest vecs0: SUCCESS (0.109s)
[587.566511] Subtest engines-hang: SUCCESS (0.490s)
[587.788157] [102/131] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[589.791117] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[589.792951] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[590.006819] [103/131] (457s left) gem_fenced_exec_thrash (2-spare-fences)
[590.062248] Subtest 2-spare-fences: SKIP (0.000s)
[590.138142] [104/131] (457s left) gem_exec_reloc (basic-cpu-read)
[590.193331] Subtest basic-cpu-read: SKIP (0.000s)
[590.316648] [105/131] (457s left) gem_exec_balancer (individual)
[590.379807] Starting subtest: individual
[592.250479] Subtest individual: SUCCESS (1.867s)
[592.715115] [106/131] (454s left) kms_display_modes (extended-mode-basic)
[594.713044] Starting subtest: extended-mode-basic
[594.716011] Subtest extended-mode-basic: SKIP (0.000s)
[594.787127] [107/131] (452s left) kms_chamelium_color (ctm-negative)
[596.785683] Subtest ctm-negative: SKIP (0.000s)
[596.871251] [108/131] (450s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[596.921693] Starting subtest: etime-multi-wait-all-submitted-signaled
[597.033123] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[597.205051] [109/131] (450s left) kms_sequence (queue-busy)
[599.201534] Starting subtest: queue-busy
[599.202602] Starting dynamic subtest: pipe-A-HDMI-A-4
[601.784371] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.581s)
[601.798727] Starting dynamic subtest: pipe-B-HDMI-A-4
[604.194415] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.407s)
[604.209035] Starting dynamic subtest: pipe-C-HDMI-A-4
[606.604271] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.408s)
[606.618656] Starting dynamic subtest: pipe-D-HDMI-A-4
[609.023393] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.417s)
[609.024300] Subtest queue-busy: SUCCESS (9.823s)
[609.191326] [110/131] (438s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[611.205353] Starting subtest: x-tiled-64bpp-rotate-90
[611.266074] Subtest x-tiled-64bpp-rotate-90: SKIP (0.061s)
[611.484815] [111/131] (436s left) gem_exec_reloc (basic-gtt-noreloc)
[611.540010] Subtest basic-gtt-noreloc: SKIP (0.000s)
[611.644473] [112/131] (436s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[613.643090] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[613.644119] Starting dynamic subtest: pipe-A-HDMI-A-4
[613.653112] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[613.665472] Starting dynamic subtest: pipe-B-HDMI-A-4
[613.674409] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[613.686601] Starting dynamic subtest: pipe-C-HDMI-A-4
[613.696151] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[613.708280] Starting dynamic subtest: pipe-D-HDMI-A-4
[613.718217] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[613.720292] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.013s)
[613.885615] [113/131] (434s left) kms_content_protection (mei-interface)
[615.939606] Starting subtest: mei-interface
[616.211454] Subtest mei-interface: SKIP (0.269s)
[616.426615] [114/131] (431s left) kms_psr (psr2-sprite-plane-onoff)
[618.423842] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[618.503561] [115/131] (429s left) gem_ccs (block-copy-uncompressed)
[618.560965] Starting subtest: block-copy-uncompressed
[618.563542] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[618.596466] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.034s)
[618.610738] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[618.612797] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[618.627275] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[618.673502] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.059s)
[618.687745] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[618.732943] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.058s)
[618.747201] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[618.749493] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[618.763840] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-lmem0
[618.764986] Dynamic subtest ymajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[618.779203] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-smem
[618.825332] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.059s)
[618.839632] Starting dynamic subtest: ymajor-uncompressed-compfmt0-lmem0-lmem0
[618.885136] Dynamic subtest ymajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.059s)
[618.886104] Subtest block-copy-uncompressed: SUCCESS (0.325s)
[619.070484] [116/131] (429s left) gem_mmap_offset (mmap-boundaries)
[619.122896] Starting subtest: mmap-boundaries
[619.123857] Starting dynamic subtest: lmem0
[619.395575] Dynamic subtest lmem0: SUCCESS (0.269s)
[619.408705] Starting dynamic subtest: smem0
[621.227114] Dynamic subtest smem0: SUCCESS (1.830s)
[621.228150] Subtest mmap-boundaries: SUCCESS (2.102s)
[621.592589] [117/131] (426s left) kms_hdr (static-toggle-suspend)
[623.586283] Starting subtest: static-toggle-suspend
[623.589313] Subtest static-toggle-suspend: SKIP (0.001s)
[623.716835] [118/131] (424s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[625.729811] Starting subtest: flip-vs-cursor-toggle
[637.963476] Subtest flip-vs-cursor-toggle: SUCCESS (12.232s)
[638.153895] [119/131] (410s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[640.199545] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[640.308695] [120/131] (408s left) gem_exec_schedule (u-fairslice-all)
[640.376559] Starting subtest: u-fairslice-all
[642.466603] Subtest u-fairslice-all: SUCCESS (2.090s)
[642.945934] [121/131] (405s left) api_intel_allocator (fork-simple-once)
[642.997302] Starting subtest: fork-simple-once
[643.030529] Subtest fork-simple-once: SUCCESS (0.034s)
[643.221546] [122/131] (405s left) kms_3d
[646.226594] [123/131] (402s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[646.295005] Starting subtest: invalid-single-wait-all-unsubmitted
[646.296151] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[646.414600] [124/131] (402s left) prime_vgem (sync)
[646.504754] Starting subtest: sync
[646.508199] Starting dynamic subtest: rcs0
[646.589340] Dynamic subtest rcs0: SUCCESS (0.084s)
[646.604224] Starting dynamic subtest: bcs0
[646.655295] Dynamic subtest bcs0: SUCCESS (0.065s)
[646.672626] Starting dynamic subtest: vcs0
[646.702951] Dynamic subtest vcs0: SUCCESS (0.046s)
[646.723340] Starting dynamic subtest: vcs1
[646.746414] Dynamic subtest vcs1: SUCCESS (0.042s)
[646.766826] Starting dynamic subtest: vecs0
[646.788379] Dynamic subtest vecs0: SUCCESS (0.040s)
[646.789409] Subtest sync: SUCCESS (0.285s)
[647.005058] [125/131] (402s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[649.003453] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[649.005327] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[649.183997] [126/131] (400s left) kms_joiner (basic-force-big-joiner)
[651.187085] Starting subtest: basic-force-big-joiner
[651.191387] Subtest basic-force-big-joiner: SKIP (0.000s)
[651.310642] [127/131] (398s left) prime_self_import (reimport-vs-gem_close-race)
[651.374459] Starting subtest: reimport-vs-gem_close-race
[656.394516] Subtest reimport-vs-gem_close-race: SUCCESS (5.020s)
[656.593612] [128/131] (392s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[658.594126] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[658.595136] Starting dynamic subtest: pipe-A-HDMI-A-4
[658.604448] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[658.617800] Starting dynamic subtest: pipe-B-HDMI-A-4
[658.626939] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[658.639821] Starting dynamic subtest: pipe-C-HDMI-A-4
[658.649207] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[658.661950] Starting dynamic subtest: pipe-D-HDMI-A-4
[658.671296] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[658.673266] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[658.836741] [129/131] (390s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[660.834934] Starting subtest: flip-vs-cursor-busy-crc-legacy
[661.497806] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.659s)
[661.682015] [130/131] (387s left) kms_pm_rpm (cursor)
[666.160470] Starting subtest: cursor
[666.163440] Subtest cursor: SKIP (0.000s)
[667.330769] [131/131] (382s left) gem_ctx_engines (invalid-engines)
[667.396713] Starting subtest: invalid-engines
[667.415002] Subtest invalid-engines: SUCCESS (0.020s)
[667.739267] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_fbcon_fbt
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: kms_vblank
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: prime_mmap
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_pm_dc
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: gem_vm_create
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_atomic_transition
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_tiled_wb
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_sseu
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_lmem_evict
results: parsing output: 39/ for test: kms_atomic
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: tools_test
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: i915_module_load
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: gem_close
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: sysfs_heartbeat_interval
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: gem_lmem_swapping
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: drm_fdinfo
results: parsing output: 69/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_prime
results: parsing output: 77/ for test: gem_mmap_wc
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_dirtyfb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: prime_self_import
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: fbdev
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pxp
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_exec_endless
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_fenced_exec_thrash
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_display_modes
results: parsing output: 106/ for test: kms_chamelium_color
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_ccs
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: kms_3d
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_joiner
results: parsing output: 126/ for test: prime_self_import
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: gem_ctx_engines
Done.