[54.608465] Initializing watchdogs
[54.608512]   /dev/watchdog0
[54.623101] [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]
[54.627538] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.629630] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.632751] [001/131] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[54.694995] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[54.799721] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[54.871077] [002/131] (960s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[54.974344] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[61.821362] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (6.858s)
[61.941388] [003/131] (953s left) gen9_exec_parse (bb-large)
[62.015515] Subtest bb-large: SKIP (0.000s)
[62.072193] [004/131] (953s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[62.178962] Starting subtest: x-tiled-64bpp-rotate-270
[62.198082] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[62.320642] [005/131] (952s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[62.427056] Starting subtest: psr-rgb565-draw-pwrite
[69.411074] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.991s)
[69.538771] [006/131] (945s left) kms_universal_plane (universal-plane-functional)
[69.633862] Starting subtest: universal-plane-functional
[69.636165] Starting dynamic subtest: pipe-A-eDP-1
[73.517492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.884s)
[73.526494] Starting dynamic subtest: pipe-B-eDP-1
[77.890623] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.374s)
[77.898110] Starting dynamic subtest: pipe-C-eDP-1
[82.239847] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.349s)
[82.247943] Starting dynamic subtest: pipe-D-eDP-1
[86.408436] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.169s)
[86.410970] Subtest universal-plane-functional: SUCCESS (16.780s)
[87.194687] [007/131] (928s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[87.298022] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[87.302681] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[88.427512] [008/131] (926s left) kms_invalid_mode (bad-vtotal)
[88.518297] Starting subtest: bad-vtotal
[88.520668] Starting dynamic subtest: pipe-A-eDP-1
[88.801387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[88.808219] Starting dynamic subtest: pipe-B-eDP-1
[88.810320] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.816853] Starting dynamic subtest: pipe-C-eDP-1
[88.819071] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[88.825738] Starting dynamic subtest: pipe-D-eDP-1
[88.827889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[88.830184] Subtest bad-vtotal: SUCCESS (0.288s)
[89.651715] [009/131] (925s left) perf (invalid-oa-metric-set-id)
[89.766559] Starting subtest: invalid-oa-metric-set-id
[89.782275] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s)
[89.822091] [010/131] (925s left) gem_ctx_param (basic)
[89.879837] Starting subtest: basic
[89.882150] Subtest basic: SUCCESS (0.001s)
[89.997657] [011/131] (925s left) intel_hwmon (hwmon-read)
[90.062075] Subtest hwmon-read: SKIP (0.000s)
[90.129667] [012/131] (925s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[90.177746] Starting subtest: multi-wait-all-for-submit-available-submitted
[90.180076] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[90.255979] [013/131] (925s left) perf_pmu (semaphore-wait)
[90.294493] Starting subtest: semaphore-wait
[90.296838] Starting dynamic subtest: rcs0
[90.809797] Dynamic subtest rcs0: SUCCESS (0.514s)
[90.818934] Starting dynamic subtest: bcs0
[91.322324] Dynamic subtest bcs0: SUCCESS (0.511s)
[91.330959] Starting dynamic subtest: vcs0
[91.833767] Dynamic subtest vcs0: SUCCESS (0.511s)
[91.844703] Starting dynamic subtest: vcs1
[92.343735] Dynamic subtest vcs1: SUCCESS (0.509s)
[92.353360] Starting dynamic subtest: vecs0
[92.857359] Dynamic subtest vecs0: SUCCESS (0.514s)
[92.870629] Starting dynamic subtest: ccs0
[93.373288] Dynamic subtest ccs0: SUCCESS (0.513s)
[93.375921] Subtest semaphore-wait: SUCCESS (3.077s)
[94.939257] [014/131] (920s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[100.009581] Starting subtest: pr-primary-plane-update-sf-dmg-area
[100.014192] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[100.840982] [015/131] (914s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[100.947523] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[100.951635] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[101.039062] [016/131] (914s left) gem_exec_reloc (basic-wc-read-noreloc)
[101.094486] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[101.154060] [017/131] (914s left) gem_ctx_exec (basic-nohangcheck)
[101.207404] Starting subtest: basic-nohangcheck
[101.459208] Subtest basic-nohangcheck: SUCCESS (0.253s)
[101.575275] [018/131] (914s left) gem_gtt_cpu_tlb
[101.687783] [019/131] (914s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[101.780474] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[101.782732] Starting dynamic subtest: pipe-A-eDP-1
[102.724041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.935s)
[102.732526] Starting dynamic subtest: pipe-B-eDP-1
[104.249387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.524s)
[104.256740] Starting dynamic subtest: pipe-C-eDP-1
[105.748087] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[105.755406] Starting dynamic subtest: pipe-D-eDP-1
[107.283054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.533s)
[107.284876] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.494s)
[108.441494] [020/131] (907s left) i915_module_load (reload-no-display)
[108.475293] Starting subtest: reload-no-display
[114.655496] Subtest reload-no-display: SUCCESS (6.180s)
[114.683131] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[114.686658] [021/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[116.198301] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[116.202570] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[116.288399] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true
[116.291946] [022/131] (899s left) dumb_buffer (create-clear)
[116.342485] Starting subtest: create-clear
[157.384205] Subtest create-clear: SUCCESS (41.038s)
[157.553103] [023/131] (858s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[157.679501] Starting subtest: protected-encrypted-src-copy-not-readible
[157.809477] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.131s)
[157.925428] [024/131] (858s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[158.035335] Starting subtest: x-tiled-16bpp-rotate-0
[159.478028] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.442s)
[159.742158] [025/131] (856s left) kms_chamelium_color (ctm-0-25)
[159.849429] Subtest ctm-0-25: SKIP (0.000s)
[159.894086] [026/131] (856s left) gem_exec_store (pages)
[159.962543] Starting subtest: pages
[159.964568] Starting dynamic subtest: rcs0
[160.056328] Dynamic subtest rcs0: SUCCESS (0.096s)
[160.066241] Starting dynamic subtest: bcs0
[160.130577] Dynamic subtest bcs0: SUCCESS (0.074s)
[160.141029] Starting dynamic subtest: vcs0
[160.194043] Dynamic subtest vcs0: SUCCESS (0.063s)
[160.202603] Starting dynamic subtest: vcs1
[160.264851] Dynamic subtest vcs1: SUCCESS (0.071s)
[160.273727] Starting dynamic subtest: vecs0
[160.327041] Dynamic subtest vecs0: SUCCESS (0.062s)
[160.335695] Starting dynamic subtest: ccs0
[160.413993] Dynamic subtest ccs0: SUCCESS (0.086s)
[160.416751] Subtest pages: SUCCESS (0.455s)
[160.594141] [027/131] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[160.700444] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[160.704724] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[160.813111] [028/131] (855s left) kms_properties (plane-properties-legacy)
[160.910722] Starting subtest: plane-properties-legacy
[160.913084] Starting dynamic subtest: pipe-A-eDP-1
[161.519302] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[161.526830] Starting dynamic subtest: pipe-B-eDP-1
[162.780188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[162.789242] Starting dynamic subtest: pipe-C-eDP-1
[164.002984] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[164.012541] Starting dynamic subtest: pipe-D-eDP-1
[165.232094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[165.234598] Subtest plane-properties-legacy: SUCCESS (4.318s)
[166.011841] [029/131] (850s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[171.081884] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[171.084400] Starting dynamic subtest: pipe-A-eDP-1
[171.864719] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s)
[171.872294] Starting dynamic subtest: pipe-B-eDP-1
[172.995959] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[173.000427] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.911s)
[174.167730] [030/131] (842s left) gem_exec_schedule (preempt-queue-contexts)
[174.231436] Subtest preempt-queue-contexts: SKIP (0.000s)
[174.515603] [031/131] (841s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[174.613826] Starting subtest: invalid-modeset-force-ultra-joiner
[174.618019] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[174.676114] [032/131] (841s left) kms_plane_multiple (tiling-none)
[174.774869] Starting subtest: tiling-none
[174.777222] Starting dynamic subtest: pipe-A-eDP-1
[178.479046] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.701s)
[178.494305] Starting dynamic subtest: pipe-B-eDP-1
[182.870715] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.391s)
[182.879228] Starting dynamic subtest: pipe-C-eDP-1
[187.145063] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.272s)
[187.154814] Starting dynamic subtest: pipe-D-eDP-1
[191.452503] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.307s)
[191.455046] Subtest tiling-none: SUCCESS (16.676s)
[192.245506] [033/131] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[192.350946] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[196.034502] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.687s)
[197.148627] [034/131] (819s left) gem_spin_batch (resubmit-new)
[197.215561] Starting subtest: resubmit-new
[197.217991] Starting dynamic subtest: rcs0
[197.223784] Dynamic subtest rcs0: SUCCESS (0.008s)
[197.231934] Starting dynamic subtest: bcs0
[197.234057] Dynamic subtest bcs0: SUCCESS (0.004s)
[197.241856] Starting dynamic subtest: vcs0
[197.243713] Dynamic subtest vcs0: SUCCESS (0.005s)
[197.251206] Starting dynamic subtest: vcs1
[197.253317] Dynamic subtest vcs1: SUCCESS (0.004s)
[197.260286] Starting dynamic subtest: vecs0
[197.262439] Dynamic subtest vecs0: SUCCESS (0.005s)
[197.269491] Starting dynamic subtest: ccs0
[197.271646] Dynamic subtest ccs0: SUCCESS (0.004s)
[197.273921] Subtest resubmit-new: SUCCESS (0.034s)
[198.970960] [035/131] (817s left) kms_big_fb (linear-32bpp-rotate-0)
[199.081673] Starting subtest: linear-32bpp-rotate-0
[200.871644] Subtest linear-32bpp-rotate-0: SUCCESS (1.789s)
[201.067489] [036/131] (815s left) kms_chamelium_frames (dp-crc-fast)
[201.454793] Subtest dp-crc-fast: SKIP (0.000s)
[202.229648] [037/131] (814s left) gem_mmap (big-bo)
[202.288347] Subtest big-bo: SKIP (0.000s)
[202.355902] [038/131] (814s left) kms_psr (fbc-psr-primary-blt)
[202.442346] Starting subtest: fbc-psr-primary-blt
[202.444602] Starting dynamic subtest: eDP-1
[202.449060] Dynamic subtest eDP-1: SKIP (0.000s)
[202.453461] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[202.512727] [039/131] (814s left) gem_exec_whisper (basic-normal-all)
[202.570341] Starting subtest: basic-normal-all
[204.843621] Subtest basic-normal-all: SUCCESS (2.271s)
[205.023909] [040/131] (811s left) kms_content_protection (dp-mst-lic-type-0)
[205.204516] Starting subtest: dp-mst-lic-type-0
[205.209275] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[205.365173] [041/131] (811s left) syncobj_wait (multi-wait-submitted)
[205.426684] Starting subtest: multi-wait-submitted
[205.527057] Subtest multi-wait-submitted: SUCCESS (0.101s)
[205.600786] [042/131] (811s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[205.705069] Starting subtest: yf-tiled-32bpp-rotate-90
[205.709363] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[205.792605] [043/131] (810s left) perf_pmu (busy-accuracy-50)
[205.833614] Starting subtest: busy-accuracy-50
[205.835419] Starting dynamic subtest: rcs0
[207.368782] Dynamic subtest rcs0: SUCCESS (1.534s)
[207.376830] Starting dynamic subtest: bcs0
[208.913665] Dynamic subtest bcs0: SUCCESS (1.542s)
[208.921614] Starting dynamic subtest: vcs0
[210.454568] Dynamic subtest vcs0: SUCCESS (1.539s)
[210.464330] Starting dynamic subtest: vcs1
[211.996839] Dynamic subtest vcs1: SUCCESS (1.541s)
[212.005040] Starting dynamic subtest: vecs0
[213.538926] Dynamic subtest vecs0: SUCCESS (1.540s)
[213.547238] Starting dynamic subtest: ccs0
[215.084243] Dynamic subtest ccs0: SUCCESS (1.544s)
[215.087129] Subtest busy-accuracy-50: SUCCESS (9.251s)
[215.196563] [044/131] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[215.304626] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[215.308805] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[215.394231] [045/131] (801s left) gem_exec_alignment (pi)
[215.461550] Starting subtest: pi
[266.956623] Subtest pi: SUCCESS (51.486s)
[267.708148] [046/131] (749s left) kms_cursor_crc (cursor-random-32x10)
[267.902301] Starting subtest: cursor-random-32x10
[267.945085] Subtest cursor-random-32x10: SKIP (0.038s)
[268.192335] [047/131] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[268.290773] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[275.489088] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.201s)
[275.597581] [048/131] (741s left) gem_softpin (allocator-nopin-reserve)
[275.663121] Starting subtest: allocator-nopin-reserve
[275.771046] Subtest allocator-nopin-reserve: SUCCESS (0.106s)
[275.885668] [049/131] (741s left) gem_tiled_swapping (non-threaded)
[275.939622] Subtest non-threaded: SKIP (0.000s)
[275.990206] [050/131] (740s left) kms_flip (absolute-wf_vblank-interruptible)
[276.091174] Starting subtest: absolute-wf_vblank-interruptible
[276.093431] Starting dynamic subtest: A-eDP1
[284.890307] Dynamic subtest A-eDP1: SUCCESS (8.798s)
[284.900460] Starting dynamic subtest: B-eDP1
[293.617432] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[293.626084] Starting dynamic subtest: C-eDP1
[302.325612] Dynamic subtest C-eDP1: SUCCESS (8.704s)
[302.334631] Starting dynamic subtest: D-eDP1
[311.051065] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[311.053493] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.962s)
[312.258570] [051/131] (704s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[312.371383] Starting subtest: 4-tiled-32bpp-rotate-0
[314.094504] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.722s)
[314.261027] [052/131] (702s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[314.645457] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[315.459337] [053/131] (701s left) kms_busy (extended-pageflip-hang-newfb)
[315.563357] Starting subtest: extended-pageflip-hang-newfb
[315.565664] Starting dynamic subtest: pipe-A
[341.667450] Dynamic subtest pipe-A: SUCCESS (26.100s)
[341.677959] Starting dynamic subtest: pipe-D
[356.722045] Dynamic subtest pipe-D: SUCCESS (15.053s)
[356.724571] Subtest extended-pageflip-hang-newfb: SUCCESS (41.158s)
[357.520878] [054/131] (659s left) prime_vgem (coherency-blt)
[357.678266] Starting subtest: coherency-blt
[358.807867] Subtest coherency-blt: SUCCESS (1.128s)
[358.943787] [FACT prime_vgem (coherency-blt)] new: kernel.kmod_is_loaded.vgem: true
[358.947256] [055/131] (658s left) api_intel_bb (object-noreloc-purge-cache-simple)
[358.997534] Starting subtest: object-noreloc-purge-cache-simple
[359.002034] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.007s)
[359.145326] [056/131] (658s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[359.233124] Starting subtest: plane-upscale-factor-0-25-with-rotation
[359.235431] Starting dynamic subtest: pipe-A
[359.460949] Dynamic subtest pipe-A: SUCCESS (0.227s)
[359.470622] Starting dynamic subtest: pipe-B
[360.794467] Dynamic subtest pipe-B: SUCCESS (1.333s)
[360.804366] Starting dynamic subtest: pipe-C
[362.123553] Dynamic subtest pipe-C: SUCCESS (1.328s)
[362.133284] Starting dynamic subtest: pipe-D
[363.450537] Dynamic subtest pipe-D: SUCCESS (1.326s)
[363.452899] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.218s)
[364.615515] [057/131] (652s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[364.727051] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[371.153280] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.430s)
[371.283814] [058/131] (645s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[371.397611] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[371.401914] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[371.514754] [059/131] (645s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[371.600357] Starting subtest: primary-yf-tiled-reflect-x-0
[371.673535] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[371.776318] [060/131] (645s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[371.873669] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[371.877872] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[371.988282] [061/131] (645s left) kms_psr (psr-cursor-render)
[372.086228] Starting subtest: psr-cursor-render
[372.088483] Starting dynamic subtest: eDP-1
[373.800972] Dynamic subtest eDP-1: SUCCESS (1.715s)
[373.803452] Subtest psr-cursor-render: SUCCESS (1.716s)
[374.663889] [062/131] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[374.769867] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[381.644723] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SUCCESS (6.877s)
[381.839245] [063/131] (635s left) kms_flip (flip-vs-modeset-vs-hang)
[381.939173] Starting subtest: flip-vs-modeset-vs-hang
[381.941463] Starting dynamic subtest: A-eDP1
[433.449626] Dynamic subtest A-eDP1: SUCCESS (51.508s)
[433.460183] Starting dynamic subtest: D-eDP1
[483.432931] Dynamic subtest D-eDP1: SUCCESS (49.979s)
[483.435442] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.493s)
[483.828079] [064/131] (533s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[483.922407] Starting subtest: psr-dirtyfb-ioctl
[483.924750] Starting dynamic subtest: A-eDP-1
[487.816900] Dynamic subtest A-eDP-1: SUCCESS (3.892s)
[487.819417] Subtest psr-dirtyfb-ioctl: SUCCESS (3.893s)
[488.595052] [065/131] (528s left) kms_pm_rpm (system-suspend-modeset)
[490.141876] Starting subtest: system-suspend-modeset
[510.827736] Subtest system-suspend-modeset: SUCCESS (5.098s)
[514.205366] [066/131] (506s left) kms_plane_alpha_blend (constant-alpha-max)
[514.332082] Starting subtest: constant-alpha-max
[514.759571] Starting dynamic subtest: pipe-A-eDP-1
[515.698114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.942s)
[515.707771] Starting dynamic subtest: pipe-D-eDP-1
[517.269731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.572s)
[517.271918] Subtest constant-alpha-max: SUCCESS (2.943s)
[518.126496] [067/131] (502s left) kms_flip (plain-flip-ts-check-interruptible)
[518.227928] Starting subtest: plain-flip-ts-check-interruptible
[518.230248] Starting dynamic subtest: A-eDP1
[527.115814] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[527.127594] Starting dynamic subtest: B-eDP1
[536.037613] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[536.048368] Starting dynamic subtest: C-eDP1
[544.851611] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[544.860742] Starting dynamic subtest: D-eDP1
[553.674225] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[553.680292] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.474s)
[554.831150] [068/131] (465s left) gem_ctx_persistence (legacy-engines-hostile)
[554.896598] Starting subtest: legacy-engines-hostile
[554.899035] Starting dynamic subtest: render
[555.008270] Dynamic subtest render: SUCCESS (0.110s)
[555.020470] Starting dynamic subtest: bsd1
[555.116592] Dynamic subtest bsd1: SUCCESS (0.106s)
[555.128117] Starting dynamic subtest: bsd2
[555.243719] Dynamic subtest bsd2: SUCCESS (0.125s)
[555.260785] Starting dynamic subtest: blt
[555.342538] Dynamic subtest blt: SUCCESS (0.097s)
[555.354181] Starting dynamic subtest: vebox
[555.444370] Dynamic subtest vebox: SUCCESS (0.100s)
[555.446797] Subtest legacy-engines-hostile: SUCCESS (0.549s)
[555.523203] [069/131] (465s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[555.621960] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[555.624314] Starting dynamic subtest: pipe-A
[556.161961] Dynamic subtest pipe-A: SUCCESS (0.540s)
[556.171867] Starting dynamic subtest: pipe-B
[557.805618] Dynamic subtest pipe-B: SUCCESS (1.644s)
[557.814918] Starting dynamic subtest: pipe-C
[559.423931] Dynamic subtest pipe-C: SUCCESS (1.618s)
[559.434891] Starting dynamic subtest: pipe-D
[561.036792] Dynamic subtest pipe-D: SUCCESS (1.612s)
[561.039232] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (5.417s)
[562.139919] [070/131] (458s left) gem_pread (uncached)
[562.214381] Subtest uncached: SKIP (0.000s)
[562.281274] [071/131] (458s left) kms_cursor_edge_walk (64x64-top-bottom)
[562.380690] Starting subtest: 64x64-top-bottom
[562.383023] Starting dynamic subtest: pipe-A-eDP-1
[565.790067] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.407s)
[565.800691] Starting dynamic subtest: pipe-D-eDP-1
[568.912354] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[568.914486] Subtest 64x64-top-bottom: SUCCESS (6.531s)
[569.717026] [072/131] (451s left) gem_exec_fence (syncobj-timeline-signal)
[570.268713] Starting subtest: syncobj-timeline-signal
[570.275599] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[571.624306] [073/131] (449s left) kms_writeback (writeback-check-output)
[571.732960] Subtest writeback-check-output: SKIP (0.000s)
[571.783796] [074/131] (449s left) gem_exec_schedule (manyslice)
[571.857212] Starting subtest: manyslice
[571.859142] Starting dynamic subtest: rcs0
[576.994602] Dynamic subtest rcs0: SUCCESS (5.147s)
[577.011410] Starting dynamic subtest: bcs0
[583.652394] Dynamic subtest bcs0: SUCCESS (6.658s)
[583.666920] Starting dynamic subtest: vcs0
[589.225011] Dynamic subtest vcs0: SUCCESS (5.573s)
[589.238569] Starting dynamic subtest: vcs1
[594.792998] Dynamic subtest vcs1: SUCCESS (5.569s)
[594.808926] Starting dynamic subtest: vecs0
[600.356419] Dynamic subtest vecs0: SUCCESS (5.563s)
[600.372687] Starting dynamic subtest: ccs0
[606.024973] Dynamic subtest ccs0: SUCCESS (5.668s)
[606.027755] Subtest manyslice: SUCCESS (34.186s)
[606.325680] [075/131] (414s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[606.430496] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[606.434672] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[606.547713] [076/131] (414s left) kms_dsc (dsc-with-output-formats)
[606.640180] Starting subtest: dsc-with-output-formats
[606.662525] Subtest dsc-with-output-formats: SKIP (0.000s)
[606.714468] [077/131] (414s left) i915_pm_rpm (system-suspend-execbuf)
[608.651039] Starting subtest: system-suspend-execbuf
[667.838141] Subtest system-suspend-execbuf: SUCCESS (44.052s)
[668.201596] [078/131] (352s left) kms_psr (pr-sprite-plane-onoff)
[668.292192] Starting subtest: pr-sprite-plane-onoff
[668.296731] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[668.362661] [079/131] (352s left) kms_flip (2x-flip-vs-panning)
[668.461070] Starting subtest: 2x-flip-vs-panning
[668.472245] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[668.603697] [080/131] (352s left) kms_psr (psr-sprite-render)
[668.696826] Starting subtest: psr-sprite-render
[668.699278] Starting dynamic subtest: eDP-1
[670.409363] Dynamic subtest eDP-1: SUCCESS (1.715s)
[670.411581] Subtest psr-sprite-render: SUCCESS (1.715s)
[671.240596] [081/131] (349s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[671.296404] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[671.301198] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[671.476568] [082/131] (349s left) gem_basic (bad-close)
[671.528197] Starting subtest: bad-close
[671.532236] Subtest bad-close: SUCCESS (0.000s)
[671.634658] [083/131] (349s left) gem_exec_reloc (basic-cpu-gtt)
[671.705542] Subtest basic-cpu-gtt: SKIP (0.000s)
[671.769371] [084/131] (349s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[671.859200] Starting subtest: flip-vs-dpms-off-vs-modeset
[671.861469] Starting dynamic subtest: A-eDP1
[675.433567] Dynamic subtest A-eDP1: SUCCESS (3.575s)
[675.442928] Starting dynamic subtest: B-eDP1
[678.593417] Dynamic subtest B-eDP1: SUCCESS (3.160s)
[678.603401] Starting dynamic subtest: C-eDP1
[681.665015] Dynamic subtest C-eDP1: SUCCESS (3.073s)
[681.674922] Starting dynamic subtest: D-eDP1
[684.737897] Dynamic subtest D-eDP1: SUCCESS (3.073s)
[684.740332] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.889s)
[685.533625] [085/131] (335s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[685.591393] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[685.593695] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[685.701144] [086/131] (335s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[685.818272] Starting subtest: cursorA-vs-flipA-atomic
[697.001850] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.179s)
[697.861063] [087/131] (323s left) kms_flip_tiling (flip-change-tiling)
[697.958036] Starting subtest: flip-change-tiling
[697.960338] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[698.171410] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.212s)
[698.187416] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[698.344006] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.170s)
[698.356148] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[698.516436] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s)
[698.534314] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[698.687170] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s)
[698.699301] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[698.873179] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.184s)
[698.884841] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[699.056531] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.182s)
[699.068402] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[699.229256] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.170s)
[699.245909] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[699.379966] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[699.391915] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[699.552421] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s)
[699.563870] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[699.722741] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s)
[699.734387] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[699.893748] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s)
[699.905323] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[700.066565] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.170s)
[700.077582] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[700.238820] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s)
[700.249878] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[700.412007] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s)
[700.424298] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[700.561700] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[700.573903] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[700.758163] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.196s)
[700.770607] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[700.929121] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.170s)
[700.941522] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[701.101300] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.170s)
[701.113407] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[701.275563] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.172s)
[701.286844] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[701.448565] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.171s)
[701.460775] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[701.630974] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.182s)
[701.642793] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[701.786543] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.153s)
[701.798680] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[701.974796] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.187s)
[701.986762] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[702.164817] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.188s)
[702.176189] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[702.340998] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.174s)
[702.352976] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[702.512478] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.170s)
[702.524501] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[702.684725] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.170s)
[702.700415] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[702.860913] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.175s)
[702.872661] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[703.014747] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.151s)
[703.031753] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[703.197184] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.181s)
[703.208390] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[703.370525] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.172s)
[703.382388] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[703.543837] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.172s)
[703.555468] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[703.723504] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.177s)
[703.734692] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[703.908393] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.184s)
[703.920166] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[704.091513] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.181s)
[704.107405] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[704.254888] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.162s)
[704.308282] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[705.528379] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.227s)
[705.540750] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[705.713989] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.183s)
[705.726164] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[705.898402] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.183s)
[705.910650] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[706.085478] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.186s)
[706.098648] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[706.267578] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.182s)
[706.279690] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[706.452715] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.183s)
[706.464906] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[706.624846] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.171s)
[706.637557] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[706.802367] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.147s)
[706.813867] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[706.947547] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s)
[706.964642] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[707.134858] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.185s)
[707.146609] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[707.320314] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.185s)
[707.336577] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[707.491552] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.170s)
[707.503260] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[707.663840] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s)
[707.676222] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[707.837334] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s)
[707.849879] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[707.985882] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[708.000145] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[708.174532] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.187s)
[708.186651] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[708.357248] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.182s)
[708.369384] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[708.532303] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.173s)
[708.544217] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[708.708482] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.173s)
[708.725643] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[708.879889] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.170s)
[708.891853] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[709.063117] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.182s)
[709.074922] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[709.214542] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.150s)
[709.226611] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[709.401434] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.185s)
[709.415280] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[709.589515] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.184s)
[709.600448] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[709.761176] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.173s)
[709.772101] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[709.939410] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.177s)
[709.954616] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[710.124018] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.182s)
[710.135674] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[710.301917] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.176s)
[710.313590] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[710.455699] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.152s)
[710.469200] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[710.644539] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.186s)
[710.656233] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[710.819354] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.173s)
[710.833733] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[710.991393] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.170s)
[711.003595] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[711.163321] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.170s)
[711.174023] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[711.351080] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.186s)
[711.363950] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[711.567635] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.214s)
[711.579965] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[711.736524] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.166s)
[711.786992] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[713.055103] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.274s)
[713.067256] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[713.205728] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[713.217983] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[713.355343] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[713.367841] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[713.529022] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.173s)
[713.540848] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[713.698188] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.166s)
[713.709988] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[713.847278] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.149s)
[713.858850] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[713.996919] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s)
[714.008919] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[714.148188] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s)
[714.160245] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[714.298007] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s)
[714.309977] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[714.446232] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.148s)
[714.458604] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[714.613379] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.166s)
[714.625116] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[714.763918] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.149s)
[714.776048] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[714.914414] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s)
[714.926403] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[715.065527] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.148s)
[715.077191] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[715.214724] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[715.230836] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[715.371000] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.155s)
[715.383567] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[715.522363] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.150s)
[715.534287] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[715.671978] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[715.683548] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[715.822219] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.148s)
[715.832749] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[715.972912] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.148s)
[715.985332] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[716.122575] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[716.135187] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[716.282964] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.159s)
[716.293812] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[716.438362] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.154s)
[716.450298] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[716.595059] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.155s)
[716.606962] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[716.745147] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.148s)
[716.757297] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[716.898914] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.152s)
[716.909429] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[717.048543] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.148s)
[717.059896] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[717.200354] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.150s)
[717.217136] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[717.355819] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.154s)
[717.367923] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[717.516374] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.158s)
[717.528412] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[717.666805] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.149s)
[717.677698] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[717.816912] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.148s)
[717.828918] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[717.977176] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.159s)
[717.989005] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[718.136199] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.158s)
[718.151453] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[718.297536] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.161s)
[718.310268] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[718.467219] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.167s)
[718.508326] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[719.781972] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.280s)
[719.793298] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[719.934812] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.153s)
[719.950441] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[720.101361] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.165s)
[720.117876] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[720.259180] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.157s)
[720.268763] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[720.410697] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.151s)
[720.422466] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[720.563795] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.152s)
[720.574677] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[720.714166] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.149s)
[720.729037] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[720.865847] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.149s)
[720.877649] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[721.014780] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.147s)
[721.026117] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[721.164059] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.147s)
[721.176281] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[721.314667] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.149s)
[721.329611] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[721.476656] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.161s)
[721.492429] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[721.627707] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.149s)
[721.638032] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[721.778011] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.147s)
[721.809607] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[721.927459] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s)
[721.937742] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[722.076135] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[722.088569] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[722.250896] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.174s)
[722.266701] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[722.409224] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.157s)
[722.421965] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[722.559218] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.148s)
[722.570792] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[722.709998] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.148s)
[722.721803] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[722.859933] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s)
[722.871701] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[723.010384] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.150s)
[723.022714] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[723.165417] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.154s)
[723.176786] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[723.319478] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.153s)
[723.336026] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[723.475788] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.155s)
[723.487549] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[723.629475] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.152s)
[723.641293] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[723.784191] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.153s)
[723.795665] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[723.935772] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.151s)
[723.947084] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[724.094017] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.156s)
[724.106560] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[724.261991] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.166s)
[724.274040] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[724.422797] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.159s)
[724.440021] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[724.597589] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.173s)
[724.612982] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[724.769957] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.171s)
[724.782118] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[724.935881] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.164s)
[724.947801] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[725.107513] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.170s)
[725.122226] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[725.280782] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.171s)
[725.314340] Subtest flip-change-tiling: SUCCESS (27.360s)
[726.563946] [088/131] (294s left) prime_self_import (basic-with_one_bo_two_files)
[726.613264] Starting subtest: basic-with_one_bo_two_files
[726.640601] Subtest basic-with_one_bo_two_files: SUCCESS (0.029s)
[726.760007] [089/131] (294s left) gem_create (create-ext-cpu-access-big)
[726.926201] Starting subtest: create-ext-cpu-access-big
[726.930619] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[726.998833] [090/131] (294s left) sw_sync (alloc_fence)
[727.040839] Starting subtest: alloc_fence
[727.043269] Subtest alloc_fence: SUCCESS (0.000s)
[727.097100] [091/131] (294s left) gem_userptr_blits (process-exit-busy)
[727.161154] Starting subtest: process-exit-busy
[727.176287] Subtest process-exit-busy: SUCCESS (0.015s)
[727.315822] [092/131] (294s left) kms_color (ctm-0-75)
[727.416132] Starting subtest: ctm-0-75
[727.418311] Starting dynamic subtest: pipe-A-eDP-1
[732.396001] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.979s)
[732.406018] Starting dynamic subtest: pipe-B-eDP-1
[737.859594] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.465s)
[737.869995] Starting dynamic subtest: pipe-C-eDP-1
[743.100428] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.240s)
[743.112237] Starting dynamic subtest: pipe-D-eDP-1
[748.394414] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.296s)
[748.396865] Subtest ctm-0-75: SUCCESS (20.984s)
[749.235874] [093/131] (272s left) kms_pm_rpm (dpms-lpsp)
[750.774195] Starting subtest: dpms-lpsp
[751.402664] Subtest dpms-lpsp: SUCCESS (0.628s)
[751.488323] [094/131] (270s left) core_getversion (all-cards)
[751.524369] Starting subtest: all-cards
[751.533006] Subtest all-cards: SUCCESS (0.011s)
[751.576333] [095/131] (270s left) gem_ctx_shared (disjoint-timelines)
[751.640415] Starting subtest: disjoint-timelines
[751.670330] Subtest disjoint-timelines: SUCCESS (0.030s)
[751.919129] [096/131] (269s left) perf (i915-ref-count)
[751.998459] Starting subtest: i915-ref-count
[752.070826] Subtest i915-ref-count: SUCCESS (0.070s)
[752.129259] [097/131] (269s left) syncobj_wait (wait-zero-handles)
[752.194595] Starting subtest: wait-zero-handles
[752.197026] Subtest wait-zero-handles: SUCCESS (0.000s)
[752.313556] [098/131] (269s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[752.419258] Starting subtest: fbc-psr2-sprite-mmap-gtt
[752.421183] Starting dynamic subtest: eDP-1
[752.425200] Dynamic subtest eDP-1: SKIP (0.000s)
[752.429189] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[752.496671] [099/131] (269s left) gem_mmap_wc (bad-offset)
[752.551134] Subtest bad-offset: SKIP (0.000s)
[752.623416] [100/131] (269s left) syncobj_wait (wait-any-interrupted)
[752.687439] Starting subtest: wait-any-interrupted
[752.787846] Subtest wait-any-interrupted: SUCCESS (0.102s)
[752.864030] [101/131] (269s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[752.968994] Starting subtest: async-flip-with-page-flip-events-linear
[753.342495] Starting dynamic subtest: pipe-A-eDP-1
[756.124493] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.780s)
[756.486835] Starting dynamic subtest: pipe-B-eDP-1
[759.249384] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s)
[759.611228] Starting dynamic subtest: pipe-C-eDP-1
[762.376435] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[762.744324] Starting dynamic subtest: pipe-D-eDP-1
[765.500572] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[765.503316] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.525s)
[766.686052] [102/131] (255s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[766.791235] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[766.797748] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[766.902550] [103/131] (255s left) gem_flink_basic (bad-flink)
[766.972591] Starting subtest: bad-flink
[766.975015] Subtest bad-flink: SUCCESS (0.000s)
[767.097254] [104/131] (255s left) gem_exec_reloc (basic-wc-noreloc)
[767.157116] Subtest basic-wc-noreloc: SKIP (0.000s)
[767.242015] [105/131] (254s left) gem_mmap_gtt (big-bo)
[767.302678] Subtest big-bo: SKIP (0.000s)
[767.369785] [106/131] (254s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[767.470496] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[767.474919] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[767.587803] [107/131] (254s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[767.653544] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[767.655662] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[767.779422] [108/131] (254s left) prime_vgem (coherency-gtt)
[767.850527] Starting subtest: coherency-gtt
[767.854229] Subtest coherency-gtt: SKIP (0.000s)
[767.944831] [109/131] (254s left) gem_exec_reloc (basic-write-wc-active)
[768.000297] Subtest basic-write-wc-active: SKIP (0.000s)
[768.070930] [110/131] (254s left) kms_cursor_crc (cursor-random-64x21)
[768.244828] Starting subtest: cursor-random-64x21
[768.288500] Subtest cursor-random-64x21: SKIP (0.039s)
[768.537079] [111/131] (253s left) gem_workarounds (suspend-resume-context)
[768.616012] Starting subtest: suspend-resume-context
[785.310156] Subtest suspend-resume-context: SUCCESS (1.574s)
[795.450145] [112/131] (237s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[795.573096] Starting subtest: y-tiled-16bpp-rotate-0
[795.577630] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[795.700266] [113/131] (236s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[795.800687] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[795.803119] Starting dynamic subtest: pipe-A-eDP-1
[829.471445] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.663s)
[829.482093] Starting dynamic subtest: pipe-B-eDP-1
[864.408263] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.325s)
[864.418170] Starting dynamic subtest: pipe-C-eDP-1
[899.352957] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.306s)
[899.362791] Starting dynamic subtest: pipe-D-eDP-1
[934.356529] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.216s)
[934.358955] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (16.514s)
[944.600754] [114/131] ( 97s left) gem_lmem_swapping (basic)
[944.644917] Subtest basic: SKIP (0.000s)
[944.692353] [115/131] ( 96s left) syncobj_timeline (single-wait-all-available-signaled)
[944.751231] Starting subtest: single-wait-all-available-signaled
[944.753696] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[944.872919] [116/131] ( 96s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[944.966727] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[944.969062] Starting dynamic subtest: pipe-A-default-mode
[945.258260] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[945.262991] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.287s)
[946.103602] [117/131] ( 95s left) kms_getfb (getfb2-accept-nv12)
[946.200658] Starting subtest: getfb2-accept-nv12
[946.202986] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[946.307481] [118/131] ( 95s left) gem_mmap_gtt (fault-concurrent-x)
[946.363879] Subtest fault-concurrent-X: SKIP (0.000s)
[946.434315] [119/131] ( 95s left) gem_exec_balancer (invalid-balancer)
[946.499443] Starting subtest: invalid-balancer
[947.394518] Subtest invalid-balancer: SUCCESS (0.893s)
[947.682351] [120/131] ( 94s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[947.787103] Starting subtest: fbc-rgb101010-draw-pwrite
[953.157408] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.373s)
[954.296701] [121/131] ( 87s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[954.402527] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[954.406980] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[954.501908] [122/131] ( 87s left) i915_hangman (detector)
[954.569196] Starting subtest: detector
[954.571121] Starting dynamic subtest: rcs0
[965.750314] Dynamic subtest rcs0: SUCCESS (11.180s)
[965.763230] Starting dynamic subtest: bcs0
[977.783677] Dynamic subtest bcs0: SUCCESS (12.029s)
[977.796718] Starting dynamic subtest: vcs0
[988.726390] Dynamic subtest vcs0: SUCCESS (10.940s)
[988.739186] Starting dynamic subtest: vcs1
[1000.758369] Dynamic subtest vcs1: SUCCESS (12.029s)
[1000.776541] Starting dynamic subtest: vecs0
[1012.727112] Dynamic subtest vecs0: SUCCESS (11.961s)
[1012.738908] Starting dynamic subtest: ccs0
[1024.758501] Dynamic subtest ccs0: SUCCESS (12.018s)
[1024.761920] Subtest detector: SUCCESS (70.169s)
[1024.878435] [123/131] ( 17s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[1025.439222] Starting subtest: syncobj-backward-timeline-chain-engines
[1025.641547] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.202s)
[1026.873432] [124/131] ( 15s left) perf (oa-exponents)
[1026.953423] Starting subtest: oa-exponents
[1026.955662] Starting dynamic subtest: 0-rcs0
[1028.837433] Dynamic subtest 0-rcs0: SUCCESS (1.881s)
[1028.847545] Starting dynamic subtest: 1-vecs0
[1030.778739] Dynamic subtest 1-vecs0: SUCCESS (1.940s)
[1030.780972] Subtest oa-exponents: SUCCESS (3.822s)
[1030.829035] [125/131] ( 11s left) gem_partial_pwrite_pread (reads)
[1030.888066] Subtest reads: SKIP (0.000s)
[1030.972529] [126/131] ( 11s left) gem_mmap_gtt (basic-write-gtt)
[1031.023359] Subtest basic-write-gtt: SKIP (0.000s)
[1031.087511] [127/131] ( 11s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[1031.197734] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[1031.202164] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[1031.309973] [128/131] ( 10s left) gem_vm_create (isolation)
[1031.360379] Starting subtest: isolation
[1031.368781] Subtest isolation: SUCCESS (0.008s)
[1031.514028] [129/131] ( 10s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[1031.608324] Starting subtest: psr-2p-pri-indfb-multidraw
[1031.612704] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[1031.715871] [130/131] ( 10s left) kms_psr (fbc-pr-dpms)
[1031.805623] Starting subtest: fbc-pr-dpms
[1031.808933] Subtest fbc-pr-dpms: SKIP (0.000s)
[1031.875946] [131/131] ( 10s left) syncobj_timeline (wait-all-interrupted)
[1031.922053] Starting subtest: wait-all-interrupted
[1032.023206] Subtest wait-all-interrupted: SUCCESS (0.101s)
[1032.096519] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_universal_plane
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_ctx_param
results: parsing output: 10/ for test: intel_hwmon
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: gem_ctx_exec
results: parsing output: 17/ for test: gem_gtt_cpu_tlb
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: i915_module_load
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: dumb_buffer
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_color
results: parsing output: 25/ for test: gem_exec_store
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_joiner
results: parsing output: 31/ for test: kms_plane_multiple
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_spin_batch
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: gem_mmap
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: kms_content_protection
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_alignment
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: gem_tiled_swapping
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_busy
results: parsing output: 53/ for test: prime_vgem
results: parsing output: 54/ for test: api_intel_bb
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_dirtyfb
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_pread
results: parsing output: 70/ for test: kms_cursor_edge_walk
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_writeback
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_dsc
results: parsing output: 76/ for test: i915_pm_rpm
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: gem_basic
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_flip_tiling
results: parsing output: 87/ for test: prime_self_import
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: core_getversion
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_flink_basic
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_workarounds
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: i915_hangman
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: perf
results: parsing output: 124/ for test: gem_partial_pwrite_pread
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_vm_create
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
Done.