[58.172318] Initializing watchdogs
[58.172364]   /dev/watchdog0
[58.185547] [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.189483] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.191647] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.194911] [001/130] (960s left) vgem_basic (busy-fence)
[58.326194] Starting subtest: busy-fence
[58.328082] Subtest busy-fence: SUCCESS (0.000s)
[58.374347] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[58.377218] [002/130] (960s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[58.630632] Starting subtest: parallel-dmabuf-import-out-fence
[59.512818] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.900s)
[59.630486] [003/130] (959s left) syncobj_wait (single-wait-all-signaled)
[59.682698] Starting subtest: single-wait-all-signaled
[59.684941] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[59.796197] [004/130] (958s left) kms_rotation_crc (sprite-rotation-270)
[59.904841] Starting subtest: sprite-rotation-270
[59.909374] Subtest sprite-rotation-270: SKIP (0.001s)
[59.969054] [005/130] (958s left) kms_content_protection (dp-mst-type-0)
[60.142663] Starting subtest: dp-mst-type-0
[60.147256] Subtest dp-mst-type-0: SKIP (0.000s)
[60.276368] [006/130] (958s left) kms_addfb_basic (bad-pitch-65536)
[60.330104] Starting subtest: bad-pitch-65536
[60.332414] Subtest bad-pitch-65536: SUCCESS (0.000s)
[60.463148] [007/130] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[60.570225] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[60.573859] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[60.684920] [008/130] (958s left) core_getversion (all-cards)
[60.720683] Starting subtest: all-cards
[62.609392] Subtest all-cards: SUCCESS (1.903s)
[62.634463] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[62.635101] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[62.638254] [009/130] (956s left) gem_eio (create)
[62.832185] Starting subtest: create
[63.089147] Subtest create: SUCCESS (0.257s)
[63.234114] [010/130] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[63.336603] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[63.341084] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[63.435675] [011/130] (955s left) gem_exec_schedule (preempt-user)
[63.509366] Starting subtest: preempt-user
[63.511339] Starting dynamic subtest: rcs0
[63.525177] Dynamic subtest rcs0: SUCCESS (0.023s)
[63.534951] Starting dynamic subtest: bcs0
[63.547534] Dynamic subtest bcs0: SUCCESS (0.023s)
[63.554390] Starting dynamic subtest: vcs0
[63.567474] Dynamic subtest vcs0: SUCCESS (0.020s)
[63.574165] Starting dynamic subtest: vcs1
[63.588252] Dynamic subtest vcs1: SUCCESS (0.021s)
[63.594767] Starting dynamic subtest: vecs0
[63.608546] Dynamic subtest vecs0: SUCCESS (0.020s)
[63.614831] Starting dynamic subtest: ccs0
[63.629792] Dynamic subtest ccs0: SUCCESS (0.021s)
[63.631736] Subtest preempt-user: SUCCESS (0.129s)
[65.030959] [012/130] (953s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[65.127684] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[65.139614] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[65.203173] [013/130] (953s left) gem_exec_schedule (fifo)
[65.271669] Starting subtest: fifo
[65.273826] Starting dynamic subtest: rcs0
[65.355064] Dynamic subtest rcs0: SUCCESS (0.094s)
[65.365864] Starting dynamic subtest: vcs0
[65.426611] Dynamic subtest vcs0: SUCCESS (0.072s)
[65.436965] Starting dynamic subtest: vcs1
[65.506819] Dynamic subtest vcs1: SUCCESS (0.080s)
[65.516381] Starting dynamic subtest: vecs0
[65.578613] Dynamic subtest vecs0: SUCCESS (0.072s)
[65.588585] Starting dynamic subtest: ccs0
[65.664867] Dynamic subtest ccs0: SUCCESS (0.086s)
[65.667368] Subtest fifo: SUCCESS (0.405s)
[67.032237] [014/130] (952s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[67.134783] Starting subtest: y-tiled-8bpp-rotate-180
[67.139175] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[67.249775] [015/130] (951s left) kms_plane_multiple (tiling-4)
[67.346837] Starting subtest: tiling-4
[67.349079] Starting dynamic subtest: pipe-A-eDP-1
[71.079916] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.737s)
[71.087966] Starting dynamic subtest: pipe-B-eDP-1
[75.463849] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.390s)
[75.471795] Starting dynamic subtest: pipe-C-eDP-1
[79.735261] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.274s)
[79.743742] Starting dynamic subtest: pipe-D-eDP-1
[84.023255] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.286s)
[84.025244] Subtest tiling-4: SUCCESS (16.690s)
[84.828940] [016/130] (934s left) perf (gen12-invalid-class-instance)
[84.935556] Starting subtest: gen12-invalid-class-instance
[84.950757] Subtest gen12-invalid-class-instance: SUCCESS (0.015s)
[84.988776] [017/130] (934s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[85.089433] Starting subtest: psr-rgb565-draw-blt
[89.905229] Subtest psr-rgb565-draw-blt: SUCCESS (4.819s)
[90.053865] [018/130] (929s left) gem_mmap_wc (bad-offset)
[90.114367] Subtest bad-offset: SKIP (0.000s)
[90.172306] [019/130] (929s left) kms_psr (fbc-psr2-cursor-render)
[90.260124] Starting subtest: fbc-psr2-cursor-render
[90.262489] Starting dynamic subtest: eDP-1
[90.267019] Dynamic subtest eDP-1: SKIP (0.000s)
[90.271531] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[90.323440] [020/130] (928s left) i915_pm_rps (basic-api)
[90.394037] Starting subtest: basic-api
[90.398486] Subtest basic-api: SKIP (0.000s)
[90.460159] [021/130] (928s left) drm_read (empty-block)
[90.639509] Starting subtest: empty-block
[91.641963] Subtest empty-block: SUCCESS (1.002s)
[91.768477] [022/130] (927s left) kms_cursor_crc (cursor-size-change)
[91.875093] Starting subtest: cursor-size-change
[91.877462] Starting dynamic subtest: pipe-A-eDP-1
[92.731709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s)
[92.741016] Starting dynamic subtest: pipe-D-eDP-1
[94.179473] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.446s)
[94.181845] Subtest cursor-size-change: SUCCESS (2.302s)
[95.046208] [023/130] (924s left) gem_ctx_persistence (idempotent)
[95.110634] Starting subtest: idempotent
[95.113033] Subtest idempotent: SUCCESS (0.000s)
[95.220074] [024/130] (924s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[95.334189] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[95.338296] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[95.445759] [025/130] (923s left) syncobj_basic (bad-flags-fd-to-handle)
[95.509443] Starting subtest: bad-flags-fd-to-handle
[95.511724] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[95.614996] [026/130] (923s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[95.706997] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[101.956262] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.255s)
[102.074100] [027/130] (917s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[102.180506] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[102.184959] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[102.292405] [028/130] (917s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[102.403464] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[102.407617] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[102.486916] [029/130] (917s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[102.581695] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[105.623053] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.046s)
[105.740941] [030/130] (913s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[105.804323] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[105.806782] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[105.907850] [031/130] (913s left) kms_vblank (query-forked-hang)
[105.998598] Starting subtest: query-forked-hang
[106.000746] Starting dynamic subtest: pipe-A-eDP-1
[132.720593] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.720s)
[132.735287] Starting dynamic subtest: pipe-D-eDP-1
[157.679654] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.954s)
[157.681952] Subtest query-forked-hang: SUCCESS (51.679s)
[158.541175] [032/130] (861s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[158.661680] Starting subtest: fbc-rgb101010-draw-mmap-wc
[162.228561] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.569s)
[162.346306] [033/130] (857s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[162.456321] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[162.460439] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[162.541947] [034/130] (857s left) kms_psr (psr-suspend)
[162.637081] Starting subtest: psr-suspend
[162.639204] Starting dynamic subtest: eDP-1
[181.108407] Dynamic subtest eDP-1: SUCCESS (2.919s)
[181.110645] Subtest psr-suspend: SUCCESS (2.920s)
[181.931150] [035/130] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[182.038284] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[186.857258] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.901s)
[187.008239] [036/130] (848s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[187.065516] Subtest tiled-to-untiled: SKIP (0.000s)
[187.127959] [037/130] (848s left) gem_ctx_engines (none)
[187.190457] Starting subtest: none
[187.192913] Subtest none: SUCCESS (0.002s)
[187.365707] [038/130] (847s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[187.462352] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[187.464656] Starting dynamic subtest: pipe-A-eDP-1
[187.485345] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[187.496234] Starting dynamic subtest: pipe-B-eDP-1
[187.518306] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[187.528228] Starting dynamic subtest: pipe-C-eDP-1
[187.548336] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[187.556250] Starting dynamic subtest: pipe-D-eDP-1
[187.576817] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[187.579258] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[189.617818] [039/130] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[189.726335] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[189.730667] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[189.817591] [040/130] (845s left) kms_lease (lessee-list)
[189.908249] Starting subtest: lessee-list
[189.910574] Starting dynamic subtest: pipe-A-eDP-1
[189.912742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[189.923428] Starting dynamic subtest: pipe-B-eDP-1
[189.925524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[189.932746] Starting dynamic subtest: pipe-C-eDP-1
[189.934822] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[189.941990] Starting dynamic subtest: pipe-D-eDP-1
[189.944163] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[189.946310] Subtest lessee-list: SUCCESS (0.007s)
[190.020425] [041/130] (845s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[195.030890] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[195.033660] Starting dynamic subtest: pipe-A-eDP-1
[207.037550] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.033s)
[207.046600] Starting dynamic subtest: pipe-B-eDP-1
[219.057889] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.019s)
[219.060514] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.055s)
[219.895951] [042/130] (815s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[220.013124] Starting subtest: fbc-farfromfence-mmap-gtt
[220.017752] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[220.098115] [043/130] (815s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[220.205655] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[221.195177] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.989s)
[221.307392] [044/130] (814s left) gem_ctx_persistence (engines-hang)
[221.363286] Starting subtest: engines-hang
[221.365627] Starting dynamic subtest: rcs0
[221.441190] Dynamic subtest rcs0: SUCCESS (0.077s)
[221.452727] Starting dynamic subtest: bcs0
[221.553967] Dynamic subtest bcs0: SUCCESS (0.111s)
[221.564841] Starting dynamic subtest: vcs0
[221.651605] Dynamic subtest vcs0: SUCCESS (0.097s)
[221.661946] Starting dynamic subtest: vcs1
[221.769419] Dynamic subtest vcs1: SUCCESS (0.117s)
[221.780467] Starting dynamic subtest: vecs0
[221.888814] Dynamic subtest vecs0: SUCCESS (0.118s)
[221.899100] Starting dynamic subtest: ccs0
[222.012540] Dynamic subtest ccs0: SUCCESS (0.123s)
[222.014602] Subtest engines-hang: SUCCESS (0.650s)
[222.084135] [045/130] (813s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[222.155400] Starting subtest: basic-batch-kernel-default-cmd
[222.159176] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[222.338069] [046/130] (813s left) api_intel_allocator (fork-simple-stress)
[222.396135] Starting subtest: fork-simple-stress
[227.800304] Subtest fork-simple-stress: SUCCESS (5.407s)
[227.912407] [047/130] (807s left) gem_userptr_blits (nohangcheck)
[227.997998] Starting subtest: nohangcheck
[228.370942] Subtest nohangcheck: SUCCESS (0.369s)
[228.510576] [048/130] (807s left) gem_reg_read (timestamp-moving)
[228.572812] Starting subtest: timestamp-moving
[229.573631] Subtest timestamp-moving: SUCCESS (1.001s)
[229.651436] [049/130] (805s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[229.755900] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[229.758357] Starting dynamic subtest: pipe-A-default-mode
[230.856766] Dynamic subtest pipe-A-default-mode: SKIP (1.095s)
[230.861691] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.096s)
[231.028015] [050/130] (804s left) drm_read (fault-buffer)
[231.193836] Starting subtest: fault-buffer
[231.196553] Subtest fault-buffer: SUCCESS (0.000s)
[231.337569] [051/130] (804s left) gem_exec_whisper (basic-queues-priority)
[231.410779] Starting subtest: basic-queues-priority
[254.489033] Subtest basic-queues-priority: SUCCESS (23.083s)
[254.670412] [052/130] (780s left) gem_softpin (evict-prime)
[254.728320] Starting subtest: evict-prime
[254.730565] Starting dynamic subtest: rcs0
[255.888045] Dynamic subtest rcs0: SUCCESS (1.160s)
[255.896194] Starting dynamic subtest: bcs0
[257.040309] Dynamic subtest bcs0: SUCCESS (1.152s)
[257.051381] Starting dynamic subtest: vcs0
[258.481512] Dynamic subtest vcs0: SUCCESS (1.439s)
[258.493120] Starting dynamic subtest: vcs1
[260.484789] Dynamic subtest vcs1: SUCCESS (2.002s)
[260.494399] Starting dynamic subtest: vecs0
[262.525595] Dynamic subtest vecs0: SUCCESS (2.040s)
[262.536948] Starting dynamic subtest: ccs0
[263.686387] Dynamic subtest ccs0: SUCCESS (1.161s)
[263.698019] Starting dynamic subtest: all
[265.475010] Dynamic subtest all: SUCCESS (1.786s)
[265.477861] Subtest evict-prime: SUCCESS (10.751s)
[265.552665] [053/130] (770s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[265.615840] Starting subtest: single-wait-all-for-submit-available-signaled
[265.618278] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[265.719945] [054/130] (770s left) kms_chamelium_audio (dp-audio)
[266.114930] Subtest dp-audio: SKIP (0.000s)
[266.912126] [055/130] (768s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[267.013302] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[267.015634] Starting dynamic subtest: pipe-A-eDP-1
[267.433429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[267.443675] Starting dynamic subtest: pipe-B-eDP-1
[268.832276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.400s)
[268.840823] Starting dynamic subtest: pipe-C-eDP-1
[270.220723] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[270.229449] Starting dynamic subtest: pipe-D-eDP-1
[271.544511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[271.546764] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.503s)
[272.729120] [056/130] (763s left) gem_tiled_fence_blits (basic)
[272.795625] Subtest basic: SKIP (0.000s)
[272.895079] [057/130] (762s left) kms_flip (basic-flip-vs-wf_vblank)
[273.001270] Starting subtest: basic-flip-vs-wf_vblank
[273.003510] Starting dynamic subtest: A-eDP1
[274.980484] Dynamic subtest A-eDP1: SUCCESS (1.979s)
[274.991561] Starting dynamic subtest: B-eDP1
[276.903514] Dynamic subtest B-eDP1: SUCCESS (1.921s)
[276.913173] Starting dynamic subtest: C-eDP1
[278.821294] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[278.830915] Starting dynamic subtest: D-eDP1
[280.745540] Dynamic subtest D-eDP1: SUCCESS (1.923s)
[280.747945] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.746s)
[281.965096] [058/130] (753s left) kms_chamelium_edid (hdmi-edid-read)
[282.350011] Subtest hdmi-edid-read: SKIP (0.000s)
[283.170576] [059/130] (752s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[283.236846] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[283.241102] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[283.415696] [060/130] (752s left) i915_pm_freq_mult (media-freq)
[283.469474] Starting subtest: media-freq
[283.471842] Starting dynamic subtest: gt0
[283.476498] Dynamic subtest gt0: SKIP (0.000s)
[283.485658] Starting dynamic subtest: gt1
[283.490282] Dynamic subtest gt1: SKIP (0.000s)
[283.494860] Subtest media-freq: SKIP (0.001s)
[283.567607] [061/130] (752s left) kms_cursor_edge_walk (128x128-top-edge)
[283.671301] Starting subtest: 128x128-top-edge
[283.673567] Starting dynamic subtest: pipe-A-eDP-1
[287.159687] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[287.168439] Starting dynamic subtest: pipe-D-eDP-1
[290.284494] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[290.286815] Subtest 128x128-top-edge: SUCCESS (6.610s)
[291.085091] [062/130] (744s left) gem_pread (exhaustion)
[291.153297] Subtest exhaustion: SKIP (0.000s)
[291.210618] [063/130] (744s left) kms_cursor_crc (cursor-onscreen-512x170)
[291.474054] Starting subtest: cursor-onscreen-512x170
[291.478769] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[291.609762] [064/130] (744s left) kms_psr (psr2-sprite-mmap-cpu)
[291.710457] Starting subtest: psr2-sprite-mmap-cpu
[291.712627] Starting dynamic subtest: eDP-1
[293.480923] Dynamic subtest eDP-1: SUCCESS (1.766s)
[293.483288] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.768s)
[294.335085] [065/130] (741s left) kms_flip (flip-vs-absolute-wf_vblank)
[294.431391] Starting subtest: flip-vs-absolute-wf_vblank
[294.433579] Starting dynamic subtest: A-eDP1
[303.384338] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[303.398324] Starting dynamic subtest: B-eDP1
[312.308610] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[312.319228] Starting dynamic subtest: C-eDP1
[321.220238] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[321.229082] Starting dynamic subtest: D-eDP1
[330.145902] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[330.150834] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.719s)
[331.356579] [066/130] (704s left) kms_joiner (basic-big-joiner)
[331.473190] Starting subtest: basic-big-joiner
[331.477564] Subtest basic-big-joiner: SKIP (0.000s)
[331.529624] [067/130] (704s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[331.634273] Starting subtest: 4-tiled-32bpp-rotate-90
[331.653204] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[331.761240] [068/130] (704s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[331.864036] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[331.866372] Starting dynamic subtest: pipe-A-eDP-1
[332.004050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[332.013603] Starting dynamic subtest: pipe-B-eDP-1
[332.141660] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.136s)
[332.151012] Starting dynamic subtest: pipe-C-eDP-1
[332.280294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.138s)
[332.289658] Starting dynamic subtest: pipe-D-eDP-1
[332.418486] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.138s)
[332.420424] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.555s)
[334.606370] [069/130] (701s left) kms_atomic_interruptible (legacy-pageflip)
[334.701421] Starting subtest: legacy-pageflip
[334.703753] Starting dynamic subtest: pipe-A-eDP-1
[342.125955] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.426s)
[342.128712] Subtest legacy-pageflip: SUCCESS (7.427s)
[342.952086] [070/130] (693s left) kms_hdr (invalid-metadata-sizes)
[343.041307] Starting subtest: invalid-metadata-sizes
[343.048049] Subtest invalid-metadata-sizes: SKIP (0.000s)
[343.110132] [071/130] (693s left) gem_close (basic)
[343.178470] Starting subtest: basic
[343.180908] Subtest basic: SUCCESS (0.000s)
[343.287113] [072/130] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[343.385727] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[347.571724] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.189s)
[347.681859] [073/130] (688s left) gem_madvise (dontneed-before-mmap)
[347.721356] Starting subtest: dontneed-before-mmap
[347.751680] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[347.867728] [074/130] (688s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[347.986933] Starting subtest: cursorB-vs-flipB-legacy
[347.991356] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[348.079753] [075/130] (688s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[348.183537] Starting subtest: fbc-psr2-cursor-mmap-cpu
[348.185898] Starting dynamic subtest: eDP-1
[348.190399] Dynamic subtest eDP-1: SKIP (0.000s)
[348.194817] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[348.254484] [076/130] (688s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[348.352570] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[348.354898] Starting dynamic subtest: pipe-A-eDP-1
[349.230019] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s)
[349.239472] Starting dynamic subtest: pipe-B-eDP-1
[350.766510] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.535s)
[350.775998] Starting dynamic subtest: pipe-C-eDP-1
[352.225150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.460s)
[352.234164] Starting dynamic subtest: pipe-D-eDP-1
[353.739649] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[353.742002] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.379s)
[354.913484] [077/130] (681s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[354.979169] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[355.056044] [078/130] (681s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[355.166718] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[355.171026] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[355.278061] [079/130] (681s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[355.382953] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[355.386947] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[355.485126] [080/130] (681s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[355.551609] Starting subtest: invalid-bsd2-flag-on-blt
[355.553951] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[355.660704] [081/130] (681s left) kms_prop_blob (basic)
[355.724276] Starting subtest: basic
[355.726681] Subtest basic: SUCCESS (0.000s)
[355.838254] [082/130] (680s left) gem_partial_pwrite_pread (writes-after-reads)
[355.908297] Subtest writes-after-reads: SKIP (0.000s)
[355.983654] [083/130] (680s left) gem_render_copy_redux (flink-interruptible)
[356.042399] Starting subtest: flink-interruptible
[356.936966] Subtest flink-interruptible: SUCCESS (0.895s)
[357.066766] [084/130] (679s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[357.161579] Starting subtest: yf-tiled-32bpp-rotate-180
[357.165341] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[357.259779] [085/130] (679s left) syncobj_wait (multi-wait-submitted)
[357.315195] Starting subtest: multi-wait-submitted
[357.420957] Subtest multi-wait-submitted: SUCCESS (0.105s)
[357.493422] [086/130] (679s left) kms_async_flips (async-flip-suspend-resume)
[357.588823] Starting subtest: async-flip-suspend-resume
[357.949291] Starting dynamic subtest: pipe-A-eDP-1
[375.679137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.877s)
[376.047192] Starting dynamic subtest: pipe-B-eDP-1
[378.775718] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[379.151937] Starting dynamic subtest: pipe-C-eDP-1
[381.857670] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.748s)
[382.221863] Starting dynamic subtest: pipe-D-eDP-1
[384.943868] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s)
[384.946516] Subtest async-flip-suspend-resume: SUCCESS (12.631s)
[386.084943] [087/130] (665s left) kms_cursor_crc (cursor-size-hints)
[386.203928] Starting subtest: cursor-size-hints
[386.206263] Starting dynamic subtest: pipe-A-eDP-1
[386.830646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.629s)
[386.841683] Starting dynamic subtest: pipe-D-eDP-1
[388.055346] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[388.057619] Subtest cursor-size-hints: SUCCESS (1.860s)
[388.833073] [088/130] (662s left) gem_eio (throttle)
[389.062312] Starting subtest: throttle
[389.397434] Subtest throttle: SUCCESS (0.338s)
[389.548375] [089/130] (662s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[389.612669] Starting subtest: multi-wait-all-for-submit-unsubmitted
[389.716501] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[389.787514] [090/130] (661s left) syncobj_timeline (wait-for-submit-complex)
[389.839734] Starting subtest: wait-for-submit-complex
[389.900196] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[389.968157] [091/130] (661s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[394.968776] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[394.973639] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[395.820458] [092/130] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[395.924433] Starting subtest: fbcpsr-2p-rte
[395.928372] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[396.033432] [093/130] (655s left) kms_addfb_basic (addfb25-4-tiled)
[396.138243] Starting subtest: addfb25-4-tiled
[396.140214] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[396.228637] [094/130] (655s left) syncobj_wait (single-wait-submitted)
[396.287102] Starting subtest: single-wait-submitted
[396.397727] Subtest single-wait-submitted: SUCCESS (0.108s)
[396.468533] [095/130] (655s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[396.561258] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[396.563658] Starting dynamic subtest: pipe-A
[396.634176] Dynamic subtest pipe-A: SUCCESS (0.073s)
[396.644548] Starting dynamic subtest: pipe-B
[397.742341] Dynamic subtest pipe-B: SUCCESS (1.109s)
[397.759787] Starting dynamic subtest: pipe-C
[398.847263] Dynamic subtest pipe-C: SUCCESS (1.105s)
[398.855472] Starting dynamic subtest: pipe-D
[399.984977] Dynamic subtest pipe-D: SUCCESS (1.138s)
[399.987325] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.431s)
[401.116975] [096/130] (650s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[401.185659] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[401.292930] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[401.361767] [097/130] (650s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[401.460571] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[405.921434] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.468s)
[406.040896] [098/130] (645s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[406.102715] Starting subtest: invalid-signal-one-illegal-handle
[406.104843] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[406.203878] [099/130] (645s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[406.335946] Starting subtest: cursor-vs-flip-atomic-transitions
[436.056665] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.717s)
[436.894571] [100/130] (615s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[437.004402] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[437.008697] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[437.087876] [101/130] (614s left) dmabuf_sync_file (import-multiple-read-only)
[437.132748] Starting subtest: import-multiple-read-only
[437.134946] Subtest import-multiple-read-only: SUCCESS (0.003s)
[437.182152] [102/130] (614s left) kms_pm_dc (dc5-retention-flops)
[438.288998] Starting subtest: dc5-retention-flops
[438.293360] Subtest dc5-retention-flops: SKIP (0.000s)
[438.357079] [103/130] (613s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[438.453992] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[438.456267] Starting dynamic subtest: pipe-A-default-mode
[438.744843] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[438.749457] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.286s)
[439.516354] [104/130] (612s left) gem_busy (semaphore)
[439.706793] Subtest semaphore: SKIP (0.000s)
[439.949349] [105/130] (612s left) kms_plane_cursor (viewport)
[440.040212] Starting subtest: viewport
[440.044601] Starting dynamic subtest: pipe-A-eDP-1-size-64
[442.868753] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.826s)
[442.928377] Starting dynamic subtest: pipe-A-eDP-1-size-128
[445.722387] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.803s)
[445.784191] Starting dynamic subtest: pipe-A-eDP-1-size-256
[448.646501] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.871s)
[448.993320] Starting dynamic subtest: pipe-B-eDP-1-size-64
[452.543793] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.560s)
[452.608744] Starting dynamic subtest: pipe-B-eDP-1-size-128
[455.430646] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.836s)
[455.490840] Starting dynamic subtest: pipe-B-eDP-1-size-256
[458.265808] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.781s)
[458.611038] Starting dynamic subtest: pipe-C-eDP-1-size-64
[461.786507] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.185s)
[461.825621] Starting dynamic subtest: pipe-C-eDP-1-size-128
[464.240524] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.424s)
[464.278877] Starting dynamic subtest: pipe-C-eDP-1-size-256
[466.729259] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.457s)
[467.057368] Starting dynamic subtest: pipe-D-eDP-1-size-64
[470.215795] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.171s)
[470.252658] Starting dynamic subtest: pipe-D-eDP-1-size-128
[472.725677] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.480s)
[472.763189] Starting dynamic subtest: pipe-D-eDP-1-size-256
[475.238664] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.481s)
[475.556794] Subtest viewport: SUCCESS (35.524s)
[476.412097] [106/130] (575s left) kms_color (ctm-signed)
[476.511060] Starting subtest: ctm-signed
[476.513319] Starting dynamic subtest: pipe-A-eDP-1
[478.586999] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.074s)
[478.597220] Starting dynamic subtest: pipe-B-eDP-1
[481.311060] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.721s)
[481.319656] Starting dynamic subtest: pipe-C-eDP-1
[483.926373] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[483.935719] Starting dynamic subtest: pipe-D-eDP-1
[486.583333] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.655s)
[486.585550] Subtest ctm-signed: SUCCESS (10.066s)
[487.423304] [107/130] (564s left) kms_writeback (writeback-check-output)
[487.519769] Subtest writeback-check-output: SKIP (0.000s)
[487.558505] [108/130] (564s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[487.660426] Starting subtest: x-tiled-8bpp-rotate-90
[487.681304] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[487.813069] [109/130] (564s left) kms_tiled_display (basic-test-pattern)
[487.936310] Subtest basic-test-pattern: SKIP (0.000s)
[487.975720] [110/130] (564s left) gen9_exec_parse (basic-rejected)
[488.034890] Subtest basic-rejected: SKIP (0.000s)
[488.097073] [111/130] (564s left) gem_exec_fence (syncobj-unused-fence)
[488.537302] Starting subtest: syncobj-unused-fence
[488.543329] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[490.455814] [112/130] (561s left) gem_exec_reloc (basic-gtt-cpu)
[490.521635] Subtest basic-gtt-cpu: SKIP (0.000s)
[490.602171] [113/130] (561s left) kms_dsc (dsc-fractional-bpp)
[490.710928] Starting subtest: dsc-fractional-bpp
[490.723857] Subtest dsc-fractional-bpp: SKIP (0.000s)
[490.780072] [114/130] (561s left) kms_chamelium_hpd (hdmi-hpd-fast)
[491.168768] Subtest hdmi-hpd-fast: SKIP (0.000s)
[491.921966] [115/130] (560s left) gem_lmem_swapping (smem-oom)
[491.965951] Subtest smem-oom: SKIP (0.000s)
[492.006711] [116/130] (560s left) kms_addfb_basic (tile-pitch-mismatch)
[492.067749] Starting subtest: tile-pitch-mismatch
[492.072545] Subtest tile-pitch-mismatch: SKIP (0.000s)
[492.199729] [117/130] (560s left) gem_mmap_gtt (zero-extend)
[492.266293] Subtest zero-extend: SKIP (0.000s)
[492.324224] [118/130] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[492.419334] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[497.593662] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (5.176s)
[497.713451] [119/130] (554s left) gem_exec_store (pages)
[497.785154] Starting subtest: pages
[497.787626] Starting dynamic subtest: rcs0
[497.897982] Dynamic subtest rcs0: SUCCESS (0.112s)
[497.909009] Starting dynamic subtest: bcs0
[497.976543] Dynamic subtest bcs0: SUCCESS (0.078s)
[497.987808] Starting dynamic subtest: vcs0
[498.048935] Dynamic subtest vcs0: SUCCESS (0.072s)
[498.057286] Starting dynamic subtest: vcs1
[498.113986] Dynamic subtest vcs1: SUCCESS (0.065s)
[498.123111] Starting dynamic subtest: vecs0
[498.204939] Dynamic subtest vecs0: SUCCESS (0.090s)
[498.216061] Starting dynamic subtest: ccs0
[498.280381] Dynamic subtest ccs0: SUCCESS (0.074s)
[498.282820] Subtest pages: SUCCESS (0.496s)
[498.457828] [120/130] (554s left) kms_psr (pr-cursor-plane-move)
[498.555235] Starting subtest: pr-cursor-plane-move
[498.559375] Subtest pr-cursor-plane-move: SKIP (0.000s)
[498.620174] [121/130] (554s left) gem_exec_capture (capture-recoverable)
[498.678796] Starting subtest: capture-recoverable
[498.681172] Subtest capture-recoverable: SUCCESS (0.002s)
[498.799684] [122/130] (553s left) perf_pmu (most-busy-idle-check-all)
[498.836847] Starting subtest: most-busy-idle-check-all
[498.839281] Starting dynamic subtest: rcs0
[500.337615] Dynamic subtest rcs0: SUCCESS (1.498s)
[500.347501] Starting dynamic subtest: bcs0
[502.322160] Dynamic subtest bcs0: SUCCESS (1.982s)
[502.338852] Starting dynamic subtest: vcs0
[504.305708] Dynamic subtest vcs0: SUCCESS (1.981s)
[504.318787] Starting dynamic subtest: vcs1
[506.354095] Dynamic subtest vcs1: SUCCESS (2.046s)
[506.367079] Starting dynamic subtest: vecs0
[508.338217] Dynamic subtest vecs0: SUCCESS (1.981s)
[508.350199] Starting dynamic subtest: ccs0
[510.321962] Dynamic subtest ccs0: SUCCESS (1.981s)
[510.325153] Subtest most-busy-idle-check-all: SUCCESS (11.483s)
[510.428566] [123/130] (542s left) dumb_buffer (map-invalid-size)
[510.487322] Starting subtest: map-invalid-size
[510.489735] Subtest map-invalid-size: SUCCESS (0.000s)
[510.601379] [124/130] (542s left) gem_linear_blits (interruptible)
[511.096667] Starting subtest: interruptible
[516.163835] Subtest interruptible: SUCCESS (5.066s)
[516.327474] [125/130] (536s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[516.464722] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[516.469061] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[516.579111] [126/130] (536s left) prime_vgem (coherency-blt)
[516.665488] Starting subtest: coherency-blt
[517.733840] Subtest coherency-blt: SUCCESS (1.067s)
[517.884112] [127/130] (535s left) gen7_exec_parse (basic-offset)
[517.951196] Subtest basic-offset: SKIP (0.000s)
[518.011877] [128/130] (534s left) api_intel_allocator (reopen-fork)
[518.071106] Starting subtest: reopen-fork
[521.351710] Subtest reopen-fork: SUCCESS (3.282s)
[521.420862] [129/130] (531s left) kms_addfb_basic (basic)
[521.482732] Starting subtest: basic
[521.484743] Subtest basic: SUCCESS (0.000s)
[521.626980] [130/130] (531s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[521.731693] Starting subtest: x-tiled-16bpp-rotate-270
[521.751668] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[521.882186] Closing watchdogs
Done.