[59.249912] Initializing watchdogs
[59.249973]   /dev/watchdog0
[59.265193] [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.269626] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.272044] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.275366] [001/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[59.405199] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[66.020934] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.613s)
[66.133111] [002/130] (953s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[66.219893] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[66.224082] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[66.287947] [003/130] (953s left) gem_lmem_swapping (parallel-random-verify)
[66.335276] Subtest parallel-random-verify: SKIP (0.000s)
[66.375106] [004/130] (953s left) perf_pmu (interrupts)
[66.416263] Starting subtest: interrupts
[67.509630] Subtest interrupts: SUCCESS (1.092s)
[67.697080] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[67.700248] [005/130] (952s left) kms_atomic (crtc-invalid-params)
[67.832180] Starting subtest: crtc-invalid-params
[67.834543] Starting dynamic subtest: pipe-A-eDP-1
[68.237879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.405s)
[68.239893] Subtest crtc-invalid-params: SUCCESS (0.406s)
[69.054757] [006/130] (950s left) kms_draw_crc (draw-method-mmap-wc)
[69.154921] Starting subtest: draw-method-mmap-wc
[69.156803] Starting dynamic subtest: xrgb8888-untiled
[69.420710] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[69.431131] Starting dynamic subtest: rgb565-untiled
[69.664637] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[69.673935] Starting dynamic subtest: xrgb2101010-untiled
[69.887069] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[69.895067] Starting dynamic subtest: xbgr16161616f-untiled
[70.119969] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[70.129129] Starting dynamic subtest: xrgb8888-xtiled
[70.242031] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[70.249997] Starting dynamic subtest: rgb565-xtiled
[70.375684] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[70.383144] Starting dynamic subtest: xrgb2101010-xtiled
[70.497663] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[70.505811] Starting dynamic subtest: xbgr16161616f-xtiled
[70.631117] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[70.638850] Starting dynamic subtest: xrgb8888-4tiled
[70.798142] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[70.806770] Starting dynamic subtest: rgb565-4tiled
[70.953556] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[70.960762] Starting dynamic subtest: xrgb2101010-4tiled
[71.098026] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[71.106157] Starting dynamic subtest: xbgr16161616f-4tiled
[71.275818] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[71.278256] Subtest draw-method-mmap-wc: SUCCESS (2.122s)
[71.370190] [007/130] (948s left) gem_huc_copy (huc-copy)
[71.432890] Starting subtest: huc-copy
[71.434755] Subtest huc-copy: SUCCESS (0.003s)
[71.543537] [008/130] (948s left) kms_async_flips (async-flip-hang)
[71.627842] Starting subtest: async-flip-hang
[72.014241] Starting dynamic subtest: pipe-A-eDP-1
[98.427938] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.404s)
[98.821809] Starting dynamic subtest: pipe-B-eDP-1
[114.427946] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.605s)
[114.807433] Starting dynamic subtest: pipe-C-eDP-1
[130.352643] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.550s)
[130.740346] Starting dynamic subtest: pipe-D-eDP-1
[146.352172] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.614s)
[146.354812] Subtest async-flip-hang: SUCCESS (74.717s)
[147.556566] [009/130] (872s left) drm_read (empty-nonblock)
[147.705028] Starting subtest: empty-nonblock
[147.707347] Subtest empty-nonblock: SUCCESS (0.000s)
[147.839508] [010/130] (872s left) perf_pmu (all-busy-check-all)
[147.878404] Starting subtest: all-busy-check-all
[149.910043] Subtest all-busy-check-all: SUCCESS (2.030s)
[149.997667] [011/130] (870s left) kms_cursor_crc (cursor-onscreen-64x64)
[150.183201] Starting subtest: cursor-onscreen-64x64
[150.187736] Starting dynamic subtest: pipe-A-eDP-1
[152.295049] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[152.324229] Starting dynamic subtest: pipe-D-eDP-1
[155.022126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.705s)
[155.024512] Subtest cursor-onscreen-64x64: SUCCESS (4.839s)
[155.814822] [012/130] (864s left) kms_psr (psr2-dpms)
[155.918630] Starting subtest: psr2-dpms
[155.920900] Starting dynamic subtest: eDP-1
[158.960438] Dynamic subtest eDP-1: SUCCESS (3.040s)
[158.962332] Subtest psr2-dpms: SUCCESS (3.041s)
[159.829239] [013/130] (860s left) kms_flip (2x-plain-flip-fb-recreate)
[159.930593] Starting subtest: 2x-plain-flip-fb-recreate
[159.940158] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[160.019679] [014/130] (860s left) i915_pm_rc6_residency (rc6-idle)
[160.071079] Starting subtest: rc6-idle
[160.096396] Starting dynamic subtest: gt0-rcs0
[184.492898] Dynamic subtest gt0-rcs0: SUCCESS (24.395s)
[184.501456] Starting dynamic subtest: gt0-bcs0
[208.705251] Dynamic subtest gt0-bcs0: SUCCESS (24.211s)
[208.715388] Starting dynamic subtest: gt0-ccs0
[232.980450] Dynamic subtest gt0-ccs0: SUCCESS (24.273s)
[232.988582] Starting dynamic subtest: gt1-vcs0
[239.208717] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[239.220973] Starting dynamic subtest: gt1-vecs0
[245.326435] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[245.332257] Subtest rc6-idle: SUCCESS (85.256s)
[245.406454] [015/130] (774s left) kms_pm_lpsp (kms-lpsp)
[246.512734] Starting subtest: kms-lpsp
[246.515117] Starting dynamic subtest: pipe-A-eDP-1
[246.657589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[246.956679] Subtest kms-lpsp: SUCCESS (0.447s)
[247.759206] [016/130] (772s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[247.854895] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[247.857196] Starting dynamic subtest: pipe-A-default-mode
[250.577915] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[250.580199] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.723s)
[251.442622] [017/130] (768s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[251.563052] Starting subtest: fbc-rgb565-draw-blt
[255.731061] Subtest fbc-rgb565-draw-blt: SUCCESS (4.171s)
[256.947702] [018/130] (763s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[257.065657] Starting subtest: primary-yf-tiled-reflect-x-270
[257.070248] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[257.155193] [019/130] (763s left) kms_psr (fbc-pr-basic)
[257.257342] Starting subtest: fbc-pr-basic
[257.261437] Subtest fbc-pr-basic: SKIP (0.000s)
[257.342094] [020/130] (763s left) kms_psr (psr-primary-render)
[257.441828] Starting subtest: psr-primary-render
[257.444126] Starting dynamic subtest: eDP-1
[259.140909] Dynamic subtest eDP-1: SUCCESS (1.694s)
[259.145093] Subtest psr-primary-render: SUCCESS (1.695s)
[259.988899] [021/130] (760s left) perf (blocking-parameterized)
[260.114380] Starting subtest: blocking-parameterized
[280.186905] Subtest blocking-parameterized: SUCCESS (20.020s)
[280.226010] [022/130] (740s left) gem_create (busy-create)
[280.282537] Starting subtest: busy-create
[280.285026] Starting dynamic subtest: smem0
[313.865799] Dynamic subtest smem0: SUCCESS (33.581s)
[313.868594] Subtest busy-create: SUCCESS (33.582s)
[314.068106] [023/130] (706s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[314.181772] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[314.184095] Starting dynamic subtest: pipe-A-eDP-1
[314.209935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[314.219980] Starting dynamic subtest: pipe-B-eDP-1
[314.244274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[314.251724] Starting dynamic subtest: pipe-C-eDP-1
[314.275772] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[314.285209] Starting dynamic subtest: pipe-D-eDP-1
[314.308426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[314.312870] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[316.432540] [024/130] (704s left) gem_readwrite (read-write)
[316.484616] Subtest read-write: SKIP (0.000s)
[316.549121] [025/130] (704s left) gem_request_retire (retire-vma-not-inactive)
[316.611439] Starting subtest: retire-vma-not-inactive
[316.671935] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[316.783426] [026/130] (704s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[316.881165] Starting subtest: plane-lut1d-ctm3x4-lut1d
[317.027270] Starting dynamic subtest: pipe-A-plane-0
[317.383146] Dynamic subtest pipe-A-plane-0: FAIL (0.191s)
[317.392362] Starting dynamic subtest: pipe-A-plane-1
[317.581202] Dynamic subtest pipe-A-plane-1: FAIL (0.183s)
[317.590457] Starting dynamic subtest: pipe-A-plane-2
[317.804283] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[318.821035] Starting dynamic subtest: pipe-B-plane-0
[319.265301] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[319.274796] Starting dynamic subtest: pipe-B-plane-1
[319.597597] Dynamic subtest pipe-B-plane-1: FAIL (0.169s)
[319.606580] Starting dynamic subtest: pipe-B-plane-2
[319.908357] Dynamic subtest pipe-B-plane-2: FAIL (0.186s)
[320.541987] Starting dynamic subtest: pipe-C-plane-0
[321.071477] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[321.082230] Starting dynamic subtest: pipe-C-plane-1
[321.485087] Dynamic subtest pipe-C-plane-1: FAIL (0.631s)
[321.495212] Starting dynamic subtest: pipe-C-plane-2
[321.880136] Dynamic subtest pipe-C-plane-2: FAIL (0.199s)
[322.658025] Starting dynamic subtest: pipe-D-plane-0
[323.273711] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[323.284496] Starting dynamic subtest: pipe-D-plane-1
[323.748951] Dynamic subtest pipe-D-plane-1: FAIL (0.642s)
[323.757868] Starting dynamic subtest: pipe-D-plane-2
[324.203563] Dynamic subtest pipe-D-plane-2: FAIL (0.541s)
[324.282435] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.401s)
[325.140773] [027/130] (695s left) gem_render_copy (linear-to-vebox-yf-tiled)
[325.196897] Starting subtest: linear-to-vebox-yf-tiled
[325.201325] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[325.380289] [028/130] (695s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[325.485381] Starting subtest: x-tiled-64bpp-rotate-270
[325.504489] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s)
[325.616712] [029/130] (695s left) gem_ringfill (legacy-basic)
[330.904468] Starting subtest: legacy-basic
[330.907106] Starting dynamic subtest: default
[330.960233] Dynamic subtest default: SUCCESS (0.056s)
[330.971226] Starting dynamic subtest: render
[331.001165] Dynamic subtest render: SUCCESS (0.039s)
[331.010752] Starting dynamic subtest: bsd
[331.043256] Dynamic subtest bsd: SUCCESS (0.040s)
[331.052760] Starting dynamic subtest: bsd1
[331.085809] Dynamic subtest bsd1: SUCCESS (0.040s)
[331.096262] Starting dynamic subtest: bsd2
[331.126673] Dynamic subtest bsd2: SUCCESS (0.039s)
[331.137396] Starting dynamic subtest: blt
[331.170440] Dynamic subtest blt: SUCCESS (0.042s)
[331.180742] Starting dynamic subtest: vebox
[331.214802] Dynamic subtest vebox: SUCCESS (0.042s)
[331.217561] Subtest legacy-basic: SUCCESS (0.312s)
[331.293934] [030/130] (689s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[331.420593] Starting subtest: cursor-vs-flip-legacy
[360.785460] Subtest cursor-vs-flip-legacy: SUCCESS (29.364s)
[361.649761] [031/130] (659s left) gen9_exec_parse (bb-start-cmd)
[361.717597] Subtest bb-start-cmd: SKIP (0.000s)
[361.781848] [032/130] (659s left) sw_sync (sync_multi_consumer)
[361.825658] Starting subtest: sync_multi_consumer
[362.256903] Subtest sync_multi_consumer: SUCCESS (0.431s)
[362.316350] [033/130] (658s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[362.414645] Starting subtest: y-tiled-16bpp-rotate-270
[362.418686] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[362.507747] [034/130] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[362.601217] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[362.605117] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[362.683779] [035/130] (658s left) gen3_render_mixed_blits
[362.802260] [036/130] (658s left) kms_fbcon_fbt (psr-suspend)
[362.861106] Starting subtest: psr-suspend
[412.283630] Subtest psr-suspend: SUCCESS (19.710s)
[412.328863] [037/130] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[412.431134] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[412.435318] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[412.531376] [038/130] (608s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[412.649538] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[412.654185] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[412.806986] [039/130] (608s left) kms_chamelium_hpd (dp-hpd-fast)
[413.203490] Subtest dp-hpd-fast: SKIP (0.000s)
[414.056388] [040/130] (607s left) gem_mmap_gtt (basic-write-read-distinct)
[414.117272] Subtest basic-write-read-distinct: SKIP (0.000s)
[414.178038] [041/130] (607s left) gem_tiling_max_stride
[414.306478] [042/130] (607s left) gem_ctx_persistence (engines-mixed)
[414.364283] Starting subtest: engines-mixed
[414.366710] Starting dynamic subtest: rcs0
[414.439879] Dynamic subtest rcs0: SUCCESS (0.075s)
[414.451861] Starting dynamic subtest: bcs0
[414.494734] Dynamic subtest bcs0: SUCCESS (0.053s)
[414.506276] Starting dynamic subtest: vcs0
[414.552919] Dynamic subtest vcs0: SUCCESS (0.057s)
[414.566605] Starting dynamic subtest: vcs1
[414.619083] Dynamic subtest vcs1: SUCCESS (0.063s)
[414.631373] Starting dynamic subtest: vecs0
[414.662700] Dynamic subtest vecs0: SUCCESS (0.042s)
[414.672615] Starting dynamic subtest: ccs0
[414.702745] Dynamic subtest ccs0: SUCCESS (0.038s)
[414.705110] Subtest engines-mixed: SUCCESS (0.337s)
[414.779151] [043/130] (606s left) kms_chamelium_frames (hdmi-frame-dump)
[415.166678] Subtest hdmi-frame-dump: SKIP (0.000s)
[415.994229] [044/130] (605s left) sw_sync (sync_busy_fork_unixsocket)
[416.032889] Starting subtest: sync_busy_fork_unixsocket
[416.038133] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[416.091867] [045/130] (605s left) kms_pm_rpm (modeset-lpsp-stress)
[417.620098] Starting subtest: modeset-lpsp-stress
[434.197927] Subtest modeset-lpsp-stress: SUCCESS (16.555s)
[434.284197] [046/130] (587s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[434.379519] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[434.381429] Starting dynamic subtest: pipe-A-eDP-1
[435.267594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.881s)
[435.276871] Starting dynamic subtest: pipe-B-eDP-1
[436.901861] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.629s)
[436.911065] Starting dynamic subtest: pipe-C-eDP-1
[438.397987] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s)
[438.407872] Starting dynamic subtest: pipe-D-eDP-1
[439.937602] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[439.939520] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.547s)
[441.080460] [047/130] (580s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[441.184970] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[441.189499] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[441.276567] [048/130] (580s left) gem_ppgtt (shrink-vs-evict-any)
[441.337597] Starting subtest: shrink-vs-evict-any
[448.543095] Subtest shrink-vs-evict-any: SUCCESS (7.152s)
[448.586622] [049/130] (573s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[448.657728] Starting subtest: multi-wait-for-submit-available-submitted
[448.660090] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[448.767158] [050/130] (573s left) kms_vblank (ts-continuation-idle-hang)
[448.864917] Starting subtest: ts-continuation-idle-hang
[448.867213] Starting dynamic subtest: pipe-A-eDP-1
[475.286703] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.415s)
[475.300452] Starting dynamic subtest: pipe-D-eDP-1
[500.247334] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.949s)
[500.249260] Subtest ts-continuation-idle-hang: SUCCESS (51.370s)
[501.060184] [051/130] (520s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[501.165342] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[501.167686] Starting dynamic subtest: pipe-A-eDP-1
[501.190287] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.204555] Starting dynamic subtest: pipe-B-eDP-1
[501.226301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.234525] Starting dynamic subtest: pipe-C-eDP-1
[501.255951] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.265428] Starting dynamic subtest: pipe-D-eDP-1
[501.287214] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.291539] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[503.417493] [052/130] (518s left) gem_exec_flush (basic-wb-rw-before-default)
[503.481483] Starting subtest: basic-wb-rw-before-default
[508.963355] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[509.128621] [053/130] (512s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[509.231552] Starting subtest: psr-rgb101010-draw-mmap-wc
[516.390874] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.164s)
[516.494198] [054/130] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[516.591074] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[516.595194] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[516.696754] [055/130] (505s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[516.797819] Starting subtest: 4-tiled-64bpp-rotate-90
[516.819187] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.021s)
[516.933182] [056/130] (505s left) gem_userptr_blits (probe)
[517.001098] Starting subtest: probe
[517.080958] Subtest probe: SUCCESS (0.079s)
[517.198507] [057/130] (504s left) i915_selftest (perf)
[520.505657] Starting subtest: perf
[520.508415] Starting dynamic subtest: engine_cs
[524.870413] Dynamic subtest engine_cs: SUCCESS (4.364s)
[524.880103] Starting dynamic subtest: request
[532.119419] Dynamic subtest request: SUCCESS (7.247s)
[532.128879] Starting dynamic subtest: migrate
[536.420397] Dynamic subtest migrate: SUCCESS (4.298s)
[536.430260] Starting dynamic subtest: region
[542.528206] Dynamic subtest region: SUCCESS (6.106s)
[542.530774] Subtest perf: SUCCESS (22.024s)
[542.559424] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[542.560196] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[542.563206] [058/130] (479s left) gem_exec_fence (basic-wait-all)
[544.139499] Starting subtest: basic-wait-all
[544.258890] Subtest basic-wait-all: SUCCESS (0.122s)
[546.506135] [FACT gem_exec_fence (basic-wait-all)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[546.507354] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.i915: true
[546.511958] [059/130] (475s left) core_getstats (basic)
[546.572181] Starting subtest: basic
[546.574504] Subtest basic: SUCCESS (0.000s)
[546.665872] [060/130] (475s left) gem_exec_schedule (reorder-wide)
[546.848243] Subtest reorder-wide: SKIP (0.000s)
[547.030663] [061/130] (475s left) gem_mmap_gtt (coherency)
[547.088934] Subtest coherency: SKIP (0.000s)
[547.145940] [062/130] (475s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[547.251279] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[547.255656] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[547.337731] [063/130] (474s left) kms_pipe_crc_basic (read-crc)
[547.429598] Starting subtest: read-crc
[547.431859] Starting dynamic subtest: pipe-A-eDP-1
[548.169549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[548.179689] Starting dynamic subtest: pipe-B-eDP-1
[549.574698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[549.584525] Starting dynamic subtest: pipe-C-eDP-1
[550.963428] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[550.973367] Starting dynamic subtest: pipe-D-eDP-1
[552.298127] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[552.300071] Subtest read-crc: SUCCESS (4.867s)
[553.117242] [064/130] (469s left) i915_getparams_basic (basic-subslice-total)
[553.179088] Starting subtest: basic-subslice-total
[553.183568] Subtest basic-subslice-total: SUCCESS (0.000s)
[553.288842] [065/130] (469s left) perf_pmu (idle)
[553.331760] Starting subtest: idle
[553.333975] Starting dynamic subtest: rcs0
[553.870244] Dynamic subtest rcs0: SUCCESS (0.538s)
[553.882924] Starting dynamic subtest: bcs0
[554.387504] Dynamic subtest bcs0: SUCCESS (0.515s)
[554.399073] Starting dynamic subtest: vcs0
[554.907917] Dynamic subtest vcs0: SUCCESS (0.517s)
[554.918661] Starting dynamic subtest: vcs1
[555.424746] Dynamic subtest vcs1: SUCCESS (0.514s)
[555.436374] Starting dynamic subtest: vecs0
[555.943003] Dynamic subtest vecs0: SUCCESS (0.516s)
[555.954703] Starting dynamic subtest: ccs0
[556.459017] Dynamic subtest ccs0: SUCCESS (0.513s)
[556.461750] Subtest idle: SUCCESS (3.129s)
[556.563177] [066/130] (465s left) gem_mmap_offset (partial-remap)
[556.620241] Starting subtest: partial-remap
[556.622154] Starting dynamic subtest: smem0
[556.631550] Dynamic subtest smem0: SUCCESS (0.005s)
[556.633519] Subtest partial-remap: SUCCESS (0.006s)
[556.739565] [067/130] (465s left) gem_exec_flush (basic-uc-set-default)
[556.799603] Starting subtest: basic-uc-set-default
[562.293095] Subtest basic-uc-set-default: SUCCESS (5.480s)
[562.471163] [068/130] (460s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[562.578280] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[562.582557] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[562.659495] [069/130] (459s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[562.757520] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[562.761444] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[562.859479] [070/130] (459s left) kms_cursor_crc (cursor-random-64x21)
[563.042732] Starting subtest: cursor-random-64x21
[563.097615] Subtest cursor-random-64x21: SKIP (0.048s)
[563.327994] [071/130] (459s left) gem_mmap_wc (read-write)
[563.381592] Subtest read-write: SKIP (0.000s)
[563.433721] [072/130] (459s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[563.545043] Starting subtest: flip-vs-cursor-atomic
[570.695780] Subtest flip-vs-cursor-atomic: SUCCESS (7.149s)
[571.551465] [073/130] (451s left) gem_exec_reloc (basic-wc-read-noreloc)
[571.614699] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[571.690226] [074/130] (451s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[571.792733] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[571.796825] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[571.883375] [075/130] (450s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[571.993068] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[571.997293] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[572.094851] [076/130] (450s left) gem_exec_store (basic)
[572.151390] Starting subtest: basic
[572.227236] Subtest basic: SUCCESS (0.079s)
[572.414065] [077/130] (450s left) perf (invalid-open-flags)
[572.530093] Starting subtest: invalid-open-flags
[572.532014] Subtest invalid-open-flags: SUCCESS (0.000s)
[572.582348] [078/130] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[572.677644] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[579.620047] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.943s)
[579.758814] [079/130] (443s left) dumb_buffer (map-valid)
[579.811418] Starting subtest: map-valid
[579.813363] Subtest map-valid: SUCCESS (0.000s)
[579.899732] [080/130] (443s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[579.988929] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[586.928634] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.940s)
[587.056093] [081/130] (435s left) gem_exec_fence (basic-await)
[587.236241] Starting subtest: basic-await
[587.238881] Starting dynamic subtest: rcs0
[587.312899] Dynamic subtest rcs0: SUCCESS (0.076s)
[587.327236] Starting dynamic subtest: bcs0
[587.386356] Dynamic subtest bcs0: SUCCESS (0.073s)
[587.396212] Starting dynamic subtest: vcs0
[587.462951] Dynamic subtest vcs0: SUCCESS (0.074s)
[587.475109] Starting dynamic subtest: vcs1
[587.538742] Dynamic subtest vcs1: SUCCESS (0.074s)
[587.550807] Starting dynamic subtest: vecs0
[587.615343] Dynamic subtest vecs0: SUCCESS (0.075s)
[587.625919] Starting dynamic subtest: ccs0
[587.692685] Dynamic subtest ccs0: SUCCESS (0.076s)
[587.694983] Subtest basic-await: SUCCESS (0.458s)
[589.555176] [082/130] (433s left) kms_psr (pr-sprite-mmap-gtt)
[589.644220] Starting subtest: pr-sprite-mmap-gtt
[589.648259] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[589.732326] [083/130] (433s left) syncobj_wait (wait-zero-handles)
[589.783617] Starting subtest: wait-zero-handles
[589.785567] Subtest wait-zero-handles: SUCCESS (0.000s)
[589.871168] [084/130] (433s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[589.937291] Starting subtest: single-wait-all-for-submit-signaled
[589.939348] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[590.050755] [085/130] (433s left) kms_lease (cursor-implicit-plane)
[590.148000] Starting subtest: cursor-implicit-plane
[590.150293] Starting dynamic subtest: pipe-A-eDP-1
[590.610177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s)
[590.622821] Starting dynamic subtest: pipe-B-eDP-1
[591.767843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.154s)
[591.777173] Starting dynamic subtest: pipe-C-eDP-1
[592.877120] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[592.886406] Starting dynamic subtest: pipe-D-eDP-1
[594.000647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[594.002947] Subtest cursor-implicit-plane: SUCCESS (3.852s)
[594.860395] [086/130] (428s left) gem_workarounds (reset-context)
[594.935679] Starting subtest: reset-context
[595.106015] Subtest reset-context: SUCCESS (0.170s)
[595.247848] [087/130] (428s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[595.306629] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[595.416196] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[595.489691] [088/130] (427s left) gem_exec_fence (syncobj-timeline-wait)
[596.013138] Starting subtest: syncobj-timeline-wait
[597.488053] Subtest syncobj-timeline-wait: SUCCESS (1.474s)
[599.589206] [089/130] (423s left) kms_psr (fbc-psr2-sprite-render)
[599.693109] Starting subtest: fbc-psr2-sprite-render
[599.695425] Starting dynamic subtest: eDP-1
[599.699855] Dynamic subtest eDP-1: SKIP (0.000s)
[599.704270] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[599.766992] [090/130] (423s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[599.819804] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[599.919487] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[600.009085] [091/130] (423s left) gem_flink_basic (double-flink)
[600.057853] Starting subtest: double-flink
[600.060104] Subtest double-flink: SUCCESS (0.000s)
[600.156168] [092/130] (423s left) drm_read (short-buffer-block)
[600.288007] Starting subtest: short-buffer-block
[600.290325] Subtest short-buffer-block: SUCCESS (0.000s)
[600.414518] [093/130] (423s left) gem_exec_fence (syncobj-invalid-flags)
[600.826195] Starting subtest: syncobj-invalid-flags
[600.828693] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[602.558034] [094/130] (421s left) gem_eio (wait-wedge-10ms)
[602.795209] Starting subtest: wait-wedge-10ms
[604.522187] Subtest wait-wedge-10ms: SUCCESS (1.727s)
[604.653929] [095/130] (418s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[604.744329] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[604.748309] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[604.817885] [096/130] (418s left) prime_busy (hang)
[604.869944] Starting subtest: hang
[604.872272] Starting dynamic subtest: rcs0
[631.035138] Dynamic subtest rcs0: SUCCESS (26.146s)
[631.044079] Starting dynamic subtest: bcs0
[638.115580] Dynamic subtest bcs0: SUCCESS (7.087s)
[638.125072] Starting dynamic subtest: vcs0
[645.154099] Dynamic subtest vcs0: SUCCESS (7.039s)
[645.163289] Starting dynamic subtest: vcs1
[652.128840] Dynamic subtest vcs1: SUCCESS (6.978s)
[652.138452] Starting dynamic subtest: vecs0
[659.114392] Dynamic subtest vecs0: SUCCESS (6.980s)
[659.123882] Starting dynamic subtest: ccs0
[673.007428] Dynamic subtest ccs0: SUCCESS (13.896s)
[673.009807] Subtest hang: SUCCESS (68.134s)
[673.130415] [097/130] (350s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[673.229401] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[673.233479] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[673.340968] [098/130] (350s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[673.437777] Starting subtest: fbc-psr2-primary-mmap-gtt
[673.439915] Starting dynamic subtest: eDP-1
[673.443823] Dynamic subtest eDP-1: SKIP (0.000s)
[673.447715] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[673.510492] [099/130] (350s left) kms_universal_plane (universal-plane-pageflip-windowed)
[673.592962] Starting subtest: universal-plane-pageflip-windowed
[673.595235] Starting dynamic subtest: pipe-A-eDP-1
[674.196726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[674.210206] Starting dynamic subtest: pipe-B-eDP-1
[675.396009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s)
[675.405855] Starting dynamic subtest: pipe-C-eDP-1
[676.622294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[676.632658] Starting dynamic subtest: pipe-D-eDP-1
[677.838617] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[677.841081] Subtest universal-plane-pageflip-windowed: SUCCESS (4.247s)
[678.679887] [100/130] (345s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[678.778891] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[678.783336] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[678.879997] [101/130] (345s left) gem_spin_batch (user-each)
[678.945359] Starting subtest: user-each
[682.212803] Subtest user-each: SUCCESS (3.261s)
[682.545269] [102/130] (341s left) kms_plane_scaling (invalid-num-scalers)
[682.640749] Starting subtest: invalid-num-scalers
[682.642873] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[682.661060] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.020s)
[682.671615] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[682.696612] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[682.706239] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[682.732299] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[682.741794] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[682.768546] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.037s)
[682.770868] Subtest invalid-num-scalers: SUCCESS (0.130s)
[682.881404] [103/130] (341s left) kms_addfb_basic (bo-too-small)
[682.990065] Starting subtest: bo-too-small
[682.992220] Subtest bo-too-small: SUCCESS (0.000s)
[683.077048] [104/130] (340s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[683.160366] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[683.162715] Starting dynamic subtest: pipe-A-eDP-1
[683.185996] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[683.198180] Starting dynamic subtest: pipe-B-eDP-1
[683.219718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[683.229610] Starting dynamic subtest: pipe-C-eDP-1
[683.251276] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[683.260849] Starting dynamic subtest: pipe-D-eDP-1
[683.283179] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[683.287546] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[685.430143] [105/130] (338s left) gem_exec_balancer (fairslice)
[685.486650] Starting subtest: fairslice
[688.407452] Subtest fairslice: SUCCESS (2.919s)
[688.726337] [106/130] (335s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[688.821574] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[688.825619] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[688.943484] [107/130] (335s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[689.039490] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[689.043640] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[689.110876] [108/130] (335s left) perf (missing-sample-flags)
[689.209858] Starting subtest: missing-sample-flags
[689.212322] Subtest missing-sample-flags: SUCCESS (0.000s)
[689.254834] [109/130] (334s left) kms_cursor_crc (cursor-sliding-256x256)
[689.486022] Starting subtest: cursor-sliding-256x256
[689.490737] Starting dynamic subtest: pipe-A-eDP-1
[692.745997] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.256s)
[692.777922] Starting dynamic subtest: pipe-D-eDP-1
[696.620350] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.849s)
[696.622145] Subtest cursor-sliding-256x256: SUCCESS (7.132s)
[697.488176] [110/130] (326s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[697.605865] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[698.546656] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.941s)
[698.798332] [111/130] (325s left) dmabuf_sync_file (import-multiple-read-write)
[698.839904] Starting subtest: import-multiple-read-write
[698.842175] Subtest import-multiple-read-write: SUCCESS (0.003s)
[698.893788] [112/130] (325s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[699.021286] Starting subtest: short-busy-flip-before-cursor-toggle
[699.025901] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[699.164056] [113/130] (325s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[699.254166] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[699.256426] Starting dynamic subtest: pipe-A-eDP-1
[699.277535] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[699.289639] Starting dynamic subtest: pipe-B-eDP-1
[699.310006] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[699.319982] Starting dynamic subtest: pipe-C-eDP-1
[699.339750] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[699.349291] Starting dynamic subtest: pipe-D-eDP-1
[699.369091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[699.371270] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[701.554488] [114/130] (322s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[701.667261] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[701.679839] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[701.757796] [115/130] (322s left) gem_ctx_persistence (heartbeat-stop)
[701.819637] Starting subtest: heartbeat-stop
[701.824489] Subtest heartbeat-stop: SKIP (0.000s)
[701.923653] [116/130] (322s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[702.010034] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[702.012404] Starting dynamic subtest: pipe-A
[702.072244] Dynamic subtest pipe-A: SUCCESS (0.065s)
[702.081692] Starting dynamic subtest: pipe-B
[703.192002] Dynamic subtest pipe-B: SUCCESS (1.119s)
[703.203667] Starting dynamic subtest: pipe-C
[704.301838] Dynamic subtest pipe-C: SUCCESS (1.109s)
[704.312415] Starting dynamic subtest: pipe-D
[705.433466] Dynamic subtest pipe-D: SUCCESS (1.131s)
[705.435801] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.426s)
[706.601998] [117/130] (317s left) prime_vgem (basic-gtt)
[706.662869] Starting subtest: basic-gtt
[706.667611] Subtest basic-gtt: SKIP (0.000s)
[706.781223] [118/130] (317s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[706.888325] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[713.950998] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.064s)
[714.075513] [119/130] (310s left) gem_mmap_wc (write-read)
[714.137333] Subtest write-read: SKIP (0.000s)
[714.193853] [120/130] (310s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[714.292825] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[714.296872] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[714.376692] [121/130] (310s left) api_intel_allocator (gem-pool)
[714.429838] Starting subtest: gem-pool
[714.435640] Subtest gem-pool: SUCCESS (0.006s)
[714.568017] [122/130] (310s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[714.677527] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[714.681754] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[714.800400] [123/130] (310s left) kms_content_protection (uevent)
[714.942091] Starting subtest: uevent
[714.945797] Subtest uevent: SKIP (0.000s)
[715.056508] [124/130] (309s left) syncobj_timeline (multi-wait-all-available-submitted)
[715.109408] Starting subtest: multi-wait-all-available-submitted
[715.111494] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[715.209482] [125/130] (309s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[715.314687] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[722.776407] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.462s)
[722.909433] [126/130] (302s left) kms_joiner (invalid-modeset-big-joiner)
[723.083903] Starting subtest: invalid-modeset-big-joiner
[723.088286] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[723.161999] [127/130] (301s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[723.295910] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[724.288651] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.994s)
[724.563875] [128/130] (300s left) i915_drm_fdinfo (memory-info-resident)
[724.624515] Starting subtest: memory-info-resident
[724.626500] Starting dynamic subtest: smem0
[727.546538] Dynamic subtest smem0: SUCCESS (2.923s)
[727.549171] Subtest memory-info-resident: SUCCESS (2.925s)
[727.624549] [129/130] (297s left) kms_busy (basic-hang)
[727.729265] Starting subtest: basic-hang
[727.731141] Starting dynamic subtest: flip-pipe-A
[728.323147] Dynamic subtest flip-pipe-A: SUCCESS (0.592s)
[728.334312] Starting dynamic subtest: modeset-pipe-A
[731.774409] Dynamic subtest modeset-pipe-A: SUCCESS (3.451s)
[731.784718] Starting dynamic subtest: flip-pipe-D
[732.968265] Dynamic subtest flip-pipe-D: SUCCESS (1.190s)
[732.978714] Starting dynamic subtest: modeset-pipe-D
[736.407914] Dynamic subtest modeset-pipe-D: SUCCESS (3.439s)
[736.410321] Subtest basic-hang: SUCCESS (8.678s)
[737.208065] [130/130] (287s left) gem_exec_schedule (preemptive-hang)
[737.391197] Starting subtest: preemptive-hang
[737.393809] Starting dynamic subtest: rcs0
[746.628080] Dynamic subtest rcs0: SUCCESS (9.238s)
[746.652117] Starting dynamic subtest: bcs0
[755.585061] Dynamic subtest bcs0: SUCCESS (8.952s)
[755.596929] Starting dynamic subtest: vcs0
[764.608716] Dynamic subtest vcs0: SUCCESS (9.020s)
[764.620755] Starting dynamic subtest: vcs1
[773.566088] Dynamic subtest vcs1: SUCCESS (8.957s)
[773.577714] Starting dynamic subtest: vecs0
[782.585758] Dynamic subtest vecs0: SUCCESS (9.019s)
[782.597726] Starting dynamic subtest: ccs0
[791.682846] Dynamic subtest ccs0: SUCCESS (9.091s)
[791.685623] Subtest preemptive-hang: SUCCESS (54.286s)
[791.906016] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_atomic
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: gem_huc_copy
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: drm_read
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: i915_pm_rc6_residency
results: parsing output: 14/ for test: kms_pm_lpsp
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_rotation_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: gem_create
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_readwrite
results: parsing output: 24/ for test: gem_request_retire
results: parsing output: 25/ for test: kms_color_pipeline
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ringfill
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gen3_render_mixed_blits
results: parsing output: 35/ for test: kms_fbcon_fbt
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_tiling_max_stride
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_chamelium_frames
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_ppgtt
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_exec_flush
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: i915_selftest
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: core_getstats
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: i915_getparams_basic
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: gem_exec_flush
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_store
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: dumb_buffer
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_lease
results: parsing output: 85/ for test: gem_workarounds
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: gem_flink_basic
results: parsing output: 91/ for test: drm_read
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: prime_busy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_universal_plane
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: perf
results: parsing output: 108/ for test: kms_cursor_crc
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: dmabuf_sync_file
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: prime_vgem
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_mmap_wc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_joiner
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: kms_busy
results: parsing output: 129/ for test: gem_exec_schedule
Done.