[59.961718] Initializing watchdogs
[59.961762]   /dev/watchdog0
[59.975885] [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]
[59.980586] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.983420] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.986744] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[60.116206] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[60.120199] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[60.221786] [002/133] (960s left) gem_ppgtt (blt-vs-render-ctxn)
[60.285902] Starting subtest: blt-vs-render-ctxN
[93.135971] Subtest blt-vs-render-ctxN: SUCCESS (32.869s)
[93.273905] [003/133] (927s left) kms_async_flips (test-cursor)
[93.406697] Starting subtest: test-cursor
[94.515066] Starting dynamic subtest: pipe-A-eDP-1
[94.942723] Dynamic subtest pipe-A-eDP-1: SKIP (0.426s)
[95.315369] Starting dynamic subtest: pipe-B-eDP-1
[96.070549] Dynamic subtest pipe-B-eDP-1: SKIP (0.758s)
[96.439576] Starting dynamic subtest: pipe-C-eDP-1
[97.197366] Dynamic subtest pipe-C-eDP-1: SKIP (0.760s)
[97.555942] Starting dynamic subtest: pipe-D-eDP-1
[98.329803] Dynamic subtest pipe-D-eDP-1: SKIP (0.777s)
[98.334139] Subtest test-cursor: SKIP (4.922s)
[99.509431] [004/133] (921s left) kms_invalid_mode (uint-max-clock)
[99.611641] Starting subtest: uint-max-clock
[99.613877] Starting dynamic subtest: pipe-A-eDP-1
[99.895078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[99.903809] Starting dynamic subtest: pipe-B-eDP-1
[99.905946] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[99.912947] Starting dynamic subtest: pipe-C-eDP-1
[99.914940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[99.922393] Starting dynamic subtest: pipe-D-eDP-1
[99.924692] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[99.927074] Subtest uint-max-clock: SUCCESS (0.291s)
[100.742168] [005/133] (919s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[100.832691] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[100.836897] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[100.930174] [006/133] (919s left) syncobj_wait (multi-wait-submitted)
[100.991680] Starting subtest: multi-wait-submitted
[101.098210] Subtest multi-wait-submitted: SUCCESS (0.104s)
[101.171853] [007/133] (919s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[101.268950] Starting subtest: y-tiled-8bpp-rotate-270
[101.273375] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[101.387327] [008/133] (919s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[101.765982] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[102.586325] [009/133] (918s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[102.655889] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[102.761844] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[102.843665] [010/133] (918s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[102.940737] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[102.945253] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[103.042717] [011/133] (917s left) gem_eio (create)
[103.292836] Starting subtest: create
[103.646416] Subtest create: SUCCESS (0.355s)
[103.785663] [012/133] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[103.886821] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[103.890446] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[103.981640] [013/133] (917s left) kms_rotation_crc (primary-rotation-270)
[104.085204] Starting subtest: primary-rotation-270
[104.089076] Subtest primary-rotation-270: SKIP (0.001s)
[104.156408] [014/133] (916s left) kms_cursor_edge_walk (64x64-left-edge)
[104.245146] Starting subtest: 64x64-left-edge
[104.247206] Starting dynamic subtest: pipe-A-eDP-1
[107.750279] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[107.759389] Starting dynamic subtest: pipe-D-eDP-1
[110.873425] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[110.875666] Subtest 64x64-left-edge: SUCCESS (6.627s)
[111.671089] [015/133] (909s left) kms_frontbuffer_tracking (fbc-2p-rte)
[111.784757] Starting subtest: fbc-2p-rte
[111.789108] Subtest fbc-2p-rte: SKIP (0.000s)
[111.875808] [016/133] (909s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[111.964379] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[111.966710] Starting dynamic subtest: pipe-A-eDP-1
[112.026432] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[112.036062] Starting dynamic subtest: pipe-B-eDP-1
[112.093837] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[112.104647] Starting dynamic subtest: pipe-C-eDP-1
[112.163860] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[112.173524] Starting dynamic subtest: pipe-D-eDP-1
[112.230725] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[112.234886] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[114.237903] [017/133] (906s left) kms_psr (psr2-cursor-mmap-cpu)
[114.329939] Starting subtest: psr2-cursor-mmap-cpu
[114.332291] Starting dynamic subtest: eDP-1
[116.030830] Dynamic subtest eDP-1: SUCCESS (1.700s)
[116.033172] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.701s)
[116.922203] [018/133] (904s left) kms_addfb_basic (invalid-set-prop-any)
[116.978825] Starting subtest: invalid-set-prop-any
[116.980960] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[117.106014] [019/133] (904s left) gem_eio (unwedge-stress)
[117.354589] Starting subtest: unwedge-stress
[117.357088] Starting dynamic subtest: render
[122.549608] Dynamic subtest render: SUCCESS (5.193s)
[122.565516] Starting dynamic subtest: bsd1
[149.979213] Dynamic subtest bsd1: SUCCESS (27.427s)
[149.993488] Starting dynamic subtest: bsd2
[185.929259] Dynamic subtest bsd2: SUCCESS (35.947s)
[185.943846] Starting dynamic subtest: blt
[185.947875] Dynamic subtest blt: SKIP (0.000s)
[185.956136] Starting dynamic subtest: vebox
[215.938225] Dynamic subtest vebox: SUCCESS (30.007s)
[215.940377] Subtest unwedge-stress: SUCCESS (98.578s)
[217.991099] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[217.994691] [020/133] (803s left) gem_mmap_gtt (big-copy-odd)
[218.060207] Subtest big-copy-odd: SKIP (0.000s)
[218.122812] [021/133] (803s left) gem_ctx_persistence (processes)
[218.186768] Starting subtest: processes
[219.883702] Subtest processes: SUCCESS (1.696s)
[219.975927] [022/133] (801s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[220.075846] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[220.077952] Starting dynamic subtest: pipe-A-eDP-1
[220.173565] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[220.184388] Starting dynamic subtest: pipe-B-eDP-1
[221.379253] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[221.383990] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.305s)
[222.575739] [023/133] (798s left) kms_psr (psr-sprite-plane-move)
[222.672669] Starting subtest: psr-sprite-plane-move
[222.675013] Starting dynamic subtest: eDP-1
[224.409326] Dynamic subtest eDP-1: SUCCESS (1.737s)
[224.411656] Subtest psr-sprite-plane-move: SUCCESS (1.738s)
[225.224442] [024/133] (796s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[225.318406] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[225.322968] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[225.391560] [025/133] (796s left) kms_draw_crc (draw-method-mmap-cpu)
[225.477996] Starting subtest: draw-method-mmap-cpu
[225.480256] Starting dynamic subtest: xrgb8888-untiled
[225.719892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[225.728367] Starting dynamic subtest: rgb565-untiled
[225.931028] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[225.939314] Starting dynamic subtest: xrgb2101010-untiled
[226.142238] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[226.151628] Starting dynamic subtest: xbgr16161616f-untiled
[226.375219] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[226.384067] Starting dynamic subtest: xrgb8888-xtiled
[226.508496] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[226.517016] Starting dynamic subtest: rgb565-xtiled
[226.641827] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[226.649917] Starting dynamic subtest: xrgb2101010-xtiled
[226.766477] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[226.775417] Starting dynamic subtest: xbgr16161616f-xtiled
[226.897472] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[226.906249] Starting dynamic subtest: xrgb8888-4tiled
[227.052809] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[227.061416] Starting dynamic subtest: rgb565-4tiled
[227.197343] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[227.205080] Starting dynamic subtest: xrgb2101010-4tiled
[227.330897] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[227.338912] Starting dynamic subtest: xbgr16161616f-4tiled
[227.475147] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[227.477096] Subtest draw-method-mmap-cpu: SUCCESS (2.000s)
[227.570951] [026/133] (793s left) gem_flink_basic (double-flink)
[227.623993] Starting subtest: double-flink
[227.625705] Subtest double-flink: SUCCESS (0.000s)
[227.705429] [027/133] (793s left) kms_lease (master-vs-lease)
[227.790395] Starting subtest: master-vs-lease
[227.792201] Subtest master-vs-lease: SUCCESS (0.002s)
[227.893301] [028/133] (793s left) gem_exec_fence (syncobj-timeline-chain-engines)
[228.429544] Starting subtest: syncobj-timeline-chain-engines
[228.552212] Subtest syncobj-timeline-chain-engines: SUCCESS (0.123s)
[229.992188] [029/133] (791s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[230.126086] Starting subtest: cursorA-vs-flipB-toggle
[230.130393] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[230.271802] [030/133] (791s left) gem_ccs (block-copy-uncompressed)
[230.336944] Starting subtest: block-copy-uncompressed
[230.338993] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[230.358052] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[230.367817] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[230.380296] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.021s)
[230.388479] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[230.397072] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[230.405146] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[230.415131] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[230.417431] Subtest block-copy-uncompressed: SUCCESS (0.081s)
[230.533775] [031/133] (791s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[230.597812] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[230.663113] [032/133] (791s left) syncobj_timeline (wait-all-interrupted)
[230.727164] Starting subtest: wait-all-interrupted
[230.828831] Subtest wait-all-interrupted: SUCCESS (0.102s)
[230.910450] [033/133] (790s left) i915_pm_rps (thresholds-idle-park)
[230.980359] Starting subtest: thresholds-idle-park
[230.985071] Subtest thresholds-idle-park: SKIP (0.001s)
[231.082250] [034/133] (790s left) kms_content_protection (content-type-change)
[231.232068] Starting subtest: content-type-change
[231.236815] Subtest content-type-change: SKIP (0.000s)
[231.359281] [035/133] (790s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[231.452778] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[231.456837] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[231.524593] [036/133] (790s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[231.630311] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[231.634287] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[231.697017] [037/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[231.803208] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[231.807199] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[231.921778] [038/133] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[232.028241] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[238.827323] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.802s)
[238.945312] [039/133] (783s left) kms_flip (plain-flip-ts-check)
[239.049311] Starting subtest: plain-flip-ts-check
[239.051488] Starting dynamic subtest: A-eDP1
[247.963568] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[247.974474] Starting dynamic subtest: B-eDP1
[256.798545] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[256.811886] Starting dynamic subtest: C-eDP1
[265.616691] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[265.629727] Starting dynamic subtest: D-eDP1
[274.454115] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[274.459177] Subtest plain-flip-ts-check: SUCCESS (35.412s)
[275.634463] [040/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[275.736150] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[282.385488] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.650s)
[282.511837] [041/133] (739s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[282.603191] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[282.605469] Starting dynamic subtest: pipe-A
[282.668121] Dynamic subtest pipe-A: SUCCESS (0.065s)
[282.678798] Starting dynamic subtest: pipe-B
[283.801671] Dynamic subtest pipe-B: SUCCESS (1.132s)
[283.811668] Starting dynamic subtest: pipe-C
[284.916604] Dynamic subtest pipe-C: SUCCESS (1.113s)
[284.926188] Starting dynamic subtest: pipe-D
[286.051048] Dynamic subtest pipe-D: SUCCESS (1.134s)
[286.053322] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s)
[287.210136] [042/133] (734s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[287.265401] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[287.267300] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[287.353595] [043/133] (734s left) gem_readwrite (beyond-eob)
[287.406953] Subtest beyond-EOB: SKIP (0.000s)
[287.469318] [044/133] (734s left) gem_eio (in-flight-10ms)
[287.702883] Starting subtest: in-flight-10ms
[295.778422] Subtest in-flight-10ms: SUCCESS (8.073s)
[295.912509] [045/133] (726s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[296.000056] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[296.002176] Starting dynamic subtest: pipe-A-default-mode
[297.155602] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[297.159596] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.155s)
[297.303110] [046/133] (725s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[297.367632] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[297.369614] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[297.478956] [047/133] (724s left) kms_addfb_basic (addfb25-modifier-no-flag)
[297.575202] Starting subtest: addfb25-modifier-no-flag
[297.577088] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[297.696784] [048/133] (724s left) gem_exec_reloc (basic-active)
[297.759380] Subtest basic-active: SKIP (0.000s)
[297.827227] [049/133] (724s left) kms_color (ctm-green-to-red)
[297.923051] Starting subtest: ctm-green-to-red
[297.925325] Starting dynamic subtest: pipe-A-eDP-1
[298.635825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[298.650200] Starting dynamic subtest: pipe-B-eDP-1
[300.017923] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[300.027199] Starting dynamic subtest: pipe-C-eDP-1
[301.407519] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[301.420050] Starting dynamic subtest: pipe-D-eDP-1
[302.724446] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[302.726680] Subtest ctm-green-to-red: SUCCESS (4.801s)
[303.535845] [050/133] (718s left) kms_plane_lowres (tiling-y)
[303.626154] Starting subtest: tiling-y
[303.630414] Subtest tiling-y: SKIP (0.000s)
[303.706985] [051/133] (718s left) prime_mmap (test_refcounting)
[303.760847] Starting subtest: test_refcounting
[303.763018] Starting dynamic subtest: test_refcounting-smem
[303.792518] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[303.794889] Subtest test_refcounting: SUCCESS (0.034s)
[303.888406] [052/133] (718s left) perf_pmu (busy-start)
[303.931229] Starting subtest: busy-start
[303.933670] Starting dynamic subtest: rcs0
[306.482566] Dynamic subtest rcs0: SUCCESS (2.552s)
[306.497085] Starting dynamic subtest: bcs0
[309.033929] Dynamic subtest bcs0: SUCCESS (2.549s)
[309.046250] Starting dynamic subtest: vcs0
[312.917327] Dynamic subtest vcs0: SUCCESS (3.880s)
[312.929067] Starting dynamic subtest: vcs1
[316.886965] Dynamic subtest vcs1: SUCCESS (3.967s)
[316.899090] Starting dynamic subtest: vecs0
[320.917800] Dynamic subtest vecs0: SUCCESS (4.028s)
[320.929337] Starting dynamic subtest: ccs0
[323.468813] Dynamic subtest ccs0: SUCCESS (2.550s)
[323.471527] Subtest busy-start: SUCCESS (19.538s)
[323.572968] [053/133] (699s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[323.679024] Starting subtest: primary-y-tiled-reflect-x-180
[323.739080] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[323.843544] [054/133] (698s left) gem_lmem_swapping (parallel-random-engines)
[323.887391] Subtest parallel-random-engines: SKIP (0.000s)
[323.931280] [055/133] (698s left) kms_cursor_crc (cursor-offscreen-256x256)
[324.189808] Starting subtest: cursor-offscreen-256x256
[324.194693] Starting dynamic subtest: pipe-A-eDP-1
[326.139762] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[326.168664] Starting dynamic subtest: pipe-D-eDP-1
[328.757306] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.595s)
[328.759469] Subtest cursor-offscreen-256x256: SUCCESS (4.566s)
[329.594091] [056/133] (693s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[329.703408] Starting subtest: 4-tiled-32bpp-rotate-270
[329.723068] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[329.866717] [057/133] (692s left) gem_exec_reloc (basic-range)
[329.925702] Subtest basic-range: SKIP (0.000s)
[330.008295] [058/133] (692s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[330.122891] Starting subtest: basic-flip-after-cursor-atomic
[331.033510] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[331.823326] [059/133] (691s left) gem_exec_whisper (basic-contexts-forked-all)
[331.903821] Starting subtest: basic-contexts-forked-all
[354.935060] Subtest basic-contexts-forked-all: SUCCESS (23.029s)
[355.123235] [060/133] (667s left) kms_pm_rpm (fences)
[357.065342] Starting subtest: fences
[357.072136] Subtest fences: SKIP (0.000s)
[357.443494] [061/133] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[357.535224] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[357.539316] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[357.642336] [062/133] (665s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[357.740289] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[366.562371] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.825s)
[366.679333] [063/133] (656s left) kms_psr (fbc-psr2-sprite-plane-move)
[366.777252] Starting subtest: fbc-psr2-sprite-plane-move
[366.779515] Starting dynamic subtest: eDP-1
[366.783660] Dynamic subtest eDP-1: SKIP (0.000s)
[366.787827] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[366.854007] [064/133] (656s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[366.952947] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[374.413548] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.463s)
[374.549516] [065/133] (648s left) perf_pmu (frequency)
[374.594328] Starting subtest: frequency
[374.596512] Starting dynamic subtest: gt0
[376.747072] Dynamic subtest gt0: SUCCESS (2.145s)
[376.758339] Starting dynamic subtest: idle-gt0
[377.252829] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[377.264386] Starting dynamic subtest: gt1
[381.910572] Dynamic subtest gt1: SUCCESS (4.654s)
[381.921728] Starting dynamic subtest: idle-gt1
[382.415156] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[382.417788] Subtest frequency: SUCCESS (7.824s)
[382.508274] [066/133] (640s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[382.632134] Starting subtest: plane-downscale-factor-0-5-with-rotation
[382.634518] Starting dynamic subtest: pipe-A
[382.653209] Dynamic subtest pipe-A: SKIP (0.017s)
[382.663437] Starting dynamic subtest: pipe-B
[382.683320] Dynamic subtest pipe-B: SKIP (0.030s)
[382.692974] Starting dynamic subtest: pipe-C
[382.714541] Dynamic subtest pipe-C: SKIP (0.030s)
[382.725319] Starting dynamic subtest: pipe-D
[382.743099] Dynamic subtest pipe-D: SKIP (0.030s)
[382.746822] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.109s)
[382.854194] [067/133] (640s left) kms_atomic_interruptible (universal-setplane-cursor)
[382.941915] Starting subtest: universal-setplane-cursor
[382.944116] Starting dynamic subtest: pipe-A-eDP-1
[390.331274] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.388s)
[390.333541] Subtest universal-setplane-cursor: SUCCESS (7.389s)
[391.185548] [068/133] (632s left) syncobj_wait (single-wait-for-submit-submitted)
[391.242560] Starting subtest: single-wait-for-submit-submitted
[391.344888] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[391.422742] [069/133] (631s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[391.525160] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[391.529501] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[391.643868] [070/133] (631s left) syncobj_wait (single-wait-signaled)
[391.699853] Starting subtest: single-wait-signaled
[391.702070] Subtest single-wait-signaled: SUCCESS (0.000s)
[391.814346] [071/133] (631s left) gem_ppgtt (shrink-vs-evict-pinned)
[391.891953] Starting subtest: shrink-vs-evict-pinned
[397.868852] Subtest shrink-vs-evict-pinned: SUCCESS (5.978s)
[397.956028] [072/133] (625s left) gem_mmap_offset (partial-remap)
[398.018217] Starting subtest: partial-remap
[398.020121] Starting dynamic subtest: smem0
[398.028302] Dynamic subtest smem0: SUCCESS (0.005s)
[398.030175] Subtest partial-remap: SUCCESS (0.006s)
[398.122722] [073/133] (625s left) gem_sync (basic-store-each)
[398.187062] Starting subtest: basic-store-each
[400.876706] Subtest basic-store-each: SUCCESS (2.699s)
[401.072010] [074/133] (622s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[401.175051] Starting subtest: yf-tiled-16bpp-rotate-270
[401.179701] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[401.275722] [075/133] (622s left) kms_psr (psr2-primary-blt)
[401.373925] Starting subtest: psr2-primary-blt
[401.376082] Starting dynamic subtest: eDP-1
[403.061966] Dynamic subtest eDP-1: SUCCESS (1.687s)
[403.064557] Subtest psr2-primary-blt: SUCCESS (1.688s)
[403.935525] [076/133] (619s left) kms_chamelium_color (ctm-red-to-blue)
[404.037752] Subtest ctm-red-to-blue: SKIP (0.000s)
[404.085270] [077/133] (619s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[404.191685] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[411.578170] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.388s)
[411.711380] [078/133] (612s left) kms_cursor_legacy (single-bo)
[411.838338] Starting subtest: single-bo
[411.840477] Starting dynamic subtest: pipe-A
[417.220309] Dynamic subtest pipe-A: SUCCESS (5.378s)
[417.231883] Starting dynamic subtest: pipe-B
[422.602537] Dynamic subtest pipe-B: SUCCESS (5.379s)
[422.614468] Starting dynamic subtest: pipe-C
[427.984373] Dynamic subtest pipe-C: SUCCESS (5.379s)
[427.996523] Starting dynamic subtest: pipe-D
[433.365595] Dynamic subtest pipe-D: SUCCESS (5.378s)
[433.377136] Starting dynamic subtest: all-pipes
[438.757520] Dynamic subtest all-pipes: SUCCESS (5.389s)
[438.759905] Subtest single-bo: SUCCESS (26.917s)
[438.911774] [079/133] (584s left) gem_exec_balancer (individual)
[438.973577] Starting subtest: individual
[440.927457] Subtest individual: SUCCESS (1.952s)
[441.238543] [080/133] (582s left) kms_chamelium_audio (dp-audio-edid)
[441.626732] Subtest dp-audio-edid: SKIP (0.000s)
[442.444139] [081/133] (581s left) gem_mmap_gtt (cpuset-big-copy)
[442.507319] Subtest cpuset-big-copy: SKIP (0.000s)
[442.566384] [082/133] (581s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[442.625910] Starting subtest: yf-tiled-ccs-to-x-tiled
[442.629857] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[442.824382] [083/133] (581s left) kms_big_fb (linear-64bpp-rotate-270)
[442.924808] Starting subtest: linear-64bpp-rotate-270
[442.943871] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[443.072523] [084/133] (580s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[443.171777] Starting subtest: fbcpsr-shrfb-scaledprimary
[448.964373] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.795s)
[449.093429] [085/133] (574s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[449.190057] Starting subtest: fbcpsr-2p-rte
[449.196837] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[449.282322] [086/133] (574s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[449.400502] Starting subtest: cursor-vs-flip-atomic-transitions
[479.449891] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.048s)
[480.316389] [087/133] (543s left) gem_exec_schedule (semaphore-resolve)
[480.392421] Starting subtest: semaphore-resolve
[480.431809] Subtest semaphore-resolve: SUCCESS (0.044s)
[480.759946] [088/133] (543s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[480.850047] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[480.852306] Starting dynamic subtest: pipe-A-eDP-1
[480.876399] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.886810] Starting dynamic subtest: pipe-B-eDP-1
[480.907931] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.916966] Starting dynamic subtest: pipe-C-eDP-1
[480.938605] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.947681] Starting dynamic subtest: pipe-D-eDP-1
[480.969807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.973974] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[483.174456] [089/133] (541s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[483.277791] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[483.282275] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[483.363386] [090/133] (540s left) gem_exec_schedule (in-order)
[483.425959] Starting subtest: in-order
[483.428060] Starting dynamic subtest: rcs0
[483.521756] Dynamic subtest rcs0: SUCCESS (0.101s)
[483.534417] Starting dynamic subtest: vcs0
[483.611823] Dynamic subtest vcs0: SUCCESS (0.088s)
[483.624039] Starting dynamic subtest: vcs1
[483.694211] Dynamic subtest vcs1: SUCCESS (0.081s)
[483.706849] Starting dynamic subtest: vecs0
[483.780343] Dynamic subtest vecs0: SUCCESS (0.085s)
[483.792971] Starting dynamic subtest: ccs0
[483.874037] Dynamic subtest ccs0: SUCCESS (0.093s)
[483.877223] Subtest in-order: SUCCESS (0.454s)
[485.001540] [091/133] (539s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[485.097301] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[485.101745] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[486.206379] [092/133] (538s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[486.297139] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[486.301384] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[486.372099] [093/133] (538s left) i915_drm_fdinfo (memory-info-resident)
[486.418071] Starting subtest: memory-info-resident
[486.420283] Starting dynamic subtest: smem0
[489.072653] Dynamic subtest smem0: SUCCESS (2.655s)
[489.075304] Subtest memory-info-resident: SUCCESS (2.656s)
[489.149700] [094/133] (535s left) gem_exec_reloc (basic-cpu-noreloc)
[489.211236] Subtest basic-cpu-noreloc: SKIP (0.000s)
[489.300127] [095/133] (535s left) gem_exec_balancer (parallel-keep-submit-fence)
[489.567809] Starting subtest: parallel-keep-submit-fence
[490.799621] Subtest parallel-keep-submit-fence: SUCCESS (1.232s)
[490.906443] [096/133] (533s left) kms_atomic_interruptible (legacy-pageflip)
[490.999805] Starting subtest: legacy-pageflip
[491.002040] Starting dynamic subtest: pipe-A-eDP-1
[498.430389] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.429s)
[498.432612] Subtest legacy-pageflip: SUCCESS (7.430s)
[499.272589] [097/133] (525s left) kms_cursor_crc (cursor-random-512x170)
[499.563843] Starting subtest: cursor-random-512x170
[499.567809] Subtest cursor-random-512x170: SKIP (0.001s)
[499.709582] [098/133] (524s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[499.810186] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[499.812400] Starting dynamic subtest: pipe-A-eDP-1
[511.120743] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.313s)
[511.130861] Starting dynamic subtest: pipe-B-eDP-1
[523.181345] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.061s)
[523.183581] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.377s)
[524.028673] [099/133] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[524.149154] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[524.153162] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[524.244592] [100/133] (500s left) kms_psr (fbc-pr-sprite-plane-move)
[524.347274] Starting subtest: fbc-pr-sprite-plane-move
[524.351573] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[524.421309] [101/133] (500s left) kms_async_flips (alternate-sync-async-flip-atomic)
[524.501745] Starting subtest: alternate-sync-async-flip-atomic
[524.888811] Starting dynamic subtest: pipe-A-eDP-1
[527.638469] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[528.023056] Starting dynamic subtest: pipe-B-eDP-1
[530.765392] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[531.161727] Starting dynamic subtest: pipe-C-eDP-1
[533.907502] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[534.273908] Starting dynamic subtest: pipe-D-eDP-1
[537.034740] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[537.036741] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.535s)
[538.208359] [102/133] (486s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[538.289456] Subtest writes-after-reads-uncached: SKIP (0.000s)
[538.369945] [103/133] (486s left) gen9_exec_parse (bb-secure)
[538.438919] Subtest bb-secure: SKIP (0.000s)
[538.507965] [104/133] (486s left) gem_userptr_blits (sd-probe)
[538.576731] Starting subtest: sd-probe
[538.578664] Subtest sd-probe: SUCCESS (0.000s)
[538.716953] [105/133] (486s left) kms_prop_blob (basic)
[538.771962] Starting subtest: basic
[538.774560] Subtest basic: SUCCESS (0.000s)
[538.865693] [106/133] (486s left) i915_pm_freq_api (freq-reset)
[538.921555] Starting subtest: freq-reset
[538.923797] Starting dynamic subtest: gt0
[539.113939] Dynamic subtest gt0: SUCCESS (0.191s)
[539.124613] Starting dynamic subtest: gt1
[539.295674] Dynamic subtest gt1: SUCCESS (0.181s)
[539.298081] Subtest freq-reset: SUCCESS (0.374s)
[539.380507] [107/133] (485s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[539.481422] Starting subtest: x-tiled-8bpp-rotate-180
[540.739578] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[540.851180] [108/133] (484s left) gem_exec_reloc (basic-cpu-gtt-active)
[540.918824] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[540.984704] [109/133] (484s left) gem_eio (wait-immediate)
[541.222828] Starting subtest: wait-immediate
[541.636697] Subtest wait-immediate: SUCCESS (0.415s)
[541.786450] [110/133] (483s left) api_intel_bb (purge-bb)
[541.850065] Starting subtest: purge-bb
[541.854459] Subtest purge-bb: SUCCESS (0.004s)
[541.967414] [111/133] (483s left) gem_ctx_bad_destroy (invalid-pad)
[542.016318] Starting subtest: invalid-pad
[542.018106] Subtest invalid-pad: SUCCESS (0.000s)
[542.095041] [112/133] (483s left) i915_pm_rpm (gem-idle)
[544.016365] Starting subtest: gem-idle
[550.221733] Subtest gem-idle: SUCCESS (6.208s)
[550.556698] [113/133] (474s left) kms_universal_plane (cursor-fb-leak)
[551.901959] Starting subtest: cursor-fb-leak
[551.903853] Starting dynamic subtest: pipe-A-eDP-1
[552.252125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.351s)
[552.264058] Starting dynamic subtest: pipe-B-eDP-1
[553.598679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s)
[553.612200] Starting dynamic subtest: pipe-C-eDP-1
[555.000743] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[555.015852] Starting dynamic subtest: pipe-D-eDP-1
[556.353358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[556.355615] Subtest cursor-fb-leak: SUCCESS (4.454s)
[557.522351] [114/133] (467s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[557.579490] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[557.680632] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[557.758765] [115/133] (467s left) gem_ctx_persistence (engines-cleanup)
[557.818541] Starting subtest: engines-cleanup
[557.820819] Starting dynamic subtest: rcs0
[557.913135] Dynamic subtest rcs0: SUCCESS (0.094s)
[557.926076] Starting dynamic subtest: bcs0
[557.936404] Dynamic subtest bcs0: SUCCESS (0.022s)
[557.945845] Starting dynamic subtest: vcs0
[557.998518] Dynamic subtest vcs0: SUCCESS (0.061s)
[558.011732] Starting dynamic subtest: vcs1
[558.064574] Dynamic subtest vcs1: SUCCESS (0.064s)
[558.075644] Starting dynamic subtest: vecs0
[558.127660] Dynamic subtest vecs0: SUCCESS (0.061s)
[558.138619] Starting dynamic subtest: ccs0
[558.162362] Dynamic subtest ccs0: SUCCESS (0.033s)
[558.164599] Subtest engines-cleanup: SUCCESS (0.346s)
[558.242887] [116/133] (467s left) gem_mmap_gtt (basic-write)
[558.300805] Subtest basic-write: SKIP (0.000s)
[558.356834] [117/133] (467s left) drm_mm (drm_mm)
[558.393539] Starting subtest: drm_mm
[558.463586] Starting dynamic subtest: drm_test_mm_init
[558.566717] Dynamic subtest drm_test_mm_init: SUCCESS (0.102s)
[558.577372] Starting dynamic subtest: drm_test_mm_debug
[558.662600] Dynamic subtest drm_test_mm_debug: SUCCESS (0.095s)
[558.673040] Starting dynamic subtest: drm_test_mm_align32
[558.778866] Dynamic subtest drm_test_mm_align32: SUCCESS (0.114s)
[558.789882] Starting dynamic subtest: drm_test_mm_align64
[558.870036] Dynamic subtest drm_test_mm_align64: SUCCESS (0.091s)
[558.880543] Starting dynamic subtest: drm_test_mm_lowest
[558.970428] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.099s)
[558.981307] Starting dynamic subtest: drm_test_mm_highest
[559.060044] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s)
[559.062311] Subtest drm_mm: SUCCESS (0.668s)
[559.207304] [118/133] (466s left) gem_create (hog-create)
[559.267696] Starting subtest: hog-create
[559.269975] Starting dynamic subtest: smem0
[592.862080] Dynamic subtest smem0: SUCCESS (33.590s)
[592.864909] Subtest hog-create: SUCCESS (33.592s)
[593.049525] [119/133] (432s left) gem_flink_basic (flink-lifetime)
[593.106081] Starting subtest: flink-lifetime
[593.111164] Subtest flink-lifetime: SUCCESS (0.004s)
[593.218495] [120/133] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[593.329869] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[593.334196] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[593.410466] [121/133] (432s left) kms_hdr (invalid-metadata-sizes)
[593.512323] Starting subtest: invalid-metadata-sizes
[593.519104] Subtest invalid-metadata-sizes: SKIP (0.000s)
[593.585491] [122/133] (432s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[593.671166] Starting subtest: crc-primary-basic-yf-tiled-ccs
[593.673509] Starting dynamic subtest: pipe-A-eDP-1
[593.696320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[593.707084] Starting dynamic subtest: pipe-B-eDP-1
[593.729065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[593.737804] Starting dynamic subtest: pipe-C-eDP-1
[593.759608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[593.768489] Starting dynamic subtest: pipe-D-eDP-1
[593.791197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[593.796032] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[595.975659] [123/133] (429s left) prime_vgem (fence-wait)
[596.059603] Starting subtest: fence-wait
[596.061765] Starting dynamic subtest: rcs0
[597.121471] Dynamic subtest rcs0: SUCCESS (1.061s)
[597.133910] Starting dynamic subtest: bcs0
[598.185269] Dynamic subtest bcs0: SUCCESS (1.063s)
[598.195202] Starting dynamic subtest: vcs0
[599.237286] Dynamic subtest vcs0: SUCCESS (1.036s)
[599.247506] Starting dynamic subtest: vcs1
[600.270606] Dynamic subtest vcs1: SUCCESS (1.046s)
[600.281717] Starting dynamic subtest: vecs0
[601.311050] Dynamic subtest vecs0: SUCCESS (1.038s)
[601.323540] Starting dynamic subtest: ccs0
[602.352520] Dynamic subtest ccs0: SUCCESS (1.038s)
[602.355798] Subtest fence-wait: SUCCESS (6.293s)
[602.482866] [124/133] (423s left) gem_shrink (reclaim)
[602.547956] Starting subtest: reclaim
[605.052098] Subtest reclaim: SUCCESS (2.498s)
[605.215038] [125/133] (420s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[605.277787] Starting subtest: multi-wait-all-for-submit-signaled
[605.280160] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[605.417865] [126/133] (420s left) sysfs_heartbeat_interval (invalid)
[605.486761] Starting subtest: invalid
[605.489320] Starting dynamic subtest: vecs0
[605.491687] Dynamic subtest vecs0: SUCCESS (0.000s)
[605.503283] Starting dynamic subtest: ccs0
[605.505468] Dynamic subtest ccs0: SUCCESS (0.000s)
[605.514790] Starting dynamic subtest: vcs0
[605.517079] Dynamic subtest vcs0: SUCCESS (0.000s)
[605.526514] Starting dynamic subtest: bcs0
[605.528450] Dynamic subtest bcs0: SUCCESS (0.000s)
[605.538067] Starting dynamic subtest: rcs0
[605.540277] Dynamic subtest rcs0: SUCCESS (0.000s)
[605.549733] Starting dynamic subtest: vcs1
[605.551660] Dynamic subtest vcs1: SUCCESS (0.000s)
[605.553603] Subtest invalid: SUCCESS (0.006s)
[605.594032] [127/133] (420s left) gem_softpin (evict-prime)
[605.647724] Starting subtest: evict-prime
[605.650075] Starting dynamic subtest: rcs0
[606.816830] Dynamic subtest rcs0: SUCCESS (1.169s)
[606.830429] Starting dynamic subtest: bcs0
[607.947124] Dynamic subtest bcs0: SUCCESS (1.127s)
[607.961686] Starting dynamic subtest: vcs0
[609.881591] Dynamic subtest vcs0: SUCCESS (1.930s)
[609.903248] Starting dynamic subtest: vcs1
[611.857136] Dynamic subtest vcs1: SUCCESS (1.972s)
[611.878198] Starting dynamic subtest: vecs0
[613.838414] Dynamic subtest vecs0: SUCCESS (1.980s)
[613.851734] Starting dynamic subtest: ccs0
[614.967129] Dynamic subtest ccs0: SUCCESS (1.125s)
[614.985847] Starting dynamic subtest: all
[616.853868] Dynamic subtest all: SUCCESS (1.883s)
[616.856863] Subtest evict-prime: SUCCESS (11.205s)
[616.949474] [128/133] (408s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[617.010052] Starting subtest: yf-tiled-to-vebox-yf-tiled
[617.014496] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[617.209299] [129/133] (408s left) kms_plane_cursor (overlay)
[617.309875] Starting subtest: overlay
[617.314021] Starting dynamic subtest: pipe-A-eDP-1-size-64
[619.884691] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.573s)
[619.944556] Starting dynamic subtest: pipe-A-eDP-1-size-128
[622.474344] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.540s)
[622.533899] Starting dynamic subtest: pipe-A-eDP-1-size-256
[625.062206] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[625.411893] Starting dynamic subtest: pipe-B-eDP-1-size-64
[628.677302] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.276s)
[628.741726] Starting dynamic subtest: pipe-B-eDP-1-size-128
[631.255949] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[631.317638] Starting dynamic subtest: pipe-B-eDP-1-size-256
[633.802430] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.495s)
[634.153502] Starting dynamic subtest: pipe-C-eDP-1-size-64
[636.916122] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.775s)
[636.955996] Starting dynamic subtest: pipe-C-eDP-1-size-128
[639.094261] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[639.132805] Starting dynamic subtest: pipe-C-eDP-1-size-256
[641.304847] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[641.635983] Starting dynamic subtest: pipe-D-eDP-1-size-64
[644.486095] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.862s)
[644.525026] Starting dynamic subtest: pipe-D-eDP-1-size-128
[646.664684] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[646.703655] Starting dynamic subtest: pipe-D-eDP-1-size-256
[648.832108] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s)
[649.148337] Subtest overlay: SUCCESS (31.838s)
[649.999310] [130/133] (375s left) syncobj_eventfd (timeline-wait-before-signal)
[650.048754] Starting subtest: timeline-wait-before-signal
[650.078751] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[650.154416] [131/133] (375s left) api_intel_allocator (simple-allocator)
[650.200282] Starting subtest: simple-allocator
[650.202472] Starting dynamic subtest: basic
[650.204325] Dynamic subtest basic: SUCCESS (0.004s)
[650.214078] Starting dynamic subtest: parallel-one
[650.390811] Dynamic subtest parallel-one: SUCCESS (0.187s)
[650.400867] Starting dynamic subtest: print
[650.403171] Dynamic subtest print: SUCCESS (0.000s)
[650.412543] Starting dynamic subtest: reuse
[650.414404] Dynamic subtest reuse: SUCCESS (0.000s)
[650.423319] Starting dynamic subtest: reserve
[650.425164] Dynamic subtest reserve: SUCCESS (0.000s)
[650.434056] Starting dynamic subtest: fork-reopen-allocator
[650.435895] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[650.437756] Subtest simple-allocator: SUCCESS (0.210s)
[650.551538] [132/133] (375s left) perf (blocking-parameterized)
[650.694668] Starting subtest: blocking-parameterized
[670.716414] Subtest blocking-parameterized: SUCCESS (20.020s)
[670.767118] [133/133] (355s left) kms_vblank (ts-continuation-dpms-rpm)
[670.858080] Starting subtest: ts-continuation-dpms-rpm
[670.859938] Starting dynamic subtest: pipe-A-eDP-1
[673.393440] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.536s)
[673.409491] Starting dynamic subtest: pipe-D-eDP-1
[675.642638] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[675.644877] Subtest ts-continuation-dpms-rpm: SUCCESS (4.784s)
[676.437401] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_ppgtt
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_draw_crc
results: parsing output: 25/ for test: gem_flink_basic
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: kms_content_protection
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: gem_readwrite
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: kms_flip_scaled_crc
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_plane_lowres
results: parsing output: 50/ for test: prime_mmap
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: gem_ppgtt
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: gem_sync
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_chamelium_color
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: kms_chamelium_audio
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_atomic_interruptible
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: gem_partial_pwrite_pread
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_prop_blob
results: parsing output: 105/ for test: i915_pm_freq_api
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: kms_universal_plane
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: drm_mm
results: parsing output: 117/ for test: gem_create
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_hdr
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: prime_vgem
results: parsing output: 123/ for test: gem_shrink
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: sysfs_heartbeat_interval
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: gem_render_copy
results: parsing output: 128/ for test: kms_plane_cursor
results: parsing output: 129/ for test: syncobj_eventfd
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: kms_vblank
Done.