[64.397613] Initializing watchdogs
[64.397663]   /dev/watchdog0
[64.411617] [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]
[64.416128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.418525] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.421921] [001/155] (960s left) kms_async_flips (test-time-stamp)
[64.535762] Starting subtest: test-time-stamp
[64.908266] Starting dynamic subtest: pipe-A-eDP-1
[65.666403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.758s)
[66.033366] Starting dynamic subtest: pipe-B-eDP-1
[66.798152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.771s)
[67.172847] Starting dynamic subtest: pipe-C-eDP-1
[68.024875] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.857s)
[68.398237] Starting dynamic subtest: pipe-D-eDP-1
[69.174098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[69.176489] Subtest test-time-stamp: SUCCESS (4.638s)
[70.346609] [002/155] (954s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[70.454059] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[70.456558] Starting dynamic subtest: pipe-A
[70.473488] Dynamic subtest pipe-A: SKIP (0.017s)
[70.482396] Starting dynamic subtest: pipe-B
[70.504023] Dynamic subtest pipe-B: SKIP (0.029s)
[70.511883] Starting dynamic subtest: pipe-C
[70.531732] Dynamic subtest pipe-C: SKIP (0.029s)
[70.539768] Starting dynamic subtest: pipe-D
[70.562745] Dynamic subtest pipe-D: SKIP (0.029s)
[70.567186] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.106s)
[70.652163] [003/155] (954s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[70.752854] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[70.756946] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[70.845856] [004/155] (954s left) kms_lease (lease-invalid-plane)
[70.942905] Starting subtest: lease-invalid-plane
[70.945436] Starting dynamic subtest: pipe-A-eDP-1
[70.947626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[70.956082] Starting dynamic subtest: pipe-B-eDP-1
[70.957956] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[70.964657] Starting dynamic subtest: pipe-C-eDP-1
[70.966551] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[70.973659] Starting dynamic subtest: pipe-D-eDP-1
[70.975894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[70.978072] Subtest lease-invalid-plane: SUCCESS (0.002s)
[71.013535] [005/155] (954s left) gem_ctx_isolation (dirty-create)
[71.077588] Starting subtest: dirty-create
[71.079930] Starting dynamic subtest: rcs0
[71.276976] Dynamic subtest rcs0: SUCCESS (0.199s)
[71.284669] Starting dynamic subtest: bcs0
[71.494812] Dynamic subtest bcs0: SUCCESS (0.218s)
[71.504531] Starting dynamic subtest: vcs0
[71.712559] Dynamic subtest vcs0: SUCCESS (0.217s)
[71.720195] Starting dynamic subtest: vcs1
[73.476535] Dynamic subtest vcs1: SUCCESS (1.763s)
[73.486355] Starting dynamic subtest: vecs0
[75.465798] Dynamic subtest vecs0: SUCCESS (1.988s)
[75.476438] Starting dynamic subtest: ccs0
[77.518705] Dynamic subtest ccs0: SUCCESS (2.052s)
[77.521344] Subtest dirty-create: SUCCESS (6.441s)
[77.752435] [006/155] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[77.846698] Starting subtest: fbcpsrhdr-stridechange
[77.851270] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[77.941493] [007/155] (947s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[78.052239] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[78.056341] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.137197] [008/155] (947s left) gem_exec_parallel (userptr)
[78.196942] Starting subtest: userptr
[78.199250] Starting dynamic subtest: rcs0
[79.619749] Dynamic subtest rcs0: SUCCESS (1.422s)
[79.629202] Starting dynamic subtest: bcs0
[81.110208] Dynamic subtest bcs0: SUCCESS (1.490s)
[81.117920] Starting dynamic subtest: vcs0
[83.269927] Dynamic subtest vcs0: SUCCESS (2.157s)
[83.280377] Starting dynamic subtest: vcs1
[85.251239] Dynamic subtest vcs1: SUCCESS (1.980s)
[85.262370] Starting dynamic subtest: vecs0
[87.298322] Dynamic subtest vecs0: SUCCESS (2.046s)
[87.308861] Starting dynamic subtest: ccs0
[88.817366] Dynamic subtest ccs0: SUCCESS (1.519s)
[88.819595] Subtest userptr: SUCCESS (10.620s)
[88.998971] [009/155] (936s left) kms_fbcon_fbt (fbc)
[89.070677] Starting subtest: fbc
[95.484460] Subtest fbc: SUCCESS (6.411s)
[96.649481] [010/155] (928s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[96.752565] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[96.754979] Starting dynamic subtest: pipe-A-eDP-1
[96.775836] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[96.785784] Starting dynamic subtest: pipe-B-eDP-1
[96.805197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[96.813148] Starting dynamic subtest: pipe-C-eDP-1
[96.832588] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[96.840249] Starting dynamic subtest: pipe-D-eDP-1
[96.860172] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[96.862362] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[99.006673] [011/155] (926s left) kms_flip (flip-vs-fences-interruptible)
[99.101902] Starting subtest: flip-vs-fences-interruptible
[99.106863] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[99.208021] [012/155] (926s left) gem_partial_pwrite_pread (writes-after-reads)
[99.270652] Subtest writes-after-reads: SKIP (0.000s)
[99.349328] [013/155] (926s left) kms_flip (2x-dpms-vs-vblank-race)
[99.441088] Starting subtest: 2x-dpms-vs-vblank-race
[99.449630] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[99.538926] [014/155] (925s left) kms_addfb_basic (basic-y-tiled-legacy)
[99.585656] Starting subtest: basic-y-tiled-legacy
[99.589917] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[99.732156] [015/155] (925s left) syncobj_timeline (invalid-signal-illegal-point)
[99.785736] Starting subtest: invalid-signal-illegal-point
[99.787984] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[99.886643] [016/155] (925s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[99.973798] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[99.977422] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[101.147190] [017/155] (924s left) gem_linear_blits (interruptible)
[101.525145] Starting subtest: interruptible
[105.497357] Subtest interruptible: SUCCESS (3.971s)
[105.643048] [018/155] (919s left) syncobj_timeline (invalid-query-bad-pad)
[105.750385] Starting subtest: invalid-query-bad-pad
[105.752672] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[105.841332] [019/155] (919s left) gem_exec_reloc (basic-cpu-gtt-active)
[105.903806] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[105.978076] [020/155] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[106.086502] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[106.090860] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[106.190845] [021/155] (919s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[106.280748] Starting subtest: fbc-psr2-cursor-mmap-cpu
[106.283071] Starting dynamic subtest: eDP-1
[106.287325] Dynamic subtest eDP-1: SKIP (0.000s)
[106.291487] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[106.347187] [022/155] (919s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[106.442211] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[106.446401] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[106.505733] [023/155] (919s left) kms_flip (flip-vs-rmfb-interruptible)
[106.606696] Starting subtest: flip-vs-rmfb-interruptible
[106.608329] Starting dynamic subtest: A-eDP1
[115.241303] Dynamic subtest A-eDP1: SUCCESS (8.633s)
[115.251553] Starting dynamic subtest: B-eDP1
[123.871128] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[123.881799] Starting dynamic subtest: C-eDP1
[132.497045] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[132.505077] Starting dynamic subtest: D-eDP1
[141.129113] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[141.133517] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.526s)
[142.295984] [024/155] (883s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[142.396906] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[142.399365] Starting dynamic subtest: A-eDP1
[146.025105] Dynamic subtest A-eDP1: SUCCESS (3.626s)
[146.034763] Starting dynamic subtest: B-eDP1
[149.215455] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[149.224269] Starting dynamic subtest: C-eDP1
[152.435528] Dynamic subtest C-eDP1: SUCCESS (3.220s)
[152.444617] Starting dynamic subtest: D-eDP1
[155.625202] Dynamic subtest D-eDP1: SUCCESS (3.186s)
[155.627779] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.228s)
[156.426474] [025/155] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[156.543575] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[156.547804] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[156.632924] [026/155] (869s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[156.723606] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[156.727931] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[156.822508] [027/155] (869s left) gem_softpin (evict-active-interruptible)
[156.887583] Starting subtest: evict-active-interruptible
[156.894215] Subtest evict-active-interruptible: SUCCESS (0.006s)
[157.024658] [028/155] (868s left) gem_exec_schedule (submit-golden-slice)
[157.099291] Starting subtest: submit-golden-slice
[157.101268] Starting dynamic subtest: rcs0
[157.124598] Dynamic subtest rcs0: SUCCESS (0.034s)
[157.137826] Starting dynamic subtest: bcs0
[157.161231] Dynamic subtest bcs0: SUCCESS (0.036s)
[157.170866] Starting dynamic subtest: vcs0
[157.199996] Dynamic subtest vcs0: SUCCESS (0.038s)
[157.209544] Starting dynamic subtest: vcs1
[157.233044] Dynamic subtest vcs1: SUCCESS (0.031s)
[157.241618] Starting dynamic subtest: vecs0
[157.268124] Dynamic subtest vecs0: SUCCESS (0.033s)
[157.276338] Starting dynamic subtest: ccs0
[157.300786] Dynamic subtest ccs0: SUCCESS (0.032s)
[157.303126] Subtest submit-golden-slice: SUCCESS (0.210s)
[158.352319] [029/155] (867s left) kms_feature_discovery (psr2)
[158.440257] Starting subtest: psr2
[158.442626] Subtest psr2: SUCCESS (0.000s)
[158.508835] [030/155] (867s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[158.605103] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[158.609230] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[158.674899] [031/155] (867s left) perf (global-sseu-config)
[158.812834] Starting subtest: global-sseu-config
[158.817724] Subtest global-sseu-config: SKIP (0.000s)
[158.851793] [032/155] (867s left) i915_drm_fdinfo (virtual-busy-hang)
[158.886634] Starting subtest: virtual-busy-hang
[158.890882] Subtest virtual-busy-hang: SKIP (0.000s)
[158.950229] [033/155] (867s left) gem_exec_reloc (basic-write-read)
[159.008818] Subtest basic-write-read: SKIP (0.000s)
[159.096097] [034/155] (867s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[159.188770] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[159.192833] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[159.289250] [035/155] (866s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[159.395540] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[160.200233] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.805s)
[160.384592] [036/155] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[160.496830] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[167.581678] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.091s)
[167.696288] [037/155] (858s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[167.813184] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[167.817172] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[167.916809] [038/155] (858s left) gem_userptr_blits (huge-split)
[167.988895] Starting subtest: huge-split
[167.998267] Subtest huge-split: SUCCESS (0.009s)
[168.130207] [039/155] (858s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[168.186110] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[168.188378] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[168.283777] [040/155] (858s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[168.377278] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-blt
[168.381358] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[168.467829] [041/155] (857s left) i915_pm_rpm (debugfs-read)
[170.497873] Starting subtest: debugfs-read
[171.648029] Subtest debugfs-read: SUCCESS (1.147s)
[172.028688] [042/155] (854s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[172.088404] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[172.092839] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[172.270182] [043/155] (854s left) gen9_exec_parse (batch-without-end)
[172.318984] Subtest batch-without-end: SKIP (0.000s)
[172.382163] [044/155] (854s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-pwrite)
[172.482720] Starting subtest: fbchdr-rgb565-draw-pwrite
[172.486687] Subtest fbchdr-rgb565-draw-pwrite: SKIP (0.000s)
[172.600927] [045/155] (854s left) kms_frontbuffer_tracking (fbchdr-farfromfence-mmap-gtt)
[172.690681] Starting subtest: fbchdr-farfromfence-mmap-gtt
[172.695087] Subtest fbchdr-farfromfence-mmap-gtt: SKIP (0.000s)
[172.794854] [046/155] (853s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[172.847296] Starting subtest: invalid-bsd1-flag-on-vebox
[172.849623] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[172.951672] [047/155] (853s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[173.042561] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[173.046972] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[173.137448] [048/155] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[173.228788] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[173.232474] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[173.335646] [049/155] (853s left) gem_basic (multigpu-create-close)
[173.385411] Starting subtest: multigpu-create-close
[173.389375] Subtest multigpu-create-close: SKIP (0.000s)
[173.486589] [050/155] (853s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[173.577345] Starting subtest: primary-y-tiled-reflect-x-270
[173.581057] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[173.645337] [051/155] (853s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[173.745367] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[173.748810] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[173.825413] [052/155] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[173.925224] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[180.642868] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.721s)
[180.775124] [053/155] (846s left) gem_exec_balancer (smoke)
[180.834209] Starting subtest: smoke
[203.479529] Subtest smoke: SUCCESS (22.642s)
[205.361462] [054/155] (821s left) kms_cursor_crc (cursor-sliding-512x170)
[205.662530] Starting subtest: cursor-sliding-512x170
[205.666853] Subtest cursor-sliding-512x170: SKIP (0.001s)
[205.786515] [055/155] (821s left) api_intel_allocator (alloc-simple)
[205.832439] Starting subtest: alloc-simple
[205.834754] Subtest alloc-simple: SUCCESS (0.003s)
[205.942701] [056/155] (821s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[206.043694] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[206.048502] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[206.132523] [057/155] (820s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[206.230437] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[206.232668] Starting dynamic subtest: pipe-A-eDP-1
[206.304237] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[206.313165] Starting dynamic subtest: pipe-B-eDP-1
[207.416913] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[207.421821] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.191s)
[208.604594] [058/155] (818s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[208.705493] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[208.709895] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[208.794221] [059/155] (818s left) gem_create (create-ext-set-pat)
[208.972238] Starting subtest: create-ext-set-pat
[208.974623] Subtest create-ext-set-pat: SUCCESS (0.001s)
[209.053838] [060/155] (818s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[209.144477] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[209.148749] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[209.283106] [061/155] (817s left) kms_plane_lowres (tiling-4)
[209.368902] Starting subtest: tiling-4
[209.371499] Starting dynamic subtest: pipe-A-eDP-1
[209.376155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[209.675507] Starting dynamic subtest: pipe-B-eDP-1
[209.680262] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[209.688576] Starting dynamic subtest: pipe-C-eDP-1
[209.693341] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[209.701868] Starting dynamic subtest: pipe-D-eDP-1
[209.706507] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[209.711076] Subtest tiling-4: SKIP (0.307s)
[210.534950] [062/155] (816s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[210.635087] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[210.637359] Starting dynamic subtest: pipe-A-eDP-1
[210.646292] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[210.656068] Starting dynamic subtest: pipe-B-eDP-1
[210.664685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[210.673286] Starting dynamic subtest: pipe-C-eDP-1
[210.681762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[210.690092] Starting dynamic subtest: pipe-D-eDP-1
[210.698614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[210.702943] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[212.903099] [063/155] (814s left) core_setmaster (master-drop-set-shared-fd)
[212.984285] Starting subtest: master-drop-set-shared-fd
[213.001808] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[213.037792] [064/155] (814s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[213.135751] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[213.139665] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[213.230630] [065/155] (814s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[213.325715] Starting subtest: fbc-rgb565-draw-blt
[217.529812] Subtest fbc-rgb565-draw-blt: SUCCESS (4.209s)
[218.723492] [066/155] (808s left) i915_suspend (forcewake)
[218.784641] Starting subtest: forcewake
[250.495115] Subtest forcewake: SUCCESS (2.361s)
[250.569878] [067/155] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[250.676628] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[250.680945] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.771283] [068/155] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[250.872883] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[250.877364] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[250.978816] [069/155] (776s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[251.095758] Starting subtest: flip-vs-cursor-busy-crc-atomic
[251.812170] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.711s)
[252.679873] [070/155] (774s left) kms_getfb (getfb2-handle-closed)
[252.772212] Starting subtest: getfb2-handle-closed
[252.774490] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[252.870010] [071/155] (774s left) kms_vblank (invalid)
[252.965950] Starting subtest: invalid
[252.968233] Starting dynamic subtest: pipe-A-eDP-1
[253.383024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[253.385428] Subtest invalid: SUCCESS (0.419s)
[254.219893] [072/155] (773s left) kms_psr (pr-suspend)
[254.314018] Starting subtest: pr-suspend
[254.318199] Subtest pr-suspend: SKIP (0.000s)
[254.399475] [073/155] (773s left) core_setmaster_vs_auth
[254.563439] [074/155] (773s left) kms_flip (dpms-vs-vblank-race)
[254.658198] Starting subtest: dpms-vs-vblank-race
[254.660623] Starting dynamic subtest: A-eDP1
[258.588523] Dynamic subtest A-eDP1: SUCCESS (3.928s)
[258.599619] Starting dynamic subtest: B-eDP1
[262.173847] Dynamic subtest B-eDP1: SUCCESS (3.580s)
[262.184091] Starting dynamic subtest: C-eDP1
[265.753225] Dynamic subtest C-eDP1: SUCCESS (3.577s)
[265.763701] Starting dynamic subtest: D-eDP1
[269.371459] Dynamic subtest D-eDP1: SUCCESS (3.614s)
[269.373611] Subtest dpms-vs-vblank-race: SUCCESS (14.710s)
[270.255588] [075/155] (757s left) kms_plane (plane-panning-bottom-right)
[270.347807] Starting subtest: plane-panning-bottom-right
[270.349727] Starting dynamic subtest: pipe-A
[271.996220] Dynamic subtest pipe-A: SUCCESS (1.647s)
[272.006774] Starting dynamic subtest: pipe-B
[274.351238] Dynamic subtest pipe-B: SUCCESS (2.355s)
[274.353750] Subtest plane-panning-bottom-right: SUCCESS (4.004s)
[275.172975] [076/155] (752s left) gem_ctx_shared (q-smoketest-all)
[275.239203] Starting subtest: Q-smoketest-all
[307.632303] Subtest Q-smoketest-all: SUCCESS (32.339s)
[308.628485] [077/155] (719s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[308.737593] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[308.741789] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[308.826921] [078/155] (719s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[308.929178] Starting subtest: pipe-fbc-rte
[308.936165] Starting dynamic subtest: pipe-B-eDP-1
[314.440409] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.516s)
[314.448110] Subtest pipe-fbc-rte: SUCCESS (5.518s)
[316.720225] [079/155] (711s left) gem_exec_reloc (basic-gtt-wc-active)
[316.779952] Subtest basic-gtt-wc-active: SKIP (0.000s)
[316.873817] [080/155] (711s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[317.248706] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[318.033983] [081/155] (710s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[318.124417] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[318.128620] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[318.225502] [082/155] (709s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[318.321125] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[318.325373] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[318.411295] [083/155] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[318.514833] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[318.519294] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.597806] [084/155] (709s left) kms_plane_lowres (tiling-y)
[318.690306] Starting subtest: tiling-y
[318.694537] Subtest tiling-y: SKIP (0.000s)
[318.774794] [085/155] (709s left) syncobj_eventfd (invalid-bad-pad)
[318.833149] Starting subtest: invalid-bad-pad
[318.835352] Subtest invalid-bad-pad: SUCCESS (0.000s)
[318.923173] [086/155] (709s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[318.983214] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[319.041722] [087/155] (709s left) gem_madvise (dontneed-before-mmap)
[319.074177] Starting subtest: dontneed-before-mmap
[319.094249] Subtest dontneed-before-mmap: SUCCESS (0.019s)
[319.198279] [088/155] (709s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[319.287440] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[319.290817] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[319.367468] [089/155] (709s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[319.467027] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[319.470292] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[319.569538] [090/155] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[319.676099] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[319.679814] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[319.768920] [091/155] (708s left) kms_vblank (wait-forked-busy-hang)
[319.864563] Starting subtest: wait-forked-busy-hang
[319.866449] Starting dynamic subtest: pipe-A-eDP-1
[346.409993] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.536s)
[346.426590] Starting dynamic subtest: pipe-D-eDP-1
[361.384367] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[361.386330] Subtest wait-forked-busy-hang: SUCCESS (41.519s)
[362.208576] [092/155] (666s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[362.313379] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[363.416243] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.103s)
[363.532363] [093/155] (665s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[363.637059] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[363.640840] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[363.763281] [094/155] (664s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[363.862813] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[363.864819] Starting dynamic subtest: pipe-A-eDP-1
[369.796756] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.937s)
[369.808252] Starting dynamic subtest: pipe-B-eDP-1
[376.438721] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.641s)
[376.441030] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.580s)
[377.320319] [095/155] (651s left) gem_pxp (verify-pxp-stale-ctx-execution)
[377.460617] Starting subtest: verify-pxp-stale-ctx-execution
[378.519287] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.057s)
[378.644372] [096/155] (650s left) kms_big_fb (y-tiled-addfb-size-overflow)
[378.735944] Starting subtest: y-tiled-addfb-size-overflow
[378.740388] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[378.846358] [097/155] (649s left) gem_ctx_param (invalid-param-get)
[378.899959] Starting subtest: invalid-param-get
[378.902324] Subtest invalid-param-get: SUCCESS (0.001s)
[378.999428] [098/155] (649s left) gem_exec_whisper (basic-forked)
[379.061223] Starting subtest: basic-forked
[386.399858] Subtest basic-forked: SUCCESS (7.337s)
[386.597641] [099/155] (642s left) perf (sysctl-defaults)
[386.666020] Starting subtest: sysctl-defaults
[386.668087] Subtest sysctl-defaults: SUCCESS (0.000s)
[386.737840] [100/155] (642s left) gem_workarounds (suspend-resume-context)
[386.827733] Starting subtest: suspend-resume-context
[402.475969] Subtest suspend-resume-context: SUCCESS (1.171s)
[402.620286] [101/155] (626s left) perf_pmu (most-busy-idle-check-all)
[402.667679] Starting subtest: most-busy-idle-check-all
[402.669932] Starting dynamic subtest: rcs0
[403.375919] Dynamic subtest rcs0: FAIL (0.645s)
[403.389793] Starting dynamic subtest: bcs0
[404.149149] Dynamic subtest bcs0: SUCCESS (0.832s)
[404.162010] Starting dynamic subtest: vcs0
[406.133022] Dynamic subtest vcs0: SUCCESS (1.978s)
[406.147306] Starting dynamic subtest: vcs1
[408.116471] Dynamic subtest vcs1: SUCCESS (1.978s)
[408.134217] Starting dynamic subtest: vecs0
[410.101164] Dynamic subtest vecs0: SUCCESS (1.980s)
[410.114339] Starting dynamic subtest: ccs0
[412.149597] Dynamic subtest ccs0: SUCCESS (2.044s)
[412.152588] Subtest most-busy-idle-check-all: FAIL (9.472s)
[412.263070] [102/155] (616s left) prime_mmap (test_dup)
[412.318592] Starting subtest: test_dup
[412.320748] Starting dynamic subtest: test_dup-smem
[412.348522] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[412.350886] Subtest test_dup: SUCCESS (0.032s)
[412.428269] [103/155] (616s left) gem_exec_reloc (basic-write-read-noreloc)
[412.485739] Subtest basic-write-read-noreloc: SKIP (0.000s)
[412.571699] [104/155] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[412.670365] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[419.708620] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.040s)
[419.847502] [105/155] (609s left) gem_lmem_evict (dontneed-evict-race)
[419.895726] Subtest dontneed-evict-race: SKIP (0.000s)
[419.938795] [106/155] (609s left) syncobj_wait (wait-all-delayed-signal)
[419.997302] Starting subtest: wait-all-delayed-signal
[420.099369] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[420.185878] [107/155] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[420.283396] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[420.288051] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.383976] [108/155] (608s left) kms_big_fb (4-tiled-addfb-size-overflow)
[420.493609] Starting subtest: 4-tiled-addfb-size-overflow
[420.495981] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[420.593498] [109/155] (608s left) gem_mmap_gtt (zero-extend)
[420.647922] Subtest zero-extend: SKIP (0.000s)
[420.719937] [110/155] (608s left) gem_exec_balancer (full-late-pulse)
[420.777961] Starting subtest: full-late-pulse
[425.000079] Subtest full-late-pulse: SUCCESS (4.221s)
[425.330700] [111/155] (603s left) syncobj_wait (single-wait-all-for-submit-submitted)
[425.386764] Starting subtest: single-wait-all-for-submit-submitted
[425.488276] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[425.566047] [112/155] (603s left) sysfs_timeslice_duration (timeout)
[425.641477] Starting subtest: timeout
[425.643608] Starting dynamic subtest: vecs0
[435.119511] Dynamic subtest vecs0: SUCCESS (9.471s)
[435.132826] Starting dynamic subtest: ccs0
[436.337461] Dynamic subtest ccs0: SUCCESS (1.218s)
[436.348177] Starting dynamic subtest: vcs0
[446.133233] Dynamic subtest vcs0: SUCCESS (9.793s)
[446.143928] Starting dynamic subtest: bcs0
[446.705272] Dynamic subtest bcs0: SUCCESS (0.571s)
[446.717461] Starting dynamic subtest: rcs0
[447.917437] Dynamic subtest rcs0: SUCCESS (1.210s)
[447.930604] Starting dynamic subtest: vcs1
[457.132653] Dynamic subtest vcs1: SUCCESS (9.212s)
[457.135612] Subtest timeout: SUCCESS (31.487s)
[457.207444] [113/155] (572s left) gem_exec_params (rel-constants-invalid-ring)
[457.271844] Starting subtest: rel-constants-invalid-ring
[457.274272] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[457.392510] [114/155] (572s left) kms_rotation_crc (sprite-rotation-270)
[457.488564] Starting subtest: sprite-rotation-270
[457.492923] Subtest sprite-rotation-270: SKIP (0.001s)
[457.571051] [115/155] (571s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[457.669034] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[458.771571] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.102s)
[458.883602] [116/155] (570s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[458.945689] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[458.947613] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[459.046157] [117/155] (570s left) kms_pm_dc (dc6-psr)
[460.137897] Starting subtest: dc6-psr
[463.032205] Subtest dc6-psr: SUCCESS (2.894s)
[463.933945] [118/155] (565s left) gem_exec_schedule (pi-ringfull)
[464.108443] Starting subtest: pi-ringfull
[464.111040] Starting dynamic subtest: rcs0
[464.198194] Dynamic subtest rcs0: SUCCESS (0.093s)
[464.215560] Starting dynamic subtest: bcs0
[464.225639] Dynamic subtest bcs0: SUCCESS (0.027s)
[464.241029] Starting dynamic subtest: vcs0
[464.252156] Dynamic subtest vcs0: SUCCESS (0.026s)
[464.267466] Starting dynamic subtest: vcs1
[464.280075] Dynamic subtest vcs1: SUCCESS (0.027s)
[464.295449] Starting dynamic subtest: vecs0
[464.306224] Dynamic subtest vecs0: SUCCESS (0.025s)
[464.321508] Starting dynamic subtest: ccs0
[464.331956] Dynamic subtest ccs0: SUCCESS (0.025s)
[464.334161] Subtest pi-ringfull: SUCCESS (0.228s)
[464.549541] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[464.553148] [119/155] (565s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[464.660693] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[464.665207] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[464.767953] [120/155] (564s left) kms_color (invalid-degamma-lut-sizes)
[464.865211] Starting subtest: invalid-degamma-lut-sizes
[464.867359] Starting dynamic subtest: pipe-A
[465.159984] Dynamic subtest pipe-A: SUCCESS (0.294s)
[465.170848] Starting dynamic subtest: pipe-B
[465.173284] Dynamic subtest pipe-B: SUCCESS (0.000s)
[465.186090] Starting dynamic subtest: pipe-C
[465.188273] Dynamic subtest pipe-C: SUCCESS (0.000s)
[465.198559] Starting dynamic subtest: pipe-D
[465.200851] Dynamic subtest pipe-D: SUCCESS (0.000s)
[465.203137] Subtest invalid-degamma-lut-sizes: SUCCESS (0.297s)
[465.970242] [121/155] (563s left) syncobj_timeline (wait-all-interrupted)
[466.029192] Starting subtest: wait-all-interrupted
[466.137206] Subtest wait-all-interrupted: SUCCESS (0.106s)
[466.213999] [122/155] (563s left) gem_pxp (create-regular-context-1)
[466.317268] Starting subtest: create-regular-context-1
[466.319733] Subtest create-regular-context-1: SUCCESS (0.002s)
[466.421322] [123/155] (563s left) kms_lease (implicit-plane-lease)
[466.518326] Starting subtest: implicit-plane-lease
[466.520580] Subtest implicit-plane-lease: SUCCESS (0.003s)
[466.622575] [124/155] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[466.714476] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[471.007438] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.298s)
[472.201446] [125/155] (557s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[472.303663] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[472.308361] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[472.411845] [126/155] (557s left) gem_sync (basic-store-all)
[472.486252] Starting subtest: basic-store-all
[475.151593] Subtest basic-store-all: SUCCESS (2.675s)
[475.333006] [127/155] (554s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[475.439367] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[475.443717] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[475.515308] [128/155] (554s left) gem_pread (snoop)
[475.576170] Subtest snoop: SKIP (0.000s)
[475.645218] [129/155] (554s left) kms_cursor_crc (cursor-random-64x21)
[475.839898] Starting subtest: cursor-random-64x21
[475.884686] Subtest cursor-random-64x21: SKIP (0.040s)
[476.116056] [130/155] (553s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[476.214648] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[476.218713] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[476.298480] [131/155] (553s left) kms_content_protection (suspend-resume)
[476.440250] Starting subtest: suspend-resume
[476.444060] Subtest suspend-resume: SKIP (0.000s)
[476.561329] [132/155] (553s left) kms_chamelium_frames (vga-frame-dump)
[476.949952] Subtest vga-frame-dump: SKIP (0.000s)
[477.810666] [133/155] (552s left) kms_pipe_crc_basic (bad-source)
[477.909614] Starting subtest: bad-source
[477.911863] Subtest bad-source: SUCCESS (0.000s)
[477.981944] [134/155] (552s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[478.024250] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[478.128524] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[478.205684] [135/155] (552s left) kms_pm_backlight (fade)
[478.299777] Starting subtest: fade
[478.345630] Starting dynamic subtest: eDP-1
[481.352201] Dynamic subtest eDP-1: SUCCESS (3.005s)
[481.354557] Subtest fade: SUCCESS (3.053s)
[482.167714] [136/155] (548s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[482.253142] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[482.255600] Starting dynamic subtest: pipe-A-eDP-1
[483.601180] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.348s)
[483.879725] Starting dynamic subtest: pipe-B-eDP-1
[484.921766] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[485.191364] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.938s)
[486.037870] [137/155] (544s left) gem_spin_batch (resubmit-new-all)
[486.089953] Starting subtest: resubmit-new-all
[486.092235] Starting dynamic subtest: rcs0
[486.107136] Dynamic subtest rcs0: SUCCESS (0.017s)
[486.117438] Starting dynamic subtest: bcs0
[486.121982] Dynamic subtest bcs0: SUCCESS (0.012s)
[486.132259] Starting dynamic subtest: vcs0
[486.134360] Dynamic subtest vcs0: SUCCESS (0.009s)
[486.144330] Starting dynamic subtest: vcs1
[486.146175] Dynamic subtest vcs1: SUCCESS (0.011s)
[486.156272] Starting dynamic subtest: vecs0
[486.158485] Dynamic subtest vecs0: SUCCESS (0.008s)
[486.168527] Starting dynamic subtest: ccs0
[486.170431] Dynamic subtest ccs0: SUCCESS (0.007s)
[486.172351] Subtest resubmit-new-all: SUCCESS (0.070s)
[488.160447] [138/155] (542s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-plflip-blt)
[488.274527] Starting subtest: fbchdr-1p-primscrn-shrfb-plflip-blt
[488.278549] Subtest fbchdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[488.378957] [139/155] (542s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[488.469709] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[488.473732] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[488.568390] [140/155] (541s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[488.656425] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[488.658712] Starting dynamic subtest: pipe-A-eDP-1
[488.718958] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[488.732832] Starting dynamic subtest: pipe-B-eDP-1
[488.790292] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[488.802566] Starting dynamic subtest: pipe-C-eDP-1
[488.860178] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[488.871342] Starting dynamic subtest: pipe-D-eDP-1
[488.928331] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[488.932820] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[490.909962] [141/155] (539s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[491.024936] Starting subtest: fbcpsr-rgb565-draw-blt
[497.952744] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.932s)
[498.089508] [142/155] (532s left) kms_psr (psr2-sprite-mmap-gtt)
[498.178746] Starting subtest: psr2-sprite-mmap-gtt
[498.182454] Starting dynamic subtest: eDP-1
[499.628304] Dynamic subtest eDP-1: SKIP (1.447s)
[499.633097] Subtest psr2-sprite-mmap-gtt: SKIP (1.449s)
[499.794360] [143/155] (530s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[499.883377] Starting subtest: multiplane-rotation-cropping-top
[517.296598] Subtest multiplane-rotation-cropping-top: SUCCESS (17.415s)
[517.403650] [144/155] (513s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[517.496413] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[517.499993] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[517.602691] [145/155] (513s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[517.659640] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[517.736577] [146/155] (513s left) i915_getparams_basic (basic-eu-total)
[517.797321] Starting subtest: basic-eu-total
[517.801035] Subtest basic-eu-total: SUCCESS (0.000s)
[517.889859] [147/155] (512s left) gem_ctx_persistence (heartbeat-hang)
[517.950593] Starting subtest: heartbeat-hang
[517.954631] Subtest heartbeat-hang: SKIP (0.000s)
[518.078915] [148/155] (512s left) kms_cursor_crc (cursor-offscreen-128x128)
[518.294014] Starting subtest: cursor-offscreen-128x128
[518.299139] Starting dynamic subtest: pipe-A-eDP-1
[520.221613] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[520.249407] Starting dynamic subtest: pipe-D-eDP-1
[522.866047] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[522.868467] Subtest cursor-offscreen-128x128: SUCCESS (4.571s)
[523.733257] [149/155] (507s left) gem_exec_fence (keep-in-fence)
[523.908500] Starting subtest: keep-in-fence
[523.911095] Starting dynamic subtest: rcs0
[523.962633] Dynamic subtest rcs0: SUCCESS (0.055s)
[523.975756] Starting dynamic subtest: bcs0
[524.016688] Dynamic subtest bcs0: SUCCESS (0.052s)
[524.030324] Starting dynamic subtest: vcs0
[525.108945] Dynamic subtest vcs0: SUCCESS (1.088s)
[525.124817] Starting dynamic subtest: vcs1
[527.093836] Dynamic subtest vcs1: SUCCESS (1.983s)
[527.107236] Starting dynamic subtest: vecs0
[529.141816] Dynamic subtest vecs0: SUCCESS (2.045s)
[529.155352] Starting dynamic subtest: ccs0
[529.385642] Dynamic subtest ccs0: SUCCESS (0.242s)
[529.388595] Subtest keep-in-fence: SUCCESS (5.478s)
[531.223219] [150/155] (499s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[531.325842] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[531.329833] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[531.426918] [151/155] (499s left) kms_cursor_legacy (single-move)
[531.537735] Starting subtest: single-move
[531.539993] Starting dynamic subtest: pipe-A
[536.922251] Dynamic subtest pipe-A: SUCCESS (5.380s)
[536.934890] Starting dynamic subtest: pipe-B
[542.306519] Dynamic subtest pipe-B: SUCCESS (5.380s)
[542.318910] Starting dynamic subtest: pipe-C
[547.688479] Dynamic subtest pipe-C: SUCCESS (5.379s)
[547.699667] Starting dynamic subtest: pipe-D
[553.074586] Dynamic subtest pipe-D: SUCCESS (5.382s)
[553.088203] Starting dynamic subtest: all-pipes
[558.464964] Dynamic subtest all-pipes: SUCCESS (5.386s)
[558.467455] Subtest single-move: SUCCESS (26.922s)
[558.624887] [152/155] (472s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[558.683438] Starting subtest: invalid-bsd1-flag-on-blt
[558.685903] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[558.778379] [153/155] (472s left) kms_psr (fbc-psr-primary-mmap-gtt)
[558.870607] Starting subtest: fbc-psr-primary-mmap-gtt
[558.873041] Starting dynamic subtest: eDP-1
[558.877075] Dynamic subtest eDP-1: SKIP (0.000s)
[558.881117] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[558.946763] [154/155] (472s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[559.045399] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[559.047660] Starting dynamic subtest: pipe-A-eDP-1
[559.072472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[559.085642] Starting dynamic subtest: pipe-B-eDP-1
[559.109650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[559.120036] Starting dynamic subtest: pipe-C-eDP-1
[559.146023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[559.157970] Starting dynamic subtest: pipe-D-eDP-1
[559.181949] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[559.186350] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[561.290830] [155/155] (469s left) api_intel_bb (object-reloc-keep-cache)
[561.345846] Starting subtest: object-reloc-keep-cache
[561.352782] Subtest object-reloc-keep-cache: SKIP (0.005s)
[561.478758] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: gem_ctx_isolation
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_parallel
results: parsing output: 8/ for test: kms_fbcon_fbt
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_linear_blits
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_basic
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_create
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_plane_lowres
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: core_setmaster
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_suspend
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_getfb
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: core_setmaster_vs_auth
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_plane_lowres
results: parsing output: 84/ for test: syncobj_eventfd
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: gem_madvise
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_pxp
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_workarounds
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: prime_mmap
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_lmem_evict
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: sysfs_timeslice_duration
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: kms_rotation_crc
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_pm_dc
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_pxp
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_sync
results: parsing output: 126/ for test: kms_flip_scaled_crc
results: parsing output: 127/ for test: gem_pread
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_content_protection
results: parsing output: 131/ for test: kms_chamelium_frames
results: parsing output: 132/ for test: kms_pipe_crc_basic
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_pm_backlight
results: parsing output: 135/ for test: kms_atomic_transition
results: parsing output: 136/ for test: gem_spin_batch
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_ccs
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: kms_rotation_crc
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gem_fenced_exec_thrash
results: parsing output: 145/ for test: i915_getparams_basic
results: parsing output: 146/ for test: gem_ctx_persistence
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: gem_exec_fence
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: gem_exec_params
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: api_intel_bb
Done.