[56.402678] Initializing watchdogs
[56.402732]   /dev/watchdog0
[56.416623] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.420809] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.423263] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.426990] [001/156] (960s left) gem_render_linear_blits (basic)
[56.499027] Starting subtest: basic
[56.539098] Subtest basic: SUCCESS (0.041s)
[56.619834] [002/156] (960s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[56.681057] Starting subtest: stress-mm-invalidate-close-overlap
[58.805658] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[58.937581] [003/156] (958s left) gem_exec_params (sol-reset-invalid)
[59.001384] Starting subtest: sol-reset-invalid
[59.005918] Subtest sol-reset-invalid: SUCCESS (0.004s)
[60.377616] [004/156] (956s left) gem_exec_endless (dispatch)
[60.439130] Starting subtest: dispatch
[60.441530] Starting dynamic subtest: rcs0
[60.448438] Dynamic subtest rcs0: SUCCESS (0.006s)
[60.460544] Starting dynamic subtest: bcs0
[60.465697] Dynamic subtest bcs0: SUCCESS (0.004s)
[60.474694] Starting dynamic subtest: vcs0
[60.479168] Dynamic subtest vcs0: SUCCESS (0.007s)
[60.486543] Starting dynamic subtest: vcs1
[60.490852] Dynamic subtest vcs1: SUCCESS (0.004s)
[60.498810] Starting dynamic subtest: vecs0
[60.503959] Dynamic subtest vecs0: SUCCESS (0.004s)
[60.511430] Starting dynamic subtest: ccs0
[60.515663] Dynamic subtest ccs0: SUCCESS (0.005s)
[60.517779] Subtest dispatch: SUCCESS (0.032s)
[62.317232] [005/156] (954s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[62.413807] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[62.416060] Starting dynamic subtest: pipe-A-eDP-1
[62.424875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.432871] Starting dynamic subtest: pipe-B-eDP-1
[62.441618] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.451050] Starting dynamic subtest: pipe-C-eDP-1
[62.459382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.466800] Starting dynamic subtest: pipe-D-eDP-1
[62.475241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.479462] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[64.717380] [006/156] (952s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[64.771425] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[64.775860] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[64.949151] [007/156] (952s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[65.050224] Starting subtest: nonblocking-crc-frame-sequence
[65.052257] Starting dynamic subtest: pipe-A-eDP-1
[65.788962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[65.798155] Starting dynamic subtest: pipe-B-eDP-1
[67.230173] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[67.241636] Starting dynamic subtest: pipe-C-eDP-1
[68.601148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[68.609919] Starting dynamic subtest: pipe-D-eDP-1
[69.939600] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s)
[69.941653] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.904s)
[70.760097] [008/156] (946s left) perf_pmu (most-busy-check-all)
[70.799650] Starting subtest: most-busy-check-all
[70.801758] Starting dynamic subtest: rcs0
[72.329575] Dynamic subtest rcs0: SUCCESS (1.532s)
[72.342464] Starting dynamic subtest: bcs0
[74.313882] Dynamic subtest bcs0: SUCCESS (1.987s)
[74.326878] Starting dynamic subtest: vcs0
[76.297713] Dynamic subtest vcs0: SUCCESS (1.984s)
[76.308711] Starting dynamic subtest: vcs1
[78.280916] Dynamic subtest vcs1: SUCCESS (1.984s)
[78.292200] Starting dynamic subtest: vecs0
[80.330656] Dynamic subtest vecs0: SUCCESS (2.050s)
[80.341963] Starting dynamic subtest: ccs0
[82.313944] Dynamic subtest ccs0: SUCCESS (1.983s)
[82.316840] Subtest most-busy-check-all: SUCCESS (11.525s)
[82.418173] [009/156] (934s left) sysfs_timeslice_duration (duration)
[82.481159] Starting subtest: duration
[82.483529] Starting dynamic subtest: vecs0
[96.232731] Dynamic subtest vecs0: SUCCESS (13.749s)
[96.244646] Starting dynamic subtest: ccs0
[109.387351] Dynamic subtest ccs0: SUCCESS (13.154s)
[109.398350] Starting dynamic subtest: vcs0
[123.238759] Dynamic subtest vcs0: SUCCESS (13.848s)
[123.252007] Starting dynamic subtest: bcs0
[136.385613] Dynamic subtest bcs0: SUCCESS (13.147s)
[136.399777] Starting dynamic subtest: rcs0
[149.530062] Dynamic subtest rcs0: SUCCESS (13.144s)
[149.540037] Starting dynamic subtest: vcs1
[163.239538] Dynamic subtest vcs1: SUCCESS (13.705s)
[163.242544] Subtest duration: SUCCESS (80.756s)
[163.318079] [010/156] (853s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[163.423864] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[163.428517] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[163.520887] [011/156] (853s left) kms_chamelium_color (ctm-green-to-red)
[163.611193] Subtest ctm-green-to-red: SKIP (0.000s)
[163.657187] [012/156] (853s left) kms_vblank (ts-continuation-dpms-rpm)
[163.753608] Starting subtest: ts-continuation-dpms-rpm
[163.755710] Starting dynamic subtest: pipe-A-eDP-1
[166.236082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.481s)
[166.248942] Starting dynamic subtest: pipe-D-eDP-1
[168.491824] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.254s)
[168.494269] Subtest ts-continuation-dpms-rpm: SUCCESS (4.738s)
[169.361141] [013/156] (848s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[169.461205] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[169.465092] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[169.568137] [014/156] (847s left) kms_plane_scaling (planes-downscale-factor-0-75)
[169.667618] Starting subtest: planes-downscale-factor-0-75
[169.669908] Starting dynamic subtest: pipe-A
[169.691394] Dynamic subtest pipe-A: SKIP (0.019s)
[169.699442] Starting dynamic subtest: pipe-B
[169.725087] Dynamic subtest pipe-B: SKIP (0.033s)
[169.733965] Starting dynamic subtest: pipe-C
[169.756221] Dynamic subtest pipe-C: SKIP (0.033s)
[169.764238] Starting dynamic subtest: pipe-D
[169.790987] Dynamic subtest pipe-D: SKIP (0.033s)
[169.795306] Subtest planes-downscale-factor-0-75: SKIP (0.118s)
[169.883510] [015/156] (847s left) kms_draw_crc (draw-method-render)
[169.984151] Starting subtest: draw-method-render
[169.986385] Starting dynamic subtest: xrgb8888-untiled
[170.260029] Dynamic subtest xrgb8888-untiled: SUCCESS (0.277s)
[170.269729] Starting dynamic subtest: rgb565-untiled
[170.492844] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[170.500634] Starting dynamic subtest: xrgb2101010-untiled
[170.715254] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[170.723996] Starting dynamic subtest: xbgr16161616f-untiled
[170.948645] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[170.958607] Starting dynamic subtest: xrgb8888-xtiled
[171.082699] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[171.090770] Starting dynamic subtest: rgb565-xtiled
[171.215250] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[171.224355] Starting dynamic subtest: xrgb2101010-xtiled
[171.326805] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[171.337344] Starting dynamic subtest: xbgr16161616f-xtiled
[171.459569] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[171.468890] Starting dynamic subtest: xrgb8888-4tiled
[171.581999] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[171.590551] Starting dynamic subtest: rgb565-4tiled
[171.693539] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[171.701939] Starting dynamic subtest: xrgb2101010-4tiled
[171.815214] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[171.824339] Starting dynamic subtest: xbgr16161616f-4tiled
[171.949087] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[171.950991] Subtest draw-method-render: SUCCESS (1.967s)
[172.048752] [016/156] (845s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[172.141667] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[172.144973] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[172.230936] [017/156] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[172.335751] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[172.339377] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.434308] [018/156] (845s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[172.489252] Starting subtest: multi-wait-available-submitted-signaled
[172.491267] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[172.585653] [019/156] (845s left) sw_sync (sync_multi_producer_single_consumer)
[172.620694] Starting subtest: sync_multi_producer_single_consumer
[173.695637] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[173.752390] [020/156] (843s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[173.848200] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[173.852775] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[173.915427] [021/156] (843s left) gem_vm_create (invalid-create)
[173.983847] Starting subtest: invalid-create
[173.986222] Subtest invalid-create: SUCCESS (0.002s)
[174.082017] [022/156] (843s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[174.174784] Starting subtest: fbcpsrhdr-suspend
[174.179310] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[174.265907] [023/156] (843s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[174.370233] Starting subtest: 4-tiled-16bpp-rotate-270
[174.391943] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[174.491275] [024/156] (843s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[174.585777] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[174.589813] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[174.707350] [025/156] (843s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[174.829323] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[175.826366] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.993s)
[176.698561] [026/156] (841s left) gem_pxp (protected-raw-src-copy-not-readible)
[176.818665] Starting subtest: protected-raw-src-copy-not-readible
[176.881103] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[177.004825] [027/156] (840s left) kms_cursor_crc (cursor-offscreen-128x42)
[177.207573] Starting subtest: cursor-offscreen-128x42
[177.253862] Subtest cursor-offscreen-128x42: SKIP (0.044s)
[177.454270] [028/156] (840s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[177.561334] Starting subtest: yf-tiled-64bpp-rotate-180
[177.565505] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[177.655362] [029/156] (840s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[177.759064] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[177.762830] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[177.843605] [030/156] (840s left) i915_suspend (debugfs-reader)
[177.897124] Starting subtest: debugfs-reader
[196.198508] Subtest debugfs-reader: SUCCESS (3.481s)
[196.378153] [031/156] (821s left) gem_mmap_wc (write-read-distinct)
[196.446674] Subtest write-read-distinct: SKIP (0.000s)
[196.508891] [032/156] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[196.603918] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[196.607942] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[196.699897] [033/156] (821s left) kms_properties (invalid-properties-legacy)
[196.795395] Starting subtest: invalid-properties-legacy
[196.900807] Subtest invalid-properties-legacy: SUCCESS (0.107s)
[196.984500] [034/156] (821s left) kms_pm_rpm (pc8-residency)
[199.308826] Starting subtest: pc8-residency
[199.313875] Subtest pc8-residency: SKIP (0.000s)
[199.696841] [035/156] (818s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff)
[199.795345] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff
[199.799676] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[199.893988] [036/156] (818s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[200.276855] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[201.089623] [037/156] (817s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[201.196872] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[201.968003] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.782s)
[202.126208] [038/156] (816s left) kms_addfb_basic (bad-pitch-999)
[202.178550] Starting subtest: bad-pitch-999
[202.180900] Subtest bad-pitch-999: SUCCESS (0.000s)
[202.305819] [039/156] (816s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt)
[202.413934] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt
[202.418031] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[202.511665] [040/156] (816s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[202.567834] Subtest untiled-to-tiled: SKIP (0.000s)
[202.656509] [041/156] (815s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[202.771551] Starting subtest: flip-vs-cursor-toggle
[211.754738] Subtest flip-vs-cursor-toggle: SUCCESS (9.026s)
[212.575467] [042/156] (806s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[212.673316] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[212.677971] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[212.743414] [043/156] (805s left) kms_async_flips (async-flip-hang)
[212.832580] Starting subtest: async-flip-hang
[213.192737] Starting dynamic subtest: pipe-A-eDP-1
[239.574246] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.409s)
[239.978339] Starting dynamic subtest: pipe-B-eDP-1
[255.570347] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.611s)
[255.955646] Starting dynamic subtest: pipe-C-eDP-1
[271.565889] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.624s)
[271.958126] Starting dynamic subtest: pipe-D-eDP-1
[287.569598] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[287.572246] Subtest async-flip-hang: SUCCESS (74.790s)
[288.784231] [044/156] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[288.883403] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[288.887866] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[289.010814] [045/156] (729s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[289.121699] Starting subtest: cursorA-vs-flipB-varying-size
[289.126133] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[289.265888] [046/156] (729s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[289.370519] Starting subtest: yf-tiled-16bpp-rotate-0
[289.374918] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[289.465612] [047/156] (729s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[289.563665] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[289.568058] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[289.637774] [048/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[289.741014] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[289.744306] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[289.831176] [049/156] (729s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[289.928342] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[289.931869] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[290.032477] [050/156] (728s left) syncobj_timeline (multi-wait-all-signaled)
[290.083688] Starting subtest: multi-wait-all-signaled
[290.085761] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[290.178210] [051/156] (728s left) gem_ctx_persistence (heartbeat-many)
[290.242729] Starting subtest: heartbeat-many
[290.246530] Subtest heartbeat-many: SKIP (0.000s)
[290.349682] [052/156] (728s left) gen7_exec_parse (basic-rejected)
[290.406283] Subtest basic-rejected: SKIP (0.000s)
[290.479569] [053/156] (728s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[290.574353] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[290.578128] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[290.672243] [054/156] (728s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[290.777951] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[290.779910] Starting dynamic subtest: pipe-A-eDP-1
[290.798931] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.810017] Starting dynamic subtest: pipe-B-eDP-1
[290.827775] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.837230] Starting dynamic subtest: pipe-C-eDP-1
[290.855186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.864009] Starting dynamic subtest: pipe-D-eDP-1
[290.881864] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.885226] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[293.043993] [055/156] (726s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[293.148046] Starting subtest: plane-all-modeset-transition-internal-panels
[293.150214] Starting dynamic subtest: pipe-A-eDP-1
[294.496253] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.344s)
[294.783097] Starting dynamic subtest: pipe-B-eDP-1
[295.830710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[296.099908] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.944s)
[296.948780] [056/156] (722s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[297.057979] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[306.531173] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.460s)
[306.671118] [057/156] (712s left) gem_softpin (evict-prime)
[306.733099] Starting subtest: evict-prime
[306.735472] Starting dynamic subtest: rcs0
[307.909022] Dynamic subtest rcs0: SUCCESS (1.173s)
[307.922418] Starting dynamic subtest: bcs0
[309.036485] Dynamic subtest bcs0: SUCCESS (1.125s)
[309.050185] Starting dynamic subtest: vcs0
[312.122715] Dynamic subtest vcs0: SUCCESS (3.081s)
[312.135636] Starting dynamic subtest: vcs1
[314.107203] Dynamic subtest vcs1: SUCCESS (1.980s)
[314.119927] Starting dynamic subtest: vecs0
[316.154113] Dynamic subtest vecs0: SUCCESS (2.044s)
[316.169859] Starting dynamic subtest: ccs0
[317.271134] Dynamic subtest ccs0: SUCCESS (1.116s)
[317.280895] Starting dynamic subtest: all
[319.098180] Dynamic subtest all: SUCCESS (1.823s)
[319.101249] Subtest evict-prime: SUCCESS (12.352s)
[319.178952] [058/156] (700s left) gem_ctx_param (invalid-ctx-set)
[319.232994] Starting subtest: invalid-ctx-set
[319.235520] Subtest invalid-ctx-set: SUCCESS (0.001s)
[319.354878] [059/156] (699s left) kms_chamelium_frames (vga-frame-dump)
[319.749751] Subtest vga-frame-dump: SKIP (0.000s)
[320.542016] [060/156] (698s left) gem_exec_flush (basic-wb-ro-default)
[320.601369] Starting subtest: basic-wb-ro-default
[326.059073] Subtest basic-wb-ro-default: SUCCESS (5.456s)
[326.246358] [061/156] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[326.357600] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[326.362060] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[326.452505] [062/156] (692s left) kms_hdr (static-swap)
[326.539493] Starting subtest: static-swap
[326.541852] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[326.546174] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[326.556171] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[326.560259] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[326.564515] Subtest static-swap: SKIP (0.002s)
[326.613786] [063/156] (692s left) kms_plane_lowres (tiling-y)
[326.700969] Starting subtest: tiling-y
[326.705102] Subtest tiling-y: SKIP (0.000s)
[326.771005] [064/156] (692s left) kms_addfb_basic (invalid-get-prop)
[326.821515] Starting subtest: invalid-get-prop
[326.823767] Subtest invalid-get-prop: SUCCESS (0.000s)
[326.960830] [065/156] (692s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt)
[327.066723] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt
[327.071137] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[327.143336] [066/156] (692s left) kms_content_protection (lic-type-0)
[327.280651] Starting subtest: lic-type-0
[327.284648] Subtest lic-type-0: SKIP (0.000s)
[327.408335] [067/156] (692s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[327.505895] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[327.509775] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[328.603417] [068/156] (691s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[328.707575] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[328.711967] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[328.809696] [069/156] (690s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[328.933899] Starting subtest: flip-vs-cursor-atomic
[336.480421] Subtest flip-vs-cursor-atomic: SUCCESS (7.542s)
[337.338824] [070/156] (682s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[337.449180] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[337.453353] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[337.553655] [071/156] (682s left) gem_exec_balancer (hang)
[337.828856] Starting subtest: hang
[339.537537] Subtest hang: SUCCESS (1.710s)
[339.666392] [072/156] (680s left) kms_pm_dc (dc5-dpms-negative)
[340.762699] Starting subtest: dc5-dpms-negative
[340.767214] Subtest dc5-dpms-negative: SKIP (0.000s)
[340.859307] [073/156] (679s left) gem_huc_copy (huc-copy)
[340.925763] Starting subtest: huc-copy
[340.931192] Subtest huc-copy: SUCCESS (0.003s)
[341.068970] [074/156] (678s left) kms_selftest (drm_plane_helper)
[341.108082] Starting subtest: drm_plane_helper
[341.163277] Starting dynamic subtest: drm_test_check_plane_state
[341.262532] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.098s)
[341.272531] Starting dynamic subtest: drm_test_check_invalid_plane_state
[341.358376] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.093s)
[341.360636] Subtest drm_plane_helper: SUCCESS (0.251s)
[341.529729] [075/156] (678s left) gem_eio (create)
[341.762066] Starting subtest: create
[342.108503] Subtest create: SUCCESS (0.347s)
[342.219514] [076/156] (677s left) gem_exec_fence (syncobj-wait)
[342.647945] Starting subtest: syncobj-wait
[344.139940] Subtest syncobj-wait: SUCCESS (1.491s)
[344.495501] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[344.498798] [077/156] (675s left) gem_mmap_wc (write)
[344.559510] Subtest write: SKIP (0.000s)
[344.615349] [078/156] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[344.729194] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[354.178501] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.453s)
[354.333737] [079/156] (665s left) kms_psr (fbc-pr-primary-blt)
[354.437814] Starting subtest: fbc-pr-primary-blt
[354.441853] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[354.515815] [080/156] (665s left) api_intel_allocator (execbuf-with-allocator)
[354.557653] Starting subtest: execbuf-with-allocator
[354.560962] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[354.682047] [081/156] (665s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[354.787503] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[354.791957] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[354.879232] [082/156] (665s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[354.974147] Starting subtest: x-tiled-16bpp-rotate-0
[356.299261] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.325s)
[356.435066] [083/156] (663s left) kms_lease (lessee-list)
[356.533742] Starting subtest: lessee-list
[356.535761] Starting dynamic subtest: pipe-A-eDP-1
[356.537778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[356.549824] Starting dynamic subtest: pipe-B-eDP-1
[356.551659] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[356.561687] Starting dynamic subtest: pipe-C-eDP-1
[356.563639] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[356.573061] Starting dynamic subtest: pipe-D-eDP-1
[356.574921] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[356.576710] Subtest lessee-list: SUCCESS (0.011s)
[356.659951] [084/156] (663s left) kms_properties (plane-properties-legacy)
[356.751814] Starting subtest: plane-properties-legacy
[356.753488] Starting dynamic subtest: pipe-A-eDP-1
[357.287044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[357.297748] Starting dynamic subtest: pipe-B-eDP-1
[358.552241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[358.564028] Starting dynamic subtest: pipe-C-eDP-1
[359.849718] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[359.861757] Starting dynamic subtest: pipe-D-eDP-1
[361.110434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[361.112733] Subtest plane-properties-legacy: SUCCESS (4.358s)
[361.920008] [085/156] (658s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[362.015310] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[362.019743] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[362.111756] [086/156] (658s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[362.219546] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[367.162593] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.946s)
[367.279315] [087/156] (653s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[367.375969] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[367.380163] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[367.483485] [088/156] (653s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[367.579510] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[367.583789] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[367.668817] [089/156] (652s left) kms_psr (fbc-psr2-cursor-blt)
[367.762487] Starting subtest: fbc-psr2-cursor-blt
[367.764764] Starting dynamic subtest: eDP-1
[367.769266] Dynamic subtest eDP-1: SKIP (0.000s)
[367.773798] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[367.851782] [090/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[367.948488] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[367.953050] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[368.051520] [091/156] (652s left) gen9_exec_parse (valid-registers)
[368.106973] Subtest valid-registers: SKIP (0.000s)
[368.177690] [092/156] (652s left) kms_psr (fbc-psr-basic)
[368.261752] Starting subtest: fbc-psr-basic
[368.263695] Starting dynamic subtest: eDP-1
[368.267223] Dynamic subtest eDP-1: SKIP (0.000s)
[368.270831] Subtest fbc-psr-basic: SKIP (0.001s)
[368.335014] [093/156] (652s left) gem_ppgtt (shrink-vs-evict-any)
[368.400779] Starting subtest: shrink-vs-evict-any
[374.106346] Subtest shrink-vs-evict-any: SUCCESS (5.703s)
[374.202469] [094/156] (646s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[374.490203] Starting subtest: cursor-rapid-movement-512x512
[374.494870] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[374.677327] [095/156] (646s left) perf_pmu (busy-double-start)
[374.717059] Starting subtest: busy-double-start
[374.718958] Starting dynamic subtest: rcs0
[378.359428] Dynamic subtest rcs0: FAIL (3.591s)
[378.370712] Starting dynamic subtest: bcs0
[381.908933] Dynamic subtest bcs0: SUCCESS (3.599s)
[381.922022] Starting dynamic subtest: vcs0
[385.678177] Dynamic subtest vcs0: SUCCESS (3.767s)
[385.696964] Starting dynamic subtest: vcs1
[389.627217] Dynamic subtest vcs1: SUCCESS (3.947s)
[389.641271] Starting dynamic subtest: vecs0
[393.693378] Dynamic subtest vecs0: SUCCESS (4.063s)
[393.706772] Starting dynamic subtest: ccs0
[397.330142] Dynamic subtest ccs0: FAIL (3.566s)
[397.332232] Subtest busy-double-start: FAIL (22.544s)
[397.381822] [096/156] (623s left) kms_psr (pr-primary-page-flip)
[397.474479] Starting subtest: pr-primary-page-flip
[397.479068] Subtest pr-primary-page-flip: SKIP (0.000s)
[397.549331] [097/156] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[397.649697] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[397.653628] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.743521] [098/156] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[397.855420] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[397.859780] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[397.953356] [099/156] (623s left) prime_udl
[398.037409] [100/156] (623s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[398.130163] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[398.134498] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[398.245643] [101/156] (622s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[398.344413] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[398.348067] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[398.463283] [102/156] (622s left) gem_mmap_wc (write-cpu-read-wc)
[398.525068] Subtest write-cpu-read-wc: SKIP (0.000s)
[398.585185] [103/156] (622s left) i915_pm_rps (thresholds)
[398.651196] Starting subtest: thresholds
[398.655179] Subtest thresholds: SKIP (0.001s)
[398.752976] [104/156] (622s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[398.845408] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[398.848923] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[398.962047] [105/156] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[399.058123] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[399.061554] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.165876] [106/156] (622s left) syncobj_timeline (wait-for-submit-delayed-submit)
[399.219526] Starting subtest: wait-for-submit-delayed-submit
[399.320181] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[399.400497] [107/156] (621s left) gem_userptr_blits (coherency-sync)
[399.467512] Starting subtest: coherency-sync
[399.787558] Subtest coherency-sync: SKIP (0.281s)
[399.894593] [108/156] (621s left) prime_mmap (test_forked)
[400.007237] Starting subtest: test_forked
[400.009986] Starting dynamic subtest: test_forked-smem
[400.051097] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[400.053779] Subtest test_forked: SUCCESS (0.045s)
[400.150080] [109/156] (621s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-blt)
[400.250594] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-blt
[400.254703] Subtest hdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[400.355178] [110/156] (621s left) core_setmaster (master-drop-set-user)
[400.451532] Starting subtest: master-drop-set-user
[400.463058] Subtest master-drop-set-user: SUCCESS (0.016s)
[400.503977] [111/156] (620s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[400.560064] Starting subtest: framebuffer-vs-set-tiling
[400.564917] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[400.715425] [112/156] (620s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[400.808223] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[400.811599] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.903996] [113/156] (620s left) kms_flip (busy-flip)
[400.991020] Starting subtest: busy-flip
[400.992942] Starting dynamic subtest: A-eDP1
[402.754356] Dynamic subtest A-eDP1: SUCCESS (1.764s)
[402.767763] Starting dynamic subtest: B-eDP1
[404.491367] Dynamic subtest B-eDP1: SUCCESS (1.735s)
[404.504976] Starting dynamic subtest: C-eDP1
[406.213887] Dynamic subtest C-eDP1: SUCCESS (1.720s)
[406.226896] Starting dynamic subtest: D-eDP1
[407.867709] Dynamic subtest D-eDP1: SUCCESS (1.653s)
[407.870102] Subtest busy-flip: SUCCESS (6.882s)
[409.127259] [114/156] (612s left) syncobj_timeline (host-signal-points)
[409.198286] Starting subtest: host-signal-points
[409.203222] Subtest host-signal-points: SUCCESS (0.004s)
[409.295138] [115/156] (612s left) prime_busy (after)
[409.350982] Starting subtest: after
[409.353359] Starting dynamic subtest: rcs0
[409.391534] Dynamic subtest rcs0: SUCCESS (0.039s)
[409.403136] Starting dynamic subtest: bcs0
[409.429990] Dynamic subtest bcs0: SUCCESS (0.038s)
[409.440634] Starting dynamic subtest: vcs0
[409.470279] Dynamic subtest vcs0: SUCCESS (0.039s)
[409.480750] Starting dynamic subtest: vcs1
[409.509189] Dynamic subtest vcs1: SUCCESS (0.038s)
[409.519470] Starting dynamic subtest: vecs0
[409.548669] Dynamic subtest vecs0: SUCCESS (0.038s)
[409.559088] Starting dynamic subtest: ccs0
[409.587478] Dynamic subtest ccs0: SUCCESS (0.039s)
[409.696085] Subtest after: SUCCESS (0.345s)
[409.786881] [116/156] (611s left) gem_exec_schedule (pi-distinct-iova)
[409.968723] Starting subtest: pi-distinct-iova
[409.971091] Starting dynamic subtest: rcs0
[410.042887] Dynamic subtest rcs0: SUCCESS (0.077s)
[410.058157] Starting dynamic subtest: vcs0
[410.100870] Dynamic subtest vcs0: SUCCESS (0.058s)
[410.112927] Starting dynamic subtest: vcs1
[410.161864] Dynamic subtest vcs1: SUCCESS (0.059s)
[410.174152] Starting dynamic subtest: vecs0
[410.220849] Dynamic subtest vecs0: SUCCESS (0.059s)
[410.232012] Starting dynamic subtest: ccs0
[410.301390] Dynamic subtest ccs0: SUCCESS (0.079s)
[410.304339] Subtest pi-distinct-iova: SUCCESS (0.337s)
[411.229905] [117/156] (610s left) kms_psr (psr2-primary-mmap-cpu)
[411.330001] Starting subtest: psr2-primary-mmap-cpu
[411.332194] Starting dynamic subtest: eDP-1
[413.018072] Dynamic subtest eDP-1: SUCCESS (1.688s)
[413.020174] Subtest psr2-primary-mmap-cpu: SUCCESS (1.689s)
[413.895706] [118/156] (607s left) gem_exec_flush (basic-wb-pro-default)
[413.966317] Starting subtest: basic-wb-pro-default
[419.422417] Subtest basic-wb-pro-default: SUCCESS (5.457s)
[419.613645] [119/156] (602s left) fbdev (info)
[419.655561] Starting subtest: info
[419.657754] Subtest info: SUCCESS (0.000s)
[419.721927] [120/156] (602s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[419.827847] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[419.832107] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[419.939036] [121/156] (601s left) gem_softpin (softpin)
[419.992055] Starting subtest: softpin
[452.295063] Subtest softpin: SUCCESS (32.298s)
[452.429788] [122/156] (569s left) i915_module_load (reload)
[452.465255] Starting subtest: reload
[457.490282] Subtest reload: SUCCESS (5.026s)
[457.541761] [123/156] (564s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[459.086484] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[459.090827] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[459.184970] [124/156] (562s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[459.296185] Starting subtest: 4-tiled-32bpp-rotate-270
[459.336709] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.037s)
[459.457513] [125/156] (562s left) gem_ctx_isolation (clean)
[459.535210] Starting subtest: clean
[459.537701] Starting dynamic subtest: rcs0
[459.593568] Dynamic subtest rcs0: SUCCESS (0.058s)
[459.605307] Starting dynamic subtest: bcs0
[459.659094] Dynamic subtest bcs0: SUCCESS (0.064s)
[459.668868] Starting dynamic subtest: vcs0
[459.692818] Dynamic subtest vcs0: SUCCESS (0.034s)
[459.702643] Starting dynamic subtest: vcs1
[461.136683] Dynamic subtest vcs1: SUCCESS (1.443s)
[461.149766] Starting dynamic subtest: vecs0
[463.177790] Dynamic subtest vecs0: SUCCESS (2.038s)
[463.189778] Starting dynamic subtest: ccs0
[465.168073] Dynamic subtest ccs0: SUCCESS (1.989s)
[465.170880] Subtest clean: SUCCESS (5.633s)
[465.389434] [126/156] (556s left) kms_invalid_mode (int-max-clock)
[465.493096] Starting subtest: int-max-clock
[465.495520] Starting dynamic subtest: pipe-A-eDP-1
[465.788831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[465.799332] Starting dynamic subtest: pipe-B-eDP-1
[465.801520] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[465.810525] Starting dynamic subtest: pipe-C-eDP-1
[465.812809] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[465.824921] Starting dynamic subtest: pipe-D-eDP-1
[465.826952] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[465.828958] Subtest int-max-clock: SUCCESS (0.301s)
[466.644803] [127/156] (555s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[466.697541] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[466.803924] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[466.913882] [128/156] (555s left) gem_create (create-ext-placement-each)
[467.094387] Starting subtest: create-ext-placement-each
[467.097026] Subtest create-ext-placement-each: SUCCESS (0.000s)
[467.175546] [129/156] (555s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[467.269568] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[467.272362] Starting dynamic subtest: pipe-A
[467.333494] Dynamic subtest pipe-A: SUCCESS (0.066s)
[467.344814] Starting dynamic subtest: pipe-B
[468.472016] Dynamic subtest pipe-B: SUCCESS (1.138s)
[468.482582] Starting dynamic subtest: pipe-C
[469.577719] Dynamic subtest pipe-C: SUCCESS (1.105s)
[469.587290] Starting dynamic subtest: pipe-D
[470.710518] Dynamic subtest pipe-D: SUCCESS (1.132s)
[470.712917] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.444s)
[471.875995] [130/156] (550s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[471.967725] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[471.979573] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[472.055867] [131/156] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[472.152739] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[478.901394] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.753s)
[479.052104] [132/156] (543s left) gem_fence_thrash (bo-copy)
[479.091910] Starting subtest: bo-copy
[479.105965] Subtest bo-copy: SKIP (0.013s)
[479.169909] [133/156] (543s left) gem_userptr_blits (access-control)
[479.253226] Starting subtest: access-control
[479.257852] Subtest access-control: SKIP (0.000s)
[479.386827] [134/156] (543s left) kms_flip (2x-flip-vs-suspend)
[479.484825] Starting subtest: 2x-flip-vs-suspend
[479.489117] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[479.589217] [135/156] (542s left) drm_read (empty-nonblock)
[479.730496] Starting subtest: empty-nonblock
[479.732950] Subtest empty-nonblock: SUCCESS (0.000s)
[479.860874] [136/156] (542s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[479.979414] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[511.818113] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.834s)
[512.660179] [137/156] (509s left) kms_cursor_legacy (single-bo)
[512.795552] Starting subtest: single-bo
[512.797507] Starting dynamic subtest: pipe-A
[518.177067] Dynamic subtest pipe-A: SUCCESS (5.378s)
[518.192492] Starting dynamic subtest: pipe-B
[523.558316] Dynamic subtest pipe-B: SUCCESS (5.379s)
[523.570243] Starting dynamic subtest: pipe-C
[528.940101] Dynamic subtest pipe-C: SUCCESS (5.379s)
[528.952079] Starting dynamic subtest: pipe-D
[534.342114] Dynamic subtest pipe-D: SUCCESS (5.379s)
[534.353992] Starting dynamic subtest: all-pipes
[539.713152] Dynamic subtest all-pipes: SUCCESS (5.386s)
[539.715518] Subtest single-bo: SUCCESS (26.915s)
[539.861030] [138/156] (482s left) kms_color (legacy-gamma)
[539.955563] Starting subtest: legacy-gamma
[539.957682] Starting dynamic subtest: pipe-A-eDP-1
[540.696725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[540.707146] Starting dynamic subtest: pipe-B-eDP-1
[542.174672] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[542.185117] Starting dynamic subtest: pipe-C-eDP-1
[543.529832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.355s)
[543.540548] Starting dynamic subtest: pipe-D-eDP-1
[544.879979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[544.882112] Subtest legacy-gamma: SUCCESS (4.924s)
[545.686646] [139/156] (477s left) api_intel_bb (destroy-bb)
[545.739423] Starting subtest: destroy-bb
[545.748430] Subtest destroy-bb: SUCCESS (0.008s)
[545.873023] [140/156] (476s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[545.971566] Starting subtest: pr-cursor-plane-move-continuous-sf
[545.975531] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[546.069988] [141/156] (476s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[546.166775] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[546.171062] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[546.267273] [142/156] (476s left) gem_exec_store (pages)
[546.343950] Starting subtest: pages
[546.346261] Starting dynamic subtest: rcs0
[546.448477] Dynamic subtest rcs0: SUCCESS (0.107s)
[546.461135] Starting dynamic subtest: bcs0
[546.528877] Dynamic subtest bcs0: SUCCESS (0.078s)
[546.541232] Starting dynamic subtest: vcs0
[546.603635] Dynamic subtest vcs0: SUCCESS (0.074s)
[546.612991] Starting dynamic subtest: vcs1
[546.668235] Dynamic subtest vcs1: SUCCESS (0.063s)
[546.679288] Starting dynamic subtest: vecs0
[546.735474] Dynamic subtest vecs0: SUCCESS (0.067s)
[546.747492] Starting dynamic subtest: ccs0
[546.799318] Dynamic subtest ccs0: SUCCESS (0.062s)
[546.801815] Subtest pages: SUCCESS (0.459s)
[546.984369] [143/156] (475s left) gem_exec_schedule (semaphore-power)
[547.165285] Subtest semaphore-power: SKIP (0.000s)
[547.355630] [144/156] (475s left) prime_vgem (basic-fence-flip)
[547.427551] Starting subtest: basic-fence-flip
[547.725292] Subtest basic-fence-flip: SUCCESS (0.297s)
[547.819886] [145/156] (475s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[547.921317] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[547.925478] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[548.021384] [146/156] (474s left) gem_mmap_offset (bad-extensions)
[548.078292] Starting subtest: bad-extensions
[548.081158] Subtest bad-extensions: SUCCESS (0.000s)
[548.192489] [147/156] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[548.294335] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[548.298537] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[548.386433] [148/156] (474s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[548.488615] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[553.016337] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.533s)
[554.221216] [149/156] (468s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[554.336376] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[561.646785] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.316s)
[561.772370] [150/156] (461s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[561.895085] Starting subtest: cursor-tearing-framebuffer-change
[561.897286] Starting dynamic subtest: pipe-A-eDP-1
[562.460619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[562.472176] Starting dynamic subtest: pipe-D-eDP-1
[563.733437] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[563.735676] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.836s)
[564.567503] [151/156] (458s left) perf (invalid-remove-userspace-config)
[564.710027] Starting subtest: invalid-remove-userspace-config
[564.722285] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[564.771172] [152/156] (458s left) kms_psr (psr-sprite-blt)
[564.859371] Starting subtest: psr-sprite-blt
[564.861634] Starting dynamic subtest: eDP-1
[566.584119] Dynamic subtest eDP-1: SUCCESS (1.724s)
[566.586524] Subtest psr-sprite-blt: SUCCESS (1.725s)
[567.442668] [153/156] (455s left) gem_exec_fence (submit-chain)
[567.611317] Starting subtest: submit-chain
[567.630543] Subtest submit-chain: SUCCESS (0.020s)
[569.219666] [154/156] (454s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[569.326268] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[569.330751] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[569.421608] [155/156] (453s left) gem_lmem_swapping (random-engines)
[569.471284] Subtest random-engines: SKIP (0.000s)
[569.517758] [156/156] (453s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[569.614677] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[569.616937] Starting dynamic subtest: pipe-A-eDP-1
[569.639699] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[569.651191] Starting dynamic subtest: pipe-B-eDP-1
[569.672910] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[569.683481] Starting dynamic subtest: pipe-C-eDP-1
[569.705046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[569.714903] Starting dynamic subtest: pipe-D-eDP-1
[569.737741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[569.741735] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[571.894203] Closing watchdogs
results: parsing output: 0/ for test: gem_render_linear_blits
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_exec_endless
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: sysfs_timeslice_duration
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_vm_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: gem_pxp
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: i915_suspend
results: parsing output: 30/ for test: gem_mmap_wc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_set_tiling_vs_blt
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_async_flips
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_hdr
results: parsing output: 62/ for test: kms_plane_lowres
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_pm_dc
results: parsing output: 72/ for test: gem_huc_copy
results: parsing output: 73/ for test: kms_selftest
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_lease
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_ppgtt
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_udl
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_wc
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: core_setmaster
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: prime_busy
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_module_load
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: kms_invalid_mode
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_fence_thrash
results: parsing output: 132/ for test: gem_userptr_blits
results: parsing output: 133/ for test: kms_flip
results: parsing output: 134/ for test: drm_read
results: parsing output: 135/ for test: kms_cursor_legacy
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_color
results: parsing output: 138/ for test: api_intel_bb
results: parsing output: 139/ for test: kms_psr2_sf
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_exec_store
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: prime_vgem
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_mmap_offset
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_cursor_crc
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_lmem_swapping
results: parsing output: 155/ for test: kms_ccs
Done.