[64.391535] Initializing watchdogs
[64.391612]   /dev/watchdog0
[64.420743] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[64.434975] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[64.439827] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.442408] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[65.992540] Starting subtest: dp-mst-lic-type-0-hdcp14
[65.994353] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[66.212878] [002/133] (958s left) core_getversion (all-cards)
[66.256422] Starting subtest: all-cards
[66.275134] Subtest all-cards: SUCCESS (0.020s)
[66.334350] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[67.817058] Starting subtest: legacy-dpms
[67.818881] Starting dynamic subtest: pipe-A-HDMI-A-3
[74.024945] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.206s)
[74.025818] Subtest legacy-dpms: SUCCESS (6.208s)
[74.217989] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[75.699654] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[75.705459] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[75.894910] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[77.395800] Starting subtest: plane-primary-toggle-with-vblank-wait
[77.398138] Starting dynamic subtest: pipe-A-HDMI-A-3
[77.610516] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.212s)
[77.765416] Starting dynamic subtest: pipe-B-HDMI-A-3
[77.997538] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.241s)
[78.054125] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.658s)
[78.265691] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[79.776529] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[79.778183] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[80.008266] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[81.491650] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[81.564760] [008/133] (944s left) perf (invalid-oa-exponent)
[81.716636] Starting subtest: invalid-oa-exponent
[81.742450] Subtest invalid-oa-exponent: SUCCESS (0.026s)
[81.807375] [009/133] (943s left) gem_eio (create-ext)
[81.942147] Starting subtest: create-ext
[82.124224] Subtest create-ext: SUCCESS (0.182s)
[83.734970] [010/133] (942s left) kms_color (invalid-degamma-lut-sizes)
[85.220863] Starting subtest: invalid-degamma-lut-sizes
[85.221726] Starting dynamic subtest: pipe-A
[85.269222] Dynamic subtest pipe-A: SUCCESS (0.049s)
[85.277305] Starting dynamic subtest: pipe-B
[85.278152] Dynamic subtest pipe-B: SUCCESS (0.001s)
[85.285918] Starting dynamic subtest: pipe-C
[85.286763] Dynamic subtest pipe-C: SUCCESS (0.001s)
[85.294447] Starting dynamic subtest: pipe-D
[85.295246] Dynamic subtest pipe-D: SUCCESS (0.001s)
[85.296037] Subtest invalid-degamma-lut-sizes: SUCCESS (0.051s)
[85.474282] [011/133] (940s left) gem_softpin (allocator-basic)
[85.521282] Starting subtest: allocator-basic
[85.790764] Subtest allocator-basic: SUCCESS (0.265s)
[86.020481] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[87.506410] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[87.572811] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[89.079221] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[90.192052] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.107s)
[90.398765] [014/133] (935s left) kms_psr (pr-primary-render)
[91.883253] Subtest pr-primary-render: SKIP (0.000s)
[91.956474] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[93.444266] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[93.445949] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[93.675126] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[95.162080] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[95.223178] [017/133] (931s left) gem_ccs (ctrl-surf-copy)
[95.272724] Starting subtest: ctrl-surf-copy
[95.274759] Subtest ctrl-surf-copy: SKIP (0.000s)
[95.415708] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[95.577866] Starting subtest: invalid-oa-metric-set-id
[95.598690] Subtest invalid-oa-metric-set-id: SUCCESS (0.021s)
[95.659414] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[97.147380] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[97.149110] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[97.402601] [020/133] (929s left) gem_pxp (create-regular-buffer)
[99.968478] Starting subtest: create-regular-buffer
[99.970291] Subtest create-regular-buffer: SKIP (0.000s)
[100.115731] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[100.247782] Starting subtest: in-flight-contexts-10ms
[113.847735] Subtest in-flight-contexts-10ms: SUCCESS (13.600s)
[115.496019] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[116.988140] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[116.990432] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[117.232643] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[117.308256] Starting subtest: u-fairslice-all
[119.382960] Subtest u-fairslice-all: SUCCESS (2.075s)
[119.814353] [024/133] (907s left) core_getstats (basic)
[119.855786] Starting subtest: basic
[119.856617] Subtest basic: SUCCESS (0.000s)
[119.999499] [025/133] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[121.482046] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[121.482971] Starting dynamic subtest: pipe-A-HDMI-A-3
[121.491550] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[121.500498] Starting dynamic subtest: pipe-B-HDMI-A-3
[121.509376] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[121.517943] Starting dynamic subtest: pipe-C-HDMI-A-3
[121.526985] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[121.535280] Starting dynamic subtest: pipe-D-HDMI-A-3
[121.544942] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[121.546858] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[121.798034] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[123.279496] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[123.281255] Starting dynamic subtest: pipe-A-HDMI-A-3
[123.289608] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[123.298281] Starting dynamic subtest: pipe-B-HDMI-A-3
[123.306696] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[123.315285] Starting dynamic subtest: pipe-C-HDMI-A-3
[123.324169] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[123.332635] Starting dynamic subtest: pipe-D-HDMI-A-3
[123.341642] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[123.343410] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[123.544201] [027/133] (903s left) sw_sync (alloc_fence)
[123.584891] Starting subtest: alloc_fence
[123.585773] Subtest alloc_fence: SUCCESS (0.000s)
[123.741263] [028/133] (903s left) i915_pm_rps (basic-api)
[123.791637] Starting subtest: basic-api
[123.793246] Subtest basic-api: SKIP (0.000s)
[123.977299] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[125.458648] Starting subtest: cursorB-vs-flipA-toggle
[125.462670] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[125.678369] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[127.352436] Starting subtest: cursor-rapid-movement-128x42
[127.359225] Starting dynamic subtest: pipe-A-HDMI-A-3
[127.783580] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.425s)
[127.816801] Starting dynamic subtest: pipe-D-HDMI-A-3
[128.128752] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.321s)
[128.129768] Subtest cursor-rapid-movement-128x42: SUCCESS (0.776s)
[128.571886] [031/133] (899s left) kms_dp_link_training (non-uhbr-sst)
[130.053756] Starting subtest: non-uhbr-sst
[130.057248] Subtest non-uhbr-sst: SKIP (0.000s)
[130.246146] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[131.735984] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[131.737931] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[131.991338] [033/133] (895s left) gem_exec_parallel (engines)
[132.044856] Starting subtest: engines
[132.045834] Starting dynamic subtest: basic
[133.634545] Dynamic subtest basic: SUCCESS (1.590s)
[133.643630] Starting dynamic subtest: contexts
[138.007191] Dynamic subtest contexts: SUCCESS (4.364s)
[138.017101] Starting dynamic subtest: fds
[142.360942] Dynamic subtest fds: SUCCESS (4.358s)
[142.370436] Starting dynamic subtest: userptr
[143.848133] Dynamic subtest userptr: SUCCESS (1.491s)
[143.849195] Subtest engines: SUCCESS (11.804s)
[144.194449] [034/133] (883s left) gem_eio (in-flight-immediate)
[144.396942] Starting subtest: in-flight-immediate
[149.012043] Subtest in-flight-immediate: SUCCESS (4.614s)
[150.644636] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[150.651425] [035/133] (877s left) prime_mmap (test_forked)
[150.694606] Starting subtest: test_forked
[150.695477] Starting dynamic subtest: test_forked-smem
[150.766434] Dynamic subtest test_forked-smem: SUCCESS (0.072s)
[150.775619] Starting dynamic subtest: test_forked-lmem0
[150.838814] Dynamic subtest test_forked-lmem0: SUCCESS (0.072s)
[150.839681] Subtest test_forked: SUCCESS (0.144s)
[151.043881] [036/133] (877s left) kms_dsc (dsc-with-formats)
[152.525885] Starting subtest: dsc-with-formats
[152.550791] Subtest dsc-with-formats: SKIP (0.002s)
[152.739093] [037/133] (875s left) prime_busy (hang)
[152.785279] Starting subtest: hang
[152.787189] Starting dynamic subtest: rcs0
[179.443044] Dynamic subtest rcs0: SUCCESS (26.663s)
[179.452484] Starting dynamic subtest: bcs0
[186.528954] Dynamic subtest bcs0: SUCCESS (7.086s)
[186.538433] Starting dynamic subtest: vcs0
[193.568439] Dynamic subtest vcs0: SUCCESS (7.041s)
[193.577758] Starting dynamic subtest: vcs1
[200.544542] Dynamic subtest vcs1: SUCCESS (6.976s)
[200.553937] Starting dynamic subtest: vecs0
[207.585147] Dynamic subtest vecs0: SUCCESS (7.040s)
[207.586033] Subtest hang: SUCCESS (54.809s)
[207.764779] [038/133] (820s left) kms_vblank (wait-idle)
[209.245590] Starting subtest: wait-idle
[209.247611] Starting dynamic subtest: pipe-A-HDMI-A-3
[211.603838] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.357s)
[211.616191] Starting dynamic subtest: pipe-D-HDMI-A-3
[213.783129] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.175s)
[213.783959] Subtest wait-idle: SUCCESS (4.538s)
[213.981872] [039/133] (814s left) kms_pm_rpm (package-g7)
[218.004976] Starting subtest: package-g7
[218.008018] Subtest package-g7: SKIP (0.000s)
[218.984043] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[220.478252] Starting subtest: flip-vs-cursor-varying-size
[234.893269] Subtest flip-vs-cursor-varying-size: SUCCESS (14.416s)
[235.096562] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[236.584741] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[236.586445] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[236.792821] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[236.836298] Starting subtest: single-wait-all-for-submit-signaled
[236.837186] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[236.987731] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[237.161575] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[237.188184] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[237.259385] [044/133] (791s left) gem_wait (busy)
[237.317399] Starting subtest: busy
[237.318301] Starting dynamic subtest: all-engines
[237.908232] Dynamic subtest all-engines: SUCCESS (0.591s)
[237.918699] Starting dynamic subtest: rcs0
[238.447846] Dynamic subtest rcs0: SUCCESS (0.539s)
[238.457331] Starting dynamic subtest: bcs0
[238.986887] Dynamic subtest bcs0: SUCCESS (0.539s)
[238.996238] Starting dynamic subtest: vcs0
[239.526780] Dynamic subtest vcs0: SUCCESS (0.539s)
[239.536158] Starting dynamic subtest: vcs1
[240.064827] Dynamic subtest vcs1: SUCCESS (0.538s)
[240.074245] Starting dynamic subtest: vecs0
[240.602914] Dynamic subtest vecs0: SUCCESS (0.538s)
[240.603913] Subtest busy: SUCCESS (3.286s)
[240.896435] [045/133] (788s left) gen9_exec_parse (bb-secure)
[240.946168] Subtest bb-secure: SKIP (0.000s)
[241.024339] [046/133] (788s left) kms_cursor_edge_walk (128x128-right-edge)
[242.504877] Starting subtest: 128x128-right-edge
[242.506868] Starting dynamic subtest: pipe-A-HDMI-A-3
[245.828113] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.321s)
[245.839113] Starting dynamic subtest: pipe-D-HDMI-A-3
[249.047453] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.218s)
[249.048243] Subtest 128x128-right-edge: SUCCESS (6.543s)
[249.259407] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[250.746645] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[250.748473] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[251.001072] [048/133] (778s left) prime_mmap (test_forked_cpu_write)
[251.044466] Starting subtest: test_forked_cpu_write
[251.045368] Starting dynamic subtest: test_forked_cpu_write-smem
[251.055537] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[251.065917] Starting dynamic subtest: test_forked_cpu_write-lmem0
[251.066988] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[251.067938] Subtest test_forked_cpu_write: SUCCESS (0.023s)
[251.298911] [049/133] (778s left) kms_addfb_basic (small-bo)
[252.780914] Starting subtest: small-bo
[252.781837] Subtest small-bo: SUCCESS (0.000s)
[253.015557] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[254.549344] Subtest dp-audio: SKIP (0.000s)
[254.663743] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[256.196400] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[256.316009] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[257.803447] Starting subtest: psr-shrfb-scaledprimary
[257.805043] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[258.044501] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[259.527105] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[259.528987] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[259.726981] [054/133] (770s left) perf (i915-ref-count)
[259.878307] Starting subtest: i915-ref-count
[259.915975] Subtest i915-ref-count: SUCCESS (0.037s)
[259.992154] [055/133] (769s left) kms_joiner (invalid-modeset-force-big-joiner)
[261.476446] Starting subtest: invalid-modeset-force-big-joiner
[261.478133] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[261.672837] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[263.155539] Starting subtest: cursor-alpha-opaque
[263.157591] Starting dynamic subtest: pipe-A-HDMI-A-3
[263.837194] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.680s)
[263.848047] Starting dynamic subtest: pipe-D-HDMI-A-3
[264.243238] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.404s)
[264.244156] Subtest cursor-alpha-opaque: SUCCESS (1.087s)
[264.963723] [057/133] (765s left) kms_legacy_colorkey (basic)
[266.447201] Starting subtest: basic
[266.452837] Starting dynamic subtest: pipe-A
[266.533555] Dynamic subtest pipe-A: SUCCESS (0.088s)
[266.552874] Starting dynamic subtest: pipe-B
[266.554069] Dynamic subtest pipe-B: SUCCESS (0.001s)
[266.583799] Starting dynamic subtest: pipe-C
[266.585390] Dynamic subtest pipe-C: SUCCESS (0.001s)
[266.623123] Starting dynamic subtest: pipe-D
[266.624741] Dynamic subtest pipe-D: SUCCESS (0.001s)
[266.626393] Subtest basic: SUCCESS (0.097s)
[266.717282] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[268.218857] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[268.220551] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[268.464270] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[268.508500] Starting subtest: bad-pitch-32
[268.509317] Subtest bad-pitch-32: SUCCESS (0.000s)
[270.202929] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[270.254933] Starting subtest: x-tiled-to-vebox-y-tiled
[270.255913] Starting dynamic subtest: smem
[270.337133] Dynamic subtest smem: SUCCESS (0.082s)
[270.346851] Starting dynamic subtest: lmem0
[271.095811] Dynamic subtest lmem0: SUCCESS (0.754s)
[271.097234] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.837s)
[271.406655] [061/133] (759s left) gem_exec_reloc (basic-range)
[271.459531] Subtest basic-range: SKIP (0.000s)
[271.574661] [062/133] (759s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[273.075632] Starting subtest: yf-tiled-64bpp-rotate-0
[273.077305] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[273.300064] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[273.343739] Starting subtest: wait-all-for-submit-snapshot
[273.427076] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[273.612281] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[275.094933] Starting subtest: invalid-async-flip
[275.321418] Starting dynamic subtest: pipe-A-HDMI-A-3
[275.752519] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.431s)
[275.933424] Starting dynamic subtest: pipe-B-HDMI-A-3
[276.024416] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.100s)
[276.197554] Starting dynamic subtest: pipe-C-HDMI-A-3
[276.306625] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.114s)
[276.455107] Starting dynamic subtest: pipe-D-HDMI-A-3
[276.557499] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.111s)
[276.558318] Subtest invalid-async-flip: SUCCESS (1.464s)
[276.969948] [065/133] (754s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[278.459342] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[278.466446] Starting dynamic subtest: A-HDMI-A3
[279.173823] Dynamic subtest A-HDMI-A3: SUCCESS (0.707s)
[279.183253] Starting dynamic subtest: B-HDMI-A3
[279.805729] Dynamic subtest B-HDMI-A3: SUCCESS (0.630s)
[279.815807] Starting dynamic subtest: C-HDMI-A3
[280.468701] Dynamic subtest C-HDMI-A3: SUCCESS (0.662s)
[280.478385] Starting dynamic subtest: D-HDMI-A3
[281.091557] Dynamic subtest D-HDMI-A3: SUCCESS (0.621s)
[281.093990] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.633s)
[281.317194] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[282.808757] Starting subtest: fbc-suspend
[338.650655] Subtest fbc-suspend: SUCCESS (22.590s)
[342.981070] [067/133] (692s left) syncobj_timeline (invalid-transfer-bad-pad)
[343.027621] Starting subtest: invalid-transfer-bad-pad
[343.028428] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[343.201375] [068/133] (692s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[344.703591] Starting subtest: 4-tiled-64bpp-rotate-90
[344.705438] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[344.945218] [069/133] (690s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[344.995109] Starting subtest: saturated-hostile-nopreempt
[344.995999] Starting dynamic subtest: rcs0
[345.807637] Dynamic subtest rcs0: SUCCESS (0.811s)
[345.821831] Starting dynamic subtest: bcs0
[346.603419] Dynamic subtest bcs0: SUCCESS (0.793s)
[346.616389] Starting dynamic subtest: vcs0
[347.393778] Dynamic subtest vcs0: SUCCESS (0.781s)
[347.407105] Starting dynamic subtest: vcs1
[348.185393] Dynamic subtest vcs1: SUCCESS (0.791s)
[348.198594] Starting dynamic subtest: vecs0
[348.965619] Dynamic subtest vecs0: SUCCESS (0.777s)
[348.967939] Subtest saturated-hostile-nopreempt: SUCCESS (3.972s)
[349.161742] [070/133] (686s left) gem_exec_big (single)
[349.210835] Starting subtest: single
[356.563815] Subtest single: SUCCESS (7.350s)
[357.487559] [071/133] (678s left) gem_exec_fence (submit67)
[357.700169] Starting subtest: submit67
[357.701876] Subtest submit67: SKIP (0.000s)
[358.294348] [072/133] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[359.787516] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[359.789297] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[359.980197] [073/133] (675s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[361.469127] Starting subtest: fbc-rgb101010-draw-mmap-wc
[361.471624] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[361.690056] [074/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[363.179395] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[363.181106] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[363.370832] [075/133] (672s left) i915_drm_fdinfo (busy-idle)
[363.418956] Starting subtest: busy-idle
[363.419813] Starting dynamic subtest: rcs0
[363.421570] Dynamic subtest rcs0: SKIP (0.000s)
[363.433610] Starting dynamic subtest: bcs0
[363.435574] Dynamic subtest bcs0: SKIP (0.000s)
[363.447271] Starting dynamic subtest: vcs0
[363.449014] Dynamic subtest vcs0: SKIP (0.000s)
[363.460681] Starting dynamic subtest: vcs1
[363.462986] Dynamic subtest vcs1: SKIP (0.000s)
[363.474656] Starting dynamic subtest: vecs0
[363.476988] Dynamic subtest vecs0: SKIP (0.000s)
[363.479017] Subtest busy-idle: SKIP (0.008s)
[363.556795] [076/133] (672s left) kms_psr (psr2-primary-page-flip)
[365.040961] Subtest psr2-primary-page-flip: SKIP (0.000s)
[365.227362] [077/133] (671s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[366.713690] Starting subtest: cursorA-vs-flipB-atomic
[366.716635] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[366.946611] [078/133] (669s left) kms_prop_blob (blob-prop-lifetime)
[366.990800] Starting subtest: blob-prop-lifetime
[366.991670] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[367.131324] [079/133] (669s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[368.615892] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[368.616832] Starting dynamic subtest: pipe-A
[371.215387] Dynamic subtest pipe-A: SUCCESS (2.600s)
[371.235153] Starting dynamic subtest: pipe-B
[373.722693] Dynamic subtest pipe-B: SUCCESS (2.505s)
[373.743970] Starting dynamic subtest: pipe-C
[374.029739] Dynamic subtest pipe-C: SUCCESS (0.305s)
[374.047262] Starting dynamic subtest: pipe-D
[374.320930] Dynamic subtest pipe-D: SUCCESS (0.289s)
[374.322082] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.707s)
[374.651810] [080/133] (661s left) kms_pipe_crc_basic (hang-read-crc)
[376.139557] Starting subtest: hang-read-crc
[376.141751] Starting dynamic subtest: pipe-A-HDMI-A-3
[377.670219] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.529s)
[377.684569] Starting dynamic subtest: pipe-B-HDMI-A-3
[378.884446] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.209s)
[378.896734] Starting dynamic subtest: pipe-C-HDMI-A-3
[380.119916] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.233s)
[380.133612] Starting dynamic subtest: pipe-D-HDMI-A-3
[381.368760] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.245s)
[381.369714] Subtest hang-read-crc: SUCCESS (5.229s)
[381.608887] [081/133] (655s left) kms_selftest (drm_format)
[381.681347] Starting subtest: drm_format
[381.754782] Starting dynamic subtest: drm_test_format_block_width_invalid
[381.788622] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.091s)
[381.804051] Starting dynamic subtest: drm_test_format_block_width_one_plane
[381.880224] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.086s)
[381.927792] Starting dynamic subtest: drm_test_format_block_width_two_plane
[381.960010] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.073s)
[381.977693] Starting dynamic subtest: drm_test_format_block_width_three_plane
[382.047273] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.083s)
[382.086923] Starting dynamic subtest: drm_test_format_block_width_tiled
[382.122258] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.068s)
[382.137638] Starting dynamic subtest: drm_test_format_block_height_invalid
[382.199409] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.073s)
[382.244437] Starting dynamic subtest: drm_test_format_block_height_one_plane
[382.279367] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.075s)
[382.298802] Starting dynamic subtest: drm_test_format_block_height_two_plane
[382.354445] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.070s)
[382.399548] Starting dynamic subtest: drm_test_format_block_height_three_plane
[382.433139] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.073s)
[382.452562] Starting dynamic subtest: drm_test_format_block_height_tiled
[382.512946] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.076s)
[382.560823] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[382.597974] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.083s)
[382.623240] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[382.688317] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.084s)
[382.733922] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[382.773458] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.080s)
[382.797537] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[382.863526] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.085s)
[382.909361] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[382.949647] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.080s)
[382.974370] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[383.038395] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.084s)
[383.084384] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[383.123920] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.079s)
[383.148394] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[383.214667] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.086s)
[383.216792] Subtest drm_format: SUCCESS (1.534s)
[383.507425] [082/133] (653s left) gem_close_race (multigpu-basic-process)
[383.578781] Starting subtest: multigpu-basic-process
[383.581136] Subtest multigpu-basic-process: SKIP (0.000s)
[383.913002] [083/133] (652s left) gem_set_tiling_vs_gtt
[384.043371] [084/133] (652s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[385.527671] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[385.528513] Starting dynamic subtest: pipe-A
[385.689459] Dynamic subtest pipe-A: SUCCESS (0.162s)
[385.711356] Starting dynamic subtest: pipe-B
[385.866176] Dynamic subtest pipe-B: SUCCESS (0.175s)
[385.879904] Starting dynamic subtest: pipe-C
[386.006650] Dynamic subtest pipe-C: SUCCESS (0.139s)
[386.020094] Starting dynamic subtest: pipe-D
[386.146746] Dynamic subtest pipe-D: SUCCESS (0.139s)
[386.147654] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.621s)
[386.389052] [085/133] (650s left) kms_addfb_basic (basic-y-tiled-legacy)
[386.434516] Starting subtest: basic-y-tiled-legacy
[386.436182] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[388.119165] [086/133] (649s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[389.626942] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[390.904408] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.277s)
[391.213655] [087/133] (646s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[391.264716] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[391.265573] Starting dynamic subtest: smem
[391.363808] Dynamic subtest smem: SUCCESS (0.098s)
[391.377560] Starting dynamic subtest: lmem0
[392.481279] Dynamic subtest lmem0: SUCCESS (1.112s)
[392.482421] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.213s)
[392.788850] [088/133] (644s left) gem_caching (writes)
[392.839047] Starting subtest: writes
[397.817397] Subtest writes: SUCCESS (4.978s)
[398.065439] [089/133] (639s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[398.111927] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[398.216898] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[398.397962] [090/133] (639s left) kms_flip (wf_vblank-ts-check)
[399.882422] Starting subtest: wf_vblank-ts-check
[399.888387] Starting dynamic subtest: A-HDMI-A3
[408.067550] Dynamic subtest A-HDMI-A3: SUCCESS (8.178s)
[408.084641] Starting dynamic subtest: B-HDMI-A3
[416.197826] Dynamic subtest B-HDMI-A3: SUCCESS (8.126s)
[416.212338] Starting dynamic subtest: C-HDMI-A3
[424.331752] Dynamic subtest C-HDMI-A3: SUCCESS (8.132s)
[424.346792] Starting dynamic subtest: D-HDMI-A3
[432.465553] Dynamic subtest D-HDMI-A3: SUCCESS (8.132s)
[432.467898] Subtest wf_vblank-ts-check: SUCCESS (32.587s)
[432.776170] [091/133] (604s left) gem_lmem_evict (dontneed-evict-race)
[437.215867] Starting subtest: dontneed-evict-race
[439.294822] Subtest dontneed-evict-race: SUCCESS (2.080s)
[441.189787] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[441.190966] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[441.193459] [092/133] (596s left) gem_mmap_gtt (medium-copy-odd)
[444.535464] Subtest medium-copy-odd: SKIP (0.000s)
[444.620270] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[444.623874] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[444.627409] [093/133] (593s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[446.115850] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[446.121030] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[446.342005] [094/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[447.826809] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[447.827691] Starting dynamic subtest: pipe-A-HDMI-A-3
[447.848069] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[447.858515] Starting dynamic subtest: pipe-B-HDMI-A-3
[447.880251] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[447.890771] Starting dynamic subtest: pipe-C-HDMI-A-3
[447.912610] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[447.922513] Starting dynamic subtest: pipe-D-HDMI-A-3
[447.943771] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[447.945389] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[448.162880] [095/133] (589s left) gem_exec_suspend (basic-s0)
[448.225368] Starting subtest: basic-S0
[448.226320] Starting dynamic subtest: smem
[468.649748] Dynamic subtest smem: SUCCESS (5.333s)
[468.662816] Starting dynamic subtest: lmem0
[488.674161] Dynamic subtest lmem0: SUCCESS (5.148s)
[488.675114] Subtest basic-S0: SUCCESS (10.485s)
[493.040090] [096/133] (549s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[494.543626] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[494.545412] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[494.772766] [097/133] (547s left) gem_mmap_offset (bad-extensions)
[494.817241] Starting subtest: bad-extensions
[494.818138] Subtest bad-extensions: SUCCESS (0.000s)
[495.026579] [098/133] (547s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[496.511595] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[496.515117] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[496.715775] [099/133] (545s left) gem_mmap_gtt (cpuset-big-copy-odd)
[496.759233] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[496.830835] [100/133] (545s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[498.334006] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[498.335623] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[498.592760] [101/133] (544s left) kms_psr (fbc-psr2-sprite-render)
[500.077635] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[500.150116] [102/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[501.640461] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[501.642253] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[501.892001] [103/133] (541s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[503.375943] Starting subtest: crc-primary-basic-y-tiled-ccs
[503.376876] Starting dynamic subtest: pipe-A-HDMI-A-3
[503.388889] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[503.399859] Starting dynamic subtest: pipe-B-HDMI-A-3
[503.407834] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[503.418828] Starting dynamic subtest: pipe-C-HDMI-A-3
[503.426902] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[503.437517] Starting dynamic subtest: pipe-D-HDMI-A-3
[503.445763] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[503.447317] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[503.692469] [104/133] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[505.181648] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[505.183415] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[505.449338] [105/133] (537s left) api_intel_bb (add-remove-objects)
[505.493121] Starting subtest: add-remove-objects
[505.514748] Subtest add-remove-objects: SUCCESS (0.022s)
[505.727803] [106/133] (537s left) sysfs_heartbeat_interval (nopreempt)
[505.777754] Starting subtest: nopreempt
[505.780220] Starting dynamic subtest: vecs0
[509.863513] Dynamic subtest vecs0: SUCCESS (4.083s)
[509.882786] Starting dynamic subtest: vcs0
[513.910578] Dynamic subtest vcs0: SUCCESS (4.044s)
[513.925874] Starting dynamic subtest: bcs0
[517.922396] Dynamic subtest bcs0: SUCCESS (4.010s)
[517.935589] Starting dynamic subtest: rcs0
[522.065479] Dynamic subtest rcs0: SUCCESS (4.141s)
[522.079122] Starting dynamic subtest: vcs1
[526.078578] Dynamic subtest vcs1: SUCCESS (4.013s)
[526.079517] Subtest nopreempt: SUCCESS (20.300s)
[526.299270] [107/133] (517s left) kms_getfb (getfb2-into-addfb2)
[527.782730] Starting subtest: getfb2-into-addfb2
[527.783625] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[528.008141] [108/133] (515s left) gem_close (basic)
[528.056290] Starting subtest: basic
[528.057207] Subtest basic: SUCCESS (0.000s)
[528.258393] [109/133] (515s left) gem_exec_schedule (preemptive-hang)
[528.453817] Starting subtest: preemptive-hang
[528.454744] Starting dynamic subtest: rcs0
[538.278056] Dynamic subtest rcs0: SUCCESS (9.833s)
[538.291313] Starting dynamic subtest: bcs0
[547.297789] Dynamic subtest bcs0: SUCCESS (9.020s)
[547.311154] Starting dynamic subtest: vcs0
[556.266835] Dynamic subtest vcs0: SUCCESS (8.968s)
[556.278792] Starting dynamic subtest: vcs1
[565.291525] Dynamic subtest vcs1: SUCCESS (9.024s)
[565.303541] Starting dynamic subtest: vecs0
[574.306809] Dynamic subtest vecs0: SUCCESS (9.014s)
[574.307676] Subtest preemptive-hang: SUCCESS (45.870s)
[574.636150] [110/133] (469s left) i915_drm_fdinfo (virtual-busy-idle)
[574.687198] Starting subtest: virtual-busy-idle
[574.688774] Subtest virtual-busy-idle: SKIP (0.000s)
[574.837556] [111/133] (468s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[576.325683] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[576.327299] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[576.595534] [112/133] (467s left) gem_linear_blits (interruptible)
[576.858908] Starting subtest: interruptible
[585.252284] Subtest interruptible: SUCCESS (8.389s)
[585.416955] [113/133] (458s left) gem_ctx_persistence (engines-mixed)
[585.510729] Starting subtest: engines-mixed
[585.511649] Starting dynamic subtest: rcs0
[585.574658] Dynamic subtest rcs0: SUCCESS (0.063s)
[585.588573] Starting dynamic subtest: bcs0
[585.634645] Dynamic subtest bcs0: SUCCESS (0.059s)
[585.654035] Starting dynamic subtest: vcs0
[585.696477] Dynamic subtest vcs0: SUCCESS (0.059s)
[585.743758] Starting dynamic subtest: vcs1
[585.779743] Dynamic subtest vcs1: SUCCESS (0.078s)
[585.801427] Starting dynamic subtest: vecs0
[585.831785] Dynamic subtest vecs0: SUCCESS (0.050s)
[585.835470] Subtest engines-mixed: SUCCESS (0.322s)
[586.086634] [114/133] (458s left) perf_pmu (init-wait)
[586.138291] Starting subtest: init-wait
[586.139321] Starting dynamic subtest: rcs0
[586.140292] Dynamic subtest rcs0: SUCCESS (0.002s)
[586.154048] Starting dynamic subtest: bcs0
[586.155054] Dynamic subtest bcs0: SUCCESS (0.001s)
[586.166997] Starting dynamic subtest: vcs0
[586.168209] Dynamic subtest vcs0: SUCCESS (0.001s)
[586.180157] Starting dynamic subtest: vcs1
[586.181522] Dynamic subtest vcs1: SUCCESS (0.001s)
[586.193591] Starting dynamic subtest: vecs0
[586.194790] Dynamic subtest vecs0: SUCCESS (0.001s)
[586.196037] Subtest init-wait: SUCCESS (0.012s)
[586.279950] [115/133] (457s left) gem_exec_reloc (basic-gtt-cpu-active)
[586.330880] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[586.431550] [116/133] (457s left) kms_pm_lpsp (screens-disabled)
[588.934309] Starting subtest: screens-disabled
[588.936077] Subtest screens-disabled: SKIP (0.000s)
[589.149737] [117/133] (455s left) kms_flip (flip-vs-expired-vblank-interruptible)
[590.638919] Starting subtest: flip-vs-expired-vblank-interruptible
[590.646178] Starting dynamic subtest: A-HDMI-A3
[598.461653] Dynamic subtest A-HDMI-A3: SUCCESS (7.816s)
[598.480964] Starting dynamic subtest: B-HDMI-A3
[606.127978] Dynamic subtest B-HDMI-A3: SUCCESS (7.663s)
[606.170273] Starting dynamic subtest: C-HDMI-A3
[613.810713] Dynamic subtest C-HDMI-A3: SUCCESS (7.675s)
[613.827465] Starting dynamic subtest: D-HDMI-A3
[621.479546] Dynamic subtest D-HDMI-A3: SUCCESS (7.667s)
[621.482097] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.843s)
[621.739803] [118/133] (422s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[623.228411] Starting subtest: psr-1p-primscrn-cur-indfb-move
[623.230072] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[623.498482] [119/133] (421s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[624.982961] Starting subtest: plane-all-modeset-transition-internal-panels
[624.984927] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[625.177759] [120/133] (419s left) gem_userptr_blits (stress-mm)
[625.236840] Starting subtest: stress-mm
[630.609859] Subtest stress-mm: SUCCESS (5.369s)
[630.845777] [121/133] (413s left) syncobj_eventfd (invalid-bad-flags)
[630.896952] Starting subtest: invalid-bad-flags
[630.897860] Subtest invalid-bad-flags: SUCCESS (0.000s)
[631.077286] [122/133] (413s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[631.123736] Starting subtest: framebuffer-vs-set-tiling
[631.125563] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[632.834731] [123/133] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[634.325061] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[634.327200] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[634.576954] [124/133] (410s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[634.622632] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[634.623544] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[634.828678] [125/133] (410s left) kms_flip (2x-modeset-vs-vblank-race)
[636.313256] Starting subtest: 2x-modeset-vs-vblank-race
[636.331882] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[636.548683] [126/133] (408s left) i915_query (query-regions-garbage-items)
[636.610351] Starting subtest: query-regions-garbage-items
[636.611290] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[636.795334] [127/133] (408s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[636.840468] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[636.944222] [128/133] (408s left) gem_exec_balancer (full-late)
[636.998470] Starting subtest: full-late
[639.320663] Subtest full-late: SUCCESS (2.322s)
[639.804080] [129/133] (405s left) gem_exec_reloc (basic-write-wc)
[639.854286] Subtest basic-write-wc: SKIP (0.000s)
[639.970962] [130/133] (405s left) kms_force_connector_basic (force-load-detect)
[640.101095] Starting subtest: force-load-detect
[640.102872] Subtest force-load-detect: SKIP (0.000s)
[641.070401] [131/133] (404s left) kms_chamelium_hpd (hdmi-hpd-fast)
[642.595403] Subtest hdmi-hpd-fast: SKIP (0.000s)
[642.714994] [132/133] (403s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[644.199906] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[644.200898] Starting dynamic subtest: pipe-A-valid-mode
[645.022921] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.822s)
[645.023901] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.824s)
[645.266558] [133/133] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[646.755207] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[646.756883] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[646.974586] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
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: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.