[47.762266] Initializing watchdogs
[47.762326]   /dev/watchdog0
[47.778400] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.784667] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.787244] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.789066] [001/155] (960s left) kms_pipe_crc_basic (read-crc)
[47.887594] Starting subtest: read-crc
[47.889139] Starting dynamic subtest: pipe-A-HDMI-A-1
[48.231827] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.344s)
[48.238913] Starting dynamic subtest: pipe-B-HDMI-A-1
[48.531892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.299s)
[48.540224] Starting dynamic subtest: pipe-C-HDMI-A-1
[48.827457] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.294s)
[48.834632] Starting dynamic subtest: pipe-D-HDMI-A-1
[49.129207] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.301s)
[49.130011] Subtest read-crc: SUCCESS (1.243s)
[49.239457] [002/155] (959s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[49.345105] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[49.346463] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[49.438774] [003/155] (958s left) gem_exec_reloc (basic-gtt)
[49.480376] Starting subtest: basic-gtt
[49.488664] Subtest basic-gtt: SUCCESS (0.008s)
[49.604030] [004/155] (958s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[49.698467] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[49.699872] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[49.789354] [005/155] (958s left) gem_render_copy (linear-to-vebox-y-tiled)
[49.828383] Starting subtest: linear-to-vebox-y-tiled
[49.829102] Starting dynamic subtest: smem
[49.926714] Dynamic subtest smem: SUCCESS (0.098s)
[49.927489] Subtest linear-to-vebox-y-tiled: SUCCESS (0.098s)
[50.108583] [006/155] (958s left) gem_ctx_isolation (nonpriv)
[50.150387] Starting subtest: nonpriv
[50.151157] Starting dynamic subtest: rcs0
[50.401102] Dynamic subtest rcs0: SUCCESS (0.242s)
[50.406890] Starting dynamic subtest: bcs0
[50.678501] Dynamic subtest bcs0: SUCCESS (0.278s)
[50.684340] Starting dynamic subtest: vcs0
[50.946151] Dynamic subtest vcs0: SUCCESS (0.275s)
[50.952265] Starting dynamic subtest: vcs1
[51.231166] Dynamic subtest vcs1: SUCCESS (0.277s)
[51.236916] Starting dynamic subtest: vecs0
[51.511905] Dynamic subtest vecs0: SUCCESS (0.281s)
[51.512730] Subtest nonpriv: SUCCESS (1.354s)
[51.681411] [007/155] (956s left) gem_exec_fence (syncobj-channel)
[52.031223] Starting subtest: syncobj-channel
[53.062651] Subtest syncobj-channel: SUCCESS (1.023s)
[53.356639] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[53.359729] [008/155] (955s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[53.454170] Starting subtest: fbc-shrfb-scaledprimary
[54.093562] Subtest fbc-shrfb-scaledprimary: SUCCESS (0.640s)
[54.214129] [009/155] (954s left) gem_ccs (block-copy-uncompressed)
[54.253316] Starting subtest: block-copy-uncompressed
[54.254891] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[54.274127] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[54.280941] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[54.291189] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[54.291949] Subtest block-copy-uncompressed: SUCCESS (0.038s)
[54.406539] [010/155] (954s left) gem_ctx_persistence (legacy-engines-hang)
[54.444479] Starting subtest: legacy-engines-hang
[54.445528] Starting dynamic subtest: render
[54.493171] Dynamic subtest render: SUCCESS (0.049s)
[54.504938] Starting dynamic subtest: bsd1
[54.534625] Dynamic subtest bsd1: SUCCESS (0.040s)
[54.549990] Starting dynamic subtest: bsd2
[54.582584] Dynamic subtest bsd2: SUCCESS (0.047s)
[54.598745] Starting dynamic subtest: blt
[54.633685] Dynamic subtest blt: SUCCESS (0.050s)
[54.647304] Starting dynamic subtest: vebox
[54.675636] Dynamic subtest vebox: SUCCESS (0.041s)
[54.676743] Subtest legacy-engines-hang: SUCCESS (0.232s)
[54.744749] [011/155] (953s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[54.839168] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[54.840554] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[54.938567] [012/155] (953s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[55.029396] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[55.030758] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[55.215384] [013/155] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[55.317512] Starting subtest: psr-1p-primscrn-cur-indfb-move
[55.318989] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[55.414963] [014/155] (953s left) kms_addfb_basic (unused-pitches)
[55.449336] Starting subtest: unused-pitches
[55.450035] Subtest unused-pitches: SUCCESS (0.000s)
[55.607115] [015/155] (953s left) gem_flink_basic (double-flink)
[55.640839] Starting subtest: double-flink
[55.641542] Subtest double-flink: SUCCESS (0.000s)
[55.740522] [016/155] (953s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[55.837869] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[55.839265] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[55.939142] [017/155] (952s left) kms_getfb (getfb-handle-protection)
[56.028683] Starting subtest: getfb-handle-protection
[56.045159] Subtest getfb-handle-protection: SUCCESS (0.017s)
[56.148790] [018/155] (952s left) i915_suspend (debugfs-reader)
[56.182529] Starting subtest: debugfs-reader
[74.502435] Subtest debugfs-reader: SUCCESS (3.290s)
[82.631225] [019/155] (934s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[82.755099] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[82.756852] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[82.900319] [020/155] (934s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[83.015213] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[83.016609] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[83.169978] [021/155] (934s left) gem_exec_schedule (fairslice)
[83.219398] Starting subtest: fairslice
[83.220467] Starting dynamic subtest: rcs0
[85.241922] Dynamic subtest rcs0: SUCCESS (2.014s)
[85.251686] Starting dynamic subtest: bcs0
[87.253502] Dynamic subtest bcs0: SUCCESS (2.012s)
[87.262875] Starting dynamic subtest: vcs0
[89.264305] Dynamic subtest vcs0: SUCCESS (2.011s)
[89.273998] Starting dynamic subtest: vcs1
[91.275627] Dynamic subtest vcs1: SUCCESS (2.011s)
[91.284843] Starting dynamic subtest: vecs0
[93.286388] Dynamic subtest vecs0: SUCCESS (2.011s)
[93.287324] Subtest fairslice: SUCCESS (10.061s)
[93.565843] [022/155] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[93.664668] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[93.666038] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[93.761767] [023/155] (923s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[93.861881] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[94.222747] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.361s)
[94.362254] [024/155] (922s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[94.396975] Starting subtest: etime-multi-wait-all-submitted-signaled
[94.503787] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[94.586996] [025/155] (922s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[94.679846] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[94.681221] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[94.774764] [026/155] (922s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[94.867743] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[94.869197] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[94.969411] [027/155] (922s left) kms_addfb_basic (addfb25-4-tiled)
[95.058780] Starting subtest: addfb25-4-tiled
[95.059482] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[95.170438] [028/155] (922s left) kms_pipe_crc_basic (hang-read-crc)
[95.259968] Starting subtest: hang-read-crc
[95.260694] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.891136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.631s)
[95.899620] Starting dynamic subtest: pipe-B-HDMI-A-1
[96.481970] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.589s)
[96.492281] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.094105] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.612s)
[97.102211] Starting dynamic subtest: pipe-D-HDMI-A-1
[97.681414] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.585s)
[97.682194] Subtest hang-read-crc: SUCCESS (2.422s)
[97.811733] [029/155] (919s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[97.909598] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[97.910951] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.000399] [030/155] (919s left) gem_create (hog-create)
[98.039523] Starting subtest: hog-create
[98.040292] Starting dynamic subtest: smem0
[130.311185] Dynamic subtest smem0: SUCCESS (32.254s)
[130.312294] Subtest hog-create: SUCCESS (32.254s)
[130.498883] [031/155] (887s left) kms_rotation_crc (sprite-rotation-270)
[130.588974] Starting subtest: sprite-rotation-270
[135.034880] Subtest sprite-rotation-270: SUCCESS (4.443s)
[135.255600] [032/155] (882s left) gem_request_retire (retire-vma-not-inactive)
[135.293671] Starting subtest: retire-vma-not-inactive
[135.304167] Subtest retire-vma-not-inactive: SUCCESS (0.010s)
[135.422625] [033/155] (882s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[135.513100] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[135.513828] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.661206] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.144s)
[135.671289] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.786459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.123s)
[135.796517] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.908742] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.121s)
[135.916143] Starting dynamic subtest: pipe-D-HDMI-A-1
[136.012948] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.104s)
[136.013647] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.498s)
[136.313906] [034/155] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[136.409359] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[136.410796] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[136.493198] [035/155] (881s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[136.584789] Starting subtest: fbc-rgb565-draw-mmap-gtt
[137.819972] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.234s)
[137.942018] [036/155] (879s left) api_intel_allocator (standalone)
[137.975075] Starting subtest: standalone
[137.992723] Subtest standalone: SUCCESS (0.018s)
[138.080913] [037/155] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[138.176960] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[138.178355] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[138.273381] [038/155] (879s left) syncobj_wait (wait-any-complex)
[138.307762] Starting subtest: wait-any-complex
[138.371107] Subtest wait-any-complex: SUCCESS (0.063s)
[138.443122] [039/155] (879s left) kms_chamelium_edid (hdmi-mode-timings)
[138.588537] Subtest hdmi-mode-timings: SKIP (0.000s)
[138.688760] [040/155] (879s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[138.783687] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[138.824158] [041/155] (879s left) kms_selftest (drm_format_helper)
[138.859456] Starting subtest: drm_format_helper
[138.871655] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[138.937880] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.066s)
[138.952137] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[139.005980] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.065s)
[139.017747] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[139.078325] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.071s)
[139.093422] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[139.150824] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.070s)
[139.164602] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[139.225402] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.074s)
[139.239921] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[139.289237] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.062s)
[139.303217] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[139.366624] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.077s)
[139.384040] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[139.451693] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.080s)
[139.466276] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[139.526801] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.074s)
[139.542166] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[139.597262] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.070s)
[139.615146] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[139.670630] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.071s)
[139.686955] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[139.744945] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.072s)
[139.759292] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[139.825991] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.079s)
[139.842046] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[139.901795] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.074s)
[139.918565] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[139.976080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.073s)
[139.993099] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[140.049559] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.070s)
[140.063638] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[140.126939] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.075s)
[140.127951] Subtest drm_format_helper: SUCCESS (1.266s)
[140.267140] [042/155] (877s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[140.357540] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[140.358294] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.365322] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[140.374717] Starting dynamic subtest: pipe-B-HDMI-A-1
[140.381760] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[140.390993] Starting dynamic subtest: pipe-C-HDMI-A-1
[140.397951] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[140.406863] Starting dynamic subtest: pipe-D-HDMI-A-1
[140.414190] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[140.415616] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[140.617974] [043/155] (877s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[140.707311] Starting subtest: random-ccs-data-y-tiled-ccs
[140.708966] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.717304] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[140.724924] Starting dynamic subtest: pipe-B-HDMI-A-1
[140.732356] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[140.739780] Starting dynamic subtest: pipe-C-HDMI-A-1
[140.747154] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[140.754336] Starting dynamic subtest: pipe-D-HDMI-A-1
[140.761884] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[140.763310] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[140.964881] [044/155] (877s left) gem_lmem_swapping (massive)
[141.003192] Subtest massive: SKIP (0.000s)
[141.048208] [045/155] (877s left) core_getclient (basic)
[141.082099] Starting subtest: basic
[141.082852] Subtest basic: SUCCESS (0.000s)
[141.153422] [046/155] (877s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[141.189065] Starting subtest: single-wait-for-submit-available-signaled
[141.189774] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[141.246211] [047/155] (877s left) gem_exec_create (legacy)
[141.288984] Starting subtest: legacy
[141.289705] Starting dynamic subtest: smem
[143.349623] Dynamic subtest smem: SUCCESS (2.060s)
[143.350408] Subtest legacy: SUCCESS (2.060s)
[143.532704] [048/155] (874s left) kms_plane_scaling (planes-upscale-20x20)
[143.624503] Starting subtest: planes-upscale-20x20
[143.625480] Starting dynamic subtest: pipe-A
[143.693394] Dynamic subtest pipe-A: SUCCESS (0.070s)
[143.701729] Starting dynamic subtest: pipe-B
[143.837581] Dynamic subtest pipe-B: SUCCESS (0.144s)
[143.845348] Starting dynamic subtest: pipe-C
[143.971227] Dynamic subtest pipe-C: SUCCESS (0.133s)
[143.981268] Starting dynamic subtest: pipe-D
[144.131874] Dynamic subtest pipe-D: SUCCESS (0.159s)
[144.132653] Subtest planes-upscale-20x20: SUCCESS (0.508s)
[144.322600] [049/155] (874s left) gem_softpin (evict-prime)
[144.360946] Starting subtest: evict-prime
[144.361703] Starting dynamic subtest: rcs0
[145.482379] Dynamic subtest rcs0: SUCCESS (1.120s)
[145.503410] Starting dynamic subtest: bcs0
[146.608282] Dynamic subtest bcs0: SUCCESS (1.124s)
[146.626962] Starting dynamic subtest: vcs0
[147.726131] Dynamic subtest vcs0: SUCCESS (1.116s)
[147.741561] Starting dynamic subtest: vcs1
[148.845044] Dynamic subtest vcs1: SUCCESS (1.117s)
[148.866024] Starting dynamic subtest: vecs0
[149.963003] Dynamic subtest vecs0: SUCCESS (1.116s)
[149.984392] Starting dynamic subtest: all
[151.081249] Dynamic subtest all: SUCCESS (1.116s)
[151.082348] Subtest evict-prime: SUCCESS (6.719s)
[151.171636] [050/155] (867s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[151.266888] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[152.344148] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.078s)
[152.466635] [051/155] (865s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[152.562203] Starting subtest: 2x-flip-vs-cursor-atomic
[152.566060] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[152.629308] [052/155] (865s left) kms_psr (pr-suspend)
[152.726527] Subtest pr-suspend: SKIP (0.000s)
[152.767740] [053/155] (865s left) gem_exec_reloc (basic-gtt-read-active)
[152.807188] Starting subtest: basic-gtt-read-active
[152.934254] Subtest basic-gtt-read-active: SUCCESS (0.118s)
[153.061355] [054/155] (865s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[153.152509] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[153.153857] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[153.238133] [055/155] (865s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[153.330549] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[153.331976] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[153.405453] [056/155] (865s left) i915_pm_rc6_residency (rc6-fence)
[153.439573] Starting subtest: rc6-fence
[153.444395] Starting dynamic subtest: gt0
[171.741944] Dynamic subtest gt0: SUCCESS (18.271s)
[171.743114] Subtest rc6-fence: SUCCESS (18.276s)
[171.786052] [057/155] (846s left) kms_psr (fbc-psr-no-drrs)
[171.876279] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[171.923699] [058/155] (846s left) gem_exec_reloc (basic-cpu-read)
[171.963212] Starting subtest: basic-cpu-read
[171.968017] Subtest basic-cpu-read: SUCCESS (0.006s)
[172.088819] [059/155] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[172.180811] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[172.182214] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[172.281217] [060/155] (846s left) perf (invalid-remove-userspace-config)
[172.380331] Starting subtest: invalid-remove-userspace-config
[172.390779] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[172.435965] [061/155] (846s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[172.470532] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[172.471255] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[172.529622] [062/155] (846s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[172.630710] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[172.632211] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[172.714592] [063/155] (846s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[172.808023] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[172.809502] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[172.914480] [064/155] (846s left) gem_userptr_blits (mmap-offset-banned)
[172.960279] Starting subtest: mmap-offset-banned
[172.961037] Starting dynamic subtest: gtt
[172.961809] Dynamic subtest gtt: SUCCESS (0.000s)
[172.970123] Starting dynamic subtest: wb
[172.970826] Dynamic subtest wb: SUCCESS (0.000s)
[172.978781] Starting dynamic subtest: wc
[172.979466] Dynamic subtest wc: SUCCESS (0.000s)
[172.987044] Starting dynamic subtest: uc
[172.987720] Dynamic subtest uc: SUCCESS (0.000s)
[172.988387] Subtest mmap-offset-banned: SUCCESS (0.003s)
[173.070304] [065/155] (845s left) kms_atomic (atomic-plane-damage)
[173.157379] Starting subtest: atomic-plane-damage
[173.210434] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.407936] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.198s)
[173.408686] Subtest atomic-plane-damage: SUCCESS (0.251s)
[173.551425] [066/155] (845s left) gem_exec_schedule (preempt-queue-contexts-chain)
[173.601853] Starting subtest: preempt-queue-contexts-chain
[173.602614] Starting dynamic subtest: rcs0
[174.000861] Dynamic subtest rcs0: SUCCESS (0.390s)
[174.015464] Starting dynamic subtest: bcs0
[174.382776] Dynamic subtest bcs0: SUCCESS (0.381s)
[174.391711] Starting dynamic subtest: vcs0
[174.756593] Dynamic subtest vcs0: SUCCESS (0.373s)
[174.765555] Starting dynamic subtest: vcs1
[175.114678] Dynamic subtest vcs1: SUCCESS (0.357s)
[175.123845] Starting dynamic subtest: vecs0
[175.472862] Dynamic subtest vecs0: SUCCESS (0.357s)
[175.473622] Subtest preempt-queue-contexts-chain: SUCCESS (1.862s)
[175.762474] [067/155] (843s left) gem_fenced_exec_thrash (2-spare-fences)
[175.801428] Starting subtest: 2-spare-fences
[177.955809] Subtest 2-spare-fences: SUCCESS (2.154s)
[178.059436] [068/155] (841s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[178.150591] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[178.195101] [069/155] (840s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[178.287948] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[178.289478] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[178.391576] [070/155] (840s left) sysfs_preempt_timeout (timeout)
[178.431401] Starting subtest: timeout
[178.432132] Starting dynamic subtest: vecs0
[179.301927] Dynamic subtest vecs0: SUCCESS (0.870s)
[179.313205] Starting dynamic subtest: vcs0
[180.184968] Dynamic subtest vcs0: SUCCESS (0.881s)
[180.195959] Starting dynamic subtest: bcs0
[181.059953] Dynamic subtest bcs0: SUCCESS (0.873s)
[181.071105] Starting dynamic subtest: rcs0
[181.959957] Dynamic subtest rcs0: SUCCESS (0.898s)
[181.971229] Starting dynamic subtest: vcs1
[182.847985] Dynamic subtest vcs1: SUCCESS (0.886s)
[182.849082] Subtest timeout: SUCCESS (4.418s)
[182.914301] [071/155] (836s left) gem_exec_params (rel-constants-invalid)
[182.952238] Starting subtest: rel-constants-invalid
[182.952931] Subtest rel-constants-invalid: SUCCESS (0.000s)
[183.052119] [072/155] (836s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[183.147923] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[183.149316] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[183.253501] [073/155] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[183.346111] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[183.347582] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[183.453160] [074/155] (835s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[183.546078] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[183.547463] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[183.641958] [075/155] (835s left) kms_frontbuffer_tracking (psrhdr-farfromfence-mmap-gtt)
[183.735855] Starting subtest: psrhdr-farfromfence-mmap-gtt
[183.737367] Subtest psrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[183.834097] [076/155] (835s left) kms_cursor_legacy (forked-bo)
[183.923426] Starting subtest: forked-bo
[183.924154] Starting dynamic subtest: pipe-A
[189.374601] Dynamic subtest pipe-A: SUCCESS (5.417s)
[189.386560] Starting dynamic subtest: pipe-B
[194.811752] Dynamic subtest pipe-B: SUCCESS (5.437s)
[194.821114] Starting dynamic subtest: pipe-C
[200.260947] Dynamic subtest pipe-C: SUCCESS (5.448s)
[200.271663] Starting dynamic subtest: pipe-D
[205.695606] Dynamic subtest pipe-D: SUCCESS (5.433s)
[205.705507] Starting dynamic subtest: all-pipes
[211.131116] Dynamic subtest all-pipes: SUCCESS (5.434s)
[211.132122] Subtest forked-bo: SUCCESS (27.177s)
[211.174505] [077/155] (808s left) gem_userptr_blits (readonly-unsync)
[211.215221] Subtest readonly-unsync: SKIP (0.000s)
[211.327544] [078/155] (808s left) drm_read (short-buffer-wakeup)
[211.439341] Starting subtest: short-buffer-wakeup
[243.663963] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[243.782714] [079/155] (775s left) gem_eio (wait-immediate)
[243.826630] Starting subtest: wait-immediate
[243.970632] Subtest wait-immediate: SUCCESS (0.143s)
[244.096262] [080/155] (775s left) gem_exec_whisper (basic-contexts-forked)
[244.141849] Starting subtest: basic-contexts-forked
[246.758219] Subtest basic-contexts-forked: SUCCESS (2.607s)
[246.934471] [081/155] (772s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[247.044191] Starting subtest: psr-rgb101010-draw-mmap-wc
[247.045540] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[247.134383] [082/155] (772s left) kms_rotation_crc (sprite-rotation-180)
[247.224862] Starting subtest: sprite-rotation-180
[250.708724] Subtest sprite-rotation-180: SUCCESS (3.484s)
[250.912343] [083/155] (768s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[251.005526] Starting subtest: fb-8bpc-vs-panel-8bpc
[251.007381] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.261541] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.254s)
[251.262341] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.256s)
[251.402776] [084/155] (768s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[251.516198] Starting subtest: primary-x-tiled-reflect-x-180
[255.059213] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.543s)
[255.247902] [085/155] (764s left) kms_big_fb (linear-16bpp-rotate-0)
[255.349269] Starting subtest: linear-16bpp-rotate-0
[256.742048] Subtest linear-16bpp-rotate-0: SUCCESS (1.392s)
[256.884205] [086/155] (763s left) kms_dsc (dsc-with-formats)
[256.977360] Starting subtest: dsc-with-formats
[256.989204] Subtest dsc-with-formats: SKIP (0.001s)
[257.048505] [087/155] (762s left) gem_mmap_wc (write-cpu-read-wc)
[257.082643] Starting subtest: write-cpu-read-wc
[257.159852] Subtest write-cpu-read-wc: SUCCESS (0.078s)
[257.264825] [088/155] (762s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[257.298360] Starting subtest: cpuset-basic-small-copy-XY
[262.848524] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.550s)
[262.940253] [089/155] (757s left) gem_exec_schedule (smoketest)
[263.161374] Starting subtest: smoketest
[263.162350] Starting dynamic subtest: rcs0
[268.624587] Dynamic subtest rcs0: SUCCESS (5.422s)
[268.636331] Starting dynamic subtest: bcs0
[274.046321] Dynamic subtest bcs0: SUCCESS (5.420s)
[274.056761] Starting dynamic subtest: vcs0
[279.463070] Dynamic subtest vcs0: SUCCESS (5.416s)
[279.474296] Starting dynamic subtest: vcs1
[284.861995] Dynamic subtest vcs1: SUCCESS (5.423s)
[284.871822] Starting dynamic subtest: vecs0
[290.313810] Dynamic subtest vecs0: SUCCESS (5.424s)
[290.314643] Subtest smoketest: SUCCESS (27.111s)
[290.465079] [090/155] (729s left) gen9_exec_parse (bb-chained)
[290.504880] Subtest bb-chained: SKIP (0.000s)
[290.547379] [091/155] (729s left) kms_color (ctm-green-to-red)
[290.643484] Starting subtest: ctm-green-to-red
[290.644225] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.950213] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.306s)
[290.962219] Starting dynamic subtest: pipe-B-HDMI-A-1
[291.244664] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.294s)
[291.255143] Starting dynamic subtest: pipe-C-HDMI-A-1
[291.536581] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s)
[291.548439] Starting dynamic subtest: pipe-D-HDMI-A-1
[291.829317] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.291s)
[291.830044] Subtest ctm-green-to-red: SUCCESS (1.186s)
[291.989410] [092/155] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[292.089955] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[292.091326] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[292.188864] [093/155] (728s left) gem_pxp (create-regular-buffer)
[292.292403] Starting subtest: create-regular-buffer
[292.293372] Subtest create-regular-buffer: SUCCESS (0.000s)
[292.407149] [094/155] (727s left) prime_mmap (test_invalid_sync_flags)
[292.442829] Starting subtest: test_invalid_sync_flags
[292.443572] Starting dynamic subtest: test_invalid_sync_flags-smem
[292.444305] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[292.445005] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[292.528549] [095/155] (727s left) kms_plane_multiple (tiling-x)
[292.617539] Starting subtest: tiling-x
[292.618275] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.284200] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.666s)
[293.296369] Starting dynamic subtest: pipe-B-HDMI-A-1
[293.906874] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.621s)
[293.918413] Starting dynamic subtest: pipe-C-HDMI-A-1
[294.528379] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.617s)
[294.541313] Starting dynamic subtest: pipe-D-HDMI-A-1
[295.163441] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.633s)
[295.164234] Subtest tiling-x: SUCCESS (2.546s)
[295.341267] [096/155] (724s left) vgem_basic (mmap)
[295.390498] Starting subtest: mmap
[295.401704] Subtest mmap: SUCCESS (0.011s)
[295.451383] [097/155] (724s left) kms_pm_dc (dc5-psr)
[296.550449] Starting subtest: dc5-psr
[296.551827] Subtest dc5-psr: SKIP (0.000s)
[296.621008] [098/155] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[296.715840] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[296.717196] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[296.814961] [099/155] (723s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[296.854041] Starting subtest: writes-after-reads
[297.897018] Subtest writes-after-reads: SUCCESS (1.043s)
[297.995979] [100/155] (722s left) kms_flip (2x-flip-vs-suspend-interruptible)
[298.092845] Starting subtest: 2x-flip-vs-suspend-interruptible
[298.095440] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[298.163093] [101/155] (722s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[298.257314] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[298.258759] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.349629] [102/155] (722s left) kms_chamelium_hpd (dp-hpd-fast)
[298.493467] Subtest dp-hpd-fast: SKIP (0.000s)
[298.594624] [103/155] (722s left) gem_gtt_cpu_tlb
[298.740426] [104/155] (721s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[298.835682] Starting subtest: hdr-rgb565-draw-pwrite
[298.837047] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[298.930100] [105/155] (721s left) gem_eio (in-flight-contexts-immediate)
[298.974318] Starting subtest: in-flight-contexts-immediate
[312.931400] Subtest in-flight-contexts-immediate: SUCCESS (13.955s)
[313.057217] [106/155] (707s left) kms_cursor_crc (cursor-dpms)
[313.149611] Starting subtest: cursor-dpms
[313.151391] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.814528] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.663s)
[313.825281] Starting dynamic subtest: pipe-D-HDMI-A-1
[314.423210] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.607s)
[314.423922] Subtest cursor-dpms: SUCCESS (1.274s)
[314.600858] [107/155] (706s left) perf_pmu (busy-hang)
[314.641393] Starting subtest: busy-hang
[314.642205] Starting dynamic subtest: rcs0
[315.683150] Dynamic subtest rcs0: SUCCESS (1.037s)
[315.694150] Starting dynamic subtest: bcs0
[316.715161] Dynamic subtest bcs0: SUCCESS (1.030s)
[316.726467] Starting dynamic subtest: vcs0
[317.763253] Dynamic subtest vcs0: SUCCESS (1.050s)
[317.777498] Starting dynamic subtest: vcs1
[318.808402] Dynamic subtest vcs1: SUCCESS (1.042s)
[318.819248] Starting dynamic subtest: vecs0
[319.854247] Dynamic subtest vecs0: SUCCESS (1.043s)
[319.855362] Subtest busy-hang: SUCCESS (5.212s)
[319.920701] [108/155] (700s left) gem_softpin (evict-snoop-interruptible)
[319.963234] Starting subtest: evict-snoop-interruptible
[319.964685] Subtest evict-snoop-interruptible: SKIP (0.000s)
[320.028273] [109/155] (700s left) gem_mmap_gtt (hang-busy)
[320.062079] Starting subtest: hang-busy
[356.148584] Subtest hang-busy: SUCCESS (36.082s)
[356.253990] [110/155] (664s left) gem_exec_balancer (full-late-pulse)
[356.301060] Starting subtest: full-late-pulse
[357.893700] Subtest full-late-pulse: SUCCESS (1.593s)
[358.086032] [111/155] (662s left) perf_pmu (init-busy)
[358.123655] Starting subtest: init-busy
[358.124377] Starting dynamic subtest: rcs0
[358.125073] Dynamic subtest rcs0: SUCCESS (0.001s)
[358.134861] Starting dynamic subtest: bcs0
[358.135554] Dynamic subtest bcs0: SUCCESS (0.000s)
[358.144681] Starting dynamic subtest: vcs0
[358.145427] Dynamic subtest vcs0: SUCCESS (0.001s)
[358.154347] Starting dynamic subtest: vcs1
[358.155049] Dynamic subtest vcs1: SUCCESS (0.000s)
[358.164217] Starting dynamic subtest: vecs0
[358.164921] Dynamic subtest vecs0: SUCCESS (0.000s)
[358.165618] Subtest init-busy: SUCCESS (0.007s)
[358.228185] [112/155] (662s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[358.321291] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[358.322797] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[358.380190] [113/155] (662s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[358.473831] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[358.520750] [114/155] (662s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[358.611054] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[358.611810] Starting dynamic subtest: pipe-A-valid-mode
[359.510589] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.899s)
[359.511368] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.900s)
[359.665801] [115/155] (661s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[359.764068] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[359.765531] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[359.869748] [116/155] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[359.962696] Starting subtest: fbcpsrhdr-slowdraw
[359.964196] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[360.034020] [117/155] (661s left) sw_sync (sync_multi_consumer_producer)
[360.068770] Starting subtest: sync_multi_consumer_producer
[360.433712] Subtest sync_multi_consumer_producer: SUCCESS (0.357s)
[360.502114] [118/155] (660s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[360.590810] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[360.591561] Starting dynamic subtest: pipe-A
[361.770426] Dynamic subtest pipe-A: SUCCESS (1.180s)
[361.784865] Starting dynamic subtest: pipe-B
[363.013510] Dynamic subtest pipe-B: SUCCESS (1.242s)
[363.025705] Starting dynamic subtest: pipe-C
[363.222100] Dynamic subtest pipe-C: SUCCESS (0.207s)
[363.233447] Starting dynamic subtest: pipe-D
[363.433975] Dynamic subtest pipe-D: SUCCESS (0.211s)
[363.434715] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (2.845s)
[363.616607] [119/155] (657s left) i915_query (query-topology-coherent-slice-mask)
[363.654910] Starting subtest: query-topology-coherent-slice-mask
[363.655687] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s)
[363.718995] [120/155] (657s left) gem_mmap_gtt (basic-read)
[363.754040] Starting subtest: basic-read
[363.765632] Subtest basic-read: SUCCESS (0.012s)
[363.850603] [121/155] (657s left) core_auth (many-magics)
[363.885695] Starting subtest: many-magics
[364.398633] Subtest many-magics: SUCCESS (0.513s)
[364.527990] [122/155] (656s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[364.627572] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[364.628951] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[364.704251] [123/155] (656s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[364.806352] Starting subtest: yf-tiled-16bpp-rotate-0
[364.807708] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[364.898529] [124/155] (656s left) prime_busy (before)
[364.937030] Starting subtest: before
[364.942068] Starting dynamic subtest: rcs0
[364.971265] Dynamic subtest rcs0: SUCCESS (0.029s)
[364.983778] Starting dynamic subtest: bcs0
[364.986537] Dynamic subtest bcs0: SUCCESS (0.014s)
[364.997643] Starting dynamic subtest: vcs0
[365.004525] Dynamic subtest vcs0: SUCCESS (0.017s)
[365.015186] Starting dynamic subtest: vcs1
[365.018585] Dynamic subtest vcs1: SUCCESS (0.013s)
[365.029231] Starting dynamic subtest: vecs0
[365.034502] Dynamic subtest vecs0: SUCCESS (0.015s)
[365.148950] Subtest before: SUCCESS (0.205s)
[365.218157] [125/155] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[365.313222] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[365.314590] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[365.407536] [126/155] (656s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[365.445931] Starting subtest: basic-wc-cpu-noreloc
[365.448146] Subtest basic-wc-cpu-noreloc: SUCCESS (0.002s)
[365.572777] [127/155] (656s left) kms_invalid_mode (int-max-clock)
[365.664158] Starting subtest: int-max-clock
[365.664867] Starting dynamic subtest: pipe-A-HDMI-A-1
[365.721654] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[365.734105] Starting dynamic subtest: pipe-B-HDMI-A-1
[365.734826] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[365.744551] Starting dynamic subtest: pipe-C-HDMI-A-1
[365.745265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[365.755330] Starting dynamic subtest: pipe-D-HDMI-A-1
[365.756055] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[365.756755] Subtest int-max-clock: SUCCESS (0.070s)
[365.880823] [128/155] (655s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[365.971399] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[365.990174] Starting dynamic subtest: pipe-A-plane-0
[366.198269] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[366.216571] Starting dynamic subtest: pipe-A-plane-3
[366.373409] Dynamic subtest pipe-A-plane-3: SUCCESS (0.173s)
[366.390158] Starting dynamic subtest: pipe-A-plane-5
[366.540057] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[366.688853] Starting dynamic subtest: pipe-B-plane-0
[366.853842] Dynamic subtest pipe-B-plane-0: SUCCESS (0.175s)
[366.872171] Starting dynamic subtest: pipe-B-plane-3
[367.020573] Dynamic subtest pipe-B-plane-3: SUCCESS (0.165s)
[367.036575] Starting dynamic subtest: pipe-B-plane-5
[367.187245] Dynamic subtest pipe-B-plane-5: SUCCESS (0.164s)
[367.260034] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (1.288s)
[367.434811] [129/155] (654s left) gem_workarounds (suspend-resume-fd)
[367.487570] Starting subtest: suspend-resume-fd
[383.479207] Subtest suspend-resume-fd: SUCCESS (1.242s)
[395.640301] [130/155] (638s left) kms_psr (psr-primary-blt)
[395.743361] Subtest psr-primary-blt: SKIP (0.000s)
[395.786150] [131/155] (638s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[395.884183] Starting subtest: x-tiled-16bpp-rotate-270
[395.960643] Subtest x-tiled-16bpp-rotate-270: SKIP (0.075s)
[396.077236] [132/155] (637s left) i915_module_load (resize-bar)
[396.110233] Starting subtest: resize-bar
[396.116965] Subtest resize-bar: SKIP (0.006s)
[396.161884] [133/155] (637s left) i915_drm_fdinfo (memory-info-active)
[396.198992] Starting subtest: memory-info-active
[396.199724] Starting dynamic subtest: smem0
[397.362188] Dynamic subtest smem0: SUCCESS (1.162s)
[397.364728] Subtest memory-info-active: SUCCESS (1.164s)
[397.425309] [134/155] (636s left) syncobj_timeline (reset-during-wait-for-submit)
[397.461135] Starting subtest: reset-during-wait-for-submit
[397.563584] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[397.654752] [135/155] (636s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[397.748554] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[397.749951] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[397.856584] [136/155] (636s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[397.945834] Starting subtest: multiplane-rotation-cropping-top
[422.969490] Subtest multiplane-rotation-cropping-top: SUCCESS (25.029s)
[423.083023] [137/155] (611s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[423.186939] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[423.188371] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[423.280101] [138/155] (610s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[423.322334] Starting subtest: y-tiled-to-vebox-yf-tiled
[423.323069] Starting dynamic subtest: smem
[423.391382] Dynamic subtest smem: SUCCESS (0.068s)
[423.392129] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.070s)
[423.576473] [139/155] (610s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[423.674145] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc
[423.675644] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[423.757753] [140/155] (610s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[423.793373] Starting subtest: multi-wait-all-for-submit-available-submitted
[423.794071] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[423.874928] [141/155] (610s left) gem_mmap_wc (coherency)
[423.910473] Starting subtest: coherency
[423.968883] Subtest coherency: SUCCESS (0.059s)
[424.053152] [142/155] (610s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[424.141525] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[424.157846] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.009s)
[424.236959] [143/155] (610s left) kms_vblank (wait-forked-busy-hang)
[424.325916] Starting subtest: wait-forked-busy-hang
[424.326622] Starting dynamic subtest: pipe-A-HDMI-A-1
[438.504805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.178s)
[438.518307] Starting dynamic subtest: pipe-D-HDMI-A-1
[452.317977] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.807s)
[452.318687] Subtest wait-forked-busy-hang: SUCCESS (27.993s)
[452.469166] [144/155] (581s left) gem_ctx_shared (exec-single-timeline)
[452.515617] Starting subtest: exec-single-timeline
[452.516345] Starting dynamic subtest: rcs0
[453.558245] Dynamic subtest rcs0: SUCCESS (1.033s)
[453.569683] Starting dynamic subtest: bcs0
[454.581594] Dynamic subtest bcs0: SUCCESS (1.021s)
[454.592869] Starting dynamic subtest: vcs0
[455.605567] Dynamic subtest vcs0: SUCCESS (1.022s)
[455.617535] Starting dynamic subtest: vcs1
[456.629540] Dynamic subtest vcs1: SUCCESS (1.022s)
[456.639970] Starting dynamic subtest: vecs0
[457.653733] Dynamic subtest vecs0: SUCCESS (1.022s)
[457.654538] Subtest exec-single-timeline: SUCCESS (5.131s)
[457.826035] [145/155] (576s left) kms_cursor_crc (cursor-random-max-size)
[457.924675] Starting subtest: cursor-random-max-size
[457.926807] Subtest cursor-random-max-size: SKIP (0.000s)
[458.027676] [146/155] (576s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[458.125356] Starting subtest: extended-modeset-hang-oldfb-with-reset
[458.127276] Starting dynamic subtest: pipe-A
[468.851513] Dynamic subtest pipe-A: SUCCESS (10.725s)
[468.864224] Starting dynamic subtest: pipe-D
[479.587678] Dynamic subtest pipe-D: SUCCESS (10.733s)
[479.590053] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.464s)
[479.725147] [147/155] (554s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[479.831175] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[479.832579] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[479.939674] [148/155] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[480.036026] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[480.037556] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[480.126746] [149/155] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[480.218849] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[480.220300] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[480.334881] [150/155] (554s left) kms_content_protection (dp-mst-lic-type-1)
[480.426878] Starting subtest: dp-mst-lic-type-1
[480.428323] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[480.522285] [151/155] (554s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[480.615331] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[480.616759] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[480.707788] [152/155] (554s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[480.796687] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[480.798541] Starting dynamic subtest: pipe-A-HDMI-A-1
[480.805261] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[480.814963] Starting dynamic subtest: pipe-B-HDMI-A-1
[480.821667] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[480.831166] Starting dynamic subtest: pipe-C-HDMI-A-1
[480.837837] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[480.847298] Starting dynamic subtest: pipe-D-HDMI-A-1
[480.854601] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[480.856056] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.007s)
[481.051186] [153/155] (553s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[481.139873] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[481.141227] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[481.199471] [154/155] (553s left) kms_psr (fbc-pr-suspend)
[481.289667] Subtest fbc-pr-suspend: SKIP (0.000s)
[481.338201] [155/155] (553s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[481.425784] Starting subtest: 2x-long-flip-vs-cursor-atomic
[481.428231] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[481.489177] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: gem_ctx_isolation
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ccs
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: gem_flink_basic
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: i915_suspend
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_pipe_crc_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_create
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: gem_request_retire
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_chamelium_edid
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_selftest
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: core_getclient
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_create
results: parsing output: 47/ for test: kms_plane_scaling
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_pm_rc6_residency
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_fenced_exec_thrash
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: sysfs_preempt_timeout
results: parsing output: 70/ for test: gem_exec_params
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: drm_read
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: kms_dither
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_dsc
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: prime_mmap
results: parsing output: 94/ for test: kms_plane_multiple
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: gem_gtt_cpu_tlb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: gem_softpin
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: core_auth
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: prime_busy
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: i915_module_load
results: parsing output: 132/ for test: i915_drm_fdinfo
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_rotation_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_render_copy
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: syncobj_timeline
results: parsing output: 140/ for test: gem_mmap_wc
results: parsing output: 141/ for test: kms_flip
results: parsing output: 142/ for test: kms_vblank
results: parsing output: 143/ for test: gem_ctx_shared
results: parsing output: 144/ for test: kms_cursor_crc
results: parsing output: 145/ for test: kms_busy
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_content_protection
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: kms_cursor_legacy
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: kms_cursor_legacy
Done.