[61.286930] Initializing watchdogs
[61.287107]   /dev/watchdog0
[61.302471] [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]
[61.306763] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.308902] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.312175] [001/131] (960s left) kms_selftest (drm_format)
[61.362994] Starting subtest: drm_format
[61.372844] Starting dynamic subtest: drm_test_format_block_width_invalid
[61.490489] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.118s)
[61.499445] Starting dynamic subtest: drm_test_format_block_width_one_plane
[61.589592] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.097s)
[61.598098] Starting dynamic subtest: drm_test_format_block_width_two_plane
[61.709229] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.119s)
[61.716913] Starting dynamic subtest: drm_test_format_block_width_three_plane
[61.814401] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.106s)
[61.822792] Starting dynamic subtest: drm_test_format_block_width_tiled
[61.930651] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.113s)
[61.938931] Starting dynamic subtest: drm_test_format_block_height_invalid
[62.051383] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.120s)
[62.059889] Starting dynamic subtest: drm_test_format_block_height_one_plane
[62.137347] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.087s)
[62.145596] Starting dynamic subtest: drm_test_format_block_height_two_plane
[62.256392] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.117s)
[62.265182] Starting dynamic subtest: drm_test_format_block_height_three_plane
[62.359521] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.104s)
[62.366376] Starting dynamic subtest: drm_test_format_block_height_tiled
[62.512491] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.152s)
[62.520941] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[62.647463] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.134s)
[62.655161] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[62.763618] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.116s)
[62.771657] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[62.857761] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.094s)
[62.865505] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[62.963335] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.106s)
[62.970952] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[63.053523] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.091s)
[63.061802] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[63.168943] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.114s)
[63.175409] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[63.269052] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.101s)
[63.275294] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[63.384924] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.115s)
[63.386921] Subtest drm_format: SUCCESS (2.021s)
[63.592173] [002/131] (958s left) gem_exec_balancer (hang)
[63.864449] Starting subtest: hang
[65.902080] Subtest hang: SUCCESS (2.038s)
[66.030401] [003/131] (955s left) syncobj_basic (bad-pad-fd-to-handle)
[66.086042] Starting subtest: bad-pad-fd-to-handle
[66.088405] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[66.210944] [004/131] (955s left) kms_cursor_crc (cursor-sliding-128x42)
[66.441872] Starting subtest: cursor-sliding-128x42
[66.488890] Subtest cursor-sliding-128x42: SKIP (0.043s)
[66.690186] [005/131] (955s left) gem_exercise_blt (fast-copy-emit)
[66.750214] Starting subtest: fast-copy-emit
[66.752543] Starting dynamic subtest: linear-smem-smem-emit
[66.774560] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.024s)
[66.786992] Starting dynamic subtest: xmajor-smem-smem-emit
[66.791891] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[66.799015] Starting dynamic subtest: tile4-smem-smem-emit
[66.808610] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[66.815369] Starting dynamic subtest: tile64-smem-smem-emit
[66.825715] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[66.828152] Subtest fast-copy-emit: SUCCESS (0.076s)
[66.964252] [006/131] (955s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[67.062073] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[67.065832] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[67.185327] [007/131] (954s left) gem_unfence_active_buffers
[67.350779] [008/131] (954s left) kms_psr (pr-sprite-plane-move)
[67.434600] Starting subtest: pr-sprite-plane-move
[67.438286] Subtest pr-sprite-plane-move: SKIP (0.000s)
[67.528646] [009/131] (954s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[67.620949] Starting subtest: psr-shrfb-scaledprimary
[73.411995] Subtest psr-shrfb-scaledprimary: SUCCESS (5.793s)
[73.545384] [010/131] (948s left) vgem_slow (nohang)
[73.620947] Starting subtest: nohang
[84.082461] Subtest nohang: SUCCESS (10.461s)
[84.158278] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[84.161351] [011/131] (938s left) kms_async_flips (async-flip-suspend-resume)
[84.253642] Starting subtest: async-flip-suspend-resume
[84.625964] Starting dynamic subtest: pipe-A-eDP-1
[102.933554] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.374s)
[103.317830] Starting dynamic subtest: pipe-B-eDP-1
[121.865999] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.185s)
[122.221362] Starting dynamic subtest: pipe-C-eDP-1
[140.862960] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.301s)
[141.231581] Starting dynamic subtest: pipe-D-eDP-1
[159.885052] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.170s)
[159.888908] Subtest async-flip-suspend-resume: SUCCESS (14.496s)
[170.075375] [012/131] (861s left) gem_exec_balancer (parallel-ordering)
[170.349234] Starting subtest: parallel-ordering
[171.310829] Subtest parallel-ordering: SUCCESS (0.964s)
[171.474163] [013/131] (859s left) gem_lmem_swapping (verify)
[171.519664] Subtest verify: SKIP (0.000s)
[171.567961] [014/131] (859s left) kms_addfb_basic (clobberred-modifier)
[171.624673] Starting subtest: clobberred-modifier
[171.629210] Subtest clobberred-modifier: SKIP (0.000s)
[171.777897] [015/131] (859s left) api_intel_bb (blit-reloc-keep-cache)
[171.831254] Starting subtest: blit-reloc-keep-cache
[171.836700] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[171.985796] [016/131] (859s left) i915_query (query-topology-garbage-items)
[172.038640] Starting subtest: query-topology-garbage-items
[172.041347] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[172.142811] [017/131] (859s left) gem_softpin (noreloc)
[172.191900] Starting subtest: noreloc
[177.605430] Subtest noreloc: SUCCESS (5.411s)
[177.734711] [018/131] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[177.836726] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[177.841375] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[177.949015] [019/131] (853s left) kms_vrr (max-min)
[178.046227] Starting subtest: max-min
[178.053217] Subtest max-min: SKIP (0.000s)
[178.146299] [020/131] (853s left) gem_exec_fence (long-history)
[178.596339] Starting subtest: long-history
[185.855612] Subtest long-history: SUCCESS (7.260s)
[186.318226] [021/131] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[186.421425] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[192.916106] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.497s)
[193.063973] [022/131] (838s left) dmabuf_sync_file (export-basic)
[193.105780] Starting subtest: export-basic
[193.108537] Subtest export-basic: SUCCESS (0.001s)
[193.186623] [023/131] (838s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[193.288925] Starting subtest: y-tiled-addfb-size-offset-overflow
[193.294230] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[193.410714] [024/131] (838s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[193.514738] Starting subtest: fbcpsr-rgb565-draw-pwrite
[200.386671] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.876s)
[200.527003] [025/131] (831s left) gem_exec_fence (syncobj-timeline-repeat)
[201.075231] Starting subtest: syncobj-timeline-repeat
[201.303973] Subtest syncobj-timeline-repeat: SUCCESS (0.229s)
[202.110793] [026/131] (829s left) kms_draw_crc (draw-method-mmap-wc)
[202.207524] Starting subtest: draw-method-mmap-wc
[202.209771] Starting dynamic subtest: xrgb8888-untiled
[202.418473] Dynamic subtest xrgb8888-untiled: SUCCESS (0.213s)
[202.427992] Starting dynamic subtest: rgb565-untiled
[202.618723] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[202.627520] Starting dynamic subtest: xrgb2101010-untiled
[202.807813] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[202.817480] Starting dynamic subtest: xbgr16161616f-untiled
[202.996543] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.188s)
[203.005899] Starting dynamic subtest: xrgb8888-xtiled
[203.107521] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.111s)
[203.116629] Starting dynamic subtest: rgb565-xtiled
[203.229642] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[203.238123] Starting dynamic subtest: xrgb2101010-xtiled
[203.352056] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[203.360599] Starting dynamic subtest: xbgr16161616f-xtiled
[203.474421] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[203.482670] Starting dynamic subtest: xrgb8888-4tiled
[203.629533] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[203.637756] Starting dynamic subtest: rgb565-4tiled
[203.763785] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[203.777444] Starting dynamic subtest: xrgb2101010-4tiled
[203.919349] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[203.928564] Starting dynamic subtest: xbgr16161616f-4tiled
[204.096481] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[204.098642] Subtest draw-method-mmap-wc: SUCCESS (1.892s)
[204.219298] [027/131] (827s left) kms_prop_blob (basic)
[204.272314] Starting subtest: basic
[204.274217] Subtest basic: SUCCESS (0.000s)
[204.386780] [028/131] (827s left) sysfs_heartbeat_interval (nopreempt)
[204.440117] Starting subtest: nopreempt
[204.442155] Starting dynamic subtest: vecs0
[214.062215] Dynamic subtest vecs0: SUCCESS (9.617s)
[214.074156] Starting dynamic subtest: ccs0
[218.025969] Dynamic subtest ccs0: SUCCESS (3.964s)
[218.036190] Starting dynamic subtest: vcs0
[228.082360] Dynamic subtest vcs0: SUCCESS (10.053s)
[228.093958] Starting dynamic subtest: bcs0
[232.034572] Dynamic subtest bcs0: SUCCESS (3.952s)
[232.046911] Starting dynamic subtest: rcs0
[236.110622] Dynamic subtest rcs0: SUCCESS (4.075s)
[236.119911] Starting dynamic subtest: vcs1
[246.046070] Dynamic subtest vcs1: SUCCESS (9.932s)
[246.048912] Subtest nopreempt: SUCCESS (41.602s)
[246.134458] [029/131] (785s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[246.246490] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[247.250901] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.004s)
[248.059406] [030/131] (783s left) kms_async_flips (invalid-async-flip)
[248.143382] Starting subtest: invalid-async-flip
[248.514474] Starting dynamic subtest: pipe-A-eDP-1
[249.360681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[249.719620] Starting dynamic subtest: pipe-B-eDP-1
[250.499930] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.789s)
[250.853680] Starting dynamic subtest: pipe-C-eDP-1
[251.611667] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[251.963730] Starting dynamic subtest: pipe-D-eDP-1
[252.743646] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[252.746554] Subtest invalid-async-flip: SUCCESS (4.601s)
[253.922676] [031/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[254.029399] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[254.033983] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[254.154483] [032/131] (777s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[254.259808] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[254.264612] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[254.376529] [033/131] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[254.476599] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[254.481319] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[254.585244] [034/131] (777s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[259.617785] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[259.623126] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[260.477437] [035/131] (771s left) gem_pxp (hw-rejects-pxp-context)
[260.608608] Starting subtest: hw-rejects-pxp-context
[260.613831] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[260.758078] [036/131] (771s left) kms_color (invalid-ctm-matrix-sizes)
[260.856626] Starting subtest: invalid-ctm-matrix-sizes
[260.859350] Starting dynamic subtest: pipe-A
[260.861820] Dynamic subtest pipe-A: SUCCESS (0.002s)
[260.871794] Starting dynamic subtest: pipe-B
[260.874152] Dynamic subtest pipe-B: SUCCESS (0.003s)
[260.883179] Starting dynamic subtest: pipe-C
[260.885754] Dynamic subtest pipe-C: SUCCESS (0.003s)
[260.894934] Starting dynamic subtest: pipe-D
[260.897166] Dynamic subtest pipe-D: SUCCESS (0.003s)
[260.899276] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[260.951209] [037/131] (771s left) gem_render_copy (y-tiled-ccs-to-linear)
[261.013205] Starting subtest: y-tiled-ccs-to-linear
[261.017923] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[261.209356] [038/131] (771s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[261.600298] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[262.382450] [039/131] (770s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[262.487745] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[262.490339] Starting dynamic subtest: pipe-A-eDP-1
[262.500122] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.509215] Starting dynamic subtest: pipe-B-eDP-1
[262.519160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.528395] Starting dynamic subtest: pipe-C-eDP-1
[262.538396] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.547495] Starting dynamic subtest: pipe-D-eDP-1
[262.557498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.562485] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[264.784884] [040/131] (767s left) gem_render_tiled_blits (basic)
[264.837938] Subtest basic: SKIP (0.000s)
[264.923352] [041/131] (767s left) kms_cursor_crc (cursor-onscreen-32x10)
[265.073843] Starting subtest: cursor-onscreen-32x10
[265.120055] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[265.414135] [042/131] (767s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[265.523705] Starting subtest: cursorB-vs-flipA-atomic
[265.528621] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[265.678107] [043/131] (766s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[265.763183] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[265.765143] Starting dynamic subtest: pipe-A-eDP-1
[265.785234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.794545] Starting dynamic subtest: pipe-B-eDP-1
[265.813907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.822735] Starting dynamic subtest: pipe-C-eDP-1
[265.844168] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.852799] Starting dynamic subtest: pipe-D-eDP-1
[265.873148] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.876845] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[267.944985] [044/131] (764s left) perf (sysctl-defaults)
[268.038523] Starting subtest: sysctl-defaults
[268.040883] Subtest sysctl-defaults: SUCCESS (0.000s)
[268.132131] [045/131] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[268.231367] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[268.235751] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[268.339862] [046/131] (764s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[268.386702] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[268.468711] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.018s)
[268.507893] [047/131] (764s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[268.602911] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[269.613984] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.013s)
[269.762289] [048/131] (763s left) gem_ringfill (legacy-basic)
[275.033416] Starting subtest: legacy-basic
[275.035883] Starting dynamic subtest: default
[275.103915] Dynamic subtest default: SUCCESS (0.070s)
[275.114726] Starting dynamic subtest: render
[275.146667] Dynamic subtest render: SUCCESS (0.041s)
[275.156844] Starting dynamic subtest: bsd
[275.189496] Dynamic subtest bsd: SUCCESS (0.041s)
[275.199939] Starting dynamic subtest: bsd1
[275.232577] Dynamic subtest bsd1: SUCCESS (0.041s)
[275.242224] Starting dynamic subtest: bsd2
[275.272788] Dynamic subtest bsd2: SUCCESS (0.038s)
[275.283925] Starting dynamic subtest: blt
[275.318836] Dynamic subtest blt: SUCCESS (0.043s)
[275.331010] Starting dynamic subtest: vebox
[275.361920] Dynamic subtest vebox: SUCCESS (0.041s)
[275.364863] Subtest legacy-basic: SUCCESS (0.330s)
[275.466018] [049/131] (757s left) gem_exec_params (sol-reset-invalid)
[275.531083] Starting subtest: sol-reset-invalid
[275.533884] Subtest sol-reset-invalid: SUCCESS (0.004s)
[277.098674] [050/131] (755s left) api_intel_bb (object-noreloc-keep-cache-simple)
[277.161452] Starting subtest: object-noreloc-keep-cache-simple
[277.168388] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.010s)
[277.269662] [051/131] (755s left) kms_pm_rpm (basic-rte)
[277.305670] Starting subtest: basic-rte
[280.563909] Subtest basic-rte: SUCCESS (3.260s)
[282.367385] [052/131] (750s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[282.469905] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[283.337919] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.870s)
[283.540288] [053/131] (749s left) gem_exec_schedule (preemptive-hang)
[283.713392] Starting subtest: preemptive-hang
[283.715803] Starting dynamic subtest: rcs0
[293.185873] Dynamic subtest rcs0: SUCCESS (9.471s)
[293.199225] Starting dynamic subtest: bcs0
[302.206170] Dynamic subtest bcs0: SUCCESS (9.019s)
[302.216637] Starting dynamic subtest: vcs0
[311.228912] Dynamic subtest vcs0: SUCCESS (9.019s)
[311.240440] Starting dynamic subtest: vcs1
[320.124672] Dynamic subtest vcs1: SUCCESS (8.892s)
[320.133787] Starting dynamic subtest: vecs0
[329.151902] Dynamic subtest vecs0: SUCCESS (9.028s)
[329.163185] Starting dynamic subtest: ccs0
[338.175920] Dynamic subtest ccs0: SUCCESS (9.020s)
[338.178748] Subtest preemptive-hang: SUCCESS (54.457s)
[338.438035] [054/131] (694s left) i915_pm_rps (fence-order)
[338.497517] Starting subtest: fence-order
[341.554669] Subtest fence-order: SUCCESS (3.057s)
[341.643702] [055/131] (691s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[341.746337] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[350.940146] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.197s)
[351.089082] [056/131] (682s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[351.164567] Starting subtest: invalid-multi-wait-all-unsubmitted
[351.167333] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[351.275415] [057/131] (681s left) gem_mmap_gtt (zero-extend)
[351.323043] Subtest zero-extend: SKIP (0.000s)
[351.394323] [058/131] (681s left) kms_psr2_su (frontbuffer-xrgb8888)
[351.454716] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[351.524915] [059/131] (681s left) gem_exec_schedule (preempt-self)
[351.593826] Starting subtest: preempt-self
[351.596518] Starting dynamic subtest: rcs0
[351.609769] Dynamic subtest rcs0: SUCCESS (0.025s)
[351.619761] Starting dynamic subtest: bcs0
[351.628950] Dynamic subtest bcs0: SUCCESS (0.018s)
[351.639203] Starting dynamic subtest: vcs0
[351.653158] Dynamic subtest vcs0: SUCCESS (0.024s)
[351.668381] Starting dynamic subtest: vcs1
[351.676672] Dynamic subtest vcs1: SUCCESS (0.022s)
[351.686883] Starting dynamic subtest: vecs0
[351.693841] Dynamic subtest vecs0: SUCCESS (0.017s)
[351.704504] Starting dynamic subtest: ccs0
[351.714897] Dynamic subtest ccs0: SUCCESS (0.020s)
[351.717705] Subtest preempt-self: SUCCESS (0.130s)
[353.163976] [060/131] (680s left) kms_big_fb (linear-8bpp-rotate-270)
[353.267399] Starting subtest: linear-8bpp-rotate-270
[353.290055] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[353.418055] [061/131] (679s left) gem_pxp (create-protected-buffer)
[353.511508] Starting subtest: create-protected-buffer
[353.513616] Subtest create-protected-buffer: SUCCESS (0.000s)
[353.627910] [062/131] (679s left) perf_pmu (semaphore-busy)
[353.665848] Starting subtest: semaphore-busy
[353.668557] Starting dynamic subtest: rcs0
[355.327784] Dynamic subtest rcs0: SUCCESS (1.658s)
[355.338233] Starting dynamic subtest: bcs0
[356.958613] Dynamic subtest bcs0: SUCCESS (1.628s)
[356.971758] Starting dynamic subtest: vcs0
[361.552748] Dynamic subtest vcs0: SUCCESS (4.591s)
[361.565570] Starting dynamic subtest: vcs1
[367.568093] Dynamic subtest vcs1: SUCCESS (6.012s)
[367.580429] Starting dynamic subtest: vecs0
[373.520477] Dynamic subtest vecs0: SUCCESS (5.949s)
[373.532650] Starting dynamic subtest: ccs0
[376.658321] Dynamic subtest ccs0: SUCCESS (3.134s)
[376.661363] Subtest semaphore-busy: SUCCESS (22.990s)
[376.813914] [063/131] (656s left) gem_vm_create (isolation)
[376.877231] Starting subtest: isolation
[376.892219] Subtest isolation: SUCCESS (0.015s)
[377.038196] [064/131] (656s left) perf (short-reads)
[377.132950] Starting subtest: short-reads
[377.148766] Subtest short-reads: SUCCESS (0.016s)
[377.199547] [065/131] (656s left) perf (non-zero-reason)
[377.294936] Starting subtest: non-zero-reason
[377.297541] Starting dynamic subtest: 0-rcs0
[382.706203] Dynamic subtest 0-rcs0: SUCCESS (5.409s)
[382.718734] Starting dynamic subtest: 1-vcs1
[386.619959] Dynamic subtest 1-vcs1: SUCCESS (3.913s)
[386.622914] Subtest non-zero-reason: SUCCESS (9.324s)
[386.665928] [066/131] (646s left) gem_ctx_param (invalid-get-no-zeromap)
[386.721434] Starting subtest: invalid-get-no-zeromap
[386.723951] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[386.836256] [067/131] (646s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[386.938648] Starting subtest: fbc-rgb565-draw-pwrite
[391.425327] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.490s)
[392.612985] [068/131] (641s left) kms_cursor_crc (cursor-random-256x85)
[392.861922] Starting subtest: cursor-random-256x85
[392.904947] Subtest cursor-random-256x85: SKIP (0.038s)
[393.103199] [069/131] (640s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[393.191297] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[393.193559] Starting dynamic subtest: pipe-A-default-mode
[393.487491] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[393.492329] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.289s)
[394.336213] [070/131] (639s left) i915_drm_fdinfo (memory-info-active)
[394.376604] Starting subtest: memory-info-active
[394.379525] Starting dynamic subtest: smem0
[396.919346] Dynamic subtest smem0: SUCCESS (2.545s)
[396.921688] Subtest memory-info-active: SUCCESS (2.546s)
[396.999046] [071/131] (636s left) kms_plane_alpha_blend (constant-alpha-min)
[397.094725] Starting subtest: constant-alpha-min
[397.390216] Starting dynamic subtest: pipe-A-eDP-1
[398.097721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[398.108692] Starting dynamic subtest: pipe-D-eDP-1
[399.583250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.485s)
[399.585721] Subtest constant-alpha-min: SUCCESS (2.489s)
[400.407680] [072/131] (633s left) kms_atomic_transition (plane-all-transition)
[400.500369] Starting subtest: plane-all-transition
[400.502793] Starting dynamic subtest: pipe-A-eDP-1
[402.998139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[403.309405] Starting dynamic subtest: pipe-B-eDP-1
[406.528479] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[406.839214] Subtest plane-all-transition: SUCCESS (6.338s)
[407.673222] [073/131] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[407.775029] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[414.224179] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.453s)
[414.375024] [074/131] (619s left) gem_spin_batch (spin-each)
[414.455807] Starting subtest: spin-each
[417.813967] Subtest spin-each: SUCCESS (3.358s)
[418.144263] [075/131] (615s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[418.274487] Starting subtest: 2x-long-flip-vs-cursor-atomic
[418.279906] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[418.429807] [076/131] (615s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[418.523464] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[418.525893] Starting dynamic subtest: pipe-A-eDP-1
[418.550491] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.561560] Starting dynamic subtest: pipe-B-eDP-1
[418.586859] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.596861] Starting dynamic subtest: pipe-C-eDP-1
[418.622456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.631900] Starting dynamic subtest: pipe-D-eDP-1
[418.657521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.662129] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[420.836668] [077/131] (613s left) gem_userptr_blits (unsync-overlap)
[420.910371] Subtest unsync-overlap: SKIP (0.000s)
[421.063748] [078/131] (613s left) gem_create (create-invalid-size)
[421.121479] Starting subtest: create-invalid-size
[421.124136] Subtest create-invalid-size: SUCCESS (0.000s)
[421.322192] [079/131] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[421.427616] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[421.432573] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.563962] [080/131] (612s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[421.649607] Starting subtest: fbc-psr-cursor-mmap-cpu
[421.652167] Starting dynamic subtest: eDP-1
[421.657032] Dynamic subtest eDP-1: SKIP (0.000s)
[421.661824] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[421.739092] [081/131] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[421.837862] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[421.842464] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[421.966321] [082/131] (612s left) gen9_exec_parse (bb-start-param)
[422.022777] Subtest bb-start-param: SKIP (0.000s)
[422.094683] [083/131] (612s left) i915_module_load (reload-no-display)
[422.131545] Starting subtest: reload-no-display
[428.674428] Subtest reload-no-display: SUCCESS (6.543s)
[428.706042] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[428.706757] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[428.710227] [084/131] (605s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[430.225328] Starting subtest: multi-wait-all-for-submit-signaled
[430.227502] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[430.318123] [FACT syncobj_wait (multi-wait-all-for-submit-signaled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[430.319382] [FACT syncobj_wait (multi-wait-all-for-submit-signaled)] new: kernel.kmod_is_loaded.i915: true
[430.323220] [085/131] (604s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[430.428640] Starting subtest: bad-pixel-format-yf-tiled-ccs
[430.431258] Starting dynamic subtest: pipe-A-eDP-1
[430.456593] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[430.466144] Starting dynamic subtest: pipe-B-eDP-1
[430.490561] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.498714] Starting dynamic subtest: pipe-C-eDP-1
[430.522828] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.530904] Starting dynamic subtest: pipe-D-eDP-1
[430.555930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.560924] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[432.699060] [086/131] (601s left) kms_fence_pin_leak
[432.889118] [087/131] (601s left) kms_atomic_interruptible (legacy-cursor)
[432.987736] Starting subtest: legacy-cursor
[432.990477] Starting dynamic subtest: pipe-A-eDP-1
[440.396419] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s)
[440.399096] Subtest legacy-cursor: SUCCESS (7.409s)
[441.258678] [088/131] (593s left) kms_plane_multiple (2x-tiling-none)
[441.350790] Starting subtest: 2x-tiling-none
[441.355707] Subtest 2x-tiling-none: SKIP (0.000s)
[441.447500] [089/131] (593s left) kms_psr (psr-cursor-mmap-cpu)
[441.540895] Starting subtest: psr-cursor-mmap-cpu
[441.543450] Starting dynamic subtest: eDP-1
[443.238143] Dynamic subtest eDP-1: SUCCESS (1.699s)
[443.240607] Subtest psr-cursor-mmap-cpu: SUCCESS (1.701s)
[444.122445] [090/131] (590s left) gem_ccs (ctrl-surf-copy-new-ctx)
[444.191913] Starting subtest: ctrl-surf-copy-new-ctx
[444.197200] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[444.298956] [091/131] (590s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[444.396335] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[445.019753] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[445.224289] [092/131] (589s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[445.313538] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[445.315894] Starting dynamic subtest: pipe-A
[445.335830] Dynamic subtest pipe-A: SKIP (0.017s)
[445.346915] Starting dynamic subtest: pipe-B
[445.369516] Dynamic subtest pipe-B: SKIP (0.035s)
[445.378851] Starting dynamic subtest: pipe-C
[445.405166] Dynamic subtest pipe-C: SKIP (0.033s)
[445.414496] Starting dynamic subtest: pipe-D
[445.433570] Dynamic subtest pipe-D: SKIP (0.030s)
[445.437749] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.118s)
[445.556324] [093/131] (589s left) kms_flip (flip-vs-panning)
[445.653489] Starting subtest: flip-vs-panning
[445.655393] Starting dynamic subtest: A-eDP1
[454.438630] Dynamic subtest A-eDP1: SUCCESS (8.786s)
[454.451752] Starting dynamic subtest: B-eDP1
[463.172800] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[463.186948] Starting dynamic subtest: C-eDP1
[471.906926] Dynamic subtest C-eDP1: SUCCESS (8.731s)
[471.916305] Starting dynamic subtest: D-eDP1
[480.642798] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[480.648530] Subtest flip-vs-panning: SUCCESS (34.994s)
[481.916087] [094/131] (552s left) syncobj_timeline (wait-for-submit-delayed-submit)
[481.974597] Starting subtest: wait-for-submit-delayed-submit
[482.079555] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[482.167838] [095/131] (552s left) kms_color (ctm-0-25)
[482.259929] Starting subtest: ctm-0-25
[482.262662] Starting dynamic subtest: pipe-A-eDP-1
[485.813146] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.553s)
[485.822594] Starting dynamic subtest: pipe-B-eDP-1
[489.900658] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.088s)
[489.911675] Starting dynamic subtest: pipe-C-eDP-1
[493.852569] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.950s)
[493.862660] Starting dynamic subtest: pipe-D-eDP-1
[497.859764] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.005s)
[497.862096] Subtest ctm-0-25: SUCCESS (15.600s)
[498.710273] [096/131] (536s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[498.817606] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[498.820232] Starting dynamic subtest: pipe-A-eDP-1
[499.226538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.381s)
[499.235949] Starting dynamic subtest: pipe-B-eDP-1
[500.600261] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[500.610915] Starting dynamic subtest: pipe-C-eDP-1
[502.010233] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.409s)
[502.020507] Starting dynamic subtest: pipe-D-eDP-1
[503.351247] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[503.353792] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.504s)
[504.568402] [097/131] (530s left) gem_ctx_shared (create-shared-gtt)
[504.629843] Starting subtest: create-shared-gtt
[506.782507] Subtest create-shared-gtt: SUCCESS (2.151s)
[507.174152] [098/131] (527s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[507.270507] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[512.000260] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.734s)
[513.188513] [099/131] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[513.289529] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[513.293776] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[513.430619] [100/131] (521s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[513.545073] Starting subtest: short-flip-after-cursor-atomic-transitions
[514.491992] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.946s)
[515.308192] [101/131] (519s left) gem_exec_parallel (basic)
[515.370105] Starting subtest: basic
[515.372912] Starting dynamic subtest: rcs0
[517.057250] Dynamic subtest rcs0: SUCCESS (1.686s)
[517.069068] Starting dynamic subtest: bcs0
[518.683908] Dynamic subtest bcs0: SUCCESS (1.626s)
[518.695740] Starting dynamic subtest: vcs0
[522.008244] Dynamic subtest vcs0: SUCCESS (3.322s)
[522.021002] Starting dynamic subtest: vcs1
[524.055163] Dynamic subtest vcs1: SUCCESS (2.044s)
[524.065915] Starting dynamic subtest: vecs0
[526.038790] Dynamic subtest vecs0: SUCCESS (1.981s)
[526.051925] Starting dynamic subtest: ccs0
[527.812965] Dynamic subtest ccs0: SUCCESS (1.772s)
[527.815828] Subtest basic: SUCCESS (12.443s)
[528.013720] [102/131] (507s left) kms_chamelium_color (ctm-red-to-blue)
[528.120338] Subtest ctm-red-to-blue: SKIP (0.000s)
[528.165765] [103/131] (506s left) kms_flip (2x-busy-flip)
[528.261583] Starting subtest: 2x-busy-flip
[528.272720] Subtest 2x-busy-flip: SKIP (0.011s)
[528.392089] [104/131] (506s left) prime_mmap (test_userptr)
[528.442396] Starting subtest: test_userptr
[528.444902] Starting dynamic subtest: test_userptr-smem
[528.447758] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[528.450672] Subtest test_userptr: SUCCESS (0.001s)
[528.554417] [105/131] (506s left) kms_psr (fbc-psr-suspend)
[528.653571] Starting subtest: fbc-psr-suspend
[528.656075] Starting dynamic subtest: eDP-1
[528.660768] Dynamic subtest eDP-1: SKIP (0.000s)
[528.665723] Subtest fbc-psr-suspend: SKIP (0.001s)
[528.741560] [106/131] (506s left) kms_flip (dpms-off-confusion)
[528.835607] Starting subtest: dpms-off-confusion
[528.837992] Starting dynamic subtest: A-eDP1
[537.507195] Dynamic subtest A-eDP1: SUCCESS (8.675s)
[537.517905] Starting dynamic subtest: B-eDP1
[546.138412] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[546.147767] Starting dynamic subtest: C-eDP1
[554.766637] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[554.778591] Starting dynamic subtest: D-eDP1
[563.399681] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[563.402206] Subtest dpms-off-confusion: SUCCESS (34.571s)
[564.585182] [107/131] (470s left) gem_flink_basic (double-flink)
[564.646939] Starting subtest: double-flink
[564.649723] Subtest double-flink: SUCCESS (0.000s)
[564.751185] [108/131] (470s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[564.842662] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[564.845163] Starting dynamic subtest: pipe-A-default-mode
[565.136850] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[565.142487] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.293s)
[566.028023] [109/131] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[566.128465] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[573.695276] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.571s)
[573.821215] [110/131] (461s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[573.921469] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[573.926525] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[573.994281] [111/131] (461s left) kms_vblank (query-forked-busy-hang)
[574.086769] Starting subtest: query-forked-busy-hang
[574.088910] Starting dynamic subtest: pipe-A-eDP-1
[600.857058] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.768s)
[600.872742] Starting dynamic subtest: pipe-D-eDP-1
[615.830918] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s)
[615.833791] Subtest query-forked-busy-hang: SUCCESS (41.743s)
[616.708123] [112/131] (418s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[616.802573] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[620.593502] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.795s)
[621.804488] [113/131] (413s left) gem_tiled_wc
[621.923032] [114/131] (413s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[622.012907] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[622.015746] Starting dynamic subtest: pipe-A
[623.195907] Dynamic subtest pipe-A: SUCCESS (1.185s)
[623.205385] Starting dynamic subtest: pipe-B
[625.437609] Dynamic subtest pipe-B: SUCCESS (2.240s)
[625.446944] Starting dynamic subtest: pipe-C
[626.600891] Dynamic subtest pipe-C: SUCCESS (1.162s)
[626.610040] Starting dynamic subtest: pipe-D
[627.831725] Dynamic subtest pipe-D: SUCCESS (1.230s)
[627.834478] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.822s)
[629.045084] [115/131] (406s left) syncobj_timeline (invalid-wait-bad-flags)
[629.112435] Starting subtest: invalid-wait-bad-flags
[629.115312] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[629.236430] [116/131] (406s left) gem_fence_thrash (bo-write-verify-x)
[629.265931] Starting subtest: bo-write-verify-x
[629.290903] Subtest bo-write-verify-x: SKIP (0.021s)
[629.352770] [117/131] (406s left) kms_joiner (basic-force-ultra-joiner)
[629.457905] Starting subtest: basic-force-ultra-joiner
[629.463431] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[629.533888] [118/131] (406s left) gem_exec_flush (basic-wb-ro-default)
[629.588241] Starting subtest: basic-wb-ro-default
[635.042289] Subtest basic-wb-ro-default: SUCCESS (5.454s)
[635.246802] [119/131] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[635.353654] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[635.358706] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[635.471340] [120/131] (400s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[635.530346] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[635.532906] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[635.637397] [121/131] (400s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[635.730791] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[642.626854] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.900s)
[642.769001] [122/131] (393s left) gem_blits (basic)
[642.837750] Starting subtest: basic
[644.162077] Subtest basic: SUCCESS (1.324s)
[644.315610] [123/131] (391s left) gem_ctx_bad_destroy (invalid-ctx)
[644.376529] Starting subtest: invalid-ctx
[644.379303] Subtest invalid-ctx: SUCCESS (0.000s)
[644.479094] [124/131] (391s left) gem_ctx_persistence (engines-queued)
[644.532562] Starting subtest: engines-queued
[644.535122] Starting dynamic subtest: rcs0
[644.585295] Dynamic subtest rcs0: SUCCESS (0.052s)
[644.595877] Starting dynamic subtest: bcs0
[644.646163] Dynamic subtest bcs0: SUCCESS (0.060s)
[644.656661] Starting dynamic subtest: vcs0
[646.005159] Dynamic subtest vcs0: SUCCESS (1.356s)
[646.015667] Starting dynamic subtest: vcs1
[647.988050] Dynamic subtest vcs1: SUCCESS (1.980s)
[648.000696] Starting dynamic subtest: vecs0
[649.971263] Dynamic subtest vecs0: SUCCESS (1.980s)
[649.983906] Starting dynamic subtest: ccs0
[650.139788] Dynamic subtest ccs0: SUCCESS (0.167s)
[650.142624] Subtest engines-queued: SUCCESS (5.607s)
[650.290748] [125/131] (385s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[650.418448] Starting subtest: basic-busy-flip-before-cursor-varying-size
[650.423281] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[650.590131] [126/131] (385s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[655.645072] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[655.647759] Starting dynamic subtest: pipe-A-eDP-1
[656.444206] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[656.454657] Starting dynamic subtest: pipe-B-eDP-1
[657.564935] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[657.569577] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.917s)
[658.769900] [127/131] (377s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[658.824682] Starting subtest: etime-multi-wait-all-submitted-signaled
[658.930327] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[659.034195] [128/131] (377s left) gem_exec_reloc (basic-range)
[659.102510] Subtest basic-range: SKIP (0.000s)
[659.170188] [129/131] (377s left) gem_exec_store (basic)
[659.238188] Starting subtest: basic
[659.366703] Subtest basic: SUCCESS (0.130s)
[659.575924] [130/131] (376s left) sw_sync (sync_merge_invalid)
[659.611479] Starting subtest: sync_merge_invalid
[659.640088] Subtest sync_merge_invalid: SUCCESS (0.031s)
[659.717718] [131/131] (376s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[659.769694] Starting subtest: single-wait-all-for-submit-unsubmitted
[659.873896] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[659.974342] Closing watchdogs
results: parsing output: 0/ for test: kms_selftest
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: syncobj_basic
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: gem_exercise_blt
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_unfence_active_buffers
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: vgem_slow
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_lmem_swapping
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: i915_query
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_vrr
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: dmabuf_sync_file
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_draw_crc
results: parsing output: 26/ for test: kms_prop_blob
results: parsing output: 27/ for test: sysfs_heartbeat_interval
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_async_flips
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: gem_render_copy
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_render_tiled_blits
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_ringfill
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: i915_pm_rps
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_psr2_su
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: gem_vm_create
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: gem_ctx_param
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_cursor_crc
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: kms_plane_alpha_blend
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: gem_create
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: i915_module_load
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_fence_pin_leak
results: parsing output: 86/ for test: kms_atomic_interruptible
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_ccs
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_ctx_shared
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: gem_exec_parallel
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: prime_mmap
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_flink_basic
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_joiner
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_tiled_wc
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_fence_thrash
results: parsing output: 116/ for test: kms_joiner
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_blits
results: parsing output: 122/ for test: gem_ctx_bad_destroy
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_exec_store
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: syncobj_wait
Done.