[56.552070] Initializing watchdogs
[56.552117]   /dev/watchdog0
[56.566110] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.570473] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.572817] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.576240] [001/131] (960s left) kms_properties (invalid-properties-atomic)
[56.687390] Starting subtest: invalid-properties-atomic
[56.994423] Subtest invalid-properties-atomic: SUCCESS (0.305s)
[57.088674] [002/131] (960s left) gem_lmem_swapping (heavy-verify-multi)
[57.128869] Subtest heavy-verify-multi: SKIP (0.000s)
[57.170046] [003/131] (959s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[57.258330] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[57.260610] Starting dynamic subtest: pipe-A-eDP-1
[57.283876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[57.294059] Starting dynamic subtest: pipe-B-eDP-1
[57.316229] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[57.325444] Starting dynamic subtest: pipe-C-eDP-1
[57.346632] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[57.353701] Starting dynamic subtest: pipe-D-eDP-1
[57.374591] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[57.378663] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[59.599740] [004/131] (957s left) gem_ctx_shared (q-smoketest-all)
[59.665456] Starting subtest: Q-smoketest-all
[92.046350] Subtest Q-smoketest-all: SUCCESS (32.330s)
[93.020452] [005/131] (924s left) i915_drm_fdinfo (virtual-busy-all)
[93.070838] Starting subtest: virtual-busy-all
[93.075442] Subtest virtual-busy-all: SKIP (0.000s)
[93.193705] [006/131] (924s left) kms_plane_alpha_blend (coverage-7efc)
[93.283907] Starting subtest: coverage-7efc
[93.574883] Starting dynamic subtest: pipe-A-eDP-1
[94.128545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[94.156925] Starting dynamic subtest: pipe-D-eDP-1
[95.474347] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[95.476812] Subtest coverage-7efc: SUCCESS (2.191s)
[96.355201] [007/131] (920s left) kms_flip (2x-nonexisting-fb)
[96.458265] Starting subtest: 2x-nonexisting-fb
[96.468122] Subtest 2x-nonexisting-fb: SKIP (0.012s)
[96.567841] [008/131] (920s left) gem_exec_schedule (pi-shared-iova)
[96.760053] Starting subtest: pi-shared-iova
[96.761979] Starting dynamic subtest: rcs0
[96.835770] Dynamic subtest rcs0: SUCCESS (0.078s)
[96.846783] Starting dynamic subtest: vcs0
[96.892080] Dynamic subtest vcs0: SUCCESS (0.057s)
[96.902698] Starting dynamic subtest: vcs1
[96.948853] Dynamic subtest vcs1: SUCCESS (0.056s)
[96.959236] Starting dynamic subtest: vecs0
[97.002396] Dynamic subtest vecs0: SUCCESS (0.054s)
[97.012983] Starting dynamic subtest: ccs0
[97.058428] Dynamic subtest ccs0: SUCCESS (0.055s)
[97.060924] Subtest pi-shared-iova: SUCCESS (0.301s)
[98.075219] [009/131] (919s left) gem_mmap_wc (coherency)
[98.138219] Subtest coherency: SKIP (0.000s)
[98.201954] [010/131] (919s left) sysfs_defaults (readonly)
[98.263514] Starting subtest: readonly
[98.265845] Starting dynamic subtest: vecs0
[98.268179] Dynamic subtest vecs0: SUCCESS (0.000s)
[98.274911] Starting dynamic subtest: ccs0
[98.276837] Dynamic subtest ccs0: SUCCESS (0.000s)
[98.283834] Starting dynamic subtest: vcs0
[98.286259] Dynamic subtest vcs0: SUCCESS (0.000s)
[98.293381] Starting dynamic subtest: bcs0
[98.295677] Dynamic subtest bcs0: SUCCESS (0.000s)
[98.302661] Starting dynamic subtest: rcs0
[98.304933] Dynamic subtest rcs0: SUCCESS (0.000s)
[98.312302] Starting dynamic subtest: vcs1
[98.314249] Dynamic subtest vcs1: SUCCESS (0.000s)
[98.316109] Subtest readonly: SUCCESS (0.003s)
[98.383499] [011/131] (919s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[98.482043] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[98.486757] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[99.586937] [012/131] (917s left) syncobj_eventfd (invalid-bad-flags)
[99.645243] Starting subtest: invalid-bad-flags
[99.647667] Subtest invalid-bad-flags: SUCCESS (0.000s)
[99.756173] [013/131] (917s left) gen7_exec_parse (basic-rejected)
[99.819079] Subtest basic-rejected: SKIP (0.000s)
[99.892635] [014/131] (917s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[100.001477] Starting subtest: 4-tiled-16bpp-rotate-180
[101.369098] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.369s)
[101.581395] [015/131] (916s left) perf_pmu (busy-double-start)
[101.627338] Starting subtest: busy-double-start
[101.629278] Starting dynamic subtest: rcs0
[105.264953] Dynamic subtest rcs0: FAIL (3.588s)
[105.273672] Starting dynamic subtest: bcs0
[108.787202] Dynamic subtest bcs0: SUCCESS (3.573s)
[108.796915] Starting dynamic subtest: vcs0
[112.435598] Dynamic subtest vcs0: SUCCESS (3.648s)
[112.445554] Starting dynamic subtest: vcs1
[116.464053] Dynamic subtest vcs1: SUCCESS (4.027s)
[116.475440] Starting dynamic subtest: vecs0
[120.446349] Dynamic subtest vecs0: SUCCESS (3.981s)
[120.457496] Starting dynamic subtest: ccs0
[124.084853] Dynamic subtest ccs0: FAIL (3.567s)
[124.086960] Subtest busy-double-start: FAIL (22.388s)
[124.168527] [016/131] (893s left) gem_exec_fence (long-history)
[124.658741] Starting subtest: long-history
[131.684700] Subtest long-history: SUCCESS (7.027s)
[133.024091] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[133.027118] [017/131] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[133.133915] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[133.138209] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[133.272863] [018/131] (884s left) kms_draw_crc (draw-method-mmap-wc)
[133.374299] Starting subtest: draw-method-mmap-wc
[133.376270] Starting dynamic subtest: xrgb8888-untiled
[133.616784] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[133.626118] Starting dynamic subtest: rgb565-untiled
[133.849898] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[133.859612] Starting dynamic subtest: xrgb2101010-untiled
[134.072180] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[134.084209] Starting dynamic subtest: xbgr16161616f-untiled
[134.294815] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[134.303636] Starting dynamic subtest: xrgb8888-xtiled
[134.427109] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[134.435321] Starting dynamic subtest: rgb565-xtiled
[134.560501] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[134.569339] Starting dynamic subtest: xrgb2101010-xtiled
[134.682529] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[134.690913] Starting dynamic subtest: xbgr16161616f-xtiled
[134.816253] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[134.824038] Starting dynamic subtest: xrgb8888-4tiled
[134.971616] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[134.979781] Starting dynamic subtest: rgb565-4tiled
[135.116525] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[135.124337] Starting dynamic subtest: xrgb2101010-4tiled
[135.271589] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[135.280211] Starting dynamic subtest: xbgr16161616f-4tiled
[135.438380] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[135.440341] Subtest draw-method-mmap-wc: SUCCESS (2.068s)
[135.575408] [019/131] (882s left) syncobj_wait (reset-unsignaled)
[135.641137] Starting subtest: reset-unsignaled
[135.642950] Subtest reset-unsignaled: SUCCESS (0.000s)
[135.759857] [020/131] (882s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[135.871140] Starting subtest: 4-tiled-16bpp-rotate-90
[135.893521] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.022s)
[136.054866] [021/131] (881s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[136.186989] Starting subtest: flip-vs-cursor-crc-atomic
[136.858213] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.669s)
[137.699790] [022/131] (880s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[142.770095] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[142.774860] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[143.641576] [023/131] (874s left) gem_ctx_isolation (preservation-reset)
[143.812057] Starting subtest: preservation-reset
[143.814689] Starting dynamic subtest: rcs0
[144.087636] Dynamic subtest rcs0: SUCCESS (0.276s)
[144.098612] Starting dynamic subtest: bcs0
[144.418623] Dynamic subtest bcs0: SUCCESS (0.330s)
[144.427798] Starting dynamic subtest: vcs0
[144.765951] Dynamic subtest vcs0: SUCCESS (0.346s)
[144.775636] Starting dynamic subtest: vcs1
[146.179446] Dynamic subtest vcs1: SUCCESS (1.413s)
[146.190814] Starting dynamic subtest: vecs0
[148.260094] Dynamic subtest vecs0: SUCCESS (2.080s)
[148.274038] Starting dynamic subtest: ccs0
[150.242328] Dynamic subtest ccs0: SUCCESS (1.982s)
[150.244784] Subtest preservation-reset: SUCCESS (6.433s)
[150.415713] [024/131] (867s left) kms_vblank (wait-busy-hang)
[150.522076] Starting subtest: wait-busy-hang
[150.524313] Starting dynamic subtest: pipe-A-eDP-1
[176.667971] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.144s)
[176.681083] Starting dynamic subtest: pipe-D-eDP-1
[201.676553] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.005s)
[201.678502] Subtest wait-busy-hang: SUCCESS (51.153s)
[202.520573] [025/131] (815s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[202.570894] Starting subtest: invalid-multi-wait-unsubmitted
[202.573119] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[202.701250] [026/131] (815s left) gem_exec_schedule (promotion)
[202.780157] Starting subtest: promotion
[202.782084] Starting dynamic subtest: rcs0
[202.877121] Dynamic subtest rcs0: SUCCESS (0.105s)
[202.886709] Starting dynamic subtest: vcs0
[202.969697] Dynamic subtest vcs0: SUCCESS (0.092s)
[202.981211] Starting dynamic subtest: vcs1
[203.054831] Dynamic subtest vcs1: SUCCESS (0.084s)
[203.065718] Starting dynamic subtest: vecs0
[203.136697] Dynamic subtest vecs0: SUCCESS (0.082s)
[203.147694] Starting dynamic subtest: ccs0
[203.232644] Dynamic subtest ccs0: SUCCESS (0.095s)
[203.235271] Subtest promotion: SUCCESS (0.461s)
[205.022204] [027/131] (813s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[205.132312] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[205.136169] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[205.262728] [028/131] (812s left) kms_lease (lease-uevent)
[205.350794] Starting subtest: lease-uevent
[206.367043] Subtest lease-uevent: SUCCESS (1.018s)
[206.498537] [029/131] (811s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[206.592638] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[210.621369] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.032s)
[211.816784] [030/131] (806s left) kms_selftest (drm_damage_helper)
[211.862346] Starting subtest: drm_damage_helper
[211.883128] Starting dynamic subtest: drm_test_damage_iter_no_damage
[212.022422] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.137s)
[212.032619] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[212.175585] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.152s)
[212.185716] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[212.322510] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.147s)
[212.332715] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[212.465249] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.143s)
[212.473490] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[212.596397] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.130s)
[212.606540] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[212.716502] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.120s)
[212.726389] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[212.847266] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.131s)
[212.857421] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[212.983343] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.135s)
[212.993125] Starting dynamic subtest: drm_test_damage_iter_single_damage
[213.111220] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.128s)
[213.121312] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[213.236434] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.124s)
[213.246769] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[213.366559] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.129s)
[213.377108] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[213.484452] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.119s)
[213.494288] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[213.634541] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.149s)
[213.644409] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[213.768256] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.133s)
[213.776852] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[213.907781] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.140s)
[213.918638] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[214.028474] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.120s)
[214.038234] Starting dynamic subtest: drm_test_damage_iter_damage
[214.155069] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.127s)
[214.163157] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[214.321771] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.166s)
[214.330632] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[214.474201] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.152s)
[214.482722] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[214.628107] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.153s)
[214.636451] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[214.772061] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.144s)
[214.773992] Subtest drm_damage_helper: SUCCESS (2.910s)
[214.985260] [031/131] (803s left) perf (rc6-disable)
[215.114643] Starting subtest: rc6-disable
[215.296355] Subtest rc6-disable: SUCCESS (0.183s)
[215.337959] [032/131] (802s left) gem_userptr_blits (invalid-null-pointer)
[215.401467] Starting subtest: invalid-null-pointer
[215.403464] Subtest invalid-null-pointer: SUCCESS (0.001s)
[215.569444] [033/131] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[215.668476] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[215.672759] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[215.798876] [034/131] (802s left) gem_exec_flush (basic-uc-prw-default)
[215.868998] Starting subtest: basic-uc-prw-default
[221.325939] Subtest basic-uc-prw-default: SUCCESS (5.457s)
[221.538161] [035/131] (796s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[221.644669] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[221.649291] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[221.755165] [036/131] (796s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[221.877571] Starting subtest: basic-busy-flip-before-cursor-varying-size
[221.882181] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[222.048189] [037/131] (796s left) gem_ppgtt (shrink-vs-evict-any)
[222.110783] Starting subtest: shrink-vs-evict-any
[229.831342] Subtest shrink-vs-evict-any: SUCCESS (7.721s)
[229.906877] [038/131] (788s left) fbdev (info)
[229.943265] Starting subtest: info
[229.945281] Subtest info: SUCCESS (0.000s)
[230.035982] [039/131] (788s left) syncobj_timeline (invalid-signal-illegal-handle)
[230.092996] Starting subtest: invalid-signal-illegal-handle
[230.095313] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[230.232790] [040/131] (788s left) syncobj_timeline (wait-all-delayed-signal)
[230.292049] Starting subtest: wait-all-delayed-signal
[230.395913] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[230.499367] [041/131] (788s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[230.622944] Starting subtest: 2x-long-flip-vs-cursor-atomic
[230.627546] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[230.792550] [042/131] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[230.883602] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[237.952045] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.071s)
[238.089417] [043/131] (780s left) syncobj_wait (wait-any-snapshot)
[238.155049] Starting subtest: wait-any-snapshot
[238.234968] Subtest wait-any-snapshot: SUCCESS (0.081s)
[238.334608] [044/131] (780s left) gem_ppgtt (blt-vs-render-ctxn)
[238.399685] Starting subtest: blt-vs-render-ctxN
[271.352908] Subtest blt-vs-render-ctxN: SUCCESS (32.950s)
[271.530106] [045/131] (747s left) drm_read (short-buffer-nonblock)
[271.742576] Starting subtest: short-buffer-nonblock
[271.744972] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[271.889183] [046/131] (746s left) prime_vgem (basic-read)
[271.975266] Starting subtest: basic-read
[271.992427] Subtest basic-read: SKIP (0.015s)
[272.141767] [047/131] (746s left) i915_pm_rpm (sysfs-read)
[274.084130] Starting subtest: sysfs-read
[275.252182] Subtest sysfs-read: SUCCESS (1.169s)
[275.652624] [048/131] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[275.753818] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[275.757941] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[275.878478] [049/131] (743s left) gem_ctx_persistence (processes)
[275.942565] Starting subtest: processes
[277.954100] Subtest processes: SUCCESS (2.011s)
[278.059761] [050/131] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[278.168769] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[278.173272] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[278.285779] [051/131] (740s left) kms_pm_rpm (basic-pci-d3-state)
[280.023320] Starting subtest: basic-pci-d3-state
[281.483904] Subtest basic-pci-d3-state: SUCCESS (1.461s)
[281.596240] [052/131] (737s left) kms_plane_scaling (planes-downscale-factor-0-5)
[281.695306] Starting subtest: planes-downscale-factor-0-5
[281.697482] Starting dynamic subtest: pipe-A
[281.717289] Dynamic subtest pipe-A: SKIP (0.018s)
[281.727349] Starting dynamic subtest: pipe-B
[281.750191] Dynamic subtest pipe-B: SKIP (0.032s)
[281.760783] Starting dynamic subtest: pipe-C
[281.780866] Dynamic subtest pipe-C: SKIP (0.032s)
[281.790466] Starting dynamic subtest: pipe-D
[281.812591] Dynamic subtest pipe-D: SKIP (0.031s)
[281.816697] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[281.944516] [053/131] (737s left) kms_cursor_crc (cursor-random-128x128)
[282.161999] Starting subtest: cursor-random-128x128
[282.164258] Starting dynamic subtest: pipe-A-eDP-1
[285.509817] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.345s)
[285.539476] Starting dynamic subtest: pipe-D-eDP-1
[289.551882] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s)
[289.553846] Subtest cursor-random-128x128: SUCCESS (7.390s)
[290.420929] [054/131] (728s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[290.523144] Starting subtest: crc-primary-suspend-y-tiled-ccs
[290.525457] Starting dynamic subtest: pipe-A-eDP-1
[290.534613] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.545467] Starting dynamic subtest: pipe-B-eDP-1
[290.554693] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.564050] Starting dynamic subtest: pipe-C-eDP-1
[290.572697] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.581726] Starting dynamic subtest: pipe-D-eDP-1
[290.589840] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.593663] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[292.788788] [055/131] (726s left) kms_psr (fbc-psr-no-drrs)
[292.889404] Starting subtest: fbc-psr-no-drrs
[292.891605] Starting dynamic subtest: eDP-1
[292.896051] Dynamic subtest eDP-1: SKIP (0.000s)
[292.900514] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[292.986649] [056/131] (726s left) kms_vblank (invalid)
[293.078892] Starting subtest: invalid
[293.081095] Starting dynamic subtest: pipe-A-eDP-1
[293.478420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[293.480388] Subtest invalid: SUCCESS (0.399s)
[294.320883] [057/131] (725s left) kms_pm_backlight (fade)
[294.428280] Starting subtest: fade
[294.476103] Starting dynamic subtest: eDP-1
[297.163172] Dynamic subtest eDP-1: SUCCESS (2.686s)
[297.165341] Subtest fade: SUCCESS (2.736s)
[298.065708] [058/131] (721s left) kms_cursor_edge_walk (128x128-right-edge)
[298.160254] Starting subtest: 128x128-right-edge
[298.162560] Starting dynamic subtest: pipe-A-eDP-1
[301.606150] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[301.616509] Starting dynamic subtest: pipe-D-eDP-1
[304.729975] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[304.732375] Subtest 128x128-right-edge: SUCCESS (6.570s)
[305.572792] [059/131] (713s left) vgem_basic (dmabuf-fence-before)
[305.611678] Starting subtest: dmabuf-fence-before
[305.613897] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[305.692608] [060/131] (713s left) gem_userptr_blits (create-destroy-unsync)
[305.764948] Subtest create-destroy-unsync: SKIP (0.000s)
[305.922036] [061/131] (713s left) kms_chamelium_frames (vga-frame-dump)
[306.301882] Subtest vga-frame-dump: SKIP (0.000s)
[307.150330] [062/131] (712s left) perf_pmu (init-busy)
[307.196454] Starting subtest: init-busy
[307.198721] Starting dynamic subtest: rcs0
[307.200977] Dynamic subtest rcs0: SUCCESS (0.001s)
[307.210962] Starting dynamic subtest: bcs0
[307.213612] Dynamic subtest bcs0: SUCCESS (0.000s)
[307.222846] Starting dynamic subtest: vcs0
[307.225105] Dynamic subtest vcs0: SUCCESS (0.001s)
[307.234179] Starting dynamic subtest: vcs1
[307.236124] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.245172] Starting dynamic subtest: vecs0
[307.247090] Dynamic subtest vecs0: SUCCESS (0.001s)
[307.256247] Starting dynamic subtest: ccs0
[307.258124] Dynamic subtest ccs0: SUCCESS (0.000s)
[307.259983] Subtest init-busy: SUCCESS (0.007s)
[307.349528] [063/131] (712s left) gem_exec_whisper (basic-fds-all)
[307.422761] Starting subtest: basic-fds-all
[318.934995] Subtest basic-fds-all: SUCCESS (11.509s)
[319.140905] [064/131] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[319.249230] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[319.253244] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[319.393084] [065/131] (700s left) perf_pmu (invalid-init)
[319.427761] Starting subtest: invalid-init
[319.429789] Subtest invalid-init: SUCCESS (0.000s)
[319.572355] [066/131] (700s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[319.664437] Starting subtest: fbc-psr2-sprite-mmap-gtt
[319.666357] Starting dynamic subtest: eDP-1
[319.670424] Dynamic subtest eDP-1: SKIP (0.000s)
[319.674527] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[319.761519] [067/131] (699s left) syncobj_wait (multi-wait-all-submitted-signaled)
[319.824499] Starting subtest: multi-wait-all-submitted-signaled
[319.928138] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[320.027326] [068/131] (699s left) gem_userptr_blits (coherency-unsync)
[320.102216] Subtest coherency-unsync: SKIP (0.000s)
[320.234233] [069/131] (699s left) kms_invalid_mode (zero-hdisplay)
[320.343277] Starting subtest: zero-hdisplay
[320.345455] Starting dynamic subtest: pipe-A-eDP-1
[320.630264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[320.641030] Starting dynamic subtest: pipe-B-eDP-1
[320.642926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[320.652243] Starting dynamic subtest: pipe-C-eDP-1
[320.654379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[320.663310] Starting dynamic subtest: pipe-D-eDP-1
[320.665643] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[320.668059] Subtest zero-hdisplay: SUCCESS (0.290s)
[321.517812] [070/131] (698s left) gem_mmap_gtt (isolation)
[321.582778] Subtest isolation: SKIP (0.000s)
[321.653899] [071/131] (698s left) gem_create (busy-create)
[321.719315] Starting subtest: busy-create
[321.721769] Starting dynamic subtest: smem0
[354.871299] Dynamic subtest smem0: SUCCESS (33.150s)
[354.873990] Subtest busy-create: SUCCESS (33.152s)
[355.087051] [072/131] (664s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[355.205262] Starting subtest: x-tiled-64bpp-rotate-180
[356.757356] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.554s)
[356.981906] [073/131] (663s left) gen7_exec_parse (basic-allocation)
[357.043416] Subtest basic-allocation: SKIP (0.000s)
[357.117407] [074/131] (662s left) dmabuf_sync_file (export-before-signal)
[357.161539] Starting subtest: export-before-signal
[357.163480] Subtest export-before-signal: SUCCESS (0.000s)
[357.241831] [075/131] (662s left) api_intel_allocator (standalone)
[357.302883] Starting subtest: standalone
[357.321418] Subtest standalone: SUCCESS (0.019s)
[357.472292] [076/131] (662s left) gem_exec_create (legacy)
[357.542826] Starting subtest: legacy
[357.545088] Starting dynamic subtest: smem
[359.892345] Dynamic subtest smem: SUCCESS (2.348s)
[359.895075] Subtest legacy: SUCCESS (2.349s)
[360.105842] [077/131] (660s left) gem_create (create-invalid-size)
[360.161380] Starting subtest: create-invalid-size
[360.163357] Subtest create-invalid-size: SUCCESS (0.000s)
[360.375542] [078/131] (659s left) gem_softpin (allocator-evict)
[360.439660] Starting subtest: allocator-evict
[360.442112] Starting dynamic subtest: rcs0
[384.611080] Dynamic subtest rcs0: SUCCESS (24.171s)
[384.623339] Starting dynamic subtest: bcs0
[408.300919] Dynamic subtest bcs0: SUCCESS (23.687s)
[408.311863] Starting dynamic subtest: vcs0
[431.956381] Dynamic subtest vcs0: SUCCESS (23.653s)
[431.968937] Starting dynamic subtest: vcs1
[455.508241] Dynamic subtest vcs1: SUCCESS (23.551s)
[455.518501] Starting dynamic subtest: vecs0
[479.250599] Dynamic subtest vecs0: SUCCESS (23.741s)
[479.262028] Starting dynamic subtest: ccs0
[503.402845] Dynamic subtest ccs0: SUCCESS (24.151s)
[503.405233] Subtest allocator-evict: SUCCESS (142.963s)
[503.508744] [079/131] (516s left) kms_addfb_basic (bad-pitch-128)
[503.611789] Starting subtest: bad-pitch-128
[503.613843] Subtest bad-pitch-128: SUCCESS (0.000s)
[503.795502] [080/131] (516s left) gem_userptr_blits (sync-overlap)
[503.861514] Starting subtest: sync-overlap
[503.863502] Subtest sync-overlap: SUCCESS (0.000s)
[504.018227] [081/131] (516s left) kms_flip (wf_vblank-ts-check-interruptible)
[504.120638] Starting subtest: wf_vblank-ts-check-interruptible
[504.122415] Starting dynamic subtest: A-eDP1
[513.024419] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[513.039355] Starting dynamic subtest: B-eDP1
[521.954562] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[521.968089] Starting dynamic subtest: C-eDP1
[530.878374] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[530.892413] Starting dynamic subtest: D-eDP1
[539.801416] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[539.807465] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.684s)
[541.052909] [082/131] (479s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[541.157691] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[541.162055] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[541.275012] [083/131] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[541.371418] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[548.740354] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.370s)
[548.902422] [084/131] (471s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[549.000614] Starting subtest: psr-modesetfrombusy
[555.131341] Subtest psr-modesetfrombusy: SUCCESS (6.134s)
[555.308947] [085/131] (465s left) gem_eio (in-flight-contexts-1us)
[555.551698] Starting subtest: in-flight-contexts-1us
[566.945462] Subtest in-flight-contexts-1us: SUCCESS (11.390s)
[567.153527] [086/131] (453s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[567.251179] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[567.253425] Starting dynamic subtest: pipe-A-eDP-1
[567.275120] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.290436] Starting dynamic subtest: pipe-B-eDP-1
[567.311673] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.324962] Starting dynamic subtest: pipe-C-eDP-1
[567.346709] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.357182] Starting dynamic subtest: pipe-D-eDP-1
[567.378696] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.383081] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[569.494510] [087/131] (451s left) kms_cursor_crc (cursor-offscreen-512x512)
[569.798860] Starting subtest: cursor-offscreen-512x512
[569.803321] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[570.010303] [088/131] (450s left) i915_query (query-garbage)
[570.070600] Starting subtest: query-garbage
[570.072582] Subtest query-garbage: SUCCESS (0.000s)
[570.194028] [089/131] (450s left) kms_pipe_crc_basic (hang-read-crc)
[570.296603] Starting subtest: hang-read-crc
[570.298930] Starting dynamic subtest: pipe-A-eDP-1
[572.360458] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[572.370695] Starting dynamic subtest: pipe-B-eDP-1
[575.029941] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.667s)
[575.040260] Starting dynamic subtest: pipe-C-eDP-1
[577.655295] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s)
[577.665900] Starting dynamic subtest: pipe-D-eDP-1
[580.290563] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s)
[580.292953] Subtest hang-read-crc: SUCCESS (9.993s)
[581.143789] [090/131] (439s left) syncobj_timeline (reset-unsignaled)
[581.215761] Starting subtest: reset-unsignaled
[581.218264] Subtest reset-unsignaled: SUCCESS (0.000s)
[581.358382] [091/131] (439s left) kms_pm_rpm (pm-tiling)
[583.096219] Starting subtest: pm-tiling
[583.101102] Subtest pm-tiling: SKIP (0.000s)
[583.682716] [092/131] (437s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[583.795308] Starting subtest: cursorA-vs-flipB-toggle
[583.799778] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[583.967521] [093/131] (436s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[584.066106] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[584.068355] Starting dynamic subtest: pipe-A-default-mode
[584.354599] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[584.358990] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.288s)
[585.199149] [094/131] (435s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[585.304438] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[592.224842] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.921s)
[592.397523] [095/131] (428s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[592.795905] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[593.631898] [096/131] (427s left) i915_suspend (debugfs-reader)
[593.694261] Starting subtest: debugfs-reader
[611.607481] Subtest debugfs-reader: SUCCESS (6.969s)
[611.782550] [097/131] (409s left) i915_hangman (gt-error-state-capture)
[611.876608] Starting subtest: gt-error-state-capture
[611.879016] Starting dynamic subtest: rcs0
[623.796318] Dynamic subtest rcs0: SUCCESS (11.909s)
[623.811818] Starting dynamic subtest: bcs0
[634.804232] Dynamic subtest bcs0: SUCCESS (11.001s)
[634.818121] Starting dynamic subtest: vcs0
[645.746662] Dynamic subtest vcs0: SUCCESS (10.940s)
[645.763989] Starting dynamic subtest: vcs1
[655.795525] Dynamic subtest vcs1: SUCCESS (10.047s)
[655.809356] Starting dynamic subtest: vecs0
[667.763048] Dynamic subtest vecs0: SUCCESS (11.965s)
[667.776168] Starting dynamic subtest: ccs0
[679.795395] Dynamic subtest ccs0: SUCCESS (12.029s)
[679.798164] Subtest gt-error-state-capture: SUCCESS (67.906s)
[679.912634] [098/131] (341s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[680.031896] Starting subtest: fbc-rgb565-draw-blt
[684.205999] Subtest fbc-rgb565-draw-blt: SUCCESS (4.178s)
[685.417095] [099/131] (335s left) gem_render_copy (yf-tiled-ccs-to-linear)
[685.478606] Starting subtest: yf-tiled-ccs-to-linear
[685.483446] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[685.687420] [100/131] (335s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[690.770842] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[690.773235] Starting dynamic subtest: pipe-A-eDP-1
[691.567166] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[691.578004] Starting dynamic subtest: pipe-B-eDP-1
[692.702430] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[692.706719] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.932s)
[693.906650] [101/131] (327s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[693.969659] Starting subtest: etime-multi-wait-all-available-unsubmitted
[694.073198] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[694.172062] [102/131] (327s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[694.262577] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[694.264847] Starting dynamic subtest: pipe-A-default-mode
[697.004897] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[697.007019] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.742s)
[697.888286] [103/131] (323s left) kms_flip (2x-absolute-wf_vblank)
[697.974662] Starting subtest: 2x-absolute-wf_vblank
[697.983582] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[698.126748] [104/131] (323s left) gem_pread (display)
[698.191363] Subtest display: SKIP (0.000s)
[698.263970] [105/131] (323s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[698.371216] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[698.375272] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[698.511010] [106/131] (323s left) kms_psr (pr-no-drrs)
[698.606976] Starting subtest: pr-no-drrs
[698.611245] Subtest pr-no-drrs: SKIP (0.000s)
[698.707477] [107/131] (322s left) gem_mmap_gtt (cpuset-big-copy-xy)
[698.768064] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[698.837527] [108/131] (322s left) kms_psr (fbc-pr-primary-blt)
[698.936795] Starting subtest: fbc-pr-primary-blt
[698.939984] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[699.034586] [109/131] (322s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[699.096216] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[699.201409] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[699.302606] [110/131] (322s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[699.394084] Starting subtest: primary-yf-tiled-reflect-x-180
[699.464716] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.070s)
[699.600477] [111/131] (322s left) kms_big_fb (linear-8bpp-rotate-180)
[699.705415] Starting subtest: linear-8bpp-rotate-180
[701.003952] Subtest linear-8bpp-rotate-180: SUCCESS (1.299s)
[701.165271] [112/131] (320s left) kms_flip (2x-flip-vs-dpms)
[701.263442] Starting subtest: 2x-flip-vs-dpms
[701.272261] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[701.375509] [113/131] (320s left) gem_ringfill (engines-basic)
[706.840738] Starting subtest: engines-basic
[706.843214] Starting dynamic subtest: rcs0
[706.929604] Dynamic subtest rcs0: SUCCESS (0.089s)
[706.942641] Starting dynamic subtest: bcs0
[706.973542] Dynamic subtest bcs0: SUCCESS (0.042s)
[706.985071] Starting dynamic subtest: vcs0
[707.017658] Dynamic subtest vcs0: SUCCESS (0.042s)
[707.028843] Starting dynamic subtest: vcs1
[707.060829] Dynamic subtest vcs1: SUCCESS (0.041s)
[707.071820] Starting dynamic subtest: vecs0
[707.103898] Dynamic subtest vecs0: SUCCESS (0.041s)
[707.117064] Starting dynamic subtest: ccs0
[707.153631] Dynamic subtest ccs0: SUCCESS (0.047s)
[707.156304] Subtest engines-basic: SUCCESS (0.315s)
[707.264275] [114/131] (314s left) api_intel_bb (simple-bb-ctx)
[707.323747] Starting subtest: simple-bb-ctx
[707.334581] Subtest simple-bb-ctx: SUCCESS (0.014s)
[707.483227] [115/131] (314s left) kms_psr (psr-primary-blt)
[707.595574] Starting subtest: psr-primary-blt
[707.597800] Starting dynamic subtest: eDP-1
[709.371325] Dynamic subtest eDP-1: SUCCESS (1.773s)
[709.373349] Subtest psr-primary-blt: SUCCESS (1.774s)
[710.271068] [116/131] (311s left) gem_exec_fence (syncobj-timeline-signal)
[710.792742] Starting subtest: syncobj-timeline-signal
[710.799923] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[711.971550] [117/131] (310s left) vgem_slow (nohang)
[712.020591] Starting subtest: nohang
[722.228080] Subtest nohang: SUCCESS (10.206s)
[722.323983] [118/131] (299s left) kms_flip (basic-flip-vs-dpms)
[722.429730] Starting subtest: basic-flip-vs-dpms
[722.431859] Starting dynamic subtest: A-eDP1
[725.054206] Dynamic subtest A-eDP1: SUCCESS (2.621s)
[725.065669] Starting dynamic subtest: B-eDP1
[727.241488] Dynamic subtest B-eDP1: SUCCESS (2.186s)
[727.251866] Starting dynamic subtest: C-eDP1
[729.326423] Dynamic subtest C-eDP1: SUCCESS (2.085s)
[729.336885] Starting dynamic subtest: D-eDP1
[731.409432] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[731.411454] Subtest basic-flip-vs-dpms: SUCCESS (8.978s)
[732.234371] [119/131] (289s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[732.332740] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[732.336639] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[732.465685] [120/131] (289s left) gem_userptr_blits (usage-restrictions)
[732.539528] Starting subtest: usage-restrictions
[732.541488] Subtest usage-restrictions: SUCCESS (0.000s)
[732.721694] [121/131] (289s left) kms_flip (flip-vs-suspend-interruptible)
[732.808790] Starting subtest: flip-vs-suspend-interruptible
[732.811121] Starting dynamic subtest: A-eDP1
[781.632899] Dynamic subtest A-eDP1: SUCCESS (4.597s)
[781.650110] Starting dynamic subtest: B-eDP1
[830.623628] Dynamic subtest B-eDP1: SUCCESS (4.474s)
[830.641224] Starting dynamic subtest: C-eDP1
[879.617363] Dynamic subtest C-eDP1: SUCCESS (4.482s)
[879.632005] Starting dynamic subtest: D-eDP1
[928.631989] Dynamic subtest D-eDP1: SUCCESS (4.549s)
[928.636368] Subtest flip-vs-suspend-interruptible: SUCCESS (18.113s)
[929.834888] [122/131] ( 92s left) kms_color (ctm-signed)
[929.952955] Starting subtest: ctm-signed
[929.955352] Starting dynamic subtest: pipe-A-eDP-1
[932.089717] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.138s)
[932.101020] Starting dynamic subtest: pipe-B-eDP-1
[934.948456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.854s)
[934.959796] Starting dynamic subtest: pipe-C-eDP-1
[937.663753] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.715s)
[937.675126] Starting dynamic subtest: pipe-D-eDP-1
[940.342453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.674s)
[940.344471] Subtest ctm-signed: SUCCESS (10.385s)
[941.180725] [123/131] ( 81s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[941.285966] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[941.290154] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[941.421842] [124/131] ( 80s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[941.524718] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[941.528841] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[941.654089] [125/131] ( 80s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[941.756435] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[941.758850] Starting dynamic subtest: pipe-A-eDP-1
[941.783382] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[941.796853] Starting dynamic subtest: pipe-B-eDP-1
[941.819725] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[941.830390] Starting dynamic subtest: pipe-C-eDP-1
[941.853982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[941.864101] Starting dynamic subtest: pipe-D-eDP-1
[941.890485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[941.895153] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[943.975451] [126/131] ( 78s left) gem_ctx_param (set-priority-range)
[944.050449] Starting subtest: set-priority-range
[944.069874] Subtest set-priority-range: SUCCESS (0.020s)
[944.212863] [127/131] ( 78s left) kms_async_flips (alternate-sync-async-flip-atomic)
[944.317841] Starting subtest: alternate-sync-async-flip-atomic
[944.693644] Starting dynamic subtest: pipe-A-eDP-1
[947.439436] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.745s)
[947.829424] Starting dynamic subtest: pipe-B-eDP-1
[950.576546] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[950.964293] Starting dynamic subtest: pipe-C-eDP-1
[953.702413] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.748s)
[954.086949] Starting dynamic subtest: pipe-D-eDP-1
[956.829998] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.752s)
[956.831913] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.513s)
[958.040070] [128/131] ( 64s left) gem_mmap_gtt (big-copy)
[958.109353] Subtest big-copy: SKIP (0.000s)
[958.191241] [129/131] ( 64s left) gem_exec_balancer (nop)
[958.254021] Starting subtest: nop
[1004.794350] Subtest nop: SUCCESS (46.546s)
[1005.144701] [130/131] ( 17s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[1005.250186] Starting subtest: y-tiled-16bpp-rotate-90
[1005.254593] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[1005.385359] [131/131] ( 17s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[1005.492297] Starting subtest: yf-tiled-16bpp-rotate-270
[1005.496889] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[1005.611064] Closing watchdogs
results: parsing output: 0/ for test: kms_properties
results: parsing output: 1/ for test: gem_lmem_swapping
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: i915_drm_fdinfo
results: parsing output: 5/ for test: kms_plane_alpha_blend
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: gem_mmap_wc
results: parsing output: 9/ for test: sysfs_defaults
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: syncobj_eventfd
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: gem_ctx_isolation
results: parsing output: 23/ for test: kms_vblank
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_selftest
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_exec_flush
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_ppgtt
results: parsing output: 37/ for test: fbdev
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: gem_ppgtt
results: parsing output: 44/ for test: drm_read
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: i915_pm_rpm
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_vblank
results: parsing output: 56/ for test: kms_pm_backlight
results: parsing output: 57/ for test: kms_cursor_edge_walk
results: parsing output: 58/ for test: vgem_basic
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_chamelium_frames
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_invalid_mode
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gen7_exec_parse
results: parsing output: 73/ for test: dmabuf_sync_file
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: gem_exec_create
results: parsing output: 76/ for test: gem_create
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: i915_query
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: i915_suspend
results: parsing output: 96/ for test: i915_hangman
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_ringfill
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: vgem_slow
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_color
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
Done.