[59.960394] Initializing watchdogs
[59.960440]   /dev/watchdog0
[59.973914] [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]
[59.978743] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.980862] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.984185] [001/133] (960s left) kms_color (ctm-0-25)
[60.113826] Starting subtest: ctm-0-25
[60.116101] Starting dynamic subtest: pipe-A-eDP-1
[63.597813] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.475s)
[63.606063] Starting dynamic subtest: pipe-B-eDP-1
[67.798836] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.198s)
[67.807966] Starting dynamic subtest: pipe-C-eDP-1
[71.860185] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.057s)
[71.868371] Starting dynamic subtest: pipe-D-eDP-1
[75.856736] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[75.858837] Subtest ctm-0-25: SUCCESS (15.726s)
[76.705189] [002/133] (943s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[76.812597] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[76.816811] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.920131] [003/133] (943s left) gem_exec_balancer (noheartbeat)
[77.186785] Starting subtest: noheartbeat
[77.191194] Subtest noheartbeat: SKIP (0.000s)
[77.293089] [004/133] (943s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[77.413370] Starting subtest: cursorB-vs-flipB-atomic-transitions
[77.418142] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[77.568745] [005/133] (943s left) kms_busy (extended-pageflip-hang-oldfb)
[77.671845] Starting subtest: extended-pageflip-hang-oldfb
[77.674127] Starting dynamic subtest: pipe-A
[78.084539] Dynamic subtest pipe-A: SUCCESS (0.412s)
[78.093559] Starting dynamic subtest: pipe-D
[79.206624] Dynamic subtest pipe-D: SUCCESS (1.121s)
[79.208892] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.537s)
[80.073593] [006/133] (940s left) kms_draw_crc (draw-method-mmap-wc)
[80.168357] Starting subtest: draw-method-mmap-wc
[80.170510] Starting dynamic subtest: xrgb8888-untiled
[80.411176] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[80.418074] Starting dynamic subtest: rgb565-untiled
[80.633278] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[80.640366] Starting dynamic subtest: xrgb2101010-untiled
[80.844350] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[80.852350] Starting dynamic subtest: xbgr16161616f-untiled
[81.054921] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[81.062263] Starting dynamic subtest: xrgb8888-xtiled
[81.200231] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[81.209071] Starting dynamic subtest: rgb565-xtiled
[81.332720] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[81.340600] Starting dynamic subtest: xrgb2101010-xtiled
[81.443903] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[81.451080] Starting dynamic subtest: xbgr16161616f-xtiled
[81.566224] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[81.573060] Starting dynamic subtest: xrgb8888-4tiled
[81.711272] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[81.719541] Starting dynamic subtest: rgb565-4tiled
[81.844218] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[81.851881] Starting dynamic subtest: xrgb2101010-4tiled
[81.988690] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[81.995878] Starting dynamic subtest: xbgr16161616f-4tiled
[82.166977] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[82.168952] Subtest draw-method-mmap-wc: SUCCESS (2.000s)
[82.281048] [007/133] (938s left) kms_content_protection (uevent)
[82.431020] Starting subtest: uevent
[82.435218] Subtest uevent: SKIP (0.000s)
[82.566400] [008/133] (938s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[82.724077] Starting subtest: cursor-rapid-movement-32x32
[82.770755] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[83.076234] [009/133] (937s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[83.137516] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[83.141414] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[83.328465] [010/133] (937s left) gem_exec_fence (syncobj-import)
[83.757631] Starting subtest: syncobj-import
[83.763668] Subtest syncobj-import: SUCCESS (0.005s)
[84.972891] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[84.976074] [011/133] (935s left) gem_exec_flush (basic-wb-pro-default)
[85.034901] Starting subtest: basic-wb-pro-default
[90.482603] Subtest basic-wb-pro-default: SUCCESS (5.449s)
[90.678104] [012/133] (930s left) gem_exec_schedule (preempt-other)
[90.760665] Starting subtest: preempt-other
[90.763122] Starting dynamic subtest: rcs0
[90.880393] Dynamic subtest rcs0: SUCCESS (0.128s)
[90.890901] Starting dynamic subtest: bcs0
[90.993479] Dynamic subtest bcs0: SUCCESS (0.113s)
[91.002791] Starting dynamic subtest: vcs0
[91.103289] Dynamic subtest vcs0: SUCCESS (0.110s)
[91.116365] Starting dynamic subtest: vcs1
[91.220071] Dynamic subtest vcs1: SUCCESS (0.116s)
[91.232925] Starting dynamic subtest: vecs0
[91.328978] Dynamic subtest vecs0: SUCCESS (0.110s)
[91.337147] Starting dynamic subtest: ccs0
[91.451884] Dynamic subtest ccs0: SUCCESS (0.122s)
[91.454242] Subtest preempt-other: SUCCESS (0.701s)
[92.065839] [013/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[92.167459] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[99.480288] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.315s)
[99.615969] [014/133] (921s left) gem_fence_thrash (bo-write-verify-threaded-y)
[99.657230] Starting subtest: bo-write-verify-threaded-y
[99.692967] Subtest bo-write-verify-threaded-y: SKIP (0.034s)
[99.763297] [015/133] (921s left) kms_addfb_basic (invalid-set-prop-any)
[99.829262] Starting subtest: invalid-set-prop-any
[99.831824] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[99.993129] [016/133] (921s left) gem_pxp (reject-modify-context-protection-off-3)
[100.126828] Starting subtest: reject-modify-context-protection-off-3
[100.129377] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[100.256072] [017/133] (920s left) gem_exec_schedule (fairslice-all)
[100.321081] Starting subtest: fairslice-all
[102.372845] Subtest fairslice-all: SUCCESS (2.054s)
[104.016701] [018/133] (917s left) kms_chamelium_edid (dp-mode-timings)
[104.395458] Subtest dp-mode-timings: SKIP (0.000s)
[105.167920] [019/133] (916s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[105.268249] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[105.270250] Starting dynamic subtest: pipe-A-eDP-1
[107.379190] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[107.386954] Starting dynamic subtest: pipe-B-eDP-1
[109.437653] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.057s)
[109.447612] Starting dynamic subtest: pipe-C-eDP-1
[111.534986] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.097s)
[111.542196] Starting dynamic subtest: pipe-D-eDP-1
[113.672521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.137s)
[113.674440] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.407s)
[114.879974] [020/133] (906s left) gem_ctx_param (invalid-get-no-zeromap)
[114.946217] Starting subtest: invalid-get-no-zeromap
[114.948638] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[115.067520] [021/133] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[115.164260] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[122.502143] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.342s)
[122.657938] [022/133] (898s left) i915_pm_rps (thresholds-idle)
[122.732675] Starting subtest: thresholds-idle
[122.737312] Subtest thresholds-idle: SKIP (0.001s)
[122.856791] [023/133] (898s left) gem_close (many-handles-one-vma)
[122.925735] Starting subtest: many-handles-one-vma
[122.951055] Subtest many-handles-one-vma: SUCCESS (0.026s)
[123.099627] [024/133] (898s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[123.210577] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[123.214712] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[123.347037] [025/133] (898s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[123.736313] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[124.584409] [026/133] (896s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[124.690085] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[124.694600] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[124.798219] [027/133] (896s left) gem_mmap_offset (clear-via-pagefault)
[124.855506] Starting subtest: clear-via-pagefault
[124.857423] Starting dynamic subtest: smem0
[157.746260] Dynamic subtest smem0: SUCCESS (32.884s)
[157.748434] Subtest clear-via-pagefault: SUCCESS (32.886s)
[157.854972] [028/133] (863s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[157.912488] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[157.983235] [029/133] (863s left) kms_psr (pr-sprite-render)
[158.087108] Starting subtest: pr-sprite-render
[158.091159] Subtest pr-sprite-render: SKIP (0.000s)
[158.171802] [030/133] (863s left) gem_exec_reloc (basic-cpu-read-noreloc)
[158.235947] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[158.310838] [031/133] (863s left) kms_setmode (basic-clone-single-crtc)
[158.374466] Starting subtest: basic-clone-single-crtc
[158.380978] Subtest basic-clone-single-crtc: SKIP (0.000s)
[158.466565] [032/133] (863s left) gem_exec_alignment (pi-isolated)
[158.524739] Starting subtest: pi-isolated
[209.115346] Subtest pi-isolated: SUCCESS (50.584s)
[210.259546] [033/133] (811s left) gem_ctx_persistence (heartbeat-hang)
[210.384525] Starting subtest: heartbeat-hang
[210.389121] Subtest heartbeat-hang: SKIP (0.000s)
[210.513125] [034/133] (811s left) kms_display_modes (extended-mode-basic)
[210.626702] Starting subtest: extended-mode-basic
[210.631071] Subtest extended-mode-basic: SKIP (0.000s)
[210.672108] [035/133] (811s left) kms_plane (plane-position-hole)
[210.763270] Starting subtest: plane-position-hole
[211.306687] Starting dynamic subtest: pipe-A-plane-1
[212.551816] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s)
[212.561718] Starting dynamic subtest: pipe-A-plane-2
[213.828290] Dynamic subtest pipe-A-plane-2: SUCCESS (1.276s)
[213.837254] Starting dynamic subtest: pipe-A-plane-3
[215.173273] Dynamic subtest pipe-A-plane-3: SUCCESS (1.346s)
[215.180988] Starting dynamic subtest: pipe-A-plane-4
[216.501286] Dynamic subtest pipe-A-plane-4: SUCCESS (1.325s)
[216.509183] Starting dynamic subtest: pipe-A-plane-5
[216.526067] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[217.750584] Starting dynamic subtest: pipe-B-plane-1
[219.012873] Dynamic subtest pipe-B-plane-1: SUCCESS (1.265s)
[219.022040] Starting dynamic subtest: pipe-B-plane-2
[220.253654] Dynamic subtest pipe-B-plane-2: SUCCESS (1.244s)
[220.262713] Starting dynamic subtest: pipe-B-plane-3
[221.539984] Dynamic subtest pipe-B-plane-3: SUCCESS (1.285s)
[221.548367] Starting dynamic subtest: pipe-B-plane-4
[222.823283] Dynamic subtest pipe-B-plane-4: SUCCESS (1.282s)
[222.835167] Starting dynamic subtest: pipe-B-plane-5
[222.849833] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[222.852260] Subtest plane-position-hole: SUCCESS (12.086s)
[223.626847] [036/133] (798s left) kms_pm_backlight (bad-brightness)
[223.719156] Starting subtest: bad-brightness
[223.802023] Starting dynamic subtest: eDP-1
[224.115365] Dynamic subtest eDP-1: SUCCESS (0.314s)
[224.117677] Subtest bad-brightness: SUCCESS (0.396s)
[224.966587] [037/133] (796s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[225.037996] Starting subtest: multi-wait-available-unsubmitted-signaled
[225.040444] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[225.151877] [038/133] (796s left) kms_mmap_write_crc (main)
[225.247479] Starting subtest: main
[225.249599] Starting dynamic subtest: pipe-A-eDP-1
[228.746780] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[228.749222] Subtest main: SUCCESS (3.501s)
[229.596015] [039/133] (792s left) gem_spin_batch (resubmit-new-all)
[229.665283] Starting subtest: resubmit-new-all
[229.667579] Starting dynamic subtest: rcs0
[229.679119] Dynamic subtest rcs0: SUCCESS (0.014s)
[229.688774] Starting dynamic subtest: bcs0
[229.691108] Dynamic subtest bcs0: SUCCESS (0.010s)
[229.698782] Starting dynamic subtest: vcs0
[229.703184] Dynamic subtest vcs0: SUCCESS (0.011s)
[229.710716] Starting dynamic subtest: vcs1
[229.713057] Dynamic subtest vcs1: SUCCESS (0.008s)
[229.720738] Starting dynamic subtest: vecs0
[229.722619] Dynamic subtest vecs0: SUCCESS (0.007s)
[229.730767] Starting dynamic subtest: ccs0
[229.732802] Dynamic subtest ccs0: SUCCESS (0.009s)
[229.734862] Subtest resubmit-new-all: SUCCESS (0.063s)
[230.994503] [040/133] (791s left) kms_flip (flip-vs-rmfb-interruptible)
[231.097197] Starting subtest: flip-vs-rmfb-interruptible
[231.099506] Starting dynamic subtest: A-eDP1
[239.774035] Dynamic subtest A-eDP1: SUCCESS (8.676s)
[239.786517] Starting dynamic subtest: B-eDP1
[248.407732] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[248.416971] Starting dynamic subtest: C-eDP1
[257.025953] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[257.037314] Starting dynamic subtest: D-eDP1
[265.658242] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[265.662818] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.564s)
[266.863838] [041/133] (755s left) kms_rotation_crc (sprite-rotation-180)
[266.980136] Starting subtest: sprite-rotation-180
[273.652809] Subtest sprite-rotation-180: SUCCESS (6.675s)
[274.838366] [042/133] (747s left) gem_exec_alignment (single)
[274.905769] Starting subtest: single
[274.911724] Subtest single: SUCCESS (0.003s)
[275.066389] [043/133] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[275.170308] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[276.193961] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.023s)
[276.349170] [044/133] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[276.453356] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[283.973178] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.523s)
[284.132499] [045/133] (738s left) syncobj_wait (invalid-signal-zero-handles)
[284.206465] Starting subtest: invalid-signal-zero-handles
[284.208993] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[284.324098] [046/133] (737s left) kms_async_flips (alternate-sync-async-flip)
[284.416035] Starting subtest: alternate-sync-async-flip
[284.786243] Starting dynamic subtest: pipe-A-eDP-1
[287.533596] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.747s)
[287.912214] Starting dynamic subtest: pipe-B-eDP-1
[290.665310] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[291.040857] Starting dynamic subtest: pipe-C-eDP-1
[293.801937] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[294.168051] Starting dynamic subtest: pipe-D-eDP-1
[296.923397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[296.925624] Subtest alternate-sync-async-flip: SUCCESS (12.510s)
[298.097871] [047/133] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[298.208479] Starting subtest: fbcpsr-1p-rte
[305.193323] Subtest fbcpsr-1p-rte: SUCCESS (6.989s)
[305.361246] [048/133] (716s left) perf (gen12-group-exclusive-stream-ctx-handle)
[305.509608] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[305.535382] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[305.574291] [049/133] (716s left) gem_render_copy_redux (flink-interruptible)
[306.874829] Starting subtest: flink-interruptible
[307.659256] Subtest flink-interruptible: SUCCESS (0.786s)
[307.838564] [050/133] (714s left) gem_userptr_blits (probe)
[307.915192] Starting subtest: probe
[307.984846] Subtest probe: SUCCESS (0.069s)
[308.127068] [051/133] (714s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[308.229481] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[308.233374] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[308.356820] [052/133] (714s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[308.393396] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[308.442614] [053/133] (714s left) core_getclient (basic)
[308.492941] Starting subtest: basic
[308.494848] Subtest basic: SUCCESS (0.000s)
[308.582470] [054/133] (714s left) kms_cursor_crc (cursor-onscreen-128x128)
[308.792543] Starting subtest: cursor-onscreen-128x128
[308.796882] Starting dynamic subtest: pipe-A-eDP-1
[310.907839] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[310.937091] Starting dynamic subtest: pipe-D-eDP-1
[313.658624] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.727s)
[313.660804] Subtest cursor-onscreen-128x128: SUCCESS (4.865s)
[314.470958] [055/133] (708s left) kms_plane_lowres (tiling-y)
[314.565327] Starting subtest: tiling-y
[314.569585] Subtest tiling-y: SKIP (0.000s)
[314.646238] [056/133] (708s left) api_intel_allocator (gem-pool)
[314.707973] Starting subtest: gem-pool
[314.713219] Subtest gem-pool: SUCCESS (0.007s)
[314.859384] [057/133] (707s left) i915_drm_fdinfo (isolation)
[314.897964] Starting subtest: isolation
[314.900099] Starting dynamic subtest: rcs0
[314.933686] Dynamic subtest rcs0: SKIP (0.034s)
[314.942872] Starting dynamic subtest: bcs0
[314.946679] Dynamic subtest bcs0: SKIP (0.000s)
[314.954097] Starting dynamic subtest: vcs0
[314.958181] Dynamic subtest vcs0: SKIP (0.000s)
[314.965337] Starting dynamic subtest: vcs1
[314.969177] Dynamic subtest vcs1: SKIP (0.000s)
[314.976035] Starting dynamic subtest: vecs0
[314.980059] Dynamic subtest vecs0: SKIP (0.000s)
[314.987164] Starting dynamic subtest: ccs0
[314.991085] Dynamic subtest ccs0: SKIP (0.000s)
[314.994970] Subtest isolation: SKIP (0.039s)
[315.029197] [058/133] (707s left) gem_exec_parallel (basic)
[315.078350] Starting subtest: basic
[315.080419] Starting dynamic subtest: rcs0
[316.526213] Dynamic subtest rcs0: SUCCESS (1.447s)
[316.535736] Starting dynamic subtest: bcs0
[317.994619] Dynamic subtest bcs0: SUCCESS (1.466s)
[318.004693] Starting dynamic subtest: vcs0
[319.891868] Dynamic subtest vcs0: SUCCESS (1.894s)
[319.903410] Starting dynamic subtest: vcs1
[321.940327] Dynamic subtest vcs1: SUCCESS (2.045s)
[321.951897] Starting dynamic subtest: vecs0
[323.860730] Dynamic subtest vecs0: SUCCESS (1.918s)
[323.872202] Starting dynamic subtest: ccs0
[325.378314] Dynamic subtest ccs0: SUCCESS (1.516s)
[325.380791] Subtest basic: SUCCESS (10.301s)
[325.581587] [059/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[325.703599] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[325.707631] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.830307] [060/133] (696s left) kms_getfb (getfb-handle-valid)
[325.945840] Starting subtest: getfb-handle-valid
[325.948240] Subtest getfb-handle-valid: SUCCESS (0.000s)
[326.079293] [061/133] (696s left) perf (invalid-remove-userspace-config)
[326.177861] Starting subtest: invalid-remove-userspace-config
[326.188631] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[326.231771] [062/133] (696s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[326.335400] Starting subtest: pr-primary-plane-update-sf-dmg-area
[326.339703] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[326.426274] [063/133] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[326.521892] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[326.525451] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.633957] [064/133] (696s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[326.732523] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[326.734379] Starting dynamic subtest: pipe-A-eDP-1
[326.753905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.764246] Starting dynamic subtest: pipe-B-eDP-1
[326.781272] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.788123] Starting dynamic subtest: pipe-C-eDP-1
[326.805064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.811971] Starting dynamic subtest: pipe-D-eDP-1
[326.829418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.832874] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[329.032193] [065/133] (693s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[329.128522] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[335.924567] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.797s)
[336.110727] [066/133] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[336.213172] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[336.217062] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[336.340474] [067/133] (686s left) kms_pm_rpm (cursor-dpms)
[338.072791] Starting subtest: cursor-dpms
[338.077943] Subtest cursor-dpms: SKIP (0.000s)
[338.594287] [068/133] (684s left) gem_ccs (block-multicopy-inplace)
[338.666541] Starting subtest: block-multicopy-inplace
[338.670627] Subtest block-multicopy-inplace: SKIP (0.000s)
[338.788619] [069/133] (684s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[338.892320] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[338.896219] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[339.018747] [070/133] (684s left) kms_cursor_edge_walk (64x64-top-bottom)
[339.109373] Starting subtest: 64x64-top-bottom
[339.111628] Starting dynamic subtest: pipe-A-eDP-1
[342.535096] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.425s)
[342.544125] Starting dynamic subtest: pipe-D-eDP-1
[345.669748] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[345.671847] Subtest 64x64-top-bottom: SUCCESS (6.561s)
[346.529100] [071/133] (676s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[346.603653] Starting subtest: invalid-single-wait-all-unsubmitted
[346.606030] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[346.739290] [072/133] (676s left) gem_exec_capture (pi)
[346.806308] Starting subtest: pi
[346.808612] Starting dynamic subtest: rcs0
[351.005901] Dynamic subtest rcs0: SUCCESS (4.202s)
[351.017162] Starting dynamic subtest: bcs0
[355.097515] Dynamic subtest bcs0: SUCCESS (4.089s)
[355.108583] Starting dynamic subtest: vcs0
[359.077773] Dynamic subtest vcs0: SUCCESS (3.978s)
[359.088719] Starting dynamic subtest: vcs1
[363.074301] Dynamic subtest vcs1: SUCCESS (3.995s)
[363.088075] Starting dynamic subtest: vecs0
[367.095703] Dynamic subtest vecs0: SUCCESS (4.019s)
[367.106977] Starting dynamic subtest: ccs0
[371.162520] Dynamic subtest ccs0: SUCCESS (4.065s)
[371.164815] Subtest pi: SUCCESS (24.359s)
[371.253774] [073/133] (652s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[371.401081] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[371.405193] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[371.485916] [074/133] (651s left) kms_hdr (static-swap)
[371.575076] Starting subtest: static-swap
[371.581140] Subtest static-swap: SKIP (0.000s)
[371.653795] [075/133] (651s left) syncobj_wait (wait-for-submit-delayed-submit)
[371.707952] Starting subtest: wait-for-submit-delayed-submit
[371.812327] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[371.914373] [076/133] (651s left) kms_vrr (flip-dpms)
[372.011250] Starting subtest: flip-dpms
[372.017782] Subtest flip-dpms: SKIP (0.000s)
[372.108249] [077/133] (651s left) kms_big_fb (linear-addfb)
[372.203997] Starting subtest: linear-addfb
[372.206269] Subtest linear-addfb: SUCCESS (0.000s)
[372.323316] [078/133] (651s left) kms_addfb_basic (addfb25-bad-modifier)
[372.426234] Starting subtest: addfb25-bad-modifier
[372.428278] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[372.539561] [079/133] (651s left) kms_psr (psr-sprite-plane-onoff)
[372.632092] Starting subtest: psr-sprite-plane-onoff
[372.634230] Starting dynamic subtest: eDP-1
[374.424637] Dynamic subtest eDP-1: SUCCESS (1.792s)
[374.426751] Subtest psr-sprite-plane-onoff: SUCCESS (1.793s)
[375.270726] [080/133] (648s left) kms_psr (fbc-psr-sprite-plane-move)
[375.359836] Starting subtest: fbc-psr-sprite-plane-move
[375.362127] Starting dynamic subtest: eDP-1
[375.366299] Dynamic subtest eDP-1: SKIP (0.000s)
[375.370662] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[375.444936] [081/133] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[375.541744] Starting subtest: fbcpsr-rgb101010-draw-blt
[382.326764] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.787s)
[382.469849] [082/133] (641s left) kms_prop_blob (invalid-get-prop)
[382.537015] Starting subtest: invalid-get-prop
[382.539336] Subtest invalid-get-prop: SUCCESS (0.000s)
[382.656271] [083/133] (641s left) sysfs_preempt_timeout (idempotent)
[382.718318] Starting subtest: idempotent
[382.720678] Starting dynamic subtest: vecs0
[382.722961] Dynamic subtest vecs0: SUCCESS (0.000s)
[382.732917] Starting dynamic subtest: ccs0
[382.735098] Dynamic subtest ccs0: SUCCESS (0.000s)
[382.742591] Starting dynamic subtest: vcs0
[382.744819] Dynamic subtest vcs0: SUCCESS (0.000s)
[382.752259] Starting dynamic subtest: bcs0
[382.754434] Dynamic subtest bcs0: SUCCESS (0.000s)
[382.762130] Starting dynamic subtest: rcs0
[382.764304] Dynamic subtest rcs0: SUCCESS (0.000s)
[382.771826] Starting dynamic subtest: vcs1
[382.774065] Dynamic subtest vcs1: SUCCESS (0.000s)
[382.776248] Subtest idempotent: SUCCESS (0.006s)
[382.846933] [084/133] (640s left) kms_psr (fbc-pr-primary-page-flip)
[382.934751] Starting subtest: fbc-pr-primary-page-flip
[382.938645] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[383.018840] [085/133] (640s left) gem_exec_reloc (basic-gtt-active)
[383.074494] Subtest basic-gtt-active: SKIP (0.000s)
[383.148836] [086/133] (640s left) kms_chamelium_color (ctm-0-75)
[383.243167] Subtest ctm-0-75: SKIP (0.000s)
[383.285839] [087/133] (640s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[383.376491] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[383.378490] Starting dynamic subtest: pipe-A-default-mode
[386.131084] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[386.133212] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.755s)
[386.978396] [088/133] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[387.093186] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[391.379709] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.290s)
[392.576945] [089/133] (631s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[392.689767] Starting subtest: psr-indfb-scaledprimary
[398.415611] Subtest psr-indfb-scaledprimary: SUCCESS (5.729s)
[398.571192] [090/133] (625s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[398.675071] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[398.679527] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[398.783359] [091/133] (625s left) syncobj_eventfd (timeline-wait)
[398.843347] Starting subtest: timeline-wait
[398.851725] Subtest timeline-wait: SUCCESS (0.010s)
[398.975079] [092/133] (625s left) gem_sync (basic-store-each)
[399.057119] Starting subtest: basic-store-each
[401.465720] Subtest basic-store-each: SUCCESS (2.417s)
[401.674334] [093/133] (622s left) core_getversion (all-cards)
[401.711646] Starting subtest: all-cards
[401.720447] Subtest all-cards: SUCCESS (0.013s)
[401.757433] [094/133] (622s left) gem_ctx_exec (basic-invalid-context)
[401.809941] Starting subtest: basic-invalid-context
[401.814484] Subtest basic-invalid-context: SUCCESS (0.005s)
[401.985329] [095/133] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[402.089648] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[406.575955] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.490s)
[407.793359] [096/133] (616s left) kms_prop_blob (blob-multiple)
[407.850816] Starting subtest: blob-multiple
[407.853072] Subtest blob-multiple: SUCCESS (0.002s)
[408.001128] [097/133] (616s left) kms_invalid_mode (zero-clock)
[408.094325] Starting subtest: zero-clock
[408.096595] Starting dynamic subtest: pipe-A-eDP-1
[408.390187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[408.401597] Starting dynamic subtest: pipe-B-eDP-1
[408.403690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[408.411373] Starting dynamic subtest: pipe-C-eDP-1
[408.413783] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[408.421261] Starting dynamic subtest: pipe-D-eDP-1
[408.423500] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[408.425795] Subtest zero-clock: SUCCESS (0.304s)
[409.211382] [098/133] (615s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[409.311126] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[409.313451] Starting dynamic subtest: pipe-A-default-mode
[412.046957] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[412.049260] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.737s)
[412.878317] [099/133] (611s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[412.978885] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[412.981012] Starting dynamic subtest: pipe-A-eDP-1
[413.005124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.014859] Starting dynamic subtest: pipe-B-eDP-1
[413.037581] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.045226] Starting dynamic subtest: pipe-C-eDP-1
[413.068364] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.075893] Starting dynamic subtest: pipe-D-eDP-1
[413.099582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.103940] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[415.166363] [100/133] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[415.281301] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[415.285341] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[415.400707] [101/133] (609s left) gem_tiled_wc
[415.526153] [102/133] (608s left) kms_universal_plane (universal-plane-sanity)
[415.616353] Starting subtest: universal-plane-sanity
[415.618333] Starting dynamic subtest: pipe-A-eDP-1
[416.210314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[416.221158] Starting dynamic subtest: pipe-B-eDP-1
[417.491405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.279s)
[417.501239] Starting dynamic subtest: pipe-C-eDP-1
[418.699954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[418.711801] Starting dynamic subtest: pipe-D-eDP-1
[419.942320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[419.944674] Subtest universal-plane-sanity: SUCCESS (4.329s)
[420.818053] [103/133] (603s left) kms_plane_alpha_blend (alpha-opaque-fb)
[420.919256] Starting subtest: alpha-opaque-fb
[421.197105] Starting dynamic subtest: pipe-A-eDP-1
[421.760091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[421.768913] Starting dynamic subtest: pipe-D-eDP-1
[423.168712] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[423.170916] Subtest alpha-opaque-fb: SUCCESS (2.252s)
[423.992108] [104/133] (600s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[424.094517] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[424.098626] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[424.200476] [105/133] (600s left) kms_psr (psr2-primary-mmap-gtt)
[424.291178] Starting subtest: psr2-primary-mmap-gtt
[424.293447] Starting dynamic subtest: eDP-1
[425.762865] Dynamic subtest eDP-1: SKIP (1.470s)
[425.767890] Subtest psr2-primary-mmap-gtt: SKIP (1.471s)
[425.939100] [106/133] (598s left) gem_exec_schedule (semaphore-codependency)
[426.017399] Starting subtest: semaphore-codependency
[426.022825] Subtest semaphore-codependency: SUCCESS (0.013s)
[426.381080] [107/133] (598s left) gem_pread (bench)
[426.444936] Subtest bench: SKIP (0.000s)
[426.518072] [108/133] (598s left) drm_read (fault-buffer)
[426.687911] Starting subtest: fault-buffer
[426.690205] Subtest fault-buffer: SUCCESS (0.001s)
[426.834099] [109/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[426.934482] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[426.938421] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[427.053287] [110/133] (597s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[427.139682] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[427.143819] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[427.284922] [111/133] (597s left) gem_softpin (evict-snoop)
[427.343522] Starting subtest: evict-snoop
[427.347409] Subtest evict-snoop: SKIP (0.000s)
[427.485086] [112/133] (597s left) kms_getfb (getfb-handle-not-fb)
[427.585587] Starting subtest: getfb-handle-not-fb
[427.587500] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[427.727730] [113/133] (597s left) syncobj_timeline (wait-all-delayed-signal)
[427.783136] Starting subtest: wait-all-delayed-signal
[427.886375] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[427.977731] [114/133] (597s left) kms_atomic (plane-invalid-params-fence)
[428.074300] Starting subtest: plane-invalid-params-fence
[428.076572] Starting dynamic subtest: pipe-A-eDP-1
[428.436883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.364s)
[428.439273] Subtest plane-invalid-params-fence: SUCCESS (0.366s)
[429.244741] [115/133] (595s left) gem_mmap_gtt (coherency)
[429.306641] Subtest coherency: SKIP (0.000s)
[429.371346] [116/133] (595s left) prime_mmap (test_forked_cpu_write)
[429.427574] Starting subtest: test_forked_cpu_write
[429.429568] Starting dynamic subtest: test_forked_cpu_write-smem
[429.431621] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[429.433974] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[429.570551] [117/133] (595s left) kms_flip (2x-nonexisting-fb)
[429.665570] Starting subtest: 2x-nonexisting-fb
[429.676930] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[429.814497] [118/133] (595s left) kms_flip (flip-vs-panning-interruptible)
[429.912228] Starting subtest: flip-vs-panning-interruptible
[429.914749] Starting dynamic subtest: A-eDP1
[438.646275] Dynamic subtest A-eDP1: SUCCESS (8.735s)
[438.655705] Starting dynamic subtest: B-eDP1
[447.381183] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[447.390858] Starting dynamic subtest: C-eDP1
[456.093901] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[456.102452] Starting dynamic subtest: D-eDP1
[464.732950] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[464.737314] Subtest flip-vs-panning-interruptible: SUCCESS (34.826s)
[466.011130] [119/133] (559s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[466.107906] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[466.110081] Starting dynamic subtest: pipe-A-eDP-1
[466.132060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[466.140766] Starting dynamic subtest: pipe-B-eDP-1
[466.161803] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[466.169553] Starting dynamic subtest: pipe-C-eDP-1
[466.189729] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[466.197356] Starting dynamic subtest: pipe-D-eDP-1
[466.218407] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[466.222361] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[468.291375] [120/133] (556s left) i915_pm_rpm (debugfs-forcewake-user)
[470.028456] Starting subtest: debugfs-forcewake-user
[481.406346] Subtest debugfs-forcewake-user: SUCCESS (11.379s)
[481.790693] [121/133] (543s left) gem_eio (throttle)
[482.041723] Starting subtest: throttle
[482.374154] Subtest throttle: SUCCESS (0.332s)
[482.519764] [122/133] (542s left) gem_ctx_param (invalid-size-set)
[482.579562] Starting subtest: invalid-size-set
[482.581954] Subtest invalid-size-set: SUCCESS (0.001s)
[482.707768] [123/133] (542s left) perf_pmu (pmu-read)
[482.746036] Starting subtest: pmu-read
[482.748031] Subtest pmu-read: SUCCESS (0.002s)
[482.871414] [124/133] (542s left) gem_lmem_swapping (verify-ccs)
[482.919278] Subtest verify-ccs: SKIP (0.000s)
[482.965196] [125/133] (542s left) gen9_exec_parse (batch-invalid-length)
[483.033573] Subtest batch-invalid-length: SKIP (0.000s)
[483.115396] [126/133] (542s left) gem_softpin (overlap)
[483.197050] Starting subtest: overlap
[484.075600] Subtest overlap: SUCCESS (0.877s)
[484.225834] [127/133] (541s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[484.343112] Starting subtest: 4-tiled-8bpp-rotate-180
[485.517457] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.174s)
[485.637094] [128/133] (539s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[485.733995] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[485.738391] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[485.816329] [129/133] (539s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[485.904589] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[485.906342] Starting dynamic subtest: pipe-A-eDP-1
[491.741714] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.839s)
[491.750487] Starting dynamic subtest: pipe-B-eDP-1
[498.408166] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.665s)
[498.410492] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.507s)
[499.295872] [130/133] (526s left) i915_pm_freq_api (freq-suspend)
[499.366874] Starting subtest: freq-suspend
[499.369083] Starting dynamic subtest: gt0
[515.870332] Dynamic subtest gt0: SUCCESS (1.338s)
[515.882027] Starting dynamic subtest: gt1
[531.867097] Dynamic subtest gt1: SUCCESS (1.224s)
[531.869261] Subtest freq-suspend: SUCCESS (2.565s)
[531.969065] [131/133] (493s left) prime_busy (after)
[532.048705] Starting subtest: after
[532.053633] Starting dynamic subtest: rcs0
[532.115043] Dynamic subtest rcs0: SUCCESS (0.063s)
[532.124447] Starting dynamic subtest: bcs0
[532.178358] Dynamic subtest bcs0: SUCCESS (0.062s)
[532.188315] Starting dynamic subtest: vcs0
[532.219015] Dynamic subtest vcs0: SUCCESS (0.040s)
[532.227927] Starting dynamic subtest: vcs1
[532.260617] Dynamic subtest vcs1: SUCCESS (0.041s)
[532.269935] Starting dynamic subtest: vecs0
[532.303373] Dynamic subtest vecs0: SUCCESS (0.042s)
[532.312748] Starting dynamic subtest: ccs0
[532.345034] Dynamic subtest ccs0: SUCCESS (0.040s)
[532.453089] Subtest after: SUCCESS (0.401s)
[532.543502] [132/133] (493s left) gem_exec_whisper (basic-contexts-forked)
[532.641575] Starting subtest: basic-contexts-forked
[555.410244] Subtest basic-contexts-forked: SUCCESS (22.630s)
[555.602137] [133/133] (470s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[555.665141] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[555.766235] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[555.852895] Closing watchdogs
results: parsing output: 0/ for test: kms_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_busy
results: parsing output: 5/ for test: kms_draw_crc
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_fence_thrash
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_chamelium_edid
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: i915_pm_rps
results: parsing output: 22/ for test: gem_close
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_chamelium_hpd
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_pipe_b_c_ivb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_setmode
results: parsing output: 31/ for test: gem_exec_alignment
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: kms_display_modes
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_mmap_write_crc
results: parsing output: 38/ for test: gem_spin_batch
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: gem_exec_alignment
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_render_copy_redux
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: core_getclient
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_plane_lowres
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: i915_drm_fdinfo
results: parsing output: 57/ for test: gem_exec_parallel
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_pm_rpm
results: parsing output: 67/ for test: gem_ccs
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_edge_walk
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_capture
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_vrr
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: sysfs_preempt_timeout
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: syncobj_eventfd
results: parsing output: 91/ for test: gem_sync
results: parsing output: 92/ for test: core_getversion
results: parsing output: 93/ for test: gem_ctx_exec
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_tiled_wc
results: parsing output: 101/ for test: kms_universal_plane
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_pread
results: parsing output: 107/ for test: drm_read
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: i915_pm_freq_api
results: parsing output: 130/ for test: prime_busy
results: parsing output: 131/ for test: gem_exec_whisper
results: parsing output: 132/ for test: syncobj_timeline
Done.