[59.325525] Initializing watchdogs
[59.325570]   /dev/watchdog0
[59.340230] [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]
[59.344723] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.347114] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.349240] [001/134] (960s left) api_intel_allocator (reopen-fork)
[59.413834] Starting subtest: reopen-fork
[63.169555] Subtest reopen-fork: SUCCESS (3.750s)
[63.251538] [002/134] (956s left) gen9_exec_parse (unaligned-jump)
[63.303748] Subtest unaligned-jump: SKIP (0.000s)
[63.375883] [003/134] (956s left) i915_pm_rc6_residency (rc6-accuracy)
[63.432040] Starting subtest: rc6-accuracy
[63.432986] Starting dynamic subtest: gt0
[66.605368] Dynamic subtest gt0: SUCCESS (3.167s)
[66.612045] Starting dynamic subtest: gt1
[69.775520] Dynamic subtest gt1: SUCCESS (3.166s)
[69.776920] Subtest rc6-accuracy: SUCCESS (6.337s)
[69.851343] [004/134] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[69.955568] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[78.318717] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.362s)
[78.467773] [005/134] (941s left) gem_exec_reloc (basic-cpu-gtt-active)
[78.525183] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[78.576950] [006/134] (941s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[78.662699] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[78.663717] Starting dynamic subtest: pipe-A
[79.002317] Dynamic subtest pipe-A: SUCCESS (0.339s)
[79.009461] Starting dynamic subtest: pipe-B
[80.423575] Dynamic subtest pipe-B: SUCCESS (1.421s)
[80.429394] Starting dynamic subtest: pipe-C
[81.890051] Dynamic subtest pipe-C: SUCCESS (1.466s)
[81.897074] Starting dynamic subtest: pipe-D
[83.294112] Dynamic subtest pipe-D: SUCCESS (1.403s)
[83.295210] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.631s)
[84.457322] [007/134] (935s left) kms_plane_cursor (overlay)
[84.552948] Starting subtest: overlay
[84.555227] Starting dynamic subtest: pipe-A-eDP-1-size-64
[86.953895] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.401s)
[87.010514] Starting dynamic subtest: pipe-A-eDP-1-size-128
[89.421640] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.418s)
[89.478677] Starting dynamic subtest: pipe-A-eDP-1-size-256
[91.932059] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.460s)
[92.278702] Starting dynamic subtest: pipe-B-eDP-1-size-64
[95.451305] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.178s)
[95.510419] Starting dynamic subtest: pipe-B-eDP-1-size-128
[98.007060] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[98.066194] Starting dynamic subtest: pipe-B-eDP-1-size-256
[100.454316] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.395s)
[100.800149] Starting dynamic subtest: pipe-C-eDP-1-size-64
[103.502763] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.709s)
[103.538630] Starting dynamic subtest: pipe-C-eDP-1-size-128
[105.570048] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.036s)
[105.606068] Starting dynamic subtest: pipe-C-eDP-1-size-256
[107.637646] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.037s)
[107.975252] Starting dynamic subtest: pipe-D-eDP-1-size-64
[110.729153] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.759s)
[110.765369] Starting dynamic subtest: pipe-D-eDP-1-size-128
[112.807257] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.047s)
[112.843294] Starting dynamic subtest: pipe-D-eDP-1-size-256
[114.862661] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.025s)
[115.178599] Subtest overlay: SUCCESS (30.624s)
[115.977422] [008/134] (904s left) sw_sync (alloc_fence)
[116.014139] Starting subtest: alloc_fence
[116.015160] Subtest alloc_fence: SUCCESS (0.000s)
[116.080471] [009/134] (904s left) gen9_exec_parse (batch-invalid-length)
[116.139390] Subtest batch-invalid-length: SKIP (0.000s)
[116.200097] [010/134] (903s left) gem_mmap_offset (blt-coherency)
[116.256141] Starting subtest: blt-coherency
[116.264108] Subtest blt-coherency: SUCCESS (0.009s)
[116.385672] [011/134] (903s left) kms_psr (pr-primary-page-flip)
[116.478337] Starting subtest: pr-primary-page-flip
[116.480063] Subtest pr-primary-page-flip: SKIP (0.000s)
[116.553624] [012/134] (903s left) kms_vblank (query-busy-hang)
[116.641068] Starting subtest: query-busy-hang
[116.643344] Starting dynamic subtest: pipe-A-eDP-1
[142.686787] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.043s)
[142.696153] Starting dynamic subtest: pipe-D-eDP-1
[157.733647] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[157.734640] Subtest query-busy-hang: SUCCESS (41.091s)
[158.538334] [013/134] (861s left) gem_softpin (allocator-evict)
[158.617650] Starting subtest: allocator-evict
[158.618796] Starting dynamic subtest: rcs0
[182.203823] Dynamic subtest rcs0: SUCCESS (23.585s)
[182.211829] Starting dynamic subtest: bcs0
[205.936886] Dynamic subtest bcs0: SUCCESS (23.731s)
[205.947679] Starting dynamic subtest: vcs0
[229.668614] Dynamic subtest vcs0: SUCCESS (23.729s)
[229.678797] Starting dynamic subtest: vcs1
[253.343403] Dynamic subtest vcs1: SUCCESS (23.672s)
[253.352531] Starting dynamic subtest: vecs0
[276.975337] Dynamic subtest vecs0: SUCCESS (23.630s)
[276.984055] Starting dynamic subtest: ccs0
[300.718780] Dynamic subtest ccs0: SUCCESS (23.741s)
[300.720097] Subtest allocator-evict: SUCCESS (142.097s)
[300.803037] [014/134] (719s left) kms_chamelium_color (ctm-max)
[300.928461] Subtest ctm-max: SKIP (0.000s)
[300.965816] [015/134] (719s left) syncobj_timeline (single-wait-signaled)
[301.021331] Starting subtest: single-wait-signaled
[301.022317] Subtest single-wait-signaled: SUCCESS (0.000s)
[301.137548] [016/134] (719s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[301.236410] Starting subtest: fbc-shrfb-scaledprimary
[304.231021] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.995s)
[305.424512] [017/134] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[305.530131] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[305.531859] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[305.644802] [018/134] (714s left) prime_mmap (test_correct_cpu_write)
[305.705415] Starting subtest: test_correct_cpu_write
[305.706398] Starting dynamic subtest: test_correct_cpu_write-smem
[305.707397] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[305.708387] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[305.815699] [019/134] (714s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[305.917456] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[309.914491] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.997s)
[311.039892] [020/134] (709s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[311.101059] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[311.102968] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[311.287126] [021/134] (709s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[311.422294] Starting subtest: basic-flip-after-cursor-atomic
[312.358049] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.935s)
[313.143788] [022/134] (707s left) gem_ctx_create (basic-files)
[313.214534] Starting subtest: basic-files
[315.257873] Subtest basic-files: SUCCESS (2.043s)
[316.931866] [023/134] (703s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[317.074959] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[317.076585] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[317.233246] [024/134] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[317.321631] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[317.323253] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[317.449894] [025/134] (703s left) syncobj_basic (bad-flags-fd-to-handle)
[317.502895] Starting subtest: bad-flags-fd-to-handle
[317.503860] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[317.615393] [026/134] (702s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[317.669626] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[317.771904] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[317.849928] [027/134] (702s left) kms_pm_dc (dc6-dpms)
[318.961089] Starting subtest: dc6-dpms
[321.026844] Subtest dc6-dpms: SUCCESS (2.063s)
[321.107078] [028/134] (699s left) gem_exec_reloc (basic-write-gtt-noreloc)
[321.167956] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[321.241883] [029/134] (699s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[321.344185] Starting subtest: y-tiled-64bpp-rotate-270
[321.345945] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[321.469260] [030/134] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[321.567778] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[321.569566] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[321.681575] [031/134] (699s left) kms_content_protection (content-type-change)
[321.816728] Starting subtest: content-type-change
[321.818732] Subtest content-type-change: SKIP (0.000s)
[321.960414] [032/134] (698s left) kms_cursor_crc (cursor-sliding-32x32)
[322.106138] Starting subtest: cursor-sliding-32x32
[322.145705] Subtest cursor-sliding-32x32: SKIP (0.038s)
[322.423485] [033/134] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[322.510081] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[322.511903] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[322.612735] [034/134] (698s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[322.728641] Starting subtest: short-flip-after-cursor-atomic-transitions
[323.684152] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.955s)
[324.521925] [035/134] (696s left) gem_ctx_shared (disjoint-timelines)
[324.580731] Starting subtest: disjoint-timelines
[324.651772] Subtest disjoint-timelines: SUCCESS (0.071s)
[324.880905] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[324.882558] [036/134] (696s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[324.967228] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[332.225262] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.259s)
[332.367032] [037/134] (688s left) prime_busy (hang)
[332.425041] Starting subtest: hang
[332.426985] Starting dynamic subtest: rcs0
[358.456653] Dynamic subtest rcs0: SUCCESS (26.028s)
[358.465285] Starting dynamic subtest: bcs0
[365.545975] Dynamic subtest bcs0: SUCCESS (7.086s)
[365.552615] Starting dynamic subtest: vcs0
[372.580317] Dynamic subtest vcs0: SUCCESS (7.033s)
[372.586592] Starting dynamic subtest: vcs1
[379.559490] Dynamic subtest vcs1: SUCCESS (6.978s)
[379.565884] Starting dynamic subtest: vecs0
[386.594802] Dynamic subtest vecs0: SUCCESS (7.034s)
[386.603224] Starting dynamic subtest: ccs0
[400.435806] Dynamic subtest ccs0: SUCCESS (13.840s)
[400.437120] Subtest hang: SUCCESS (68.007s)
[400.581796] [038/134] (620s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[400.675248] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[400.676921] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[400.781917] [039/134] (620s left) sysfs_preempt_timeout (timeout)
[400.842407] Starting subtest: timeout
[400.843403] Starting dynamic subtest: vecs0
[410.922434] Dynamic subtest vecs0: SUCCESS (10.076s)
[410.930474] Starting dynamic subtest: ccs0
[412.142428] Dynamic subtest ccs0: SUCCESS (1.220s)
[412.152738] Starting dynamic subtest: vcs0
[421.928334] Dynamic subtest vcs0: SUCCESS (9.782s)
[421.940041] Starting dynamic subtest: bcs0
[423.195479] Dynamic subtest bcs0: SUCCESS (1.266s)
[423.203983] Starting dynamic subtest: rcs0
[424.566417] Dynamic subtest rcs0: SUCCESS (1.370s)
[424.576102] Starting dynamic subtest: vcs1
[433.887679] Dynamic subtest vcs1: SUCCESS (9.315s)
[433.889555] Subtest timeout: SUCCESS (33.042s)
[433.980155] [040/134] (587s left) gem_pwrite (basic-random)
[434.040924] Subtest basic-random: SKIP (0.000s)
[434.105855] [041/134] (586s left) kms_vblank (ts-continuation-dpms-rpm)
[434.217092] Starting subtest: ts-continuation-dpms-rpm
[434.218277] Starting dynamic subtest: pipe-A-eDP-1
[436.724414] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[436.733081] Starting dynamic subtest: pipe-D-eDP-1
[438.985744] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[438.986590] Subtest ts-continuation-dpms-rpm: SUCCESS (4.768s)
[439.786399] [042/134] (581s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[440.161997] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[440.985086] [043/134] (580s left) prime_self_import (basic-with_one_bo_two_files)
[441.017210] Starting subtest: basic-with_one_bo_two_files
[441.045561] Subtest basic-with_one_bo_two_files: SUCCESS (0.029s)
[441.156699] [044/134] (579s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[441.253244] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[441.254029] Starting dynamic subtest: pipe-A-default-mode
[441.537860] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[441.539585] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.285s)
[442.353517] [045/134] (578s left) gem_exec_reloc (basic-gtt)
[442.415496] Subtest basic-gtt: SKIP (0.000s)
[442.490891] [046/134] (578s left) kms_big_fb (linear-32bpp-rotate-0)
[442.593321] Starting subtest: linear-32bpp-rotate-0
[443.982862] Subtest linear-32bpp-rotate-0: SUCCESS (1.390s)
[444.156934] [047/134] (577s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[444.255332] Starting subtest: basic-max-pipe-crc-check
[444.257092] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[444.299660] [048/134] (576s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[449.330146] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[449.332066] Starting dynamic subtest: pipe-A-eDP-1
[455.952072] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.619s)
[455.959936] Starting dynamic subtest: pipe-B-eDP-1
[462.622511] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.668s)
[462.623350] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.292s)
[463.503722] [049/134] (557s left) drm_read (short-buffer-block)
[463.656046] Starting subtest: short-buffer-block
[463.657033] Subtest short-buffer-block: SUCCESS (0.000s)
[463.797428] [050/134] (557s left) gem_ctx_persistence (many-contexts)
[463.853089] Starting subtest: many-contexts
[502.230463] Subtest many-contexts: SUCCESS (38.376s)
[502.315875] [051/134] (519s left) prime_mmap (test_correct)
[502.383965] Starting subtest: test_correct
[502.384963] Starting dynamic subtest: test_correct-smem
[502.438524] Dynamic subtest test_correct-smem: SUCCESS (0.054s)
[502.439817] Subtest test_correct: SUCCESS (0.055s)
[502.562097] [052/134] (518s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[502.617999] Starting subtest: invalid-multi-wait-all-unsubmitted
[502.618960] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[502.741520] [053/134] (518s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[502.851502] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[503.841798] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.990s)
[503.993413] [054/134] (517s left) gem_mmap_gtt (basic-copy)
[504.045605] Subtest basic-copy: SKIP (0.000s)
[504.110802] [055/134] (517s left) gem_exec_suspend (basic)
[504.171588] Starting subtest: basic
[504.172567] Starting dynamic subtest: smem
[505.945392] Dynamic subtest smem: SUCCESS (1.772s)
[505.946933] Subtest basic: SUCCESS (1.774s)
[506.134710] [056/134] (515s left) perf_pmu (busy-accuracy-2)
[506.174923] Starting subtest: busy-accuracy-2
[506.175768] Starting dynamic subtest: rcs0
[509.221346] Dynamic subtest rcs0: SUCCESS (3.045s)
[509.232616] Starting dynamic subtest: bcs0
[512.281699] Dynamic subtest bcs0: SUCCESS (3.057s)
[512.291541] Starting dynamic subtest: vcs0
[515.329763] Dynamic subtest vcs0: SUCCESS (3.045s)
[515.339599] Starting dynamic subtest: vcs1
[518.376711] Dynamic subtest vcs1: SUCCESS (3.045s)
[518.385557] Starting dynamic subtest: vecs0
[521.424169] Dynamic subtest vecs0: SUCCESS (3.045s)
[521.433461] Starting dynamic subtest: ccs0
[524.484139] Dynamic subtest ccs0: SUCCESS (3.057s)
[524.485144] Subtest busy-accuracy-2: SUCCESS (18.309s)
[524.617023] [057/134] (496s left) gem_wait (await)
[524.676298] Starting subtest: await
[524.677319] Starting dynamic subtest: all-engines
[525.830961] Dynamic subtest all-engines: SUCCESS (1.154s)
[525.846650] Starting dynamic subtest: rcs0
[526.894989] Dynamic subtest rcs0: SUCCESS (1.062s)
[526.911647] Starting dynamic subtest: bcs0
[527.957828] Dynamic subtest bcs0: SUCCESS (1.060s)
[527.974442] Starting dynamic subtest: vcs0
[529.013662] Dynamic subtest vcs0: SUCCESS (1.053s)
[529.029094] Starting dynamic subtest: vcs1
[530.066388] Dynamic subtest vcs1: SUCCESS (1.051s)
[530.082265] Starting dynamic subtest: vecs0
[531.122456] Dynamic subtest vecs0: SUCCESS (1.054s)
[531.138628] Starting dynamic subtest: ccs0
[532.178895] Dynamic subtest ccs0: SUCCESS (1.054s)
[532.181997] Subtest await: SUCCESS (7.504s)
[532.393431] [058/134] (489s left) prime_mmap (test_refcounting)
[532.462068] Starting subtest: test_refcounting
[532.463123] Starting dynamic subtest: test_refcounting-smem
[532.541644] Dynamic subtest test_refcounting-smem: SUCCESS (0.078s)
[532.543157] Subtest test_refcounting: SUCCESS (0.081s)
[532.665921] [059/134] (488s left) gem_exec_balancer (individual)
[532.723500] Starting subtest: individual
[534.946848] Subtest individual: SUCCESS (2.222s)
[535.282487] [060/134] (486s left) kms_dp_link_training (uhbr-sst)
[535.380394] Starting subtest: uhbr-sst
[535.383864] Subtest uhbr-sst: SKIP (0.000s)
[535.460345] [061/134] (486s left) gem_busy (busy)
[535.519435] Starting subtest: busy
[535.520379] Starting dynamic subtest: all-engines
[535.591451] Dynamic subtest all-engines: SUCCESS (0.072s)
[535.599178] Starting dynamic subtest: rcs0
[536.861282] Dynamic subtest rcs0: SUCCESS (1.268s)
[536.868326] Starting dynamic subtest: bcs0
[536.925267] Dynamic subtest bcs0: SUCCESS (0.062s)
[536.933221] Starting dynamic subtest: vcs0
[536.965689] Dynamic subtest vcs0: SUCCESS (0.040s)
[536.973029] Starting dynamic subtest: vcs1
[538.909204] Dynamic subtest vcs1: SUCCESS (1.939s)
[538.917281] Starting dynamic subtest: vecs0
[540.893287] Dynamic subtest vecs0: SUCCESS (1.981s)
[540.902054] Starting dynamic subtest: ccs0
[542.940769] Dynamic subtest ccs0: SUCCESS (2.047s)
[542.942029] Subtest busy: SUCCESS (7.419s)
[543.279381] [062/134] (478s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[543.393599] Starting subtest: 4-tiled-8bpp-rotate-180
[544.540451] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.147s)
[544.657620] [063/134] (477s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[544.894082] Starting subtest: cursor-rapid-movement-128x42
[544.933657] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[545.199951] [064/134] (476s left) kms_joiner (invalid-modeset-force-big-joiner)
[545.290613] Starting subtest: invalid-modeset-force-big-joiner
[545.292462] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[545.364610] [065/134] (476s left) kms_flip (dpms-off-confusion-interruptible)
[545.469853] Starting subtest: dpms-off-confusion-interruptible
[545.472304] Starting dynamic subtest: A-eDP1
[554.087697] Dynamic subtest A-eDP1: SUCCESS (8.615s)
[554.103421] Starting dynamic subtest: B-eDP1
[562.714294] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[562.724271] Starting dynamic subtest: C-eDP1
[571.324886] Dynamic subtest C-eDP1: SUCCESS (8.607s)
[571.333504] Starting dynamic subtest: D-eDP1
[579.956687] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[579.960263] Subtest dpms-off-confusion-interruptible: SUCCESS (34.488s)
[581.137999] [066/134] (440s left) perf_pmu (pmu-read)
[581.173115] Starting subtest: pmu-read
[581.176370] Subtest pmu-read: SUCCESS (0.003s)
[581.299555] [067/134] (440s left) gem_lmem_swapping (random)
[581.350376] Subtest random: SKIP (0.000s)
[581.394259] [068/134] (440s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[581.496415] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[581.498191] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[582.658163] [069/134] (439s left) gem_exec_schedule (u-semaphore-user)
[582.721888] Starting subtest: u-semaphore-user
[582.781325] Subtest u-semaphore-user: SUCCESS (0.059s)
[583.941015] [070/134] (438s left) gem_workarounds (basic-read)
[584.010401] Starting subtest: basic-read
[584.022866] Subtest basic-read: SUCCESS (0.014s)
[584.170293] [071/134] (437s left) kms_hdr (bpc-switch-suspend)
[584.262172] Starting subtest: bpc-switch-suspend
[585.322935] Starting dynamic subtest: pipe-A-eDP-1
[605.634314] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.851s)
[605.635369] Subtest bpc-switch-suspend: SUCCESS (6.913s)
[612.784261] [072/134] (416s left) kms_prime (d3hot)
[612.884308] Subtest D3hot: SKIP (0.000s)
[612.973006] [073/134] (416s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[613.063059] Starting subtest: bad-rotation-90-yf-tiled-ccs
[613.064185] Starting dynamic subtest: pipe-A-eDP-1
[613.074901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[613.083610] Starting dynamic subtest: pipe-B-eDP-1
[613.092664] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[613.101102] Starting dynamic subtest: pipe-C-eDP-1
[613.110509] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[613.118426] Starting dynamic subtest: pipe-D-eDP-1
[613.128194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[613.130019] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[615.302939] [074/134] (413s left) gem_exec_endless (dispatch)
[615.362991] Starting subtest: dispatch
[615.364357] Starting dynamic subtest: rcs0
[615.369554] Dynamic subtest rcs0: SUCCESS (0.005s)
[615.378465] Starting dynamic subtest: bcs0
[615.381186] Dynamic subtest bcs0: SUCCESS (0.008s)
[615.389380] Starting dynamic subtest: vcs0
[615.391449] Dynamic subtest vcs0: SUCCESS (0.005s)
[615.399288] Starting dynamic subtest: vcs1
[615.401250] Dynamic subtest vcs1: SUCCESS (0.005s)
[615.408672] Starting dynamic subtest: vecs0
[615.410978] Dynamic subtest vecs0: SUCCESS (0.004s)
[615.418898] Starting dynamic subtest: ccs0
[615.420973] Dynamic subtest ccs0: SUCCESS (0.004s)
[615.421980] Subtest dispatch: SUCCESS (0.037s)
[617.411325] [075/134] (411s left) kms_async_flips (test-time-stamp-atomic)
[617.505663] Starting subtest: test-time-stamp-atomic
[617.890810] Starting dynamic subtest: pipe-A-eDP-1
[618.732036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[619.126484] Starting dynamic subtest: pipe-B-eDP-1
[619.881336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[620.245664] Starting dynamic subtest: pipe-C-eDP-1
[621.014400] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[621.375847] Starting dynamic subtest: pipe-D-eDP-1
[622.146168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[622.147527] Subtest test-time-stamp-atomic: SUCCESS (4.619s)
[623.326309] [076/134] (405s left) dmabuf_sync_file (export-wait-after-attach)
[623.375353] Starting subtest: export-wait-after-attach
[623.378712] Subtest export-wait-after-attach: SUCCESS (0.002s)
[623.444278] [077/134] (405s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[623.540204] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[623.567992] Starting dynamic subtest: pipe-A-plane-0
[623.991307] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[623.999367] Starting dynamic subtest: pipe-A-plane-3
[624.258707] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[624.266976] Starting dynamic subtest: pipe-A-plane-5
[624.268971] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[625.407432] Starting dynamic subtest: pipe-B-plane-0
[625.845356] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[625.853370] Starting dynamic subtest: pipe-B-plane-3
[626.101324] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[626.109701] Starting dynamic subtest: pipe-B-plane-5
[626.112016] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[626.409701] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.862s)
[627.285972] [078/134] (402s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[627.373550] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[627.376006] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[628.519986] [079/134] (400s left) kms_flip (2x-flip-vs-panning-vs-hang)
[628.598652] Starting subtest: 2x-flip-vs-panning-vs-hang
[628.609812] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s)
[628.703516] [080/134] (400s left) gem_mmap_gtt (basic-small-copy-xy)
[628.759652] Subtest basic-small-copy-XY: SKIP (0.000s)
[628.824463] [081/134] (400s left) kms_cursor_crc (cursor-dpms)
[628.949921] Starting subtest: cursor-dpms
[628.950738] Starting dynamic subtest: pipe-A-eDP-1
[631.977317] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.022s)
[631.985382] Starting dynamic subtest: pipe-D-eDP-1
[635.583444] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.600s)
[635.584669] Subtest cursor-dpms: SUCCESS (6.625s)
[636.435808] [082/134] (393s left) kms_chamelium_frames (hdmi-frame-dump)
[636.825472] Subtest hdmi-frame-dump: SKIP (0.000s)
[637.634021] [083/134] (391s left) gen3_render_linear_blits
[637.740801] [084/134] (391s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[637.838335] Starting subtest: yf-tiled-64bpp-rotate-180
[637.840242] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[637.955928] [085/134] (391s left) kms_properties (invalid-properties-legacy)
[638.050916] Starting subtest: invalid-properties-legacy
[638.155675] Subtest invalid-properties-legacy: SUCCESS (0.104s)
[638.232789] [086/134] (391s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[638.282684] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[638.393098] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[638.474282] [087/134] (391s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[638.561686] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[645.180009] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.611s)
[645.322108] [088/134] (384s left) kms_psr (psr-no-drrs)
[645.409303] Starting subtest: psr-no-drrs
[645.410218] Starting dynamic subtest: eDP-1
[647.074400] Dynamic subtest eDP-1: SUCCESS (1.664s)
[647.075773] Subtest psr-no-drrs: SUCCESS (1.665s)
[647.959701] [089/134] (381s left) gem_exec_params (readonly)
[648.019431] Starting subtest: readonly
[648.020997] Subtest readonly: SUCCESS (0.003s)
[648.148878] [090/134] (381s left) i915_hangman (gt-error-state-capture)
[648.212444] Starting subtest: gt-error-state-capture
[648.213680] Starting dynamic subtest: rcs0
[658.355899] Dynamic subtest rcs0: SUCCESS (10.135s)
[658.367424] Starting dynamic subtest: bcs0
[670.323125] Dynamic subtest bcs0: SUCCESS (11.959s)
[670.334116] Starting dynamic subtest: vcs0
[682.355988] Dynamic subtest vcs0: SUCCESS (12.024s)
[682.367090] Starting dynamic subtest: vcs1
[692.340247] Dynamic subtest vcs1: SUCCESS (9.976s)
[692.351887] Starting dynamic subtest: vecs0
[704.306899] Dynamic subtest vecs0: SUCCESS (11.957s)
[704.318541] Starting dynamic subtest: ccs0
[716.340123] Dynamic subtest ccs0: SUCCESS (12.039s)
[716.341745] Subtest gt-error-state-capture: SUCCESS (68.109s)
[716.429541] [091/134] (313s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[716.543490] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[716.544665] Starting dynamic subtest: pipe-A-default-mode
[717.728389] Dynamic subtest pipe-A-default-mode: SKIP (1.184s)
[717.730671] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.186s)
[717.903944] [092/134] (311s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[717.999338] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[718.001327] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[718.097085] [093/134] (311s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[723.096707] Starting subtest: psr2-cursor-plane-move-continuous-sf
[723.099234] Starting dynamic subtest: pipe-A-eDP-1
[734.203346] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.106s)
[734.212256] Starting dynamic subtest: pipe-B-eDP-1
[745.331339] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.129s)
[745.332210] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.239s)
[746.140789] [094/134] (283s left) gem_ctx_param (invalid-get-no-zeromap)
[746.192698] Starting subtest: invalid-get-no-zeromap
[746.194096] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[746.299145] [095/134] (283s left) kms_flip (bo-too-big)
[746.387362] Starting subtest: bo-too-big
[746.390404] Starting dynamic subtest: A-eDP1
[747.685966] Dynamic subtest A-eDP1: SUCCESS (1.297s)
[747.696661] Starting dynamic subtest: B-eDP1
[749.018726] Dynamic subtest B-eDP1: SUCCESS (1.329s)
[749.029921] Starting dynamic subtest: C-eDP1
[750.356158] Dynamic subtest C-eDP1: SUCCESS (1.340s)
[750.364176] Starting dynamic subtest: D-eDP1
[751.691326] Dynamic subtest D-eDP1: SUCCESS (1.334s)
[751.695242] Subtest bo-too-big: SUCCESS (5.307s)
[752.900728] [096/134] (277s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[752.987970] Starting subtest: fbcpsr-abgr161616f-draw-render
[752.990032] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[753.103841] [097/134] (276s left) kms_flip (2x-flip-vs-dpms)
[753.194548] Starting subtest: 2x-flip-vs-dpms
[753.205682] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[753.328371] [098/134] (276s left) core_auth (getclient-master-drop)
[753.360059] Starting subtest: getclient-master-drop
[753.380551] Subtest getclient-master-drop: SUCCESS (0.021s)
[753.491171] [099/134] (276s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[753.583039] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[757.681603] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.100s)
[758.908767] [100/134] (271s left) gem_render_copy (yf-tiled)
[758.970980] Starting subtest: yf-tiled
[758.974040] Subtest yf-tiled: SKIP (0.000s)
[759.160924] [101/134] (270s left) i915_selftest (mock)
[761.058891] Starting subtest: mock
[761.060285] Starting dynamic subtest: sanitycheck
[763.072547] Dynamic subtest sanitycheck: SUCCESS (2.014s)
[763.081843] Starting dynamic subtest: shmem
[765.064620] Dynamic subtest shmem: SUCCESS (1.990s)
[765.073511] Starting dynamic subtest: fence
[774.549549] Dynamic subtest fence: SUCCESS (9.481s)
[774.558471] Starting dynamic subtest: scatterlist
[777.582559] Dynamic subtest scatterlist: SUCCESS (3.030s)
[777.591817] Starting dynamic subtest: syncmap
[782.195494] Dynamic subtest syncmap: SUCCESS (4.610s)
[782.205440] Starting dynamic subtest: uncore
[784.237370] Dynamic subtest uncore: SUCCESS (2.039s)
[784.246361] Starting dynamic subtest: ring
[786.242208] Dynamic subtest ring: SUCCESS (2.002s)
[786.251364] Starting dynamic subtest: engine
[788.301377] Dynamic subtest engine: SUCCESS (2.056s)
[788.310517] Starting dynamic subtest: timelines
[793.481304] Dynamic subtest timelines: SUCCESS (5.177s)
[793.489435] Starting dynamic subtest: requests
[798.097470] Dynamic subtest requests: SUCCESS (4.613s)
[798.105621] Starting dynamic subtest: objects
[800.239855] Dynamic subtest objects: SUCCESS (2.139s)
[800.248931] Starting dynamic subtest: phys
[802.402494] Dynamic subtest phys: SUCCESS (2.160s)
[802.411498] Starting dynamic subtest: dmabuf
[804.496609] Dynamic subtest dmabuf: SUCCESS (2.089s)
[804.505495] Starting dynamic subtest: vma
[811.364272] Dynamic subtest vma: SUCCESS (6.867s)
[811.373104] Starting dynamic subtest: evict
[814.083090] Dynamic subtest evict: SUCCESS (2.717s)
[814.091512] Starting dynamic subtest: gtt
[818.620572] Dynamic subtest gtt: SUCCESS (4.534s)
[818.629957] Starting dynamic subtest: hugepages
[820.947572] Dynamic subtest hugepages: SUCCESS (2.324s)
[820.956488] Starting dynamic subtest: memory_region
[824.882726] Dynamic subtest memory_region: SUCCESS (3.932s)
[824.884148] Subtest mock: SUCCESS (63.810s)
[824.906046] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[824.906845] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[824.909072] [102/134] (205s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[827.746440] Starting subtest: x-tiled-8bpp-rotate-180
[829.022670] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.276s)
[829.215754] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[829.217146] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true
[829.220111] [103/134] (200s left) gem_userptr_blits (relocations)
[829.283338] Starting subtest: relocations
[829.285695] Subtest relocations: SKIP (0.000s)
[829.430305] [104/134] (200s left) gem_exec_fence (submit3)
[829.605103] Starting subtest: submit3
[829.607725] Subtest submit3: SKIP (0.000s)
[831.482568] [105/134] (198s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[831.586590] Starting subtest: flip-primary-invalidate-overlay
[843.256009] Subtest flip-primary-invalidate-overlay: SUCCESS (11.673s)
[843.447536] [106/134] (186s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[843.504130] Starting subtest: multi-wait-all-for-submit-available-submitted
[843.505271] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[843.612303] [107/134] (186s left) gem_ctx_engines (invalid-engines)
[843.672719] Starting subtest: invalid-engines
[843.680949] Subtest invalid-engines: SUCCESS (0.008s)
[843.928510] [108/134] (186s left) gem_exec_schedule (pi-ringfull)
[844.111971] Starting subtest: pi-ringfull
[844.113368] Starting dynamic subtest: rcs0
[844.141685] Dynamic subtest rcs0: SUCCESS (0.033s)
[844.149435] Starting dynamic subtest: bcs0
[844.177851] Dynamic subtest bcs0: SUCCESS (0.035s)
[844.185324] Starting dynamic subtest: vcs0
[844.207517] Dynamic subtest vcs0: SUCCESS (0.028s)
[844.216094] Starting dynamic subtest: vcs1
[844.236977] Dynamic subtest vcs1: SUCCESS (0.028s)
[844.245048] Starting dynamic subtest: vecs0
[844.266401] Dynamic subtest vecs0: SUCCESS (0.028s)
[844.278329] Starting dynamic subtest: ccs0
[844.293480] Dynamic subtest ccs0: SUCCESS (0.027s)
[844.294602] Subtest pi-ringfull: SUCCESS (0.185s)
[844.522994] [109/134] (185s left) gem_exec_whisper (basic-fds-all)
[844.590460] Starting subtest: basic-fds-all
[854.868662] Subtest basic-fds-all: SUCCESS (10.278s)
[855.064020] [110/134] (175s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[855.163186] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[855.164126] Starting dynamic subtest: pipe-A
[855.502025] Dynamic subtest pipe-A: SUCCESS (0.339s)
[855.511156] Starting dynamic subtest: pipe-B
[856.932210] Dynamic subtest pipe-B: SUCCESS (1.429s)
[856.941011] Starting dynamic subtest: pipe-C
[858.357243] Dynamic subtest pipe-C: SUCCESS (1.424s)
[858.375602] Starting dynamic subtest: pipe-D
[859.783068] Dynamic subtest pipe-D: SUCCESS (1.424s)
[859.784351] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.621s)
[861.198297] [111/134] (169s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[861.283093] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[861.294206] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[861.429441] [112/134] (169s left) kms_plane_multiple (tiling-x)
[861.529216] Starting subtest: tiling-x
[861.530352] Starting dynamic subtest: pipe-A-eDP-1
[865.202812] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.675s)
[865.210861] Starting dynamic subtest: pipe-B-eDP-1
[869.773684] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.570s)
[869.783204] Starting dynamic subtest: pipe-C-eDP-1
[874.158349] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.383s)
[874.167150] Starting dynamic subtest: pipe-D-eDP-1
[878.487685] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.329s)
[878.489150] Subtest tiling-x: SUCCESS (16.962s)
[879.305134] [113/134] (151s left) gem_flink_basic (basic)
[879.362075] Starting subtest: basic
[879.363322] Subtest basic: SUCCESS (0.000s)
[879.481969] [114/134] (151s left) gem_exec_parallel (basic)
[879.554870] Starting subtest: basic
[879.555900] Starting dynamic subtest: rcs0
[881.272583] Dynamic subtest rcs0: SUCCESS (1.717s)
[881.281405] Starting dynamic subtest: bcs0
[882.965838] Dynamic subtest bcs0: SUCCESS (1.692s)
[882.977428] Starting dynamic subtest: vcs0
[886.357180] Dynamic subtest vcs0: SUCCESS (3.387s)
[886.368090] Starting dynamic subtest: vcs1
[888.341009] Dynamic subtest vcs1: SUCCESS (1.981s)
[888.350971] Starting dynamic subtest: vecs0
[890.388942] Dynamic subtest vecs0: SUCCESS (2.045s)
[890.397710] Starting dynamic subtest: ccs0
[892.175585] Dynamic subtest ccs0: SUCCESS (1.786s)
[892.177279] Subtest basic: SUCCESS (12.622s)
[892.374331] [115/134] (138s left) gem_exec_whisper (basic-queues-priority-all)
[892.432656] Starting subtest: basic-queues-priority-all
[914.735282] Subtest basic-queues-priority-all: SUCCESS (22.297s)
[914.923275] [116/134] (115s left) kms_psr (fbc-psr-sprite-plane-move)
[915.027724] Starting subtest: fbc-psr-sprite-plane-move
[915.029026] Starting dynamic subtest: eDP-1
[915.031071] Dynamic subtest eDP-1: SKIP (0.000s)
[915.032873] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[915.097723] [117/134] (115s left) gem_sync (basic-many-each)
[915.160931] Starting subtest: basic-many-each
[917.466234] Subtest basic-many-each: SUCCESS (2.308s)
[917.657803] [118/134] (112s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[917.765588] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[924.515285] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.751s)
[924.656649] [119/134] (106s left) gem_fence_thrash (bo-write-verify-threaded-x)
[924.686363] Starting subtest: bo-write-verify-threaded-x
[924.721683] Subtest bo-write-verify-threaded-x: SKIP (0.032s)
[924.789237] [120/134] (105s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[924.852560] Starting subtest: multi-wait-available-unsubmitted-signaled
[924.854418] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[924.971707] [121/134] (105s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[925.067615] Starting subtest: primary-yf-tiled-reflect-x-270
[925.069988] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[925.169707] [122/134] (105s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[925.262951] Starting subtest: fbc-pr-sprite-mmap-gtt
[925.265452] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[925.341356] [123/134] (105s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[925.439055] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[925.441191] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[925.536167] [124/134] (105s left) syncobj_wait (multi-wait-for-submit-submitted)
[925.588248] Starting subtest: multi-wait-for-submit-submitted
[925.697428] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[925.780593] [125/134] (105s left) sw_sync (sync_busy_fork_unixsocket)
[925.809941] Starting subtest: sync_busy_fork_unixsocket
[925.818814] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[925.887432] [126/134] (105s left) kms_async_flips (crc)
[925.987428] Starting subtest: crc
[926.369593] Starting dynamic subtest: pipe-A-eDP-1
[929.244711] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.875s)
[929.636867] Starting dynamic subtest: pipe-B-eDP-1
[932.492136] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[932.865263] Starting dynamic subtest: pipe-C-eDP-1
[935.788334] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.930s)
[936.154479] Starting dynamic subtest: pipe-D-eDP-1
[939.003234] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[939.004715] Subtest crc: SUCCESS (13.015s)
[940.192082] [127/134] ( 90s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[940.310303] Starting subtest: cursorB-vs-flipA-atomic
[940.312552] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[940.460003] [128/134] ( 90s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[940.553985] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[940.555872] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[940.681070] [129/134] ( 90s left) gem_exec_flush (basic-wb-rw-before-default)
[940.743948] Starting subtest: basic-wb-rw-before-default
[946.195073] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[946.394062] [130/134] ( 84s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[946.487541] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[946.488697] Starting dynamic subtest: pipe-A-eDP-1
[946.501331] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[946.511974] Starting dynamic subtest: pipe-B-eDP-1
[946.522032] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[946.530517] Starting dynamic subtest: pipe-C-eDP-1
[946.539745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[946.547608] Starting dynamic subtest: pipe-D-eDP-1
[946.555851] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[946.557452] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[948.674530] [131/134] ( 82s left) kms_properties (colorop-properties-legacy)
[948.772754] Starting subtest: colorop-properties-legacy
[948.774075] Starting dynamic subtest: pipe-A-eDP-1
[949.119021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.347s)
[949.127956] Starting dynamic subtest: pipe-B-eDP-1
[950.148399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.027s)
[950.157426] Starting dynamic subtest: pipe-C-eDP-1
[951.183959] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[951.193332] Starting dynamic subtest: pipe-D-eDP-1
[952.240112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.056s)
[952.241106] Subtest colorop-properties-legacy: SUCCESS (3.469s)
[953.040508] [132/134] ( 78s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[953.136834] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[953.139053] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[953.248014] [133/134] ( 77s left) kms_busy (extended-modeset-hang-newfb)
[953.346921] Starting subtest: extended-modeset-hang-newfb
[953.347906] Starting dynamic subtest: pipe-A
[989.127507] Dynamic subtest pipe-A: SUCCESS (35.773s)
[989.137958] Starting dynamic subtest: pipe-D
[1006.234964] Dynamic subtest pipe-D: SUCCESS (17.100s)
[1006.236219] Subtest extended-modeset-hang-newfb: SUCCESS (52.878s)
[1007.044351] [134/134] ( 24s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[1007.145384] Starting subtest: plane-lut1d-ctm3x4-lut1d
[1007.160406] Starting dynamic subtest: pipe-A-eDP-1
[1007.642667] Dynamic subtest pipe-A-eDP-1: FAIL (0.324s)
[1008.511822] Starting dynamic subtest: pipe-B-eDP-1
[1009.032968] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[1009.946623] Starting dynamic subtest: pipe-C-eDP-1
[1010.448364] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[1011.278517] Starting dynamic subtest: pipe-D-eDP-1
[1011.760916] Dynamic subtest pipe-D-eDP-1: FAIL (0.249s)
[1011.819404] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.674s)
[1012.685135] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: gen9_exec_parse
results: parsing output: 2/ for test: i915_pm_rc6_residency
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_plane_cursor
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: prime_mmap
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_ctx_create
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_basic
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_pm_dc
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_content_protection
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: sysfs_preempt_timeout
results: parsing output: 39/ for test: gem_pwrite
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_chamelium_hpd
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_multipipe_modeset
results: parsing output: 47/ for test: kms_psr2_sf
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: gem_ctx_persistence
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: gem_wait
results: parsing output: 57/ for test: prime_mmap
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: kms_dp_link_training
results: parsing output: 60/ for test: gem_busy
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: kms_joiner
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_workarounds
results: parsing output: 70/ for test: kms_hdr
results: parsing output: 71/ for test: kms_prime
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: gem_exec_endless
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: dmabuf_sync_file
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gen3_render_linear_blits
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_properties
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_ctx_param
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: core_auth
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: i915_selftest
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_psr_stress_test
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_ctx_engines
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_plane_multiple
results: parsing output: 112/ for test: gem_flink_basic
results: parsing output: 113/ for test: gem_exec_parallel
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_sync
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_fence_thrash
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_flush
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_busy
results: parsing output: 133/ for test: kms_color_pipeline
Done.