[58.738108] Initializing watchdogs
[58.738242]   /dev/watchdog0
[58.755514] [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]
[58.759934] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.762163] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.764104] [001/133] (960s left) gem_userptr_blits (process-exit)
[58.821340] Starting subtest: process-exit
[58.829157] Subtest process-exit: SUCCESS (0.008s)
[58.951400] [002/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[59.041941] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[59.043684] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[60.138728] [003/133] (959s left) i915_pm_rps (waitboost)
[60.208112] Starting subtest: waitboost
[66.294217] Subtest waitboost: SUCCESS (6.103s)
[66.427158] [004/133] (952s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[66.547500] Starting subtest: flip-vs-cursor-crc-atomic
[67.229412] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.682s)
[68.068803] [005/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[68.290828] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[68.292529] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.408211] [006/133] (951s left) i915_pm_freq_api (freq-basic-api)
[68.466441] Starting subtest: freq-basic-api
[68.467500] Starting dynamic subtest: gt0
[68.468478] Dynamic subtest gt0: SUCCESS (0.002s)
[68.475869] Starting dynamic subtest: gt1
[68.476751] Dynamic subtest gt1: SUCCESS (0.003s)
[68.477586] Subtest freq-basic-api: SUCCESS (0.005s)
[68.583073] [007/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[68.639475] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[68.747896] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[68.822961] [008/133] (950s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[68.909442] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[68.910330] Starting dynamic subtest: pipe-A-eDP-1
[68.918315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[68.924605] Starting dynamic subtest: pipe-B-eDP-1
[68.932538] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.938086] Starting dynamic subtest: pipe-C-eDP-1
[68.945915] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.951163] Starting dynamic subtest: pipe-D-eDP-1
[68.958793] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.959653] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[71.141268] [009/133] (948s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[71.239965] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[71.241871] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[71.312312] [010/133] (948s left) kms_pm_rpm (modeset-non-lpsp-stress)
[73.037105] Starting subtest: modeset-non-lpsp-stress
[74.206164] Subtest modeset-non-lpsp-stress: SKIP (1.168s)
[74.585540] [011/133] (944s left) kms_cursor_crc (cursor-dpms)
[74.716212] Starting subtest: cursor-dpms
[74.717075] Starting dynamic subtest: pipe-A-eDP-1
[77.748792] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.033s)
[77.755833] Starting dynamic subtest: pipe-D-eDP-1
[81.322914] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.572s)
[81.323840] Subtest cursor-dpms: SUCCESS (6.606s)
[82.178191] [012/133] (937s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[82.283052] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[82.284635] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[82.406570] [013/133] (937s left) kms_content_protection (uevent-hdcp14)
[82.561427] Starting subtest: uevent-hdcp14
[82.563217] Subtest uevent-hdcp14: SKIP (0.000s)
[82.720259] [014/133] (936s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[82.782497] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[82.852925] [015/133] (936s left) perf_pmu (init-wait)
[82.889506] Starting subtest: init-wait
[82.890470] Starting dynamic subtest: rcs0
[82.892434] Dynamic subtest rcs0: SUCCESS (0.002s)
[82.899861] Starting dynamic subtest: bcs0
[82.900788] Dynamic subtest bcs0: SUCCESS (0.000s)
[82.906228] Starting dynamic subtest: vcs0
[82.907068] Dynamic subtest vcs0: SUCCESS (0.001s)
[82.912336] Starting dynamic subtest: vcs1
[82.913140] Dynamic subtest vcs1: SUCCESS (0.001s)
[82.918471] Starting dynamic subtest: vecs0
[82.919293] Dynamic subtest vecs0: SUCCESS (0.000s)
[82.924635] Starting dynamic subtest: ccs0
[82.925433] Dynamic subtest ccs0: SUCCESS (0.000s)
[82.926343] Subtest init-wait: SUCCESS (0.006s)
[82.975061] [016/133] (936s left) kms_addfb_basic (master-rmfb)
[83.028065] Starting subtest: master-rmfb
[83.029030] Subtest master-rmfb: SUCCESS (0.001s)
[83.177852] [017/133] (936s left) gem_userptr_blits (unsync-unmap-cycles)
[83.237519] Subtest unsync-unmap-cycles: SKIP (0.000s)
[83.395829] [018/133] (936s left) gem_mmap_gtt (zero-extend)
[83.461204] Subtest zero-extend: SKIP (0.000s)
[83.511712] [019/133] (936s left) perf (blocking-parameterized)
[83.622902] Starting subtest: blocking-parameterized
[103.648286] Subtest blocking-parameterized: SUCCESS (20.020s)
[103.686279] [020/133] (916s left) gem_exec_reloc (basic-wc-gtt-active)
[103.742382] Subtest basic-wc-gtt-active: SKIP (0.000s)
[103.790677] [021/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[103.883610] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[103.885307] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[104.005209] [022/133] (915s left) kms_vblank (ts-continuation-idle-hang)
[104.096449] Starting subtest: ts-continuation-idle-hang
[104.097482] Starting dynamic subtest: pipe-A-eDP-1
[130.729559] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.630s)
[130.737825] Starting dynamic subtest: pipe-D-eDP-1
[155.726216] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.994s)
[155.727188] Subtest ts-continuation-idle-hang: SUCCESS (51.628s)
[156.527702] [023/133] (863s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[156.587683] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[156.588761] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[156.714483] [024/133] (863s left) kms_psr (psr-cursor-render)
[156.807269] Starting subtest: psr-cursor-render
[156.808184] Starting dynamic subtest: eDP-1
[158.528934] Dynamic subtest eDP-1: SUCCESS (1.722s)
[158.529901] Subtest psr-cursor-render: SUCCESS (1.722s)
[159.401256] [025/133] (860s left) gem_tiled_blits (interruptible)
[159.463604] Subtest interruptible: SKIP (0.000s)
[159.548336] [026/133] (860s left) kms_tiled_display (basic-test-pattern)
[159.653926] Subtest basic-test-pattern: SKIP (0.000s)
[159.703679] [027/133] (860s left) gem_exec_params (dr1-dirt)
[159.768353] Starting subtest: DR1-dirt
[159.769622] Subtest DR1-dirt: SUCCESS (0.000s)
[159.884494] [028/133] (860s left) gem_eio (banned)
[160.098233] Starting subtest: banned
[160.655440] Subtest banned: SUCCESS (0.559s)
[160.843334] [029/133] (859s left) syncobj_timeline (wait-all-interrupted)
[160.901069] Starting subtest: wait-all-interrupted
[161.004585] Subtest wait-all-interrupted: SUCCESS (0.102s)
[161.078643] [030/133] (859s left) gem_lmem_swapping (heavy-random)
[161.116052] Subtest heavy-random: SKIP (0.000s)
[161.154136] [031/133] (858s left) kms_atomic (crtc-invalid-params-fence)
[161.246482] Starting subtest: crtc-invalid-params-fence
[161.247499] Starting dynamic subtest: pipe-A-eDP-1
[161.667590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[161.668566] Subtest crtc-invalid-params-fence: SUCCESS (0.423s)
[162.529180] [032/133] (857s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[162.625980] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[162.654265] Starting dynamic subtest: pipe-A-plane-0
[162.656249] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[162.664171] Starting dynamic subtest: pipe-A-plane-3
[162.666038] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[162.673531] Starting dynamic subtest: pipe-A-plane-5
[162.675264] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[163.814607] Starting dynamic subtest: pipe-B-plane-0
[163.816471] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[163.822794] Starting dynamic subtest: pipe-B-plane-3
[163.824738] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[163.830566] Starting dynamic subtest: pipe-B-plane-5
[163.832380] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[164.118968] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (1.491s)
[164.994051] [033/133] (855s left) gem_exec_fence (nb-await)
[165.168919] Starting subtest: nb-await
[165.170038] Starting dynamic subtest: rcs0
[165.240084] Dynamic subtest rcs0: SUCCESS (0.070s)
[165.248936] Starting dynamic subtest: bcs0
[165.298909] Dynamic subtest bcs0: SUCCESS (0.058s)
[165.307143] Starting dynamic subtest: vcs0
[165.358428] Dynamic subtest vcs0: SUCCESS (0.058s)
[165.366963] Starting dynamic subtest: vcs1
[165.417092] Dynamic subtest vcs1: SUCCESS (0.058s)
[165.425098] Starting dynamic subtest: vecs0
[165.476383] Dynamic subtest vecs0: SUCCESS (0.058s)
[165.484988] Starting dynamic subtest: ccs0
[165.534759] Dynamic subtest ccs0: SUCCESS (0.057s)
[165.535951] Subtest nb-await: SUCCESS (0.366s)
[166.976897] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[166.978588] [034/133] (853s left) syncobj_timeline (reset-signaled)
[167.038247] Starting subtest: reset-signaled
[167.039257] Subtest reset-signaled: SUCCESS (0.000s)
[167.180355] [035/133] (853s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[167.245714] Subtest writes-after-reads: SKIP (0.000s)
[167.329542] [036/133] (852s left) kms_invalid_mode (bad-vsync-start)
[167.424760] Starting subtest: bad-vsync-start
[167.425717] Starting dynamic subtest: pipe-A-eDP-1
[167.707919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[167.714680] Starting dynamic subtest: pipe-B-eDP-1
[167.715588] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[167.721454] Starting dynamic subtest: pipe-C-eDP-1
[167.722353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[167.728213] Starting dynamic subtest: pipe-D-eDP-1
[167.729073] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[167.729928] Subtest bad-vsync-start: SUCCESS (0.287s)
[168.552729] [037/133] (851s left) gem_mmap_gtt (basic-small-bo-tiledy)
[168.617363] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[168.692525] [038/133] (851s left) kms_flip (flip-vs-fences-interruptible)
[168.787326] Starting subtest: flip-vs-fences-interruptible
[168.789099] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[168.921705] [039/133] (851s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[169.012421] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[169.014155] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[169.131561] [040/133] (851s left) kms_flip (dpms-off-confusion)
[169.224877] Starting subtest: dpms-off-confusion
[169.227198] Starting dynamic subtest: A-eDP1
[177.925499] Dynamic subtest A-eDP1: SUCCESS (8.699s)
[177.938130] Starting dynamic subtest: B-eDP1
[186.550828] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[186.558991] Starting dynamic subtest: C-eDP1
[195.174061] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[195.180915] Starting dynamic subtest: D-eDP1
[203.806769] Dynamic subtest D-eDP1: SUCCESS (8.632s)
[203.809809] Subtest dpms-off-confusion: SUCCESS (34.584s)
[205.080303] [041/133] (815s left) kms_plane_alpha_blend (coverage-7efc)
[205.171257] Starting subtest: coverage-7efc
[205.451143] Starting dynamic subtest: pipe-A-eDP-1
[206.006800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[206.029878] Starting dynamic subtest: pipe-D-eDP-1
[207.284235] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[207.285153] Subtest coverage-7efc: SUCCESS (2.114s)
[208.177266] [042/133] (812s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[208.286647] Starting subtest: 4-tiled-64bpp-rotate-0
[209.953281] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.667s)
[210.141042] [043/133] (810s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[210.270226] Starting subtest: cursor-tearing-framebuffer-change
[210.272248] Starting dynamic subtest: pipe-A-eDP-1
[210.839996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.568s)
[210.846848] Starting dynamic subtest: pipe-D-eDP-1
[212.101780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[212.102637] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.831s)
[212.947081] [044/133] (807s left) kms_plane (pixel-format-yf-tiled-modifier)
[213.044314] Starting subtest: pixel-format-yf-tiled-modifier
[213.071420] Starting dynamic subtest: pipe-A-plane-0
[213.073324] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[213.081434] Starting dynamic subtest: pipe-A-plane-3
[213.083192] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[213.089321] Starting dynamic subtest: pipe-A-plane-5
[213.091091] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[214.115276] Starting dynamic subtest: pipe-B-plane-0
[214.116886] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[214.123076] Starting dynamic subtest: pipe-B-plane-3
[214.124713] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[214.130880] Starting dynamic subtest: pipe-B-plane-5
[214.132584] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[214.421963] Subtest pixel-format-yf-tiled-modifier: SKIP (1.377s)
[215.293280] [045/133] (805s left) gem_exec_balancer (bonded-true-hang)
[215.546682] Starting subtest: bonded-true-hang
[215.548598] Subtest bonded-true-hang: SKIP (0.000s)
[215.665581] [046/133] (805s left) gem_mmap_gtt (basic-write-read-distinct)
[215.709959] Subtest basic-write-read-distinct: SKIP (0.000s)
[215.772058] [047/133] (804s left) kms_pm_lpsp (screens-disabled)
[216.871906] Starting subtest: screens-disabled
[216.874777] Subtest screens-disabled: SKIP (0.000s)
[216.951788] [048/133] (803s left) gem_ctx_persistence (engines-queued)
[217.006774] Starting subtest: engines-queued
[217.007823] Starting dynamic subtest: rcs0
[217.118199] Dynamic subtest rcs0: SUCCESS (0.110s)
[217.128243] Starting dynamic subtest: bcs0
[217.149132] Dynamic subtest bcs0: SUCCESS (0.031s)
[217.156204] Starting dynamic subtest: vcs0
[218.871868] Dynamic subtest vcs0: SUCCESS (1.719s)
[218.881766] Starting dynamic subtest: vcs1
[220.855875] Dynamic subtest vcs1: SUCCESS (1.981s)
[220.866526] Starting dynamic subtest: vecs0
[222.901500] Dynamic subtest vecs0: SUCCESS (2.043s)
[222.910857] Starting dynamic subtest: ccs0
[223.083205] Dynamic subtest ccs0: SUCCESS (0.182s)
[223.084298] Subtest engines-queued: SUCCESS (6.076s)
[223.225500] [049/133] (797s left) kms_psr (psr-no-drrs)
[223.323323] Starting subtest: psr-no-drrs
[223.324257] Starting dynamic subtest: eDP-1
[224.983425] Dynamic subtest eDP-1: SUCCESS (1.660s)
[224.984433] Subtest psr-no-drrs: SUCCESS (1.661s)
[225.885273] [050/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[225.980854] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[225.982577] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[226.102709] [051/133] (794s left) gem_exec_async (concurrent-writes)
[226.164395] Starting subtest: concurrent-writes
[226.165335] Starting dynamic subtest: rcs0
[226.179423] Dynamic subtest rcs0: SUCCESS (0.016s)
[226.188137] Starting dynamic subtest: bcs0
[226.188964] Dynamic subtest bcs0: SUCCESS (0.006s)
[226.195881] Starting dynamic subtest: vcs0
[226.196767] Dynamic subtest vcs0: SUCCESS (0.005s)
[226.203147] Starting dynamic subtest: vcs1
[226.203992] Dynamic subtest vcs1: SUCCESS (0.007s)
[226.216233] Starting dynamic subtest: vecs0
[226.217323] Dynamic subtest vecs0: SUCCESS (0.005s)
[226.226672] Starting dynamic subtest: ccs0
[226.227557] Dynamic subtest ccs0: SUCCESS (0.006s)
[226.228407] Subtest concurrent-writes: SUCCESS (0.048s)
[226.472427] [052/133] (794s left) gem_flink_basic (basic)
[226.521452] Starting subtest: basic
[226.522449] Subtest basic: SUCCESS (0.000s)
[226.636946] [053/133] (794s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[226.731352] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[226.732289] Starting dynamic subtest: pipe-A-default-mode
[229.525256] Dynamic subtest pipe-A-default-mode: SUCCESS (2.794s)
[229.526039] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.795s)
[230.351785] [054/133] (790s left) kms_lease (possible-crtcs-filtering)
[230.456301] Starting subtest: possible-crtcs-filtering
[230.463033] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[230.591522] [055/133] (790s left) gem_exec_parallel (userptr)
[230.662330] Starting subtest: userptr
[230.663239] Starting dynamic subtest: rcs0
[232.101779] Dynamic subtest rcs0: SUCCESS (1.440s)
[232.111224] Starting dynamic subtest: bcs0
[233.608579] Dynamic subtest bcs0: SUCCESS (1.504s)
[233.618099] Starting dynamic subtest: vcs0
[236.890063] Dynamic subtest vcs0: SUCCESS (3.276s)
[236.899500] Starting dynamic subtest: vcs1
[238.873359] Dynamic subtest vcs1: SUCCESS (1.980s)
[238.882938] Starting dynamic subtest: vecs0
[240.855899] Dynamic subtest vecs0: SUCCESS (1.981s)
[240.864400] Starting dynamic subtest: ccs0
[242.329643] Dynamic subtest ccs0: SUCCESS (1.474s)
[242.330960] Subtest userptr: SUCCESS (11.669s)
[242.520266] [056/133] (778s left) gen7_exec_parse (cmd-crossing-page)
[242.584450] Subtest cmd-crossing-page: SKIP (0.000s)
[242.658505] [057/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[242.752238] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[249.444623] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.693s)
[249.604102] [058/133] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[249.699690] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[249.701317] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[249.795249] [059/133] (771s left) kms_rotation_crc (sprite-rotation-90)
[249.880872] Starting subtest: sprite-rotation-90
[249.882553] Subtest sprite-rotation-90: SKIP (0.001s)
[249.959953] [060/133] (771s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[250.057839] Starting subtest: x-tiled-16bpp-rotate-90
[250.077678] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[250.210869] [061/133] (770s left) kms_chamelium_color (ctm-0-75)
[250.301666] Subtest ctm-0-75: SKIP (0.000s)
[250.342349] [062/133] (770s left) gem_pxp (reject-modify-context-protection-off-2)
[250.468257] Starting subtest: reject-modify-context-protection-off-2
[250.469258] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[250.603437] [063/133] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[250.697192] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[250.698853] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[250.809263] [064/133] (770s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[250.861444] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[250.972066] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[251.052151] [065/133] (770s left) gen9_exec_parse (valid-registers)
[251.112855] Subtest valid-registers: SKIP (0.000s)
[251.193584] [066/133] (770s left) gem_eio (in-flight-internal-immediate)
[251.430231] Starting subtest: in-flight-internal-immediate
[252.958405] Subtest in-flight-internal-immediate: SUCCESS (1.529s)
[253.113750] [067/133] (768s left) gem_tiled_pread_basic (basic)
[253.171995] Subtest basic: SKIP (0.000s)
[253.242200] [068/133] (768s left) kms_addfb_basic (unused-handle)
[253.296721] Starting subtest: unused-handle
[253.297696] Subtest unused-handle: SUCCESS (0.000s)
[253.452796] [069/133] (767s left) kms_psr (pr-primary-blt)
[253.542255] Starting subtest: pr-primary-blt
[253.543834] Subtest pr-primary-blt: SKIP (0.000s)
[253.620840] [070/133] (767s left) gem_exec_schedule (pi-ringfull)
[253.794960] Starting subtest: pi-ringfull
[253.796335] Starting dynamic subtest: rcs0
[253.832283] Dynamic subtest rcs0: SUCCESS (0.038s)
[253.839613] Starting dynamic subtest: bcs0
[253.874903] Dynamic subtest bcs0: SUCCESS (0.042s)
[253.882477] Starting dynamic subtest: vcs0
[253.909442] Dynamic subtest vcs0: SUCCESS (0.034s)
[253.916197] Starting dynamic subtest: vcs1
[253.943227] Dynamic subtest vcs1: SUCCESS (0.033s)
[253.949858] Starting dynamic subtest: vecs0
[253.974497] Dynamic subtest vecs0: SUCCESS (0.030s)
[253.981217] Starting dynamic subtest: ccs0
[254.001732] Dynamic subtest ccs0: SUCCESS (0.027s)
[254.002531] Subtest pi-ringfull: SUCCESS (0.209s)
[254.265307] [071/133] (767s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[254.330755] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[254.332411] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[254.516885] [072/133] (767s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[254.579831] Starting subtest: multi-wait-for-submit-submitted-signaled
[254.580806] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[254.697187] [073/133] (766s left) gem_close_race (multigpu-basic-process)
[254.768607] Starting subtest: multigpu-basic-process
[254.770591] Subtest multigpu-basic-process: SKIP (0.000s)
[255.007598] [074/133] (766s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[255.103092] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[256.137897] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.035s)
[256.322845] [075/133] (765s left) gem_softpin (overlap)
[256.392635] Starting subtest: overlap
[257.324937] Subtest overlap: SUCCESS (0.931s)
[257.474638] [076/133] (764s left) perf_pmu (interrupts-sync)
[257.509588] Starting subtest: interrupts-sync
[258.624351] Subtest interrupts-sync: SUCCESS (1.112s)
[258.772970] [077/133] (762s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[258.861151] Starting subtest: fbc-psr2-cursor-mmap-cpu
[258.861985] Starting dynamic subtest: eDP-1
[258.863759] Dynamic subtest eDP-1: SKIP (0.000s)
[258.865389] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[258.942367] [078/133] (762s left) kms_feature_discovery (dp-mst)
[259.038827] Starting subtest: dp-mst
[259.040430] Subtest dp-mst: SKIP (0.000s)
[259.114067] [079/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[259.214826] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[259.216488] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[259.340607] [080/133] (762s left) syncobj_timeline (etime-single-wait-all-submitted)
[259.386553] Starting subtest: etime-single-wait-all-submitted
[259.492292] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[259.571366] [081/133] (762s left) gem_ctx_persistence (legacy-engines-mixed-process)
[259.639902] Starting subtest: legacy-engines-mixed-process
[259.640869] Starting dynamic subtest: render
[260.910768] Dynamic subtest render: SUCCESS (1.270s)
[260.921325] Starting dynamic subtest: bsd1
[262.892412] Dynamic subtest bsd1: SUCCESS (1.980s)
[262.902959] Starting dynamic subtest: bsd2
[264.964836] Dynamic subtest bsd2: SUCCESS (2.069s)
[264.976415] Starting dynamic subtest: blt
[266.933487] Dynamic subtest blt: SUCCESS (1.966s)
[266.944677] Starting dynamic subtest: vebox
[268.933658] Dynamic subtest vebox: SUCCESS (1.997s)
[268.934721] Subtest legacy-engines-mixed-process: SUCCESS (9.294s)
[269.022331] [082/133] (752s left) kms_frontbuffer_tracking (psr-suspend)
[269.120048] Starting subtest: psr-suspend
[308.141235] Subtest psr-suspend: SUCCESS (9.536s)
[314.322818] [083/133] (713s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[314.416368] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[314.417990] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[315.561128] [084/133] (712s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[315.942290] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[316.735534] [085/133] (711s left) gem_mmap_wc (bad-offset)
[316.787202] Subtest bad-offset: SKIP (0.000s)
[316.842276] [086/133] (711s left) gem_exec_schedule (timeslicing)
[316.905575] Starting subtest: timeslicing
[316.906447] Starting dynamic subtest: rcs0
[316.927773] Dynamic subtest rcs0: SUCCESS (0.024s)
[316.939366] Starting dynamic subtest: bcs0
[316.949370] Dynamic subtest bcs0: SUCCESS (0.020s)
[316.957591] Starting dynamic subtest: vcs0
[316.969146] Dynamic subtest vcs0: SUCCESS (0.019s)
[316.976891] Starting dynamic subtest: vcs1
[316.989381] Dynamic subtest vcs1: SUCCESS (0.020s)
[316.996926] Starting dynamic subtest: vecs0
[317.010136] Dynamic subtest vecs0: SUCCESS (0.020s)
[317.017739] Starting dynamic subtest: ccs0
[317.030249] Dynamic subtest ccs0: SUCCESS (0.020s)
[317.031132] Subtest timeslicing: SUCCESS (0.129s)
[318.447746] [087/133] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[318.550441] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[318.552192] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.681955] [088/133] (709s left) sysfs_heartbeat_interval (invalid)
[318.747857] Starting subtest: invalid
[318.748841] Starting dynamic subtest: vecs0
[318.749774] Dynamic subtest vecs0: SUCCESS (0.000s)
[318.759956] Starting dynamic subtest: ccs0
[318.761281] Dynamic subtest ccs0: SUCCESS (0.000s)
[318.769274] Starting dynamic subtest: vcs0
[318.770219] Dynamic subtest vcs0: SUCCESS (0.000s)
[318.777751] Starting dynamic subtest: bcs0
[318.778640] Dynamic subtest bcs0: SUCCESS (0.000s)
[318.785972] Starting dynamic subtest: rcs0
[318.786912] Dynamic subtest rcs0: SUCCESS (0.000s)
[318.794235] Starting dynamic subtest: vcs1
[318.795128] Dynamic subtest vcs1: SUCCESS (0.000s)
[318.796065] Subtest invalid: SUCCESS (0.006s)
[318.890151] [089/133] (709s left) kms_psr (fbc-pr-primary-blt)
[318.980817] Starting subtest: fbc-pr-primary-blt
[318.982488] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[319.072915] [090/133] (709s left) gem_exec_schedule (wide)
[319.236340] Starting subtest: wide
[319.237564] Starting dynamic subtest: rcs0
[329.437390] Dynamic subtest rcs0: SUCCESS (10.277s)
[329.450307] Starting dynamic subtest: vcs0
[340.251909] Dynamic subtest vcs0: SUCCESS (10.839s)
[340.260896] Starting dynamic subtest: vcs1
[355.753415] Dynamic subtest vcs1: SUCCESS (15.498s)
[355.764782] Starting dynamic subtest: vecs0
[366.870874] Dynamic subtest vecs0: SUCCESS (11.118s)
[366.881838] Starting dynamic subtest: ccs0
[380.631525] Dynamic subtest ccs0: SUCCESS (13.764s)
[380.633222] Subtest wide: SUCCESS (61.503s)
[382.735058] [091/133] (645s left) api_intel_bb (offset-control)
[382.799627] Starting subtest: offset-control
[382.812170] Subtest offset-control: SUCCESS (0.013s)
[382.974009] [092/133] (645s left) fbdev (info)
[383.009790] Starting subtest: info
[383.010923] Subtest info: SUCCESS (0.000s)
[383.095834] [093/133] (645s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[383.197054] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[383.198965] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[383.315969] [094/133] (644s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[383.692397] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[384.503832] [095/133] (643s left) gem_exec_reloc (basic-gtt)
[384.558520] Subtest basic-gtt: SKIP (0.000s)
[384.631631] [096/133] (643s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[384.739052] Starting subtest: y-tiled-8bpp-rotate-0
[384.741061] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[384.849381] [097/133] (643s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[384.944852] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[384.945778] Starting dynamic subtest: pipe-A-eDP-1
[384.970073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.026s)
[384.979956] Starting dynamic subtest: pipe-B-eDP-1
[384.993221] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[385.002285] Starting dynamic subtest: pipe-C-eDP-1
[385.017884] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[385.032679] Starting dynamic subtest: pipe-D-eDP-1
[385.040488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[385.041494] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[387.225236] [098/133] (641s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[387.320921] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[394.282409] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.965s)
[394.424260] [099/133] (634s left) kms_big_fb (linear-8bpp-rotate-270)
[394.533030] Starting subtest: linear-8bpp-rotate-270
[394.554313] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[394.712484] [100/133] (633s left) api_intel_bb (blit-reloc-keep-cache)
[394.767299] Starting subtest: blit-reloc-keep-cache
[394.769329] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[394.900175] [101/133] (633s left) gem_tiled_partial_pwrite_pread (reads)
[394.971042] Subtest reads: SKIP (0.000s)
[395.032894] [102/133] (633s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[395.153741] Starting subtest: cursorA-vs-flipA-atomic
[406.274216] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.123s)
[407.154051] [103/133] (621s left) kms_busy (extended-modeset-hang-newfb)
[407.255400] Starting subtest: extended-modeset-hang-newfb
[407.257686] Starting dynamic subtest: pipe-A
[442.343256] Dynamic subtest pipe-A: SUCCESS (35.078s)
[442.352899] Starting dynamic subtest: pipe-D
[465.331813] Dynamic subtest pipe-D: SUCCESS (22.987s)
[465.332766] Subtest extended-modeset-hang-newfb: SUCCESS (58.070s)
[466.143110] [104/133] (562s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[466.202369] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[466.304347] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[466.387425] [105/133] (562s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[466.486518] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[473.730244] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.244s)
[473.889294] [106/133] (554s left) kms_color_pipeline (plane-ctm3x4)
[473.978758] Starting subtest: plane-ctm3x4
[473.994344] Starting dynamic subtest: pipe-A-eDP-1
[474.411309] Dynamic subtest pipe-A-eDP-1: FAIL (0.276s)
[475.333289] Starting dynamic subtest: pipe-B-eDP-1
[475.767630] Dynamic subtest pipe-B-eDP-1: FAIL (0.257s)
[476.668384] Starting dynamic subtest: pipe-C-eDP-1
[477.099196] Dynamic subtest pipe-C-eDP-1: FAIL (0.223s)
[477.995242] Starting dynamic subtest: pipe-D-eDP-1
[478.458742] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[478.541246] Subtest plane-ctm3x4: FAIL (4.564s)
[479.378427] [107/133] (549s left) kms_cursor_crc (cursor-random-512x170)
[479.645228] Starting subtest: cursor-random-512x170
[479.647230] Subtest cursor-random-512x170: SKIP (0.001s)
[479.828500] [108/133] (548s left) kms_plane_scaling (invalid-num-scalers)
[479.916704] Starting subtest: invalid-num-scalers
[479.917529] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[479.933547] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.016s)
[479.943045] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[479.962101] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.027s)
[479.971357] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[479.991432] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[479.999433] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[480.020364] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[480.021223] Subtest invalid-num-scalers: SUCCESS (0.104s)
[480.146604] [109/133] (548s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[480.255235] Starting subtest: short-flip-after-cursor-atomic-transitions
[481.213859] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.958s)
[482.008478] [110/133] (546s left) gem_exec_params (invalid-bsd-ring)
[482.064802] Starting subtest: invalid-bsd-ring
[482.065726] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[482.179517] [111/133] (546s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[482.279353] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[486.428886] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.151s)
[487.620623] [112/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[487.706739] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[487.708417] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[487.809707] [113/133] (541s left) dmabuf_sync_file (export-wait-after-attach)
[487.845445] Starting subtest: export-wait-after-attach
[487.846315] Subtest export-wait-after-attach: SUCCESS (0.001s)
[487.908614] [114/133] (541s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[487.992955] Starting subtest: fbc-psr-sprite-mmap-cpu
[487.993854] Starting dynamic subtest: eDP-1
[487.995646] Dynamic subtest eDP-1: SKIP (0.000s)
[487.997368] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[488.075964] [115/133] (540s left) gem_mmap_gtt (basic-copy)
[488.123478] Subtest basic-copy: SKIP (0.000s)
[488.184604] [116/133] (540s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[488.278279] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[488.279172] Starting dynamic subtest: pipe-A-eDP-1
[488.378343] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[488.387957] Starting dynamic subtest: pipe-B-eDP-1
[489.474069] Dynamic subtest pipe-B-eDP-1: SKIP (1.095s)
[489.475752] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.197s)
[490.656337] [117/133] (538s left) drm_read (invalid-buffer)
[490.796149] Starting subtest: invalid-buffer
[490.797175] Subtest invalid-buffer: SUCCESS (0.000s)
[490.962773] [118/133] (538s left) kms_display_modes (extended-mode-basic)
[491.058874] Starting subtest: extended-mode-basic
[491.060700] Subtest extended-mode-basic: SKIP (0.000s)
[491.101715] [119/133] (538s left) prime_busy (hang)
[491.163889] Starting subtest: hang
[491.166193] Starting dynamic subtest: rcs0
[516.898251] Dynamic subtest rcs0: SUCCESS (25.738s)
[516.906521] Starting dynamic subtest: bcs0
[524.055733] Dynamic subtest bcs0: SUCCESS (7.159s)
[524.063962] Starting dynamic subtest: vcs0
[531.026201] Dynamic subtest vcs0: SUCCESS (6.971s)
[531.034929] Starting dynamic subtest: vcs1
[538.083349] Dynamic subtest vcs1: SUCCESS (7.053s)
[538.091391] Starting dynamic subtest: vecs0
[545.039459] Dynamic subtest vecs0: SUCCESS (6.952s)
[545.047325] Starting dynamic subtest: ccs0
[558.889301] Dynamic subtest ccs0: SUCCESS (13.844s)
[558.890524] Subtest hang: SUCCESS (67.726s)
[559.035026] [120/133] (470s left) i915_pm_rpm (gem-execbuf)
[560.564526] Starting subtest: gem-execbuf
[560.566131] Starting dynamic subtest: smem0
[562.256419] Dynamic subtest smem0: SUCCESS (1.693s)
[562.257339] Subtest gem-execbuf: SUCCESS (1.695s)
[562.353088] [121/133] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[562.459534] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[562.461334] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[562.578115] [122/133] (466s left) sw_sync (sync_busy_fork_unixsocket)
[562.610533] Starting subtest: sync_busy_fork_unixsocket
[562.614689] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[562.677575] [123/133] (466s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[562.773291] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[569.742373] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.966s)
[569.897377] [124/133] (459s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[569.991936] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[569.992797] Starting dynamic subtest: pipe-A
[570.055397] Dynamic subtest pipe-A: SUCCESS (0.064s)
[570.063684] Starting dynamic subtest: pipe-B
[571.156600] Dynamic subtest pipe-B: SUCCESS (1.100s)
[571.167881] Starting dynamic subtest: pipe-C
[572.258187] Dynamic subtest pipe-C: SUCCESS (1.100s)
[572.266557] Starting dynamic subtest: pipe-D
[573.383566] Dynamic subtest pipe-D: SUCCESS (1.124s)
[573.384494] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.392s)
[574.553202] [125/133] (454s left) gem_mmap_gtt (big-copy-xy)
[574.607629] Subtest big-copy-XY: SKIP (0.000s)
[574.660130] [126/133] (454s left) prime_self_import (export-vs-gem_close-race)
[574.692283] Starting subtest: export-vs-gem_close-race
[579.783152] Subtest export-vs-gem_close-race: SUCCESS (5.091s)
[579.869251] [127/133] (449s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[579.976276] Starting subtest: yf-tiled-64bpp-rotate-90
[579.978349] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[580.099044] [128/133] (449s left) gem_softpin (evict-prime)
[580.159494] Starting subtest: evict-prime
[580.160425] Starting dynamic subtest: rcs0
[581.375408] Dynamic subtest rcs0: SUCCESS (1.216s)
[581.392261] Starting dynamic subtest: bcs0
[582.528918] Dynamic subtest bcs0: SUCCESS (1.152s)
[582.540048] Starting dynamic subtest: vcs0
[584.424684] Dynamic subtest vcs0: SUCCESS (1.891s)
[584.439929] Starting dynamic subtest: vcs1
[586.403080] Dynamic subtest vcs1: SUCCESS (1.975s)
[586.414635] Starting dynamic subtest: vecs0
[588.462537] Dynamic subtest vecs0: SUCCESS (2.056s)
[588.471214] Starting dynamic subtest: ccs0
[589.614367] Dynamic subtest ccs0: SUCCESS (1.153s)
[589.627064] Starting dynamic subtest: all
[591.347910] Dynamic subtest all: SUCCESS (1.729s)
[591.349079] Subtest evict-prime: SUCCESS (11.188s)
[591.496510] [129/133] (437s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[591.588897] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[591.589877] Starting dynamic subtest: pipe-A-default-mode
[594.273972] Dynamic subtest pipe-A-default-mode: SUCCESS (2.684s)
[594.274926] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.685s)
[595.144911] [130/133] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[595.241653] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[595.243368] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[595.352853] [131/133] (434s left) gem_exec_fence (basic-await)
[595.517162] Starting subtest: basic-await
[595.518287] Starting dynamic subtest: rcs0
[595.593279] Dynamic subtest rcs0: SUCCESS (0.077s)
[595.608179] Starting dynamic subtest: bcs0
[595.665238] Dynamic subtest bcs0: SUCCESS (0.072s)
[595.677413] Starting dynamic subtest: vcs0
[595.739381] Dynamic subtest vcs0: SUCCESS (0.071s)
[595.750939] Starting dynamic subtest: vcs1
[595.812407] Dynamic subtest vcs1: SUCCESS (0.071s)
[595.824019] Starting dynamic subtest: vecs0
[595.886110] Dynamic subtest vecs0: SUCCESS (0.072s)
[595.898002] Starting dynamic subtest: ccs0
[595.959035] Dynamic subtest ccs0: SUCCESS (0.071s)
[595.960790] Subtest basic-await: SUCCESS (0.444s)
[597.491250] [132/133] (432s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[597.608874] Starting subtest: flip-vs-cursor-legacy
[604.689508] Subtest flip-vs-cursor-legacy: SUCCESS (7.080s)
[605.571014] [133/133] (424s left) gem_lmem_swapping (verify-random-ccs)
[605.609399] Subtest verify-random-ccs: SKIP (0.000s)
[605.642280] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_tiled_blits
results: parsing output: 25/ for test: kms_tiled_display
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_pm_lpsp
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_async
results: parsing output: 51/ for test: gem_flink_basic
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_tiled_pread_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_close_race
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_feature_discovery
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color_pipeline
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: kms_display_modes
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: prime_self_import
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_lmem_swapping
Done.