[61.373236] Initializing watchdogs
[61.373315]   /dev/watchdog0
[61.403091] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[61.416904] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.422444] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.425029] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[62.976368] Starting subtest: dp-mst-lic-type-0-hdcp14
[62.978362] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[63.210261] [002/133] (958s left) core_getversion (all-cards)
[63.252218] Starting subtest: all-cards
[63.271903] Subtest all-cards: SUCCESS (0.020s)
[63.334476] [003/133] (958s left) kms_atomic_interruptible (legacy-dpms)
[64.817934] Starting subtest: legacy-dpms
[64.818793] Starting dynamic subtest: pipe-A-HDMI-A-3
[71.027314] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (6.208s)
[71.028225] Subtest legacy-dpms: SUCCESS (6.210s)
[71.254745] [004/133] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[72.755854] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[72.760996] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[72.976686] [005/133] (949s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[74.460553] Starting subtest: plane-primary-toggle-with-vblank-wait
[74.461555] Starting dynamic subtest: pipe-A-HDMI-A-3
[74.673726] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.212s)
[74.828769] Starting dynamic subtest: pipe-B-HDMI-A-3
[75.060368] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.240s)
[75.118884] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.659s)
[75.307609] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[76.795149] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[76.796722] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[77.034173] [007/133] (945s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[78.516589] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[78.591602] [008/133] (943s left) perf (invalid-oa-exponent)
[78.767255] Starting subtest: invalid-oa-exponent
[78.793629] Subtest invalid-oa-exponent: SUCCESS (0.027s)
[78.861332] [009/133] (943s left) gem_eio (create-ext)
[78.995703] Starting subtest: create-ext
[79.176268] Subtest create-ext: SUCCESS (0.181s)
[80.809688] [010/133] (941s left) kms_color (invalid-degamma-lut-sizes)
[82.295425] Starting subtest: invalid-degamma-lut-sizes
[82.296319] Starting dynamic subtest: pipe-A
[82.344464] Dynamic subtest pipe-A: SUCCESS (0.049s)
[82.352515] Starting dynamic subtest: pipe-B
[82.353395] Dynamic subtest pipe-B: SUCCESS (0.001s)
[82.361273] Starting dynamic subtest: pipe-C
[82.362247] Dynamic subtest pipe-C: SUCCESS (0.001s)
[82.370109] Starting dynamic subtest: pipe-D
[82.371044] Dynamic subtest pipe-D: SUCCESS (0.001s)
[82.371936] Subtest invalid-degamma-lut-sizes: SUCCESS (0.051s)
[82.546338] [011/133] (940s left) gem_softpin (allocator-basic)
[82.594349] Starting subtest: allocator-basic
[82.863619] Subtest allocator-basic: SUCCESS (0.266s)
[83.043444] [012/133] (939s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[84.525884] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[84.595710] [013/133] (938s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[86.101206] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[87.231242] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.126s)
[87.406501] [014/133] (935s left) kms_psr (pr-primary-render)
[88.889495] Subtest pr-primary-render: SKIP (0.000s)
[88.962854] [015/133] (934s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[90.453242] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[90.454834] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[90.680158] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[92.164626] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[92.229108] [017/133] (931s left) gem_ccs (ctrl-surf-copy)
[92.279396] Starting subtest: ctrl-surf-copy
[92.281360] Subtest ctrl-surf-copy: SKIP (0.000s)
[92.418468] [018/133] (930s left) perf (invalid-oa-metric-set-id)
[92.548460] Starting subtest: invalid-oa-metric-set-id
[92.568786] Subtest invalid-oa-metric-set-id: SUCCESS (0.020s)
[92.632401] [019/133] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[94.119343] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[94.120920] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[94.339919] [020/133] (929s left) gem_pxp (create-regular-buffer)
[96.924437] Starting subtest: create-regular-buffer
[96.926091] Subtest create-regular-buffer: SKIP (0.000s)
[97.103943] [021/133] (926s left) gem_eio (in-flight-contexts-10ms)
[97.235392] Starting subtest: in-flight-contexts-10ms
[110.905625] Subtest in-flight-contexts-10ms: SUCCESS (13.671s)
[112.559171] [022/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[114.047383] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[114.049507] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[114.289542] [023/133] (909s left) gem_exec_schedule (u-fairslice-all)
[114.346563] Starting subtest: u-fairslice-all
[116.423831] Subtest u-fairslice-all: SUCCESS (2.077s)
[116.907897] [024/133] (907s left) core_getstats (basic)
[116.949617] Starting subtest: basic
[116.950409] Subtest basic: SUCCESS (0.000s)
[117.099936] [025/133] (906s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[118.581898] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[118.582855] Starting dynamic subtest: pipe-A-HDMI-A-3
[118.591239] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[118.600040] Starting dynamic subtest: pipe-B-HDMI-A-3
[118.608194] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[118.616856] Starting dynamic subtest: pipe-C-HDMI-A-3
[118.625173] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[118.633846] Starting dynamic subtest: pipe-D-HDMI-A-3
[118.642772] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[118.644351] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[118.855050] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[120.337495] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[120.339267] Starting dynamic subtest: pipe-A-HDMI-A-3
[120.347500] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[120.356379] Starting dynamic subtest: pipe-B-HDMI-A-3
[120.364870] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[120.373539] Starting dynamic subtest: pipe-C-HDMI-A-3
[120.382144] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[120.390921] Starting dynamic subtest: pipe-D-HDMI-A-3
[120.399839] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[120.401549] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[120.642995] [027/133] (903s left) sw_sync (alloc_fence)
[120.684897] Starting subtest: alloc_fence
[120.686449] Subtest alloc_fence: SUCCESS (0.000s)
[120.812562] [028/133] (903s left) i915_pm_rps (basic-api)
[120.861870] Starting subtest: basic-api
[120.863458] Subtest basic-api: SKIP (0.000s)
[121.017264] [029/133] (903s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[122.500870] Starting subtest: cursorB-vs-flipA-toggle
[122.504310] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s)
[122.698307] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[124.369692] Starting subtest: cursor-rapid-movement-128x42
[124.375813] Starting dynamic subtest: pipe-A-HDMI-A-3
[124.802828] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.427s)
[124.836088] Starting dynamic subtest: pipe-D-HDMI-A-3
[125.150032] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.322s)
[125.150937] Subtest cursor-rapid-movement-128x42: SUCCESS (0.780s)
[125.628957] [031/133] (898s left) kms_dp_link_training (non-uhbr-sst)
[127.111875] Starting subtest: non-uhbr-sst
[127.115362] Subtest non-uhbr-sst: SKIP (0.000s)
[127.308181] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[128.797940] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[128.799990] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.034213] [033/133] (895s left) gem_exec_parallel (engines)
[129.105696] Starting subtest: engines
[129.106591] Starting dynamic subtest: basic
[130.697518] Dynamic subtest basic: SUCCESS (1.592s)
[130.706578] Starting dynamic subtest: contexts
[135.447440] Dynamic subtest contexts: SUCCESS (4.747s)
[135.456674] Starting dynamic subtest: fds
[139.812590] Dynamic subtest fds: SUCCESS (4.365s)
[139.821623] Starting dynamic subtest: userptr
[141.334353] Dynamic subtest userptr: SUCCESS (1.525s)
[141.335404] Subtest engines: SUCCESS (12.229s)
[141.712654] [034/133] (883s left) gem_eio (in-flight-immediate)
[141.915800] Starting subtest: in-flight-immediate
[146.478448] Subtest in-flight-immediate: SUCCESS (4.563s)
[148.075269] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[148.077852] [035/133] (876s left) prime_mmap (test_forked)
[148.126259] Starting subtest: test_forked
[148.127123] Starting dynamic subtest: test_forked-smem
[148.196769] Dynamic subtest test_forked-smem: SUCCESS (0.070s)
[148.206053] Starting dynamic subtest: test_forked-lmem0
[148.268297] Dynamic subtest test_forked-lmem0: SUCCESS (0.071s)
[148.269180] Subtest test_forked: SUCCESS (0.142s)
[148.482425] [036/133] (876s left) kms_dsc (dsc-with-formats)
[149.968648] Starting subtest: dsc-with-formats
[149.986702] Subtest dsc-with-formats: SKIP (0.002s)
[150.122723] [037/133] (875s left) prime_busy (hang)
[150.177204] Starting subtest: hang
[150.178951] Starting dynamic subtest: rcs0
[176.439308] Dynamic subtest rcs0: SUCCESS (26.257s)
[176.448581] Starting dynamic subtest: bcs0
[183.587170] Dynamic subtest bcs0: SUCCESS (7.146s)
[183.596809] Starting dynamic subtest: vcs0
[190.562824] Dynamic subtest vcs0: SUCCESS (6.976s)
[190.572564] Starting dynamic subtest: vcs1
[197.538393] Dynamic subtest vcs1: SUCCESS (6.975s)
[197.547933] Starting dynamic subtest: vecs0
[204.576761] Dynamic subtest vecs0: SUCCESS (7.038s)
[204.577818] Subtest hang: SUCCESS (54.394s)
[204.737768] [038/133] (820s left) kms_vblank (wait-idle)
[206.220659] Starting subtest: wait-idle
[206.222838] Starting dynamic subtest: pipe-A-HDMI-A-3
[208.555370] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.333s)
[208.568342] Starting dynamic subtest: pipe-D-HDMI-A-3
[210.748946] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.189s)
[210.749936] Subtest wait-idle: SUCCESS (4.527s)
[210.952803] [039/133] (814s left) kms_pm_rpm (package-g7)
[215.063074] Starting subtest: package-g7
[215.065848] Subtest package-g7: SKIP (0.000s)
[216.099899] [040/133] (809s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[217.601928] Starting subtest: flip-vs-cursor-varying-size
[232.056508] Subtest flip-vs-cursor-varying-size: SUCCESS (14.454s)
[232.281714] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[233.769834] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[233.771504] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[234.023497] [042/133] (791s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[234.081831] Starting subtest: single-wait-all-for-submit-signaled
[234.082799] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[234.262858] [043/133] (791s left) perf (gen12-group-exclusive-stream-ctx-handle)
[234.398715] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[234.425185] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.026s)
[234.497828] [044/133] (791s left) gem_wait (busy)
[234.556278] Starting subtest: busy
[234.557308] Starting dynamic subtest: all-engines
[235.130243] Dynamic subtest all-engines: SUCCESS (0.574s)
[235.140723] Starting dynamic subtest: rcs0
[235.668922] Dynamic subtest rcs0: SUCCESS (0.538s)
[235.678303] Starting dynamic subtest: bcs0
[236.206822] Dynamic subtest bcs0: SUCCESS (0.537s)
[236.216218] Starting dynamic subtest: vcs0
[236.744893] Dynamic subtest vcs0: SUCCESS (0.537s)
[236.754264] Starting dynamic subtest: vcs1
[237.282907] Dynamic subtest vcs1: SUCCESS (0.537s)
[237.292361] Starting dynamic subtest: vecs0
[237.821895] Dynamic subtest vecs0: SUCCESS (0.538s)
[237.822953] Subtest busy: SUCCESS (3.266s)
[238.105441] [045/133] (787s left) gen9_exec_parse (bb-secure)
[238.154040] Subtest bb-secure: SKIP (0.000s)
[238.228257] [046/133] (787s left) kms_cursor_edge_walk (128x128-right-edge)
[239.709983] Starting subtest: 128x128-right-edge
[239.710902] Starting dynamic subtest: pipe-A-HDMI-A-3
[243.025883] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.315s)
[243.036641] Starting dynamic subtest: pipe-D-HDMI-A-3
[246.265222] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.237s)
[246.266112] Subtest 128x128-right-edge: SUCCESS (6.556s)
[246.501849] [047/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[247.990908] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[247.992821] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.249528] [048/133] (778s left) prime_mmap (test_forked_cpu_write)
[248.295250] Starting subtest: test_forked_cpu_write
[248.296097] Starting dynamic subtest: test_forked_cpu_write-smem
[248.306716] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[248.316194] Starting dynamic subtest: test_forked_cpu_write-lmem0
[248.318521] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.011s)
[248.319337] Subtest test_forked_cpu_write: SUCCESS (0.024s)
[248.530459] [049/133] (777s left) kms_addfb_basic (small-bo)
[250.017903] Starting subtest: small-bo
[250.018753] Subtest small-bo: SUCCESS (0.000s)
[250.226509] [050/133] (776s left) kms_chamelium_audio (dp-audio)
[251.750133] Subtest dp-audio: SKIP (0.000s)
[251.863945] [051/133] (774s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[253.395538] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[253.508668] [052/133] (773s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[254.996999] Starting subtest: psr-shrfb-scaledprimary
[254.998973] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[255.249401] [053/133] (771s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[256.748930] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[256.751091] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[256.956515] [054/133] (769s left) perf (i915-ref-count)
[257.105045] Starting subtest: i915-ref-count
[257.147208] Subtest i915-ref-count: SUCCESS (0.041s)
[257.223923] [055/133] (769s left) kms_joiner (invalid-modeset-force-big-joiner)
[258.707151] Starting subtest: invalid-modeset-force-big-joiner
[258.708849] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[258.907315] [056/133] (768s left) kms_cursor_crc (cursor-alpha-opaque)
[260.389662] Starting subtest: cursor-alpha-opaque
[260.391652] Starting dynamic subtest: pipe-A-HDMI-A-3
[261.002971] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.611s)
[261.013753] Starting dynamic subtest: pipe-D-HDMI-A-3
[261.428581] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.424s)
[261.429424] Subtest cursor-alpha-opaque: SUCCESS (1.039s)
[262.205325] [057/133] (765s left) kms_legacy_colorkey (basic)
[263.687755] Starting subtest: basic
[263.688568] Starting dynamic subtest: pipe-A
[263.787780] Dynamic subtest pipe-A: SUCCESS (0.099s)
[263.815329] Starting dynamic subtest: pipe-B
[263.816975] Dynamic subtest pipe-B: SUCCESS (0.002s)
[263.864703] Starting dynamic subtest: pipe-C
[263.866648] Dynamic subtest pipe-C: SUCCESS (0.001s)
[263.910575] Starting dynamic subtest: pipe-D
[263.911939] Dynamic subtest pipe-D: SUCCESS (0.002s)
[263.913286] Subtest basic: SUCCESS (0.110s)
[264.003739] [058/133] (763s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[265.505968] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[265.507905] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[265.748105] [059/133] (761s left) kms_addfb_basic (bad-pitch-32)
[265.791066] Starting subtest: bad-pitch-32
[265.791957] Subtest bad-pitch-32: SUCCESS (0.000s)
[267.490969] [060/133] (760s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[267.541989] Starting subtest: x-tiled-to-vebox-y-tiled
[267.542989] Starting dynamic subtest: smem
[267.623853] Dynamic subtest smem: SUCCESS (0.083s)
[267.633412] Starting dynamic subtest: lmem0
[268.381107] Dynamic subtest lmem0: SUCCESS (0.753s)
[268.382144] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.837s)
[268.669470] [061/133] (759s left) gem_exec_reloc (basic-range)
[268.717441] Subtest basic-range: SKIP (0.000s)
[268.835552] [062/133] (758s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[270.336718] Starting subtest: yf-tiled-64bpp-rotate-0
[270.338355] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[270.580167] [063/133] (757s left) syncobj_wait (wait-all-for-submit-snapshot)
[270.623594] Starting subtest: wait-all-for-submit-snapshot
[270.707834] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[270.882946] [064/133] (757s left) kms_async_flips (invalid-async-flip)
[272.388033] Starting subtest: invalid-async-flip
[272.657416] Starting dynamic subtest: pipe-A-HDMI-A-3
[273.096774] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.439s)
[273.277885] Starting dynamic subtest: pipe-B-HDMI-A-3
[273.368813] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.100s)
[273.544155] Starting dynamic subtest: pipe-C-HDMI-A-3
[273.649143] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.113s)
[273.804895] Starting dynamic subtest: pipe-D-HDMI-A-3
[273.907476] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.111s)
[273.908329] Subtest invalid-async-flip: SUCCESS (1.521s)
[274.331818] [065/133] (753s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[275.823136] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[275.830099] Starting dynamic subtest: A-HDMI-A3
[276.529881] Dynamic subtest A-HDMI-A3: SUCCESS (0.699s)
[276.539733] Starting dynamic subtest: B-HDMI-A3
[277.165219] Dynamic subtest B-HDMI-A3: SUCCESS (0.634s)
[277.175975] Starting dynamic subtest: C-HDMI-A3
[277.823424] Dynamic subtest C-HDMI-A3: SUCCESS (0.657s)
[277.833204] Starting dynamic subtest: D-HDMI-A3
[278.448557] Dynamic subtest D-HDMI-A3: SUCCESS (0.624s)
[278.451022] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.626s)
[278.677598] [066/133] (749s left) kms_frontbuffer_tracking (fbc-suspend)
[280.167974] Starting subtest: fbc-suspend
[336.267931] Subtest fbc-suspend: SUCCESS (22.505s)
[339.554881] [067/133] (691s left) syncobj_timeline (invalid-transfer-bad-pad)
[339.598875] Starting subtest: invalid-transfer-bad-pad
[339.599679] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[339.808814] [068/133] (691s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[341.314035] Starting subtest: 4-tiled-64bpp-rotate-90
[341.316084] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[341.573346] [069/133] (690s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[341.623655] Starting subtest: saturated-hostile-nopreempt
[341.624523] Starting dynamic subtest: rcs0
[342.429284] Dynamic subtest rcs0: SUCCESS (0.805s)
[342.444612] Starting dynamic subtest: bcs0
[343.210922] Dynamic subtest bcs0: SUCCESS (0.779s)
[343.224219] Starting dynamic subtest: vcs0
[343.998891] Dynamic subtest vcs0: SUCCESS (0.786s)
[344.012559] Starting dynamic subtest: vcs1
[344.788508] Dynamic subtest vcs1: SUCCESS (0.786s)
[344.800111] Starting dynamic subtest: vecs0
[345.565847] Dynamic subtest vecs0: SUCCESS (0.776s)
[345.566844] Subtest saturated-hostile-nopreempt: SUCCESS (3.943s)
[345.761367] [070/133] (685s left) gem_exec_big (single)
[345.808930] Starting subtest: single
[353.121238] Subtest single: SUCCESS (7.309s)
[353.973906] [071/133] (677s left) gem_exec_fence (submit67)
[354.185976] Starting subtest: submit67
[354.187759] Subtest submit67: SKIP (0.000s)
[354.832417] [072/133] (676s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[356.330241] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[356.332173] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[356.498153] [073/133] (675s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[357.987370] Starting subtest: fbc-rgb101010-draw-mmap-wc
[357.989689] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[358.274224] [074/133] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[359.764420] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[359.766237] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.023400] [075/133] (672s left) i915_drm_fdinfo (busy-idle)
[360.100609] Starting subtest: busy-idle
[360.101421] Starting dynamic subtest: rcs0
[360.103088] Dynamic subtest rcs0: SKIP (0.000s)
[360.115281] Starting dynamic subtest: bcs0
[360.117476] Dynamic subtest bcs0: SKIP (0.000s)
[360.129647] Starting dynamic subtest: vcs0
[360.131729] Dynamic subtest vcs0: SKIP (0.000s)
[360.143402] Starting dynamic subtest: vcs1
[360.145467] Dynamic subtest vcs1: SKIP (0.000s)
[360.157084] Starting dynamic subtest: vecs0
[360.159199] Dynamic subtest vecs0: SKIP (0.016s)
[360.161200] Subtest busy-idle: SKIP (0.024s)
[360.250345] [076/133] (671s left) kms_psr (psr2-primary-page-flip)
[361.733409] Subtest psr2-primary-page-flip: SKIP (0.000s)
[361.810877] [077/133] (670s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[363.297241] Starting subtest: cursorA-vs-flipB-atomic
[363.298927] Subtest cursorA-vs-flipB-atomic: SKIP (0.002s)
[363.519896] [078/133] (668s left) kms_prop_blob (blob-prop-lifetime)
[363.563528] Starting subtest: blob-prop-lifetime
[363.565821] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[363.752490] [079/133] (668s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[365.237011] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[365.238123] Starting dynamic subtest: pipe-A
[367.683616] Dynamic subtest pipe-A: SUCCESS (2.446s)
[367.710974] Starting dynamic subtest: pipe-B
[370.124833] Dynamic subtest pipe-B: SUCCESS (2.439s)
[370.140408] Starting dynamic subtest: pipe-C
[370.416375] Dynamic subtest pipe-C: SUCCESS (0.290s)
[370.432722] Starting dynamic subtest: pipe-D
[370.706353] Dynamic subtest pipe-D: SUCCESS (0.288s)
[370.707281] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (5.470s)
[370.944287] [080/133] (661s left) kms_pipe_crc_basic (hang-read-crc)
[372.431341] Starting subtest: hang-read-crc
[372.433646] Starting dynamic subtest: pipe-A-HDMI-A-3
[373.894617] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.462s)
[373.909238] Starting dynamic subtest: pipe-B-HDMI-A-3
[375.148525] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.249s)
[375.162399] Starting dynamic subtest: pipe-C-HDMI-A-3
[376.349914] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.200s)
[376.364011] Starting dynamic subtest: pipe-D-HDMI-A-3
[377.638238] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.285s)
[377.639082] Subtest hang-read-crc: SUCCESS (5.207s)
[377.872758] [081/133] (654s left) kms_selftest (drm_format)
[377.930719] Starting subtest: drm_format
[377.940683] Starting dynamic subtest: drm_test_format_block_width_invalid
[378.028010] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.085s)
[378.076042] Starting dynamic subtest: drm_test_format_block_width_one_plane
[378.112943] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.077s)
[378.134261] Starting dynamic subtest: drm_test_format_block_width_two_plane
[378.204740] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.087s)
[378.251722] Starting dynamic subtest: drm_test_format_block_width_three_plane
[378.291082] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.080s)
[378.317806] Starting dynamic subtest: drm_test_format_block_width_tiled
[378.381043] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.085s)
[378.430390] Starting dynamic subtest: drm_test_format_block_height_invalid
[378.476909] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.089s)
[378.509421] Starting dynamic subtest: drm_test_format_block_height_one_plane
[378.566292] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.085s)
[378.612290] Starting dynamic subtest: drm_test_format_block_height_two_plane
[378.654073] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.081s)
[378.678074] Starting dynamic subtest: drm_test_format_block_height_three_plane
[378.741934] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.082s)
[378.794338] Starting dynamic subtest: drm_test_format_block_height_tiled
[378.827325] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.080s)
[378.849556] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[378.896554] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.066s)
[378.911611] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[378.973758] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.072s)
[379.015954] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[379.051564] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.075s)
[379.077892] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[379.144093] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.086s)
[379.159400] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[379.229403] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.080s)
[379.245239] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[379.319256] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.084s)
[379.370595] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[379.407343] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.082s)
[379.430348] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[379.497176] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.086s)
[379.505112] Subtest drm_format: SUCCESS (1.568s)
[379.777438] [082/133] (653s left) gem_close_race (multigpu-basic-process)
[379.850491] Starting subtest: multigpu-basic-process
[379.852770] Subtest multigpu-basic-process: SKIP (0.000s)
[380.192126] [083/133] (652s left) gem_set_tiling_vs_gtt
[380.315686] [084/133] (652s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[381.801304] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[381.802201] Starting dynamic subtest: pipe-A
[381.958747] Dynamic subtest pipe-A: SUCCESS (0.158s)
[381.980412] Starting dynamic subtest: pipe-B
[382.136219] Dynamic subtest pipe-B: SUCCESS (0.175s)
[382.149890] Starting dynamic subtest: pipe-C
[382.276311] Dynamic subtest pipe-C: SUCCESS (0.139s)
[382.290179] Starting dynamic subtest: pipe-D
[382.416382] Dynamic subtest pipe-D: SUCCESS (0.139s)
[382.417281] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.617s)
[382.669805] [085/133] (650s left) kms_addfb_basic (basic-y-tiled-legacy)
[382.715609] Starting subtest: basic-y-tiled-legacy
[382.717216] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[384.428008] [086/133] (648s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[385.936823] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[387.257101] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.321s)
[387.524820] [087/133] (645s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[387.575575] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[387.576489] Starting dynamic subtest: smem
[387.674451] Dynamic subtest smem: SUCCESS (0.098s)
[387.688165] Starting dynamic subtest: lmem0
[388.794172] Dynamic subtest lmem0: SUCCESS (1.115s)
[388.795281] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (1.216s)
[389.102425] [088/133] (644s left) gem_caching (writes)
[389.151590] Starting subtest: writes
[394.158750] Subtest writes: SUCCESS (5.007s)
[394.334935] [089/133] (639s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[394.380468] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[394.491472] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[394.644983] [090/133] (638s left) kms_flip (wf_vblank-ts-check)
[396.131275] Starting subtest: wf_vblank-ts-check
[396.137273] Starting dynamic subtest: A-HDMI-A3
[404.158593] Dynamic subtest A-HDMI-A3: SUCCESS (8.021s)
[404.174857] Starting dynamic subtest: B-HDMI-A3
[412.122761] Dynamic subtest B-HDMI-A3: SUCCESS (7.962s)
[412.137461] Starting dynamic subtest: C-HDMI-A3
[420.091519] Dynamic subtest C-HDMI-A3: SUCCESS (7.967s)
[420.105907] Starting dynamic subtest: D-HDMI-A3
[428.060814] Dynamic subtest D-HDMI-A3: SUCCESS (7.967s)
[428.063273] Subtest wf_vblank-ts-check: SUCCESS (31.932s)
[428.323792] [091/133] (605s left) gem_lmem_evict (dontneed-evict-race)
[432.864553] Starting subtest: dontneed-evict-race
[434.978287] Subtest dontneed-evict-race: SUCCESS (2.110s)
[436.829644] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[436.830743] [FACT gem_lmem_evict (dontneed-evict-race)] deleted: kernel.kmod_is_loaded.i915: true
[436.833145] [092/133] (596s left) gem_mmap_gtt (medium-copy-odd)
[440.159027] Subtest medium-copy-odd: SKIP (0.000s)
[440.231818] [FACT gem_mmap_gtt (medium-copy-odd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[440.235308] [FACT gem_mmap_gtt (medium-copy-odd)] new: kernel.kmod_is_loaded.i915: true
[440.238510] [093/133] (593s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[441.726388] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[441.732018] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[441.931433] [094/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[443.433315] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[443.434450] Starting dynamic subtest: pipe-A-HDMI-A-3
[443.455198] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.003s)
[443.465413] Starting dynamic subtest: pipe-B-HDMI-A-3
[443.485850] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.003s)
[443.496022] Starting dynamic subtest: pipe-C-HDMI-A-3
[443.517861] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.003s)
[443.527890] Starting dynamic subtest: pipe-D-HDMI-A-3
[443.549530] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.003s)
[443.551093] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.020s)
[443.748922] [095/133] (590s left) gem_exec_suspend (basic-s0)
[443.808468] Starting subtest: basic-S0
[443.809527] Starting dynamic subtest: smem
[464.227168] Dynamic subtest smem: SUCCESS (5.177s)
[464.240083] Starting dynamic subtest: lmem0
[484.270860] Dynamic subtest lmem0: SUCCESS (4.828s)
[484.271761] Subtest basic-S0: SUCCESS (10.008s)
[489.625833] [096/133] (549s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[491.130492] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[491.132496] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[491.384829] [097/133] (547s left) gem_mmap_offset (bad-extensions)
[491.429698] Starting subtest: bad-extensions
[491.430638] Subtest bad-extensions: SUCCESS (0.000s)
[491.642706] [098/133] (547s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[493.129883] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[493.133024] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[493.323664] [099/133] (546s left) gem_mmap_gtt (cpuset-big-copy-odd)
[493.373534] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[493.447669] [100/133] (546s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[494.950522] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[494.952359] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[495.168342] [101/133] (544s left) kms_psr (fbc-psr2-sprite-render)
[496.652027] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[496.733378] [102/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[498.222101] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[498.223766] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[498.483421] [103/133] (541s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[499.967868] Starting subtest: crc-primary-basic-y-tiled-ccs
[499.968710] Starting dynamic subtest: pipe-A-HDMI-A-3
[499.976406] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[499.987630] Starting dynamic subtest: pipe-B-HDMI-A-3
[499.995488] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[500.006629] Starting dynamic subtest: pipe-C-HDMI-A-3
[500.014628] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[500.025325] Starting dynamic subtest: pipe-D-HDMI-A-3
[500.033388] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[500.034938] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.014s)
[500.289040] [104/133] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[501.778818] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[501.780622] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[502.016775] [105/133] (538s left) api_intel_bb (add-remove-objects)
[502.060877] Starting subtest: add-remove-objects
[502.082603] Subtest add-remove-objects: SUCCESS (0.022s)
[502.312546] [106/133] (537s left) sysfs_heartbeat_interval (nopreempt)
[502.361755] Starting subtest: nopreempt
[502.364110] Starting dynamic subtest: vecs0
[506.474564] Dynamic subtest vecs0: SUCCESS (4.110s)
[506.489200] Starting dynamic subtest: vcs0
[510.480073] Dynamic subtest vcs0: SUCCESS (4.003s)
[510.493481] Starting dynamic subtest: bcs0
[514.490553] Dynamic subtest bcs0: SUCCESS (4.008s)
[514.503861] Starting dynamic subtest: rcs0
[518.594899] Dynamic subtest rcs0: SUCCESS (4.102s)
[518.609796] Starting dynamic subtest: vcs1
[522.606515] Dynamic subtest vcs1: SUCCESS (4.010s)
[522.607390] Subtest nopreempt: SUCCESS (20.241s)
[522.813191] [107/133] (517s left) kms_getfb (getfb2-into-addfb2)
[524.298079] Starting subtest: getfb2-into-addfb2
[524.298984] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[524.539723] [108/133] (515s left) gem_close (basic)
[524.588524] Starting subtest: basic
[524.589469] Subtest basic: SUCCESS (0.000s)
[524.796787] [109/133] (515s left) gem_exec_schedule (preemptive-hang)
[524.985225] Starting subtest: preemptive-hang
[524.986193] Starting dynamic subtest: rcs0
[534.123971] Dynamic subtest rcs0: SUCCESS (9.146s)
[534.137631] Starting dynamic subtest: bcs0
[543.143925] Dynamic subtest bcs0: SUCCESS (9.020s)
[543.157463] Starting dynamic subtest: vcs0
[552.113049] Dynamic subtest vcs0: SUCCESS (8.969s)
[552.126759] Starting dynamic subtest: vcs1
[561.137214] Dynamic subtest vcs1: SUCCESS (9.023s)
[561.150826] Starting dynamic subtest: vecs0
[570.153909] Dynamic subtest vecs0: SUCCESS (9.015s)
[570.154770] Subtest preemptive-hang: SUCCESS (45.180s)
[570.494273] [110/133] (470s left) i915_drm_fdinfo (virtual-busy-idle)
[570.541778] Starting subtest: virtual-busy-idle
[570.543689] Subtest virtual-busy-idle: SKIP (0.000s)
[570.735522] [111/133] (470s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[572.224268] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[572.225849] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[572.472310] [112/133] (468s left) gem_linear_blits (interruptible)
[572.712314] Starting subtest: interruptible
[581.202088] Subtest interruptible: SUCCESS (8.485s)
[581.403023] [113/133] (459s left) gem_ctx_persistence (engines-mixed)
[581.494958] Starting subtest: engines-mixed
[581.495811] Starting dynamic subtest: rcs0
[581.577321] Dynamic subtest rcs0: SUCCESS (0.081s)
[581.596700] Starting dynamic subtest: bcs0
[581.631107] Dynamic subtest bcs0: SUCCESS (0.052s)
[581.666919] Starting dynamic subtest: vcs0
[581.718413] Dynamic subtest vcs0: SUCCESS (0.083s)
[581.766255] Starting dynamic subtest: vcs1
[581.798779] Dynamic subtest vcs1: SUCCESS (0.076s)
[581.817823] Starting dynamic subtest: vecs0
[581.848846] Dynamic subtest vecs0: SUCCESS (0.048s)
[581.852226] Subtest engines-mixed: SUCCESS (0.355s)
[582.063793] [114/133] (459s left) perf_pmu (init-wait)
[582.112486] Starting subtest: init-wait
[582.113623] Starting dynamic subtest: rcs0
[582.116005] Dynamic subtest rcs0: SUCCESS (0.002s)
[582.128051] Starting dynamic subtest: bcs0
[582.128896] Dynamic subtest bcs0: SUCCESS (0.001s)
[582.140952] Starting dynamic subtest: vcs0
[582.142108] Dynamic subtest vcs0: SUCCESS (0.001s)
[582.153814] Starting dynamic subtest: vcs1
[582.154950] Dynamic subtest vcs1: SUCCESS (0.001s)
[582.166804] Starting dynamic subtest: vecs0
[582.167811] Dynamic subtest vecs0: SUCCESS (0.001s)
[582.168799] Subtest init-wait: SUCCESS (0.012s)
[582.279578] [115/133] (458s left) gem_exec_reloc (basic-gtt-cpu-active)
[582.330741] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[582.430796] [116/133] (458s left) kms_pm_lpsp (screens-disabled)
[584.933263] Starting subtest: screens-disabled
[584.937669] Subtest screens-disabled: SKIP (0.000s)
[585.158400] [117/133] (456s left) kms_flip (flip-vs-expired-vblank-interruptible)
[586.649072] Starting subtest: flip-vs-expired-vblank-interruptible
[586.656341] Starting dynamic subtest: A-HDMI-A3
[594.415437] Dynamic subtest A-HDMI-A3: SUCCESS (7.759s)
[594.436953] Starting dynamic subtest: B-HDMI-A3
[602.081103] Dynamic subtest B-HDMI-A3: SUCCESS (7.662s)
[602.123738] Starting dynamic subtest: C-HDMI-A3
[609.765784] Dynamic subtest C-HDMI-A3: SUCCESS (7.676s)
[609.782532] Starting dynamic subtest: D-HDMI-A3
[617.434708] Dynamic subtest D-HDMI-A3: SUCCESS (7.663s)
[617.445225] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.795s)
[617.750332] [118/133] (423s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[619.239826] Starting subtest: psr-1p-primscrn-cur-indfb-move
[619.241512] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[619.495312] [119/133] (422s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[620.981117] Starting subtest: plane-all-modeset-transition-internal-panels
[620.982965] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[621.191922] [120/133] (420s left) gem_userptr_blits (stress-mm)
[621.251932] Starting subtest: stress-mm
[626.624141] Subtest stress-mm: SUCCESS (5.369s)
[626.811772] [121/133] (415s left) syncobj_eventfd (invalid-bad-flags)
[626.862980] Starting subtest: invalid-bad-flags
[626.863873] Subtest invalid-bad-flags: SUCCESS (0.000s)
[627.049532] [122/133] (414s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[627.094750] Starting subtest: framebuffer-vs-set-tiling
[627.096492] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[628.806449] [123/133] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[630.294793] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[630.296406] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[630.547831] [124/133] (411s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[630.592427] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[630.593325] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[630.780008] [125/133] (411s left) kms_flip (2x-modeset-vs-vblank-race)
[632.265985] Starting subtest: 2x-modeset-vs-vblank-race
[632.285062] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[632.498979] [126/133] (409s left) i915_query (query-regions-garbage-items)
[632.543629] Starting subtest: query-regions-garbage-items
[632.544560] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[632.730324] [127/133] (409s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[632.776311] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[632.880875] [128/133] (409s left) gem_exec_balancer (full-late)
[632.935005] Starting subtest: full-late
[635.292755] Subtest full-late: SUCCESS (2.358s)
[635.775935] [129/133] (406s left) gem_exec_reloc (basic-write-wc)
[635.823571] Subtest basic-write-wc: SKIP (0.000s)
[635.925917] [130/133] (406s left) kms_force_connector_basic (force-load-detect)
[636.053987] Starting subtest: force-load-detect
[636.055649] Subtest force-load-detect: SKIP (0.000s)
[637.055395] [131/133] (405s left) kms_chamelium_hpd (hdmi-hpd-fast)
[638.582902] Subtest hdmi-hpd-fast: SKIP (0.000s)
[638.702337] [132/133] (404s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[640.186934] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[640.187884] Starting dynamic subtest: pipe-A-valid-mode
[641.015437] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.827s)
[641.016301] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.830s)
[641.273127] [133/133] (401s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[642.761241] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[642.762954] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[643.007248] 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.