[58.266157] Initializing watchdogs
[58.266203]   /dev/watchdog0
[58.279518] [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]
[58.284146] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.286434] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.289789] [001/134] (960s left) dumb_buffer (map-uaf)
[58.375280] Starting subtest: map-uaf
[58.378278] Subtest map-uaf: SUCCESS (0.005s)
[58.496067] [002/134] (960s left) kms_cursor_crc (cursor-size-hints)
[58.638914] Starting subtest: cursor-size-hints
[58.641418] Starting dynamic subtest: pipe-A-eDP-1
[59.293395] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s)
[59.301801] Starting dynamic subtest: pipe-D-eDP-1
[60.511062] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[60.513085] Subtest cursor-size-hints: SUCCESS (1.871s)
[61.354465] [003/134] (957s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[61.466118] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[61.470685] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[62.555691] [004/134] (956s left) syncobj_wait (single-wait-for-submit-signaled)
[62.615133] Starting subtest: single-wait-for-submit-signaled
[62.617177] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[62.741736] [005/134] (956s left) gem_workarounds (basic-read)
[62.810806] Starting subtest: basic-read
[62.820701] Subtest basic-read: SUCCESS (0.010s)
[62.974645] [006/134] (956s left) kms_dp_linktrain_fallback (dsc-fallback)
[63.065420] Starting subtest: dsc-fallback
[63.071908] Subtest dsc-fallback: SKIP (0.000s)
[63.145980] [007/134] (955s left) gem_create (create-invalid-size)
[63.200804] Starting subtest: create-invalid-size
[63.202744] Subtest create-invalid-size: SUCCESS (0.000s)
[63.389822] [008/134] (955s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[63.484872] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[63.489294] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[63.595563] [009/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[63.697588] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[70.137783] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.446s)
[70.296624] [010/134] (948s left) gem_partial_pwrite_pread (reads)
[70.362416] Subtest reads: SKIP (0.000s)
[70.417170] [011/134] (948s left) api_intel_bb (object-reloc-purge-cache)
[70.473797] Starting subtest: object-reloc-purge-cache
[70.478428] Subtest object-reloc-purge-cache: SKIP (0.003s)
[70.608938] [012/134] (948s left) gem_render_copy (y-tiled-to-vebox-linear)
[70.677219] Starting subtest: y-tiled-to-vebox-linear
[70.681374] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[70.878562] [013/134] (948s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[70.969477] Starting subtest: 2x-absolute-wf_vblank-interruptible
[70.980596] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[71.087123] [014/134] (948s left) gem_softpin (allocator-nopin)
[71.147580] Starting subtest: allocator-nopin
[71.246385] Subtest allocator-nopin: SUCCESS (0.098s)
[71.380109] [015/134] (947s left) kms_pm_rpm (drm-resources-equal)
[73.096359] Starting subtest: drm-resources-equal
[78.262867] Subtest drm-resources-equal: SUCCESS (5.167s)
[78.360392] [016/134] (941s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[78.454991] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[78.457424] Starting dynamic subtest: pipe-A
[78.789566] Dynamic subtest pipe-A: SUCCESS (0.338s)
[78.798247] Starting dynamic subtest: pipe-B
[80.173479] Dynamic subtest pipe-B: SUCCESS (1.384s)
[80.182164] Starting dynamic subtest: pipe-C
[81.604124] Dynamic subtest pipe-C: SUCCESS (1.431s)
[81.612018] Starting dynamic subtest: pipe-D
[83.034390] Dynamic subtest pipe-D: SUCCESS (1.430s)
[83.036794] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.584s)
[84.200107] [017/134] (935s left) gem_ctx_persistence (engines-hang)
[84.262336] Starting subtest: engines-hang
[84.264900] Starting dynamic subtest: rcs0
[84.396820] Dynamic subtest rcs0: SUCCESS (0.134s)
[84.407509] Starting dynamic subtest: bcs0
[84.481329] Dynamic subtest bcs0: SUCCESS (0.084s)
[84.490545] Starting dynamic subtest: vcs0
[84.607731] Dynamic subtest vcs0: SUCCESS (0.125s)
[84.617622] Starting dynamic subtest: vcs1
[84.726365] Dynamic subtest vcs1: SUCCESS (0.117s)
[84.736570] Starting dynamic subtest: vecs0
[84.847265] Dynamic subtest vecs0: SUCCESS (0.120s)
[84.857297] Starting dynamic subtest: ccs0
[84.961957] Dynamic subtest ccs0: SUCCESS (0.114s)
[84.964779] Subtest engines-hang: SUCCESS (0.700s)
[85.061802] [018/134] (934s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[85.167516] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[85.193187] Starting dynamic subtest: pipe-A-plane-0
[85.197055] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[85.206099] Starting dynamic subtest: pipe-A-plane-3
[85.209972] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[85.218168] Starting dynamic subtest: pipe-A-plane-5
[85.222215] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[86.270711] Starting dynamic subtest: pipe-B-plane-0
[86.274760] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[86.284722] Starting dynamic subtest: pipe-B-plane-3
[86.289610] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[86.296164] Starting dynamic subtest: pipe-B-plane-5
[86.300613] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[86.583481] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (1.415s)
[87.457879] [019/134] (932s left) i915_pm_rc6_residency (media-rc6-accuracy)
[87.514857] Starting subtest: media-rc6-accuracy
[87.519270] Subtest media-rc6-accuracy: SKIP (0.000s)
[87.638395] [020/134] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[87.741938] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[87.745913] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[87.869179] [021/134] (931s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[87.976778] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[87.979329] Starting dynamic subtest: pipe-A-default-mode
[90.672545] Dynamic subtest pipe-A-default-mode: SUCCESS (2.695s)
[90.674543] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.696s)
[91.549295] [022/134] (928s left) kms_chamelium_hpd (vga-hpd-fast)
[91.939745] Subtest vga-hpd-fast: SKIP (0.000s)
[92.742734] [023/134] (926s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[92.803511] Starting subtest: etime-single-wait-all-for-submit-submitted
[92.903047] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[92.985696] [024/134] (926s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[93.083129] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[93.085446] Starting dynamic subtest: pipe-A-eDP-1
[93.095262] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.103754] Starting dynamic subtest: pipe-B-eDP-1
[93.112939] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.119608] Starting dynamic subtest: pipe-C-eDP-1
[93.128433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.134952] Starting dynamic subtest: pipe-D-eDP-1
[93.143582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.148267] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.006s)
[95.325759] [025/134] (924s left) kms_psr (psr-cursor-mmap-cpu)
[95.427199] Starting subtest: psr-cursor-mmap-cpu
[95.429520] Starting dynamic subtest: eDP-1
[97.112361] Dynamic subtest eDP-1: SUCCESS (1.686s)
[97.114761] Subtest psr-cursor-mmap-cpu: SUCCESS (1.687s)
[97.986865] [026/134] (921s left) kms_sequence (get-forked-busy)
[98.092351] Starting subtest: get-forked-busy
[98.094671] Starting dynamic subtest: pipe-A-eDP-1
[100.016608] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[100.024825] Starting dynamic subtest: pipe-B-eDP-1
[102.597808] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.582s)
[102.606781] Starting dynamic subtest: pipe-C-eDP-1
[105.205300] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[105.213370] Starting dynamic subtest: pipe-D-eDP-1
[107.835796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[107.838119] Subtest get-forked-busy: SUCCESS (9.742s)
[108.707897] [027/134] (911s left) sysfs_timeslice_duration (invalid)
[108.771967] Starting subtest: invalid
[108.775576] Starting dynamic subtest: vecs0
[108.777890] Dynamic subtest vecs0: SUCCESS (0.000s)
[108.784612] Starting dynamic subtest: ccs0
[108.786702] Dynamic subtest ccs0: SUCCESS (0.000s)
[108.793347] Starting dynamic subtest: vcs0
[108.795496] Dynamic subtest vcs0: SUCCESS (0.000s)
[108.802048] Starting dynamic subtest: bcs0
[108.804167] Dynamic subtest bcs0: SUCCESS (0.000s)
[108.810611] Starting dynamic subtest: rcs0
[108.812778] Dynamic subtest rcs0: SUCCESS (0.000s)
[108.819282] Starting dynamic subtest: vcs1
[108.821499] Dynamic subtest vcs1: SUCCESS (0.000s)
[108.823714] Subtest invalid: SUCCESS (0.004s)
[108.900584] [028/134] (910s left) perf (i915-ref-count)
[108.969668] Starting subtest: i915-ref-count
[109.031875] Subtest i915-ref-count: SUCCESS (0.061s)
[109.081753] [029/134] (910s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[109.138039] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[109.140373] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[109.242992] [030/134] (910s left) kms_rmfb (close-fd)
[109.328724] Starting subtest: close-fd
[109.331011] Starting dynamic subtest: pipe-A-eDP-1
[109.438251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[109.446514] Starting dynamic subtest: pipe-B-eDP-1
[110.567460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.128s)
[110.575686] Starting dynamic subtest: pipe-C-eDP-1
[111.689425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[111.696381] Starting dynamic subtest: pipe-D-eDP-1
[112.820962] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[112.823192] Subtest close-fd: SUCCESS (3.489s)
[114.061677] [031/134] (905s left) template (b)
[114.129475] Starting subtest: B
[114.131840] Subtest B: SUCCESS (0.000s)
[114.247792] [032/134] (905s left) kms_plane (pixel-format-linear-modifier)
[114.349056] Starting subtest: pixel-format-linear-modifier
[114.374864] Starting dynamic subtest: pipe-A-plane-0
[117.908138] Dynamic subtest pipe-A-plane-0: SUCCESS (3.533s)
[117.915085] Starting dynamic subtest: pipe-A-plane-3
[119.563587] Dynamic subtest pipe-A-plane-3: SUCCESS (1.655s)
[119.571488] Starting dynamic subtest: pipe-A-plane-5
[119.764041] Dynamic subtest pipe-A-plane-5: SUCCESS (0.200s)
[120.832497] Starting dynamic subtest: pipe-B-plane-0
[124.249633] Dynamic subtest pipe-B-plane-0: SUCCESS (3.422s)
[124.261825] Starting dynamic subtest: pipe-B-plane-3
[126.038815] Dynamic subtest pipe-B-plane-3: SUCCESS (1.787s)
[126.050910] Starting dynamic subtest: pipe-B-plane-5
[126.238252] Dynamic subtest pipe-B-plane-5: SUCCESS (0.198s)
[126.547386] Subtest pixel-format-linear-modifier: SUCCESS (12.197s)
[127.425111] [033/134] (892s left) gem_ctx_shared (q-promotion)
[127.495897] Starting subtest: Q-promotion
[127.498089] Starting dynamic subtest: rcs0
[127.655709] Dynamic subtest rcs0: SUCCESS (0.159s)
[127.669060] Starting dynamic subtest: vcs0
[127.735521] Dynamic subtest vcs0: SUCCESS (0.078s)
[127.752006] Starting dynamic subtest: vcs1
[127.815858] Dynamic subtest vcs1: SUCCESS (0.079s)
[127.828489] Starting dynamic subtest: vecs0
[127.891863] Dynamic subtest vecs0: SUCCESS (0.076s)
[127.904784] Starting dynamic subtest: ccs0
[127.968465] Dynamic subtest ccs0: SUCCESS (0.075s)
[127.970833] Subtest Q-promotion: SUCCESS (0.472s)
[129.067494] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[129.071092] [034/134] (890s left) kms_cursor_crc (cursor-offscreen-max-size)
[129.386703] Starting subtest: cursor-offscreen-max-size
[129.393387] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[129.545044] [035/134] (890s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[129.632297] Starting subtest: fbc-psr-sprite-mmap-gtt
[129.634445] Starting dynamic subtest: eDP-1
[129.638676] Dynamic subtest eDP-1: SKIP (0.000s)
[129.642957] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[129.716380] [036/134] (890s left) sw_sync (sync_merge_invalid)
[129.757734] Starting subtest: sync_merge_invalid
[129.776927] Subtest sync_merge_invalid: SUCCESS (0.018s)
[129.847335] [037/134] (890s left) i915_drm_fdinfo (busy-idle-check-all)
[129.885903] Starting subtest: busy-idle-check-all
[129.888285] Starting dynamic subtest: rcs0
[129.892830] Dynamic subtest rcs0: SKIP (0.004s)
[129.903888] Starting dynamic subtest: bcs0
[129.908205] Dynamic subtest bcs0: SKIP (0.000s)
[129.918172] Starting dynamic subtest: vcs0
[129.922413] Dynamic subtest vcs0: SKIP (0.000s)
[129.929442] Starting dynamic subtest: vcs1
[129.933760] Dynamic subtest vcs1: SKIP (0.000s)
[129.942435] Starting dynamic subtest: vecs0
[129.946787] Dynamic subtest vecs0: SKIP (0.000s)
[129.954178] Starting dynamic subtest: ccs0
[129.958489] Dynamic subtest ccs0: SKIP (0.000s)
[129.962803] Subtest busy-idle-check-all: SKIP (0.008s)
[130.016365] [038/134] (890s left) i915_module_load (reload)
[130.049579] Starting subtest: reload
[135.050361] Subtest reload: SUCCESS (5.001s)
[135.091251] [039/134] (885s left) gem_exec_suspend (basic-s3)
[136.835325] Starting subtest: basic-S3
[136.837985] Starting dynamic subtest: smem
[158.144132] Dynamic subtest smem: SUCCESS (7.060s)
[158.147101] Subtest basic-S3: SUCCESS (7.062s)
[158.357811] [040/134] (861s left) gem_close (many-handles-one-vma)
[158.426348] Starting subtest: many-handles-one-vma
[158.450584] Subtest many-handles-one-vma: SUCCESS (0.024s)
[158.577775] [041/134] (861s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[158.659886] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[158.662204] Starting dynamic subtest: pipe-A-eDP-1
[158.687076] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.696589] Starting dynamic subtest: pipe-B-eDP-1
[158.723703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.732073] Starting dynamic subtest: pipe-C-eDP-1
[158.757046] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.764284] Starting dynamic subtest: pipe-D-eDP-1
[158.789273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.793761] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[160.912690] [042/134] (859s left) gem_exec_balancer (parallel-out-fence)
[161.184410] Starting subtest: parallel-out-fence
[162.489613] Subtest parallel-out-fence: SUCCESS (1.311s)
[162.608612] [043/134] (857s left) gem_exec_reloc (basic-gtt-read)
[162.667347] Subtest basic-gtt-read: SKIP (0.000s)
[162.736239] [044/134] (857s left) kms_invalid_mode (bad-vsync-start)
[162.824784] Starting subtest: bad-vsync-start
[162.827259] Starting dynamic subtest: pipe-A-eDP-1
[163.120442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[163.129879] Starting dynamic subtest: pipe-B-eDP-1
[163.132475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[163.141250] Starting dynamic subtest: pipe-C-eDP-1
[163.144162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[163.158135] Starting dynamic subtest: pipe-D-eDP-1
[163.160834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[163.163532] Subtest bad-vsync-start: SUCCESS (0.302s)
[163.945015] [045/134] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[164.054467] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[164.059480] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[164.181066] [046/134] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[164.283389] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[164.288611] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.414099] [047/134] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[164.511595] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[171.097596] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.596s)
[171.213943] [048/134] (849s left) perf_pmu (busy-idle)
[171.265953] Starting subtest: busy-idle
[171.268572] Starting dynamic subtest: rcs0
[171.974061] Dynamic subtest rcs0: SUCCESS (0.712s)
[171.988616] Starting dynamic subtest: bcs0
[172.643817] Dynamic subtest bcs0: SUCCESS (0.668s)
[172.655618] Starting dynamic subtest: vcs0
[174.143970] Dynamic subtest vcs0: SUCCESS (1.497s)
[174.156046] Starting dynamic subtest: vcs1
[176.129101] Dynamic subtest vcs1: SUCCESS (1.983s)
[176.141311] Starting dynamic subtest: vecs0
[178.175936] Dynamic subtest vecs0: SUCCESS (2.044s)
[178.188221] Starting dynamic subtest: ccs0
[178.848008] Dynamic subtest ccs0: SUCCESS (0.671s)
[178.850573] Subtest busy-idle: SUCCESS (7.591s)
[178.968314] [049/134] (841s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[179.104996] Starting subtest: short-flip-after-cursor-toggle
[180.030769] Subtest short-flip-after-cursor-toggle: SUCCESS (0.923s)
[180.899670] [050/134] (839s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[180.994957] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[180.997308] Starting dynamic subtest: pipe-A
[181.016354] Dynamic subtest pipe-A: SKIP (0.017s)
[181.029204] Starting dynamic subtest: pipe-B
[181.052259] Dynamic subtest pipe-B: SKIP (0.035s)
[181.063779] Starting dynamic subtest: pipe-C
[181.089250] Dynamic subtest pipe-C: SKIP (0.035s)
[181.104131] Starting dynamic subtest: pipe-D
[181.120192] Dynamic subtest pipe-D: SKIP (0.028s)
[181.125169] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.118s)
[181.232431] [051/134] (839s left) kms_vblank (ts-continuation-modeset)
[181.320412] Starting subtest: ts-continuation-modeset
[181.323046] Starting dynamic subtest: pipe-A-eDP-1
[182.763946] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.445s)
[182.779579] Starting dynamic subtest: pipe-D-eDP-1
[184.923489] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.158s)
[184.926466] Subtest ts-continuation-modeset: SUCCESS (3.607s)
[185.731088] [052/134] (835s left) gem_exec_fence (keep-in-fence)
[185.923911] Starting subtest: keep-in-fence
[185.926595] Starting dynamic subtest: rcs0
[186.012605] Dynamic subtest rcs0: SUCCESS (0.092s)
[186.027597] Starting dynamic subtest: bcs0
[186.072892] Dynamic subtest bcs0: SUCCESS (0.056s)
[186.092917] Starting dynamic subtest: vcs0
[188.097398] Dynamic subtest vcs0: SUCCESS (2.021s)
[188.117454] Starting dynamic subtest: vcs1
[190.080777] Dynamic subtest vcs1: SUCCESS (1.981s)
[190.100543] Starting dynamic subtest: vecs0
[192.129348] Dynamic subtest vecs0: SUCCESS (2.045s)
[192.147913] Starting dynamic subtest: ccs0
[192.378632] Dynamic subtest ccs0: SUCCESS (0.247s)
[192.381643] Subtest keep-in-fence: SUCCESS (6.460s)
[194.287149] [053/134] (826s left) gem_basic (create-close)
[194.355622] Starting subtest: create-close
[194.360859] Subtest create-close: SUCCESS (0.000s)
[194.459730] [054/134] (826s left) kms_chamelium_color (gamma)
[194.556842] Subtest gamma: SKIP (0.000s)
[194.602465] [055/134] (826s left) perf_pmu (init-sema)
[194.644600] Starting subtest: init-sema
[194.647417] Starting dynamic subtest: rcs0
[194.650400] Dynamic subtest rcs0: SUCCESS (0.002s)
[194.661124] Starting dynamic subtest: bcs0
[194.663584] Dynamic subtest bcs0: SUCCESS (0.001s)
[194.672509] Starting dynamic subtest: vcs0
[194.675408] Dynamic subtest vcs0: SUCCESS (0.000s)
[194.684178] Starting dynamic subtest: vcs1
[194.686373] Dynamic subtest vcs1: SUCCESS (0.000s)
[194.695612] Starting dynamic subtest: vecs0
[194.698452] Dynamic subtest vecs0: SUCCESS (0.000s)
[194.709157] Starting dynamic subtest: ccs0
[194.711547] Dynamic subtest ccs0: SUCCESS (0.000s)
[194.714463] Subtest init-sema: SUCCESS (0.009s)
[194.757239] [056/134] (826s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[194.847498] Starting subtest: fbc-pr-sprite-mmap-cpu
[194.852539] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[194.935889] [057/134] (826s left) kms_lease (lease-get)
[195.024478] Starting subtest: lease-get
[195.027252] Starting dynamic subtest: pipe-A-eDP-1
[195.029963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[195.039077] Starting dynamic subtest: pipe-B-eDP-1
[195.041244] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[195.049790] Starting dynamic subtest: pipe-C-eDP-1
[195.051882] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[195.060359] Starting dynamic subtest: pipe-D-eDP-1
[195.062615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[195.064860] Subtest lease-get: SUCCESS (0.008s)
[195.152463] [058/134] (825s left) gem_lmem_swapping (parallel-random-verify-ccs)
[195.193383] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[195.239941] [059/134] (825s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[195.295267] Starting subtest: y-tiled-ccs-to-x-tiled
[195.300096] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[195.487987] [060/134] (825s left) gem_exec_balancer (bonded-false-hang)
[195.754624] Starting subtest: bonded-false-hang
[195.760539] Subtest bonded-false-hang: SKIP (0.000s)
[195.866779] [061/134] (825s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[200.910182] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[200.915461] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[201.765607] [062/134] (819s left) gen7_exec_parse (basic-allowed)
[201.835914] Subtest basic-allowed: SKIP (0.000s)
[201.926594] [063/134] (819s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[202.026363] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[202.029044] Starting dynamic subtest: pipe-A-eDP-1
[202.051506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[202.061593] Starting dynamic subtest: pipe-B-eDP-1
[202.084732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[202.094839] Starting dynamic subtest: pipe-C-eDP-1
[202.117235] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[202.126021] Starting dynamic subtest: pipe-D-eDP-1
[202.149082] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[202.151509] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[204.233941] [064/134] (817s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[209.311993] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[209.317276] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[210.168721] [065/134] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[210.260603] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[210.266212] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.378527] [066/134] (811s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[210.463975] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[210.465976] Starting dynamic subtest: pipe-A-eDP-1
[210.612311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[210.622591] Starting dynamic subtest: pipe-B-eDP-1
[210.642952] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[210.651355] Starting dynamic subtest: pipe-C-eDP-1
[210.671472] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[210.679491] Starting dynamic subtest: pipe-D-eDP-1
[210.701809] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[210.704078] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[212.932668] [067/134] (808s left) kms_flip (flip-vs-panning)
[213.034370] Starting subtest: flip-vs-panning
[213.036513] Starting dynamic subtest: A-eDP1
[221.763161] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[221.773174] Starting dynamic subtest: B-eDP1
[230.480338] Dynamic subtest B-eDP1: SUCCESS (8.718s)
[230.489176] Starting dynamic subtest: C-eDP1
[239.200242] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[239.212358] Starting dynamic subtest: D-eDP1
[247.922177] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[247.924492] Subtest flip-vs-panning: SUCCESS (34.902s)
[249.100529] [068/134] (772s left) syncobj_eventfd (timeline-wait)
[249.151540] Starting subtest: timeline-wait
[249.160440] Subtest timeline-wait: SUCCESS (0.010s)
[249.290661] [069/134] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[249.380786] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[249.385605] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[249.493946] [070/134] (772s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[249.601458] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[249.603919] Starting dynamic subtest: A-eDP1
[253.186455] Dynamic subtest A-eDP1: SUCCESS (3.584s)
[253.196496] Starting dynamic subtest: B-eDP1
[256.397474] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[256.406458] Starting dynamic subtest: C-eDP1
[259.500351] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[259.510332] Starting dynamic subtest: D-eDP1
[262.612028] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[262.614536] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.011s)
[263.421464] [071/134] (758s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[263.529845] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[264.538143] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.008s)
[264.714102] [072/134] (756s left) gem_mmap_offset (oob-read)
[264.773408] Starting subtest: oob-read
[264.775861] Subtest oob-read: SUCCESS (0.000s)
[264.890533] [073/134] (756s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[264.990165] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[264.992333] Starting dynamic subtest: pipe-A-default-mode
[265.298609] Dynamic subtest pipe-A-default-mode: SKIP (0.307s)
[265.304447] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.309s)
[266.157875] [074/134] (755s left) gem_pxp (regular-baseline-src-copy-readible)
[266.281498] Starting subtest: regular-baseline-src-copy-readible
[266.339364] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[266.488240] [075/134] (755s left) kms_3d (basic)
[266.562058] Starting subtest: basic
[268.530438] Subtest basic: SUCCESS (1.968s)
[269.037919] [076/134] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[269.142348] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[269.147531] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[269.259373] [077/134] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[269.365128] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[269.370120] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[269.493968] [078/134] (752s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[269.606577] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[269.611925] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[269.719663] [079/134] (752s left) gem_exec_schedule (fairslice-all)
[269.813163] Starting subtest: fairslice-all
[271.863670] Subtest fairslice-all: SUCCESS (2.055s)
[273.235092] [080/134] (748s left) kms_properties (plane-properties-atomic)
[273.343206] Starting subtest: plane-properties-atomic
[273.345915] Starting dynamic subtest: pipe-A-eDP-1
[273.902594] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[273.914192] Starting dynamic subtest: pipe-B-eDP-1
[275.212533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s)
[275.226413] Starting dynamic subtest: pipe-C-eDP-1
[276.507507] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.294s)
[276.517480] Starting dynamic subtest: pipe-D-eDP-1
[277.807315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[277.809932] Subtest plane-properties-atomic: SUCCESS (4.464s)
[278.679638] [081/134] (743s left) gem_cs_tlb (engines)
[278.742937] Starting subtest: engines
[278.745076] Starting dynamic subtest: rcs0
[280.895352] Dynamic subtest rcs0: SUCCESS (2.151s)
[280.903729] Starting dynamic subtest: bcs0
[283.050605] Dynamic subtest bcs0: SUCCESS (2.153s)
[283.060582] Starting dynamic subtest: vcs0
[285.203846] Dynamic subtest vcs0: SUCCESS (2.152s)
[285.213009] Starting dynamic subtest: vcs1
[287.358884] Dynamic subtest vcs1: SUCCESS (2.154s)
[287.369523] Starting dynamic subtest: vecs0
[289.512148] Dynamic subtest vecs0: SUCCESS (2.152s)
[289.521199] Starting dynamic subtest: ccs0
[291.666608] Dynamic subtest ccs0: SUCCESS (2.154s)
[291.669164] Subtest engines: SUCCESS (12.923s)
[291.824166] [082/134] (730s left) kms_scaling_modes (scaling-mode-none)
[291.928370] Starting subtest: scaling-mode-none
[291.930922] Starting dynamic subtest: pipe-A-eDP-1
[292.026544] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[292.037403] Starting dynamic subtest: pipe-B-eDP-1
[292.061979] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[292.071158] Starting dynamic subtest: pipe-C-eDP-1
[292.094449] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[292.106110] Starting dynamic subtest: pipe-D-eDP-1
[292.128525] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[292.133607] Subtest scaling-mode-none: SKIP (0.198s)
[292.273753] [083/134] (729s left) kms_psr (pr-sprite-render)
[292.377349] Starting subtest: pr-sprite-render
[292.382040] Subtest pr-sprite-render: SKIP (0.000s)
[292.461129] [084/134] (729s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-pwrite)
[292.558383] Starting subtest: fbc-abgr161616f-draw-pwrite
[292.564097] Subtest fbc-abgr161616f-draw-pwrite: SKIP (0.000s)
[292.690852] [085/134] (729s left) kms_flip (2x-flip-vs-expired-vblank)
[292.786291] Starting subtest: 2x-flip-vs-expired-vblank
[292.794045] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[292.934013] [086/134] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[293.034027] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[293.038497] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[293.168967] [087/134] (729s left) kms_content_protection (srm)
[293.313139] Starting subtest: srm
[293.317460] Subtest srm: SKIP (0.003s)
[293.470954] [088/134] (728s left) gem_userptr_blits (process-exit-busy)
[293.542444] Starting subtest: process-exit-busy
[293.556142] Subtest process-exit-busy: SUCCESS (0.013s)
[293.708638] [089/134] (728s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[293.822391] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[293.826767] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[293.948807] [090/134] (728s left) kms_color (invalid-degamma-lut-sizes)
[294.040018] Starting subtest: invalid-degamma-lut-sizes
[294.042230] Starting dynamic subtest: pipe-A
[294.328319] Dynamic subtest pipe-A: SUCCESS (0.287s)
[294.337916] Starting dynamic subtest: pipe-B
[294.340576] Dynamic subtest pipe-B: SUCCESS (0.000s)
[294.351905] Starting dynamic subtest: pipe-C
[294.354407] Dynamic subtest pipe-C: SUCCESS (0.000s)
[294.363664] Starting dynamic subtest: pipe-D
[294.366357] Dynamic subtest pipe-D: SUCCESS (0.000s)
[294.368658] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[295.186779] [091/134] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[295.298625] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[295.304421] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[295.402005] [092/134] (727s left) kms_pipe_crc_basic (nonblocking-crc)
[295.510873] Starting subtest: nonblocking-crc
[295.513394] Starting dynamic subtest: pipe-A-eDP-1
[296.247609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[296.259227] Starting dynamic subtest: pipe-B-eDP-1
[297.635460] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[297.646154] Starting dynamic subtest: pipe-C-eDP-1
[298.997417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s)
[299.007428] Starting dynamic subtest: pipe-D-eDP-1
[300.399416] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[300.401434] Subtest nonblocking-crc: SUCCESS (4.889s)
[301.280173] [093/134] (721s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.388981] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[302.179491] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[302.379485] [094/134] (720s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[302.477306] Starting subtest: 4-tiled-8bpp-rotate-0
[303.679182] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.204s)
[303.849378] [095/134] (718s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[303.949296] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[303.953381] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[304.069163] [096/134] (718s left) gem_exec_schedule (u-semaphore-codependency)
[304.144209] Starting subtest: u-semaphore-codependency
[304.156411] Subtest u-semaphore-codependency: SUCCESS (0.016s)
[304.527917] [097/134] (718s left) syncobj_timeline (wait-any-snapshot)
[304.585399] Starting subtest: wait-any-snapshot
[304.665344] Subtest wait-any-snapshot: SUCCESS (0.082s)
[304.757041] [098/134] (718s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[304.815491] Subtest no-spare-fences-busy: SKIP (0.000s)
[304.908619] [099/134] (717s left) kms_dsc (dsc-with-output-formats-with-bpc)
[304.995196] Starting subtest: dsc-with-output-formats-with-bpc
[305.064540] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[305.109292] [100/134] (717s left) gem_userptr_blits (dmabuf-unsync)
[305.183624] Subtest dmabuf-unsync: SKIP (0.000s)
[305.327977] [101/134] (717s left) kms_prop_blob (blob-prop-core)
[305.400747] Starting subtest: blob-prop-core
[305.403484] Subtest blob-prop-core: SUCCESS (0.000s)
[305.523432] [102/134] (717s left) gem_exec_reloc (basic-gtt-cpu)
[305.588422] Subtest basic-gtt-cpu: SKIP (0.000s)
[305.657113] [103/134] (717s left) syncobj_timeline (invalid-query-bad-pad)
[305.711609] Starting subtest: invalid-query-bad-pad
[305.714219] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[305.837056] [104/134] (717s left) vgem_basic (dmabuf-export)
[305.883401] Starting subtest: dmabuf-export
[305.934611] Subtest dmabuf-export: SUCCESS (0.058s)
[306.052597] [105/134] (717s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-gtt)
[306.163250] Starting subtest: psr-abgr161616f-draw-mmap-gtt
[306.167458] Subtest psr-abgr161616f-draw-mmap-gtt: SKIP (0.000s)
[306.287888] [106/134] (716s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[306.384860] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[306.389365] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[306.494668] [107/134] (716s left) gem_gpgpu_fill (basic)
[306.548610] Starting subtest: basic
[306.551060] Starting dynamic subtest: smem
[306.557303] Dynamic subtest smem: SUCCESS (0.010s)
[306.559442] Subtest basic: SUCCESS (0.011s)
[306.722008] [108/134] (716s left) gem_mmap_gtt (basic-copy)
[306.788821] Subtest basic-copy: SKIP (0.000s)
[306.859801] [109/134] (716s left) gen9_exec_parse (batch-invalid-length)
[306.921418] Subtest batch-invalid-length: SKIP (0.000s)
[307.001389] [110/134] (716s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[307.100101] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[307.104372] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[307.230115] [111/134] (716s left) gem_tiled_wc
[307.356596] [112/134] (716s left) gem_exec_capture (userptr)
[307.412139] Starting subtest: userptr
[308.248998] Subtest userptr: SUCCESS (0.835s)
[308.405859] [113/134] (715s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[308.514005] Starting subtest: flip-vs-dpms-off-vs-modeset
[308.516326] Starting dynamic subtest: A-eDP1
[312.195572] Dynamic subtest A-eDP1: SUCCESS (3.678s)
[312.204957] Starting dynamic subtest: B-eDP1
[315.499900] Dynamic subtest B-eDP1: SUCCESS (3.307s)
[315.509647] Starting dynamic subtest: C-eDP1
[318.792887] Dynamic subtest C-eDP1: SUCCESS (3.291s)
[318.802517] Starting dynamic subtest: D-eDP1
[322.099517] Dynamic subtest D-eDP1: SUCCESS (3.304s)
[322.102351] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.586s)
[322.983262] [114/134] (700s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[323.081776] Starting subtest: fbc-rgb565-draw-pwrite
[327.580712] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.503s)
[328.777542] [115/134] (694s left) gem_exec_whisper (basic-contexts-forked-all)
[328.860494] Starting subtest: basic-contexts-forked-all
[351.022690] Subtest basic-contexts-forked-all: SUCCESS (22.161s)
[351.233348] [116/134] (672s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[351.380253] Starting subtest: cursorB-vs-flipB-atomic
[351.385076] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[351.536662] [117/134] (672s left) gem_pread (exhaustion)
[351.596717] Subtest exhaustion: SKIP (0.000s)
[351.666077] [118/134] (672s left) gem_ctx_persistence (heartbeat-hostile)
[351.728073] Starting subtest: heartbeat-hostile
[351.733370] Subtest heartbeat-hostile: SKIP (0.000s)
[351.838067] [119/134] (671s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[351.932595] Starting subtest: extended-pageflip-modeset-hang-oldfb
[351.934900] Starting dynamic subtest: pipe-A
[359.844392] Dynamic subtest pipe-A: SUCCESS (7.912s)
[359.854354] Starting dynamic subtest: pipe-D
[368.421580] Dynamic subtest pipe-D: SUCCESS (8.576s)
[368.424520] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.494s)
[369.275596] [120/134] (654s left) gem_sync (basic-store-each)
[369.354055] Starting subtest: basic-store-each
[371.822905] Subtest basic-store-each: SUCCESS (2.481s)
[372.022855] [121/134] (651s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[372.118374] Starting subtest: psr-shrfb-scaledprimary
[377.790239] Subtest psr-shrfb-scaledprimary: SUCCESS (5.677s)
[377.929617] [122/134] (645s left) dmabuf_sync_file (import-multiple-read-only)
[377.977353] Starting subtest: import-multiple-read-only
[377.979913] Subtest import-multiple-read-only: SUCCESS (0.003s)
[378.045330] [123/134] (645s left) kms_atomic_interruptible (universal-setplane-primary)
[378.139093] Starting subtest: universal-setplane-primary
[378.141451] Starting dynamic subtest: pipe-A-eDP-1
[385.551421] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.410s)
[385.554234] Subtest universal-setplane-primary: SUCCESS (7.412s)
[386.362149] [124/134] (637s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[386.474481] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[392.994268] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.522s)
[393.145008] [125/134] (630s left) kms_cursor_edge_walk (128x128-right-edge)
[393.246479] Starting subtest: 128x128-right-edge
[393.249109] Starting dynamic subtest: pipe-A-eDP-1
[396.687571] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[396.697173] Starting dynamic subtest: pipe-D-eDP-1
[399.879864] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.189s)
[399.882578] Subtest 128x128-right-edge: SUCCESS (6.633s)
[400.764619] [126/134] (623s left) api_intel_allocator (two-level-inception)
[400.829528] Starting subtest: two-level-inception
[406.227535] Subtest two-level-inception: SUCCESS (5.399s)
[406.371422] [127/134] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[406.482990] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[406.487794] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[406.608383] [128/134] (617s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[406.668644] Starting subtest: wait-all-for-submit-delayed-submit
[406.769577] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[406.864971] [129/134] (617s left) gem_exec_schedule (pi-ringfull)
[407.053607] Starting subtest: pi-ringfull
[407.056374] Starting dynamic subtest: rcs0
[407.107610] Dynamic subtest rcs0: SUCCESS (0.057s)
[407.117938] Starting dynamic subtest: bcs0
[407.168040] Dynamic subtest bcs0: SUCCESS (0.059s)
[407.178260] Starting dynamic subtest: vcs0
[407.216661] Dynamic subtest vcs0: SUCCESS (0.048s)
[407.226514] Starting dynamic subtest: vcs1
[407.258850] Dynamic subtest vcs1: SUCCESS (0.041s)
[407.272349] Starting dynamic subtest: vecs0
[407.293770] Dynamic subtest vecs0: SUCCESS (0.034s)
[407.305911] Starting dynamic subtest: ccs0
[407.328604] Dynamic subtest ccs0: SUCCESS (0.034s)
[407.331402] Subtest pi-ringfull: SUCCESS (0.279s)
[407.579935] [130/134] (616s left) kms_async_flips (crc-atomic)
[407.678052] Starting subtest: crc-atomic
[408.054663] Starting dynamic subtest: pipe-A-eDP-1
[410.941210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.887s)
[411.330500] Starting dynamic subtest: pipe-B-eDP-1
[414.242404] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.919s)
[414.615586] Starting dynamic subtest: pipe-C-eDP-1
[417.509578] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.902s)
[417.873762] Starting dynamic subtest: pipe-D-eDP-1
[420.722613] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.861s)
[420.725390] Subtest crc-atomic: SUCCESS (13.046s)
[421.976370] [131/134] (602s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[427.036449] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[427.039353] Starting dynamic subtest: pipe-A-eDP-1
[433.503962] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.465s)
[433.521016] Starting dynamic subtest: pipe-B-eDP-1
[439.997541] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.492s)
[440.000398] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.961s)
[440.865022] [132/134] (583s left) i915_suspend (fence-restore-tiled2untiled)
[440.940994] Starting subtest: fence-restore-tiled2untiled
[440.946376] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[441.069179] [133/134] (583s left) prime_busy (after)
[441.134142] Starting subtest: after
[441.136540] Starting dynamic subtest: rcs0
[441.176228] Dynamic subtest rcs0: SUCCESS (0.042s)
[441.187008] Starting dynamic subtest: bcs0
[441.240884] Dynamic subtest bcs0: SUCCESS (0.063s)
[441.252377] Starting dynamic subtest: vcs0
[441.284297] Dynamic subtest vcs0: SUCCESS (0.042s)
[441.294115] Starting dynamic subtest: vcs1
[441.327595] Dynamic subtest vcs1: SUCCESS (0.041s)
[441.337635] Starting dynamic subtest: vecs0
[441.369232] Dynamic subtest vecs0: SUCCESS (0.040s)
[441.378615] Starting dynamic subtest: ccs0
[441.408207] Dynamic subtest ccs0: SUCCESS (0.038s)
[441.517486] Subtest after: SUCCESS (0.385s)
[441.609386] [134/134] (582s left) prime_mmap (test_refcounting)
[441.681368] Starting subtest: test_refcounting
[441.684360] Starting dynamic subtest: test_refcounting-smem
[441.712248] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[441.715347] Subtest test_refcounting: SUCCESS (0.034s)
[441.849220] Closing watchdogs
results: parsing output: 0/ for test: dumb_buffer
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_workarounds
results: parsing output: 5/ for test: kms_dp_linktrain_fallback
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_partial_pwrite_pread
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: i915_pm_rc6_residency
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: sysfs_timeslice_duration
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_rmfb
results: parsing output: 30/ for test: template
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_ctx_shared
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: sw_sync
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: i915_module_load
results: parsing output: 38/ for test: gem_exec_suspend
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_invalid_mode
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_basic
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gen7_exec_parse
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: syncobj_eventfd
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_3d
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_properties
results: parsing output: 80/ for test: gem_cs_tlb
results: parsing output: 81/ for test: kms_scaling_modes
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_content_protection
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_pipe_crc_basic
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_fenced_exec_thrash
results: parsing output: 98/ for test: kms_dsc
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_gpgpu_fill
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_tiled_wc
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_pread
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: dmabuf_sync_file
results: parsing output: 122/ for test: kms_atomic_interruptible
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_edge_walk
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_async_flips
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: i915_suspend
results: parsing output: 132/ for test: prime_busy
results: parsing output: 133/ for test: prime_mmap
Done.