[87.786956] Initializing watchdogs
[87.787311]   /dev/watchdog0
[87.826087] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.840252] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.847149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.855764] [001/130] (960s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[88.461362] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[88.697849] [002/130] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[88.921627] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[88.929963] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[89.055747] [003/130] (959s left) prime_self_import (export-vs-gem_close-race)
[89.184288] Starting subtest: export-vs-gem_close-race
[94.199474] Subtest export-vs-gem_close-race: SUCCESS (5.020s)
[94.333863] [004/130] (954s left) kms_properties (get_properties-sanity-atomic)
[94.546104] Starting subtest: get_properties-sanity-atomic
[94.549605] Subtest get_properties-sanity-atomic: SUCCESS (0.007s)
[94.670392] [005/130] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[94.894589] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[97.910644] Subtest fbc-2p-primscrn-cur-indfb-move: SUCCESS (3.022s)
[98.111607] [006/130] (950s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[98.336336] Starting subtest: fbc-farfromfence-mmap-gtt
[101.484498] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (3.142s)
[101.727976] [007/130] (947s left) gem_exec_schedule (fifo)
[101.887587] Starting subtest: fifo
[101.891083] Starting dynamic subtest: rcs0
[102.007192] Dynamic subtest rcs0: SUCCESS (0.113s)
[102.025450] Starting dynamic subtest: bcs0
[102.128448] Dynamic subtest bcs0: SUCCESS (0.122s)
[102.147751] Starting dynamic subtest: vcs0
[102.231517] Dynamic subtest vcs0: SUCCESS (0.106s)
[102.247967] Starting dynamic subtest: vecs0
[102.343219] Dynamic subtest vecs0: SUCCESS (0.110s)
[102.348835] Subtest fifo: SUCCESS (0.453s)
[102.724165] [008/130] (946s left) gem_eio (in-flight-1us)
[102.877448] Starting subtest: in-flight-1us
[103.803255] Subtest in-flight-1us: SUCCESS (0.936s)
[104.027041] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[104.035550] [009/130] (945s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[104.255843] Starting subtest: cursorA-vs-flipB-legacy
[115.541626] Subtest cursorA-vs-flipB-legacy: SUCCESS (11.284s)
[115.822102] [010/130] (933s left) kms_properties (plane-properties-atomic)
[116.022308] Starting subtest: plane-properties-atomic
[116.025728] Starting dynamic subtest: pipe-A-HDMI-A-1
[116.761123] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.732s)
[116.778346] Starting dynamic subtest: pipe-B-HDMI-A-2
[117.359226] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.592s)
[117.376538] Starting dynamic subtest: pipe-C-HDMI-A-1
[117.946223] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.582s)
[117.950273] Subtest plane-properties-atomic: SUCCESS (1.917s)
[118.221544] [011/130] (931s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[118.432399] Starting subtest: short-flip-after-cursor-atomic-transitions
[119.704836] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.275s)
[120.000958] [012/130] (929s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[120.231257] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[120.449975] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.214s)
[120.683733] [013/130] (928s left) syncobj_wait (single-wait-all-signaled)
[120.818119] Starting subtest: single-wait-all-signaled
[120.822197] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[120.956932] [014/130] (928s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[121.171731] Starting subtest: 2x-plain-flip-ts-check-interruptible
[121.178960] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[132.189641] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.008s)
[132.207290] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[143.156324] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.965s)
[143.175528] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[154.099056] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.933s)
[154.106092] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (32.920s)
[154.686769] [015/130] (894s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[154.915436] Starting subtest: fbcpsr-suspend
[154.922550] Subtest fbcpsr-suspend: SKIP (0.000s)
[155.113977] [016/130] (894s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[155.369256] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[155.414932] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[155.959858] [017/130] (893s left) kms_pm_rpm (modeset-non-lpsp-stress)
[157.893313] Starting subtest: modeset-non-lpsp-stress
[163.272686] Subtest modeset-non-lpsp-stress: SUCCESS (5.379s)
[163.594632] [018/130] (886s left) gem_exec_whisper (basic-fds-priority)
[163.749337] Starting subtest: basic-fds-priority
[174.378719] Subtest basic-fds-priority: SUCCESS (10.626s)
[174.638377] [019/130] (875s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[174.878632] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[174.970869] [020/130] (875s left) kms_dp_link_training (non-uhbr-sst)
[175.167492] Starting subtest: non-uhbr-sst
[175.189983] Subtest non-uhbr-sst: SKIP (0.001s)
[175.314080] [021/130] (874s left) gem_mmap_offset (pf-nonblock)
[175.434082] Starting subtest: pf-nonblock
[175.444077] Subtest pf-nonblock: SUCCESS (0.012s)
[175.602571] [022/130] (874s left) kms_vblank (wait-forked-busy-hang)
[175.809217] Starting subtest: wait-forked-busy-hang
[175.812946] Starting dynamic subtest: pipe-A-HDMI-A-1
[182.961313] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.141s)
[183.000238] Starting dynamic subtest: pipe-A-HDMI-A-2
[189.938836] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.967s)
[189.997399] Starting dynamic subtest: pipe-C-HDMI-A-1
[196.957883] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.012s)
[196.998491] Starting dynamic subtest: pipe-C-HDMI-A-2
[203.935520] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.966s)
[203.938830] Subtest wait-forked-busy-hang: SUCCESS (28.126s)
[204.221746] [023/130] (846s left) kms_feature_discovery (chamelium)
[204.433908] Starting subtest: chamelium
[204.440925] Subtest chamelium: SKIP (0.000s)
[204.571509] [024/130] (845s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[204.776135] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[204.780147] Starting dynamic subtest: pipe-A
[205.113085] Dynamic subtest pipe-A: SUCCESS (0.336s)
[205.144970] Starting dynamic subtest: pipe-B
[205.544997] Dynamic subtest pipe-B: SUCCESS (0.429s)
[205.584563] Starting dynamic subtest: pipe-C
[205.630381] Dynamic subtest pipe-C: SUCCESS (0.085s)
[205.636118] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.856s)
[206.065474] [025/130] (844s left) gem_exec_fence (syncobj-timeline-unused-fence)
[206.753924] Starting subtest: syncobj-timeline-unused-fence
[206.762849] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[207.051177] [026/130] (843s left) kms_atomic_transition (modeset-transition)
[207.252272] Starting subtest: modeset-transition
[207.255302] Starting dynamic subtest: 1x-outputs
[210.650054] Dynamic subtest 1x-outputs: SUCCESS (3.399s)
[210.825028] Starting dynamic subtest: 2x-outputs
[217.878938] Dynamic subtest 2x-outputs: SUCCESS (7.071s)
[218.195670] Subtest modeset-transition: SUCCESS (10.941s)
[218.492125] [027/130] (832s left) drm_fdinfo (virtual-busy-idle-all)
[218.627892] Starting subtest: virtual-busy-idle-all
[218.632559] Subtest virtual-busy-idle-all: SUCCESS (0.001s)
[218.788672] [028/130] (832s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[219.364663] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[220.563490] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.488s)
[220.975617] [029/130] (830s left) gem_spin_batch (spin-each)
[221.126270] Starting subtest: spin-each
[224.532726] Subtest spin-each: SUCCESS (3.407s)
[224.800130] [030/130] (826s left) gem_fence_thrash (bo-write-verify-threaded-none)
[224.919804] Starting subtest: bo-write-verify-threaded-none
[230.208659] Subtest bo-write-verify-threaded-none: SUCCESS (5.295s)
[230.384657] [031/130] (820s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[230.588849] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[230.592178] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.606777] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[230.690978] Starting dynamic subtest: pipe-A-HDMI-A-2
[230.724102] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[230.743541] Starting dynamic subtest: pipe-B-HDMI-A-1
[230.757123] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[230.776844] Starting dynamic subtest: pipe-B-HDMI-A-2
[230.790492] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[230.810024] Starting dynamic subtest: pipe-C-HDMI-A-1
[230.823322] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[230.842815] Starting dynamic subtest: pipe-C-HDMI-A-2
[230.856141] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[230.862707] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.043s)
[231.531878] [032/130] (819s left) core_auth (getclient-master-drop)
[231.658061] Starting subtest: getclient-master-drop
[231.664671] Subtest getclient-master-drop: SUCCESS (0.005s)
[231.813717] [033/130] (819s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[232.011881] Starting subtest: coverage-vs-premult-vs-constant
[232.265603] Starting dynamic subtest: pipe-A-HDMI-A-1
[232.987972] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.723s)
[233.057178] Starting dynamic subtest: pipe-C-HDMI-A-1
[233.643103] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.630s)
[233.647054] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.619s)
[233.948546] [034/130] (817s left) kms_legacy_colorkey (basic)
[234.151804] Starting subtest: basic
[234.155082] Starting dynamic subtest: pipe-A
[234.186467] Dynamic subtest pipe-A: SUCCESS (0.034s)
[234.206476] Starting dynamic subtest: pipe-B
[234.225226] Dynamic subtest pipe-B: SUCCESS (0.035s)
[234.248684] Starting dynamic subtest: pipe-C
[234.252110] Dynamic subtest pipe-C: SUCCESS (0.001s)
[234.256885] Subtest basic: SUCCESS (0.077s)
[234.379460] [035/130] (817s left) gem_userptr_blits (unsync-unmap-cycles)
[234.520569] Subtest unsync-unmap-cycles: SKIP (0.000s)
[234.719925] [036/130] (817s left) kms_selftest (drm_dp_mst_helper)
[234.844936] Starting subtest: drm_dp_mst_helper
[234.864084] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[234.928932] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.068s)
[234.949245] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[235.023280] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.086s)
[235.044214] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[235.113577] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.088s)
[235.117589] Subtest drm_dp_mst_helper: SUCCESS (0.268s)
[235.302298] [037/130] (816s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[235.530688] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[235.537508] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[235.685339] [038/130] (816s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[235.821706] Starting subtest: untiled-to-tiled
[235.951311] Subtest untiled-to-tiled: SUCCESS (0.124s)
[236.109179] [039/130] (815s left) drm_fdinfo (context-close-stress)
[236.237598] Starting subtest: context-close-stress
[247.003406] Subtest context-close-stress: SUCCESS (10.767s)
[247.155841] [040/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[247.386381] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[247.395403] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.535292] [041/130] (804s left) gem_workarounds (suspend-resume)
[247.695274] Starting subtest: suspend-resume
[263.367638] Subtest suspend-resume: SUCCESS (1.131s)
[272.512506] [042/130] (803s left) kms_plane (plane-panning-top-left)
[272.735734] Starting subtest: plane-panning-top-left
[272.739027] Starting dynamic subtest: pipe-A
[273.940992] Dynamic subtest pipe-A: SUCCESS (1.203s)
[273.965356] Starting dynamic subtest: pipe-B
[274.830158] Dynamic subtest pipe-B: SUCCESS (0.877s)
[274.868367] Subtest plane-panning-top-left: SUCCESS (2.091s)
[275.117734] [043/130] (800s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[275.698835] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[275.966720] [044/130] (800s left) gem_exec_flush (basic-uc-set-default)
[276.120654] Starting subtest: basic-uc-set-default
[281.550138] Subtest basic-uc-set-default: SUCCESS (5.429s)
[281.837184] [045/130] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[282.058699] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[282.065303] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[282.219415] [046/130] (794s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[282.350560] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[282.468439] [047/130] (793s left) gem_ctx_sseu (engines)
[282.603616] Subtest engines: SKIP (0.000s)
[282.720219] [048/130] (793s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[282.945008] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[282.952965] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[283.086717] [049/130] (793s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[283.297170] Starting subtest: plane-upscale-20x20-with-modifiers
[283.301704] Starting dynamic subtest: pipe-A
[284.104372] Dynamic subtest pipe-A: SUCCESS (0.813s)
[284.128979] Starting dynamic subtest: pipe-B
[284.917715] Dynamic subtest pipe-B: SUCCESS (0.809s)
[284.989625] Starting dynamic subtest: pipe-C
[285.732735] Dynamic subtest pipe-C: SUCCESS (0.812s)
[285.737005] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.444s)
[286.230962] [050/130] (790s left) gem_exec_reloc (basic-wc-cpu)
[286.368327] Starting subtest: basic-wc-cpu
[286.389326] Subtest basic-wc-cpu: SUCCESS (0.019s)
[286.628159] [051/130] (790s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[286.852391] Starting subtest: y-tiled-8bpp-rotate-0
[290.164536] Subtest y-tiled-8bpp-rotate-0: SUCCESS (3.311s)
[290.523104] [052/130] (786s left) kms_invalid_mode (zero-vdisplay)
[290.750250] Starting subtest: zero-vdisplay
[290.756259] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.111406] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.381s)
[291.143686] Starting dynamic subtest: pipe-A-HDMI-A-2
[291.146845] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[291.172993] Starting dynamic subtest: pipe-B-HDMI-A-1
[291.177500] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[291.238035] Starting dynamic subtest: pipe-B-HDMI-A-2
[291.241488] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[291.283203] Starting dynamic subtest: pipe-C-HDMI-A-1
[291.286757] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[291.310043] Starting dynamic subtest: pipe-C-HDMI-A-2
[291.313362] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[291.316667] Subtest zero-vdisplay: SUCCESS (0.443s)
[291.472047] [053/130] (785s left) i915_pm_rpm (reg-read-ioctl)
[293.430295] Starting subtest: reg-read-ioctl
[293.759948] Subtest reg-read-ioctl: SUCCESS (0.335s)
[294.119624] [054/130] (782s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[294.384688] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[294.393601] Starting dynamic subtest: pipe-A-valid-mode
[294.761619] Dynamic subtest pipe-A-valid-mode: SKIP (0.366s)
[294.800490] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.372s)
[294.987789] [055/130] (782s left) kms_hdr (static-toggle-dpms)
[295.217142] Starting subtest: static-toggle-dpms
[295.231782] Subtest static-toggle-dpms: SKIP (0.002s)
[295.352864] [056/130] (781s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[295.585986] Starting subtest: cursor-rapid-movement-512x512
[295.594765] Subtest cursor-rapid-movement-512x512: SKIP (0.004s)
[295.753894] [057/130] (781s left) kms_vblank (ts-continuation-modeset-rpm)
[295.952398] Starting subtest: ts-continuation-modeset-rpm
[295.955830] Starting dynamic subtest: pipe-A-HDMI-A-1
[298.263551] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.309s)
[298.297248] Starting dynamic subtest: pipe-A-HDMI-A-2
[299.283051] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.009s)
[299.322307] Starting dynamic subtest: pipe-C-HDMI-A-1
[300.174036] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.871s)
[300.220722] Starting dynamic subtest: pipe-C-HDMI-A-2
[301.140449] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.960s)
[301.144220] Subtest ts-continuation-modeset-rpm: SUCCESS (5.187s)
[301.430077] [058/130] (776s left) kms_cursor_crc (cursor-random-512x512)
[301.674961] Starting subtest: cursor-random-512x512
[301.683724] Subtest cursor-random-512x512: SKIP (0.004s)
[301.847688] [059/130] (775s left) gem_exec_fence (basic-await)
[302.139348] Starting subtest: basic-await
[302.142959] Starting dynamic subtest: rcs0
[302.268331] Dynamic subtest rcs0: SUCCESS (0.127s)
[302.294495] Starting dynamic subtest: bcs0
[302.398297] Dynamic subtest bcs0: SUCCESS (0.125s)
[302.422979] Starting dynamic subtest: vcs0
[302.527826] Dynamic subtest vcs0: SUCCESS (0.124s)
[302.553836] Starting dynamic subtest: vecs0
[302.654255] Dynamic subtest vecs0: SUCCESS (0.123s)
[302.659963] Subtest basic-await: SUCCESS (0.517s)
[303.349039] [060/130] (774s left) kms_setmode (invalid-clone-exclusive-crtc)
[303.499716] Starting subtest: invalid-clone-exclusive-crtc
[304.090485] Subtest invalid-clone-exclusive-crtc: SKIP (0.567s)
[304.326508] [061/130] (773s left) kms_flip (2x-absolute-wf_vblank)
[304.903296] Starting subtest: 2x-absolute-wf_vblank
[304.969254] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[315.574486] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.903s)
[315.606432] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[326.264075] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.685s)
[326.295038] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[337.124157] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.848s)
[337.127436] Subtest 2x-absolute-wf_vblank: SUCCESS (32.459s)
[337.768981] [062/130] (740s left) gem_basic (create-fd-close)
[337.898971] Starting subtest: create-fd-close
[337.906795] Subtest create-fd-close: SUCCESS (0.000s)
[338.046532] [063/130] (739s left) drm_read (short-buffer-block)
[338.500579] Starting subtest: short-buffer-block
[338.503843] Subtest short-buffer-block: SUCCESS (0.000s)
[338.778996] [064/130] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[339.007599] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[339.014945] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[339.161816] [065/130] (739s left) kms_psr (fbc-pr-sprite-plane-onoff)
[339.381626] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[339.502142] [066/130] (738s left) kms_psr (fbc-psr-sprite-blt)
[339.716717] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[339.839905] [067/130] (738s left) gem_eio (wait-wedge-1us)
[339.995060] Starting subtest: wait-wedge-1us
[340.111708] Subtest wait-wedge-1us: SUCCESS (0.117s)
[340.376460] [068/130] (738s left) gem_wait (await)
[340.541533] Starting subtest: await
[340.547131] Starting dynamic subtest: all-engines
[341.584846] Dynamic subtest all-engines: SUCCESS (1.040s)
[341.610243] Starting dynamic subtest: rcs0
[342.617147] Dynamic subtest rcs0: SUCCESS (1.029s)
[342.641611] Starting dynamic subtest: bcs0
[343.653235] Dynamic subtest bcs0: SUCCESS (1.034s)
[343.677916] Starting dynamic subtest: vcs0
[344.692100] Dynamic subtest vcs0: SUCCESS (1.035s)
[344.717840] Starting dynamic subtest: vecs0
[345.728380] Dynamic subtest vecs0: SUCCESS (1.030s)
[345.731671] Subtest await: SUCCESS (5.187s)
[346.037068] [069/130] (732s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[346.246152] Starting subtest: bad-pixel-format-y-tiled-ccs
[346.249495] Starting dynamic subtest: pipe-A-HDMI-A-1
[346.286185] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[346.373702] Starting dynamic subtest: pipe-A-HDMI-A-2
[346.408972] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[346.432707] Starting dynamic subtest: pipe-B-HDMI-A-1
[346.460313] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[346.484559] Starting dynamic subtest: pipe-B-HDMI-A-2
[346.511389] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[346.534691] Starting dynamic subtest: pipe-C-HDMI-A-1
[346.565377] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[346.588247] Starting dynamic subtest: pipe-C-HDMI-A-2
[346.633776] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[346.636885] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.042s)
[347.221124] [070/130] (731s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[347.439117] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[347.443760] Starting dynamic subtest: pipe-A-HDMI-A-1
[347.561963] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[347.584730] Starting dynamic subtest: pipe-A-HDMI-A-2
[347.617697] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[347.641718] Starting dynamic subtest: pipe-B-HDMI-A-1
[347.673943] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[347.697072] Starting dynamic subtest: pipe-B-HDMI-A-2
[347.729462] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[347.752334] Starting dynamic subtest: pipe-C-HDMI-A-1
[347.785687] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[347.808475] Starting dynamic subtest: pipe-C-HDMI-A-2
[347.840497] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[347.847138] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.036s)
[348.410684] [071/130] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[348.648507] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[348.655952] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[348.797418] [072/130] (730s left) sw_sync (alloc_fence)
[348.923524] Starting subtest: alloc_fence
[348.928976] Subtest alloc_fence: SUCCESS (0.001s)
[349.065466] [073/130] (729s left) gem_exec_store (basic)
[349.241194] Starting subtest: basic
[349.295668] Subtest basic: SUCCESS (0.054s)
[349.569536] [074/130] (729s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[349.698665] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[349.817548] [075/130] (729s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[350.049575] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[350.141060] [076/130] (729s left) sw_sync (alloc_timeline)
[350.268767] Starting subtest: alloc_timeline
[350.272189] Subtest alloc_timeline: SUCCESS (0.000s)
[350.396832] [077/130] (729s left) kms_cursor_legacy (forked-bo)
[350.611135] Starting subtest: forked-bo
[350.614517] Starting dynamic subtest: pipe-A
[356.079110] Dynamic subtest pipe-A: SUCCESS (5.471s)
[356.214115] Starting dynamic subtest: pipe-B
[361.505458] Dynamic subtest pipe-B: SUCCESS (5.421s)
[361.531509] Starting dynamic subtest: pipe-C
[366.953386] Dynamic subtest pipe-C: SUCCESS (5.433s)
[366.984775] Starting dynamic subtest: all-pipes
[372.382117] Dynamic subtest all-pipes: SUCCESS (5.437s)
[372.387351] Subtest forked-bo: SUCCESS (21.776s)
[372.533252] [078/130] (706s left) gen3_render_mixed_blits
[372.772569] [079/130] (706s left) gem_exec_schedule (pi-distinct-iova)
[373.059311] Starting subtest: pi-distinct-iova
[373.062770] Starting dynamic subtest: rcs0
[373.113322] Dynamic subtest rcs0: SUCCESS (0.050s)
[373.140534] Starting dynamic subtest: bcs0
[373.178892] Dynamic subtest bcs0: SUCCESS (0.063s)
[373.220730] Starting dynamic subtest: vcs0
[373.232162] Dynamic subtest vcs0: SUCCESS (0.042s)
[373.273403] Starting dynamic subtest: vecs0
[373.276692] Dynamic subtest vecs0: SUCCESS (0.040s)
[373.280244] Subtest pi-distinct-iova: SUCCESS (0.209s)
[373.552737] [080/130] (706s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[373.785127] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[376.252826] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.471s)
[376.532908] [081/130] (703s left) gem_softpin (32b-excludes-last-page)
[376.665800] Starting subtest: 32b-excludes-last-page
[376.670041] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[376.919710] [082/130] (703s left) perf_pmu (invalid-open)
[377.409389] Starting subtest: invalid-open
[377.475112] Subtest invalid-open: SUCCESS (0.001s)
[377.837103] [083/130] (702s left) gem_pxp (display-protected-crc)
[380.556948] Starting subtest: display-protected-crc
[380.565450] Subtest display-protected-crc: SKIP (0.000s)
[380.703538] [084/130] (699s left) gem_ctx_engines (invalid-engines)
[380.858470] Starting subtest: invalid-engines
[380.868680] Subtest invalid-engines: SUCCESS (0.014s)
[381.141597] [085/130] (699s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[381.271432] Starting subtest: multi-wait-for-submit-available-signaled
[381.274988] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[381.418525] [086/130] (699s left) gem_exec_balancer (invalid-bonds)
[381.565866] Starting subtest: invalid-bonds
[381.574083] Subtest invalid-bonds: SUCCESS (0.007s)
[381.857708] [087/130] (698s left) gem_huc_copy (huc-copy)
[381.992573] Starting subtest: huc-copy
[381.999893] Subtest huc-copy: SKIP (0.000s)
[382.170707] [088/130] (698s left) api_intel_allocator (fork-simple-stress-signal)
[382.294858] Starting subtest: fork-simple-stress-signal
[387.862325] Subtest fork-simple-stress-signal: SUCCESS (5.571s)
[388.025234] [089/130] (692s left) kms_content_protection (srm)
[388.274811] Starting subtest: srm
[390.019107] Subtest srm: SKIP (1.731s)
[390.490960] [090/130] (690s left) kms_prop_blob (blob-prop-lifetime)
[390.621494] Starting subtest: blob-prop-lifetime
[390.624919] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[390.787137] [091/130] (690s left) gem_mmap_gtt (big-bo-tiledy)
[390.909744] Starting subtest: big-bo-tiledY
[392.129490] Subtest big-bo-tiledY: SUCCESS (1.222s)
[392.368207] [092/130] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[392.741600] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[392.749039] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[392.893873] [093/130] (688s left) kms_psr (psr2-dpms)
[393.119989] Subtest psr2-dpms: SKIP (0.000s)
[393.236472] [094/130] (688s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[393.396548] Starting subtest: multi-wait-all-for-submit-signaled
[393.400379] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.003s)
[393.548207] [095/130] (687s left) gem_mmap_wc (read-write-distinct)
[393.673727] Starting subtest: read-write-distinct
[393.703143] Subtest read-write-distinct: SUCCESS (0.033s)
[393.874840] [096/130] (687s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[393.999899] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[394.105697] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[394.261522] [097/130] (687s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[394.403440] Starting subtest: yf-tiled-ccs-to-y-tiled
[394.406989] Starting dynamic subtest: smem
[394.677001] Dynamic subtest smem: SUCCESS (0.270s)
[394.680846] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.274s)
[394.967211] [098/130] (686s left) kms_big_fb (linear-8bpp-rotate-270)
[395.229011] Starting subtest: linear-8bpp-rotate-270
[395.537378] Subtest linear-8bpp-rotate-270: SKIP (0.308s)
[395.744753] [099/130] (686s left) kms_psr (fbc-psr2-primary-page-flip)
[395.959352] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[396.084821] [100/130] (685s left) kms_addfb_basic (unused-handle)
[396.214140] Starting subtest: unused-handle
[396.219368] Subtest unused-handle: SUCCESS (0.000s)
[396.444124] [101/130] (685s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[396.683650] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[399.979516] Subtest fbc-2p-primscrn-spr-indfb-move: SUCCESS (3.299s)
[400.212572] [102/130] (682s left) sw_sync (sync_expired_merge)
[400.339378] Starting subtest: sync_expired_merge
[401.416725] Subtest sync_expired_merge: SUCCESS (1.076s)
[401.545426] [103/130] (680s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[401.671903] Starting subtest: single-wait-for-submit-unsubmitted
[401.775327] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[401.931812] [104/130] (680s left) gem_ctx_persistence (heartbeat-hang)
[402.064311] Starting subtest: heartbeat-hang
[403.232477] Subtest heartbeat-hang: SUCCESS (1.169s)
[403.393462] [105/130] (679s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[403.979154] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[404.234151] [106/130] (678s left) kms_psr (psr-primary-blt)
[404.450006] Subtest psr-primary-blt: SKIP (0.000s)
[404.561748] [107/130] (678s left) perf (non-zero-reason)
[404.829250] Starting subtest: non-zero-reason
[404.832703] Starting dynamic subtest: 0-rcs0
[456.354912] Dynamic subtest 0-rcs0: SUCCESS (51.522s)
[456.358829] Subtest non-zero-reason: SUCCESS (51.525s)
[456.475648] [108/130] (626s left) gem_ccs (block-multicopy-inplace)
[456.613845] Subtest block-multicopy-inplace: SKIP (0.000s)
[456.737530] [109/130] (626s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[456.943571] Starting subtest: plane-all-transition-nonblocking-fencing
[456.946820] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.939350] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.993s)
[461.142098] Starting dynamic subtest: pipe-A-HDMI-A-2
[465.001385] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.881s)
[465.203574] Starting dynamic subtest: pipe-B-HDMI-A-1
[469.067838] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.886s)
[469.262327] Starting dynamic subtest: pipe-B-HDMI-A-2
[473.108737] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.876s)
[473.268158] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (16.324s)
[473.568998] [110/130] (609s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[473.793666] Starting subtest: psr-rgb101010-draw-mmap-gtt
[473.800670] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[473.953624] [111/130] (609s left) kms_async_flips (invalid-async-flip)
[474.177838] Starting subtest: invalid-async-flip
[474.763494] Starting dynamic subtest: pipe-A-HDMI-A-1
[475.077468] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.307s)
[475.396733] Starting dynamic subtest: pipe-A-HDMI-A-2
[475.733306] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.350s)
[476.045437] Starting dynamic subtest: pipe-B-HDMI-A-1
[476.355546] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s)
[476.648564] Starting dynamic subtest: pipe-B-HDMI-A-2
[476.942968] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.316s)
[477.248934] Starting dynamic subtest: pipe-C-HDMI-A-1
[477.519690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.297s)
[477.820736] Starting dynamic subtest: pipe-C-HDMI-A-2
[478.090528] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.293s)
[478.095473] Subtest invalid-async-flip: SUCCESS (3.915s)
[478.652878] [112/130] (604s left) syncobj_wait (wait-any-interrupted)
[478.785252] Starting subtest: wait-any-interrupted
[478.882424] Subtest wait-any-interrupted: SUCCESS (0.102s)
[479.043223] [113/130] (604s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[479.275695] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[480.651854] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.376s)
[481.058867] [114/130] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[481.288067] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[481.294613] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[481.436217] [115/130] (602s left) syncobj_wait (wait-for-submit-delayed-submit)
[481.567630] Starting subtest: wait-for-submit-delayed-submit
[481.665394] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[481.822357] [116/130] (601s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[481.950036] Starting subtest: invalid-multi-wait-unsubmitted
[481.955558] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[482.109560] [117/130] (601s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[482.342668] Starting subtest: fbc-rgb101010-draw-mmap-wc
[485.388380] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.046s)
[485.673572] [118/130] (598s left) gem_ctx_bad_destroy (invalid-pad)
[485.802407] Starting subtest: invalid-pad
[485.806028] Subtest invalid-pad: SUCCESS (0.000s)
[485.957571] [119/130] (598s left) gem_mmap_gtt (cpuset-big-copy)
[486.083253] Starting subtest: cpuset-big-copy
[502.952331] Subtest cpuset-big-copy: SUCCESS (16.874s)
[503.343192] [120/130] (580s left) kms_cursor_crc (cursor-size-change)
[503.686116] Starting subtest: cursor-size-change
[503.690479] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.912151] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.214s)
[504.940961] Starting dynamic subtest: pipe-C-HDMI-A-1
[505.694517] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.781s)
[505.697889] Subtest cursor-size-change: SUCCESS (2.007s)
[506.003931] [121/130] (578s left) gem_exec_flush (basic-batch-kernel-default-uc)
[506.168680] Starting subtest: basic-batch-kernel-default-uc
[511.822855] Subtest basic-batch-kernel-default-uc: SUCCESS (5.653s)
[512.105714] [122/130] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[512.347791] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[512.355078] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[512.502451] [123/130] (571s left) i915_pm_rpm (gem-evict-pwrite)
[514.440292] Starting subtest: gem-evict-pwrite
[515.458372] Subtest gem-evict-pwrite: SUCCESS (1.014s)
[515.959091] [124/130] (568s left) gem_ctx_persistence (legacy-engines-mixed-process)
[516.113353] Starting subtest: legacy-engines-mixed-process
[516.116555] Starting dynamic subtest: render
[516.537395] Dynamic subtest render: SUCCESS (0.416s)
[516.588523] Starting dynamic subtest: bsd
[516.911733] Dynamic subtest bsd: SUCCESS (0.379s)
[516.967606] Starting dynamic subtest: blt
[517.293839] Dynamic subtest blt: SUCCESS (0.374s)
[517.336203] Starting dynamic subtest: vebox
[517.687739] Dynamic subtest vebox: SUCCESS (0.384s)
[517.692254] Subtest legacy-engines-mixed-process: SUCCESS (1.583s)
[517.870838] [125/130] (566s left) i915_query (query-regions-unallocated)
[517.999811] Starting subtest: query-regions-unallocated
[518.003164] Subtest query-regions-unallocated: SUCCESS (0.000s)
[518.155116] [126/130] (566s left) perf (gen8-unprivileged-single-ctx-counters)
[518.434764] Starting subtest: gen8-unprivileged-single-ctx-counters
[518.779195] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.351s)
[518.904942] [127/130] (565s left) kms_chamelium_color (ctm-0-25)
[519.115521] Subtest ctm-0-25: SKIP (0.000s)
[519.234474] [128/130] (565s left) gem_exec_reloc (basic-range)
[519.373201] Starting subtest: basic-range
[519.444765] Subtest basic-range: SUCCESS (0.067s)
[519.665241] [129/130] (565s left) syncobj_timeline (wait-for-submit-complex)
[519.796344] Starting subtest: wait-for-submit-complex
[519.858559] Subtest wait-for-submit-complex: SUCCESS (0.068s)
[520.011496] [130/130] (565s left) gen9_exec_parse (bb-oversize)
[520.160881] Starting subtest: bb-oversize
[520.370749] Subtest bb-oversize: SKIP (0.146s)
[520.626322] Closing watchdogs
Done.