[71.702141] Initializing watchdogs
[71.702249]   /dev/watchdog0
[71.745571] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[71.775523] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[71.784974] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.789473] [001/156] (960s left) api_intel_allocator (execbuf-with-allocator)
[71.877729] Starting subtest: execbuf-with-allocator
[71.911418] Subtest execbuf-with-allocator: SUCCESS (0.034s)
[72.317441] [002/156] (960s left) gem_busy (semaphore)
[72.532053] Subtest semaphore: SKIP (0.000s)
[72.899425] [003/156] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[74.401418] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[74.404169] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[74.567953] [004/156] (958s left) gem_exec_reloc (basic-wc-read-noreloc)
[74.644855] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[74.738472] [005/156] (957s left) gem_exec_schedule (promotion)
[74.799339] Starting subtest: promotion
[74.800845] Starting dynamic subtest: rcs0
[75.012565] Dynamic subtest rcs0: SUCCESS (0.209s)
[75.022151] Starting dynamic subtest: bcs0
[75.151085] Dynamic subtest bcs0: SUCCESS (0.141s)
[75.160878] Starting dynamic subtest: vcs0
[75.299145] Dynamic subtest vcs0: SUCCESS (0.148s)
[75.309565] Starting dynamic subtest: vcs1
[75.443870] Dynamic subtest vcs1: SUCCESS (0.144s)
[75.453148] Starting dynamic subtest: vecs0
[75.598424] Dynamic subtest vecs0: SUCCESS (0.154s)
[75.599911] Subtest promotion: SUCCESS (0.798s)
[76.056672] [006/156] (956s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[77.576151] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[78.743730] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.163s)
[78.918645] [007/156] (953s left) perf (global-sseu-config)
[79.038279] Starting subtest: global-sseu-config
[79.039758] Starting dynamic subtest: 0-rcs0
[79.094682] Dynamic subtest 0-rcs0: SUCCESS (0.055s)
[79.096185] Subtest global-sseu-config: SUCCESS (0.055s)
[79.167500] [008/156] (953s left) gem_exec_balancer (persistence)
[79.600197] Starting subtest: persistence
[81.662445] Subtest persistence: SUCCESS (2.058s)
[81.812381] [009/156] (951s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-render)
[83.312211] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-render
[83.315286] Subtest psrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[83.448496] [010/156] (949s left) gem_ctx_bad_destroy (invalid-default-ctx)
[83.511397] Starting subtest: invalid-default-ctx
[83.513060] Subtest invalid-default-ctx: SUCCESS (0.000s)
[83.632423] [011/156] (949s left) kms_selftest (drm_format_helper)
[83.682992] Starting subtest: drm_format_helper
[83.794742] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[83.884733] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.087s)
[83.925586] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[83.957451] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.073s)
[83.975191] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[84.051547] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.089s)
[84.087851] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[84.127898] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.076s)
[84.146311] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[84.217172] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.086s)
[84.250989] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[84.287446] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.071s)
[84.314129] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[84.357599] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.070s)
[84.382586] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[84.448616] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.087s)
[84.486766] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[84.518209] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.071s)
[84.535237] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[84.600323] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.078s)
[84.637412] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[84.674831] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.075s)
[84.697572] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[84.757170] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.080s)
[84.796656] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[84.836094] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.079s)
[84.858670] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[84.926080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.089s)
[84.966066] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[85.010208] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.080s)
[85.041847] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[85.103365] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.093s)
[85.140761] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[85.187551] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.081s)
[85.189620] Subtest drm_format_helper: SUCCESS (1.501s)
[85.412638] [012/156] (947s left) gem_mmap_offset (partial-unmap)
[85.473980] Starting subtest: partial-unmap
[85.476646] Starting dynamic subtest: lmem0
[85.495542] Dynamic subtest lmem0: SUCCESS (0.024s)
[85.513492] Starting dynamic subtest: smem0
[85.515599] Dynamic subtest smem0: SUCCESS (0.011s)
[85.517772] Subtest partial-unmap: SUCCESS (0.036s)
[85.658069] [013/156] (947s left) kms_flip (flip-vs-fences-interruptible)
[87.165152] Starting subtest: flip-vs-fences-interruptible
[87.168764] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[87.332997] [014/156] (946s left) kms_plane_alpha_blend (constant-alpha-mid)
[88.831783] Starting subtest: constant-alpha-mid
[89.100602] Starting dynamic subtest: pipe-A-HDMI-A-4
[89.805043] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.703s)
[89.815362] Starting dynamic subtest: pipe-D-HDMI-A-4
[90.506388] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.699s)
[90.508285] Subtest constant-alpha-mid: SUCCESS (1.672s)
[90.705124] [015/156] (942s left) gem_exec_reloc (basic-cpu-active)
[90.760230] Subtest basic-cpu-active: SKIP (0.000s)
[90.874335] [016/156] (942s left) gem_exec_balancer (full-late)
[90.933899] Starting subtest: full-late
[93.350855] Subtest full-late: SUCCESS (2.417s)
[93.806399] [017/156] (939s left) kms_frontbuffer_tracking (fbc-1p-rte)
[95.303542] Starting subtest: fbc-1p-rte
[98.780895] Subtest fbc-1p-rte: SUCCESS (3.480s)
[98.985090] [018/156] (934s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[100.475465] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[100.477156] Starting dynamic subtest: pipe-A-HDMI-A-4
[100.493933] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s)
[100.505693] Starting dynamic subtest: pipe-B-HDMI-A-4
[100.522796] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s)
[100.533970] Starting dynamic subtest: pipe-C-HDMI-A-4
[100.560626] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s)
[100.571437] Starting dynamic subtest: pipe-D-HDMI-A-4
[100.585967] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s)
[100.588937] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[100.745020] [019/156] (932s left) kms_vblank (wait-forked-busy-hang)
[102.234239] Starting subtest: wait-forked-busy-hang
[102.235782] Starting dynamic subtest: pipe-A-HDMI-A-4
[128.489661] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (26.247s)
[128.503800] Starting dynamic subtest: pipe-D-HDMI-A-4
[153.430494] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (24.934s)
[153.432240] Subtest wait-forked-busy-hang: SUCCESS (51.187s)
[153.605539] [020/156] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[155.101387] Starting subtest: basic-busy-flip-before-cursor-legacy
[155.104975] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[155.214658] [021/156] (878s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[156.827773] Starting subtest: cursor-rapid-movement-32x10
[156.888400] Subtest cursor-rapid-movement-32x10: SKIP (0.047s)
[157.314493] [022/156] (876s left) prime_vgem (fence-read-hang)
[157.447345] Subtest fence-read-hang: SKIP (0.000s)
[157.651356] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[157.654320] [023/156] (876s left) gem_exec_parallel (engines)
[157.715666] Starting subtest: engines
[157.717352] Starting dynamic subtest: basic
[159.499050] Dynamic subtest basic: SUCCESS (1.785s)
[159.512558] Starting dynamic subtest: contexts
[163.982832] Dynamic subtest contexts: SUCCESS (4.480s)
[163.994587] Starting dynamic subtest: fds
[166.925905] Dynamic subtest fds: SUCCESS (2.943s)
[166.937786] Starting dynamic subtest: userptr
[168.450184] Dynamic subtest userptr: SUCCESS (1.527s)
[168.451837] Subtest engines: SUCCESS (10.738s)
[168.824410] [024/156] (865s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[170.323609] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[170.326341] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[170.506602] [025/156] (863s left) kms_getfb (getfb-handle-protection)
[171.997270] Starting subtest: getfb-handle-protection
[172.013279] Subtest getfb-handle-protection: SUCCESS (0.017s)
[172.187015] [026/156] (862s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[173.678223] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[173.679854] Starting dynamic subtest: pipe-A-valid-mode
[174.567961] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.889s)
[174.570781] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.891s)
[174.760520] [027/156] (859s left) kms_psr (fbc-psr2-sprite-blt)
[176.253149] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[176.339027] [028/156] (858s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[177.840450] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[177.843751] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[178.039419] [029/156] (856s left) kms_addfb_basic (addfb25-modifier-no-flag)
[179.530777] Starting subtest: addfb25-modifier-no-flag
[179.532517] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[179.693966] [030/156] (855s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[181.187340] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[181.188913] Starting dynamic subtest: pipe-A-HDMI-A-4
[201.612583] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.599s)
[201.654925] Starting dynamic subtest: pipe-B-HDMI-A-4
[223.554648] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (10.295s)
[223.567827] Starting dynamic subtest: pipe-C-HDMI-A-4
[245.566279] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (10.220s)
[245.579988] Starting dynamic subtest: pipe-D-HDMI-A-4
[267.559179] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (10.118s)
[267.560838] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (41.240s)
[272.796152] [031/156] (767s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[274.297964] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[274.300698] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[274.518103] [032/156] (765s left) perf (gen8-unprivileged-single-ctx-counters)
[274.641541] Starting subtest: gen8-unprivileged-single-ctx-counters
[274.644777] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[274.715450] [033/156] (765s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[276.211710] Starting subtest: psr-farfromfence-mmap-gtt
[276.214544] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[276.398780] [034/156] (763s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[277.920328] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[277.922897] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[278.167404] [035/156] (762s left) gem_partial_pwrite_pread (reads-snoop)
[278.221553] Subtest reads-snoop: SKIP (0.000s)
[278.314268] [036/156] (762s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[279.811061] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[279.896166] [037/156] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[281.393941] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[281.396563] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[281.584564] [038/156] (759s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[283.084007] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[283.087392] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[283.282854] [039/156] (757s left) kms_psr (fbc-psr-sprite-plane-onoff)
[284.780424] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[284.864808] [040/156] (755s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[286.354531] Starting subtest: plane-lut1d-ctm3x4-lut1d
[286.551074] Starting dynamic subtest: pipe-A-plane-0
[286.801043] Dynamic subtest pipe-A-plane-0: SUCCESS (0.249s)
[286.831009] Starting dynamic subtest: pipe-A-plane-1
[287.000977] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[287.035494] Starting dynamic subtest: pipe-A-plane-2
[287.200696] Dynamic subtest pipe-A-plane-2: SUCCESS (0.195s)
[287.494266] Starting dynamic subtest: pipe-B-plane-0
[287.642446] Dynamic subtest pipe-B-plane-0: SUCCESS (0.165s)
[287.656079] Starting dynamic subtest: pipe-B-plane-1
[287.827800] Dynamic subtest pipe-B-plane-1: SUCCESS (0.183s)
[287.860630] Starting dynamic subtest: pipe-B-plane-2
[288.011240] Dynamic subtest pipe-B-plane-2: SUCCESS (0.178s)
[288.322796] Starting dynamic subtest: pipe-C-plane-0
[288.501304] Dynamic subtest pipe-C-plane-0: SUCCESS (0.215s)
[288.543035] Starting dynamic subtest: pipe-C-plane-1
[288.718136] Dynamic subtest pipe-C-plane-1: SUCCESS (0.212s)
[288.761370] Starting dynamic subtest: pipe-C-plane-2
[288.934821] Dynamic subtest pipe-C-plane-2: SUCCESS (0.214s)
[289.236396] Starting dynamic subtest: pipe-D-plane-0
[289.406009] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[289.419713] Starting dynamic subtest: pipe-D-plane-1
[289.591506] Dynamic subtest pipe-D-plane-1: SUCCESS (0.183s)
[289.609874] Starting dynamic subtest: pipe-D-plane-2
[289.774974] Dynamic subtest pipe-D-plane-2: SUCCESS (0.180s)
[289.830536] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.473s)
[290.041839] [041/156] (750s left) gem_ctx_param (invalid-get-no-zeromap)
[290.101737] Starting subtest: invalid-get-no-zeromap
[290.103230] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[290.231480] [042/156] (750s left) kms_psr (psr-primary-mmap-gtt)
[291.724766] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[291.806221] [043/156] (749s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt)
[293.305840] Starting subtest: hdr-rgb101010-draw-blt
[293.309253] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s)
[293.505359] [044/156] (747s left) kms_cursor_crc (cursor-onscreen-128x42)
[295.201230] Starting subtest: cursor-onscreen-128x42
[295.208657] Starting dynamic subtest: pipe-A-HDMI-A-4
[297.616294] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.407s)
[297.649744] Starting dynamic subtest: pipe-D-HDMI-A-4
[300.308763] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.670s)
[300.310491] Subtest cursor-onscreen-128x42: SUCCESS (5.106s)
[300.721045] [045/156] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[302.243453] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[302.247250] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[302.432758] [046/156] (738s left) kms_setmode (basic)
[302.481876] Starting subtest: basic
[302.566743] Starting dynamic subtest: pipe-A-HDMI-A-4
[304.697945] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.126s)
[304.784893] Starting dynamic subtest: pipe-C-HDMI-A-4
[306.900897] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.123s)
[306.936523] Subtest basic: SUCCESS (4.454s)
[307.162459] [047/156] (734s left) kms_psr (pr-cursor-mmap-cpu)
[308.656159] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[308.734608] [048/156] (732s left) gem_exec_schedule (preempt-queue)
[308.805931] Subtest preempt-queue: SKIP (0.000s)
[309.231259] [049/156] (732s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[310.733216] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[310.736857] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[310.924873] [050/156] (730s left) gem_userptr_blits (map-fixed-invalidate)
[310.987484] Starting subtest: map-fixed-invalidate
[310.990775] Subtest map-fixed-invalidate: SKIP (0.000s)
[311.212766] [051/156] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[312.712097] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[312.715525] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[312.855007] [052/156] (729s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[314.352692] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[314.355855] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[314.473087] [053/156] (727s left) gem_ctx_shared (q-out-order)
[314.541377] Starting subtest: Q-out-order
[314.543033] Starting dynamic subtest: rcs0
[314.737491] Dynamic subtest rcs0: SUCCESS (0.192s)
[314.752024] Starting dynamic subtest: bcs0
[314.870452] Dynamic subtest bcs0: SUCCESS (0.132s)
[314.884942] Starting dynamic subtest: vcs0
[314.997794] Dynamic subtest vcs0: SUCCESS (0.127s)
[315.011594] Starting dynamic subtest: vcs1
[315.121580] Dynamic subtest vcs1: SUCCESS (0.123s)
[315.138637] Starting dynamic subtest: vecs0
[315.256184] Dynamic subtest vecs0: SUCCESS (0.133s)
[315.258045] Subtest Q-out-order: SUCCESS (0.712s)
[315.633109] [054/156] (726s left) i915_pm_rps (engine-order)
[315.692165] Starting subtest: engine-order
[323.535052] Subtest engine-order: SUCCESS (7.843s)
[323.748196] [055/156] (718s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[325.246660] Starting subtest: fbchdr-tiling-linear
[325.249384] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[325.436939] [056/156] (716s left) gem_pxp (create-protected-buffer)
[328.010128] Starting subtest: create-protected-buffer
[328.013021] Subtest create-protected-buffer: SKIP (0.000s)
[328.126216] [057/156] (714s left) syncobj_eventfd (binary-wait)
[328.183732] Starting subtest: binary-wait
[328.193611] Subtest binary-wait: SUCCESS (0.011s)
[328.319882] [058/156] (714s left) kms_prop_blob (basic)
[328.367764] Starting subtest: basic
[328.369292] Subtest basic: SUCCESS (0.000s)
[328.503276] [059/156] (714s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[329.999682] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[330.002397] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[330.173269] [060/156] (712s left) gem_create (create-invalid-size)
[330.223302] Starting subtest: create-invalid-size
[330.224881] Subtest create-invalid-size: SUCCESS (0.000s)
[330.559348] [061/156] (712s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[332.058308] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[332.061237] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[332.217947] [062/156] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[333.718759] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[333.722525] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[333.893668] [063/156] (709s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[335.405272] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[335.996404] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[336.216834] [064/156] (706s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[337.705824] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[337.707551] Starting dynamic subtest: pipe-A-valid-mode
[340.245630] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.537s)
[340.247082] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (2.539s)
[340.452320] [065/156] (702s left) i915_pm_rps (thresholds-park)
[340.511239] Starting subtest: thresholds-park
[340.514185] Subtest thresholds-park: SKIP (0.001s)
[340.642653] [066/156] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[342.140247] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[342.143051] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[342.323876] [067/156] (701s left) gem_ctx_persistence (userptr)
[342.382019] Starting subtest: userptr
[342.543152] Subtest userptr: SUCCESS (0.164s)
[342.734880] [068/156] (700s left) sw_sync (alloc_timeline)
[342.814296] Starting subtest: alloc_timeline
[342.816017] Subtest alloc_timeline: SUCCESS (0.000s)
[342.917448] [069/156] (700s left) gem_eio (unwedge-stress)
[343.094510] Starting subtest: unwedge-stress
[343.096176] Starting dynamic subtest: render
[348.971252] Dynamic subtest render: SUCCESS (5.876s)
[348.986785] Starting dynamic subtest: bsd1
[358.681337] Dynamic subtest bsd1: SUCCESS (9.708s)
[358.696202] Starting dynamic subtest: bsd2
[367.350208] Dynamic subtest bsd2: SUCCESS (8.667s)
[367.365541] Starting dynamic subtest: blt
[374.285032] Dynamic subtest blt: SUCCESS (6.934s)
[374.300895] Starting dynamic subtest: vebox
[382.302564] Dynamic subtest vebox: SUCCESS (8.017s)
[382.304015] Subtest unwedge-stress: SUCCESS (39.209s)
[383.956536] [070/156] (659s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[385.449711] Starting subtest: random-ccs-data-yf-tiled-ccs
[385.451207] Starting dynamic subtest: pipe-A-HDMI-A-4
[385.467006] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[385.482249] Starting dynamic subtest: pipe-B-HDMI-A-4
[385.498001] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[385.512640] Starting dynamic subtest: pipe-C-HDMI-A-4
[385.531563] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[385.545955] Starting dynamic subtest: pipe-D-HDMI-A-4
[385.563033] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[385.566094] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.008s)
[385.759428] [071/156] (658s left) gem_madvise (dontneed-after-mmap)
[385.838787] Starting subtest: dontneed-after-mmap
[385.842118] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[386.004846] [072/156] (657s left) gem_spin_batch (resubmit-new)
[386.063013] Starting subtest: resubmit-new
[386.064752] Starting dynamic subtest: rcs0
[386.084516] Dynamic subtest rcs0: SUCCESS (0.021s)
[386.100160] Starting dynamic subtest: bcs0
[386.101870] Dynamic subtest bcs0: SUCCESS (0.005s)
[386.130173] Starting dynamic subtest: vcs0
[386.131777] Dynamic subtest vcs0: SUCCESS (0.006s)
[386.146785] Starting dynamic subtest: vcs1
[386.148197] Dynamic subtest vcs1: SUCCESS (0.004s)
[386.162774] Starting dynamic subtest: vecs0
[386.164172] Dynamic subtest vecs0: SUCCESS (0.005s)
[386.165776] Subtest resubmit-new: SUCCESS (0.047s)
[386.381285] [073/156] (657s left) syncobj_basic (create-signaled)
[386.432717] Starting subtest: create-signaled
[386.434313] Subtest create-signaled: SUCCESS (0.000s)
[386.543880] [074/156] (657s left) kms_pm_dc (dc5-dpms-negative)
[389.067646] Starting subtest: dc5-dpms-negative
[393.297268] Subtest dc5-dpms-negative: SUCCESS (4.226s)
[393.414375] [075/156] (650s left) syncobj_timeline (single-wait-all-signaled)
[393.482702] Starting subtest: single-wait-all-signaled
[393.484495] Subtest single-wait-all-signaled: SUCCESS (0.002s)
[393.626710] [076/156] (650s left) gem_workarounds (suspend-resume)
[393.701491] Starting subtest: suspend-resume
[414.505777] Subtest suspend-resume: SUCCESS (10.146s)
[421.665971] [077/156] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[423.829577] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[423.833194] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[424.021125] [078/156] (627s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[425.513589] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[425.515189] Starting dynamic subtest: pipe-A-HDMI-A-4
[425.556657] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[425.572614] Starting dynamic subtest: pipe-B-HDMI-A-4
[425.627437] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[425.643163] Starting dynamic subtest: pipe-C-HDMI-A-4
[425.680704] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[425.696548] Starting dynamic subtest: pipe-D-HDMI-A-4
[425.744249] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[425.747977] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.019s)
[425.836491] [079/156] (625s left) dumb_buffer (create-clear)
[425.885741] Starting subtest: create-clear
[464.327230] Subtest create-clear: SUCCESS (38.437s)
[464.479879] [080/156] (587s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[465.978870] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[465.982090] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[466.191191] [081/156] (585s left) gem_ctx_engines (none)
[466.249485] Starting subtest: none
[466.255565] Subtest none: SUCCESS (0.002s)
[466.591148] [082/156] (585s left) syncobj_timeline (device-submit-unordered)
[466.640919] Starting subtest: device-submit-unordered
[466.642616] Subtest device-submit-unordered: SUCCESS (0.001s)
[466.794983] [083/156] (585s left) kms_debugfs (display-on-read-all)
[468.285251] Starting subtest: display-on-read-all
[468.441855] Subtest display-on-read-all: SUCCESS (0.157s)
[468.776267] [084/156] (583s left) kms_psr (fbc-pr-dpms)
[470.268771] Subtest fbc-pr-dpms: SKIP (0.000s)
[470.358496] [085/156] (581s left) gem_exec_fence (syncobj-invalid-wait)
[470.781467] Starting subtest: syncobj-invalid-wait
[470.783178] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[471.203607] [086/156] (581s left) sw_sync (sync_multi_timeline_wait)
[471.261541] Starting subtest: sync_multi_timeline_wait
[471.263176] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[471.344151] [087/156] (581s left) prime_self_import (reimport-vs-gem_close-race)
[471.389349] Starting subtest: reimport-vs-gem_close-race
[476.424991] Subtest reimport-vs-gem_close-race: SUCCESS (5.034s)
[476.609860] [088/156] (575s left) kms_rmfb (rmfb-ioctl)
[478.105007] Starting subtest: rmfb-ioctl
[478.106431] Starting dynamic subtest: pipe-A-HDMI-A-4
[478.309387] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.204s)
[478.342132] Starting dynamic subtest: pipe-B-HDMI-A-4
[478.566045] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.251s)
[478.584040] Starting dynamic subtest: pipe-C-HDMI-A-4
[478.789485] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.221s)
[478.805489] Starting dynamic subtest: pipe-D-HDMI-A-4
[479.011625] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.221s)
[479.013332] Subtest rmfb-ioctl: SUCCESS (0.909s)
[479.249194] [089/156] (573s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[479.301195] Starting subtest: invalid-multi-wait-unsubmitted
[479.303151] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[479.442579] [090/156] (573s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[480.941288] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[480.944572] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[481.135722] [091/156] (571s left) syncobj_timeline (multi-wait-all-available-submitted)
[481.187718] Starting subtest: multi-wait-all-available-submitted
[481.189291] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[481.322009] [092/156] (571s left) syncobj_timeline (multi-wait-all-signaled)
[481.370013] Starting subtest: multi-wait-all-signaled
[481.371553] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[481.502653] [093/156] (571s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[483.005246] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[483.009010] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[483.196209] [094/156] (569s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[484.707826] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[485.300197] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.593s)
[485.537982] [095/156] (567s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[487.029233] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[487.030873] Starting dynamic subtest: pipe-A-valid-mode
[487.815564] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.784s)
[487.817932] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.786s)
[488.018751] [096/156] (565s left) kms_chamelium_frames (dp-crc-fast)
[489.551270] Subtest dp-crc-fast: SKIP (0.000s)
[489.682983] [097/156] (563s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[491.265976] Starting subtest: dp-mst-type-1-suspend-resume
[491.268865] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[491.476809] [098/156] (562s left) perf_pmu (most-busy-idle-check-all)
[491.573768] Starting subtest: most-busy-idle-check-all
[491.575268] Starting dynamic subtest: rcs0
[492.242702] Dynamic subtest rcs0: SUCCESS (0.668s)
[492.265092] Starting dynamic subtest: bcs0
[492.899377] Dynamic subtest bcs0: SUCCESS (0.653s)
[492.953167] Starting dynamic subtest: vcs0
[493.574425] Dynamic subtest vcs0: SUCCESS (0.668s)
[493.601052] Starting dynamic subtest: vcs1
[494.235260] Dynamic subtest vcs1: SUCCESS (0.654s)
[494.262563] Starting dynamic subtest: vecs0
[494.898428] Dynamic subtest vecs0: SUCCESS (0.656s)
[494.904619] Subtest most-busy-idle-check-all: SUCCESS (3.327s)
[495.049064] [099/156] (558s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[496.589992] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[496.723391] [100/156] (556s left) kms_async_flips (invalid-async-flip-atomic)
[498.214984] Starting subtest: invalid-async-flip-atomic
[498.402282] Starting dynamic subtest: pipe-A-HDMI-A-4
[498.824466] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.422s)
[498.987616] Starting dynamic subtest: pipe-B-HDMI-A-4
[499.092729] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.119s)
[499.270745] Starting dynamic subtest: pipe-C-HDMI-A-4
[499.373627] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.117s)
[499.545430] Starting dynamic subtest: pipe-D-HDMI-A-4
[499.655819] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.124s)
[499.657577] Subtest invalid-async-flip-atomic: SUCCESS (1.441s)
[500.037530] [101/156] (553s left) gem_eio (wait-immediate)
[500.206843] Starting subtest: wait-immediate
[500.610023] Subtest wait-immediate: SUCCESS (0.404s)
[502.198117] [102/156] (551s left) gem_exec_whisper (basic-contexts-forked-all)
[502.267432] Starting subtest: basic-contexts-forked-all
[516.931982] Subtest basic-contexts-forked-all: SUCCESS (14.664s)
[517.204923] [103/156] (536s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[518.703158] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[521.789552] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.088s)
[522.067519] [104/156] (532s left) kms_invalid_mode (bad-vtotal)
[523.561023] Starting subtest: bad-vtotal
[523.562629] Starting dynamic subtest: pipe-A-HDMI-A-4
[523.612111] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.050s)
[523.628119] Starting dynamic subtest: pipe-B-HDMI-A-4
[523.630338] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s)
[523.646496] Starting dynamic subtest: pipe-C-HDMI-A-4
[523.648168] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s)
[523.664773] Starting dynamic subtest: pipe-D-HDMI-A-4
[523.666465] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s)
[523.668121] Subtest bad-vtotal: SUCCESS (0.063s)
[523.820764] [105/156] (530s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[525.321070] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[525.326784] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[525.509857] [106/156] (528s left) sw_sync (sync_random_merge)
[525.557417] Starting subtest: sync_random_merge
[525.652811] Subtest sync_random_merge: SUCCESS (0.097s)
[525.759334] [107/156] (528s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[527.253290] Starting subtest: flip-vs-cursor-busy-crc-legacy
[527.828349] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.576s)
[528.045990] [108/156] (526s left) gem_mmap_gtt (basic-small-bo-tiledx)
[528.095056] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[528.181272] [109/156] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[529.684101] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[529.687545] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[529.884764] [110/156] (524s left) gem_softpin (32b-excludes-last-page)
[529.940034] Starting subtest: 32b-excludes-last-page
[529.945229] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[530.156711] [111/156] (524s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[531.657342] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[531.660713] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[531.866948] [112/156] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[533.367508] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[533.370722] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[533.557112] [113/156] (521s left) gem_lmem_swapping (smem-oom)
[537.975883] Starting subtest: smem-oom
[537.977908] Starting dynamic subtest: lmem0
[574.180803] Dynamic subtest lmem0: SUCCESS (36.201s)
[574.182553] Subtest smem-oom: SUCCESS (36.205s)
[575.295676] [FACT gem_lmem_swapping (smem-oom)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[575.301002] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[575.305894] [114/156] (479s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[580.269921] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[580.282802] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.001s)
[580.483268] [FACT kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[580.486583] [FACT kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)] new: kernel.kmod_is_loaded.i915: true
[580.493664] [115/156] (474s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[581.992176] Starting subtest: plane-all-transition-nonblocking-fencing
[581.993641] Starting dynamic subtest: pipe-A-HDMI-A-4
[586.012971] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.018s)
[586.102247] Starting dynamic subtest: pipe-B-HDMI-A-4
[590.056719] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (3.970s)
[590.113058] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.121s)
[590.317399] [116/156] (464s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[590.375822] Starting subtest: invalid-smem-bo-on-discrete
[590.377348] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s)
[592.040414] [117/156] (463s left) i915_drm_fdinfo (memory-info-shared)
[592.116918] Starting subtest: memory-info-shared
[592.118285] Starting dynamic subtest: lmem0
[592.191425] Dynamic subtest lmem0: SUCCESS (0.074s)
[592.210145] Starting dynamic subtest: smem0
[592.244530] Dynamic subtest smem0: SUCCESS (0.051s)
[592.245980] Subtest memory-info-shared: SUCCESS (0.129s)
[592.388019] [118/156] (463s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[592.448281] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[592.677435] [119/156] (462s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[594.179897] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[594.193233] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[594.375013] [120/156] (461s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[595.874832] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[595.877770] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[596.049671] [121/156] (459s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[597.561343] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[597.565295] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[597.760164] [122/156] (458s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt)
[599.263433] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt
[599.267221] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[599.429233] [123/156] (456s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[600.925985] Starting subtest: cursor-vs-flip-varying-size
[636.191972] Subtest cursor-vs-flip-varying-size: SUCCESS (35.266s)
[636.400420] [124/156] (419s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[637.910157] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[638.497806] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.587s)
[638.736073] [125/156] (417s left) kms_pm_backlight (fade)
[640.229823] Subtest fade: SKIP (0.000s)
[640.317023] [126/156] (416s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[641.813908] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[641.816644] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[642.009498] [127/156] (414s left) gem_pxp (reject-modify-context-protection-on)
[644.587803] Starting subtest: reject-modify-context-protection-on
[644.591150] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[644.715806] [128/156] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[646.224375] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[646.228034] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[646.431555] [129/156] (410s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[647.930862] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[647.933829] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[648.129229] [130/156] (408s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[649.627934] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[649.631499] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[649.741610] [131/156] (407s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[651.244022] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[651.332554] [132/156] (405s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt)
[652.830260] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt
[652.833424] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[653.027951] [133/156] (404s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[654.529264] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[654.532707] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[654.727825] [134/156] (402s left) gem_lmem_swapping (heavy-verify-random)
[658.977018] Starting subtest: heavy-verify-random
[658.979777] Starting dynamic subtest: lmem0
[676.566808] Dynamic subtest lmem0: SUCCESS (17.588s)
[676.568464] Subtest heavy-verify-random: SUCCESS (17.589s)
[677.909302] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[677.910476] [FACT gem_lmem_swapping (heavy-verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[677.916549] [135/156] (379s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[682.641126] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[682.644454] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[682.860799] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[682.864208] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[682.871557] [136/156] (374s left) sysfs_timeslice_duration (timeout)
[682.933482] Starting subtest: timeout
[682.935190] Starting dynamic subtest: vecs0
[684.208708] Dynamic subtest vecs0: SUCCESS (1.274s)
[684.226956] Starting dynamic subtest: vcs0
[685.463327] Dynamic subtest vcs0: SUCCESS (1.252s)
[685.479498] Starting dynamic subtest: bcs0
[686.128979] Dynamic subtest bcs0: SUCCESS (0.664s)
[686.145650] Starting dynamic subtest: rcs0
[686.801936] Dynamic subtest rcs0: SUCCESS (0.670s)
[686.819046] Starting dynamic subtest: vcs1
[688.100872] Dynamic subtest vcs1: SUCCESS (1.298s)
[688.102185] Subtest timeout: SUCCESS (5.168s)
[688.251927] [137/156] (369s left) i915_pm_freq_api (freq-reset)
[688.308193] Starting subtest: freq-reset
[688.309536] Starting dynamic subtest: gt0
[688.520835] Dynamic subtest gt0: SUCCESS (0.211s)
[688.522259] Subtest freq-reset: SUCCESS (0.212s)
[688.638529] [138/156] (369s left) kms_atomic_interruptible (legacy-cursor)
[690.133014] Starting subtest: legacy-cursor
[690.134599] Starting dynamic subtest: pipe-A-HDMI-A-4
[696.340697] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.205s)
[696.342458] Subtest legacy-cursor: SUCCESS (6.208s)
[696.530290] [139/156] (361s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[698.030463] Starting subtest: fbcpsrhdr-stridechange
[698.033659] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[698.214737] [140/156] (359s left) kms_cursor_crc (cursor-sliding-max-size)
[700.058945] Starting subtest: cursor-sliding-max-size
[700.063529] Subtest cursor-sliding-max-size: SKIP (0.000s)
[700.319189] [141/156] (357s left) kms_flip (dpms-off-confusion)
[701.818422] Starting subtest: dpms-off-confusion
[701.825232] Starting dynamic subtest: A-HDMI-A4
[709.666115] Dynamic subtest A-HDMI-A4: SUCCESS (7.841s)
[709.694079] Starting dynamic subtest: B-HDMI-A4
[717.367575] Dynamic subtest B-HDMI-A4: SUCCESS (7.697s)
[717.389120] Starting dynamic subtest: C-HDMI-A4
[725.064637] Dynamic subtest C-HDMI-A4: SUCCESS (7.689s)
[725.119419] Starting dynamic subtest: D-HDMI-A4
[732.792256] Dynamic subtest D-HDMI-A4: SUCCESS (7.722s)
[732.793722] Subtest dpms-off-confusion: SUCCESS (30.977s)
[733.025294] [142/156] (325s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[734.525110] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[734.527935] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[734.697388] [143/156] (323s left) kms_lease (page-flip-implicit-plane)
[736.189418] Starting subtest: page-flip-implicit-plane
[736.190809] Starting dynamic subtest: pipe-A-HDMI-A-4
[736.573036] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.384s)
[736.593734] Starting dynamic subtest: pipe-B-HDMI-A-4
[736.834220] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.257s)
[736.853471] Starting dynamic subtest: pipe-C-HDMI-A-4
[737.092899] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.257s)
[737.115903] Starting dynamic subtest: pipe-D-HDMI-A-4
[737.345040] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.248s)
[737.347104] Subtest page-flip-implicit-plane: SUCCESS (1.158s)
[737.560787] [144/156] (320s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[739.052665] Starting subtest: cursorA-vs-flipA-atomic
[749.968225] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.914s)
[750.316403] [145/156] (308s left) syncobj_wait (wait-any-interrupted)
[750.377346] Starting subtest: wait-any-interrupted
[750.481085] Subtest wait-any-interrupted: SUCCESS (0.102s)
[750.600952] [146/156] (307s left) gen9_exec_parse (secure-batches)
[750.656480] Subtest secure-batches: SKIP (0.000s)
[750.737549] [147/156] (307s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[752.229541] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[752.231496] Starting dynamic subtest: pipe-A-HDMI-A-4
[752.258968] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[752.277002] Starting dynamic subtest: pipe-B-HDMI-A-4
[752.291408] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[752.311465] Starting dynamic subtest: pipe-C-HDMI-A-4
[752.327314] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[752.344977] Starting dynamic subtest: pipe-D-HDMI-A-4
[752.360481] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[752.363523] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[752.507957] [148/156] (306s left) kms_feature_discovery (chamelium)
[754.001775] Starting subtest: chamelium
[754.004798] Subtest chamelium: SKIP (0.000s)
[754.125941] [149/156] (304s left) kms_psr (psr-dpms)
[755.621482] Subtest psr-dpms: SKIP (0.000s)
[755.716228] [150/156] (303s left) api_intel_bb (destroy-bb)
[755.765632] Starting subtest: destroy-bb
[755.794963] Subtest destroy-bb: SUCCESS (0.028s)
[756.009773] [151/156] (302s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[756.060596] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[756.062396] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[756.188199] [152/156] (302s left) gem_userptr_blits (access-control)
[756.260679] Starting subtest: access-control
[756.264267] Subtest access-control: SKIP (0.000s)
[756.439314] [153/156] (302s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[757.933176] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[757.936443] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[758.075138] [154/156] (301s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[759.585458] Starting subtest: 4-tiled-32bpp-rotate-270
[759.588651] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[759.751885] [155/156] (299s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[761.244269] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[761.245858] Starting dynamic subtest: pipe-A
[762.046588] Dynamic subtest pipe-A: SUCCESS (0.801s)
[762.066086] Starting dynamic subtest: pipe-B
[762.821359] Dynamic subtest pipe-B: SUCCESS (0.773s)
[762.849630] Starting dynamic subtest: pipe-C
[763.611139] Dynamic subtest pipe-C: SUCCESS (0.788s)
[763.630152] Starting dynamic subtest: pipe-D
[764.384527] Dynamic subtest pipe-D: SUCCESS (0.772s)
[764.386421] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.141s)
[764.629097] [156/156] (294s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[766.132247] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[766.135421] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[766.299075] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: gem_busy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_reloc
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_ctx_bad_destroy
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_plane_alpha_blend
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: gem_exec_parallel
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_color_pipeline
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_setmode
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: gem_ctx_shared
results: parsing output: 53/ for test: i915_pm_rps
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: syncobj_eventfd
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_madvise
results: parsing output: 71/ for test: gem_spin_batch
results: parsing output: 72/ for test: syncobj_basic
results: parsing output: 73/ for test: kms_pm_dc
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_workarounds
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: dumb_buffer
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_ctx_engines
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_debugfs
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: kms_rmfb
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_content_protection
results: parsing output: 97/ for test: perf_pmu
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: kms_async_flips
results: parsing output: 100/ for test: gem_eio
results: parsing output: 101/ for test: gem_exec_whisper
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_atomic_transition
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_pm_backlight
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_lmem_swapping
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: sysfs_timeslice_duration
results: parsing output: 136/ for test: i915_pm_freq_api
results: parsing output: 137/ for test: kms_atomic_interruptible
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_cursor_crc
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_lease
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: syncobj_wait
results: parsing output: 145/ for test: gen9_exec_parse
results: parsing output: 146/ for test: kms_ccs
results: parsing output: 147/ for test: kms_feature_discovery
results: parsing output: 148/ for test: kms_psr
results: parsing output: 149/ for test: api_intel_bb
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: gem_userptr_blits
results: parsing output: 152/ for test: kms_plane
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: kms_plane_scaling
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.