[96.648886] Initializing watchdogs
[96.649253]   /dev/watchdog0
[96.686908] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[96.700796] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.709072] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.716942] [001/130] (960s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[97.607727] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[97.847679] [002/130] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[98.066837] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[98.069151] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[98.189617] [003/130] (959s left) prime_self_import (export-vs-gem_close-race)
[98.303548] Starting subtest: export-vs-gem_close-race
[103.322640] Subtest export-vs-gem_close-race: SUCCESS (5.018s)
[103.448838] [004/130] (954s left) kms_properties (get_properties-sanity-atomic)
[103.647192] Starting subtest: get_properties-sanity-atomic
[103.651437] Subtest get_properties-sanity-atomic: SUCCESS (0.008s)
[103.776684] [005/130] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[103.992374] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[107.036960] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (3.038s)
[107.231669] [006/130] (950s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[107.453121] Starting subtest: fbc-farfromfence-mmap-gtt
[110.558054] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (3.097s)
[110.797692] [007/130] (946s left) gem_exec_schedule (fifo)
[110.953774] Starting subtest: fifo
[110.954895] Starting dynamic subtest: rcs0
[111.072053] Dynamic subtest rcs0: SUCCESS (0.110s)
[111.090701] Starting dynamic subtest: bcs0
[111.189807] Dynamic subtest bcs0: SUCCESS (0.116s)
[111.207501] Starting dynamic subtest: vcs0
[111.299399] Dynamic subtest vcs0: SUCCESS (0.104s)
[111.313987] Starting dynamic subtest: vecs0
[111.388942] Dynamic subtest vecs0: SUCCESS (0.100s)
[111.390286] Subtest fifo: SUCCESS (0.432s)
[111.769499] [008/130] (946s left) gem_eio (in-flight-1us)
[111.919077] Starting subtest: in-flight-1us
[113.052313] Subtest in-flight-1us: SUCCESS (1.137s)
[113.365830] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[113.375450] [009/130] (944s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[113.668102] Starting subtest: cursorA-vs-flipB-legacy
[125.100372] Subtest cursorA-vs-flipB-legacy: SUCCESS (11.431s)
[125.474512] [010/130] (932s left) kms_properties (plane-properties-atomic)
[125.998764] Starting subtest: plane-properties-atomic
[126.007097] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.832621] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.817s)
[126.867521] Starting dynamic subtest: pipe-B-HDMI-A-2
[127.478603] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.644s)
[127.510317] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.191383] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.684s)
[128.196252] Subtest plane-properties-atomic: SUCCESS (2.186s)
[128.619380] [011/130] (929s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[128.896802] Starting subtest: short-flip-after-cursor-atomic-transitions
[130.255293] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.361s)
[130.686242] [012/130] (927s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[131.021206] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[131.263116] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.242s)
[131.652655] [013/130] (926s left) syncobj_wait (single-wait-all-signaled)
[131.867981] Starting subtest: single-wait-all-signaled
[131.870450] Subtest single-wait-all-signaled: SUCCESS (0.002s)
[132.012304] [014/130] (926s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[132.309613] Starting subtest: 2x-plain-flip-ts-check-interruptible
[132.321170] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[143.503261] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.174s)
[143.528492] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[154.456207] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.949s)
[154.472273] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[165.426209] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.969s)
[165.427310] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (33.112s)
[166.036197] [015/130] (892s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[166.242918] Starting subtest: fbcpsr-suspend
[166.246447] Subtest fbcpsr-suspend: SKIP (0.000s)
[166.391819] [016/130] (892s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[166.630907] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[166.638268] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[167.237697] [017/130] (891s left) kms_pm_rpm (modeset-non-lpsp-stress)
[169.156793] Starting subtest: modeset-non-lpsp-stress
[174.723471] Subtest modeset-non-lpsp-stress: SUCCESS (5.568s)
[175.024845] [018/130] (884s left) gem_exec_whisper (basic-fds-priority)
[175.168075] Starting subtest: basic-fds-priority
[184.769730] Subtest basic-fds-priority: SUCCESS (9.601s)
[185.036296] [019/130] (874s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[185.241792] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[185.345737] [020/130] (873s left) kms_dp_link_training (non-uhbr-sst)
[185.541719] Starting subtest: non-uhbr-sst
[185.549472] Subtest non-uhbr-sst: SKIP (0.001s)
[185.692938] [021/130] (873s left) gem_mmap_offset (pf-nonblock)
[185.803240] Starting subtest: pf-nonblock
[185.815603] Subtest pf-nonblock: SUCCESS (0.012s)
[185.969258] [022/130] (873s left) kms_vblank (wait-forked-busy-hang)
[186.164273] Starting subtest: wait-forked-busy-hang
[186.168171] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.953834] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.779s)
[193.977286] Starting dynamic subtest: pipe-A-HDMI-A-2
[200.933257] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.964s)
[200.959301] Starting dynamic subtest: pipe-C-HDMI-A-1
[207.964989] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.016s)
[208.000600] Starting dynamic subtest: pipe-C-HDMI-A-2
[214.926510] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.958s)
[214.937124] Subtest wait-forked-busy-hang: SUCCESS (28.764s)
[215.221755] [023/130] (844s left) kms_feature_discovery (chamelium)
[215.430267] Starting subtest: chamelium
[215.433235] Subtest chamelium: SKIP (0.001s)
[215.569107] [024/130] (844s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[215.766126] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[215.767193] Starting dynamic subtest: pipe-A
[216.134797] Dynamic subtest pipe-A: SUCCESS (0.362s)
[216.162637] Starting dynamic subtest: pipe-B
[216.557566] Dynamic subtest pipe-B: SUCCESS (0.425s)
[216.591248] Starting dynamic subtest: pipe-C
[216.654470] Dynamic subtest pipe-C: SUCCESS (0.089s)
[216.656935] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.886s)
[217.096227] [025/130] (842s left) gem_exec_fence (syncobj-timeline-unused-fence)
[217.787090] Starting subtest: syncobj-timeline-unused-fence
[217.790459] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[218.071854] [026/130] (841s left) kms_atomic_transition (modeset-transition)
[218.274332] Starting subtest: modeset-transition
[218.275394] Starting dynamic subtest: 1x-outputs
[221.673890] Dynamic subtest 1x-outputs: SUCCESS (3.397s)
[221.847424] Starting dynamic subtest: 2x-outputs
[228.904379] Dynamic subtest 2x-outputs: SUCCESS (7.072s)
[229.216471] Subtest modeset-transition: SUCCESS (10.939s)
[229.510564] [027/130] (830s left) drm_fdinfo (virtual-busy-idle-all)
[229.633740] Starting subtest: virtual-busy-idle-all
[229.638643] Subtest virtual-busy-idle-all: SUCCESS (0.003s)
[229.786344] [028/130] (830s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[229.997169] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[231.485487] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.485s)
[231.910841] [029/130] (828s left) gem_spin_batch (spin-each)
[232.050179] Starting subtest: spin-each
[235.458966] Subtest spin-each: SUCCESS (3.409s)
[235.737072] [030/130] (824s left) gem_fence_thrash (bo-write-verify-threaded-none)
[235.845513] Starting subtest: bo-write-verify-threaded-none
[241.148414] Subtest bo-write-verify-threaded-none: SUCCESS (5.300s)
[241.297508] [031/130] (818s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[241.500136] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[241.504419] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.510409] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[241.544424] Starting dynamic subtest: pipe-A-HDMI-A-2
[241.549742] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[241.585615] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.591540] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[241.618668] Starting dynamic subtest: pipe-B-HDMI-A-2
[241.623237] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[241.640928] Starting dynamic subtest: pipe-C-HDMI-A-1
[241.645473] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[241.664092] Starting dynamic subtest: pipe-C-HDMI-A-2
[241.668644] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[241.670935] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.026s)
[242.436259] [032/130] (817s left) core_auth (getclient-master-drop)
[242.554200] Starting subtest: getclient-master-drop
[242.559660] Subtest getclient-master-drop: SUCCESS (0.006s)
[242.707828] [033/130] (817s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[242.911356] Starting subtest: coverage-vs-premult-vs-constant
[243.174971] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.937160] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.760s)
[243.975590] Starting dynamic subtest: pipe-C-HDMI-A-1
[244.566086] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.621s)
[244.577132] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.657s)
[244.882400] [034/130] (815s left) kms_legacy_colorkey (basic)
[245.086946] Starting subtest: basic
[245.088077] Starting dynamic subtest: pipe-A
[245.125206] Dynamic subtest pipe-A: SUCCESS (0.038s)
[245.146028] Starting dynamic subtest: pipe-B
[245.164535] Dynamic subtest pipe-B: SUCCESS (0.036s)
[245.191212] Starting dynamic subtest: pipe-C
[245.192381] Dynamic subtest pipe-C: SUCCESS (0.018s)
[245.193436] Subtest basic: SUCCESS (0.100s)
[245.355607] [035/130] (815s left) gem_userptr_blits (unsync-unmap-cycles)
[245.482623] Subtest unsync-unmap-cycles: SKIP (0.000s)
[245.690462] [036/130] (815s left) kms_selftest (drm_dp_mst_helper)
[245.806073] Starting subtest: drm_dp_mst_helper
[245.823397] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[245.900844] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.074s)
[245.920334] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[246.005789] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[246.023827] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[246.108435] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.097s)
[246.109502] Subtest drm_dp_mst_helper: SUCCESS (0.299s)
[246.289462] [037/130] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[246.503932] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[246.506723] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[246.654859] [038/130] (814s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[246.784179] Starting subtest: untiled-to-tiled
[246.918698] Subtest untiled-to-tiled: SUCCESS (0.128s)
[247.078646] [039/130] (813s left) drm_fdinfo (context-close-stress)
[247.203156] Starting subtest: context-close-stress
[257.973464] Subtest context-close-stress: SUCCESS (10.769s)
[258.109464] [040/130] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[258.323081] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[258.325745] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[258.473163] [041/130] (802s left) gem_workarounds (suspend-resume)
[258.621845] Starting subtest: suspend-resume
[274.864082] Subtest suspend-resume: SUCCESS (1.131s)
[286.994160] [042/130] (801s left) kms_plane (plane-panning-top-left)
[287.193924] Starting subtest: plane-panning-top-left
[287.201502] Starting dynamic subtest: pipe-A
[288.504354] Dynamic subtest pipe-A: SUCCESS (1.292s)
[288.533249] Starting dynamic subtest: pipe-B
[289.670823] Dynamic subtest pipe-B: SUCCESS (1.171s)
[289.677662] Subtest plane-panning-top-left: SUCCESS (2.481s)
[290.176440] [043/130] (798s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[290.941716] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[291.314646] [044/130] (797s left) gem_exec_flush (basic-uc-set-default)
[291.546572] Starting subtest: basic-uc-set-default
[296.982864] Subtest basic-uc-set-default: SUCCESS (5.434s)
[297.265556] [045/130] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[297.515581] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[297.519342] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[297.667605] [046/130] (791s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[297.782127] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[297.896018] [047/130] (791s left) gem_ctx_sseu (engines)
[298.022762] Subtest engines: SKIP (0.000s)
[298.141033] [048/130] (791s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[298.360113] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[298.363638] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[298.513059] [049/130] (790s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[298.719917] Starting subtest: plane-upscale-20x20-with-modifiers
[298.723055] Starting dynamic subtest: pipe-A
[299.569674] Dynamic subtest pipe-A: SUCCESS (0.851s)
[299.595127] Starting dynamic subtest: pipe-B
[300.400540] Dynamic subtest pipe-B: SUCCESS (0.828s)
[300.425118] Starting dynamic subtest: pipe-C
[301.235526] Dynamic subtest pipe-C: SUCCESS (0.829s)
[301.237542] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.519s)
[301.744724] [050/130] (787s left) gem_exec_reloc (basic-wc-cpu)
[301.873695] Starting subtest: basic-wc-cpu
[301.892720] Subtest basic-wc-cpu: SUCCESS (0.017s)
[302.145898] [051/130] (787s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[302.358950] Starting subtest: y-tiled-8bpp-rotate-0
[305.700518] Subtest y-tiled-8bpp-rotate-0: SUCCESS (3.339s)
[306.088035] [052/130] (783s left) kms_invalid_mode (zero-vdisplay)
[306.340500] Starting subtest: zero-vdisplay
[306.341570] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.750026] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.427s)
[306.825967] Starting dynamic subtest: pipe-A-HDMI-A-2
[306.831702] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[306.873058] Starting dynamic subtest: pipe-B-HDMI-A-1
[306.874826] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[306.900770] Starting dynamic subtest: pipe-B-HDMI-A-2
[306.901941] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[306.923783] Starting dynamic subtest: pipe-C-HDMI-A-1
[306.924863] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[306.945716] Starting dynamic subtest: pipe-C-HDMI-A-2
[306.946838] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[306.947964] Subtest zero-vdisplay: SUCCESS (0.464s)
[307.081630] [053/130] (782s left) i915_pm_rpm (reg-read-ioctl)
[309.043710] Starting subtest: reg-read-ioctl
[309.381329] Subtest reg-read-ioctl: SUCCESS (0.339s)
[309.762120] [054/130] (780s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[309.960241] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[310.010114] Starting dynamic subtest: pipe-A-valid-mode
[310.348616] Dynamic subtest pipe-A-valid-mode: SKIP (0.381s)
[310.350790] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.387s)
[310.655925] [055/130] (779s left) kms_hdr (static-toggle-dpms)
[310.871283] Starting subtest: static-toggle-dpms
[310.881846] Subtest static-toggle-dpms: SKIP (0.003s)
[311.035321] [056/130] (778s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[311.275240] Starting subtest: cursor-rapid-movement-512x512
[311.283905] Subtest cursor-rapid-movement-512x512: SKIP (0.006s)
[311.452977] [057/130] (778s left) kms_vblank (ts-continuation-modeset-rpm)
[311.653986] Starting subtest: ts-continuation-modeset-rpm
[311.664109] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.974779] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.304s)
[314.003055] Starting dynamic subtest: pipe-A-HDMI-A-2
[315.032284] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.028s)
[315.065067] Starting dynamic subtest: pipe-C-HDMI-A-1
[315.906879] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.844s)
[315.928971] Starting dynamic subtest: pipe-C-HDMI-A-2
[316.888626] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.974s)
[316.930342] Subtest ts-continuation-modeset-rpm: SUCCESS (5.228s)
[317.166436] [058/130] (773s left) kms_cursor_crc (cursor-random-512x512)
[317.403456] Starting subtest: cursor-random-512x512
[317.411424] Subtest cursor-random-512x512: SKIP (0.005s)
[317.566969] [059/130] (772s left) gem_exec_fence (basic-await)
[317.846245] Starting subtest: basic-await
[317.847606] Starting dynamic subtest: rcs0
[317.975019] Dynamic subtest rcs0: SUCCESS (0.124s)
[317.996620] Starting dynamic subtest: bcs0
[318.101728] Dynamic subtest bcs0: SUCCESS (0.123s)
[318.128001] Starting dynamic subtest: vcs0
[318.233261] Dynamic subtest vcs0: SUCCESS (0.127s)
[318.259049] Starting dynamic subtest: vecs0
[318.369062] Dynamic subtest vecs0: SUCCESS (0.130s)
[318.370993] Subtest basic-await: SUCCESS (0.525s)
[319.070215] [060/130] (771s left) kms_setmode (invalid-clone-exclusive-crtc)
[319.206046] Starting subtest: invalid-clone-exclusive-crtc
[319.741828] Subtest invalid-clone-exclusive-crtc: SKIP (0.544s)
[320.024092] [061/130] (770s left) kms_flip (2x-absolute-wf_vblank)
[320.231109] Starting subtest: 2x-absolute-wf_vblank
[320.237102] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[331.176575] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.932s)
[331.206443] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[341.876822] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.698s)
[341.913278] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[352.587358] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.703s)
[352.591549] Subtest 2x-absolute-wf_vblank: SUCCESS (32.354s)
[353.200892] [062/130] (737s left) gem_basic (create-fd-close)
[353.317764] Starting subtest: create-fd-close
[353.323706] Subtest create-fd-close: SUCCESS (0.001s)
[353.485316] [063/130] (737s left) drm_read (short-buffer-block)
[353.954431] Starting subtest: short-buffer-block
[353.955635] Subtest short-buffer-block: SUCCESS (0.000s)
[354.229342] [064/130] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[354.453900] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[354.457176] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[354.611193] [065/130] (736s left) kms_psr (fbc-pr-sprite-plane-onoff)
[354.815542] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[354.927038] [066/130] (736s left) kms_psr (fbc-psr-sprite-blt)
[355.136128] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[355.247830] [067/130] (735s left) gem_eio (wait-wedge-1us)
[355.397467] Starting subtest: wait-wedge-1us
[355.489135] Subtest wait-wedge-1us: SUCCESS (0.096s)
[355.727017] [068/130] (735s left) gem_wait (await)
[355.883892] Starting subtest: await
[355.884950] Starting dynamic subtest: all-engines
[356.932365] Dynamic subtest all-engines: SUCCESS (1.048s)
[356.958016] Starting dynamic subtest: rcs0
[357.978260] Dynamic subtest rcs0: SUCCESS (1.040s)
[358.003854] Starting dynamic subtest: bcs0
[359.023637] Dynamic subtest bcs0: SUCCESS (1.038s)
[359.046451] Starting dynamic subtest: vcs0
[360.063107] Dynamic subtest vcs0: SUCCESS (1.036s)
[360.085634] Starting dynamic subtest: vecs0
[361.103096] Dynamic subtest vecs0: SUCCESS (1.037s)
[361.104525] Subtest await: SUCCESS (5.219s)
[361.444797] [069/130] (729s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[361.640408] Starting subtest: bad-pixel-format-y-tiled-ccs
[361.648858] Starting dynamic subtest: pipe-A-HDMI-A-1
[361.666428] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[361.764522] Starting dynamic subtest: pipe-A-HDMI-A-2
[361.798705] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[361.820326] Starting dynamic subtest: pipe-B-HDMI-A-1
[361.831775] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[361.855459] Starting dynamic subtest: pipe-B-HDMI-A-2
[361.865908] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[361.887193] Starting dynamic subtest: pipe-C-HDMI-A-1
[361.898516] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[361.919686] Starting dynamic subtest: pipe-C-HDMI-A-2
[361.930880] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[361.931986] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.062s)
[362.607053] [070/130] (728s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[362.819575] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[362.827465] Starting dynamic subtest: pipe-A-HDMI-A-1
[362.844810] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[362.940721] Starting dynamic subtest: pipe-A-HDMI-A-2
[362.977354] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[362.998340] Starting dynamic subtest: pipe-B-HDMI-A-1
[363.009818] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[363.030853] Starting dynamic subtest: pipe-B-HDMI-A-2
[363.043887] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.021s)
[363.065332] Starting dynamic subtest: pipe-C-HDMI-A-1
[363.076702] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[363.097759] Starting dynamic subtest: pipe-C-HDMI-A-2
[363.109206] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[363.111533] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.058s)
[363.781247] [071/130] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[364.019801] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[364.023872] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[364.172717] [072/130] (727s left) sw_sync (alloc_fence)
[364.290341] Starting subtest: alloc_fence
[364.294436] Subtest alloc_fence: SUCCESS (0.001s)
[364.423694] [073/130] (727s left) gem_exec_store (basic)
[364.564266] Starting subtest: basic
[364.621107] Subtest basic: SUCCESS (0.056s)
[364.909105] [074/130] (726s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[365.028233] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[365.146655] [075/130] (726s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[365.358787] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[365.477952] [076/130] (726s left) sw_sync (alloc_timeline)
[365.596449] Starting subtest: alloc_timeline
[365.597570] Subtest alloc_timeline: SUCCESS (0.000s)
[365.740275] [077/130] (726s left) kms_cursor_legacy (forked-bo)
[365.946585] Starting subtest: forked-bo
[365.947794] Starting dynamic subtest: pipe-A
[371.449457] Dynamic subtest pipe-A: SUCCESS (5.496s)
[371.490783] Starting dynamic subtest: pipe-B
[376.879897] Dynamic subtest pipe-B: SUCCESS (5.428s)
[376.903419] Starting dynamic subtest: pipe-C
[382.312807] Dynamic subtest pipe-C: SUCCESS (5.430s)
[382.374652] Starting dynamic subtest: all-pipes
[387.757487] Dynamic subtest all-pipes: SUCCESS (5.438s)
[387.758978] Subtest forked-bo: SUCCESS (21.807s)
[387.933207] [078/130] (704s left) gen3_render_mixed_blits
[388.161774] [079/130] (704s left) gem_exec_schedule (pi-distinct-iova)
[388.443584] Starting subtest: pi-distinct-iova
[388.444763] Starting dynamic subtest: rcs0
[388.499280] Dynamic subtest rcs0: SUCCESS (0.052s)
[388.534327] Starting dynamic subtest: bcs0
[388.564595] Dynamic subtest bcs0: SUCCESS (0.061s)
[388.597029] Starting dynamic subtest: vcs0
[388.619707] Dynamic subtest vcs0: SUCCESS (0.050s)
[388.656038] Starting dynamic subtest: vecs0
[388.670860] Dynamic subtest vecs0: SUCCESS (0.045s)
[388.672134] Subtest pi-distinct-iova: SUCCESS (0.227s)
[388.977293] [080/130] (703s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[389.203056] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[391.698322] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.491s)
[391.975052] [081/130] (700s left) gem_softpin (32b-excludes-last-page)
[392.098621] Starting subtest: 32b-excludes-last-page
[392.103211] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[392.254577] [082/130] (700s left) perf_pmu (invalid-open)
[392.377118] Starting subtest: invalid-open
[392.381447] Subtest invalid-open: SUCCESS (0.001s)
[392.540516] [083/130] (700s left) gem_pxp (display-protected-crc)
[395.197489] Starting subtest: display-protected-crc
[395.200144] Subtest display-protected-crc: SKIP (0.000s)
[395.340301] [084/130] (697s left) gem_ctx_engines (invalid-engines)
[395.487617] Starting subtest: invalid-engines
[395.501184] Subtest invalid-engines: SUCCESS (0.016s)
[395.759466] [085/130] (697s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[395.875243] Starting subtest: multi-wait-for-submit-available-signaled
[395.876316] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[396.020721] [086/130] (697s left) gem_exec_balancer (invalid-bonds)
[396.199013] Starting subtest: invalid-bonds
[396.233588] Subtest invalid-bonds: SUCCESS (0.032s)
[396.523561] [087/130] (696s left) gem_huc_copy (huc-copy)
[396.657456] Starting subtest: huc-copy
[396.660306] Subtest huc-copy: SKIP (0.001s)
[396.801186] [088/130] (696s left) api_intel_allocator (fork-simple-stress-signal)
[396.911581] Starting subtest: fork-simple-stress-signal
[402.479316] Subtest fork-simple-stress-signal: SUCCESS (5.566s)
[402.643953] [089/130] (690s left) kms_content_protection (srm)
[402.885108] Starting subtest: srm
[404.580682] Subtest srm: SKIP (1.689s)
[405.069905] [090/130] (688s left) kms_prop_blob (blob-prop-lifetime)
[405.184698] Starting subtest: blob-prop-lifetime
[405.186229] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[405.342305] [091/130] (688s left) gem_mmap_gtt (big-bo-tiledy)
[405.460731] Starting subtest: big-bo-tiledY
[407.291194] Subtest big-bo-tiledY: SUCCESS (1.804s)
[407.508056] [092/130] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[407.877291] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[407.880984] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[408.024989] [093/130] (685s left) kms_psr (psr2-dpms)
[408.223742] Subtest psr2-dpms: SKIP (0.000s)
[408.344326] [094/130] (685s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[408.479409] Starting subtest: multi-wait-all-for-submit-signaled
[408.480637] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.003s)
[408.643492] [095/130] (685s left) gem_mmap_wc (read-write-distinct)
[408.759179] Starting subtest: read-write-distinct
[408.791500] Subtest read-write-distinct: SUCCESS (0.029s)
[408.963874] [096/130] (685s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[409.082714] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[409.190461] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[409.345439] [097/130] (684s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[409.483419] Starting subtest: yf-tiled-ccs-to-y-tiled
[409.484661] Starting dynamic subtest: smem
[409.757236] Dynamic subtest smem: SUCCESS (0.271s)
[409.758644] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.274s)
[410.039148] [098/130] (684s left) kms_big_fb (linear-8bpp-rotate-270)
[410.258309] Starting subtest: linear-8bpp-rotate-270
[410.568940] Subtest linear-8bpp-rotate-270: SKIP (0.306s)
[410.836059] [099/130] (683s left) kms_psr (fbc-psr2-primary-page-flip)
[411.040716] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[411.162668] [100/130] (683s left) kms_addfb_basic (unused-handle)
[411.308488] Starting subtest: unused-handle
[411.309612] Subtest unused-handle: SUCCESS (0.000s)
[411.556896] [101/130] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[411.777136] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[415.094841] Subtest fbc-2p-primscrn-spr-indfb-move: SUCCESS (3.315s)
[415.314576] [102/130] (679s left) sw_sync (sync_expired_merge)
[415.428303] Starting subtest: sync_expired_merge
[416.505804] Subtest sync_expired_merge: SUCCESS (1.074s)
[416.642003] [103/130] (678s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[416.756334] Starting subtest: single-wait-for-submit-unsubmitted
[416.863506] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[417.009911] [104/130] (677s left) gem_ctx_persistence (heartbeat-hang)
[417.140557] Starting subtest: heartbeat-hang
[418.289805] Subtest heartbeat-hang: SUCCESS (1.146s)
[418.442978] [105/130] (676s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[419.023629] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[419.293025] [106/130] (675s left) kms_psr (psr-primary-blt)
[419.504034] Subtest psr-primary-blt: SKIP (0.000s)
[419.620633] [107/130] (675s left) perf (non-zero-reason)
[419.873101] Starting subtest: non-zero-reason
[419.874464] Starting dynamic subtest: 0-rcs0
[470.193674] Dynamic subtest 0-rcs0: SUCCESS (50.315s)
[470.195645] Subtest non-zero-reason: SUCCESS (50.318s)
[470.316549] [108/130] (624s left) gem_ccs (block-multicopy-inplace)
[470.441238] Subtest block-multicopy-inplace: SKIP (0.000s)
[470.569273] [109/130] (624s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[470.767106] Starting subtest: plane-all-transition-nonblocking-fencing
[470.768248] Starting dynamic subtest: pipe-A-HDMI-A-1
[474.771671] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.003s)
[474.979866] Starting dynamic subtest: pipe-A-HDMI-A-2
[478.822447] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.872s)
[479.027737] Starting dynamic subtest: pipe-B-HDMI-A-1
[482.893446] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.887s)
[483.086094] Starting dynamic subtest: pipe-B-HDMI-A-2
[486.924037] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.870s)
[487.083704] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (16.316s)
[487.389049] [110/130] (608s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[487.623425] Starting subtest: psr-rgb101010-draw-mmap-gtt
[487.627175] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[487.775945] [111/130] (607s left) kms_async_flips (invalid-async-flip)
[487.981050] Starting subtest: invalid-async-flip
[488.542314] Starting dynamic subtest: pipe-A-HDMI-A-1
[488.862428] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.309s)
[489.161783] Starting dynamic subtest: pipe-A-HDMI-A-2
[489.471447] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.328s)
[489.762173] Starting dynamic subtest: pipe-B-HDMI-A-1
[490.070430] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.324s)
[490.372811] Starting dynamic subtest: pipe-B-HDMI-A-2
[490.689596] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.330s)
[490.984290] Starting dynamic subtest: pipe-C-HDMI-A-1
[491.261445] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.294s)
[491.581623] Starting dynamic subtest: pipe-C-HDMI-A-2
[491.865215] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.302s)
[491.879421] Subtest invalid-async-flip: SUCCESS (3.884s)
[492.435748] [112/130] (603s left) syncobj_wait (wait-any-interrupted)
[492.563586] Starting subtest: wait-any-interrupted
[492.669173] Subtest wait-any-interrupted: SUCCESS (0.103s)
[492.822625] [113/130] (602s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[493.042328] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[494.372141] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.328s)
[494.773805] [114/130] (601s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[494.998665] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[495.003966] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[495.156028] [115/130] (600s left) syncobj_wait (wait-for-submit-delayed-submit)
[495.277867] Starting subtest: wait-for-submit-delayed-submit
[495.386497] Subtest wait-for-submit-delayed-submit: SUCCESS (0.106s)
[495.539744] [116/130] (600s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[495.660443] Starting subtest: invalid-multi-wait-unsubmitted
[495.661750] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[495.808695] [117/130] (600s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[496.019604] Starting subtest: fbc-rgb101010-draw-mmap-wc
[499.056183] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.036s)
[499.336871] [118/130] (596s left) gem_ctx_bad_destroy (invalid-pad)
[499.452072] Starting subtest: invalid-pad
[499.456104] Subtest invalid-pad: SUCCESS (0.000s)
[499.619271] [119/130] (596s left) gem_mmap_gtt (cpuset-big-copy)
[499.737779] Starting subtest: cpuset-big-copy
[516.607698] Subtest cpuset-big-copy: SUCCESS (16.870s)
[517.005668] [120/130] (579s left) kms_cursor_crc (cursor-size-change)
[517.358565] Starting subtest: cursor-size-change
[517.365012] Starting dynamic subtest: pipe-A-HDMI-A-1
[518.577155] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.209s)
[518.629003] Starting dynamic subtest: pipe-C-HDMI-A-1
[519.395690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.799s)
[519.396947] Subtest cursor-size-change: SUCCESS (2.028s)
[519.729022] [121/130] (576s left) gem_exec_flush (basic-batch-kernel-default-uc)
[519.880261] Starting subtest: basic-batch-kernel-default-uc
[525.512403] Subtest basic-batch-kernel-default-uc: SUCCESS (5.634s)
[525.787440] [122/130] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[526.003146] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[526.005773] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[526.161240] [123/130] (570s left) i915_pm_rpm (gem-evict-pwrite)
[528.103481] Starting subtest: gem-evict-pwrite
[529.118323] Subtest gem-evict-pwrite: SUCCESS (1.013s)
[529.587026] [124/130] (567s left) gem_ctx_persistence (legacy-engines-mixed-process)
[529.717665] Starting subtest: legacy-engines-mixed-process
[529.722748] Starting dynamic subtest: render
[530.136076] Dynamic subtest render: SUCCESS (0.411s)
[530.192627] Starting dynamic subtest: bsd
[530.585699] Dynamic subtest bsd: SUCCESS (0.439s)
[530.629220] Starting dynamic subtest: blt
[530.986300] Dynamic subtest blt: SUCCESS (0.394s)
[531.042273] Starting dynamic subtest: vebox
[531.386442] Dynamic subtest vebox: SUCCESS (0.385s)
[531.387686] Subtest legacy-engines-mixed-process: SUCCESS (1.667s)
[531.583841] [125/130] (565s left) i915_query (query-regions-unallocated)
[531.698332] Starting subtest: query-regions-unallocated
[531.699603] Subtest query-regions-unallocated: SUCCESS (0.000s)
[531.843968] [126/130] (565s left) perf (gen8-unprivileged-single-ctx-counters)
[532.106160] Starting subtest: gen8-unprivileged-single-ctx-counters
[532.269824] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.166s)
[532.395721] [127/130] (564s left) kms_chamelium_color (ctm-0-25)
[532.595759] Subtest ctm-0-25: SKIP (0.000s)
[532.722860] [128/130] (564s left) gem_exec_reloc (basic-range)
[532.853603] Starting subtest: basic-range
[532.924462] Subtest basic-range: SUCCESS (0.063s)
[533.171793] [129/130] (564s left) syncobj_timeline (wait-for-submit-complex)
[533.296615] Starting subtest: wait-for-submit-complex
[533.367009] Subtest wait-for-submit-complex: SUCCESS (0.068s)
[533.523098] [130/130] (563s left) gen9_exec_parse (bb-oversize)
[533.662462] Starting subtest: bb-oversize
[533.814648] Subtest bb-oversize: SKIP (0.126s)
[534.115210] Closing watchdogs
Done.