[63.693573] Initializing watchdogs
[63.693623]   /dev/watchdog0
[63.707861] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[63.712332] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.714771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.718429] [001/133] (960s left) i915_drm_fdinfo (memory-info-shared)
[63.779796] Starting subtest: memory-info-shared
[63.782314] Starting dynamic subtest: smem0
[63.834623] Dynamic subtest smem0: SUCCESS (0.055s)
[63.837099] Subtest memory-info-shared: SUCCESS (0.055s)
[63.920602] [002/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[64.000261] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[64.045311] Starting dynamic subtest: pipe-A-plane-0
[64.478704] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[64.486871] Starting dynamic subtest: pipe-A-plane-3
[64.734526] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[64.741465] Starting dynamic subtest: pipe-A-plane-5
[64.745093] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[65.816049] Starting dynamic subtest: pipe-B-plane-0
[66.253796] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[66.261241] Starting dynamic subtest: pipe-B-plane-3
[66.553809] Dynamic subtest pipe-B-plane-3: SUCCESS (0.299s)
[66.560886] Starting dynamic subtest: pipe-B-plane-5
[66.565495] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[66.875257] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.873s)
[67.704749] [003/133] (956s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[67.873836] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[67.878531] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[67.952668] [004/133] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[68.157444] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[68.159877] Starting dynamic subtest: pipe-A-eDP-1
[68.453219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.264s)
[68.460151] Starting dynamic subtest: pipe-B-eDP-1
[69.791774] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[69.799750] Starting dynamic subtest: pipe-C-eDP-1
[71.091449] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[71.100354] Starting dynamic subtest: pipe-D-eDP-1
[72.326394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[72.328824] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.140s)
[73.433032] [005/133] (950s left) fbdev (info)
[73.481186] Starting subtest: info
[73.483575] Subtest info: SUCCESS (0.000s)
[73.542438] [006/133] (950s left) prime_vgem (coherency-blt)
[73.654084] Starting subtest: coherency-blt
[74.816633] Subtest coherency-blt: SUCCESS (1.160s)
[74.950559] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[74.953846] [007/133] (949s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[75.037395] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[75.039783] Starting dynamic subtest: pipe-A-eDP-1
[75.070971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.078995] Starting dynamic subtest: pipe-B-eDP-1
[75.099558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.106483] Starting dynamic subtest: pipe-C-eDP-1
[75.127331] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.134220] Starting dynamic subtest: pipe-D-eDP-1
[75.156246] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.160257] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[77.207705] [008/133] (947s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[77.264877] Starting subtest: invalid-single-wait-all-unsubmitted
[77.266847] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[77.352782] [009/133] (947s left) api_intel_bb (simple-bb)
[77.404496] Starting subtest: simple-bb
[77.409336] Subtest simple-bb: SUCCESS (0.007s)
[77.524185] [010/133] (947s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[77.609960] Starting subtest: multiplane-rotation-cropping-bottom
[95.011952] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.404s)
[95.115419] [011/133] (929s left) kms_plane_multiple (tiling-4)
[95.230221] Starting subtest: tiling-4
[95.231813] Starting dynamic subtest: pipe-A-eDP-1
[98.988060] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.758s)
[98.996054] Starting dynamic subtest: pipe-B-eDP-1
[103.493239] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.503s)
[103.501852] Starting dynamic subtest: pipe-C-eDP-1
[107.813230] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.319s)
[107.822252] Starting dynamic subtest: pipe-D-eDP-1
[112.153323] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.338s)
[112.155492] Subtest tiling-4: SUCCESS (16.923s)
[112.952365] [012/133] (911s left) kms_content_protection (atomic-dpms-hdcp14)
[113.096841] Starting subtest: atomic-dpms-hdcp14
[113.101338] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[113.216478] [013/133] (911s left) i915_pciid
[113.366508] [014/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[113.458643] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[113.462734] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.554901] [015/133] (911s left) gem_ctx_isolation (preservation-reset)
[113.726312] Starting subtest: preservation-reset
[113.729302] Starting dynamic subtest: rcs0
[114.014242] Dynamic subtest rcs0: SUCCESS (0.288s)
[114.026033] Starting dynamic subtest: bcs0
[114.345135] Dynamic subtest bcs0: SUCCESS (0.330s)
[114.352939] Starting dynamic subtest: vcs0
[114.673801] Dynamic subtest vcs0: SUCCESS (0.328s)
[114.681620] Starting dynamic subtest: vcs1
[116.296585] Dynamic subtest vcs1: SUCCESS (1.622s)
[116.307322] Starting dynamic subtest: vecs0
[118.150087] Dynamic subtest vecs0: SUCCESS (1.853s)
[118.160700] Starting dynamic subtest: ccs0
[120.214481] Dynamic subtest ccs0: SUCCESS (2.064s)
[120.216889] Subtest preservation-reset: SUCCESS (6.492s)
[120.352881] [016/133] (904s left) syncobj_wait (invalid-reset-bad-pad)
[120.408623] Starting subtest: invalid-reset-bad-pad
[120.410843] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[120.518185] [017/133] (904s left) gem_mmap_wc (set-cache-level)
[120.576709] Subtest set-cache-level: SKIP (0.000s)
[120.632041] [018/133] (904s left) kms_invalid_mode (uint-max-clock)
[120.732156] Starting subtest: uint-max-clock
[120.734408] Starting dynamic subtest: pipe-A-eDP-1
[121.022827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[121.031248] Starting dynamic subtest: pipe-B-eDP-1
[121.033225] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[121.040636] Starting dynamic subtest: pipe-C-eDP-1
[121.042615] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.050277] Starting dynamic subtest: pipe-D-eDP-1
[121.052532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[121.054767] Subtest uint-max-clock: SUCCESS (0.298s)
[121.892652] [019/133] (903s left) perf_pmu (busy-no-semaphores)
[121.937959] Starting subtest: busy-no-semaphores
[121.940320] Starting dynamic subtest: rcs0
[122.502875] Dynamic subtest rcs0: SUCCESS (0.564s)
[122.514333] Starting dynamic subtest: bcs0
[123.055094] Dynamic subtest bcs0: SUCCESS (0.550s)
[123.066200] Starting dynamic subtest: vcs0
[123.607440] Dynamic subtest vcs0: SUCCESS (0.549s)
[123.618930] Starting dynamic subtest: vcs1
[125.399764] Dynamic subtest vcs1: SUCCESS (1.789s)
[125.411220] Starting dynamic subtest: vecs0
[127.448521] Dynamic subtest vecs0: SUCCESS (2.046s)
[127.460281] Starting dynamic subtest: ccs0
[129.434541] Dynamic subtest ccs0: SUCCESS (1.983s)
[129.437573] Subtest busy-no-semaphores: SUCCESS (7.498s)
[129.551485] [020/133] (895s left) gem_spin_batch (engines)
[129.625395] Starting subtest: engines
[129.627814] Starting dynamic subtest: rcs0
[132.866992] Dynamic subtest rcs0: SUCCESS (3.237s)
[132.877654] Starting dynamic subtest: bcs0
[136.102793] Dynamic subtest bcs0: SUCCESS (3.233s)
[136.112723] Starting dynamic subtest: vcs0
[139.339650] Dynamic subtest vcs0: SUCCESS (3.235s)
[139.350336] Starting dynamic subtest: vcs1
[142.577913] Dynamic subtest vcs1: SUCCESS (3.236s)
[142.588773] Starting dynamic subtest: vecs0
[145.817277] Dynamic subtest vecs0: SUCCESS (3.235s)
[145.827633] Starting dynamic subtest: ccs0
[149.053955] Dynamic subtest ccs0: SUCCESS (3.235s)
[149.056517] Subtest engines: SUCCESS (19.424s)
[149.299421] [021/133] (875s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[149.409445] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[149.413696] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[149.526590] [022/133] (875s left) kms_chamelium_color (gamma)
[149.614863] Subtest gamma: SKIP (0.000s)
[149.661587] [023/133] (875s left) i915_pm_rpm (gem-execbuf-stress)
[151.227712] Starting subtest: gem-execbuf-stress
[151.229890] Starting dynamic subtest: smem0
[164.139684] Dynamic subtest smem0: SUCCESS (12.911s)
[164.149659] Starting dynamic subtest: extra-wait-smem0
[225.912604] Dynamic subtest extra-wait-smem0: SUCCESS (61.769s)
[225.915710] Subtest gem-execbuf-stress: SUCCESS (74.687s)
[226.291322] [024/133] (798s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[226.404546] Starting subtest: flip-vs-cursor-crc-atomic
[227.104051] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.698s)
[227.913754] [025/133] (797s left) gem_mmap_offset (partial-mmap)
[227.964459] Starting subtest: partial-mmap
[227.966970] Starting dynamic subtest: smem0
[227.969485] Dynamic subtest smem0: SUCCESS (0.003s)
[227.971793] Subtest partial-mmap: SUCCESS (0.004s)
[228.062414] [026/133] (797s left) gem_exec_reloc (basic-wc-read-active)
[228.128936] Subtest basic-wc-read-active: SKIP (0.000s)
[228.204260] [027/133] (797s left) prime_self_import (basic-with_two_bos)
[228.245162] Starting subtest: basic-with_two_bos
[228.264046] Subtest basic-with_two_bos: SUCCESS (0.023s)
[228.379199] [028/133] (796s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[228.477179] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[228.479395] Starting dynamic subtest: pipe-A-eDP-1
[229.354891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s)
[229.364063] Starting dynamic subtest: pipe-B-eDP-1
[231.009426] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.652s)
[231.018358] Starting dynamic subtest: pipe-C-eDP-1
[232.569177] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.559s)
[232.578181] Starting dynamic subtest: pipe-D-eDP-1
[234.098936] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[234.101174] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.615s)
[235.265060] [029/133] (790s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[235.365958] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[236.201720] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[236.375587] [030/133] (789s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[236.468407] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[236.472526] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[236.569200] [031/133] (788s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[236.630167] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[236.632390] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[236.757158] [032/133] (788s left) gem_linear_blits (normal)
[237.158236] Starting subtest: normal
[241.248237] Subtest normal: SUCCESS (4.089s)
[241.396730] [033/133] (784s left) gen7_exec_parse (basic-offset)
[241.495480] Subtest basic-offset: SKIP (0.000s)
[241.566106] [034/133] (784s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[241.667274] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[241.671633] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[241.759471] [035/133] (783s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[242.396961] Starting subtest: syncobj-backward-timeline-chain-engines
[242.518622] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.125s)
[243.942215] [036/133] (781s left) kms_vrr (flip-basic)
[244.031204] Starting subtest: flip-basic
[244.037188] Subtest flip-basic: SKIP (0.000s)
[244.104107] [037/133] (781s left) gem_exec_params (readonly)
[244.165091] Starting subtest: readonly
[244.167390] Subtest readonly: SUCCESS (0.002s)
[244.285443] [038/133] (781s left) syncobj_timeline (single-wait-for-submit-signaled)
[244.353148] Starting subtest: single-wait-for-submit-signaled
[244.355311] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[244.451339] [039/133] (781s left) gem_lmem_swapping (basic)
[244.497243] Subtest basic: SKIP (0.000s)
[244.536926] [040/133] (781s left) gem_exec_balancer (hang)
[244.792632] Starting subtest: hang
[246.940142] Subtest hang: SUCCESS (2.150s)
[247.020960] [041/133] (778s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[247.122801] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[247.126755] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[247.220973] [042/133] (778s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[247.342308] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[247.347033] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[247.485427] [043/133] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[247.582812] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[254.655375] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.075s)
[254.768653] [044/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[254.867611] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[254.872079] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[254.969507] [045/133] (771s left) gem_exec_endless (dispatch)
[255.038549] Starting subtest: dispatch
[255.041046] Starting dynamic subtest: rcs0
[255.045609] Dynamic subtest rcs0: SUCCESS (0.007s)
[255.061134] Starting dynamic subtest: bcs0
[255.065505] Dynamic subtest bcs0: SUCCESS (0.004s)
[255.076730] Starting dynamic subtest: vcs0
[255.080918] Dynamic subtest vcs0: SUCCESS (0.005s)
[255.089499] Starting dynamic subtest: vcs1
[255.093630] Dynamic subtest vcs1: SUCCESS (0.004s)
[255.101757] Starting dynamic subtest: vecs0
[255.105703] Dynamic subtest vecs0: SUCCESS (0.005s)
[255.113744] Starting dynamic subtest: ccs0
[255.117632] Dynamic subtest ccs0: SUCCESS (0.004s)
[255.119481] Subtest dispatch: SUCCESS (0.034s)
[256.956065] [046/133] (769s left) perf (gen12-invalid-class-instance)
[257.105468] Starting subtest: gen12-invalid-class-instance
[257.115937] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[257.155545] [047/133] (769s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[257.218700] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[257.221047] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[257.330839] [048/133] (768s left) api_intel_bb (blit-reloc-purge-cache)
[257.394900] Starting subtest: blit-reloc-purge-cache
[257.399431] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[257.521902] [049/133] (768s left) gem_madvise (dontneed-after-mmap)
[257.569926] Starting subtest: dontneed-after-mmap
[257.595066] Subtest dontneed-after-mmap: SUCCESS (0.028s)
[257.704692] [050/133] (768s left) gem_tiled_fence_blits (normal)
[257.762471] Subtest normal: SKIP (0.000s)
[257.843503] [051/133] (768s left) kms_flip (flip-vs-panning)
[257.943614] Starting subtest: flip-vs-panning
[257.945246] Starting dynamic subtest: A-eDP1
[266.715301] Dynamic subtest A-eDP1: SUCCESS (8.770s)
[266.725507] Starting dynamic subtest: B-eDP1
[275.450571] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[275.464980] Starting dynamic subtest: C-eDP1
[284.168484] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[284.180131] Starting dynamic subtest: D-eDP1
[292.894823] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[292.899257] Subtest flip-vs-panning: SUCCESS (34.955s)
[294.063886] [052/133] (732s left) kms_draw_crc (draw-method-render)
[294.163435] Starting subtest: draw-method-render
[294.165486] Starting dynamic subtest: xrgb8888-untiled
[294.417098] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[294.426023] Starting dynamic subtest: rgb565-untiled
[294.672085] Dynamic subtest rgb565-untiled: SUCCESS (0.253s)
[294.683975] Starting dynamic subtest: xrgb2101010-untiled
[294.906833] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s)
[294.922514] Starting dynamic subtest: xbgr16161616f-untiled
[295.138913] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[295.151534] Starting dynamic subtest: xrgb8888-xtiled
[295.262133] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[295.270700] Starting dynamic subtest: rgb565-xtiled
[295.382909] Dynamic subtest rgb565-xtiled: SUCCESS (0.120s)
[295.392064] Starting dynamic subtest: xrgb2101010-xtiled
[295.505814] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[295.515246] Starting dynamic subtest: xbgr16161616f-xtiled
[295.639048] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[295.650485] Starting dynamic subtest: xrgb8888-4tiled
[295.772139] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.131s)
[295.781126] Starting dynamic subtest: rgb565-4tiled
[295.883244] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[295.892387] Starting dynamic subtest: xrgb2101010-4tiled
[296.005662] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[296.014986] Starting dynamic subtest: xbgr16161616f-4tiled
[296.139279] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[296.141280] Subtest draw-method-render: SUCCESS (1.979s)
[296.242625] [053/133] (730s left) kms_atomic_interruptible (universal-setplane-primary)
[296.340559] Starting subtest: universal-setplane-primary
[296.342488] Starting dynamic subtest: pipe-A-eDP-1
[303.764850] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.423s)
[303.767335] Subtest universal-setplane-primary: SUCCESS (7.425s)
[304.617934] [054/133] (721s left) gem_exec_schedule (u-fairslice)
[304.695078] Starting subtest: u-fairslice
[304.697583] Starting dynamic subtest: rcs0
[306.734026] Dynamic subtest rcs0: SUCCESS (2.036s)
[306.743702] Starting dynamic subtest: bcs0
[308.757874] Dynamic subtest bcs0: SUCCESS (2.021s)
[308.767559] Starting dynamic subtest: vcs0
[310.781119] Dynamic subtest vcs0: SUCCESS (2.023s)
[310.792808] Starting dynamic subtest: vcs1
[312.804455] Dynamic subtest vcs1: SUCCESS (2.021s)
[312.814659] Starting dynamic subtest: vecs0
[314.827212] Dynamic subtest vecs0: SUCCESS (2.020s)
[314.837571] Starting dynamic subtest: ccs0
[316.850251] Dynamic subtest ccs0: SUCCESS (2.024s)
[316.852499] Subtest u-fairslice: SUCCESS (12.151s)
[317.156830] [055/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[317.259685] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[317.263745] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[317.363468] [056/133] (709s left) i915_query (query-topology-kernel-writes)
[317.410746] Starting subtest: query-topology-kernel-writes
[317.412585] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[317.498176] [057/133] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[317.610568] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[317.614620] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[317.692169] [058/133] (708s left) gem_mmap_gtt (basic-small-bo)
[317.766915] Subtest basic-small-bo: SKIP (0.000s)
[317.834681] [059/133] (708s left) gem_exec_params (invalid-flag)
[317.893425] Starting subtest: invalid-flag
[317.895755] Subtest invalid-flag: SUCCESS (0.000s)
[317.988695] [060/133] (708s left) gem_exec_async (forked-writes)
[318.045639] Starting subtest: forked-writes
[318.048064] Starting dynamic subtest: rcs0
[318.074812] Dynamic subtest rcs0: SUCCESS (0.029s)
[318.088819] Starting dynamic subtest: bcs0
[318.100734] Dynamic subtest bcs0: SUCCESS (0.025s)
[318.110182] Starting dynamic subtest: vcs0
[318.123605] Dynamic subtest vcs0: SUCCESS (0.022s)
[318.132749] Starting dynamic subtest: vcs1
[318.147982] Dynamic subtest vcs1: SUCCESS (0.023s)
[318.157024] Starting dynamic subtest: vecs0
[318.174087] Dynamic subtest vecs0: SUCCESS (0.025s)
[318.183587] Starting dynamic subtest: ccs0
[318.197121] Dynamic subtest ccs0: SUCCESS (0.022s)
[318.198993] Subtest forked-writes: SUCCESS (0.152s)
[318.416741] [061/133] (708s left) gem_tiled_pread_basic (basic)
[318.476275] Subtest basic: SKIP (0.000s)
[318.534059] [062/133] (708s left) kms_cursor_crc (cursor-random-32x10)
[318.719585] Starting subtest: cursor-random-32x10
[318.775111] Subtest cursor-random-32x10: SKIP (0.050s)
[319.079426] [063/133] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[319.173462] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[326.437226] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.266s)
[326.582822] [064/133] (700s left) gem_exec_nop (basic-series)
[326.662876] Starting subtest: basic-series
[341.312670] Subtest basic-series: SUCCESS (14.658s)
[341.556697] [065/133] (685s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[341.665739] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[341.670338] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[341.759821] [066/133] (685s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[341.822688] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[341.878638] [067/133] (685s left) gem_eio (wait-1us)
[342.125888] Starting subtest: wait-1us
[342.559610] Subtest wait-1us: SUCCESS (0.435s)
[342.700660] [068/133] (684s left) sysfs_timeslice_duration (duration)
[342.752291] Starting subtest: duration
[342.754356] Starting dynamic subtest: vecs0
[357.811843] Dynamic subtest vecs0: SUCCESS (15.055s)
[357.824027] Starting dynamic subtest: ccs0
[370.946342] Dynamic subtest ccs0: SUCCESS (13.133s)
[370.958028] Starting dynamic subtest: vcs0
[384.819307] Dynamic subtest vcs0: SUCCESS (13.868s)
[384.831737] Starting dynamic subtest: bcs0
[397.980438] Dynamic subtest bcs0: SUCCESS (13.159s)
[397.992923] Starting dynamic subtest: rcs0
[411.114974] Dynamic subtest rcs0: SUCCESS (13.132s)
[411.126367] Starting dynamic subtest: vcs1
[424.819105] Dynamic subtest vcs1: SUCCESS (13.700s)
[424.821766] Subtest duration: SUCCESS (82.063s)
[424.923119] [069/133] (602s left) gem_fenced_exec_thrash (too-many-fences)
[424.993441] Subtest too-many-fences: SKIP (0.000s)
[425.068752] [070/133] (602s left) gem_eio (wait-wedge-10ms)
[425.262239] Starting subtest: wait-wedge-10ms
[426.960154] Subtest wait-wedge-10ms: SUCCESS (1.698s)
[427.080808] [071/133] (600s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[427.181844] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[427.186307] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[427.270550] [072/133] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[427.375814] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[434.141879] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.768s)
[434.271389] [073/133] (593s left) i915_selftest (mock)
[435.989319] Starting subtest: mock
[435.992468] Starting dynamic subtest: sanitycheck
[436.724377] Dynamic subtest sanitycheck: SUCCESS (0.734s)
[436.734163] Starting dynamic subtest: shmem
[437.375110] Dynamic subtest shmem: SUCCESS (0.649s)
[437.384710] Starting dynamic subtest: fence
[445.005896] Dynamic subtest fence: SUCCESS (7.628s)
[445.015815] Starting dynamic subtest: scatterlist
[446.704812] Dynamic subtest scatterlist: SUCCESS (1.697s)
[446.714566] Starting dynamic subtest: syncmap
[449.910224] Dynamic subtest syncmap: SUCCESS (3.203s)
[449.919946] Starting dynamic subtest: uncore
[450.572142] Dynamic subtest uncore: SUCCESS (0.660s)
[450.579905] Starting dynamic subtest: ring
[451.239481] Dynamic subtest ring: SUCCESS (0.665s)
[451.249912] Starting dynamic subtest: engine
[451.896169] Dynamic subtest engine: SUCCESS (0.655s)
[451.905649] Starting dynamic subtest: timelines
[455.714597] Dynamic subtest timelines: SUCCESS (3.816s)
[455.728673] Starting dynamic subtest: requests
[459.146059] Dynamic subtest requests: SUCCESS (3.430s)
[459.155213] Starting dynamic subtest: objects
[459.930441] Dynamic subtest objects: SUCCESS (0.783s)
[459.939711] Starting dynamic subtest: phys
[460.669924] Dynamic subtest phys: SUCCESS (0.738s)
[460.676872] Starting dynamic subtest: dmabuf
[461.433107] Dynamic subtest dmabuf: SUCCESS (0.762s)
[461.442804] Starting dynamic subtest: vma
[467.199996] Dynamic subtest vma: SUCCESS (5.765s)
[467.209468] Starting dynamic subtest: evict
[468.591922] Dynamic subtest evict: SUCCESS (1.390s)
[468.601059] Starting dynamic subtest: gtt
[471.895385] Dynamic subtest gtt: SUCCESS (3.302s)
[471.904343] Starting dynamic subtest: hugepages
[472.802265] Dynamic subtest hugepages: SUCCESS (0.905s)
[472.811449] Starting dynamic subtest: memory_region
[475.404648] Dynamic subtest memory_region: SUCCESS (2.600s)
[475.407514] Subtest mock: SUCCESS (39.414s)
[475.437403] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[475.438113] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[475.441318] [074/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[477.049138] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[477.053515] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[477.141443] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[477.142746] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)] new: kernel.kmod_is_loaded.i915: true
[477.146512] [075/133] (550s left) gem_pxp (display-protected-crc)
[477.280855] Starting subtest: display-protected-crc
[479.016405] Subtest display-protected-crc: SUCCESS (1.739s)
[479.134927] [076/133] (548s left) gem_exec_params (invalid-ring2)
[479.189835] Starting subtest: invalid-ring2
[479.192388] Subtest invalid-ring2: SUCCESS (0.000s)
[479.286625] [077/133] (548s left) kms_psr (fbc-pr-cursor-render)
[479.382205] Starting subtest: fbc-pr-cursor-render
[479.386243] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[479.473857] [078/133] (548s left) gem_ctx_shared (create-shared-gtt)
[479.527579] Starting subtest: create-shared-gtt
[481.679776] Subtest create-shared-gtt: SUCCESS (2.151s)
[482.045635] [079/133] (545s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[482.145188] Starting subtest: primary-y-tiled-reflect-x-270
[482.149798] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[482.217681] [080/133] (545s left) kms_psr (fbc-psr-sprite-plane-onoff)
[482.312368] Starting subtest: fbc-psr-sprite-plane-onoff
[482.314685] Starting dynamic subtest: eDP-1
[482.318734] Dynamic subtest eDP-1: SKIP (0.000s)
[482.322830] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[482.386687] [081/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[482.481807] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[486.064738] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.587s)
[487.305707] [082/133] (540s left) gem_ctx_engines (execute-oneforall)
[487.373661] Starting subtest: execute-oneforall
[487.924877] Subtest execute-oneforall: SUCCESS (0.551s)
[489.027664] [083/133] (538s left) kms_psr (psr2-sprite-mmap-cpu)
[489.117214] Starting subtest: psr2-sprite-mmap-cpu
[489.119475] Starting dynamic subtest: eDP-1
[490.854433] Dynamic subtest eDP-1: SUCCESS (1.735s)
[490.856685] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.736s)
[491.728019] [084/133] (536s left) kms_flip (2x-flip-vs-dpms-on-nop)
[491.826179] Starting subtest: 2x-flip-vs-dpms-on-nop
[491.834690] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[491.946785] [085/133] (535s left) dmabuf_sync_file (export-basic)
[491.996549] Starting subtest: export-basic
[491.998505] Subtest export-basic: SUCCESS (0.001s)
[492.067559] [086/133] (535s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[492.160485] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[492.254316] [087/133] (535s left) kms_getfb (getfb-handle-not-fb)
[492.363187] Starting subtest: getfb-handle-not-fb
[492.365468] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[492.457889] [088/133] (535s left) gem_userptr_blits (sync-unmap-cycles)
[492.524640] Starting subtest: sync-unmap-cycles
[497.899814] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[498.042086] [089/133] (529s left) gem_softpin (overlap)
[498.105326] Starting subtest: overlap
[499.035858] Subtest overlap: SUCCESS (0.931s)
[499.156054] [090/133] (528s left) kms_dp_link_training (uhbr-mst)
[499.248847] Starting subtest: uhbr-mst
[499.257141] Subtest uhbr-mst: SKIP (0.000s)
[499.321403] [091/133] (528s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[499.441589] Starting subtest: flip-vs-cursor-crc-legacy
[500.120801] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.679s)
[500.956707] [092/133] (527s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[501.053802] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[501.056147] Starting dynamic subtest: pipe-A
[501.077709] Dynamic subtest pipe-A: SKIP (0.019s)
[501.087421] Starting dynamic subtest: pipe-B
[501.115193] Dynamic subtest pipe-B: SKIP (0.038s)
[501.124153] Starting dynamic subtest: pipe-C
[501.151720] Dynamic subtest pipe-C: SKIP (0.038s)
[501.160226] Starting dynamic subtest: pipe-D
[501.191528] Dynamic subtest pipe-D: SKIP (0.037s)
[501.195958] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.134s)
[501.294941] [093/133] (526s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[501.396813] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[508.271246] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.877s)
[508.384426] [094/133] (519s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[508.437388] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[508.546055] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[508.625167] [095/133] (519s left) kms_cursor_crc (cursor-sliding-max-size)
[508.934566] Starting subtest: cursor-sliding-max-size
[508.941323] Subtest cursor-sliding-max-size: SKIP (0.000s)
[509.066410] [096/133] (519s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[509.155493] Starting subtest: nonblocking-crc-frame-sequence
[509.157451] Starting dynamic subtest: pipe-A-eDP-1
[509.902981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s)
[509.914829] Starting dynamic subtest: pipe-B-eDP-1
[511.366733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.465s)
[511.379065] Starting dynamic subtest: pipe-C-eDP-1
[512.694048] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.323s)
[512.702802] Starting dynamic subtest: pipe-D-eDP-1
[514.026905] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[514.029214] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.873s)
[514.832778] [097/133] (513s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[515.217525] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[516.025584] [098/133] (512s left) gem_render_copy_redux (interruptible)
[516.087107] Starting subtest: interruptible
[516.365755] Subtest interruptible: SUCCESS (0.280s)
[516.500591] [099/133] (511s left) kms_psr (pr-primary-blt)
[516.587219] Starting subtest: pr-primary-blt
[516.591650] Subtest pr-primary-blt: SKIP (0.000s)
[516.674975] [100/133] (511s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[516.787602] Starting subtest: cursor-vs-flip-legacy
[546.298689] Subtest cursor-vs-flip-legacy: SUCCESS (29.510s)
[547.182295] [101/133] (481s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[547.294807] Starting subtest: 4-tiled-16bpp-rotate-90
[547.319231] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.024s)
[547.434202] [102/133] (481s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[547.548673] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[547.552666] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[547.646885] [103/133] (480s left) gem_shrink (reclaim)
[547.707670] Starting subtest: reclaim
[550.121981] Subtest reclaim: SUCCESS (2.408s)
[550.268043] [104/133] (478s left) sw_sync (alloc_fence)
[550.301339] Starting subtest: alloc_fence
[550.303308] Subtest alloc_fence: SUCCESS (0.000s)
[550.368920] [105/133] (478s left) kms_cursor_crc (cursor-onscreen-32x10)
[550.546073] Starting subtest: cursor-onscreen-32x10
[550.594364] Subtest cursor-onscreen-32x10: SKIP (0.044s)
[550.858448] [106/133] (477s left) kms_pm_rpm (universal-planes)
[553.086064] Starting subtest: universal-planes
[553.088441] Starting dynamic subtest: plane-34
[561.519933] Dynamic subtest plane-34: SUCCESS (8.434s)
[561.531707] Starting dynamic subtest: plane-64
[569.936030] Dynamic subtest plane-64: SUCCESS (8.412s)
[569.948986] Starting dynamic subtest: plane-94
[578.341852] Dynamic subtest plane-94: SUCCESS (8.404s)
[578.352554] Starting dynamic subtest: plane-124
[586.658223] Dynamic subtest plane-124: SUCCESS (8.313s)
[586.670172] Starting dynamic subtest: plane-134
[595.056369] Dynamic subtest plane-134: SUCCESS (8.394s)
[595.068579] Starting dynamic subtest: plane-144
[603.391035] Dynamic subtest plane-144: SUCCESS (8.332s)
[603.393865] Subtest universal-planes: SUCCESS (50.308s)
[603.766447] [107/133] (424s left) gem_mmap (short-mmap)
[603.833810] Subtest short-mmap: SKIP (0.000s)
[603.900967] [108/133] (424s left) gem_exec_schedule (independent)
[603.973076] Starting subtest: independent
[603.975295] Starting dynamic subtest: rcs0
[605.908800] Dynamic subtest rcs0: SUCCESS (1.943s)
[605.921449] Starting dynamic subtest: vcs0
[607.898928] Dynamic subtest vcs0: SUCCESS (1.987s)
[607.910851] Starting dynamic subtest: vcs1
[609.891340] Dynamic subtest vcs1: SUCCESS (1.991s)
[609.903084] Starting dynamic subtest: vecs0
[611.941748] Dynamic subtest vecs0: SUCCESS (2.048s)
[611.953661] Starting dynamic subtest: ccs0
[613.909108] Dynamic subtest ccs0: SUCCESS (1.965s)
[613.911719] Subtest independent: SUCCESS (9.945s)
[614.227654] [109/133] (414s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[614.326972] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[614.951650] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[615.104582] [110/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[615.200128] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[615.204075] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[615.300890] [111/133] (413s left) gem_render_copy (y-tiled-to-vebox-linear)
[615.356595] Starting subtest: y-tiled-to-vebox-linear
[615.360931] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[615.541543] [112/133] (413s left) kms_joiner (invalid-modeset-ultra-joiner)
[615.635651] Starting subtest: invalid-modeset-ultra-joiner
[615.640107] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[615.701924] [113/133] (413s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[615.750924] Starting subtest: etime-single-wait-for-submit-submitted
[615.856902] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[615.946571] [114/133] (413s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[616.054179] Starting subtest: psr-rgb101010-draw-mmap-cpu
[623.147952] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.093s)
[623.261911] [115/133] (405s left) gem_exec_store (basic)
[623.335820] Starting subtest: basic
[623.438088] Subtest basic: SUCCESS (0.105s)
[623.625787] [116/133] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[623.725865] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[623.730421] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[623.830276] [117/133] (405s left) kms_atomic (atomic-invalid-params)
[623.923048] Starting subtest: atomic-invalid-params
[623.925469] Starting dynamic subtest: pipe-A-eDP-1
[624.325528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[624.328103] Subtest atomic-invalid-params: SUCCESS (0.406s)
[625.121811] [118/133] (404s left) kms_color (legacy-gamma)
[625.209259] Starting subtest: legacy-gamma
[625.211470] Starting dynamic subtest: pipe-A-eDP-1
[625.922854] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[625.932514] Starting dynamic subtest: pipe-B-eDP-1
[628.105053] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.178s)
[628.115568] Starting dynamic subtest: pipe-C-eDP-1
[628.979528] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.875s)
[628.989583] Starting dynamic subtest: pipe-D-eDP-1
[630.310513] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[630.312916] Subtest legacy-gamma: SUCCESS (5.104s)
[631.115419] [119/133] (398s left) kms_busy (extended-modeset-hang-oldfb)
[631.226834] Starting subtest: extended-modeset-hang-oldfb
[631.229412] Starting dynamic subtest: pipe-A
[643.002019] Dynamic subtest pipe-A: SUCCESS (11.773s)
[643.011981] Starting dynamic subtest: pipe-D
[655.273628] Dynamic subtest pipe-D: SUCCESS (12.271s)
[655.276057] Subtest extended-modeset-hang-oldfb: SUCCESS (24.049s)
[656.080441] [120/133] (373s left) gem_close_race (basic-threads)
[656.167650] Starting subtest: basic-threads
[657.604942] Subtest basic-threads: SUCCESS (1.440s)
[657.793325] [121/133] (371s left) kms_pm_backlight (fade)
[657.895432] Starting subtest: fade
[657.946271] Starting dynamic subtest: eDP-1
[660.425352] Dynamic subtest eDP-1: SUCCESS (2.478s)
[660.427738] Subtest fade: SUCCESS (2.529s)
[661.304775] [122/133] (368s left) kms_psr (fbc-pr-primary-mmap-gtt)
[661.406286] Starting subtest: fbc-pr-primary-mmap-gtt
[661.410822] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[661.483119] [123/133] (367s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[661.594828] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[661.599185] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[661.670163] [124/133] (367s left) kms_flip (2x-absolute-wf_vblank)
[661.757080] Starting subtest: 2x-absolute-wf_vblank
[661.766485] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[661.846983] [125/133] (367s left) gem_flink_race (flink_name)
[661.883728] Starting subtest: flink_name
[667.281700] Subtest flink_name: SUCCESS (5.398s)
[667.399965] [126/133] (362s left) kms_chamelium_color (ctm-0-25)
[667.499157] Subtest ctm-0-25: SKIP (0.000s)
[667.545677] [127/133] (362s left) kms_vblank (accuracy-idle)
[667.628205] Starting subtest: accuracy-idle
[667.630069] Starting dynamic subtest: pipe-A-eDP-1
[669.381378] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[669.395529] Starting dynamic subtest: pipe-D-eDP-1
[671.836776] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[671.839217] Subtest accuracy-idle: SUCCESS (4.211s)
[672.643463] [128/133] (356s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[672.744655] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[672.748718] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[672.812738] [129/133] (356s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[672.912425] Starting subtest: x-tiled-8bpp-rotate-180
[674.125699] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.213s)
[674.248381] [130/133] (355s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[674.343805] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[681.280073] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.936s)
[681.410560] [131/133] (348s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[681.505972] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[681.510519] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[681.608345] [132/133] (348s left) gem_pxp (regular-baseline-src-copy-readible)
[681.708644] Starting subtest: regular-baseline-src-copy-readible
[681.775061] Subtest regular-baseline-src-copy-readible: SUCCESS (0.068s)
[681.896071] [133/133] (347s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[681.997259] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[681.999168] Starting dynamic subtest: pipe-A-eDP-1
[682.141589] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[682.152805] Starting dynamic subtest: pipe-B-eDP-1
[682.172746] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[682.181436] Starting dynamic subtest: pipe-C-eDP-1
[682.200670] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[682.209336] Starting dynamic subtest: pipe-D-eDP-1
[682.229053] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[682.231318] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.146s)
[684.429170] Closing watchdogs
results: parsing output: 0/ for test: i915_drm_fdinfo
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: fbdev
results: parsing output: 5/ for test: prime_vgem
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: i915_pciid
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_isolation
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_invalid_mode
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_chamelium_color
results: parsing output: 22/ for test: i915_pm_rpm
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_mmap_offset
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_endless
results: parsing output: 45/ for test: perf
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: gem_madvise
results: parsing output: 49/ for test: gem_tiled_fence_blits
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_draw_crc
results: parsing output: 52/ for test: kms_atomic_interruptible
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_query
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_async
results: parsing output: 60/ for test: gem_tiled_pread_basic
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_nop
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: sysfs_timeslice_duration
results: parsing output: 68/ for test: gem_fenced_exec_thrash
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_selftest
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: gem_exec_params
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_ctx_shared
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_getfb
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: kms_dp_link_training
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: kms_chamelium_hpd
results: parsing output: 97/ for test: gem_render_copy_redux
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_shrink
results: parsing output: 103/ for test: sw_sync
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_joiner
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_store
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_atomic
results: parsing output: 117/ for test: kms_color
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_close_race
results: parsing output: 120/ for test: kms_pm_backlight
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gem_flink_race
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_pxp
results: parsing output: 132/ for test: kms_ccs
Done.