[56.609013] Initializing watchdogs
[56.609055]   /dev/watchdog0
[56.623211] [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]
[56.627409] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.629551] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.633130] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[56.753539] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[63.331686] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.581s)
[63.461550] [002/133] (953s left) syncobj_eventfd (binary-wait-signaled)
[63.524732] Starting subtest: binary-wait-signaled
[63.527047] Subtest binary-wait-signaled: SUCCESS (0.000s)
[63.649306] [003/133] (953s left) gem_exec_schedule (noreorder)
[63.847827] Starting subtest: noreorder
[63.850300] Starting dynamic subtest: rcs0
[63.946792] Dynamic subtest rcs0: SUCCESS (0.100s)
[63.957061] Starting dynamic subtest: vcs0
[65.982857] Dynamic subtest vcs0: SUCCESS (2.036s)
[65.993567] Starting dynamic subtest: vcs1
[68.000475] Dynamic subtest vcs1: SUCCESS (2.015s)
[68.010816] Starting dynamic subtest: vecs0
[69.932540] Dynamic subtest vecs0: SUCCESS (1.931s)
[69.941845] Starting dynamic subtest: ccs0
[70.014425] Dynamic subtest ccs0: SUCCESS (0.082s)
[70.017236] Subtest noreorder: SUCCESS (6.169s)
[70.206614] [004/133] (947s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[70.275745] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[70.279981] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[70.466309] [005/133] (946s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[70.853294] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[71.624297] [006/133] (945s left) kms_cursor_crc (cursor-random-32x10)
[71.779146] Starting subtest: cursor-random-32x10
[71.827856] Subtest cursor-random-32x10: SKIP (0.043s)
[72.096233] [007/133] (945s left) gem_wait (busy)
[72.166019] Starting subtest: busy
[72.168032] Starting dynamic subtest: all-engines
[73.941424] Dynamic subtest all-engines: SUCCESS (1.776s)
[73.951676] Starting dynamic subtest: rcs0
[74.484484] Dynamic subtest rcs0: SUCCESS (0.543s)
[74.493735] Starting dynamic subtest: bcs0
[75.025071] Dynamic subtest bcs0: SUCCESS (0.540s)
[75.034468] Starting dynamic subtest: vcs0
[76.885114] Dynamic subtest vcs0: SUCCESS (1.859s)
[76.895413] Starting dynamic subtest: vcs1
[78.933049] Dynamic subtest vcs1: SUCCESS (2.047s)
[78.943451] Starting dynamic subtest: vecs0
[80.917051] Dynamic subtest vecs0: SUCCESS (1.983s)
[80.927264] Starting dynamic subtest: ccs0
[81.458669] Dynamic subtest ccs0: SUCCESS (0.542s)
[81.461061] Subtest busy: SUCCESS (9.295s)
[81.664760] [008/133] (935s left) kms_draw_crc (fill-fb)
[81.782693] Starting subtest: fill-fb
[82.200719] Subtest fill-fb: SUCCESS (0.419s)
[82.340746] [009/133] (935s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[82.414598] Starting subtest: map-fixed-invalidate-overlap-busy
[82.418911] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[82.567598] [010/133] (934s left) gem_mmap_gtt (basic-small-copy-xy)
[82.628871] Subtest basic-small-copy-XY: SKIP (0.000s)
[82.686684] [011/133] (934s left) kms_flip (dpms-vs-vblank-race)
[82.776951] Starting subtest: dpms-vs-vblank-race
[82.778772] Starting dynamic subtest: A-eDP1
[87.744128] Dynamic subtest A-eDP1: SUCCESS (4.966s)
[87.752590] Starting dynamic subtest: B-eDP1
[92.364958] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[92.373432] Starting dynamic subtest: C-eDP1
[96.994256] Dynamic subtest C-eDP1: SUCCESS (4.629s)
[97.004700] Starting dynamic subtest: D-eDP1
[101.606581] Dynamic subtest D-eDP1: SUCCESS (4.609s)
[101.608610] Subtest dpms-vs-vblank-race: SUCCESS (18.830s)
[102.499435] [012/133] (915s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[102.620072] Starting subtest: short-busy-flip-before-cursor-toggle
[102.624453] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[102.771358] [013/133] (914s left) i915_query (engine-info)
[102.826467] Starting subtest: engine-info
[102.828517] Subtest engine-info: SUCCESS (0.005s)
[102.958097] [014/133] (914s left) gem_mmap_gtt (close-race)
[103.014977] Subtest close-race: SKIP (0.000s)
[103.082256] [015/133] (914s left) kms_content_protection (atomic-dpms)
[103.219803] Starting subtest: atomic-dpms
[103.224400] Subtest atomic-dpms: SKIP (0.000s)
[103.366256] [016/133] (914s left) gem_eio (kms)
[103.615060] Starting subtest: kms
[121.193095] Subtest kms: SUCCESS (17.576s)
[122.377018] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[122.380195] [017/133] (895s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[122.479876] Starting subtest: plane-lut1d-pre-ctm3x4
[122.492724] Starting dynamic subtest: pipe-A-eDP-1
[123.234420] Dynamic subtest pipe-A-eDP-1: FAIL (0.358s)
[123.940140] Starting dynamic subtest: pipe-B-eDP-1
[124.772877] Dynamic subtest pipe-B-eDP-1: FAIL (0.314s)
[125.282853] Starting dynamic subtest: pipe-C-eDP-1
[126.115749] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[126.623507] Starting dynamic subtest: pipe-D-eDP-1
[127.479485] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s)
[127.481467] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.702s)
[128.073321] [018/133] (889s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[128.183057] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[128.187365] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[129.353582] [019/133] (888s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[129.446384] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[129.450684] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[129.551940] [020/133] (888s left) kms_psr (pr-sprite-blt)
[129.650060] Starting subtest: pr-sprite-blt
[129.654356] Subtest pr-sprite-blt: SKIP (0.000s)
[129.728216] [021/133] (888s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[129.836695] Starting subtest: fbc-psr2-cursor-plane-update-sf
[129.839047] Starting dynamic subtest: pipe-A-eDP-1
[129.934274] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[129.941821] Starting dynamic subtest: pipe-B-eDP-1
[131.017250] Dynamic subtest pipe-B-eDP-1: SKIP (1.080s)
[131.021450] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.183s)
[132.239026] [022/133] (885s left) kms_atomic (plane-cursor-legacy)
[132.335815] Starting subtest: plane-cursor-legacy
[132.337663] Starting dynamic subtest: pipe-A-eDP-1
[132.703727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[132.706052] Subtest plane-cursor-legacy: SUCCESS (0.368s)
[133.574374] [023/133] (884s left) kms_plane_alpha_blend (alpha-opaque-fb)
[133.674334] Starting subtest: alpha-opaque-fb
[133.976061] Starting dynamic subtest: pipe-A-eDP-1
[134.548532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[134.556722] Starting dynamic subtest: pipe-D-eDP-1
[135.888912] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[135.891163] Subtest alpha-opaque-fb: SUCCESS (2.212s)
[136.720481] [024/133] (881s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[137.117113] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[137.905130] [025/133] (880s left) kms_addfb_basic (addfb25-bad-modifier)
[138.001503] Starting subtest: addfb25-bad-modifier
[138.003382] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[138.103635] [026/133] (880s left) i915_pm_rpm (system-suspend-execbuf)
[140.033481] Starting subtest: system-suspend-execbuf
[198.201208] Subtest system-suspend-execbuf: SUCCESS (43.015s)
[198.598800] [027/133] (819s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[198.695454] Starting subtest: plane-upscale-factor-0-25-with-rotation
[198.697588] Starting dynamic subtest: pipe-A
[198.919984] Dynamic subtest pipe-A: SUCCESS (0.227s)
[198.929209] Starting dynamic subtest: pipe-B
[200.245882] Dynamic subtest pipe-B: SUCCESS (1.325s)
[200.255082] Starting dynamic subtest: pipe-C
[201.567723] Dynamic subtest pipe-C: SUCCESS (1.321s)
[201.581313] Starting dynamic subtest: pipe-D
[202.911867] Dynamic subtest pipe-D: SUCCESS (1.342s)
[202.914392] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.219s)
[204.107096] [028/133] (814s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[204.208012] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[211.671988] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.465s)
[211.839771] [029/133] (806s left) gem_exec_balancer (parallel)
[212.108483] Starting subtest: parallel
[213.048583] Subtest parallel: SUCCESS (0.940s)
[213.176545] [030/133] (805s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[213.279427] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[213.281679] Starting dynamic subtest: pipe-A-eDP-1
[213.304241] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.315362] Starting dynamic subtest: pipe-B-eDP-1
[213.335803] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.344089] Starting dynamic subtest: pipe-C-eDP-1
[213.365315] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.374323] Starting dynamic subtest: pipe-D-eDP-1
[213.395958] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.400269] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[215.519689] [031/133] (802s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[215.636249] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[215.640670] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[215.746345] [032/133] (802s left) gem_gpgpu_fill (offset-16x16)
[215.803760] Starting subtest: offset-16x16
[215.809269] Subtest offset-16x16: SUCCESS (0.008s)
[215.977582] [033/133] (802s left) kms_psr (psr2-cursor-plane-onoff)
[216.083198] Starting subtest: psr2-cursor-plane-onoff
[216.085330] Starting dynamic subtest: eDP-1
[217.793017] Dynamic subtest eDP-1: SUCCESS (1.708s)
[217.795288] Subtest psr2-cursor-plane-onoff: SUCCESS (1.709s)
[218.606418] [034/133] (799s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[218.708953] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[218.713341] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.812902] [035/133] (799s left) gem_mmap_offset (ptrace)
[218.875740] Starting subtest: ptrace
[218.878025] Starting dynamic subtest: smem0-wb
[218.895883] Dynamic subtest smem0-wb: SUCCESS (0.019s)
[218.907175] Starting dynamic subtest: smem0-wc
[218.916672] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[218.925018] Starting dynamic subtest: smem0-uc
[218.940007] Dynamic subtest smem0-uc: SUCCESS (0.023s)
[218.942265] Subtest ptrace: SUCCESS (0.067s)
[219.087168] [036/133] (799s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[219.202627] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[219.207217] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.333017] [037/133] (799s left) fbdev (unaligned-read)
[219.378544] Starting subtest: unaligned-read
[219.393812] Subtest unaligned-read: SUCCESS (0.015s)
[219.467084] [038/133] (799s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[219.527205] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[219.607463] [039/133] (799s left) syncobj_wait (wait-all-snapshot)
[219.673000] Starting subtest: wait-all-snapshot
[219.755467] Subtest wait-all-snapshot: SUCCESS (0.081s)
[219.849476] [040/133] (798s left) perf_pmu (busy-hang)
[219.883898] Starting subtest: busy-hang
[219.885704] Starting dynamic subtest: rcs0
[221.184607] Dynamic subtest rcs0: SUCCESS (1.299s)
[221.195620] Starting dynamic subtest: bcs0
[222.435360] Dynamic subtest bcs0: SUCCESS (1.246s)
[222.446238] Starting dynamic subtest: vcs0
[224.580300] Dynamic subtest vcs0: SUCCESS (2.143s)
[224.594235] Starting dynamic subtest: vcs1
[226.560542] Dynamic subtest vcs1: SUCCESS (1.981s)
[226.571913] Starting dynamic subtest: vecs0
[228.543517] Dynamic subtest vecs0: SUCCESS (1.981s)
[228.554659] Starting dynamic subtest: ccs0
[229.787944] Dynamic subtest ccs0: SUCCESS (1.239s)
[229.790322] Subtest busy-hang: SUCCESS (9.900s)
[229.909793] [041/133] (788s left) gem_softpin (overlap)
[229.975704] Starting subtest: overlap
[230.874804] Subtest overlap: SUCCESS (0.898s)
[231.045017] [042/133] (787s left) gem_ctx_persistence (saturated-hostile)
[231.115677] Starting subtest: saturated-hostile
[231.118129] Starting dynamic subtest: rcs0
[231.965592] Dynamic subtest rcs0: SUCCESS (0.849s)
[231.980570] Starting dynamic subtest: bcs0
[232.793635] Dynamic subtest bcs0: SUCCESS (0.826s)
[232.804800] Starting dynamic subtest: vcs0
[233.619257] Dynamic subtest vcs0: SUCCESS (0.823s)
[233.629479] Starting dynamic subtest: vcs1
[234.432699] Dynamic subtest vcs1: SUCCESS (0.812s)
[234.443646] Starting dynamic subtest: vecs0
[235.258743] Dynamic subtest vecs0: SUCCESS (0.824s)
[235.269570] Starting dynamic subtest: ccs0
[236.113635] Dynamic subtest ccs0: SUCCESS (0.852s)
[236.116115] Subtest saturated-hostile: SUCCESS (4.998s)
[236.202930] [043/133] (782s left) sw_sync (sync_busy_fork_unixsocket)
[236.236634] Starting subtest: sync_busy_fork_unixsocket
[236.243231] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[236.320437] [044/133] (782s left) gen9_exec_parse (allowed-single)
[236.379127] Subtest allowed-single: SKIP (0.000s)
[236.458392] [045/133] (782s left) api_intel_bb (lot-of-buffers)
[236.523391] Starting subtest: lot-of-buffers
[237.518746] Subtest lot-of-buffers: SUCCESS (0.999s)
[238.200927] [046/133] (780s left) kms_atomic_interruptible (legacy-dpms)
[238.300101] Starting subtest: legacy-dpms
[238.302309] Starting dynamic subtest: pipe-A-eDP-1
[245.710130] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s)
[245.712238] Subtest legacy-dpms: SUCCESS (7.408s)
[246.575038] [047/133] (772s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[246.678404] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[247.346336] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[247.534172] [048/133] (771s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[247.630721] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[247.634777] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[247.755509] [049/133] (771s left) syncobj_timeline (reset-multiple-signaled)
[247.812471] Starting subtest: reset-multiple-signaled
[247.814557] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[247.942820] [050/133] (771s left) gem_exec_reloc (basic-cpu-read)
[248.011355] Subtest basic-cpu-read: SKIP (0.000s)
[248.105935] [051/133] (771s left) prime_busy (after)
[248.171813] Starting subtest: after
[248.177189] Starting dynamic subtest: rcs0
[248.200097] Dynamic subtest rcs0: SUCCESS (0.025s)
[248.211036] Starting dynamic subtest: bcs0
[248.240884] Dynamic subtest bcs0: SUCCESS (0.040s)
[248.250030] Starting dynamic subtest: vcs0
[248.282261] Dynamic subtest vcs0: SUCCESS (0.040s)
[248.291135] Starting dynamic subtest: vcs1
[248.322438] Dynamic subtest vcs1: SUCCESS (0.039s)
[248.331048] Starting dynamic subtest: vecs0
[248.362808] Dynamic subtest vecs0: SUCCESS (0.040s)
[248.371176] Starting dynamic subtest: ccs0
[248.403368] Dynamic subtest ccs0: SUCCESS (0.040s)
[248.511786] Subtest after: SUCCESS (0.338s)
[248.597417] [052/133] (770s left) gem_userptr_blits (usage-restrictions)
[248.671346] Starting subtest: usage-restrictions
[248.673625] Subtest usage-restrictions: SUCCESS (0.000s)
[248.821056] [053/133] (770s left) gem_exec_reloc (basic-gtt-cpu)
[248.884950] Subtest basic-gtt-cpu: SKIP (0.000s)
[248.968919] [054/133] (770s left) vgem_slow (nohang)
[249.022003] Starting subtest: nohang
[259.478913] Subtest nohang: SUCCESS (10.458s)
[259.562922] [055/133] (759s left) gem_exec_fence (basic-wait-all)
[259.630326] Starting subtest: basic-wait-all
[259.754884] Subtest basic-wait-all: SUCCESS (0.124s)
[262.179703] [056/133] (757s left) kms_pm_dc (dc3co-vpb-simulation)
[263.291455] Starting subtest: dc3co-vpb-simulation
[272.061755] Subtest dc3co-vpb-simulation: SKIP (8.767s)
[272.227483] [057/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[272.319914] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[272.323949] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[272.418362] [058/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[272.524394] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[279.396065] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.875s)
[279.581028] [059/133] (739s left) gem_workarounds (suspend-resume-fd)
[279.656749] Starting subtest: suspend-resume-fd
[295.352778] Subtest suspend-resume-fd: SUCCESS (1.949s)
[296.504705] [060/133] (724s left) gem_exec_fence (syncobj-invalid-flags)
[296.914828] Starting subtest: syncobj-invalid-flags
[296.917333] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[298.878106] [061/133] (721s left) sysfs_heartbeat_interval (invalid)
[298.946791] Starting subtest: invalid
[298.949168] Starting dynamic subtest: vecs0
[298.951598] Dynamic subtest vecs0: SUCCESS (0.000s)
[298.965212] Starting dynamic subtest: ccs0
[298.967472] Dynamic subtest ccs0: SUCCESS (0.000s)
[298.976576] Starting dynamic subtest: vcs0
[298.978827] Dynamic subtest vcs0: SUCCESS (0.000s)
[298.987531] Starting dynamic subtest: bcs0
[298.989794] Dynamic subtest bcs0: SUCCESS (0.000s)
[298.998869] Starting dynamic subtest: rcs0
[299.001060] Dynamic subtest rcs0: SUCCESS (0.000s)
[299.009630] Starting dynamic subtest: vcs1
[299.011488] Dynamic subtest vcs1: SUCCESS (0.000s)
[299.013905] Subtest invalid: SUCCESS (0.005s)
[299.098498] [062/133] (721s left) vgem_basic (second-client)
[299.148409] Starting subtest: second-client
[299.173880] Subtest second-client: SUCCESS (0.022s)
[299.240906] [063/133] (721s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[299.339922] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[299.342236] Starting dynamic subtest: pipe-A-eDP-1
[299.364927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.376173] Starting dynamic subtest: pipe-B-eDP-1
[299.397959] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.406759] Starting dynamic subtest: pipe-C-eDP-1
[299.428615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.437585] Starting dynamic subtest: pipe-D-eDP-1
[299.459942] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.464044] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[301.585195] [064/133] (719s left) kms_flip (2x-flip-vs-fences)
[301.691295] Starting subtest: 2x-flip-vs-fences
[301.695938] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[301.823890] [065/133] (718s left) gem_exec_reloc (basic-wc-read-noreloc)
[301.889177] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[301.976869] [066/133] (718s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[302.073728] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[302.075956] Starting dynamic subtest: pipe-A-eDP-1
[302.133264] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[302.143959] Starting dynamic subtest: pipe-B-eDP-1
[302.200702] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[302.211244] Starting dynamic subtest: pipe-C-eDP-1
[302.267677] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[302.277644] Starting dynamic subtest: pipe-D-eDP-1
[302.334858] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[302.339308] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[304.255897] [067/133] (716s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[304.363814] Starting subtest: fbc-psr2-sprite-mmap-gtt
[304.366102] Starting dynamic subtest: eDP-1
[304.370202] Dynamic subtest eDP-1: SKIP (0.000s)
[304.374355] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[304.448350] [068/133] (716s left) kms_big_fb (linear-32bpp-rotate-180)
[304.550916] Starting subtest: linear-32bpp-rotate-180
[305.988762] Subtest linear-32bpp-rotate-180: SUCCESS (1.435s)
[306.152368] [069/133] (714s left) gem_exec_schedule (semaphore-power)
[306.332426] Subtest semaphore-power: SKIP (0.000s)
[306.524733] [070/133] (714s left) gem_exec_fence (concurrent)
[306.696742] Starting subtest: concurrent
[306.701467] Subtest concurrent: SKIP (0.000s)
[308.881752] [071/133] (712s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[308.978447] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[308.982650] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[309.061611] [072/133] (711s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[309.159531] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[309.161857] Starting dynamic subtest: pipe-A-eDP-1
[309.186858] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[309.197615] Starting dynamic subtest: pipe-B-eDP-1
[309.221525] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[309.231127] Starting dynamic subtest: pipe-C-eDP-1
[309.253631] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.262140] Starting dynamic subtest: pipe-D-eDP-1
[309.284709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.288618] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[311.416383] [073/133] (709s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[311.513340] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[311.515490] Starting dynamic subtest: pipe-A-eDP-1
[311.612108] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[311.628039] Starting dynamic subtest: pipe-B-eDP-1
[312.786257] Dynamic subtest pipe-B-eDP-1: SKIP (1.172s)
[312.790926] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.275s)
[313.980334] [074/133] (707s left) kms_invalid_mode (bad-hsync-start)
[314.078614] Starting subtest: bad-hsync-start
[314.080707] Starting dynamic subtest: pipe-A-eDP-1
[314.368205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[314.378834] Starting dynamic subtest: pipe-B-eDP-1
[314.381180] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[314.391218] Starting dynamic subtest: pipe-C-eDP-1
[314.393078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.401336] Starting dynamic subtest: pipe-D-eDP-1
[314.403218] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.405484] Subtest bad-hsync-start: SUCCESS (0.296s)
[315.228574] [075/133] (705s left) syncobj_timeline (wait-all-complex)
[315.287896] Starting subtest: wait-all-complex
[315.499300] Subtest wait-all-complex: SUCCESS (0.212s)
[315.584999] [076/133] (705s left) gen9_exec_parse (unaligned-jump)
[315.641547] Subtest unaligned-jump: SKIP (0.000s)
[315.722090] [077/133] (705s left) i915_hangman (engine-engine-hang)
[315.791084] Starting subtest: engine-engine-hang
[315.793192] Starting dynamic subtest: rcs0
[317.767902] Dynamic subtest rcs0: SUCCESS (1.976s)
[317.782030] Starting dynamic subtest: bcs0
[319.752855] Dynamic subtest bcs0: SUCCESS (1.980s)
[319.767872] Starting dynamic subtest: vcs0
[321.737249] Dynamic subtest vcs0: SUCCESS (1.981s)
[321.750338] Starting dynamic subtest: vcs1
[323.785600] Dynamic subtest vcs1: SUCCESS (2.045s)
[323.798303] Starting dynamic subtest: vecs0
[325.768043] Dynamic subtest vecs0: SUCCESS (1.979s)
[325.780188] Starting dynamic subtest: ccs0
[327.688701] Dynamic subtest ccs0: SUCCESS (1.917s)
[327.691414] Subtest engine-engine-hang: SUCCESS (11.894s)
[327.793444] [078/133] (693s left) kms_rotation_crc (cursor-rotation-180)
[327.895339] Starting subtest: cursor-rotation-180
[329.392171] Subtest cursor-rotation-180: SUCCESS (1.498s)
[330.594611] [079/133] (690s left) gem_ctx_persistence (engines-hostile-preempt)
[330.674465] Starting subtest: engines-hostile-preempt
[330.676910] Starting dynamic subtest: rcs0
[330.769409] Dynamic subtest rcs0: SUCCESS (0.094s)
[330.784266] Starting dynamic subtest: bcs0
[330.798330] Dynamic subtest bcs0: SUCCESS (0.026s)
[330.806928] Starting dynamic subtest: vcs0
[332.759808] Dynamic subtest vcs0: SUCCESS (1.960s)
[332.772183] Starting dynamic subtest: vcs1
[334.800087] Dynamic subtest vcs1: SUCCESS (2.038s)
[334.812197] Starting dynamic subtest: vecs0
[336.829026] Dynamic subtest vecs0: SUCCESS (2.027s)
[336.841128] Starting dynamic subtest: ccs0
[336.906577] Dynamic subtest ccs0: SUCCESS (0.076s)
[336.909306] Subtest engines-hostile-preempt: SUCCESS (6.235s)
[336.993345] [080/133] (684s left) kms_fence_pin_leak
[337.177069] [081/133] (684s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[337.275999] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[344.366237] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.094s)
[344.537123] [082/133] (676s left) gem_tiled_fence_blits (normal)
[344.601884] Subtest normal: SKIP (0.000s)
[344.664400] [083/133] (676s left) gem_sync (basic-all)
[344.740305] Starting subtest: basic-all
[348.777632] Subtest basic-all: SUCCESS (4.044s)
[348.976568] [084/133] (672s left) syncobj_wait (invalid-reset-bad-pad)
[349.042415] Starting subtest: invalid-reset-bad-pad
[349.045045] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[349.159196] [085/133] (672s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[349.275172] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[350.353984] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.079s)
[350.490581] [086/133] (671s left) api_intel_allocator (reopen-fork)
[350.555122] Starting subtest: reopen-fork
[354.204432] Subtest reopen-fork: SUCCESS (3.650s)
[354.294856] [087/133] (667s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[354.399470] Starting subtest: primary-y-tiled-reflect-x-270
[354.403724] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[354.498119] [088/133] (667s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[354.552585] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[354.654159] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[354.746716] [089/133] (667s left) gem_spin_batch (legacy)
[354.812812] Starting subtest: legacy
[354.814896] Starting dynamic subtest: default
[358.050397] Dynamic subtest default: SUCCESS (3.235s)
[358.062213] Starting dynamic subtest: render
[361.283501] Dynamic subtest render: SUCCESS (3.230s)
[361.295647] Starting dynamic subtest: bsd
[364.520235] Dynamic subtest bsd: SUCCESS (3.232s)
[364.531149] Starting dynamic subtest: bsd1
[367.750774] Dynamic subtest bsd1: SUCCESS (3.227s)
[367.760622] Starting dynamic subtest: bsd2
[370.988056] Dynamic subtest bsd2: SUCCESS (3.233s)
[370.999625] Starting dynamic subtest: blt
[374.224375] Dynamic subtest blt: SUCCESS (3.233s)
[374.235926] Starting dynamic subtest: vebox
[377.460237] Dynamic subtest vebox: SUCCESS (3.232s)
[377.462355] Subtest legacy: SUCCESS (22.644s)
[377.843537] [090/133] (643s left) kms_cursor_edge_walk (64x64-top-edge)
[377.952365] Starting subtest: 64x64-top-edge
[377.954551] Starting dynamic subtest: pipe-A-eDP-1
[381.447384] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[381.456723] Starting dynamic subtest: pipe-D-eDP-1
[384.571695] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[384.573974] Subtest 64x64-top-edge: SUCCESS (6.621s)
[385.387231] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[385.506939] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[385.511239] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[385.616962] [092/133] (636s left) kms_lease (lease-invalid-crtc)
[385.705849] Starting subtest: lease-invalid-crtc
[385.708127] Starting dynamic subtest: pipe-A-eDP-1
[385.710275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[385.723929] Starting dynamic subtest: pipe-B-eDP-1
[385.726377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[385.742281] Starting dynamic subtest: pipe-C-eDP-1
[385.744267] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[385.754507] Starting dynamic subtest: pipe-D-eDP-1
[385.756368] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[385.758266] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[385.801961] [093/133] (636s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[385.903628] Starting subtest: fbc-pr-cursor-mmap-gtt
[385.907932] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[385.987715] [094/133] (635s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[386.080973] Starting subtest: fbc-2p-pri-indfb-multidraw
[386.084810] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[386.220716] [095/133] (635s left) kms_plane_lowres (tiling-x)
[386.308505] Starting subtest: tiling-x
[386.310734] Starting dynamic subtest: pipe-A-eDP-1
[386.315091] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[386.622246] Starting dynamic subtest: pipe-B-eDP-1
[386.627205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[386.646132] Starting dynamic subtest: pipe-C-eDP-1
[386.650182] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[386.659108] Starting dynamic subtest: pipe-D-eDP-1
[386.663197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[386.667274] Subtest tiling-x: SKIP (0.308s)
[387.448229] [096/133] (634s left) kms_cursor_crc (cursor-offscreen-32x32)
[387.594957] Starting subtest: cursor-offscreen-32x32
[387.638440] Subtest cursor-offscreen-32x32: SKIP (0.040s)
[387.953397] [097/133] (634s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[388.063467] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[392.318604] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.258s)
[393.538547] [098/133] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[393.653475] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[400.072075] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.423s)
[400.243786] [099/133] (621s left) kms_frontbuffer_tracking (fbc-tiling-y)
[400.349431] Starting subtest: fbc-tiling-y
[400.353502] Subtest fbc-tiling-y: SKIP (0.000s)
[400.462270] [100/133] (621s left) kms_addfb_basic (legacy-format)
[400.530882] Starting subtest: legacy-format
[400.553812] Subtest legacy-format: SUCCESS (0.021s)
[400.715600] [101/133] (621s left) prime_vgem (basic-read)
[400.804459] Starting subtest: basic-read
[400.816245] Subtest basic-read: SKIP (0.010s)
[400.963762] [102/133] (621s left) gem_exec_schedule (fairslice)
[401.034484] Starting subtest: fairslice
[401.036452] Starting dynamic subtest: rcs0
[403.049614] Dynamic subtest rcs0: SUCCESS (2.018s)
[403.060547] Starting dynamic subtest: bcs0
[405.068679] Dynamic subtest bcs0: SUCCESS (2.017s)
[405.080501] Starting dynamic subtest: vcs0
[407.091052] Dynamic subtest vcs0: SUCCESS (2.020s)
[407.101816] Starting dynamic subtest: vcs1
[409.108835] Dynamic subtest vcs1: SUCCESS (2.018s)
[409.119614] Starting dynamic subtest: vecs0
[411.127369] Dynamic subtest vecs0: SUCCESS (2.017s)
[411.137623] Starting dynamic subtest: ccs0
[413.147294] Dynamic subtest ccs0: SUCCESS (2.018s)
[413.149338] Subtest fairslice: SUCCESS (12.115s)
[413.469312] [103/133] (608s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[413.570840] Starting subtest: yf-tiled-8bpp-rotate-90
[413.575292] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[413.690340] [104/133] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[413.783849] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[413.788108] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[413.924876] [105/133] (608s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[414.026429] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[414.030530] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[414.160362] [106/133] (608s left) kms_rotation_crc (bad-tiling)
[414.258690] Starting subtest: bad-tiling
[414.263122] Subtest bad-tiling: SKIP (0.001s)
[414.342672] [107/133] (608s left) perf_pmu (init-sema)
[414.381612] Starting subtest: init-sema
[414.383395] Starting dynamic subtest: rcs0
[414.385314] Dynamic subtest rcs0: SUCCESS (0.002s)
[414.399350] Starting dynamic subtest: bcs0
[414.401023] Dynamic subtest bcs0: SUCCESS (0.000s)
[414.409819] Starting dynamic subtest: vcs0
[414.411641] Dynamic subtest vcs0: SUCCESS (0.001s)
[414.419649] Starting dynamic subtest: vcs1
[414.421342] Dynamic subtest vcs1: SUCCESS (0.001s)
[414.429616] Starting dynamic subtest: vecs0
[414.431290] Dynamic subtest vecs0: SUCCESS (0.001s)
[414.440329] Starting dynamic subtest: ccs0
[414.442013] Dynamic subtest ccs0: SUCCESS (0.000s)
[414.443624] Subtest init-sema: SUCCESS (0.008s)
[414.533326] [108/133] (608s left) kms_prime (basic-crc-vgem)
[414.616013] Starting subtest: basic-crc-vgem
[414.617958] Starting dynamic subtest: second-to-first
[415.529628] Dynamic subtest second-to-first: SUCCESS (0.917s)
[415.531509] Subtest basic-crc-vgem: SUCCESS (0.917s)
[415.635713] [109/133] (606s left) i915_query (query-garbage)
[415.735679] Starting subtest: query-garbage
[415.737803] Subtest query-garbage: SUCCESS (0.000s)
[415.859671] [110/133] (606s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[415.980782] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[447.238040] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.250s)
[448.089323] [111/133] (574s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[448.203167] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[448.205463] Starting dynamic subtest: pipe-A
[448.311477] Dynamic subtest pipe-A: SKIP (0.106s)
[448.321722] Starting dynamic subtest: pipe-B
[449.432661] Dynamic subtest pipe-B: SKIP (1.119s)
[449.442648] Starting dynamic subtest: pipe-C
[450.579745] Dynamic subtest pipe-C: SUCCESS (1.152s)
[450.590023] Starting dynamic subtest: pipe-D
[451.716802] Dynamic subtest pipe-D: SUCCESS (1.136s)
[451.719079] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.516s)
[452.920189] [112/133] (569s left) gem_exec_params (cliprects_ptr-dirt)
[452.986545] Starting subtest: cliprects_ptr-dirt
[452.988935] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[453.109457] [113/133] (569s left) dumb_buffer (create-valid-dumb)
[453.166988] Starting subtest: create-valid-dumb
[453.168891] Subtest create-valid-dumb: SUCCESS (0.000s)
[453.285385] [114/133] (569s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[453.379400] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[453.383322] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[453.462956] [115/133] (569s left) kms_vblank (ts-continuation-dpms-suspend)
[453.560668] Starting subtest: ts-continuation-dpms-suspend
[453.562518] Starting dynamic subtest: pipe-A-eDP-1
[470.909928] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.842s)
[470.928142] Starting dynamic subtest: pipe-D-eDP-1
[488.901793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.458s)
[488.904168] Subtest ts-continuation-dpms-suspend: SUCCESS (4.303s)
[489.734062] [116/133] (533s left) kms_vblank (query-busy-hang)
[489.836275] Starting subtest: query-busy-hang
[489.838180] Starting dynamic subtest: pipe-A-eDP-1
[516.587061] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.720s)
[516.600532] Starting dynamic subtest: pipe-D-eDP-1
[541.617818] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.033s)
[541.620019] Subtest query-busy-hang: SUCCESS (51.758s)
[542.431555] [117/133] (480s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[542.523588] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[542.549199] Starting dynamic subtest: pipe-A-plane-0
[542.838661] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[542.853989] Starting dynamic subtest: pipe-A-plane-3
[543.071286] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[544.203439] Starting dynamic subtest: pipe-B-plane-0
[544.495179] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[544.506185] Starting dynamic subtest: pipe-B-plane-3
[544.729254] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[545.038236] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.514s)
[545.885646] [118/133] (477s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[545.985196] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[545.989467] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[546.093643] [119/133] (476s left) syncobj_timeline (invalid-query-bad-pad)
[546.157938] Starting subtest: invalid-query-bad-pad
[546.160282] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[546.265010] [120/133] (476s left) kms_feature_discovery (display-3x)
[546.366650] Starting subtest: display-3x
[546.371050] Subtest display-3x: SKIP (0.000s)
[546.449879] [121/133] (476s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[546.552083] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[553.285788] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.735s)
[553.412553] [122/133] (469s left) kms_scaling_modes (scaling-mode-full-aspect)
[553.520661] Starting subtest: scaling-mode-full-aspect
[553.522964] Starting dynamic subtest: pipe-A-eDP-1
[553.614774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[553.625298] Starting dynamic subtest: pipe-B-eDP-1
[554.827118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[554.836297] Starting dynamic subtest: pipe-C-eDP-1
[556.047390] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[556.056657] Starting dynamic subtest: pipe-D-eDP-1
[557.180174] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[557.183147] Subtest scaling-mode-full-aspect: SUCCESS (3.661s)
[558.380301] [123/133] (464s left) sw_sync (timeline_closed)
[558.435047] Starting subtest: timeline_closed
[558.437312] Subtest timeline_closed: SUCCESS (0.000s)
[558.523380] [124/133] (464s left) gem_exec_store (pages)
[558.584131] Starting subtest: pages
[558.586538] Starting dynamic subtest: rcs0
[558.671130] Dynamic subtest rcs0: SUCCESS (0.087s)
[558.683746] Starting dynamic subtest: bcs0
[558.748782] Dynamic subtest bcs0: SUCCESS (0.076s)
[558.761427] Starting dynamic subtest: vcs0
[558.814000] Dynamic subtest vcs0: SUCCESS (0.065s)
[558.826071] Starting dynamic subtest: vcs1
[558.881456] Dynamic subtest vcs1: SUCCESS (0.066s)
[558.892946] Starting dynamic subtest: vecs0
[558.946974] Dynamic subtest vecs0: SUCCESS (0.065s)
[558.957334] Starting dynamic subtest: ccs0
[559.022690] Dynamic subtest ccs0: SUCCESS (0.074s)
[559.024977] Subtest pages: SUCCESS (0.440s)
[559.222627] [125/133] (464s left) gem_softpin (softpin)
[559.288023] Starting subtest: softpin
[591.533484] Subtest softpin: SUCCESS (32.235s)
[591.676833] [126/133] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[591.785952] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[591.790436] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[591.899860] [127/133] (431s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[591.999681] Starting subtest: x-tiled-64bpp-rotate-270
[592.021309] Subtest x-tiled-64bpp-rotate-270: SKIP (0.021s)
[592.184391] [128/133] (431s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[592.274744] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[592.278707] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[592.394744] [129/133] (431s left) gem_create (create-ext-set-pat)
[592.553652] Starting subtest: create-ext-set-pat
[592.555607] Subtest create-ext-set-pat: SUCCESS (0.001s)
[592.658345] [130/133] (430s left) kms_psr (fbc-psr2-primary-blt)
[592.766241] Starting subtest: fbc-psr2-primary-blt
[592.768527] Starting dynamic subtest: eDP-1
[592.772695] Dynamic subtest eDP-1: SKIP (0.000s)
[592.777014] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[592.849988] [131/133] (430s left) gem_pxp (reject-modify-context-protection-off-3)
[592.975984] Starting subtest: reject-modify-context-protection-off-3
[592.978347] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[593.118096] [132/133] (430s left) gem_mmap_offset (open-flood)
[593.186910] Starting subtest: open-flood
[614.673274] Subtest open-flood: SUCCESS (21.488s)
[614.819113] [133/133] (408s left) gem_exec_params (invalid-fence-in)
[614.881336] Starting subtest: invalid-fence-in
[614.883330] Subtest invalid-fence-in: SUCCESS (0.000s)
[615.024358] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_eventfd
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: kms_chamelium_edid
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_wait
results: parsing output: 7/ for test: kms_draw_crc
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: i915_query
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: kms_color_pipeline
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_atomic
results: parsing output: 22/ for test: kms_plane_alpha_blend
results: parsing output: 23/ for test: kms_chamelium_hpd
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_gpgpu_fill
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_mmap_offset
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: fbdev
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_atomic_interruptible
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: prime_busy
results: parsing output: 51/ for test: gem_userptr_blits
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: vgem_slow
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_pm_dc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: sysfs_heartbeat_interval
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_invalid_mode
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: i915_hangman
results: parsing output: 77/ for test: kms_rotation_crc
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_fence_pin_leak
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_tiled_fence_blits
results: parsing output: 82/ for test: gem_sync
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_lowres
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_prime
results: parsing output: 108/ for test: i915_query
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: gem_exec_params
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_feature_discovery
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_scaling_modes
results: parsing output: 122/ for test: sw_sync
results: parsing output: 123/ for test: gem_exec_store
results: parsing output: 124/ for test: gem_softpin
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_create
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: gem_mmap_offset
results: parsing output: 132/ for test: gem_exec_params
Done.