[58.174350] Initializing watchdogs
[58.174397]   /dev/watchdog0
[58.188612] [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.193017] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.195546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.198709] [001/131] (960s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[58.474071] Starting subtest: cursor-rapid-movement-256x256
[58.489599] Starting dynamic subtest: pipe-A-eDP-1
[59.102682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s)
[59.132696] Starting dynamic subtest: pipe-D-eDP-1
[60.271507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[60.273939] Subtest cursor-rapid-movement-256x256: SUCCESS (1.800s)
[61.145614] [002/131] (957s left) perf (gen12-oa-tlb-invalidate)
[61.281098] Starting subtest: gen12-oa-tlb-invalidate
[61.284804] Starting dynamic subtest: 0-rcs0
[71.371042] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[71.379803] Starting dynamic subtest: 1-vcs1
[81.419064] Dynamic subtest 1-vcs1: SUCCESS (10.047s)
[81.421719] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.087s)
[81.457420] [003/131] (937s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[81.572687] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[81.576810] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[81.673500] [004/131] (937s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[81.773312] Starting subtest: psr2-overlay-plane-update-continuous-sf
[81.775700] Starting dynamic subtest: pipe-A-eDP-1
[82.897482] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.130s)
[82.906308] Starting dynamic subtest: pipe-B-eDP-1
[84.689072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.791s)
[84.691387] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.923s)
[85.492190] [005/131] (933s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[85.610229] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[85.614449] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[85.714359] [006/131] (933s left) kms_cursor_legacy (forked-move)
[85.829433] Starting subtest: forked-move
[85.831688] Starting dynamic subtest: pipe-A
[91.343506] Dynamic subtest pipe-A: SUCCESS (5.459s)
[91.351513] Starting dynamic subtest: pipe-B
[96.818097] Dynamic subtest pipe-B: SUCCESS (5.475s)
[96.825562] Starting dynamic subtest: pipe-C
[102.289195] Dynamic subtest pipe-C: SUCCESS (5.470s)
[102.300442] Starting dynamic subtest: pipe-D
[107.754297] Dynamic subtest pipe-D: SUCCESS (5.465s)
[107.763743] Starting dynamic subtest: all-pipes
[113.233631] Dynamic subtest all-pipes: SUCCESS (5.476s)
[113.235831] Subtest forked-move: SUCCESS (27.348s)
[113.320211] [007/131] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[113.436413] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[113.440418] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[113.527601] [008/131] (905s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[113.613315] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[117.595356] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.985s)
[118.801098] [009/131] (900s left) gem_lmem_swapping (parallel-random-verify)
[118.847414] Subtest parallel-random-verify: SKIP (0.000s)
[118.889626] [010/131] (900s left) gem_sync (basic-many-each)
[118.963484] Starting subtest: basic-many-each
[121.250131] Subtest basic-many-each: SUCCESS (2.284s)
[121.419222] [011/131] (897s left) gem_ctx_persistence (heartbeat-hostile)
[121.471597] Starting subtest: heartbeat-hostile
[121.476269] Subtest heartbeat-hostile: SKIP (0.000s)
[121.572670] [012/131] (897s left) kms_psr (psr2-cursor-mmap-cpu)
[121.659876] Starting subtest: psr2-cursor-mmap-cpu
[121.662260] Starting dynamic subtest: eDP-1
[123.354494] Dynamic subtest eDP-1: SUCCESS (1.695s)
[123.356961] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.696s)
[124.147528] [013/131] (894s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[124.526335] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[125.340082] [014/131] (893s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[125.390064] Starting subtest: invalid-bsd1-flag-on-vebox
[125.392321] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[125.496848] [015/131] (893s left) kms_chamelium_audio (dp-audio)
[125.881518] Subtest dp-audio: SKIP (0.000s)
[126.670400] [016/131] (892s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[126.758136] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[126.760718] Starting dynamic subtest: pipe-A-eDP-1
[126.770318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.779716] Starting dynamic subtest: pipe-B-eDP-1
[126.788550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.795455] Starting dynamic subtest: pipe-C-eDP-1
[126.803986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.810709] Starting dynamic subtest: pipe-D-eDP-1
[126.819205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.823269] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[128.960090] [017/131] (890s left) gen7_exec_parse (basic-allocation)
[129.013784] Subtest basic-allocation: SKIP (0.000s)
[129.078337] [018/131] (890s left) gem_render_copy (yf-tiled)
[129.136060] Starting subtest: yf-tiled
[129.140690] Subtest yf-tiled: SKIP (0.000s)
[129.317838] [019/131] (890s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[129.422165] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[129.424544] Starting dynamic subtest: pipe-A-eDP-1
[129.517194] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[129.526792] Starting dynamic subtest: pipe-B-eDP-1
[130.639021] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[130.643787] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.221s)
[131.817084] [020/131] (887s left) gem_gtt_cpu_tlb
[131.925675] [021/131] (887s left) gem_pread (snoop)
[131.981162] Subtest snoop: SKIP (0.000s)
[132.035375] [022/131] (887s left) gem_exec_whisper (basic-fds-all)
[132.091119] Starting subtest: basic-fds-all
[143.363266] Subtest basic-fds-all: SUCCESS (11.272s)
[143.541689] [023/131] (875s left) gem_linear_blits (normal)
[143.951333] Starting subtest: normal
[148.787579] Subtest normal: SUCCESS (4.835s)
[148.986906] [024/131] (870s left) kms_psr (psr-sprite-mmap-cpu)
[149.118584] Starting subtest: psr-sprite-mmap-cpu
[149.120786] Starting dynamic subtest: eDP-1
[150.831057] Dynamic subtest eDP-1: SUCCESS (1.713s)
[150.833384] Subtest psr-sprite-mmap-cpu: SUCCESS (1.713s)
[151.677713] [025/131] (867s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[151.798567] Starting subtest: 4-tiled-64bpp-rotate-90
[151.817263] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[151.938505] [026/131] (867s left) i915_drm_fdinfo (most-busy-check-all)
[151.981178] Starting subtest: most-busy-check-all
[151.983131] Starting dynamic subtest: rcs0
[151.987794] Dynamic subtest rcs0: SKIP (0.004s)
[151.998823] Starting dynamic subtest: bcs0
[152.003307] Dynamic subtest bcs0: SKIP (0.000s)
[152.011271] Starting dynamic subtest: vcs0
[152.015289] Dynamic subtest vcs0: SKIP (0.000s)
[152.022566] Starting dynamic subtest: vcs1
[152.026642] Dynamic subtest vcs1: SKIP (0.000s)
[152.033931] Starting dynamic subtest: vecs0
[152.038108] Dynamic subtest vecs0: SKIP (0.000s)
[152.045203] Starting dynamic subtest: ccs0
[152.049307] Dynamic subtest ccs0: SKIP (0.000s)
[152.053354] Subtest most-busy-check-all: SKIP (0.007s)
[152.086803] [027/131] (867s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[152.241146] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[152.245723] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[152.388207] [028/131] (867s left) syncobj_eventfd (invalid-illegal-eventfd)
[152.453753] Starting subtest: invalid-illegal-eventfd
[152.456084] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[152.556961] [029/131] (867s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[152.649515] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[152.651644] Starting dynamic subtest: pipe-A-eDP-1
[152.671442] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.686871] Starting dynamic subtest: pipe-B-eDP-1
[152.704825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.712855] Starting dynamic subtest: pipe-C-eDP-1
[152.730995] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.738505] Starting dynamic subtest: pipe-D-eDP-1
[152.757089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.760809] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[154.948389] [030/131] (864s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[155.004783] Starting subtest: etime-single-wait-available-unsubmitted
[155.104716] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[155.178901] [031/131] (864s left) gem_tiled_blits (basic)
[155.245562] Subtest basic: SKIP (0.000s)
[155.322730] [032/131] (864s left) gem_flink_basic (double-flink)
[155.378925] Starting subtest: double-flink
[155.381203] Subtest double-flink: SUCCESS (0.000s)
[155.461340] [033/131] (864s left) i915_suspend (basic-s2idle-without-i915)
[155.497295] Starting subtest: basic-s2idle-without-i915
[176.174363] Subtest basic-s2idle-without-i915: SUCCESS (5.647s)
[176.282889] [034/131] (843s left) syncobj_wait (multi-wait-all-submitted)
[176.347886] Starting subtest: multi-wait-all-submitted
[176.454328] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[176.525939] [035/131] (843s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[176.622004] Starting subtest: fbc-indfb-scaledprimary
[179.580933] Subtest fbc-indfb-scaledprimary: SUCCESS (2.959s)
[180.781209] [036/131] (839s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[180.883540] Starting subtest: yf-tiled-8bpp-rotate-90
[180.888224] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[180.973803] [037/131] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[181.063878] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[184.769679] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.708s)
[185.980952] [038/131] (834s left) gem_ctx_engines (execute-allforone)
[186.039982] Starting subtest: execute-allforone
[186.055047] Subtest execute-allforone: SUCCESS (0.015s)
[187.994973] [039/131] (832s left) syncobj_timeline (wait-zero-handles)
[188.059777] Starting subtest: wait-zero-handles
[188.061957] Subtest wait-zero-handles: SUCCESS (0.000s)
[188.160496] [040/131] (832s left) gem_partial_pwrite_pread (writes-after-reads-display)
[188.226558] Subtest writes-after-reads-display: SKIP (0.000s)
[188.302971] [041/131] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[188.402685] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[188.406819] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[188.493426] [042/131] (831s left) kms_frontbuffer_tracking (fbc-tiling-4)
[188.590944] Starting subtest: fbc-tiling-4
[192.747541] Subtest fbc-tiling-4: SUCCESS (4.159s)
[193.872467] [043/131] (826s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[194.001341] Starting subtest: basic-flip-after-cursor-legacy
[194.937168] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.935s)
[195.788286] [044/131] (824s left) gem_exec_balancer (individual)
[195.866318] Starting subtest: individual
[197.960876] Subtest individual: SUCCESS (2.092s)
[198.297922] [045/131] (822s left) kms_pipe_crc_basic (read-crc)
[198.399249] Starting subtest: read-crc
[198.401531] Starting dynamic subtest: pipe-A-eDP-1
[199.104664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[199.115070] Starting dynamic subtest: pipe-B-eDP-1
[200.472618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.366s)
[200.482072] Starting dynamic subtest: pipe-C-eDP-1
[201.771720] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[201.782479] Starting dynamic subtest: pipe-D-eDP-1
[203.083872] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[203.086170] Subtest read-crc: SUCCESS (4.684s)
[203.923867] [046/131] (816s left) gem_softpin (allocator-nopin)
[203.983051] Starting subtest: allocator-nopin
[204.068722] Subtest allocator-nopin: SUCCESS (0.086s)
[204.183844] [047/131] (816s left) sw_sync (sync_multi_timeline_wait)
[204.217913] Starting subtest: sync_multi_timeline_wait
[204.220329] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[204.269696] [048/131] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[204.358469] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[208.947286] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.592s)
[210.107056] [049/131] (810s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[210.231385] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[241.640716] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.402s)
[242.437317] [050/131] (778s left) gem_madvise (dontneed-after-mmap)
[242.473703] Starting subtest: dontneed-after-mmap
[242.491465] Subtest dontneed-after-mmap: SUCCESS (0.017s)
[242.593685] [051/131] (778s left) gem_exec_create (legacy)
[242.651290] Starting subtest: legacy
[242.653590] Starting dynamic subtest: smem
[244.757102] Dynamic subtest smem: SUCCESS (2.087s)
[244.759233] Subtest legacy: SUCCESS (2.088s)
[244.935152] [052/131] (775s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[245.037896] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[245.041986] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[245.107449] [053/131] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[245.222465] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[245.226555] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[245.320885] [054/131] (775s left) kms_flip (2x-flip-vs-wf_vblank)
[245.417059] Starting subtest: 2x-flip-vs-wf_vblank
[245.427686] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[245.507736] [055/131] (775s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[245.635815] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[246.260148] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[246.458030] [056/131] (774s left) kms_flip (2x-blocking-absolute-wf_vblank)
[246.558104] Starting subtest: 2x-blocking-absolute-wf_vblank
[246.567030] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[246.643516] [057/131] (774s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[246.702475] Starting subtest: yf-tiled-ccs-to-y-tiled
[246.707063] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[246.882860] [058/131] (773s left) kms_psr (fbc-psr-cursor-plane-onoff)
[246.968321] Starting subtest: fbc-psr-cursor-plane-onoff
[246.970657] Starting dynamic subtest: eDP-1
[246.975154] Dynamic subtest eDP-1: SKIP (0.000s)
[246.979563] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[247.037246] [059/131] (773s left) gem_softpin (overlap)
[247.093547] Starting subtest: overlap
[247.995407] Subtest overlap: SUCCESS (0.901s)
[248.124036] [060/131] (772s left) kms_vblank (accuracy-idle)
[248.210574] Starting subtest: accuracy-idle
[248.212877] Starting dynamic subtest: pipe-A-eDP-1
[249.961798] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[249.976970] Starting dynamic subtest: pipe-D-eDP-1
[252.367439] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[252.369877] Subtest accuracy-idle: SUCCESS (4.159s)
[253.190483] [061/131] (767s left) sriov_basic (enable-vfs-autoprobe-on)
[253.267020] Starting subtest: enable-vfs-autoprobe-on
[253.269921] Starting dynamic subtest: numvfs-1
[253.352678] Dynamic subtest numvfs-1: FAIL (0.033s)
[253.363777] Starting dynamic subtest: numvfs-2
[253.437387] Dynamic subtest numvfs-2: FAIL (0.008s)
[253.447583] Starting dynamic subtest: numvfs-3
[253.521192] Dynamic subtest numvfs-3: FAIL (0.003s)
[253.530661] Starting dynamic subtest: numvfs-4
[253.603671] Dynamic subtest numvfs-4: FAIL (0.003s)
[253.613854] Starting dynamic subtest: numvfs-5
[253.686842] Dynamic subtest numvfs-5: FAIL (0.003s)
[253.696824] Starting dynamic subtest: numvfs-6
[253.770695] Dynamic subtest numvfs-6: FAIL (0.004s)
[253.780793] Starting dynamic subtest: numvfs-7
[253.852534] Dynamic subtest numvfs-7: FAIL (0.003s)
[253.862413] Starting dynamic subtest: numvfs-random
[253.934226] Dynamic subtest numvfs-random: FAIL (0.004s)
[253.944286] Starting dynamic subtest: numvfs-all
[254.017261] Dynamic subtest numvfs-all: FAIL (0.004s)
[254.019254] Subtest enable-vfs-autoprobe-on: FAIL (0.582s)
[254.055284] [062/131] (766s left) kms_pm_backlight (fade-with-dpms)
[254.152720] Starting subtest: fade-with-dpms
[256.404688] Starting dynamic subtest: eDP-1
[258.914194] Dynamic subtest eDP-1: SUCCESS (2.507s)
[258.916550] Subtest fade-with-dpms: SUCCESS (4.759s)
[259.718360] [063/131] (761s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[259.819369] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[266.861392] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.043s)
[266.960327] [064/131] (754s left) kms_plane_scaling (planes-upscale-factor-0-25)
[267.053228] Starting subtest: planes-upscale-factor-0-25
[267.055520] Starting dynamic subtest: pipe-A
[267.113778] Dynamic subtest pipe-A: SUCCESS (0.062s)
[267.126947] Starting dynamic subtest: pipe-B
[268.247896] Dynamic subtest pipe-B: SUCCESS (1.133s)
[268.260314] Starting dynamic subtest: pipe-C
[269.356639] Dynamic subtest pipe-C: SUCCESS (1.108s)
[269.366115] Starting dynamic subtest: pipe-D
[270.494835] Dynamic subtest pipe-D: SUCCESS (1.138s)
[270.497161] Subtest planes-upscale-factor-0-25: SUCCESS (3.444s)
[271.654331] [065/131] (749s left) gem_exec_schedule (reorder-wide)
[271.840354] Subtest reorder-wide: SKIP (0.000s)
[272.030875] [066/131] (749s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[272.126239] Starting subtest: fbc-rgb565-draw-mmap-gtt
[272.130195] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[272.218881] [067/131] (748s left) gen9_exec_parse (allowed-all)
[272.283893] Subtest allowed-all: SKIP (0.000s)
[272.351083] [068/131] (748s left) syncobj_wait (invalid-single-wait-unsubmitted)
[272.403077] Starting subtest: invalid-single-wait-unsubmitted
[272.405438] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[272.501415] [069/131] (748s left) gem_exec_schedule (noreorder-priority)
[272.681872] Starting subtest: noreorder-priority
[272.684319] Starting dynamic subtest: rcs0
[273.824948] Dynamic subtest rcs0: SUCCESS (1.143s)
[273.839260] Starting dynamic subtest: vcs0
[275.888162] Dynamic subtest vcs0: SUCCESS (2.059s)
[275.899889] Starting dynamic subtest: vcs1
[277.957562] Dynamic subtest vcs1: SUCCESS (2.067s)
[277.969380] Starting dynamic subtest: vecs0
[279.943942] Dynamic subtest vecs0: SUCCESS (1.986s)
[279.955731] Starting dynamic subtest: ccs0
[281.090770] Dynamic subtest ccs0: SUCCESS (1.147s)
[281.093158] Subtest noreorder-priority: SUCCESS (8.413s)
[281.274932] [070/131] (740s left) gem_exec_params (readonly)
[281.337680] Starting subtest: readonly
[281.343485] Subtest readonly: SUCCESS (0.005s)
[281.470038] [071/131] (739s left) kms_getfb (getfb2-accept-nv12)
[281.563974] Starting subtest: getfb2-accept-nv12
[281.566219] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[281.662880] [072/131] (739s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[281.753401] Starting subtest: fbc-psr2-cursor-mmap-gtt
[281.755664] Starting dynamic subtest: eDP-1
[281.759761] Dynamic subtest eDP-1: SKIP (0.000s)
[281.763866] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[281.821618] [073/131] (739s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[281.918470] Starting subtest: fbc-pr-cursor-plane-update-sf
[281.922446] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[281.981515] [074/131] (739s left) syncobj_wait (multi-wait-for-submit-signaled)
[282.033782] Starting subtest: multi-wait-for-submit-signaled
[282.035951] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[282.130548] [075/131] (739s left) kms_lease (lessee-list)
[282.212210] Starting subtest: lessee-list
[282.214163] Starting dynamic subtest: pipe-A-eDP-1
[282.215892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[282.225218] Starting dynamic subtest: pipe-B-eDP-1
[282.226946] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[282.235383] Starting dynamic subtest: pipe-C-eDP-1
[282.237157] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[282.245351] Starting dynamic subtest: pipe-D-eDP-1
[282.247060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[282.248836] Subtest lessee-list: SUCCESS (0.008s)
[282.333977] [076/131] (739s left) kms_cursor_edge_walk (64x64-right-edge)
[282.417649] Starting subtest: 64x64-right-edge
[282.419523] Starting dynamic subtest: pipe-A-eDP-1
[285.926431] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[285.935771] Starting dynamic subtest: pipe-D-eDP-1
[289.038908] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[289.041241] Subtest 64x64-right-edge: SUCCESS (6.622s)
[289.842845] [077/131] (731s left) kms_joiner (basic-force-ultra-joiner)
[289.939726] Starting subtest: basic-force-ultra-joiner
[289.943937] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[289.999008] [078/131] (731s left) gem_pxp (create-valid-protected-context)
[290.121846] Starting subtest: create-valid-protected-context
[290.124374] Subtest create-valid-protected-context: SUCCESS (0.001s)
[290.226483] [079/131] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[290.318543] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[290.322652] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[290.400620] [080/131] (731s left) kms_plane (plane-position-covered)
[290.495288] Starting subtest: plane-position-covered
[291.010485] Starting dynamic subtest: pipe-A-plane-1
[292.342496] Dynamic subtest pipe-A-plane-1: SUCCESS (1.333s)
[292.352439] Starting dynamic subtest: pipe-A-plane-2
[293.655384] Dynamic subtest pipe-A-plane-2: SUCCESS (1.312s)
[293.665804] Starting dynamic subtest: pipe-A-plane-3
[294.863856] Dynamic subtest pipe-A-plane-3: SUCCESS (1.206s)
[294.874738] Starting dynamic subtest: pipe-A-plane-4
[296.106789] Dynamic subtest pipe-A-plane-4: SUCCESS (1.245s)
[296.116448] Starting dynamic subtest: pipe-A-plane-5
[296.133223] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[297.290515] Starting dynamic subtest: pipe-B-plane-1
[298.591939] Dynamic subtest pipe-B-plane-1: SUCCESS (1.312s)
[298.602156] Starting dynamic subtest: pipe-B-plane-2
[299.905747] Dynamic subtest pipe-B-plane-2: SUCCESS (1.312s)
[299.915156] Starting dynamic subtest: pipe-B-plane-3
[301.152807] Dynamic subtest pipe-B-plane-3: SUCCESS (1.246s)
[301.164960] Starting dynamic subtest: pipe-B-plane-4
[302.413480] Dynamic subtest pipe-B-plane-4: SUCCESS (1.259s)
[302.422457] Starting dynamic subtest: pipe-B-plane-5
[302.439846] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[302.442168] Subtest plane-position-covered: SUCCESS (11.947s)
[303.290711] [081/131] (718s left) i915_pm_rpm (sysfs-read)
[305.022876] Starting subtest: sysfs-read
[306.171528] Subtest sysfs-read: SUCCESS (1.146s)
[306.553044] [082/131] (715s left) syncobj_timeline (invalid-signal-illegal-handle)
[306.609854] Starting subtest: invalid-signal-illegal-handle
[306.612151] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[306.703941] [083/131] (715s left) kms_color (invalid-degamma-lut-sizes)
[306.799964] Starting subtest: invalid-degamma-lut-sizes
[306.802182] Starting dynamic subtest: pipe-A
[307.086804] Dynamic subtest pipe-A: SUCCESS (0.287s)
[307.100687] Starting dynamic subtest: pipe-B
[307.103126] Dynamic subtest pipe-B: SUCCESS (0.000s)
[307.116752] Starting dynamic subtest: pipe-C
[307.119127] Dynamic subtest pipe-C: SUCCESS (0.000s)
[307.127452] Starting dynamic subtest: pipe-D
[307.129704] Dynamic subtest pipe-D: SUCCESS (0.000s)
[307.131867] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[307.964001] [084/131] (713s left) api_intel_bb (intel-bb-blit-y)
[308.019607] Starting subtest: intel-bb-blit-y
[311.432431] Subtest intel-bb-blit-y: SUCCESS (3.414s)
[311.532234] [085/131] (710s left) i915_hangman (engine-error-state-capture)
[311.606891] Starting subtest: engine-error-state-capture
[311.608880] Starting dynamic subtest: rcs0
[314.920750] Dynamic subtest rcs0: SUCCESS (3.315s)
[314.933026] Starting dynamic subtest: bcs0
[320.873138] Dynamic subtest bcs0: SUCCESS (5.949s)
[320.885170] Starting dynamic subtest: vcs0
[326.825953] Dynamic subtest vcs0: SUCCESS (5.950s)
[326.837944] Starting dynamic subtest: vcs1
[331.879184] Dynamic subtest vcs1: SUCCESS (5.050s)
[331.890756] Starting dynamic subtest: vecs0
[337.832399] Dynamic subtest vecs0: SUCCESS (5.950s)
[337.844471] Starting dynamic subtest: ccs0
[343.848938] Dynamic subtest ccs0: SUCCESS (6.013s)
[343.852323] Subtest engine-error-state-capture: SUCCESS (32.244s)
[343.928212] [086/131] (677s left) syncobj_wait (invalid-reset-one-illegal-handle)
[343.980754] Starting subtest: invalid-reset-one-illegal-handle
[343.982667] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[344.077307] [087/131] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[344.178543] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[344.182907] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[344.283905] [088/131] (677s left) perf_pmu (init-wait)
[344.333314] Starting subtest: init-wait
[344.335554] Starting dynamic subtest: rcs0
[344.337762] Dynamic subtest rcs0: SUCCESS (0.002s)
[344.346542] Starting dynamic subtest: bcs0
[344.348688] Dynamic subtest bcs0: SUCCESS (0.000s)
[344.356954] Starting dynamic subtest: vcs0
[344.359179] Dynamic subtest vcs0: SUCCESS (0.001s)
[344.367344] Starting dynamic subtest: vcs1
[344.369521] Dynamic subtest vcs1: SUCCESS (0.001s)
[344.377738] Starting dynamic subtest: vecs0
[344.379926] Dynamic subtest vecs0: SUCCESS (0.001s)
[344.388148] Starting dynamic subtest: ccs0
[344.390301] Dynamic subtest ccs0: SUCCESS (0.000s)
[344.392539] Subtest init-wait: SUCCESS (0.008s)
[344.459985] [089/131] (677s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[344.583613] Starting subtest: flip-vs-cursor-busy-crc-atomic
[345.375914] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.792s)
[346.188366] [090/131] (675s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[346.279155] Starting subtest: addfb25-yf-tiled-legacy
[346.281294] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[346.368299] [091/131] (675s left) kms_content_protection (lic-type-0-hdcp14)
[346.505328] Starting subtest: lic-type-0-hdcp14
[346.509613] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[346.613797] [092/131] (675s left) gem_workarounds (basic-read-fd)
[346.685855] Starting subtest: basic-read-fd
[346.698468] Subtest basic-read-fd: SUCCESS (0.011s)
[346.828523] [093/131] (675s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[346.922416] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[346.926666] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[347.012402] [094/131] (675s left) kms_plane_lowres (tiling-none)
[347.103205] Starting subtest: tiling-none
[347.105471] Starting dynamic subtest: pipe-A-eDP-1
[347.109964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.410731] Starting dynamic subtest: pipe-B-eDP-1
[347.415380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.424257] Starting dynamic subtest: pipe-C-eDP-1
[347.428895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.437515] Starting dynamic subtest: pipe-D-eDP-1
[347.441962] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.446319] Subtest tiling-none: SKIP (0.306s)
[348.230956] [095/131] (674s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[348.323295] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[348.327368] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[348.394919] [096/131] (673s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[348.495490] Starting subtest: y-tiled-16bpp-rotate-90
[348.499500] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[348.594273] [097/131] (673s left) api_intel_allocator (standalone)
[348.656792] Starting subtest: standalone
[348.669727] Subtest standalone: SUCCESS (0.016s)
[348.801319] [098/131] (673s left) perf (low-oa-exponent-permissions)
[348.944687] Starting subtest: low-oa-exponent-permissions
[348.983791] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[349.031258] [099/131] (673s left) syncobj_wait (wait-all-for-submit-complex)
[349.082203] Starting subtest: wait-all-for-submit-complex
[349.295514] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[349.380729] [100/131] (673s left) gem_busy (semaphore)
[349.571724] Subtest semaphore: SKIP (0.000s)
[349.784036] [101/131] (672s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[349.878148] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[349.880073] Starting dynamic subtest: pipe-A-eDP-1
[351.182457] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.304s)
[351.459830] Starting dynamic subtest: pipe-B-eDP-1
[352.506034] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[352.775662] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.895s)
[353.616588] [102/131] (668s left) dmabuf_sync_file (export-basic)
[353.746248] Starting subtest: export-basic
[353.748542] Subtest export-basic: SUCCESS (0.001s)
[353.800380] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[353.805327] [103/131] (668s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[353.897491] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[353.901746] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[353.991523] [104/131] (668s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[354.085477] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[354.087422] Starting dynamic subtest: pipe-A-eDP-1
[356.207681] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s)
[356.216631] Starting dynamic subtest: pipe-B-eDP-1
[358.521980] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.312s)
[358.531058] Starting dynamic subtest: pipe-C-eDP-1
[360.610419] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.086s)
[360.619382] Starting dynamic subtest: pipe-D-eDP-1
[362.678741] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.069s)
[362.680681] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.595s)
[363.860050] [105/131] (658s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[363.958751] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[363.962901] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[364.055932] [106/131] (658s left) gem_exec_async (forked-writes)
[364.122339] Starting subtest: forked-writes
[364.124533] Starting dynamic subtest: rcs0
[364.173300] Dynamic subtest rcs0: SUCCESS (0.052s)
[364.183010] Starting dynamic subtest: bcs0
[364.195873] Dynamic subtest bcs0: SUCCESS (0.022s)
[364.204658] Starting dynamic subtest: vcs0
[364.217452] Dynamic subtest vcs0: SUCCESS (0.020s)
[364.227252] Starting dynamic subtest: vcs1
[364.240204] Dynamic subtest vcs1: SUCCESS (0.022s)
[364.249784] Starting dynamic subtest: vecs0
[364.263124] Dynamic subtest vecs0: SUCCESS (0.022s)
[364.277813] Starting dynamic subtest: ccs0
[364.296417] Dynamic subtest ccs0: SUCCESS (0.031s)
[364.298689] Subtest forked-writes: SUCCESS (0.177s)
[364.524486] [107/131] (658s left) kms_vrr (flip-basic)
[364.610174] Starting subtest: flip-basic
[364.616418] Subtest flip-basic: SKIP (0.000s)
[364.683212] [108/131] (658s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[364.775972] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[364.780192] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[364.858801] [109/131] (657s left) gem_exec_fence (syncobj-timeline-chain-engines)
[365.387076] Starting subtest: syncobj-timeline-chain-engines
[365.485616] Subtest syncobj-timeline-chain-engines: SUCCESS (0.100s)
[367.014766] [110/131] (655s left) kms_dsc (dsc-basic)
[367.107353] Starting subtest: dsc-basic
[367.120536] Subtest dsc-basic: SKIP (0.000s)
[367.187951] [111/131] (655s left) kms_chamelium_edid (hdmi-mode-timings)
[367.580286] Subtest hdmi-mode-timings: SKIP (0.000s)
[368.364389] [112/131] (654s left) kms_atomic_transition (modeset-transition)
[368.462339] Starting subtest: modeset-transition
[368.464290] Starting dynamic subtest: 1x-outputs
[379.245461] Dynamic subtest 1x-outputs: SUCCESS (10.784s)
[379.247799] Subtest modeset-transition: SUCCESS (10.786s)
[380.091961] [113/131] (642s left) syncobj_wait (wait-for-submit-snapshot)
[380.155197] Starting subtest: wait-for-submit-snapshot
[380.235316] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[380.312558] [114/131] (642s left) gem_mmap_offset (isolation)
[380.371050] Starting subtest: isolation
[380.388155] Subtest isolation: SUCCESS (0.006s)
[380.488024] [115/131] (642s left) sw_sync (sync_busy)
[380.523701] Starting subtest: sync_busy
[380.525651] Subtest sync_busy: SUCCESS (0.002s)
[380.578074] [116/131] (642s left) gem_gpgpu_fill (basic)
[380.638663] Starting subtest: basic
[380.640551] Starting dynamic subtest: smem
[380.645396] Dynamic subtest smem: SUCCESS (0.007s)
[380.647555] Subtest basic: SUCCESS (0.008s)
[380.783988] [117/131] (642s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[380.887347] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[380.891262] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.992906] [118/131] (642s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[381.089528] Starting subtest: extended-pageflip-modeset-hang-oldfb
[381.091394] Starting dynamic subtest: pipe-A
[388.976177] Dynamic subtest pipe-A: SUCCESS (7.885s)
[388.986155] Starting dynamic subtest: pipe-D
[397.611390] Dynamic subtest pipe-D: SUCCESS (8.632s)
[397.613769] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.522s)
[398.470932] [119/131] (624s left) kms_cursor_crc (cursor-offscreen-512x170)
[398.787415] Starting subtest: cursor-offscreen-512x170
[398.791985] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[398.948013] [120/131] (624s left) gem_ctx_param (invalid-set-ringsize)
[399.020929] Starting subtest: invalid-set-ringsize
[399.023370] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[399.100394] [121/131] (624s left) gem_exec_params (cliprects_ptr-dirt)
[399.160755] Starting subtest: cliprects_ptr-dirt
[399.163135] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[399.264026] [122/131] (624s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[399.365187] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[399.367329] Starting dynamic subtest: pipe-A-eDP-1
[399.389296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.400651] Starting dynamic subtest: pipe-B-eDP-1
[399.417891] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.425950] Starting dynamic subtest: pipe-C-eDP-1
[399.442996] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.451040] Starting dynamic subtest: pipe-D-eDP-1
[399.468636] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.472180] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[401.643892] [123/131] (621s left) syncobj_timeline (signal-point-0)
[401.709382] Starting subtest: signal-point-0
[401.711980] Subtest signal-point-0: SUCCESS (0.000s)
[401.808793] [124/131] (621s left) kms_frontbuffer_tracking (psr-suspend)
[401.910466] Starting subtest: psr-suspend
[440.248600] Subtest psr-suspend: SUCCESS (7.946s)
[440.377904] [125/131] (583s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[440.493780] Starting subtest: cursorB-vs-flipB-atomic-transitions
[440.499250] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[440.638397] [126/131] (582s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[440.752705] Starting subtest: cursor-vs-flip-toggle
[471.637481] Subtest cursor-vs-flip-toggle: SUCCESS (30.859s)
[472.501663] [127/131] (551s left) kms_psr (psr2-suspend)
[472.584357] Starting subtest: psr2-suspend
[472.586688] Starting dynamic subtest: eDP-1
[490.130927] Dynamic subtest eDP-1: SUCCESS (2.888s)
[490.133240] Subtest psr2-suspend: SUCCESS (2.889s)
[490.989510] [128/131] (532s left) syncobj_timeline (reset-multiple-signaled)
[491.059022] Starting subtest: reset-multiple-signaled
[491.061352] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[491.160678] [129/131] (532s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[491.250815] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[492.031709] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[492.200137] [130/131] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[492.297442] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[499.649906] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.345s)
[499.763253] [131/131] (523s left) gem_softpin (noreloc)
[499.834488] Starting subtest: noreloc
[505.288180] Subtest noreloc: SUCCESS (5.396s)
[505.354525] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: gem_sync
results: parsing output: 10/ for test: gem_ctx_persistence
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_chamelium_audio
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gen7_exec_parse
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: gem_gtt_cpu_tlb
results: parsing output: 20/ for test: gem_pread
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gem_linear_blits
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_tiled_blits
results: parsing output: 31/ for test: gem_flink_basic
results: parsing output: 32/ for test: i915_suspend
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_engines
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_pipe_crc_basic
results: parsing output: 45/ for test: gem_softpin
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gem_madvise
results: parsing output: 50/ for test: gem_exec_create
results: parsing output: 51/ for test: kms_plane
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_render_copy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: sriov_basic
results: parsing output: 61/ for test: kms_pm_backlight
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: kms_joiner
results: parsing output: 77/ for test: gem_pxp
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane_lowres
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: perf
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: gem_busy
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: dmabuf_sync_file
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_async
results: parsing output: 106/ for test: kms_vrr
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_dsc
results: parsing output: 110/ for test: kms_chamelium_edid
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: gem_gpgpu_fill
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_busy
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_softpin
Done.