[49.935097] Initializing watchdogs
[49.935170]   /dev/watchdog0
[49.952283] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[49.959065] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.961677] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.963545] [001/133] (960s left) kms_vblank (invalid)
[50.062386] Starting subtest: invalid
[50.063106] Starting dynamic subtest: pipe-A-HDMI-A-1
[50.229343] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.162s)
[50.230107] Subtest invalid: SUCCESS (0.163s)
[50.374782] [002/133] (960s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[50.482470] Starting subtest: yf-tiled-64bpp-rotate-180
[50.484007] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[50.560037] [003/133] (959s left) prime_busy (before-wait)
[50.601814] Starting subtest: before-wait
[50.607020] Starting dynamic subtest: rcs0
[50.625767] Dynamic subtest rcs0: SUCCESS (0.018s)
[50.632966] Starting dynamic subtest: bcs0
[50.646513] Dynamic subtest bcs0: SUCCESS (0.020s)
[50.656032] Starting dynamic subtest: vcs0
[50.663066] Dynamic subtest vcs0: SUCCESS (0.016s)
[50.673101] Starting dynamic subtest: vcs1
[50.679596] Dynamic subtest vcs1: SUCCESS (0.016s)
[50.687773] Starting dynamic subtest: vecs0
[50.693196] Dynamic subtest vecs0: SUCCESS (0.013s)
[50.802142] Subtest before-wait: SUCCESS (0.194s)
[50.887126] [004/133] (959s left) syncobj_timeline (invalid-wait-bad-flags)
[50.923405] Starting subtest: invalid-wait-bad-flags
[50.924236] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[51.004356] [005/133] (959s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[51.039160] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[51.040656] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[51.096423] [006/133] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[51.193704] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[51.195240] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[51.305035] [007/133] (959s left) gem_exec_whisper (basic-fds-forked-all)
[51.349956] Starting subtest: basic-fds-forked-all
[55.604614] Subtest basic-fds-forked-all: SUCCESS (4.165s)
[55.784179] [008/133] (954s left) gem_exec_async (forked-writes)
[55.828801] Starting subtest: forked-writes
[55.829548] Starting dynamic subtest: rcs0
[55.857850] Dynamic subtest rcs0: SUCCESS (0.028s)
[55.865810] Starting dynamic subtest: bcs0
[55.883711] Dynamic subtest bcs0: SUCCESS (0.025s)
[55.891745] Starting dynamic subtest: vcs0
[55.909860] Dynamic subtest vcs0: SUCCESS (0.026s)
[55.919349] Starting dynamic subtest: vcs1
[55.936259] Dynamic subtest vcs1: SUCCESS (0.025s)
[55.944471] Starting dynamic subtest: vecs0
[55.961281] Dynamic subtest vecs0: SUCCESS (0.025s)
[55.962119] Subtest forked-writes: SUCCESS (0.131s)
[56.155952] [009/133] (954s left) gem_exec_fence (invalid-timeline-fence-array)
[56.648600] Starting subtest: invalid-timeline-fence-array
[56.649430] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[56.832337] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[56.834029] [010/133] (953s left) core_setmaster (master-drop-set-shared-fd)
[56.917205] Starting subtest: master-drop-set-shared-fd
[56.934811] Subtest master-drop-set-shared-fd: SUCCESS (0.016s)
[56.970552] [011/133] (953s left) kms_pm_backlight (basic-brightness)
[57.064094] Subtest basic-brightness: SKIP (0.000s)
[57.108957] [012/133] (953s left) gem_fence_thrash (bo-write-verify-none)
[57.140945] Starting subtest: bo-write-verify-none
[58.372523] Subtest bo-write-verify-none: SUCCESS (1.210s)
[58.450281] [013/133] (952s left) kms_psr (pr-primary-blt)
[58.543505] Subtest pr-primary-blt: SKIP (0.000s)
[58.583447] [014/133] (952s left) gen9_exec_parse (batch-zero-length)
[58.621876] Subtest batch-zero-length: SKIP (0.000s)
[58.667699] [015/133] (952s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[58.761191] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[58.764855] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s)
[58.850273] [016/133] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[58.944730] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[58.946187] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[59.047201] [017/133] (952s left) kms_getfb (getfb2-handle-closed)
[59.137375] Starting subtest: getfb2-handle-closed
[59.138140] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[59.240459] [018/133] (951s left) kms_properties (get_properties-sanity-non-atomic)
[59.328608] Starting subtest: get_properties-sanity-non-atomic
[59.330983] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s)
[59.419367] [019/133] (951s left) gem_fence_thrash (bo-copy)
[59.451510] Starting subtest: bo-copy
[60.810911] Subtest bo-copy: SUCCESS (1.340s)
[60.915919] [020/133] (950s left) gem_spin_batch (resubmit-all)
[60.964043] Starting subtest: resubmit-all
[60.964802] Starting dynamic subtest: rcs0
[60.965496] Dynamic subtest rcs0: SUCCESS (0.004s)
[60.973891] Starting dynamic subtest: bcs0
[60.974781] Dynamic subtest bcs0: SUCCESS (0.003s)
[60.981929] Starting dynamic subtest: vcs0
[60.982640] Dynamic subtest vcs0: SUCCESS (0.002s)
[60.989366] Starting dynamic subtest: vcs1
[60.990078] Dynamic subtest vcs1: SUCCESS (0.002s)
[60.996616] Starting dynamic subtest: vecs0
[60.997312] Dynamic subtest vecs0: SUCCESS (0.002s)
[60.998076] Subtest resubmit-all: SUCCESS (0.014s)
[61.173146] [021/133] (950s left) gem_exec_reloc (basic-cpu-read-active)
[61.211351] Starting subtest: basic-cpu-read-active
[61.343493] Subtest basic-cpu-read-active: SUCCESS (0.122s)
[61.489593] [022/133] (949s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[61.587619] Starting subtest: 4-tiled-16bpp-rotate-0
[61.589023] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[61.692225] [023/133] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[61.784553] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[61.785942] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[61.897718] [024/133] (949s left) kms_dp_link_training (uhbr-sst)
[61.987752] Starting subtest: uhbr-sst
[61.989157] Subtest uhbr-sst: SKIP (0.000s)
[62.048382] [025/133] (949s left) gem_userptr_blits (huge-split)
[62.101829] Starting subtest: huge-split
[62.105750] Subtest huge-split: SUCCESS (0.004s)
[62.221610] [026/133] (949s left) kms_async_flips (async-flip-hang)
[62.309973] Starting subtest: async-flip-hang
[62.431802] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.434592] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.933s)
[77.537879] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.793966] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (15.221s)
[92.886480] Starting dynamic subtest: pipe-C-HDMI-A-1
[107.642128] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (14.724s)
[107.738091] Starting dynamic subtest: pipe-D-HDMI-A-1
[122.465260] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.723s)
[122.466217] Subtest async-flip-hang: SUCCESS (60.091s)
[122.706537] [027/133] (888s left) gem_eio (hibernate)
[122.750327] Starting subtest: hibernate
[135.957538] Subtest hibernate: SUCCESS (13.205s)
[144.096259] [028/133] (875s left) syncobj_timeline (wait-any-complex)
[144.133672] Starting subtest: wait-any-complex
[144.196925] Subtest wait-any-complex: SUCCESS (0.063s)
[144.281854] [029/133] (875s left) kms_vblank (ts-continuation-modeset)
[144.370562] Starting subtest: ts-continuation-modeset
[144.372132] Starting dynamic subtest: pipe-A-HDMI-A-1
[144.682461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.310s)
[144.693748] Starting dynamic subtest: pipe-D-HDMI-A-1
[144.950463] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.265s)
[144.951240] Subtest ts-continuation-modeset: SUCCESS (0.580s)
[145.083308] [030/133] (874s left) gem_exec_create (basic)
[145.131446] Starting subtest: basic
[145.132190] Starting dynamic subtest: smem
[147.174066] Dynamic subtest smem: SUCCESS (2.043s)
[147.174830] Subtest basic: SUCCESS (2.043s)
[147.361944] [031/133] (872s left) kms_psr (fbc-pr-sprite-plane-move)
[147.456318] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[147.502588] [032/133] (872s left) i915_pm_rps (thresholds)
[147.542086] Starting subtest: thresholds
[147.542833] Starting dynamic subtest: gt0
[157.623280] Dynamic subtest gt0: SUCCESS (10.080s)
[157.624475] Subtest thresholds: SUCCESS (10.081s)
[157.699728] [033/133] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[157.795486] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[157.796877] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[157.895596] [034/133] (861s left) gem_exec_params (larger-than-life-batch)
[157.932485] Starting subtest: larger-than-life-batch
[159.983108] Subtest larger-than-life-batch: SUCCESS (2.050s)
[160.120152] [035/133] (859s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[160.214631] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[160.318742] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[160.407379] [036/133] (859s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[160.504596] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[160.506085] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.611941] [037/133] (859s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[160.709961] Starting subtest: cursor-rapid-movement-256x85
[160.714493] Starting dynamic subtest: pipe-A-HDMI-A-1
[160.980055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.266s)
[161.016801] Starting dynamic subtest: pipe-D-HDMI-A-1
[161.218433] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.211s)
[161.219155] Subtest cursor-rapid-movement-256x85: SUCCESS (0.509s)
[161.369804] [038/133] (858s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[161.414442] Starting subtest: no-spare-fences-busy
[163.574242] Subtest no-spare-fences-busy: SUCCESS (2.159s)
[163.691532] [039/133] (856s left) syncobj_timeline (reset-multiple-signaled)
[163.726181] Starting subtest: reset-multiple-signaled
[163.726908] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[163.793566] [040/133] (856s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[163.894867] Starting subtest: 4-tiled-8bpp-rotate-270
[163.896269] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[163.987437] [041/133] (856s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[164.076973] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[164.078454] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[164.145974] [042/133] (856s left) kms_addfb_basic (addfb25-modifier-no-flag)
[164.234652] Starting subtest: addfb25-modifier-no-flag
[164.235387] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[164.343029] [043/133] (855s left) gem_render_copy (y-tiled)
[164.383637] Starting subtest: y-tiled
[164.384450] Starting dynamic subtest: smem
[164.482842] Dynamic subtest smem: SUCCESS (0.099s)
[164.483567] Subtest y-tiled: SUCCESS (0.099s)
[164.676263] [044/133] (855s left) perf_pmu (busy-accuracy-2)
[164.714171] Starting subtest: busy-accuracy-2
[164.714906] Starting dynamic subtest: rcs0
[167.747674] Dynamic subtest rcs0: SUCCESS (3.030s)
[167.758569] Starting dynamic subtest: bcs0
[170.780182] Dynamic subtest bcs0: SUCCESS (3.031s)
[170.790775] Starting dynamic subtest: vcs0
[173.812198] Dynamic subtest vcs0: SUCCESS (3.031s)
[173.822623] Starting dynamic subtest: vcs1
[176.843640] Dynamic subtest vcs1: SUCCESS (3.032s)
[176.855217] Starting dynamic subtest: vecs0
[179.875395] Dynamic subtest vecs0: SUCCESS (3.031s)
[179.876283] Subtest busy-accuracy-2: SUCCESS (15.159s)
[179.957476] [045/133] (840s left) kms_chamelium_hpd (hdmi-hpd)
[180.103120] Subtest hdmi-hpd: SKIP (0.000s)
[180.198800] [046/133] (840s left) kms_cursor_edge_walk (256x256-top-bottom)
[180.294012] Starting subtest: 256x256-top-bottom
[180.294778] Starting dynamic subtest: pipe-A-HDMI-A-1
[182.052918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.758s)
[182.063560] Starting dynamic subtest: pipe-D-HDMI-A-1
[183.763367] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.708s)
[183.764064] Subtest 256x256-top-bottom: SUCCESS (3.470s)
[183.871587] [047/133] (836s left) gem_exec_reloc (basic-wc-cpu)
[183.913505] Starting subtest: basic-wc-cpu
[183.920066] Subtest basic-wc-cpu: SUCCESS (0.007s)
[184.048736] [048/133] (836s left) gem_mmap_gtt (basic-read-write-distinct)
[184.083173] Starting subtest: basic-read-write-distinct
[184.085739] Subtest basic-read-write-distinct: SUCCESS (0.003s)
[184.180578] [049/133] (836s left) gem_softpin (softpin)
[184.220104] Starting subtest: softpin
[216.552805] Subtest softpin: SUCCESS (32.320s)
[216.650342] [050/133] (803s left) kms_cursor_crc (cursor-onscreen-256x85)
[216.745145] Starting subtest: cursor-onscreen-256x85
[216.749579] Starting dynamic subtest: pipe-A-HDMI-A-1
[217.631887] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.691s)
[217.643490] Starting dynamic subtest: pipe-D-HDMI-A-1
[218.719849] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.243s)
[218.720610] Subtest cursor-onscreen-256x85: FAIL (1.975s)
[218.860618] [051/133] (801s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[218.959689] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[227.913082] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.953s)
[228.042876] [052/133] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[228.146953] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[228.148345] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[228.263781] [053/133] (792s left) gem_exec_balancer (hog)
[228.307790] Starting subtest: hog
[229.713920] Subtest hog: SUCCESS (1.398s)
[229.927214] [054/133] (790s left) sysfs_heartbeat_interval (mixed)
[229.964635] Starting subtest: mixed
[229.965381] Starting dynamic subtest: vecs0
[235.130109] Dynamic subtest vecs0: SUCCESS (5.164s)
[235.145629] Starting dynamic subtest: vcs0
[240.290310] Dynamic subtest vcs0: SUCCESS (5.157s)
[240.303179] Starting dynamic subtest: bcs0
[245.466132] Dynamic subtest bcs0: SUCCESS (5.174s)
[245.479086] Starting dynamic subtest: rcs0
[250.670417] Dynamic subtest rcs0: SUCCESS (5.202s)
[250.685659] Starting dynamic subtest: vcs1
[255.846321] Dynamic subtest vcs1: SUCCESS (5.174s)
[255.847415] Subtest mixed: SUCCESS (25.881s)
[255.918807] [055/133] (764s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[256.013416] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[256.056914] [056/133] (764s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[256.149537] Starting subtest: stress-xrgb8888-xtiled
[262.855441] Subtest stress-xrgb8888-xtiled: SUCCESS (6.705s)
[262.986164] [057/133] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[263.083783] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[263.085168] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[263.190600] [058/133] (757s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[263.291086] Starting subtest: fbcpsr-shrfb-scaledprimary
[263.292435] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s)
[263.391122] [059/133] (757s left) perf_pmu (render-node-busy-idle)
[263.429892] Starting subtest: render-node-busy-idle
[263.430672] Starting dynamic subtest: rcs0
[264.080846] Dynamic subtest rcs0: SUCCESS (0.649s)
[264.092620] Starting dynamic subtest: bcs0
[264.708794] Dynamic subtest bcs0: SUCCESS (0.626s)
[264.721856] Starting dynamic subtest: vcs0
[265.343799] Dynamic subtest vcs0: SUCCESS (0.634s)
[265.355675] Starting dynamic subtest: vcs1
[265.983878] Dynamic subtest vcs1: SUCCESS (0.637s)
[265.995903] Starting dynamic subtest: vecs0
[266.611212] Dynamic subtest vecs0: SUCCESS (0.628s)
[266.612250] Subtest render-node-busy-idle: SUCCESS (3.183s)
[266.695707] [060/133] (754s left) i915_drm_fdinfo (virtual-idle)
[266.733153] Starting subtest: virtual-idle
[269.262084] Subtest virtual-idle: SUCCESS (2.519s)
[269.342721] [061/133] (751s left) gem_exec_reloc (basic-gtt-cpu)
[269.380372] Starting subtest: basic-gtt-cpu
[269.387513] Subtest basic-gtt-cpu: SUCCESS (0.007s)
[269.528880] [062/133] (751s left) gem_mmap (bad-offset)
[269.563853] Starting subtest: bad-offset
[269.564591] Subtest bad-offset: SUCCESS (0.000s)
[269.654841] [063/133] (751s left) gem_exec_endless (dispatch)
[269.705441] Starting subtest: dispatch
[269.706293] Starting dynamic subtest: rcs0
[269.709042] Dynamic subtest rcs0: SUCCESS (0.003s)
[269.719911] Starting dynamic subtest: bcs0
[269.721406] Dynamic subtest bcs0: SUCCESS (0.003s)
[269.732236] Starting dynamic subtest: vcs0
[269.733583] Dynamic subtest vcs0: SUCCESS (0.003s)
[269.742891] Starting dynamic subtest: vcs1
[269.744237] Dynamic subtest vcs1: SUCCESS (0.003s)
[269.753459] Starting dynamic subtest: vecs0
[269.754777] Dynamic subtest vecs0: SUCCESS (0.003s)
[269.755451] Subtest dispatch: SUCCESS (0.018s)
[269.830523] [064/133] (751s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[269.931775] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[269.933221] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[270.020787] [065/133] (751s left) gem_compute (compute-square)
[270.054901] Starting subtest: compute-square
[270.058328] Subtest compute-square: SUCCESS (0.004s)
[270.157190] [066/133] (751s left) kms_pm_dc (dc6-psr)
[271.255761] Starting subtest: dc6-psr
[271.257194] Subtest dc6-psr: SKIP (0.000s)
[271.321959] [067/133] (749s left) api_intel_allocator (reopen-fork)
[271.357915] Starting subtest: reopen-fork
[274.764403] Subtest reopen-fork: SUCCESS (3.373s)
[274.807567] [068/133] (746s left) gem_userptr_blits (readonly-pwrite-unsync)
[274.847565] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[274.965976] [069/133] (746s left) kms_psr (fbc-psr-primary-blt)
[275.058384] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[275.101928] [070/133] (746s left) gem_busy (busy)
[275.146552] Starting subtest: busy
[275.147330] Starting dynamic subtest: all-engines
[275.176274] Dynamic subtest all-engines: SUCCESS (0.029s)
[275.186326] Starting dynamic subtest: rcs0
[275.193832] Dynamic subtest rcs0: SUCCESS (0.017s)
[275.204310] Starting dynamic subtest: bcs0
[275.208274] Dynamic subtest bcs0: SUCCESS (0.014s)
[275.219156] Starting dynamic subtest: vcs0
[275.226269] Dynamic subtest vcs0: SUCCESS (0.017s)
[275.236391] Starting dynamic subtest: vcs1
[275.242132] Dynamic subtest vcs1: SUCCESS (0.015s)
[275.254880] Starting dynamic subtest: vecs0
[275.255690] Dynamic subtest vecs0: SUCCESS (0.012s)
[275.256415] Subtest busy: SUCCESS (0.109s)
[275.638042] [071/133] (745s left) i915_drm_fdinfo (virtual-busy-hang-all)
[275.675012] Starting subtest: virtual-busy-hang-all
[276.700647] Subtest virtual-busy-hang-all: SUCCESS (1.025s)
[276.770772] [072/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[276.870949] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[276.872408] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[276.966826] [073/133] (744s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[277.059650] Starting subtest: plane-lut1d-post-ctm3x4
[277.151136] Starting dynamic subtest: pipe-A-plane-0
[277.242700] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[277.261661] Starting dynamic subtest: pipe-A-plane-1
[277.334468] Dynamic subtest pipe-A-plane-1: SUCCESS (0.090s)
[277.350768] Starting dynamic subtest: pipe-A-plane-2
[277.434125] Dynamic subtest pipe-A-plane-2: SUCCESS (0.097s)
[277.655933] Starting dynamic subtest: pipe-B-plane-0
[277.730918] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[277.747507] Starting dynamic subtest: pipe-B-plane-1
[277.822769] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[277.838532] Starting dynamic subtest: pipe-B-plane-2
[277.915522] Dynamic subtest pipe-B-plane-2: SUCCESS (0.090s)
[278.111275] Starting dynamic subtest: pipe-C-plane-0
[278.188843] Dynamic subtest pipe-C-plane-0: SUCCESS (0.091s)
[278.202223] Starting dynamic subtest: pipe-C-plane-1
[278.288159] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s)
[278.301118] Starting dynamic subtest: pipe-C-plane-2
[278.388341] Dynamic subtest pipe-C-plane-2: SUCCESS (0.099s)
[278.601963] Starting dynamic subtest: pipe-D-plane-0
[278.684123] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[278.697385] Starting dynamic subtest: pipe-D-plane-1
[278.784693] Dynamic subtest pipe-D-plane-1: SUCCESS (0.099s)
[278.801576] Starting dynamic subtest: pipe-D-plane-2
[278.884674] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[278.933492] Subtest plane-lut1d-post-ctm3x4: SUCCESS (1.874s)
[279.052970] [074/133] (742s left) prime_mmap_kms (buffer-sharing)
[279.150072] Starting subtest: buffer-sharing
[279.328384] Subtest buffer-sharing: SUCCESS (0.179s)
[279.484810] [075/133] (742s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[279.578914] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[279.579646] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.586820] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[279.600481] Starting dynamic subtest: pipe-B-HDMI-A-1
[279.607643] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[279.620847] Starting dynamic subtest: pipe-C-HDMI-A-1
[279.627720] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[279.637334] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.644369] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[279.645717] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.008s)
[279.841080] [076/133] (741s left) kms_big_fb (x-tiled-addfb)
[279.940771] Starting subtest: x-tiled-addfb
[279.941465] Subtest x-tiled-addfb: SUCCESS (0.000s)
[280.045440] [077/133] (741s left) kms_busy (extended-modeset-hang-oldfb)
[280.139188] Starting subtest: extended-modeset-hang-oldfb
[280.140973] Starting dynamic subtest: pipe-A
[290.593452] Dynamic subtest pipe-A: SUCCESS (10.452s)
[290.606224] Starting dynamic subtest: pipe-D
[301.316263] Dynamic subtest pipe-D: SUCCESS (10.719s)
[301.318036] Subtest extended-modeset-hang-oldfb: SUCCESS (21.177s)
[301.448033] [078/133] (720s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[301.487291] Starting subtest: wait-all-for-submit-delayed-submit
[301.590233] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[301.685801] [079/133] (720s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[301.791591] Starting subtest: yf-tiled-32bpp-rotate-0
[301.793084] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[301.888928] [080/133] (719s left) kms_prop_blob (basic)
[301.924036] Starting subtest: basic
[301.924806] Subtest basic: SUCCESS (0.000s)
[301.985913] [081/133] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[302.080073] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[302.081535] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[302.181625] [082/133] (719s left) kms_plane_multiple (2x-tiling-y)
[302.273104] Starting subtest: 2x-tiling-y
[302.274622] Subtest 2x-tiling-y: SKIP (0.000s)
[302.335934] [083/133] (719s left) syncobj_wait (reset-multiple-signaled)
[302.371151] Starting subtest: reset-multiple-signaled
[302.371910] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[302.440503] [084/133] (719s left) gem_exec_parallel (basic)
[302.483437] Starting subtest: basic
[302.484267] Starting dynamic subtest: rcs0
[304.144127] Dynamic subtest rcs0: SUCCESS (1.660s)
[304.156760] Starting dynamic subtest: bcs0
[305.777220] Dynamic subtest bcs0: SUCCESS (1.632s)
[305.791817] Starting dynamic subtest: vcs0
[307.427463] Dynamic subtest vcs0: SUCCESS (1.649s)
[307.437821] Starting dynamic subtest: vcs1
[309.066152] Dynamic subtest vcs1: SUCCESS (1.638s)
[309.078745] Starting dynamic subtest: vecs0
[310.676212] Dynamic subtest vecs0: SUCCESS (1.609s)
[310.676966] Subtest basic: SUCCESS (8.193s)
[310.855661] [085/133] (711s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[310.953029] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[312.059050] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.106s)
[312.179340] [086/133] (709s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[312.283858] Starting subtest: basic-flip-before-cursor-legacy
[312.824532] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.541s)
[312.981497] [087/133] (709s left) gem_mmap_offset (partial-mmap)
[313.019307] Starting subtest: partial-mmap
[313.020046] Starting dynamic subtest: smem0
[313.022140] Dynamic subtest smem0: SUCCESS (0.003s)
[313.022840] Subtest partial-mmap: SUCCESS (0.004s)
[313.132827] [088/133] (709s left) api_intel_bb (reset-bb)
[313.168678] Starting subtest: reset-bb
[313.171281] Subtest reset-bb: SUCCESS (0.003s)
[313.302179] [089/133] (708s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[313.396925] Starting subtest: primary-yf-tiled-reflect-x-270
[313.450615] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.053s)
[313.543624] [090/133] (708s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[313.634044] Starting subtest: short-flip-after-cursor-atomic-transitions
[314.147222] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.513s)
[314.294172] [091/133] (708s left) kms_chamelium_frames (hdmi-crc-fast)
[314.443546] Subtest hdmi-crc-fast: SKIP (0.000s)
[314.555812] [092/133] (707s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[314.603270] Starting subtest: yf-tiled-to-vebox-x-tiled
[314.604102] Starting dynamic subtest: smem
[314.699235] Dynamic subtest smem: SUCCESS (0.095s)
[314.699986] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.096s)
[314.885876] [093/133] (707s left) gem_exec_schedule (semaphore-noskip)
[314.933602] Starting subtest: semaphore-noskip
[315.258649] Subtest semaphore-noskip: SUCCESS (0.316s)
[315.563871] [094/133] (706s left) perf (oa-exponents)
[315.659071] Starting subtest: oa-exponents
[315.659826] Starting dynamic subtest: 0-rcs0
[319.089718] Dynamic subtest 0-rcs0: SUCCESS (3.421s)
[319.090500] Subtest oa-exponents: SUCCESS (3.422s)
[319.131822] [095/133] (703s left) kms_lease (lease-get)
[319.242039] Starting subtest: lease-get
[319.243821] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.244604] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[319.259341] Starting dynamic subtest: pipe-B-HDMI-A-1
[319.260123] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[319.270723] Starting dynamic subtest: pipe-C-HDMI-A-1
[319.271452] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[319.281584] Starting dynamic subtest: pipe-D-HDMI-A-1
[319.282317] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[319.283057] Subtest lease-get: SUCCESS (0.009s)
[319.318075] [096/133] (703s left) kms_properties (colorop-properties-legacy)
[319.409147] Starting subtest: colorop-properties-legacy
[319.411123] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.510999] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.101s)
[319.522618] Starting dynamic subtest: pipe-B-HDMI-A-1
[319.626242] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.113s)
[319.637640] Starting dynamic subtest: pipe-C-HDMI-A-1
[319.742176] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.114s)
[319.755487] Starting dynamic subtest: pipe-D-HDMI-A-1
[319.876906] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.120s)
[319.877641] Subtest colorop-properties-legacy: SUCCESS (0.454s)
[320.024685] [097/133] (702s left) gem_pwrite (basic-self)
[320.061543] Starting subtest: basic-self
[320.099634] Subtest basic-self: SUCCESS (0.039s)
[320.201303] [098/133] (702s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[320.292365] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[320.293799] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[320.481967] [099/133] (702s left) gem_exec_alignment (single)
[320.520619] Starting subtest: single
[320.522849] Subtest single: SUCCESS (0.002s)
[320.633119] [100/133] (702s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[320.723439] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[320.724206] Starting dynamic subtest: pipe-A
[321.991639] Dynamic subtest pipe-A: SUCCESS (1.268s)
[322.006302] Starting dynamic subtest: pipe-B
[323.284650] Dynamic subtest pipe-B: SUCCESS (1.292s)
[323.302045] Starting dynamic subtest: pipe-C
[323.494719] Dynamic subtest pipe-C: SUCCESS (0.209s)
[323.518101] Starting dynamic subtest: pipe-D
[323.704035] Dynamic subtest pipe-D: SUCCESS (0.208s)
[323.704851] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (2.981s)
[323.889218] [101/133] (698s left) i915_selftest (perf)
[324.906288] Starting subtest: perf
[324.907145] Starting dynamic subtest: engine_cs
[326.224932] Dynamic subtest engine_cs: SUCCESS (1.312s)
[326.233597] Starting dynamic subtest: request
[330.539835] Dynamic subtest request: SUCCESS (4.312s)
[330.548684] Starting dynamic subtest: migrate
[331.939920] Dynamic subtest migrate: SUCCESS (1.398s)
[331.950665] Starting dynamic subtest: region
[334.199947] Dynamic subtest region: SUCCESS (2.257s)
[334.200976] Subtest perf: SUCCESS (9.288s)
[334.233246] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[334.234036] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[334.237089] [102/133] (688s left) kms_invalid_mode (zero-clock)
[335.342649] Starting subtest: zero-clock
[335.344520] Starting dynamic subtest: pipe-A-HDMI-A-1
[335.397724] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[335.410593] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.411376] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[335.420601] Starting dynamic subtest: pipe-C-HDMI-A-1
[335.421379] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[335.429956] Starting dynamic subtest: pipe-D-HDMI-A-1
[335.430762] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[335.431481] Subtest zero-clock: SUCCESS (0.064s)
[335.553766] [FACT kms_invalid_mode (zero-clock)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[335.555122] [FACT kms_invalid_mode (zero-clock)] new: kernel.kmod_is_loaded.i915: true
[335.557871] [103/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[335.651983] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[335.653419] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[335.757859] [104/133] (687s left) gem_exec_schedule (implicit-write-read)
[335.806795] Starting subtest: implicit-write-read
[335.807570] Starting dynamic subtest: rcs0
[335.882557] Dynamic subtest rcs0: SUCCESS (0.075s)
[335.895291] Starting dynamic subtest: bcs0
[335.949026] Dynamic subtest bcs0: SUCCESS (0.064s)
[335.964822] Starting dynamic subtest: vcs0
[336.017224] Dynamic subtest vcs0: SUCCESS (0.065s)
[336.034593] Starting dynamic subtest: vcs1
[336.087353] Dynamic subtest vcs1: SUCCESS (0.067s)
[336.105608] Starting dynamic subtest: vecs0
[336.158136] Dynamic subtest vecs0: SUCCESS (0.068s)
[336.161983] Subtest implicit-write-read: SUCCESS (0.352s)
[336.481063] [105/133] (686s left) gem_ctx_persistence (many-contexts)
[336.618788] Starting subtest: many-contexts
[375.605340] Subtest many-contexts: SUCCESS (38.975s)
[375.675715] [106/133] (647s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[375.775110] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[375.784767] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s)
[375.847529] [107/133] (647s left) gem_ctx_param (invalid-size-set)
[375.883915] Starting subtest: invalid-size-set
[375.884647] Subtest invalid-size-set: SUCCESS (0.000s)
[375.952911] [108/133] (647s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[376.043073] Starting subtest: primary-4-tiled-reflect-x-180
[376.109347] Subtest primary-4-tiled-reflect-x-180: SKIP (0.065s)
[376.209824] [109/133] (646s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[376.298958] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[376.300756] Starting dynamic subtest: pipe-A-HDMI-A-1
[376.307500] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[376.316998] Starting dynamic subtest: pipe-B-HDMI-A-1
[376.323839] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[376.333958] Starting dynamic subtest: pipe-C-HDMI-A-1
[376.340698] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[376.351288] Starting dynamic subtest: pipe-D-HDMI-A-1
[376.358245] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[376.359602] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[376.551291] [110/133] (646s left) core_setmaster_vs_auth
[376.666661] [111/133] (646s left) drm_read (short-buffer-block)
[376.796192] Starting subtest: short-buffer-block
[376.797017] Subtest short-buffer-block: SUCCESS (0.000s)
[376.908116] [112/133] (646s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[376.998478] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[376.999226] Starting dynamic subtest: pipe-A-valid-mode
[377.849903] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.851s)
[377.850685] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.852s)
[378.001186] [113/133] (645s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[378.094051] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[378.096090] Starting dynamic subtest: pipe-A-HDMI-A-1
[378.102687] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[378.112316] Starting dynamic subtest: pipe-B-HDMI-A-1
[378.119036] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[378.128857] Starting dynamic subtest: pipe-C-HDMI-A-1
[378.135422] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[378.144599] Starting dynamic subtest: pipe-D-HDMI-A-1
[378.151353] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[378.152691] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[378.331900] [114/133] (645s left) kms_feature_discovery (dp-mst)
[378.423197] Starting subtest: dp-mst
[378.424674] Subtest dp-mst: SKIP (0.000s)
[378.494983] [115/133] (644s left) kms_psr (psr2-cursor-mmap-gtt)
[378.584825] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[378.629798] [116/133] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[378.729420] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[378.730789] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[378.834823] [117/133] (644s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[378.929837] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[380.229490] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.299s)
[380.358523] [118/133] (643s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[380.452821] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[380.453569] Starting dynamic subtest: pipe-A-valid-mode
[382.310517] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.857s)
[382.311304] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.859s)
[382.447740] [119/133] (641s left) kms_addfb_basic (bad-pitch-1024)
[382.484317] Starting subtest: bad-pitch-1024
[382.485051] Subtest bad-pitch-1024: SUCCESS (0.000s)
[382.639066] [120/133] (641s left) gem_exec_whisper (basic-queues-forked-all)
[382.683997] Starting subtest: basic-queues-forked-all
[385.651191] Subtest basic-queues-forked-all: SUCCESS (2.957s)
[385.834118] [121/133] (637s left) kms_content_protection (atomic-dpms)
[385.935077] Starting subtest: atomic-dpms
[385.941133] Subtest atomic-dpms: SKIP (0.004s)
[386.039492] [122/133] (637s left) gem_pxp (reject-modify-context-protection-off-1)
[386.142972] Starting subtest: reject-modify-context-protection-off-1
[386.144271] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[386.215218] [123/133] (637s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[386.314914] Starting subtest: y-tiled-16bpp-rotate-90
[387.417269] Subtest y-tiled-16bpp-rotate-90: SUCCESS (1.103s)
[387.570352] [124/133] (636s left) gem_userptr_blits (usage-restrictions)
[387.609513] Starting subtest: usage-restrictions
[387.610191] Subtest usage-restrictions: SUCCESS (0.000s)
[387.761812] [125/133] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[387.857860] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[387.859326] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[387.955315] [126/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[388.049932] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[388.051334] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[388.151998] [127/133] (635s left) gem_exec_reloc (basic-cpu-wc)
[388.193167] Starting subtest: basic-cpu-wc
[388.197382] Subtest basic-cpu-wc: SUCCESS (0.005s)
[388.315055] [128/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[388.412094] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[388.413574] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[388.515794] [129/133] (635s left) kms_psr2_su (page_flip-p010)
[388.553828] Subtest page_flip-P010: SKIP (0.000s)
[388.601156] [130/133] (635s left) syncobj_eventfd (timeline-wait-signaled)
[388.635708] Starting subtest: timeline-wait-signaled
[388.636398] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[388.697933] [131/133] (635s left) kms_flip (flip-vs-panning-interruptible)
[388.792058] Starting subtest: flip-vs-panning-interruptible
[388.795041] Starting dynamic subtest: A-HDMI-A1
[396.458273] Dynamic subtest A-HDMI-A1: SUCCESS (7.662s)
[396.480380] Starting dynamic subtest: B-HDMI-A1
[404.114388] Dynamic subtest B-HDMI-A1: SUCCESS (7.651s)
[404.130671] Starting dynamic subtest: C-HDMI-A1
[411.756132] Dynamic subtest C-HDMI-A1: SUCCESS (7.638s)
[411.778705] Starting dynamic subtest: D-HDMI-A1
[419.405232] Dynamic subtest D-HDMI-A1: SUCCESS (7.645s)
[419.410938] Subtest flip-vs-panning-interruptible: SUCCESS (30.616s)
[419.590457] [132/133] (604s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[419.684874] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[419.686236] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[419.853621] [133/133] (604s left) gem_ctx_persistence (engines-hang)
[419.892090] Starting subtest: engines-hang
[419.892891] Starting dynamic subtest: rcs0
[419.940771] Dynamic subtest rcs0: SUCCESS (0.048s)
[419.970833] Starting dynamic subtest: bcs0
[419.986559] Dynamic subtest bcs0: SUCCESS (0.044s)
[420.005503] Starting dynamic subtest: vcs0
[420.032685] Dynamic subtest vcs0: SUCCESS (0.044s)
[420.054116] Starting dynamic subtest: vcs1
[420.075715] Dynamic subtest vcs1: SUCCESS (0.041s)
[420.095201] Starting dynamic subtest: vecs0
[420.123607] Dynamic subtest vecs0: SUCCESS (0.046s)
[420.124904] Subtest engines-hang: SUCCESS (0.232s)
[420.199835] Closing watchdogs
results: parsing output: 0/ for test: kms_vblank
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: prime_busy
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_exec_async
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: core_setmaster
results: parsing output: 10/ for test: kms_pm_backlight
results: parsing output: 11/ for test: gem_fence_thrash
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: gem_fence_thrash
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_dp_link_training
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_vblank
results: parsing output: 29/ for test: gem_exec_create
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: i915_pm_rps
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: gem_fenced_exec_thrash
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_chamelium_hpd
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: sysfs_heartbeat_interval
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_pipe_stress
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf_pmu
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: gem_exec_endless
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_compute
results: parsing output: 65/ for test: kms_pm_dc
results: parsing output: 66/ for test: api_intel_allocator
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: i915_drm_fdinfo
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_color_pipeline
results: parsing output: 73/ for test: prime_mmap_kms
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_prop_blob
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_plane_multiple
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_exec_parallel
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: api_intel_bb
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: kms_properties
results: parsing output: 96/ for test: gem_pwrite
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_exec_alignment
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: i915_selftest
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: core_setmaster_vs_auth
results: parsing output: 110/ for test: drm_read
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_addfb_basic
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_content_protection
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr2_su
results: parsing output: 129/ for test: syncobj_eventfd
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: gem_ctx_persistence
Done.