[61.339289] Initializing watchdogs
[61.339338]   /dev/watchdog0
[61.354108] [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]
[61.358704] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.361517] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.363899] [001/133] (960s left) syncobj_eventfd (binary-wait)
[61.417539] Starting subtest: binary-wait
[61.428169] Subtest binary-wait: SUCCESS (0.011s)
[61.507910] [002/133] (960s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[61.605747] Starting subtest: yf-tiled-addfb-size-overflow
[61.607735] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[61.706188] [003/133] (960s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[63.259870] Starting subtest: modeset-lpsp-stress-no-wait
[73.572874] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.327s)
[73.642774] [004/133] (948s left) gem_exec_schedule (lateslice)
[73.698838] Starting subtest: lateslice
[73.699653] Starting dynamic subtest: rcs0
[73.719827] Dynamic subtest rcs0: SUCCESS (0.021s)
[73.726621] Starting dynamic subtest: bcs0
[73.740919] Dynamic subtest bcs0: SUCCESS (0.021s)
[73.746537] Starting dynamic subtest: vcs0
[73.758714] Dynamic subtest vcs0: SUCCESS (0.017s)
[73.764683] Starting dynamic subtest: vcs1
[73.777225] Dynamic subtest vcs1: SUCCESS (0.018s)
[73.783056] Starting dynamic subtest: vecs0
[73.795525] Dynamic subtest vecs0: SUCCESS (0.018s)
[73.801344] Starting dynamic subtest: ccs0
[73.813586] Dynamic subtest ccs0: SUCCESS (0.018s)
[73.814664] Subtest lateslice: SUCCESS (0.115s)
[74.971417] [005/133] (947s left) kms_frontbuffer_tracking (psr-slowdraw)
[75.072080] Starting subtest: psr-slowdraw
[100.381157] Subtest psr-slowdraw: SUCCESS (25.317s)
[100.485975] [006/133] (921s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[100.579973] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[100.581996] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[101.662663] [007/133] (920s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[101.759423] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[101.760445] Starting dynamic subtest: pipe-A
[102.087551] Dynamic subtest pipe-A: SUCCESS (0.337s)
[102.095544] Starting dynamic subtest: pipe-B
[103.454989] Dynamic subtest pipe-B: SUCCESS (1.367s)
[103.461470] Starting dynamic subtest: pipe-C
[104.881178] Dynamic subtest pipe-C: SUCCESS (1.425s)
[104.888551] Starting dynamic subtest: pipe-D
[106.315061] Dynamic subtest pipe-D: SUCCESS (1.433s)
[106.316348] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.566s)
[107.479546] [008/133] (914s left) core_getversion (basic)
[107.511992] Starting subtest: basic
[107.513917] Subtest basic: SUCCESS (0.000s)
[107.565605] [009/133] (914s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[107.680979] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[109.069808] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.389s)
[109.958271] [010/133] (912s left) gem_exec_schedule (deep)
[110.142452] Starting subtest: deep
[110.143543] Starting dynamic subtest: rcs0
[115.415340] Dynamic subtest rcs0: SKIP (5.270s)
[115.422539] Starting dynamic subtest: vcs0
[125.553141] Dynamic subtest vcs0: SUCCESS (10.138s)
[125.568903] Starting dynamic subtest: vcs1
[136.320128] Dynamic subtest vcs1: SUCCESS (10.766s)
[136.329056] Starting dynamic subtest: vecs0
[147.288694] Dynamic subtest vecs0: SUCCESS (10.967s)
[147.300279] Starting dynamic subtest: ccs0
[159.494797] Dynamic subtest ccs0: SUCCESS (12.204s)
[159.496536] Subtest deep: SUCCESS (49.349s)
[161.490292] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[161.492008] [011/133] (860s left) gem_exec_alignment (single)
[161.545998] Starting subtest: single
[161.551528] Subtest single: SUCCESS (0.006s)
[161.689465] [012/133] (860s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[161.793134] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[161.794059] Starting dynamic subtest: pipe-A-eDP-1
[161.797653] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.804764] Starting dynamic subtest: pipe-B-eDP-1
[161.808420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.815143] Starting dynamic subtest: pipe-C-eDP-1
[161.818784] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.824943] Starting dynamic subtest: pipe-D-eDP-1
[161.828475] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.830253] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.006s)
[164.116250] [013/133] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[164.214620] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[164.216485] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[164.304851] [014/133] (857s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[164.391587] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[168.898397] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.506s)
[170.029060] [015/133] (852s left) i915_drm_fdinfo (busy-check-all)
[170.064773] Starting subtest: busy-check-all
[170.065691] Starting dynamic subtest: rcs0
[170.069280] Dynamic subtest rcs0: SKIP (0.004s)
[170.076392] Starting dynamic subtest: bcs0
[170.077856] Dynamic subtest bcs0: SKIP (0.000s)
[170.084162] Starting dynamic subtest: vcs0
[170.085692] Dynamic subtest vcs0: SKIP (0.000s)
[170.093525] Starting dynamic subtest: vcs1
[170.095112] Dynamic subtest vcs1: SKIP (0.000s)
[170.101686] Starting dynamic subtest: vecs0
[170.103343] Dynamic subtest vecs0: SKIP (0.000s)
[170.109387] Starting dynamic subtest: ccs0
[170.111064] Dynamic subtest ccs0: SKIP (0.000s)
[170.112640] Subtest busy-check-all: SKIP (0.007s)
[170.139682] [016/133] (852s left) gem_exec_whisper (basic-queues-all)
[170.232505] Starting subtest: basic-queues-all
[181.822427] Subtest basic-queues-all: SUCCESS (11.580s)
[182.016076] [017/133] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[182.120355] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[182.122036] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[182.214493] [018/133] (840s left) gem_exec_schedule (submit-late-slice)
[182.278962] Starting subtest: submit-late-slice
[182.280091] Starting dynamic subtest: rcs0
[182.313257] Dynamic subtest rcs0: SUCCESS (0.034s)
[182.321732] Starting dynamic subtest: bcs0
[182.340939] Dynamic subtest bcs0: SUCCESS (0.027s)
[182.348333] Starting dynamic subtest: vcs0
[182.374066] Dynamic subtest vcs0: SUCCESS (0.033s)
[182.382661] Starting dynamic subtest: vcs1
[182.403392] Dynamic subtest vcs1: SUCCESS (0.029s)
[182.412444] Starting dynamic subtest: vecs0
[182.431567] Dynamic subtest vecs0: SUCCESS (0.028s)
[182.442056] Starting dynamic subtest: ccs0
[182.460472] Dynamic subtest ccs0: SUCCESS (0.029s)
[182.461339] Subtest submit-late-slice: SUCCESS (0.182s)
[183.967413] [019/133] (838s left) kms_psr (pr-primary-mmap-gtt)
[184.066086] Starting subtest: pr-primary-mmap-gtt
[184.067902] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[184.137247] [020/133] (838s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[184.238877] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[185.372764] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.134s)
[185.493271] [021/133] (837s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[185.593806] Starting subtest: cursor-tearing-framebuffer-change
[185.594670] Starting dynamic subtest: pipe-A-eDP-1
[186.161175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[186.168799] Starting dynamic subtest: pipe-D-eDP-1
[187.366872] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s)
[187.367731] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.773s)
[188.205736] [022/133] (834s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[188.807831] Starting subtest: syncobj-timeline-multiple-ext-nodes
[188.808675] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[189.983708] [023/133] (832s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[190.089873] Starting subtest: 2x-long-flip-vs-cursor-legacy
[190.092592] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[190.231593] [024/133] (832s left) kms_content_protection (atomic-dpms)
[190.379273] Starting subtest: atomic-dpms
[190.381322] Subtest atomic-dpms: SKIP (0.000s)
[190.499870] [025/133] (832s left) kms_selftest (drm_plane_helper)
[190.532819] Starting subtest: drm_plane_helper
[190.539858] Starting dynamic subtest: drm_test_check_plane_state
[190.641398] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.100s)
[190.649197] Starting dynamic subtest: drm_test_check_invalid_plane_state
[190.733198] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.092s)
[190.734361] Subtest drm_plane_helper: SUCCESS (0.202s)
[190.889569] [026/133] (831s left) kms_cursor_crc (cursor-onscreen-512x170)
[191.170772] Starting subtest: cursor-onscreen-512x170
[191.172619] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[191.303463] [027/133] (831s left) i915_hangman (hangcheck-unterminated)
[191.360911] Starting subtest: hangcheck-unterminated
[202.877918] Subtest hangcheck-unterminated: SUCCESS (11.507s)
[202.992225] [028/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[203.096777] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[209.773433] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.678s)
[209.890318] [029/133] (812s left) kms_force_connector_basic (prune-stale-modes)
[209.962273] Starting subtest: prune-stale-modes
[210.398622] Subtest prune-stale-modes: SUCCESS (0.437s)
[210.529193] [030/133] (812s left) prime_vgem (coherency-gtt)
[210.596475] Starting subtest: coherency-gtt
[210.598505] Subtest coherency-gtt: SKIP (0.000s)
[210.685060] [031/133] (812s left) kms_joiner (basic-force-ultra-joiner)
[210.765803] Starting subtest: basic-force-ultra-joiner
[210.767440] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[210.841609] [032/133] (812s left) perf (gen12-oa-tlb-invalidate)
[210.965894] Starting subtest: gen12-oa-tlb-invalidate
[210.966750] Starting dynamic subtest: 0-rcs0
[221.049513] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[221.059370] Starting dynamic subtest: 1-vecs0
[231.098579] Dynamic subtest 1-vecs0: SUCCESS (10.047s)
[231.100088] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.088s)
[231.133664] [033/133] (791s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[231.236821] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[231.265047] Starting dynamic subtest: pipe-A-plane-0
[231.553876] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[231.563455] Starting dynamic subtest: pipe-A-plane-3
[231.787832] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[232.898219] Starting dynamic subtest: pipe-B-plane-0
[233.190412] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[233.198188] Starting dynamic subtest: pipe-B-plane-3
[233.423905] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[233.732783] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.495s)
[234.526948] [034/133] (788s left) gem_exec_balancer (bonded-true-hang)
[234.784072] Starting subtest: bonded-true-hang
[234.786270] Subtest bonded-true-hang: SKIP (0.000s)
[234.890459] [035/133] (788s left) syncobj_eventfd (invalid-illegal-eventfd)
[234.944395] Starting subtest: invalid-illegal-eventfd
[234.945290] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[235.042286] [036/133] (787s left) gen9_exec_parse (batch-without-end)
[235.094303] Subtest batch-without-end: SKIP (0.000s)
[235.162022] [037/133] (787s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[235.257092] Starting subtest: stress-xrgb8888-4tiled
[241.153796] Subtest stress-xrgb8888-4tiled: SUCCESS (5.898s)
[241.201655] [038/133] (781s left) vgem_basic (dmabuf-mmap)
[241.249089] Starting subtest: dmabuf-mmap
[241.270197] Subtest dmabuf-mmap: SUCCESS (0.023s)
[241.326491] [039/133] (781s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[241.412743] Starting subtest: pr-overlay-plane-update-continuous-sf
[241.414416] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[241.494137] [040/133] (781s left) gem_spin_batch (spin-all)
[241.544857] Starting subtest: spin-all
[241.556709] Subtest spin-all: SUCCESS (0.012s)
[242.935564] [041/133] (780s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[243.018065] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[243.019733] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[243.087666] [042/133] (780s left) kms_chamelium_edid (vga-edid-read)
[243.488515] Subtest vga-edid-read: SKIP (0.000s)
[244.300768] [043/133] (778s left) gem_exec_reloc (basic-cpu-gtt-active)
[244.346136] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[244.407648] [044/133] (778s left) kms_flip (2x-flip-vs-expired-vblank)
[244.490179] Starting subtest: 2x-flip-vs-expired-vblank
[244.500415] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[244.576545] [045/133] (778s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[244.681245] Starting subtest: cursorB-vs-flipB-varying-size
[244.682876] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[244.823190] [046/133] (778s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[244.868914] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[244.920987] [047/133] (778s left) kms_dp_link_training (uhbr-mst)
[244.999560] Starting subtest: uhbr-mst
[245.003104] Subtest uhbr-mst: SKIP (0.000s)
[245.064097] [048/133] (778s left) kms_async_flips (alternate-sync-async-flip-atomic)
[245.154457] Starting subtest: alternate-sync-async-flip-atomic
[245.528993] Starting dynamic subtest: pipe-A-eDP-1
[248.288346] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.760s)
[248.667065] Starting dynamic subtest: pipe-B-eDP-1
[251.491202] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.831s)
[251.882337] Starting dynamic subtest: pipe-C-eDP-1
[254.695026] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.820s)
[255.065606] Starting dynamic subtest: pipe-D-eDP-1
[257.895648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.839s)
[257.896669] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.743s)
[259.142093] [049/133] (764s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[259.237531] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[265.855899] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.619s)
[265.985526] [050/133] (757s left) kms_color (invalid-ctm-matrix-sizes)
[266.067545] Starting subtest: invalid-ctm-matrix-sizes
[266.068380] Starting dynamic subtest: pipe-A
[266.069193] Dynamic subtest pipe-A: SUCCESS (0.002s)
[266.081237] Starting dynamic subtest: pipe-B
[266.082044] Dynamic subtest pipe-B: SUCCESS (0.003s)
[266.088986] Starting dynamic subtest: pipe-C
[266.089870] Dynamic subtest pipe-C: SUCCESS (0.004s)
[266.096774] Starting dynamic subtest: pipe-D
[266.097786] Dynamic subtest pipe-D: SUCCESS (0.004s)
[266.098656] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[266.147409] [051/133] (757s left) gem_exec_nop (basic-series)
[266.208052] Starting subtest: basic-series
[282.912668] Subtest basic-series: SUCCESS (16.694s)
[283.129209] [052/133] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[283.220904] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[283.222702] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[283.307692] [053/133] (740s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[283.400522] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[284.417229] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.016s)
[284.564811] [054/133] (739s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[284.619711] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[284.721631] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[284.805815] [055/133] (738s left) gem_ctx_param (basic-default)
[284.857027] Starting subtest: basic-default
[284.858259] Subtest basic-default: SUCCESS (0.000s)
[284.913087] [056/133] (738s left) gem_ctx_persistence (engines-queued)
[284.963255] Starting subtest: engines-queued
[284.964228] Starting dynamic subtest: rcs0
[285.038820] Dynamic subtest rcs0: SUCCESS (0.075s)
[285.050519] Starting dynamic subtest: bcs0
[285.072214] Dynamic subtest bcs0: SUCCESS (0.032s)
[285.082389] Starting dynamic subtest: vcs0
[286.909885] Dynamic subtest vcs0: SUCCESS (1.826s)
[286.920199] Starting dynamic subtest: vcs1
[288.894507] Dynamic subtest vcs1: SUCCESS (1.981s)
[288.904474] Starting dynamic subtest: vecs0
[290.876865] Dynamic subtest vecs0: SUCCESS (1.979s)
[290.886832] Starting dynamic subtest: ccs0
[291.040297] Dynamic subtest ccs0: SUCCESS (0.171s)
[291.041345] Subtest engines-queued: SUCCESS (6.077s)
[291.142476] [057/133] (732s left) i915_selftest (live)
[295.700809] Starting subtest: live
[295.702077] Starting dynamic subtest: sanitycheck
[300.002413] Dynamic subtest sanitycheck: SUCCESS (4.300s)
[300.008674] Starting dynamic subtest: uncore
[304.292017] Dynamic subtest uncore: SUCCESS (4.289s)
[304.300106] Starting dynamic subtest: workarounds
[307.390521] Dynamic subtest workarounds: SUCCESS (3.097s)
[307.398469] Starting dynamic subtest: gt_engines
[310.408557] Dynamic subtest gt_engines: SUCCESS (3.015s)
[310.415920] Starting dynamic subtest: gt_timelines
[326.176831] Dynamic subtest gt_timelines: SUCCESS (15.764s)
[326.185266] Starting dynamic subtest: gt_contexts
[330.519032] Dynamic subtest gt_contexts: SUCCESS (4.340s)
[330.527837] Starting dynamic subtest: gt_lrc
[334.832121] Dynamic subtest gt_lrc: SUCCESS (4.311s)
[334.839932] Starting dynamic subtest: gt_mocs
[337.734534] Dynamic subtest gt_mocs: SUCCESS (2.900s)
[337.743128] Starting dynamic subtest: gt_pm
[344.519761] Dynamic subtest gt_pm: SUCCESS (6.782s)
[344.528198] Starting dynamic subtest: gt_heartbeat
[348.849982] Dynamic subtest gt_heartbeat: SUCCESS (4.330s)
[348.859384] Starting dynamic subtest: gt_tlb
[358.259384] Dynamic subtest gt_tlb: SUCCESS (9.407s)
[358.267637] Starting dynamic subtest: requests
[369.844588] Dynamic subtest requests: SUCCESS (11.582s)
[369.853669] Starting dynamic subtest: migrate
[377.535991] Dynamic subtest migrate: SUCCESS (7.689s)
[377.544238] Starting dynamic subtest: active
[381.899317] Dynamic subtest active: SUCCESS (4.361s)
[381.906552] Starting dynamic subtest: objects
[386.735032] Dynamic subtest objects: SUCCESS (4.833s)
[386.743554] Starting dynamic subtest: mman
[391.469612] Dynamic subtest mman: SUCCESS (4.732s)
[391.477899] Starting dynamic subtest: dmabuf
[395.738062] Dynamic subtest dmabuf: SUCCESS (4.271s)
[395.746093] Starting dynamic subtest: vma
[400.058809] Dynamic subtest vma: SUCCESS (4.325s)
[400.066987] Starting dynamic subtest: coherency
[403.754224] Dynamic subtest coherency: SUCCESS (3.685s)
[403.762241] Starting dynamic subtest: gtt
[413.731906] Dynamic subtest gtt: SUCCESS (9.975s)
[413.740627] Starting dynamic subtest: gem
[419.611205] Dynamic subtest gem: SUCCESS (5.878s)
[419.620497] Starting dynamic subtest: evict
[425.119908] Dynamic subtest evict: SUCCESS (5.506s)
[425.128601] Starting dynamic subtest: hugepages
[435.889589] Dynamic subtest hugepages: SUCCESS (10.768s)
[435.898083] Starting dynamic subtest: gem_contexts
[462.739897] Dynamic subtest gem_contexts: SUCCESS (26.849s)
[462.747891] Starting dynamic subtest: client
[465.491829] Dynamic subtest client: SUCCESS (2.750s)
[465.500832] Starting dynamic subtest: gem_migrate
[469.834287] Dynamic subtest gem_migrate: SUCCESS (4.342s)
[469.842982] Starting dynamic subtest: reset
[472.617482] Dynamic subtest reset: SUCCESS (2.782s)
[472.625405] Starting dynamic subtest: memory_region
[475.303087] Dynamic subtest memory_region: SUCCESS (2.683s)
[475.311161] Starting dynamic subtest: hangcheck
[489.212786] Dynamic subtest hangcheck: SUCCESS (13.906s)
[489.221429] Starting dynamic subtest: execlists
[493.569092] Dynamic subtest execlists: SUCCESS (4.356s)
[493.577799] Starting dynamic subtest: ring_submission
[497.890189] Dynamic subtest ring_submission: SUCCESS (4.320s)
[497.897998] Starting dynamic subtest: perf
[502.170930] Dynamic subtest perf: SUCCESS (4.278s)
[502.179432] Starting dynamic subtest: slpc
[514.172510] Dynamic subtest slpc: SUCCESS (11.999s)
[514.179855] Starting dynamic subtest: guc
[518.027704] Dynamic subtest guc: SUCCESS (3.853s)
[518.035901] Starting dynamic subtest: guc_multi_lrc
[522.349426] Dynamic subtest guc_multi_lrc: SUCCESS (4.320s)
[522.358273] Starting dynamic subtest: guc_hang
[527.267376] Dynamic subtest guc_hang: SUCCESS (4.916s)
[527.275631] Starting dynamic subtest: late_gt_pm
[531.572237] Dynamic subtest late_gt_pm: SUCCESS (4.304s)
[531.573543] Subtest live: SUCCESS (235.867s)
[531.594651] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[531.595370] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[531.596908] [058/133] (492s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[533.180205] Starting subtest: 4-tiled-32bpp-rotate-270
[533.218071] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.037s)
[533.333997] [FACT kms_big_fb (4-tiled-32bpp-rotate-270)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[533.335463] [FACT kms_big_fb (4-tiled-32bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[533.338126] [059/133] (490s left) gem_eio (in-flight-internal-immediate)
[533.480943] Starting subtest: in-flight-internal-immediate
[534.972643] Subtest in-flight-internal-immediate: SUCCESS (1.492s)
[535.114395] [060/133] (488s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[535.198581] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[542.409573] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.211s)
[542.515400] [061/133] (481s left) kms_pm_dc (dc6-psr)
[543.612547] Starting subtest: dc6-psr
[546.494991] Subtest dc6-psr: SUCCESS (2.883s)
[547.291056] [062/133] (476s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[547.378451] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[547.380151] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[547.457361] [063/133] (476s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[547.552311] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[547.554178] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[547.654933] [064/133] (476s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[547.744606] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[547.746530] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[547.841067] [065/133] (476s left) syncobj_wait (multi-wait-all-signaled)
[547.890264] Starting subtest: multi-wait-all-signaled
[547.891429] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[547.981634] [066/133] (476s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[548.066190] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[548.066979] Starting dynamic subtest: pipe-A-eDP-1
[548.075841] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[548.085193] Starting dynamic subtest: pipe-B-eDP-1
[548.093602] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[548.100735] Starting dynamic subtest: pipe-C-eDP-1
[548.109036] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[548.116024] Starting dynamic subtest: pipe-D-eDP-1
[548.124417] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[548.126112] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[550.364356] [067/133] (473s left) gem_ctx_param (basic)
[550.413585] Starting subtest: basic
[550.414561] Subtest basic: SUCCESS (0.001s)
[550.517087] [068/133] (473s left) template (a)
[550.573188] Starting subtest: A
[550.574081] Subtest A: SUCCESS (0.000s)
[550.664895] [069/133] (473s left) kms_psr (psr-cursor-mmap-gtt)
[550.756086] Starting subtest: psr-cursor-mmap-gtt
[550.756882] Starting dynamic subtest: eDP-1
[552.456153] Dynamic subtest eDP-1: SUCCESS (1.699s)
[552.457169] Subtest psr-cursor-mmap-gtt: SUCCESS (1.700s)
[553.324735] [070/133] (470s left) kms_feature_discovery (display-2x)
[553.425031] Starting subtest: display-2x
[553.427044] Subtest display-2x: SKIP (0.000s)
[553.495889] [071/133] (470s left) kms_lease (multimaster-lease)
[553.578467] Starting subtest: multimaster-lease
[553.581521] Subtest multimaster-lease: SUCCESS (0.004s)
[553.705051] [072/133] (470s left) gem_exec_params (no-vebox)
[553.771379] Starting subtest: no-vebox
[553.775022] Subtest no-vebox: SUCCESS (0.003s)
[554.976817] [073/133] (469s left) kms_flip_tiling (flip-change-tiling)
[555.059134] Starting subtest: flip-change-tiling
[555.060763] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[555.236744] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.177s)
[555.252244] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[555.370521] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[555.381807] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[555.524899] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[555.533896] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[555.658562] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[555.669282] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[555.802932] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[555.813963] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[555.947640] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[555.958445] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[556.081393] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[556.093606] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[556.192392] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[556.203542] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[556.346196] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[556.354359] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[556.481201] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[556.492470] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[556.625472] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[556.636952] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[556.769804] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[556.782275] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[556.903449] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[556.915187] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[557.057518] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[557.068051] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[557.159105] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[557.170885] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[557.303520] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[557.315313] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[557.447902] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[557.460512] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[557.592214] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[557.604068] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[557.736657] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[557.748759] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[557.881938] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[557.894454] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[558.025823] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[558.037337] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[558.152902] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.125s)
[558.164307] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[558.275332] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.120s)
[558.286363] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[558.397248] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.120s)
[558.408561] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[558.530844] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[558.542531] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[558.675610] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[558.688482] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[558.819738] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[558.831359] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[558.964290] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[558.975436] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[559.086668] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[559.098395] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[559.230847] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[559.242114] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[559.375227] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[559.387240] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[559.519800] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[559.531240] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[559.664767] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[559.676992] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[559.808661] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[559.820184] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[559.953786] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[559.965250] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[560.103266] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.147s)
[560.159440] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[561.401436] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.253s)
[561.413259] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[561.535417] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[561.545582] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[561.678597] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[561.688613] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[561.812637] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[561.824551] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[561.956661] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[561.968307] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[562.100999] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[562.112896] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[562.234903] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[562.245645] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[562.357069] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s)
[562.368857] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[562.491438] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[562.503623] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[562.634913] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s)
[562.646882] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[562.778992] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[562.790509] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[562.923601] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[562.935301] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[563.057711] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.132s)
[563.069580] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[563.191107] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[563.202779] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[563.312797] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.118s)
[563.324607] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[563.457040] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[563.469582] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[563.601256] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[563.612501] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[563.745536] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[563.756782] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[563.879322] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[563.891286] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[564.023811] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[564.034716] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[564.168440] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[564.180779] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[564.290316] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[564.302052] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[564.445894] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.153s)
[564.457902] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[564.590253] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[564.602958] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[564.734847] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[564.747322] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[564.879564] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[564.891498] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[565.023846] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[565.039361] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[565.168457] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.143s)
[565.180277] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[565.290421] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[565.302397] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[565.446395] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.154s)
[565.458263] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[565.590573] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[565.602792] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[565.735251] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[565.747582] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[565.879577] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[565.891257] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[566.023856] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[566.035918] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[566.169314] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.143s)
[566.182939] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[566.290894] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s)
[566.342886] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[567.542761] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.206s)
[567.554531] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[567.642569] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[567.655075] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[567.742520] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[567.754515] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[567.853882] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[567.866285] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[567.964272] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[567.975206] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[568.075496] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[568.087592] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[568.175937] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[568.187699] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[568.276072] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[568.286868] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[568.375966] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[568.386751] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[568.486885] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[568.498404] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[568.597669] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[568.608939] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[568.708820] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[568.723449] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[568.809417] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[568.822807] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[568.909423] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[568.919893] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[569.009504] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[569.019596] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[569.120475] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[569.132135] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[569.231116] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[569.244390] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[569.342486] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[569.356595] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[569.453889] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[569.466052] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[569.553909] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[569.564732] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[569.664940] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[569.676618] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[569.776069] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[569.790187] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[569.886679] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.108s)
[569.899347] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[569.998027] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[570.009452] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[570.108993] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[570.119988] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[570.220170] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[570.231539] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[570.320127] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[570.330976] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[570.431181] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[570.442395] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[570.542647] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[570.554320] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[570.653837] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[570.668520] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[570.764525] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[570.775516] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[570.875877] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[570.887893] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[570.986869] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[570.998286] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[571.097987] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[571.109375] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[571.209837] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[571.222886] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[571.320775] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[571.362808] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[572.577995] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.221s)
[572.589893] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[572.677992] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[572.689941] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[572.789236] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[572.800351] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[572.899580] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[572.911775] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[573.010423] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[573.021261] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[573.121628] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[573.132620] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[573.221930] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[573.233408] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[573.322019] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[573.332140] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[573.422405] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[573.434339] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[573.533095] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[573.543530] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[573.644078] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[573.655306] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[573.755190] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[573.766261] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[573.855415] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[573.867184] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[573.955641] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[573.965671] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[574.055622] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[574.066483] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[574.178028] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.120s)
[574.190131] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[574.288390] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[574.299833] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[574.438458] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[574.453817] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[574.549929] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[574.562577] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[574.661041] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[574.673066] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[574.772297] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[574.784091] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[574.883506] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[574.898108] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[574.993796] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[575.003978] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[575.104957] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[575.115734] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[575.216109] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[575.225711] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[575.316077] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[575.326827] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[575.427112] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[575.437888] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[575.549597] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.120s)
[575.560743] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[575.661384] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[575.671076] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[575.772064] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[575.783861] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[575.882764] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[575.894519] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[575.995360] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[576.005354] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[576.105342] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[576.116709] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[576.216128] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[576.227213] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[576.327822] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[576.339995] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[576.438944] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[576.471463] Subtest flip-change-tiling: SUCCESS (21.411s)
[577.676849] [074/133] (446s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[577.793427] Starting subtest: random-ccs-data-y-tiled-ccs
[577.794345] Starting dynamic subtest: pipe-A-eDP-1
[577.805316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[577.817951] Starting dynamic subtest: pipe-B-eDP-1
[577.827106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[577.836033] Starting dynamic subtest: pipe-C-eDP-1
[577.844906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[577.851694] Starting dynamic subtest: pipe-D-eDP-1
[577.861691] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[577.863402] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[580.032606] [075/133] (444s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[580.118355] Starting subtest: sprite-rotation-90-pos-100-0
[580.120312] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[580.198760] [076/133] (444s left) perf (invalid-oa-metric-set-id)
[580.322444] Starting subtest: invalid-oa-metric-set-id
[580.335823] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s)
[580.372927] [077/133] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[580.467833] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[580.469561] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[580.560558] [078/133] (443s left) gem_render_copy (linear-to-vebox-y-tiled)
[580.609400] Starting subtest: linear-to-vebox-y-tiled
[580.611321] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[580.799097] [079/133] (443s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[580.896159] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[580.898044] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[580.980426] [080/133] (443s left) gem_softpin (noreloc-s3)
[581.038458] Starting subtest: noreloc-S3
[601.188267] Subtest noreloc-S3: SUCCESS (5.407s)
[611.328049] [081/133] (423s left) kms_big_fb (linear-8bpp-rotate-270)
[611.439160] Starting subtest: linear-8bpp-rotate-270
[611.460364] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[611.572038] [082/133] (423s left) gem_exec_capture (userptr)
[611.624748] Starting subtest: userptr
[612.452317] Subtest userptr: SUCCESS (0.844s)
[612.567812] [083/133] (422s left) syncobj_timeline (single-wait-available-signaled)
[612.608517] Starting subtest: single-wait-available-signaled
[612.609446] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[612.709383] [084/133] (421s left) gem_softpin (noreloc-interruptible)
[612.775859] Starting subtest: noreloc-interruptible
[618.143375] Subtest noreloc-interruptible: SUCCESS (5.390s)
[618.229245] [085/133] (416s left) kms_cursor_crc (cursor-random-128x42)
[618.454164] Starting subtest: cursor-random-128x42
[618.504098] Subtest cursor-random-128x42: SKIP (0.047s)
[618.694964] [086/133] (416s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[618.778290] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[618.779837] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[618.877091] [087/133] (415s left) gem_mmap_offset (partial-unmap)
[618.928556] Starting subtest: partial-unmap
[618.929444] Starting dynamic subtest: smem0
[619.441717] Dynamic subtest smem0: SUCCESS (0.507s)
[619.443203] Subtest partial-unmap: SUCCESS (0.508s)
[619.535169] [088/133] (415s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[619.584140] Starting subtest: y-tiled-to-vebox-x-tiled
[619.585739] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[619.766744] [089/133] (415s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[619.851192] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[619.852175] Starting dynamic subtest: pipe-A-eDP-1
[619.859488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[619.867803] Starting dynamic subtest: pipe-B-eDP-1
[619.875400] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[619.883437] Starting dynamic subtest: pipe-C-eDP-1
[619.890580] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[619.898449] Starting dynamic subtest: pipe-D-eDP-1
[619.905471] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[619.906310] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[622.112559] [090/133] (412s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[622.212727] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[629.583991] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.398s)
[629.694450] [091/133] (405s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[629.771321] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[629.773020] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[629.839924] [092/133] (405s left) kms_async_flips (test-time-stamp)
[629.919150] Starting subtest: test-time-stamp
[630.299108] Starting dynamic subtest: pipe-A-eDP-1
[631.115250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[631.506404] Starting dynamic subtest: pipe-B-eDP-1
[632.261977] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[632.637885] Starting dynamic subtest: pipe-C-eDP-1
[633.392208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[633.755920] Starting dynamic subtest: pipe-D-eDP-1
[634.521549] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[634.522533] Subtest test-time-stamp: SUCCESS (4.611s)
[635.670774] [093/133] (399s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[635.765303] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[635.766123] Starting dynamic subtest: pipe-A-eDP-1
[635.829378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[635.839356] Starting dynamic subtest: pipe-B-eDP-1
[635.893182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[635.902821] Starting dynamic subtest: pipe-C-eDP-1
[635.962468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.068s)
[635.971810] Starting dynamic subtest: pipe-D-eDP-1
[636.029137] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.065s)
[636.030079] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.265s)
[638.351035] [094/133] (396s left) syncobj_timeline (invalid-signal-illegal-handle)
[638.401189] Starting subtest: invalid-signal-illegal-handle
[638.402074] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[638.486083] [095/133] (396s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[638.855223] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[639.647380] [096/133] (395s left) gem_ctx_persistence (legacy-engines-mixed)
[639.699726] Starting subtest: legacy-engines-mixed
[639.700678] Starting dynamic subtest: render
[639.777499] Dynamic subtest render: SUCCESS (0.079s)
[639.790483] Starting dynamic subtest: bsd1
[639.835720] Dynamic subtest bsd1: SUCCESS (0.055s)
[639.848147] Starting dynamic subtest: bsd2
[639.883500] Dynamic subtest bsd2: SUCCESS (0.045s)
[639.894885] Starting dynamic subtest: blt
[639.944819] Dynamic subtest blt: SUCCESS (0.059s)
[639.957416] Starting dynamic subtest: vebox
[640.017476] Dynamic subtest vebox: SUCCESS (0.070s)
[640.018653] Subtest legacy-engines-mixed: SUCCESS (0.321s)
[640.092558] [097/133] (395s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[640.181991] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[640.183799] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[640.267877] [098/133] (394s left) i915_pm_rpm (debugfs-read)
[641.793628] Starting subtest: debugfs-read
[642.951322] Subtest debugfs-read: SUCCESS (1.157s)
[643.321844] [099/133] (391s left) kms_vblank (ts-continuation-idle-hang)
[643.406383] Starting subtest: ts-continuation-idle-hang
[643.407437] Starting dynamic subtest: pipe-A-eDP-1
[669.411363] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.003s)
[669.421350] Starting dynamic subtest: pipe-D-eDP-1
[684.467243] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.057s)
[684.468240] Subtest ts-continuation-idle-hang: SUCCESS (41.065s)
[685.264884] [100/133] (349s left) api_intel_allocator (reserve-simple)
[685.325197] Starting subtest: reserve-simple
[685.327992] Subtest reserve-simple: SUCCESS (0.004s)
[685.439176] [101/133] (349s left) sysfs_heartbeat_interval (invalid)
[685.490794] Starting subtest: invalid
[685.491709] Starting dynamic subtest: vecs0
[685.492613] Dynamic subtest vecs0: SUCCESS (0.000s)
[685.501647] Starting dynamic subtest: ccs0
[685.502924] Dynamic subtest ccs0: SUCCESS (0.000s)
[685.510843] Starting dynamic subtest: vcs0
[685.511733] Dynamic subtest vcs0: SUCCESS (0.000s)
[685.519708] Starting dynamic subtest: bcs0
[685.520506] Dynamic subtest bcs0: SUCCESS (0.000s)
[685.528302] Starting dynamic subtest: rcs0
[685.529040] Dynamic subtest rcs0: SUCCESS (0.000s)
[685.536788] Starting dynamic subtest: vcs1
[685.537789] Dynamic subtest vcs1: SUCCESS (0.000s)
[685.538673] Subtest invalid: SUCCESS (0.006s)
[685.568452] [102/133] (349s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[685.631618] Starting subtest: stress-mm-invalidate-close-overlap
[687.778248] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[687.907577] [103/133] (347s left) gem_pxp (create-regular-context-2)
[688.029488] Starting subtest: create-regular-context-2
[688.030939] Subtest create-regular-context-2: SUCCESS (0.002s)
[688.131746] [104/133] (347s left) gem_exec_reloc (basic-gtt-cpu-active)
[688.187207] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[688.246355] [105/133] (347s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[688.340224] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[693.096889] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.759s)
[694.276520] [106/133] (341s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[694.333379] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[694.401772] [107/133] (341s left) perf_pmu (most-busy-idle-check-all)
[694.444477] Starting subtest: most-busy-idle-check-all
[694.445348] Starting dynamic subtest: rcs0
[695.660314] Dynamic subtest rcs0: SUCCESS (1.206s)
[695.671854] Starting dynamic subtest: bcs0
[697.644458] Dynamic subtest bcs0: SUCCESS (1.982s)
[697.655483] Starting dynamic subtest: vcs0
[699.628021] Dynamic subtest vcs0: SUCCESS (1.982s)
[699.638856] Starting dynamic subtest: vcs1
[701.676050] Dynamic subtest vcs1: SUCCESS (2.046s)
[701.687280] Starting dynamic subtest: vecs0
[703.660753] Dynamic subtest vecs0: SUCCESS (1.982s)
[703.671698] Starting dynamic subtest: ccs0
[705.644345] Dynamic subtest ccs0: SUCCESS (1.981s)
[705.645695] Subtest most-busy-idle-check-all: SUCCESS (11.195s)
[705.737336] [108/133] (329s left) gem_wait (wait)
[705.807797] Starting subtest: wait
[705.808822] Starting dynamic subtest: all-engines
[707.628399] Dynamic subtest all-engines: SUCCESS (1.810s)
[707.639259] Starting dynamic subtest: rcs0
[708.702502] Dynamic subtest rcs0: SUCCESS (1.081s)
[708.720656] Starting dynamic subtest: bcs0
[709.830457] Dynamic subtest bcs0: SUCCESS (1.124s)
[709.847120] Starting dynamic subtest: vcs0
[710.874496] Dynamic subtest vcs0: SUCCESS (1.041s)
[710.886691] Starting dynamic subtest: vcs1
[711.919075] Dynamic subtest vcs1: SUCCESS (1.042s)
[711.931169] Starting dynamic subtest: vecs0
[712.964054] Dynamic subtest vecs0: SUCCESS (1.042s)
[712.976302] Starting dynamic subtest: ccs0
[714.010729] Dynamic subtest ccs0: SUCCESS (1.044s)
[714.011792] Subtest wait: SUCCESS (8.200s)
[714.203799] [109/133] (321s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[714.327526] Starting subtest: 2x-flip-vs-cursor-atomic
[714.330834] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[714.484404] [110/133] (321s left) syncobj_wait (single-wait-submitted)
[714.540495] Starting subtest: single-wait-submitted
[714.646763] Subtest single-wait-submitted: SUCCESS (0.105s)
[714.736826] [111/133] (320s left) kms_psr (psr-sprite-mmap-cpu)
[714.819508] Starting subtest: psr-sprite-mmap-cpu
[714.820397] Starting dynamic subtest: eDP-1
[716.598427] Dynamic subtest eDP-1: SUCCESS (1.778s)
[716.599463] Subtest psr-sprite-mmap-cpu: SUCCESS (1.780s)
[717.441302] [112/133] (318s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[717.530301] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[717.531187] Starting dynamic subtest: pipe-A-default-mode
[718.718307] Dynamic subtest pipe-A-default-mode: SKIP (1.185s)
[718.720008] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.187s)
[718.867717] [113/133] (316s left) gem_exec_big (single)
[718.924883] Starting subtest: single
[722.731132] Subtest single: FAIL (3.783s)
[722.788325] [114/133] (312s left) gem_exec_whisper (basic-contexts-priority)
[722.876313] Starting subtest: basic-contexts-priority
[748.099324] Subtest basic-contexts-priority: SUCCESS (25.174s)
[748.243314] [115/133] (287s left) kms_plane_multiple (tiling-x)
[748.332092] Starting subtest: tiling-x
[748.333012] Starting dynamic subtest: pipe-A-eDP-1
[752.036554] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.704s)
[752.045679] Starting dynamic subtest: pipe-B-eDP-1
[756.393039] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.356s)
[756.403177] Starting dynamic subtest: pipe-C-eDP-1
[760.739977] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.346s)
[760.748905] Starting dynamic subtest: pipe-D-eDP-1
[765.089730] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.348s)
[765.090620] Subtest tiling-x: SUCCESS (16.760s)
[765.894384] [116/133] (269s left) api_intel_bb (object-reloc-purge-cache)
[765.955002] Starting subtest: object-reloc-purge-cache
[765.957387] Subtest object-reloc-purge-cache: SKIP (0.003s)
[766.059453] [117/133] (269s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[766.160550] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[770.533369] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.374s)
[771.693765] [118/133] (264s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[771.775204] Starting subtest: fbc-psr-sprite-mmap-cpu
[771.776050] Starting dynamic subtest: eDP-1
[771.777708] Dynamic subtest eDP-1: SKIP (0.000s)
[771.779495] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[771.851749] [119/133] (264s left) gem_exec_reloc (basic-gtt-read)
[771.913244] Subtest basic-gtt-read: SKIP (0.000s)
[771.983073] [120/133] (263s left) gem_ccs (ctrl-surf-copy-new-ctx)
[772.041847] Starting subtest: ctrl-surf-copy-new-ctx
[772.044086] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[772.131612] [121/133] (263s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[772.232375] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[772.234043] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[772.316357] [122/133] (263s left) kms_psr (fbc-psr2-primary-render)
[772.402998] Starting subtest: fbc-psr2-primary-render
[772.403874] Starting dynamic subtest: eDP-1
[772.405607] Dynamic subtest eDP-1: SKIP (0.000s)
[772.407413] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[772.472444] [123/133] (263s left) kms_psr2_su (page_flip-xrgb8888)
[772.522842] Subtest page_flip-XRGB8888: SKIP (0.000s)
[772.587197] [124/133] (263s left) gem_ctx_shared (q-out-order)
[772.648613] Starting subtest: Q-out-order
[772.649652] Starting dynamic subtest: rcs0
[772.782448] Dynamic subtest rcs0: SUCCESS (0.124s)
[772.794262] Starting dynamic subtest: vcs0
[772.880270] Dynamic subtest vcs0: SUCCESS (0.106s)
[772.892022] Starting dynamic subtest: vcs1
[772.966520] Dynamic subtest vcs1: SUCCESS (0.084s)
[772.982910] Starting dynamic subtest: vecs0
[773.051935] Dynamic subtest vecs0: SUCCESS (0.084s)
[773.071058] Starting dynamic subtest: ccs0
[773.137727] Dynamic subtest ccs0: SUCCESS (0.085s)
[773.139265] Subtest Q-out-order: SUCCESS (0.489s)
[774.724844] [125/133] (261s left) kms_flip (flip-vs-rmfb)
[774.805406] Starting subtest: flip-vs-rmfb
[774.806370] Starting dynamic subtest: A-eDP1
[783.571550] Dynamic subtest A-eDP1: SUCCESS (8.767s)
[783.585821] Starting dynamic subtest: B-eDP1
[792.206064] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[792.218228] Starting dynamic subtest: C-eDP1
[800.860304] Dynamic subtest C-eDP1: SUCCESS (8.655s)
[800.871758] Starting dynamic subtest: D-eDP1
[809.507585] Dynamic subtest D-eDP1: SUCCESS (8.648s)
[809.512149] Subtest flip-vs-rmfb: SUCCESS (34.715s)
[810.752187] [126/133] (225s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[810.850801] Starting subtest: psr-indfb-scaledprimary
[816.624891] Subtest psr-indfb-scaledprimary: SUCCESS (5.778s)
[816.745529] [127/133] (219s left) syncobj_wait (wait-all-interrupted)
[816.799775] Starting subtest: wait-all-interrupted
[816.901490] Subtest wait-all-interrupted: SUCCESS (0.103s)
[816.975988] [128/133] (219s left) kms_flip (flip-vs-fences)
[817.068657] Starting subtest: flip-vs-fences
[817.070251] Subtest flip-vs-fences: SKIP (0.000s)
[817.171551] [129/133] (219s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[817.265254] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[817.266875] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[817.358354] [130/133] (218s left) syncobj_timeline (multi-wait-signaled)
[817.416286] Starting subtest: multi-wait-signaled
[817.417180] Subtest multi-wait-signaled: SUCCESS (0.000s)
[817.520792] [131/133] (218s left) gem_compute (compute-square)
[817.572342] Starting subtest: compute-square
[817.580104] Subtest compute-square: SUCCESS (0.009s)
[817.692540] [132/133] (218s left) kms_addfb_basic (basic)
[817.753878] Starting subtest: basic
[817.754807] Subtest basic: SUCCESS (0.000s)
[817.888350] [133/133] (218s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[817.981769] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[817.983475] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[818.074280] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: core_getversion
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_exec_alignment
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: gem_exec_whisper
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_selftest
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: i915_hangman
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_force_connector_basic
results: parsing output: 29/ for test: prime_vgem
results: parsing output: 30/ for test: kms_joiner
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: syncobj_eventfd
results: parsing output: 35/ for test: gen9_exec_parse
results: parsing output: 36/ for test: kms_pipe_stress
results: parsing output: 37/ for test: vgem_basic
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_spin_batch
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_chamelium_edid
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_dp_link_training
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: gem_exec_nop
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_ctx_param
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: i915_selftest
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_eio
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_pm_dc
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: template
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_feature_discovery
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: kms_flip_tiling
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_capture
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_softpin
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: kms_async_flips
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_pm_rpm
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: sysfs_heartbeat_interval
results: parsing output: 101/ for test: gem_userptr_blits
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: gem_wait
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_exec_big
results: parsing output: 113/ for test: gem_exec_whisper
results: parsing output: 114/ for test: kms_plane_multiple
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_su
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_compute
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.