[60.003534] Initializing watchdogs
[60.003582]   /dev/watchdog0
[60.017646] [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]
[60.022048] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.024305] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.031235] [001/133] (960s left) kms_pm_rpm (dpms-non-lpsp)
[62.014275] Starting subtest: dpms-non-lpsp
[62.019494] Subtest dpms-non-lpsp: SKIP (0.000s)
[62.404336] [002/133] (958s left) kms_chamelium_frames (hdmi-aspect-ratio)
[62.797428] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[63.598946] [003/133] (957s left) gem_ctx_persistence (legacy-engines-persistence)
[63.669088] Starting subtest: legacy-engines-persistence
[63.670956] Starting dynamic subtest: render
[64.472514] Dynamic subtest render: SUCCESS (0.805s)
[64.482222] Starting dynamic subtest: bsd1
[65.233530] Dynamic subtest bsd1: SUCCESS (0.759s)
[65.243290] Starting dynamic subtest: bsd2
[66.001661] Dynamic subtest bsd2: SUCCESS (0.766s)
[66.010905] Starting dynamic subtest: blt
[66.835670] Dynamic subtest blt: SUCCESS (0.832s)
[66.847529] Starting dynamic subtest: vebox
[67.652059] Dynamic subtest vebox: SUCCESS (0.814s)
[67.654860] Subtest legacy-engines-persistence: SUCCESS (3.986s)
[67.743383] [004/133] (952s left) api_intel_allocator (alloc-simple)
[67.867155] Starting subtest: alloc-simple
[67.875056] Subtest alloc-simple: SUCCESS (0.008s)
[68.140710] [005/133] (952s left) kms_psr (psr2-sprite-blt)
[68.240958] Starting subtest: psr2-sprite-blt
[68.243409] Starting dynamic subtest: eDP-1
[69.944832] Dynamic subtest eDP-1: SUCCESS (1.702s)
[69.946809] Subtest psr2-sprite-blt: SUCCESS (1.703s)
[70.815834] [006/133] (949s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[70.919306] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[70.923505] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[71.030693] [007/133] (949s left) gem_exec_params (invalid-bsd1-flag-on-render)
[71.086424] Starting subtest: invalid-bsd1-flag-on-render
[71.088312] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[71.196074] [008/133] (949s left) sw_sync (sync_multi_producer_single_consumer)
[71.225972] Starting subtest: sync_multi_producer_single_consumer
[72.301026] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[72.356912] [009/133] (948s left) i915_suspend (fence-restore-tiled2untiled)
[72.409982] Starting subtest: fence-restore-tiled2untiled
[72.414745] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[72.526742] [010/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[72.633413] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[72.637489] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[72.745860] [011/133] (948s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[72.809756] Starting subtest: map-fixed-invalidate-overlap
[72.813767] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[72.931611] [012/133] (948s left) gem_exec_capture (userptr)
[72.990803] Starting subtest: userptr
[73.812446] Subtest userptr: SUCCESS (0.820s)
[73.936183] [013/133] (947s left) kms_dsc (dsc-with-bpc-formats)
[74.025066] Starting subtest: dsc-with-bpc-formats
[74.137641] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[74.171437] [014/133] (946s left) gem_userptr_blits (unsync-overlap)
[74.241635] Subtest unsync-overlap: SKIP (0.000s)
[74.354556] [015/133] (946s left) gem_softpin (evict-prime)
[74.405235] Starting subtest: evict-prime
[74.407067] Starting dynamic subtest: rcs0
[75.549623] Dynamic subtest rcs0: SUCCESS (1.146s)
[75.557818] Starting dynamic subtest: bcs0
[76.672845] Dynamic subtest bcs0: SUCCESS (1.123s)
[76.682461] Starting dynamic subtest: vcs0
[77.840900] Dynamic subtest vcs0: SUCCESS (1.166s)
[77.851087] Starting dynamic subtest: vcs1
[79.897322] Dynamic subtest vcs1: SUCCESS (2.055s)
[79.906778] Starting dynamic subtest: vecs0
[81.891899] Dynamic subtest vecs0: SUCCESS (1.994s)
[81.902037] Starting dynamic subtest: ccs0
[83.033982] Dynamic subtest ccs0: SUCCESS (1.143s)
[83.042389] Starting dynamic subtest: all
[84.898398] Dynamic subtest all: SUCCESS (1.862s)
[84.900796] Subtest evict-prime: SUCCESS (10.494s)
[84.990717] [016/133] (936s left) gem_cs_tlb (engines)
[85.048024] Starting subtest: engines
[85.050361] Starting dynamic subtest: rcs0
[87.206299] Dynamic subtest rcs0: SUCCESS (2.154s)
[87.214882] Starting dynamic subtest: bcs0
[89.358799] Dynamic subtest bcs0: SUCCESS (2.152s)
[89.368572] Starting dynamic subtest: vcs0
[91.511742] Dynamic subtest vcs0: SUCCESS (2.154s)
[91.519812] Starting dynamic subtest: vcs1
[93.666183] Dynamic subtest vcs1: SUCCESS (2.153s)
[93.674620] Starting dynamic subtest: vecs0
[95.819521] Dynamic subtest vecs0: SUCCESS (2.152s)
[95.829171] Starting dynamic subtest: ccs0
[97.971067] Dynamic subtest ccs0: SUCCESS (2.152s)
[97.973407] Subtest engines: SUCCESS (12.920s)
[98.081108] [017/133] (923s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[98.177990] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[98.182061] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[98.258863] [018/133] (922s left) kms_panel_fitting (atomic-fastset)
[98.367342] Starting subtest: atomic-fastset
[98.369684] Starting dynamic subtest: pipe-A-eDP-1
[98.510062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[98.520605] Starting dynamic subtest: pipe-B-eDP-1
[99.779736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.269s)
[99.787891] Starting dynamic subtest: pipe-C-eDP-1
[100.961899] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[100.970617] Starting dynamic subtest: pipe-D-eDP-1
[102.106876] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[102.109361] Subtest atomic-fastset: SUCCESS (3.741s)
[103.348566] [019/133] (917s left) gem_mmap_gtt (fault-concurrent)
[103.413816] Subtest fault-concurrent: SKIP (0.000s)
[103.474464] [020/133] (917s left) gem_caching (read-writes)
[103.535849] Subtest read-writes: SKIP (0.000s)
[103.605742] [021/133] (917s left) kms_flip (flip-vs-panning-vs-hang)
[103.703975] Starting subtest: flip-vs-panning-vs-hang
[103.706080] Starting dynamic subtest: A-eDP1
[143.360744] Dynamic subtest A-eDP1: SUCCESS (39.658s)
[143.368466] Starting dynamic subtest: D-eDP1
[193.404510] Dynamic subtest D-eDP1: SUCCESS (50.041s)
[193.410182] Subtest flip-vs-panning-vs-hang: SUCCESS (89.704s)
[194.621901] [022/133] (826s left) gem_exec_reloc (basic-write-gtt-active)
[194.695490] Subtest basic-write-gtt-active: SKIP (0.000s)
[194.765748] [023/133] (826s left) kms_lease (lease-invalid-plane)
[194.860282] Starting subtest: lease-invalid-plane
[194.862528] Starting dynamic subtest: pipe-A-eDP-1
[194.864503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[194.872736] Starting dynamic subtest: pipe-B-eDP-1
[194.875077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[194.881959] Starting dynamic subtest: pipe-C-eDP-1
[194.884190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[194.891127] Starting dynamic subtest: pipe-D-eDP-1
[194.893031] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[194.894980] Subtest lease-invalid-plane: SUCCESS (0.002s)
[194.927196] [024/133] (826s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[194.982965] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[194.985372] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[195.080108] [025/133] (826s left) dmabuf_sync_file (import-basic)
[195.189710] Starting subtest: import-basic
[195.191960] Subtest import-basic: SUCCESS (0.001s)
[195.241788] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[195.245925] [026/133] (826s left) kms_color (ctm-0-75)
[195.331937] Starting subtest: ctm-0-75
[195.334465] Starting dynamic subtest: pipe-A-eDP-1
[200.259036] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.927s)
[200.267313] Starting dynamic subtest: pipe-B-eDP-1
[206.000292] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.739s)
[206.009400] Starting dynamic subtest: pipe-C-eDP-1
[211.367485] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.368s)
[211.375634] Starting dynamic subtest: pipe-D-eDP-1
[216.680681] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.311s)
[216.682637] Subtest ctm-0-75: SUCCESS (21.348s)
[217.509409] [027/133] (804s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[217.638379] Starting subtest: cursorA-vs-flipA-atomic-transitions
[228.805944] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.168s)
[229.637276] [028/133] (791s left) gem_exec_params (rel-constants-invalid-ring)
[229.710883] Starting subtest: rel-constants-invalid-ring
[229.713437] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[229.827332] [029/133] (791s left) kms_pm_rpm (modeset-non-lpsp-stress)
[232.070212] Starting subtest: modeset-non-lpsp-stress
[233.233788] Subtest modeset-non-lpsp-stress: SKIP (1.160s)
[233.603744] [030/133] (788s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[233.697270] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[233.699569] Starting dynamic subtest: pipe-A-eDP-1
[233.708809] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.716856] Starting dynamic subtest: pipe-B-eDP-1
[233.726085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.733277] Starting dynamic subtest: pipe-C-eDP-1
[233.742037] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.749433] Starting dynamic subtest: pipe-D-eDP-1
[233.758202] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.762586] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[235.936558] [031/133] (785s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[236.026642] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[236.028748] Starting dynamic subtest: pipe-A-eDP-1
[236.052479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[236.060615] Starting dynamic subtest: pipe-B-eDP-1
[236.083368] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[236.090343] Starting dynamic subtest: pipe-C-eDP-1
[236.113174] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[236.120119] Starting dynamic subtest: pipe-D-eDP-1
[236.146208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[236.150605] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[238.213597] [032/133] (783s left) kms_cursor_crc (cursor-onscreen-256x256)
[238.456717] Starting subtest: cursor-onscreen-256x256
[238.461597] Starting dynamic subtest: pipe-A-eDP-1
[240.547654] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.085s)
[240.575160] Starting dynamic subtest: pipe-D-eDP-1
[243.314131] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.743s)
[243.316273] Subtest cursor-onscreen-256x256: SUCCESS (4.854s)
[244.179198] [033/133] (777s left) i915_pm_rc6_residency (rc6-accuracy)
[244.241937] Starting subtest: rc6-accuracy
[244.244669] Starting dynamic subtest: gt0
[247.414047] Dynamic subtest gt0: SUCCESS (3.169s)
[247.424653] Starting dynamic subtest: gt1
[250.586608] Dynamic subtest gt1: SUCCESS (3.168s)
[250.589131] Subtest rc6-accuracy: SUCCESS (6.345s)
[250.661969] [034/133] (771s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[250.778348] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[250.782961] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[250.843310] [035/133] (770s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[250.934247] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[251.736512] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[251.909542] [036/133] (769s left) gem_exec_fence (keep-in-fence)
[252.079978] Starting subtest: keep-in-fence
[252.082677] Starting dynamic subtest: rcs0
[252.153650] Dynamic subtest rcs0: SUCCESS (0.074s)
[252.164803] Starting dynamic subtest: bcs0
[252.207102] Dynamic subtest bcs0: SUCCESS (0.051s)
[252.217451] Starting dynamic subtest: vcs0
[253.912456] Dynamic subtest vcs0: SUCCESS (1.701s)
[253.921674] Starting dynamic subtest: vcs1
[255.895384] Dynamic subtest vcs1: SUCCESS (1.980s)
[255.905546] Starting dynamic subtest: vecs0
[257.879234] Dynamic subtest vecs0: SUCCESS (1.981s)
[257.890432] Starting dynamic subtest: ccs0
[258.118231] Dynamic subtest ccs0: SUCCESS (0.237s)
[258.120897] Subtest keep-in-fence: SUCCESS (6.039s)
[260.017319] [037/133] (761s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[260.119580] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[260.124309] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[260.190641] [038/133] (761s left) kms_plane_lowres (tiling-none)
[260.286567] Starting subtest: tiling-none
[260.288808] Starting dynamic subtest: pipe-A-eDP-1
[260.293174] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.590429] Starting dynamic subtest: pipe-B-eDP-1
[260.595603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.602563] Starting dynamic subtest: pipe-C-eDP-1
[260.606952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.613964] Starting dynamic subtest: pipe-D-eDP-1
[260.618584] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.623299] Subtest tiling-none: SKIP (0.306s)
[261.413293] [039/133] (760s left) gem_exec_schedule (preemptive-hang)
[261.589905] Starting subtest: preemptive-hang
[261.592776] Starting dynamic subtest: rcs0
[271.039871] Dynamic subtest rcs0: SUCCESS (9.446s)
[271.047427] Starting dynamic subtest: bcs0
[279.997031] Dynamic subtest bcs0: SUCCESS (8.958s)
[280.007445] Starting dynamic subtest: vcs0
[289.023694] Dynamic subtest vcs0: SUCCESS (9.025s)
[289.031278] Starting dynamic subtest: vcs1
[298.049152] Dynamic subtest vcs1: SUCCESS (9.021s)
[298.060827] Starting dynamic subtest: vecs0
[307.001995] Dynamic subtest vecs0: SUCCESS (8.955s)
[307.009800] Starting dynamic subtest: ccs0
[316.032362] Dynamic subtest ccs0: SUCCESS (9.027s)
[316.034819] Subtest preemptive-hang: SUCCESS (54.441s)
[316.295997] [040/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[316.392520] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[316.396788] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[316.483718] [041/133] (705s left) kms_psr (fbc-psr2-dpms)
[316.584265] Starting subtest: fbc-psr2-dpms
[316.586637] Starting dynamic subtest: eDP-1
[316.591041] Dynamic subtest eDP-1: SKIP (0.000s)
[316.595330] Subtest fbc-psr2-dpms: SKIP (0.001s)
[316.670435] [042/133] (705s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[316.756998] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[316.760870] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[316.827164] [043/133] (705s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[316.924923] Starting subtest: 4-tiled-32bpp-rotate-270
[316.945059] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[317.059882] [044/133] (705s left) gem_exec_schedule (submit-late-slice)
[317.138130] Starting subtest: submit-late-slice
[317.140422] Starting dynamic subtest: rcs0
[317.167825] Dynamic subtest rcs0: SUCCESS (0.039s)
[317.177623] Starting dynamic subtest: bcs0
[317.195243] Dynamic subtest bcs0: SUCCESS (0.027s)
[317.202969] Starting dynamic subtest: vcs0
[317.229548] Dynamic subtest vcs0: SUCCESS (0.033s)
[317.241369] Starting dynamic subtest: vcs1
[317.258155] Dynamic subtest vcs1: SUCCESS (0.027s)
[317.266331] Starting dynamic subtest: vecs0
[317.290543] Dynamic subtest vecs0: SUCCESS (0.031s)
[317.297804] Starting dynamic subtest: ccs0
[317.327618] Dynamic subtest ccs0: SUCCESS (0.036s)
[317.329550] Subtest submit-late-slice: SUCCESS (0.200s)
[319.009109] [045/133] (703s left) gem_mmap_offset (perf)
[319.079636] Starting subtest: perf
[319.081634] Starting dynamic subtest: smem0
[319.426901] Dynamic subtest smem0: SUCCESS (0.344s)
[319.429349] Subtest perf: SUCCESS (0.346s)
[319.526096] [046/133] (702s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[319.597097] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[319.601663] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[319.784152] [047/133] (702s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[319.850603] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[319.924411] [048/133] (702s left) gem_fenced_exec_thrash (2-spare-fences)
[319.989019] Subtest 2-spare-fences: SKIP (0.000s)
[320.058333] [049/133] (702s left) sw_sync (sync_multi_timeline_wait)
[320.097469] Starting subtest: sync_multi_timeline_wait
[320.099778] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[320.163026] [050/133] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[320.277361] Starting subtest: pr-overlay-plane-move-continuous-sf
[320.281646] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[320.344411] [051/133] (702s left) kms_flip (dpms-vs-vblank-race-interruptible)
[320.442669] Starting subtest: dpms-vs-vblank-race-interruptible
[320.445038] Starting dynamic subtest: A-eDP1
[324.369312] Dynamic subtest A-eDP1: SUCCESS (3.924s)
[324.376846] Starting dynamic subtest: B-eDP1
[329.006350] Dynamic subtest B-eDP1: SUCCESS (4.635s)
[329.014154] Starting dynamic subtest: C-eDP1
[333.621879] Dynamic subtest C-eDP1: SUCCESS (4.611s)
[333.632296] Starting dynamic subtest: D-eDP1
[338.254298] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[338.256602] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.813s)
[339.126140] [052/133] (683s left) gem_ccs (block-multicopy-compressed)
[339.181329] Starting subtest: block-multicopy-compressed
[339.186319] Subtest block-multicopy-compressed: SKIP (0.000s)
[339.280034] [053/133] (683s left) perf_pmu (all-busy-idle-check-all)
[339.321056] Starting subtest: all-busy-idle-check-all
[340.887913] Subtest all-busy-idle-check-all: SUCCESS (1.565s)
[341.008014] [054/133] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[341.102060] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[341.105846] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.194128] [055/133] (681s left) kms_universal_plane (universal-plane-functional)
[341.285601] Starting subtest: universal-plane-functional
[341.287940] Starting dynamic subtest: pipe-A-eDP-1
[345.234438] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.948s)
[345.242376] Starting dynamic subtest: pipe-B-eDP-1
[349.675522] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.438s)
[349.685287] Starting dynamic subtest: pipe-C-eDP-1
[354.076020] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.399s)
[354.085584] Starting dynamic subtest: pipe-D-eDP-1
[358.436419] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.360s)
[358.438646] Subtest universal-plane-functional: SUCCESS (17.151s)
[359.291707] [056/133] (663s left) sriov_basic (enable-vfs-bind-unbind-each)
[359.358396] Starting subtest: enable-vfs-bind-unbind-each
[359.360776] Starting dynamic subtest: numvfs-1
[359.439076] Dynamic subtest numvfs-1: FAIL (0.032s)
[359.449348] Starting dynamic subtest: numvfs-2
[359.520241] Dynamic subtest numvfs-2: FAIL (0.005s)
[359.530051] Starting dynamic subtest: numvfs-3
[359.602735] Dynamic subtest numvfs-3: FAIL (0.003s)
[359.611597] Starting dynamic subtest: numvfs-4
[359.683423] Dynamic subtest numvfs-4: FAIL (0.003s)
[359.692060] Starting dynamic subtest: numvfs-5
[359.760596] Dynamic subtest numvfs-5: FAIL (0.003s)
[359.768651] Starting dynamic subtest: numvfs-6
[359.837349] Dynamic subtest numvfs-6: FAIL (0.003s)
[359.845432] Starting dynamic subtest: numvfs-7
[359.914452] Dynamic subtest numvfs-7: FAIL (0.004s)
[359.922286] Starting dynamic subtest: numvfs-random
[359.996091] Dynamic subtest numvfs-random: FAIL (0.003s)
[359.998240] Subtest enable-vfs-bind-unbind-each: FAIL (0.064s)
[360.035502] [057/133] (662s left) gen7_exec_parse (cmd-crossing-page)
[360.095814] Subtest cmd-crossing-page: SKIP (0.000s)
[360.164358] [058/133] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[360.271705] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[360.275183] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[360.368756] [059/133] (662s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[360.468989] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[360.470854] Starting dynamic subtest: pipe-A-eDP-1
[360.487571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[360.498515] Starting dynamic subtest: pipe-B-eDP-1
[360.514190] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[360.521491] Starting dynamic subtest: pipe-C-eDP-1
[360.536917] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[360.544633] Starting dynamic subtest: pipe-D-eDP-1
[360.560235] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[360.561826] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[362.748528] [060/133] (660s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[362.857230] Starting subtest: fbc-2p-pri-indfb-multidraw
[362.861388] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[362.953626] [061/133] (659s left) i915_query (query-topology-coherent-slice-mask)
[363.020678] Starting subtest: query-topology-coherent-slice-mask
[363.024702] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[363.137431] [062/133] (659s left) kms_async_flips (async-flip-dpms)
[363.226090] Starting subtest: async-flip-dpms
[363.599274] Starting dynamic subtest: pipe-A-eDP-1
[367.379972] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.781s)
[367.758611] Starting dynamic subtest: pipe-B-eDP-1
[370.542061] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[370.931965] Starting dynamic subtest: pipe-C-eDP-1
[373.708139] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.783s)
[374.089554] Starting dynamic subtest: pipe-D-eDP-1
[376.877871] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.794s)
[376.880332] Subtest async-flip-dpms: SUCCESS (13.653s)
[378.065157] [063/133] (644s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[378.160854] Starting subtest: fbc-indfb-scaledprimary
[381.150381] Subtest fbc-indfb-scaledprimary: SUCCESS (2.993s)
[382.279064] [064/133] (640s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[382.333474] Subtest tiled-to-untiled: SKIP (0.000s)
[382.401385] [065/133] (640s left) perf_pmu (invalid-init)
[382.436432] Starting subtest: invalid-init
[382.438641] Subtest invalid-init: SUCCESS (0.000s)
[382.528253] [066/133] (640s left) gem_exec_balancer (parallel-contexts)
[382.791177] Starting subtest: parallel-contexts
[385.406833] Subtest parallel-contexts: SUCCESS (2.615s)
[385.490157] [067/133] (637s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[385.613981] Starting subtest: verify-pxp-key-change-after-suspend-resume
[393.669728] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (8.059s)
[393.803773] [068/133] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[393.916239] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[401.058230] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.145s)
[401.172851] [069/133] (622s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[401.555994] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[402.384664] [070/133] (620s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[402.477100] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[402.479420] Starting dynamic subtest: pipe-A-default-mode
[403.677687] Dynamic subtest pipe-A-default-mode: SKIP (1.196s)
[403.682374] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.198s)
[403.837272] [071/133] (619s left) perf_pmu (interrupts)
[403.884023] Starting subtest: interrupts
[404.975883] Subtest interrupts: SUCCESS (1.091s)
[405.102624] [072/133] (618s left) gem_exec_alignment (forked)
[405.157082] Starting subtest: forked
[443.731920] Subtest forked: SUCCESS (38.568s)
[444.440490] [073/133] (578s left) sysfs_heartbeat_interval (mixed)
[444.541039] Starting subtest: mixed
[444.543483] Starting dynamic subtest: vecs0
[449.793289] Dynamic subtest vecs0: SUCCESS (5.251s)
[449.805270] Starting dynamic subtest: ccs0
[454.952552] Dynamic subtest ccs0: SUCCESS (5.157s)
[454.963350] Starting dynamic subtest: vcs0
[460.193187] Dynamic subtest vcs0: SUCCESS (5.239s)
[460.205385] Starting dynamic subtest: bcs0
[465.360516] Dynamic subtest bcs0: SUCCESS (5.165s)
[465.369317] Starting dynamic subtest: rcs0
[470.536617] Dynamic subtest rcs0: SUCCESS (5.175s)
[470.548354] Starting dynamic subtest: vcs1
[475.780069] Dynamic subtest vcs1: SUCCESS (5.240s)
[475.782642] Subtest mixed: SUCCESS (31.239s)
[475.856951] [074/133] (547s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[475.967839] Starting subtest: fbc-psr2-sprite-mmap-gtt
[475.970063] Starting dynamic subtest: eDP-1
[475.974049] Dynamic subtest eDP-1: SKIP (0.000s)
[475.978064] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[476.045216] [075/133] (547s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[476.146510] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[476.148653] Starting dynamic subtest: pipe-A
[476.167492] Dynamic subtest pipe-A: SKIP (0.018s)
[476.176950] Starting dynamic subtest: pipe-B
[476.201061] Dynamic subtest pipe-B: SKIP (0.031s)
[476.210124] Starting dynamic subtest: pipe-C
[476.231677] Dynamic subtest pipe-C: SKIP (0.030s)
[476.240580] Starting dynamic subtest: pipe-D
[476.262387] Dynamic subtest pipe-D: SKIP (0.029s)
[476.266043] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.111s)
[476.360431] [076/133] (547s left) kms_addfb_basic (size-max)
[476.454492] Starting subtest: size-max
[476.456678] Subtest size-max: SUCCESS (0.000s)
[476.545728] [077/133] (547s left) gem_partial_pwrite_pread (write-uncached)
[476.613552] Subtest write-uncached: SKIP (0.000s)
[476.684343] [078/133] (546s left) kms_joiner (basic-force-big-joiner)
[476.777823] Starting subtest: basic-force-big-joiner
[476.781188] Subtest basic-force-big-joiner: SKIP (0.000s)
[476.847426] [079/133] (546s left) syncobj_timeline (single-wait-all-signaled)
[476.902626] Starting subtest: single-wait-all-signaled
[476.904555] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[476.994102] [080/133] (546s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[477.075525] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[477.077546] Starting dynamic subtest: pipe-A-eDP-1
[477.096596] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.111270] Starting dynamic subtest: pipe-B-eDP-1
[477.129502] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.138695] Starting dynamic subtest: pipe-C-eDP-1
[477.155869] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.164064] Starting dynamic subtest: pipe-D-eDP-1
[477.181176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.184550] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[479.213182] [081/133] (544s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[479.310228] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[480.101238] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[480.274504] [082/133] (543s left) gem_mmap_wc (bad-size)
[480.345675] Subtest bad-size: SKIP (0.000s)
[480.402457] [083/133] (543s left) kms_vblank (wait-forked-hang)
[480.495991] Starting subtest: wait-forked-hang
[480.497920] Starting dynamic subtest: pipe-A-eDP-1
[506.640622] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.144s)
[506.661056] Starting dynamic subtest: pipe-D-eDP-1
[521.691986] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.048s)
[521.694322] Subtest wait-forked-hang: SUCCESS (41.197s)
[522.574872] [084/133] (501s left) gem_fence_thrash (bo-copy)
[522.614375] Starting subtest: bo-copy
[522.636146] Subtest bo-copy: SKIP (0.020s)
[522.694133] [085/133] (501s left) gem_vm_create (invalid-destroy)
[522.756065] Starting subtest: invalid-destroy
[522.758445] Subtest invalid-destroy: SUCCESS (0.002s)
[522.874422] [086/133] (501s left) kms_big_fb (y-tiled-addfb)
[522.982392] Starting subtest: y-tiled-addfb
[522.986724] Subtest y-tiled-addfb: SKIP (0.000s)
[523.070984] [087/133] (500s left) gem_lmem_swapping (heavy-verify-multi)
[523.110069] Subtest heavy-verify-multi: SKIP (0.000s)
[523.150316] [088/133] (500s left) gem_eio (in-flight-suspend)
[523.358236] Starting subtest: in-flight-suspend
[566.392894] Subtest in-flight-suspend: SUCCESS (13.563s)
[566.570525] [089/133] (457s left) sw_sync (sync_merge_invalid)
[566.620020] Starting subtest: sync_merge_invalid
[566.638299] Subtest sync_merge_invalid: SUCCESS (0.019s)
[566.710892] [090/133] (457s left) gem_mmap (bad-offset)
[566.770421] Subtest bad-offset: SKIP (0.000s)
[566.827294] [091/133] (457s left) gem_exec_whisper (basic-normal)
[566.908369] Starting subtest: basic-normal
[572.514258] Subtest basic-normal: SUCCESS (5.597s)
[572.702935] [092/133] (451s left) gem_sync (basic-all)
[572.785099] Starting subtest: basic-all
[576.412058] Subtest basic-all: SUCCESS (3.633s)
[576.609626] [093/133] (447s left) i915_query (query-topology-unsupported)
[576.660749] Starting subtest: query-topology-unsupported
[576.665063] Subtest query-topology-unsupported: SKIP (0.000s)
[576.769008] [094/133] (447s left) kms_psr (psr-sprite-plane-move)
[576.875810] Starting subtest: psr-sprite-plane-move
[576.878059] Starting dynamic subtest: eDP-1
[578.664174] Dynamic subtest eDP-1: SUCCESS (1.785s)
[578.666181] Subtest psr-sprite-plane-move: SUCCESS (1.786s)
[579.503356] [095/133] (444s left) kms_atomic (plane-immutable-zpos)
[579.611908] Starting subtest: plane-immutable-zpos
[579.614251] Starting dynamic subtest: pipe-A-eDP-1
[580.256381] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[580.258327] Subtest plane-immutable-zpos: SUCCESS (0.645s)
[581.124875] [096/133] (443s left) kms_addfb_basic (bad-pitch-1024)
[581.170087] Starting subtest: bad-pitch-1024
[581.172296] Subtest bad-pitch-1024: SUCCESS (0.000s)
[581.311307] [097/133] (443s left) syncobj_eventfd (binary-wait-before-signal)
[581.378632] Starting subtest: binary-wait-before-signal
[581.408286] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[581.487696] [098/133] (442s left) kms_cursor_edge_walk (256x256-top-edge)
[581.589676] Starting subtest: 256x256-top-edge
[581.591996] Starting dynamic subtest: pipe-A-eDP-1
[585.101456] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[585.111931] Starting dynamic subtest: pipe-D-eDP-1
[588.223105] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[588.225425] Subtest 256x256-top-edge: SUCCESS (6.633s)
[589.027371] [099/133] (435s left) kms_psr (pr-suspend)
[589.127709] Starting subtest: pr-suspend
[589.132201] Subtest pr-suspend: SKIP (0.000s)
[589.199967] [100/133] (435s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[589.255572] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[589.363245] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[589.442530] [101/133] (435s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[589.546128] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[593.765481] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.223s)
[594.939722] [102/133] (429s left) gem_ctx_isolation (nonpriv)
[595.003849] Starting subtest: nonpriv
[595.006103] Starting dynamic subtest: rcs0
[595.236372] Dynamic subtest rcs0: SUCCESS (0.232s)
[595.248628] Starting dynamic subtest: bcs0
[595.486429] Dynamic subtest bcs0: SUCCESS (0.249s)
[595.496078] Starting dynamic subtest: vcs0
[595.756640] Dynamic subtest vcs0: SUCCESS (0.268s)
[595.768913] Starting dynamic subtest: vcs1
[597.634304] Dynamic subtest vcs1: SUCCESS (1.877s)
[597.646480] Starting dynamic subtest: vecs0
[599.616864] Dynamic subtest vecs0: SUCCESS (1.981s)
[599.626499] Starting dynamic subtest: ccs0
[601.669474] Dynamic subtest ccs0: SUCCESS (2.051s)
[601.671876] Subtest nonpriv: SUCCESS (6.664s)
[601.921117] [103/133] (422s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[602.051777] Starting subtest: 2x-flip-vs-cursor-legacy
[602.056504] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[602.197783] [104/133] (422s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[602.290970] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[602.295286] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[602.398635] [105/133] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[602.499938] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[609.495326] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.995s)
[609.608876] [106/133] (415s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[609.668703] Starting subtest: invalid-single-wait-unsubmitted
[609.670956] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[609.777214] [107/133] (415s left) api_intel_bb (object-noreloc-purge-cache-simple)
[609.831002] Starting subtest: object-noreloc-purge-cache-simple
[609.834561] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[609.950138] [108/133] (414s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[610.048510] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[610.052949] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[610.143306] [109/133] (414s left) kms_content_protection (legacy-hdcp14)
[610.286737] Starting subtest: legacy-hdcp14
[610.291082] Subtest legacy-hdcp14: SKIP (0.000s)
[610.422056] [110/133] (414s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[610.517100] Starting subtest: psr2-cursor-plane-update-sf
[610.519064] Starting dynamic subtest: pipe-A-eDP-1
[611.096074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[611.106209] Starting dynamic subtest: pipe-B-eDP-1
[612.358169] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[612.360602] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.847s)
[613.232134] [111/133] (411s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[613.348362] Starting subtest: short-busy-flip-before-cursor-toggle
[613.352730] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[613.494084] [112/133] (411s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[613.597834] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[613.602284] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[613.697897] [113/133] (411s left) gen9_exec_parse (unaligned-access)
[613.758807] Subtest unaligned-access: SKIP (0.000s)
[613.844966] [114/133] (411s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[613.944318] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[613.948494] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[614.046619] [115/133] (411s left) kms_vrr (flip-suspend)
[614.137232] Starting subtest: flip-suspend
[614.143368] Subtest flip-suspend: SKIP (0.000s)
[614.222357] [116/133] (410s left) drm_read (short-buffer-block)
[614.380039] Starting subtest: short-buffer-block
[614.382083] Subtest short-buffer-block: SUCCESS (0.000s)
[614.524970] [117/133] (410s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[614.629149] Starting subtest: read-crc-frame-sequence
[614.630949] Starting dynamic subtest: pipe-A-eDP-1
[615.334059] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[615.344795] Starting dynamic subtest: pipe-B-eDP-1
[616.690104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[616.700867] Starting dynamic subtest: pipe-C-eDP-1
[617.978308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[617.989080] Starting dynamic subtest: pipe-D-eDP-1
[619.318281] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[619.320132] Subtest read-crc-frame-sequence: SUCCESS (4.687s)
[620.143993] [118/133] (405s left) perf_pmu (most-busy-idle-check-all)
[620.191518] Starting subtest: most-busy-idle-check-all
[620.193427] Starting dynamic subtest: rcs0
[621.367775] Dynamic subtest rcs0: SUCCESS (1.176s)
[621.380960] Starting dynamic subtest: bcs0
[623.415254] Dynamic subtest bcs0: SUCCESS (2.044s)
[623.427385] Starting dynamic subtest: vcs0
[625.399580] Dynamic subtest vcs0: SUCCESS (1.980s)
[625.412397] Starting dynamic subtest: vcs1
[627.383784] Dynamic subtest vcs1: SUCCESS (1.980s)
[627.396056] Starting dynamic subtest: vecs0
[629.366590] Dynamic subtest vecs0: SUCCESS (1.979s)
[629.379166] Starting dynamic subtest: ccs0
[631.350834] Dynamic subtest ccs0: SUCCESS (1.981s)
[631.353624] Subtest most-busy-idle-check-all: SUCCESS (11.158s)
[631.463600] [119/133] (393s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[631.592923] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[631.595275] Starting dynamic subtest: pipe-A-eDP-1
[631.641356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.047s)
[631.654874] Starting dynamic subtest: pipe-B-eDP-1
[631.674580] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[631.683995] Starting dynamic subtest: pipe-C-eDP-1
[631.702935] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[631.712197] Starting dynamic subtest: pipe-D-eDP-1
[631.731480] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[631.733691] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.124s)
[633.916597] [120/133] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[634.024080] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[634.028055] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[634.105209] [121/133] (391s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[634.207059] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[634.211442] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[634.289797] [122/133] (391s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[634.396450] Starting subtest: psr-rgb101010-draw-blt
[641.728585] Subtest psr-rgb101010-draw-blt: SUCCESS (7.333s)
[641.841280] [123/133] (383s left) gem_exec_flush (basic-wb-prw-default)
[641.903885] Starting subtest: basic-wb-prw-default
[647.361080] Subtest basic-wb-prw-default: SUCCESS (5.457s)
[647.549230] [124/133] (378s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[647.608387] Starting subtest: multi-wait-all-for-submit-signaled
[647.610828] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[647.725422] [125/133] (377s left) i915_hangman (hangcheck-unterminated)
[647.798576] Starting subtest: hangcheck-unterminated
[659.349436] Subtest hangcheck-unterminated: SUCCESS (11.549s)
[659.487356] [126/133] (366s left) gem_exec_balancer (full-late)
[659.561683] Starting subtest: full-late
[664.446763] Subtest full-late: SUCCESS (4.884s)
[664.758721] [127/133] (360s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[664.868667] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[671.453300] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.588s)
[671.586890] [128/133] (354s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[671.854611] Starting subtest: cursor-rapid-movement-256x85
[671.903769] Subtest cursor-rapid-movement-256x85: SKIP (0.046s)
[672.069276] [129/133] (353s left) syncobj_timeline (etime-single-wait-submitted)
[672.140596] Starting subtest: etime-single-wait-submitted
[672.243210] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[672.319727] [130/133] (353s left) gem_userptr_blits (coherency-sync)
[672.382018] Starting subtest: coherency-sync
[672.536830] Subtest coherency-sync: SKIP (0.121s)
[672.636776] [131/133] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[672.782671] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[672.787070] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[672.883281] [132/133] (353s left) gem_exec_schedule (implicit-boths)
[672.961089] Starting subtest: implicit-boths
[672.963417] Starting dynamic subtest: rcs0
[673.059046] Dynamic subtest rcs0: SUCCESS (0.108s)
[673.072134] Starting dynamic subtest: vcs0
[673.158269] Dynamic subtest vcs0: SUCCESS (0.099s)
[673.170878] Starting dynamic subtest: vcs1
[673.243926] Dynamic subtest vcs1: SUCCESS (0.084s)
[673.256814] Starting dynamic subtest: vecs0
[673.319829] Dynamic subtest vecs0: SUCCESS (0.076s)
[673.333569] Starting dynamic subtest: ccs0
[673.420061] Dynamic subtest ccs0: SUCCESS (0.100s)
[673.422441] Subtest implicit-boths: SUCCESS (0.470s)
[674.434382] [133/133] (351s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[674.561854] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[674.566169] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[674.657319] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_chamelium_frames
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: i915_suspend
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: gem_exec_capture
results: parsing output: 12/ for test: kms_dsc
results: parsing output: 13/ for test: gem_userptr_blits
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_cs_tlb
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_panel_fitting
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_caching
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_pm_rpm
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: i915_pm_rc6_residency
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_plane_lowres
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_plane
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_fenced_exec_thrash
results: parsing output: 48/ for test: sw_sync
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: gem_ccs
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_universal_plane
results: parsing output: 55/ for test: sriov_basic
results: parsing output: 56/ for test: gen7_exec_parse
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_set_tiling_vs_blt
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gem_exec_alignment
results: parsing output: 72/ for test: sysfs_heartbeat_interval
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: kms_joiner
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: gem_fence_thrash
results: parsing output: 84/ for test: gem_vm_create
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: sw_sync
results: parsing output: 89/ for test: gem_mmap
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: i915_query
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_atomic
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: syncobj_eventfd
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_isolation
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: drm_read
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: perf_pmu
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_flush
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: i915_hangman
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.