[62.276998] Initializing watchdogs
[62.277146]   /dev/watchdog0
[62.293352] [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]
[62.297960] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.300236] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.303524] [001/133] (960s left) kms_async_flips (test-cursor)
[62.431204] Starting subtest: test-cursor
[62.813555] Starting dynamic subtest: pipe-A-eDP-1
[63.600123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[63.985419] Starting dynamic subtest: pipe-B-eDP-1
[64.732372] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[65.118403] Starting dynamic subtest: pipe-C-eDP-1
[65.866804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s)
[66.229434] Starting dynamic subtest: pipe-D-eDP-1
[66.994404] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[66.996715] Subtest test-cursor: SUCCESS (4.566s)
[68.162055] [002/133] (954s left) gem_exec_schedule (timeslicing)
[68.248130] Starting subtest: timeslicing
[68.250138] Starting dynamic subtest: rcs0
[68.268077] Dynamic subtest rcs0: SUCCESS (0.021s)
[68.278109] Starting dynamic subtest: bcs0
[68.289115] Dynamic subtest bcs0: SUCCESS (0.021s)
[68.297935] Starting dynamic subtest: vcs0
[68.309343] Dynamic subtest vcs0: SUCCESS (0.020s)
[68.316684] Starting dynamic subtest: vcs1
[68.331080] Dynamic subtest vcs1: SUCCESS (0.021s)
[68.338304] Starting dynamic subtest: vecs0
[68.353400] Dynamic subtest vecs0: SUCCESS (0.022s)
[68.360632] Starting dynamic subtest: ccs0
[68.374066] Dynamic subtest ccs0: SUCCESS (0.020s)
[68.376440] Subtest timeslicing: SUCCESS (0.128s)
[70.344241] [003/133] (952s left) kms_flip (flip-vs-expired-vblank-interruptible)
[70.443334] Starting subtest: flip-vs-expired-vblank-interruptible
[70.445661] Starting dynamic subtest: A-eDP1
[79.182522] Dynamic subtest A-eDP1: SUCCESS (8.738s)
[79.193306] Starting dynamic subtest: B-eDP1
[87.800809] Dynamic subtest B-eDP1: SUCCESS (8.617s)
[87.808609] Starting dynamic subtest: C-eDP1
[93.827532] Dynamic subtest C-eDP1: FAIL (5.556s)
[93.837052] Starting dynamic subtest: D-eDP1
[102.054095] Dynamic subtest D-eDP1: SUCCESS (8.692s)
[102.056504] Subtest flip-vs-expired-vblank-interruptible: FAIL (31.613s)
[103.221334] [004/133] (919s left) kms_plane_lowres (tiling-y)
[103.327954] Starting subtest: tiling-y
[103.332182] Subtest tiling-y: SKIP (0.000s)
[103.397843] [005/133] (919s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[103.495886] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[103.498182] Starting dynamic subtest: pipe-A-eDP-1
[120.685433] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[120.695588] Starting dynamic subtest: pipe-B-eDP-1
[138.614575] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[138.622800] Starting dynamic subtest: pipe-C-eDP-1
[156.632222] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[156.641969] Starting dynamic subtest: pipe-D-eDP-1
[174.625137] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s)
[174.627490] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.264s)
[179.860991] [006/133] (847s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[179.971489] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[179.975571] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[180.070439] [007/133] (846s left) kms_async_flips (async-flip-dpms)
[180.168893] Starting subtest: async-flip-dpms
[180.553606] Starting dynamic subtest: pipe-A-eDP-1
[184.376848] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.818s)
[184.746070] Starting dynamic subtest: pipe-B-eDP-1
[187.545471] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.804s)
[187.934701] Starting dynamic subtest: pipe-C-eDP-1
[190.708308] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[191.083416] Starting dynamic subtest: pipe-D-eDP-1
[193.875666] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[193.877911] Subtest async-flip-dpms: SUCCESS (13.700s)
[195.065374] [008/133] (832s left) kms_chamelium_frames (dp-crc-fast)
[195.457636] Subtest dp-crc-fast: SKIP (0.000s)
[196.280172] [009/133] (830s left) syncobj_wait (single-wait-all-for-submit-submitted)
[196.339785] Starting subtest: single-wait-all-for-submit-submitted
[196.445618] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[196.519943] [010/133] (830s left) perf (gen12-mi-rpc)
[196.653347] Starting subtest: gen12-mi-rpc
[196.655461] Starting dynamic subtest: rcs0
[196.670354] Dynamic subtest rcs0: SUCCESS (0.017s)
[196.672204] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[196.717286] [011/133] (830s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[196.847618] Starting subtest: plane-ctm3x4-lut1d
[196.982797] Starting dynamic subtest: pipe-A-plane-0
[197.160476] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[197.170504] Starting dynamic subtest: pipe-A-plane-1
[197.316000] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[197.325498] Starting dynamic subtest: pipe-A-plane-2
[197.460180] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[198.624680] Starting dynamic subtest: pipe-B-plane-0
[198.817142] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[198.827092] Starting dynamic subtest: pipe-B-plane-1
[198.984106] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[198.993235] Starting dynamic subtest: pipe-B-plane-2
[199.140125] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[200.339083] Starting dynamic subtest: pipe-C-plane-0
[200.476443] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[200.486278] Starting dynamic subtest: pipe-C-plane-1
[200.631989] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[200.644024] Starting dynamic subtest: pipe-C-plane-2
[200.776536] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[201.995164] Starting dynamic subtest: pipe-D-plane-0
[202.166002] Dynamic subtest pipe-D-plane-0: SUCCESS (0.178s)
[202.175570] Starting dynamic subtest: pipe-D-plane-1
[202.333520] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[202.350600] Starting dynamic subtest: pipe-D-plane-2
[202.488505] Dynamic subtest pipe-D-plane-2: SUCCESS (0.153s)
[202.773673] Subtest plane-ctm3x4-lut1d: SUCCESS (5.924s)
[203.657460] [012/133] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[203.753831] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[211.109783] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.361s)
[211.257134] [013/133] (816s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[211.344874] Starting subtest: fbc-psr-sprite-mmap-gtt
[211.347016] Starting dynamic subtest: eDP-1
[211.350803] Dynamic subtest eDP-1: SKIP (0.000s)
[211.354652] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[211.412628] [014/133] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[211.506358] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[219.030799] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.531s)
[219.147996] [015/133] (808s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[219.242705] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[219.245041] Starting dynamic subtest: pipe-A-default-mode
[221.953041] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[221.955570] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.713s)
[222.789368] [016/133] (804s left) gem_exec_fence (submit)
[222.970332] Starting subtest: submit
[222.975030] Subtest submit: SKIP (0.000s)
[225.251513] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[225.254942] [017/133] (802s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[225.374600] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[225.422533] [018/133] (802s left) gem_bad_reloc (negative-reloc-lut)
[225.483021] Subtest negative-reloc-lut: SKIP (0.000s)
[225.559411] [019/133] (801s left) gem_softpin (evict-prime)
[225.614370] Starting subtest: evict-prime
[225.616534] Starting dynamic subtest: rcs0
[226.755121] Dynamic subtest rcs0: SUCCESS (1.141s)
[226.764463] Starting dynamic subtest: bcs0
[227.882663] Dynamic subtest bcs0: SUCCESS (1.126s)
[227.894574] Starting dynamic subtest: vcs0
[229.154203] Dynamic subtest vcs0: SUCCESS (1.268s)
[229.166085] Starting dynamic subtest: vcs1
[231.170651] Dynamic subtest vcs1: SUCCESS (1.996s)
[231.180828] Starting dynamic subtest: vecs0
[233.125944] Dynamic subtest vecs0: SUCCESS (1.972s)
[233.138939] Starting dynamic subtest: ccs0
[234.255550] Dynamic subtest ccs0: SUCCESS (1.129s)
[234.268110] Starting dynamic subtest: all
[236.190741] Dynamic subtest all: SUCCESS (1.932s)
[236.193097] Subtest evict-prime: SUCCESS (10.578s)
[236.279432] [020/133] (791s left) dumb_buffer (create-valid-dumb)
[236.347652] Starting subtest: create-valid-dumb
[236.349916] Subtest create-valid-dumb: SUCCESS (0.000s)
[236.457228] [021/133] (791s left) syncobj_timeline (wait-any-snapshot)
[236.511502] Starting subtest: wait-any-snapshot
[236.591626] Subtest wait-any-snapshot: SUCCESS (0.082s)
[236.670149] [022/133] (790s left) kms_psr (psr-primary-page-flip)
[236.772508] Starting subtest: psr-primary-page-flip
[236.774755] Starting dynamic subtest: eDP-1
[238.499638] Dynamic subtest eDP-1: SUCCESS (1.728s)
[238.502195] Subtest psr-primary-page-flip: SUCCESS (1.729s)
[239.363111] [023/133] (788s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[239.504397] Starting subtest: multiplane-atomic-fence-wait
[239.824872] Subtest multiplane-atomic-fence-wait: SUCCESS (0.319s)
[241.009160] [024/133] (786s left) gen7_exec_parse (load-register-reg)
[241.070454] Subtest load-register-reg: SKIP (0.000s)
[241.135613] [025/133] (786s left) kms_invalid_mode (bad-vsync-end)
[241.234140] Starting subtest: bad-vsync-end
[241.236507] Starting dynamic subtest: pipe-A-eDP-1
[241.514833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[241.524796] Starting dynamic subtest: pipe-B-eDP-1
[241.527010] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[241.535413] Starting dynamic subtest: pipe-C-eDP-1
[241.537616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[241.546279] Starting dynamic subtest: pipe-D-eDP-1
[241.548625] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[241.550932] Subtest bad-vsync-end: SUCCESS (0.291s)
[242.329485] [026/133] (785s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[242.426825] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[242.429079] Starting dynamic subtest: pipe-A-default-mode
[243.598864] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[243.603391] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.172s)
[243.733873] [027/133] (784s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[243.835054] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[243.837388] Starting dynamic subtest: pipe-A-eDP-1
[243.895112] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[243.903665] Starting dynamic subtest: pipe-B-eDP-1
[243.961400] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[243.971942] Starting dynamic subtest: pipe-C-eDP-1
[244.029458] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[244.039399] Starting dynamic subtest: pipe-D-eDP-1
[244.097608] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[244.101933] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[246.144874] [028/133] (781s left) api_intel_allocator (gem-pool)
[246.199568] Starting subtest: gem-pool
[246.205317] Subtest gem-pool: SUCCESS (0.008s)
[246.334130] [029/133] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[246.430437] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[246.434553] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[246.537466] [030/133] (781s left) syncobj_timeline (signal-point-0)
[246.593887] Starting subtest: signal-point-0
[246.596190] Subtest signal-point-0: SUCCESS (0.000s)
[246.694408] [031/133] (781s left) kms_lease (possible-crtcs-filtering)
[246.801952] Starting subtest: possible-crtcs-filtering
[246.806490] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[246.920964] [032/133] (781s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[247.019481] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[251.738465] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.724s)
[252.934327] [033/133] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[253.031329] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[253.035681] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[253.135342] [034/133] (775s left) gem_set_tiling_vs_pwrite
[253.245967] [035/133] (774s left) gem_partial_pwrite_pread (reads-snoop)
[253.306205] Subtest reads-snoop: SKIP (0.000s)
[253.367791] [036/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[253.472239] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[253.476314] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[253.579325] [037/133] (774s left) kms_hdr (invalid-metadata-sizes)
[253.677778] Starting subtest: invalid-metadata-sizes
[253.684315] Subtest invalid-metadata-sizes: SKIP (0.000s)
[253.753080] [038/133] (774s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[253.845992] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[253.850110] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[253.938823] [039/133] (774s left) kms_pm_rpm (pm-tiling)
[255.455332] Starting subtest: pm-tiling
[255.460609] Subtest pm-tiling: SKIP (0.000s)
[256.178995] [040/133] (772s left) sw_sync (alloc_fence_invalid_timeline)
[256.220988] Starting subtest: alloc_fence_invalid_timeline
[256.223130] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[256.277427] [041/133] (772s left) gem_exec_reloc (basic-softpin)
[256.349519] Subtest basic-softpin: SKIP (0.000s)
[256.432198] [042/133] (772s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[256.526977] Starting subtest: yf-tiled-32bpp-rotate-270
[256.531014] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[256.622452] [043/133] (771s left) gem_exec_store (dword)
[256.686624] Starting subtest: dword
[256.689034] Starting dynamic subtest: rcs0
[256.732715] Dynamic subtest rcs0: SUCCESS (0.048s)
[256.743434] Starting dynamic subtest: bcs0
[256.775373] Dynamic subtest bcs0: SUCCESS (0.041s)
[256.789003] Starting dynamic subtest: vcs0
[256.817986] Dynamic subtest vcs0: SUCCESS (0.041s)
[256.828687] Starting dynamic subtest: vcs1
[256.859816] Dynamic subtest vcs1: SUCCESS (0.040s)
[256.869881] Starting dynamic subtest: vecs0
[256.901038] Dynamic subtest vecs0: SUCCESS (0.039s)
[256.911515] Starting dynamic subtest: ccs0
[256.944055] Dynamic subtest ccs0: SUCCESS (0.041s)
[256.946401] Subtest dword: SUCCESS (0.261s)
[257.143529] [044/133] (771s left) gem_exec_reloc (basic-wc-read-noreloc)
[257.204320] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[257.276762] [045/133] (771s left) i915_pm_rc6_residency (media-rc6-accuracy)
[257.337148] Starting subtest: media-rc6-accuracy
[257.341477] Subtest media-rc6-accuracy: SKIP (0.000s)
[257.439929] [046/133] (771s left) gem_exec_balancer (indices)
[257.503882] Starting subtest: indices
[260.159356] Subtest indices: SUCCESS (2.653s)
[260.464537] [047/133] (768s left) prime_self_import (basic-with_one_bo_two_files)
[260.507061] Starting subtest: basic-with_one_bo_two_files
[260.538027] Subtest basic-with_one_bo_two_files: SUCCESS (0.029s)
[260.657362] [048/133] (768s left) syncobj_timeline (invalid-signal-zero-handles)
[260.703396] Starting subtest: invalid-signal-zero-handles
[260.705649] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[260.796369] [049/133] (767s left) gem_ctx_isolation (nonpriv-switch)
[260.861610] Starting subtest: nonpriv-switch
[260.863713] Starting dynamic subtest: rcs0
[261.228973] Dynamic subtest rcs0: SUCCESS (0.369s)
[261.239228] Starting dynamic subtest: bcs0
[261.579559] Dynamic subtest bcs0: SUCCESS (0.350s)
[261.591278] Starting dynamic subtest: vcs0
[261.906994] Dynamic subtest vcs0: SUCCESS (0.326s)
[261.917067] Starting dynamic subtest: vcs1
[263.501677] Dynamic subtest vcs1: SUCCESS (1.593s)
[263.513830] Starting dynamic subtest: vecs0
[265.486559] Dynamic subtest vecs0: SUCCESS (1.983s)
[265.497858] Starting dynamic subtest: ccs0
[267.492277] Dynamic subtest ccs0: SUCCESS (2.005s)
[267.494663] Subtest nonpriv-switch: SUCCESS (6.634s)
[267.722163] [050/133] (761s left) kms_psr (pr-sprite-blt)
[267.819599] Starting subtest: pr-sprite-blt
[267.823894] Subtest pr-sprite-blt: SKIP (0.000s)
[267.892874] [051/133] (760s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[267.986651] Starting subtest: x-tiled-8bpp-rotate-180
[269.167068] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.180s)
[269.316986] [052/133] (759s left) perf_pmu (busy-idle-check-all)
[269.366697] Starting subtest: busy-idle-check-all
[269.368358] Starting dynamic subtest: rcs0
[270.017107] Dynamic subtest rcs0: SUCCESS (0.652s)
[270.028823] Starting dynamic subtest: bcs0
[270.669356] Dynamic subtest bcs0: SUCCESS (0.650s)
[270.681176] Starting dynamic subtest: vcs0
[272.225067] Dynamic subtest vcs0: SUCCESS (1.552s)
[272.236881] Starting dynamic subtest: vcs1
[274.209519] Dynamic subtest vcs1: SUCCESS (1.982s)
[274.222022] Starting dynamic subtest: vecs0
[276.201412] Dynamic subtest vecs0: SUCCESS (1.980s)
[276.212515] Starting dynamic subtest: ccs0
[276.848458] Dynamic subtest ccs0: SUCCESS (0.655s)
[276.851302] Subtest busy-idle-check-all: SUCCESS (7.484s)
[276.946407] [053/133] (752s left) kms_flip (2x-flip-vs-panning-vs-hang)
[277.037994] Starting subtest: 2x-flip-vs-panning-vs-hang
[277.042338] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[277.145387] [054/133] (751s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[277.248324] Starting subtest: psr2-overlay-plane-update-continuous-sf
[277.250822] Starting dynamic subtest: pipe-A-eDP-1
[278.377118] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.133s)
[278.387472] Starting dynamic subtest: pipe-B-eDP-1
[280.099453] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.722s)
[280.101812] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.858s)
[280.911147] [055/133] (748s left) kms_getfb (getfb-handle-valid)
[281.000819] Starting subtest: getfb-handle-valid
[281.002959] Subtest getfb-handle-valid: SUCCESS (0.000s)
[281.100823] [056/133] (748s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[281.187242] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[281.191290] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[281.305194] [057/133] (747s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[281.537646] Starting subtest: cursor-rapid-movement-256x256
[281.540692] Starting dynamic subtest: pipe-A-eDP-1
[282.072907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[282.105878] Starting dynamic subtest: pipe-D-eDP-1
[283.309724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[283.312063] Subtest cursor-rapid-movement-256x256: SUCCESS (1.775s)
[284.184073] [058/133] (745s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[284.280784] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[284.282996] Starting dynamic subtest: pipe-A-eDP-1
[284.307089] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.317922] Starting dynamic subtest: pipe-B-eDP-1
[284.340922] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.350343] Starting dynamic subtest: pipe-C-eDP-1
[284.373994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.382977] Starting dynamic subtest: pipe-D-eDP-1
[284.406964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.410934] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[286.545180] [059/133] (742s left) gem_render_copy (linear-to-vebox-yf-tiled)
[286.614783] Starting subtest: linear-to-vebox-yf-tiled
[286.619338] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[286.815133] [060/133] (742s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[286.909803] Starting subtest: fbc-psr2-primary-mmap-cpu
[286.912042] Starting dynamic subtest: eDP-1
[286.916135] Dynamic subtest eDP-1: SKIP (0.000s)
[286.920260] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[287.001323] [061/133] (742s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[287.104370] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[287.108742] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[287.212302] [062/133] (742s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[287.310791] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[287.313067] Starting dynamic subtest: pipe-A
[288.520582] Dynamic subtest pipe-A: SUCCESS (1.211s)
[288.535591] Starting dynamic subtest: pipe-B
[290.787849] Dynamic subtest pipe-B: SUCCESS (2.265s)
[290.797751] Starting dynamic subtest: pipe-C
[291.937233] Dynamic subtest pipe-C: SUCCESS (1.147s)
[291.947379] Starting dynamic subtest: pipe-D
[293.174104] Dynamic subtest pipe-D: SUCCESS (1.235s)
[293.176390] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.866s)
[294.372258] [063/133] (735s left) kms_concurrent (multi-plane-atomic-lowres)
[294.461816] Starting subtest: multi-plane-atomic-lowres
[294.463689] Starting dynamic subtest: pipe-A-eDP-1
[294.952439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.490s)
[294.962883] Starting dynamic subtest: pipe-B-eDP-1
[296.225141] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.272s)
[296.235244] Starting dynamic subtest: pipe-C-eDP-1
[297.460625] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[297.470243] Starting dynamic subtest: pipe-D-eDP-1
[298.670878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[298.673209] Subtest multi-plane-atomic-lowres: SUCCESS (4.210s)
[299.510945] [064/133] (729s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[299.571351] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[299.651837] [065/133] (729s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[299.744820] Starting subtest: disable-crc-after-crtc
[299.747005] Starting dynamic subtest: pipe-A-eDP-1
[301.473961] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.729s)
[301.483960] Starting dynamic subtest: pipe-B-eDP-1
[303.752460] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.277s)
[303.762863] Starting dynamic subtest: pipe-C-eDP-1
[305.996057] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.240s)
[306.005680] Starting dynamic subtest: pipe-D-eDP-1
[308.265645] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.270s)
[308.268315] Subtest disable-crc-after-crtc: SUCCESS (8.522s)
[309.083811] [066/133] (720s left) kms_atomic_interruptible (legacy-setmode)
[309.178487] Starting subtest: legacy-setmode
[309.180847] Starting dynamic subtest: pipe-A-eDP-1
[316.064322] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.887s)
[316.066549] Subtest legacy-setmode: SUCCESS (6.888s)
[316.948528] [067/133] (712s left) kms_rmfb (close-fd)
[317.047690] Starting subtest: close-fd
[317.049626] Starting dynamic subtest: pipe-A-eDP-1
[317.155195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[317.166477] Starting dynamic subtest: pipe-B-eDP-1
[318.305294] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[318.316418] Starting dynamic subtest: pipe-C-eDP-1
[319.526847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[319.537611] Starting dynamic subtest: pipe-D-eDP-1
[320.671449] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[320.673745] Subtest close-fd: SUCCESS (3.626s)
[321.893287] [068/133] (707s left) gem_flink_basic (double-flink)
[321.951048] Starting subtest: double-flink
[321.952942] Subtest double-flink: SUCCESS (0.000s)
[322.055735] [069/133] (707s left) gem_exec_reloc (basic-gtt-wc-active)
[322.106098] Subtest basic-gtt-wc-active: SKIP (0.000s)
[322.178483] [070/133] (707s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[322.293994] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[322.298509] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[322.374156] [071/133] (707s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[322.437222] Starting subtest: etime-multi-wait-all-submitted-signaled
[322.542021] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[322.620911] [072/133] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[322.730004] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[322.733942] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[322.825527] [073/133] (707s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[322.920054] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[323.956541] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.036s)
[324.082485] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[324.189012] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[324.192510] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[324.282892] [075/133] (705s left) kms_pm_rpm (fences)
[326.315506] Starting subtest: fences
[326.320206] Subtest fences: SKIP (0.000s)
[326.685742] [076/133] (703s left) gem_ctx_persistence (file)
[326.737470] Starting subtest: file
[326.855690] Subtest file: SUCCESS (0.119s)
[326.973489] [077/133] (703s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[327.085322] Starting subtest: flip-vs-cursor-busy-crc-legacy
[327.890517] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.802s)
[328.708194] [078/133] (701s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[329.098933] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[329.917019] [079/133] (700s left) gem_vm_create (create-ext)
[329.992571] Starting subtest: create-ext
[329.998862] Subtest create-ext: SUCCESS (0.006s)
[330.130158] [080/133] (700s left) gem_exec_alignment (pi-isolated)
[330.193346] Starting subtest: pi-isolated
[381.504592] Subtest pi-isolated: SUCCESS (51.305s)
[382.478466] [081/133] (647s left) gem_mmap_offset (pf-nonblock)
[382.586859] Starting subtest: pf-nonblock
[382.594908] Subtest pf-nonblock: SUCCESS (0.010s)
[382.731777] [082/133] (647s left) gem_exec_params (rel-constants-invalid-ring)
[382.787606] Starting subtest: rel-constants-invalid-ring
[382.789863] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[382.894108] [083/133] (647s left) gem_wait (invalid-buf)
[382.949254] Starting subtest: invalid-buf
[382.951636] Subtest invalid-buf: SUCCESS (0.000s)
[383.167960] [084/133] (647s left) gem_create (create-ext-cpu-access-sanity-check)
[383.324601] Starting subtest: create-ext-cpu-access-sanity-check
[383.329377] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[383.402998] [085/133] (646s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[383.515677] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[383.520170] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[383.624389] [086/133] (646s left) kms_cursor_crc (cursor-offscreen-512x170)
[383.911452] Starting subtest: cursor-offscreen-512x170
[383.915609] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[384.059529] [087/133] (646s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[384.143905] Starting subtest: primary-x-tiled-reflect-x-0
[391.373799] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.232s)
[392.595621] [088/133] (637s left) kms_vblank (wait-busy-hang)
[392.704989] Starting subtest: wait-busy-hang
[392.707160] Starting dynamic subtest: pipe-A-eDP-1
[419.051573] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.344s)
[419.066914] Starting dynamic subtest: pipe-D-eDP-1
[433.963503] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.910s)
[433.965835] Subtest wait-busy-hang: SUCCESS (41.258s)
[434.811865] [089/133] (595s left) gem_flink_basic (flink-lifetime)
[434.880034] Starting subtest: flink-lifetime
[434.882231] Subtest flink-lifetime: SUCCESS (0.002s)
[434.980984] [090/133] (595s left) kms_psr (psr-cursor-mmap-gtt)
[435.085912] Starting subtest: psr-cursor-mmap-gtt
[435.088131] Starting dynamic subtest: eDP-1
[436.772862] Dynamic subtest eDP-1: SUCCESS (1.686s)
[436.775142] Subtest psr-cursor-mmap-gtt: SUCCESS (1.688s)
[437.642040] [091/133] (593s left) core_debugfs (read-all-entries)
[437.696094] Starting subtest: read-all-entries
[437.794715] Subtest read-all-entries: SUCCESS (0.099s)
[437.893049] [092/133] (592s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[437.995142] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[437.999198] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[438.097679] [093/133] (592s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[438.197942] Starting subtest: pr-cursor-plane-move-continuous-sf
[438.201879] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[438.276765] [094/133] (592s left) kms_frontbuffer_tracking (psr-2p-rte)
[438.377792] Starting subtest: psr-2p-rte
[438.382214] Subtest psr-2p-rte: SKIP (0.000s)
[438.489507] [095/133] (592s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[438.587949] Starting subtest: fbc-rgb101010-draw-pwrite
[443.955759] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.369s)
[445.158997] [096/133] (585s left) gem_exec_schedule (fairslice)
[445.257675] Starting subtest: fairslice
[445.259715] Starting dynamic subtest: rcs0
[447.268168] Dynamic subtest rcs0: SUCCESS (2.016s)
[447.279460] Starting dynamic subtest: bcs0
[449.286427] Dynamic subtest bcs0: SUCCESS (2.018s)
[449.297216] Starting dynamic subtest: vcs0
[451.306754] Dynamic subtest vcs0: SUCCESS (2.017s)
[451.318116] Starting dynamic subtest: vcs1
[453.323450] Dynamic subtest vcs1: SUCCESS (2.016s)
[453.334461] Starting dynamic subtest: vecs0
[455.342015] Dynamic subtest vecs0: SUCCESS (2.017s)
[455.352127] Starting dynamic subtest: ccs0
[457.360168] Dynamic subtest ccs0: SUCCESS (2.018s)
[457.362108] Subtest fairslice: SUCCESS (12.108s)
[457.660223] [097/133] (573s left) gem_exec_create (basic)
[457.717826] Starting subtest: basic
[457.720023] Starting dynamic subtest: smem
[461.153780] Dynamic subtest smem: SUCCESS (3.433s)
[461.156375] Subtest basic: SUCCESS (3.435s)
[461.341405] [098/133] (569s left) prime_busy (hang)
[461.393981] Starting subtest: hang
[461.396343] Starting dynamic subtest: rcs0
[488.701525] Dynamic subtest rcs0: SUCCESS (27.302s)
[488.711055] Starting dynamic subtest: bcs0
[495.854625] Dynamic subtest bcs0: SUCCESS (7.150s)
[495.865310] Starting dynamic subtest: vcs0
[502.831956] Dynamic subtest vcs0: SUCCESS (6.973s)
[502.841505] Starting dynamic subtest: vcs1
[509.866057] Dynamic subtest vcs1: SUCCESS (7.036s)
[509.876330] Starting dynamic subtest: vecs0
[516.844770] Dynamic subtest vecs0: SUCCESS (6.973s)
[516.856722] Starting dynamic subtest: ccs0
[530.676171] Dynamic subtest ccs0: SUCCESS (13.834s)
[530.679046] Subtest hang: SUCCESS (69.280s)
[530.805783] [099/133] (500s left) perf (disabled-read-error)
[530.909903] Starting subtest: disabled-read-error
[530.921765] Subtest disabled-read-error: SUCCESS (0.014s)
[530.971280] [100/133] (500s left) i915_drm_fdinfo (isolation)
[531.012847] Starting subtest: isolation
[531.015042] Starting dynamic subtest: rcs0
[531.043550] Dynamic subtest rcs0: SKIP (0.029s)
[531.054873] Starting dynamic subtest: bcs0
[531.058813] Dynamic subtest bcs0: SKIP (0.000s)
[531.068391] Starting dynamic subtest: vcs0
[531.072438] Dynamic subtest vcs0: SKIP (0.000s)
[531.081785] Starting dynamic subtest: vcs1
[531.085773] Dynamic subtest vcs1: SKIP (0.000s)
[531.095364] Starting dynamic subtest: vecs0
[531.099691] Dynamic subtest vecs0: SKIP (0.000s)
[531.110857] Starting dynamic subtest: ccs0
[531.114818] Dynamic subtest ccs0: SKIP (0.000s)
[531.123089] Subtest isolation: SKIP (0.034s)
[531.169624] [101/133] (499s left) i915_query (engine-info)
[531.245993] Starting subtest: engine-info
[531.248705] Subtest engine-info: SUCCESS (0.005s)
[531.360328] [102/133] (499s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[531.455685] Starting subtest: fbcpsr-rgb565-draw-blt
[538.502063] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.048s)
[538.627845] [103/133] (492s left) gem_exec_create (legacy)
[538.688069] Starting subtest: legacy
[538.690424] Starting dynamic subtest: smem
[540.770691] Dynamic subtest smem: SUCCESS (2.085s)
[540.773669] Subtest legacy: SUCCESS (2.086s)
[540.971308] [104/133] (490s left) gem_exec_schedule (preemptive-hang)
[541.142035] Starting subtest: preemptive-hang
[541.144457] Starting dynamic subtest: rcs0
[550.352106] Dynamic subtest rcs0: SUCCESS (9.207s)
[550.363972] Starting dynamic subtest: bcs0
[559.304755] Dynamic subtest bcs0: SUCCESS (8.949s)
[559.317612] Starting dynamic subtest: vcs0
[568.327825] Dynamic subtest vcs0: SUCCESS (9.023s)
[568.337984] Starting dynamic subtest: vcs1
[577.292153] Dynamic subtest vcs1: SUCCESS (8.958s)
[577.304994] Starting dynamic subtest: vecs0
[586.312102] Dynamic subtest vecs0: SUCCESS (9.023s)
[586.325446] Starting dynamic subtest: ccs0
[595.343434] Dynamic subtest ccs0: SUCCESS (9.030s)
[595.345946] Subtest preemptive-hang: SUCCESS (54.198s)
[595.576972] [105/133] (435s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[595.699110] Starting subtest: cursor-vs-flip-atomic
[625.472898] Subtest cursor-vs-flip-atomic: SUCCESS (29.772s)
[626.315840] [106/133] (405s left) kms_plane (pixel-format-x-tiled-modifier)
[626.408080] Starting subtest: pixel-format-x-tiled-modifier
[626.433757] Starting dynamic subtest: pipe-A-plane-0
[627.044295] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[627.055342] Starting dynamic subtest: pipe-A-plane-3
[627.433096] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[627.443201] Starting dynamic subtest: pipe-A-plane-5
[627.447076] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[628.497964] Starting dynamic subtest: pipe-B-plane-0
[629.122634] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[629.133455] Starting dynamic subtest: pipe-B-plane-3
[629.544585] Dynamic subtest pipe-B-plane-3: SUCCESS (0.420s)
[629.554983] Starting dynamic subtest: pipe-B-plane-5
[629.558709] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[629.872775] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.466s)
[630.699973] [107/133] (400s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[630.792954] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[630.795174] Starting dynamic subtest: pipe-A-eDP-1
[630.815347] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[630.826803] Starting dynamic subtest: pipe-B-eDP-1
[630.846287] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[630.856073] Starting dynamic subtest: pipe-C-eDP-1
[630.875366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[630.885678] Starting dynamic subtest: pipe-D-eDP-1
[630.905287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[630.907750] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[633.052919] [108/133] (398s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[633.148166] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[639.879846] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.735s)
[639.995197] [109/133] (391s left) i915_pm_freq_api (freq-reset)
[640.053512] Starting subtest: freq-reset
[640.055801] Starting dynamic subtest: gt0
[640.253052] Dynamic subtest gt0: SUCCESS (0.197s)
[640.264060] Starting dynamic subtest: gt1
[640.415467] Dynamic subtest gt1: SUCCESS (0.159s)
[640.418015] Subtest freq-reset: SUCCESS (0.358s)
[640.488149] [110/133] (391s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[640.596986] Starting subtest: pipe-fbc-rte
[640.603405] Starting dynamic subtest: pipe-B-eDP-1
[646.043190] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.449s)
[646.050771] Subtest pipe-fbc-rte: SUCCESS (5.452s)
[648.325914] [111/133] (383s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[648.373778] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[648.477353] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[648.556689] [112/133] (383s left) kms_flip (plain-flip-interruptible)
[648.666060] Starting subtest: plain-flip-interruptible
[648.668331] Starting dynamic subtest: A-eDP1
[650.333566] Dynamic subtest A-eDP1: SUCCESS (1.666s)
[650.354155] Starting dynamic subtest: B-eDP1
[651.976145] Dynamic subtest B-eDP1: SUCCESS (1.639s)
[651.989955] Starting dynamic subtest: C-eDP1
[653.593867] Dynamic subtest C-eDP1: SUCCESS (1.616s)
[653.607108] Starting dynamic subtest: D-eDP1
[655.239595] Dynamic subtest D-eDP1: SUCCESS (1.644s)
[655.245267] Subtest plain-flip-interruptible: SUCCESS (6.580s)
[656.400868] [113/133] (375s left) gem_exec_reloc (basic-gtt-active)
[656.459942] Subtest basic-gtt-active: SKIP (0.000s)
[656.537149] [114/133] (375s left) perf_pmu (frequency)
[656.579903] Starting subtest: frequency
[656.582199] Starting dynamic subtest: gt0
[658.719096] Dynamic subtest gt0: SUCCESS (2.131s)
[658.732927] Starting dynamic subtest: idle-gt0
[659.224212] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[659.235078] Starting dynamic subtest: gt1
[664.139197] Dynamic subtest gt1: SUCCESS (4.909s)
[664.152108] Starting dynamic subtest: idle-gt1
[664.669400] Dynamic subtest idle-gt1: SUCCESS (0.529s)
[664.671459] Subtest frequency: SUCCESS (8.092s)
[664.767899] [115/133] (366s left) kms_cursor_legacy (torture-move)
[664.894328] Starting subtest: torture-move
[664.896591] Starting dynamic subtest: pipe-A
[670.654085] Dynamic subtest pipe-A: SUCCESS (5.755s)
[670.667242] Starting dynamic subtest: pipe-B
[676.653528] Dynamic subtest pipe-B: SUCCESS (5.996s)
[676.670408] Starting dynamic subtest: pipe-C
[684.156763] Dynamic subtest pipe-C: SUCCESS (7.500s)
[684.169413] Starting dynamic subtest: pipe-D
[691.104564] Dynamic subtest pipe-D: SUCCESS (6.945s)
[691.118276] Starting dynamic subtest: all-pipes
[697.991461] Dynamic subtest all-pipes: SUCCESS (6.886s)
[697.993828] Subtest torture-move: SUCCESS (33.092s)
[698.156742] [116/133] (333s left) kms_cursor_edge_walk (256x256-right-edge)
[698.257163] Starting subtest: 256x256-right-edge
[698.259511] Starting dynamic subtest: pipe-A-eDP-1
[701.756718] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[701.767700] Starting dynamic subtest: pipe-D-eDP-1
[704.872128] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[704.874285] Subtest 256x256-right-edge: SUCCESS (6.615s)
[705.679394] [117/133] (326s left) syncobj_wait (invalid-reset-illegal-handle)
[705.741057] Starting subtest: invalid-reset-illegal-handle
[705.743014] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[705.848259] [118/133] (325s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[705.965202] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[717.145133] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.179s)
[718.022146] [119/133] (313s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[718.079756] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[718.082004] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[718.171563] [120/133] (313s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[718.235771] Starting subtest: yf-tiled-to-vebox-x-tiled
[718.240623] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[718.421141] [121/133] (313s left) drm_read (fault-buffer)
[718.563472] Starting subtest: fault-buffer
[718.565802] Subtest fault-buffer: SUCCESS (0.001s)
[718.678619] [122/133] (313s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[718.765869] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[718.768205] Starting dynamic subtest: A-eDP1
[727.673354] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[727.685988] Starting dynamic subtest: B-eDP1
[736.602329] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[736.615014] Starting dynamic subtest: C-eDP1
[745.525148] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[745.536750] Starting dynamic subtest: D-eDP1
[754.460778] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[754.466121] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.696s)
[755.693994] [123/133] (276s left) gem_lmem_swapping (random)
[755.743821] Subtest random: SKIP (0.000s)
[755.795070] [124/133] (276s left) gem_lmem_evict (dontneed-evict-race)
[755.838011] Subtest dontneed-evict-race: SKIP (0.000s)
[755.898670] [125/133] (276s left) gem_readwrite (read-write)
[756.023299] Subtest read-write: SKIP (0.000s)
[756.163856] [126/133] (276s left) gem_partial_pwrite_pread (writes-after-reads-display)
[756.298060] Subtest writes-after-reads-display: SKIP (0.000s)
[756.506146] [127/133] (275s left) gem_mmap_offset (open-flood)
[756.584823] Starting subtest: open-flood
[778.076392] Subtest open-flood: SUCCESS (21.491s)
[778.178412] [128/133] (254s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[778.273815] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[778.275702] Starting dynamic subtest: pipe-A-eDP-1
[778.294191] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[778.307858] Starting dynamic subtest: pipe-B-eDP-1
[778.324807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[778.334278] Starting dynamic subtest: pipe-C-eDP-1
[778.351211] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[778.360646] Starting dynamic subtest: pipe-D-eDP-1
[778.378439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[778.381778] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[780.477658] [129/133] (251s left) gem_workarounds (suspend-resume-fd)
[780.560118] Starting subtest: suspend-resume-fd
[797.452457] Subtest suspend-resume-fd: SUCCESS (1.575s)
[803.612184] [130/133] (234s left) gem_exec_flush (basic-wb-rw-before-default)
[803.673712] Starting subtest: basic-wb-rw-before-default
[809.140604] Subtest basic-wb-rw-before-default: SUCCESS (5.464s)
[809.327099] [131/133] (229s left) kms_plane_scaling (planes-downscale-factor-0-75)
[809.430038] Starting subtest: planes-downscale-factor-0-75
[809.432345] Starting dynamic subtest: pipe-A
[809.452197] Dynamic subtest pipe-A: SKIP (0.018s)
[809.463413] Starting dynamic subtest: pipe-B
[809.483632] Dynamic subtest pipe-B: SKIP (0.032s)
[809.494178] Starting dynamic subtest: pipe-C
[809.515848] Dynamic subtest pipe-C: SKIP (0.032s)
[809.526190] Starting dynamic subtest: pipe-D
[809.548088] Dynamic subtest pipe-D: SKIP (0.031s)
[809.552241] Subtest planes-downscale-factor-0-75: SKIP (0.116s)
[809.636958] [132/133] (228s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[809.735099] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[813.446625] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.714s)
[814.624234] [133/133] (223s left) kms_big_fb (linear-32bpp-rotate-270)
[814.723370] Starting subtest: linear-32bpp-rotate-270
[814.742715] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[814.856988] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_plane_lowres
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_async_flips
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: kms_tiled_display
results: parsing output: 17/ for test: gem_bad_reloc
results: parsing output: 18/ for test: gem_softpin
results: parsing output: 19/ for test: dumb_buffer
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_explicit_fence
results: parsing output: 23/ for test: gen7_exec_parse
results: parsing output: 24/ for test: kms_invalid_mode
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 34/ for test: gem_partial_pwrite_pread
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_hdr
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: sw_sync
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_exec_store
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: i915_pm_rc6_residency
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: prime_self_import
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: kms_concurrent
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: kms_atomic_interruptible
results: parsing output: 66/ for test: kms_rmfb
results: parsing output: 67/ for test: gem_flink_basic
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: gem_vm_create
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: gem_mmap_offset
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: gem_flink_basic
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: core_debugfs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_exec_create
results: parsing output: 97/ for test: prime_busy
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: i915_drm_fdinfo
results: parsing output: 100/ for test: i915_query
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_create
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_plane
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_freq_api
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_cursor_edge_walk
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: drm_read
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: gem_lmem_evict
results: parsing output: 124/ for test: gem_readwrite
results: parsing output: 125/ for test: gem_partial_pwrite_pread
results: parsing output: 126/ for test: gem_mmap_offset
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: gem_exec_flush
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_big_fb
Done.