[51.061029] Initializing watchdogs
[51.061162]   /dev/watchdog0
[51.076144] [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]
[51.080355] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.082475] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.085747] [001/133] (960s left) gem_exec_fence (syncobj-import)
[51.567593] Starting subtest: syncobj-import
[51.572671] Subtest syncobj-import: SUCCESS (0.008s)
[53.001455] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[53.004646] [002/133] (958s left) api_intel_bb (delta-check)
[53.077765] Starting subtest: delta-check
[53.088147] Subtest delta-check: SUCCESS (0.011s)
[53.256626] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[53.373121] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[53.377265] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[53.500445] [004/133] (958s left) gem_pwrite (basic-exhaustion)
[53.549028] Subtest basic-exhaustion: SKIP (0.000s)
[53.617775] [005/133] (958s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[53.744511] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[71.527218] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.782s)
[72.438867] [006/133] (939s left) gem_lmem_swapping (random-engines)
[72.483761] Subtest random-engines: SKIP (0.000s)
[72.521705] [007/133] (939s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[72.563637] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[72.606464] [008/133] (939s left) kms_selftest (drm_dp_mst_helper)
[72.640413] Starting subtest: drm_dp_mst_helper
[72.647639] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[72.791372] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.144s)
[72.799875] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[72.947488] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.156s)
[72.956168] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[73.091112] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.143s)
[73.093668] Subtest drm_dp_mst_helper: SUCCESS (0.452s)
[73.298900] [009/133] (938s left) gem_softpin (softpin)
[73.372297] Starting subtest: softpin
[105.687449] Subtest softpin: SUCCESS (32.309s)
[105.837473] [010/133] (906s left) gem_exec_reloc (basic-write-cpu-active)
[105.904599] Subtest basic-write-cpu-active: SKIP (0.000s)
[105.993844] [011/133] (905s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[106.234279] Starting subtest: cursor-rapid-movement-256x85
[106.285463] Subtest cursor-rapid-movement-256x85: SKIP (0.044s)
[106.480592] [012/133] (905s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[106.581094] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[106.583428] Starting dynamic subtest: pipe-A-eDP-1
[106.606479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[106.614726] Starting dynamic subtest: pipe-B-eDP-1
[106.635329] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[106.642299] Starting dynamic subtest: pipe-C-eDP-1
[106.663404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[106.671173] Starting dynamic subtest: pipe-D-eDP-1
[106.692455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[106.696480] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[108.801147] [013/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[108.898013] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[109.920935] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.022s)
[110.086416] [014/133] (902s left) kms_flip (2x-plain-flip-fb-recreate)
[110.182257] Starting subtest: 2x-plain-flip-fb-recreate
[110.191946] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[110.293677] [015/133] (901s left) kms_properties (colorop-properties-atomic)
[110.400558] Starting subtest: colorop-properties-atomic
[110.402483] Starting dynamic subtest: pipe-A-eDP-1
[110.734664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.333s)
[110.744559] Starting dynamic subtest: pipe-B-eDP-1
[111.848783] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[111.860092] Starting dynamic subtest: pipe-C-eDP-1
[112.882674] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.036s)
[112.893153] Starting dynamic subtest: pipe-D-eDP-1
[113.922418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.039s)
[113.924748] Subtest colorop-properties-atomic: SUCCESS (3.524s)
[114.747337] [016/133] (897s left) syncobj_wait (invalid-signal-one-illegal-handle)
[114.810993] Starting subtest: invalid-signal-one-illegal-handle
[114.813461] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[114.924251] [017/133] (897s left) kms_panel_fitting (legacy)
[115.021981] Starting subtest: legacy
[115.024330] Starting dynamic subtest: pipe-A-eDP-1
[115.574276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[115.604830] Starting dynamic subtest: pipe-B-eDP-1
[117.113847] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.518s)
[117.141805] Starting dynamic subtest: pipe-C-eDP-1
[118.629796] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[118.653368] Starting dynamic subtest: pipe-D-eDP-1
[120.137807] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[120.140081] Subtest legacy: SUCCESS (5.117s)
[121.388592] [018/133] (890s left) kms_draw_crc (draw-method-pwrite)
[121.491934] Starting subtest: draw-method-pwrite
[121.494297] Starting dynamic subtest: xrgb8888-untiled
[122.023271] Dynamic subtest xrgb8888-untiled: SUCCESS (0.533s)
[122.031841] Starting dynamic subtest: rgb565-untiled
[122.456665] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[122.465221] Starting dynamic subtest: xrgb2101010-untiled
[122.979606] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.523s)
[122.990232] Starting dynamic subtest: xbgr16161616f-untiled
[123.723371] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.743s)
[123.730771] Starting dynamic subtest: xrgb8888-xtiled
[125.423697] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.700s)
[125.431388] Starting dynamic subtest: rgb565-xtiled
[126.445686] Dynamic subtest rgb565-xtiled: SUCCESS (1.022s)
[126.454203] Starting dynamic subtest: xrgb2101010-xtiled
[128.134415] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.688s)
[128.142578] Starting dynamic subtest: xbgr16161616f-xtiled
[131.279298] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.144s)
[131.287104] Starting dynamic subtest: xrgb8888-4tiled
[132.334545] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.055s)
[132.342977] Starting dynamic subtest: rgb565-4tiled
[132.856826] Dynamic subtest rgb565-4tiled: SUCCESS (0.522s)
[132.865237] Starting dynamic subtest: xrgb2101010-4tiled
[133.912423] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s)
[133.920746] Starting dynamic subtest: xbgr16161616f-4tiled
[136.779170] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.866s)
[136.781546] Subtest draw-method-pwrite: SUCCESS (15.289s)
[136.920265] [019/133] (875s left) syncobj_timeline (host-signal-points)
[136.979083] Starting subtest: host-signal-points
[136.984834] Subtest host-signal-points: SUCCESS (0.007s)
[137.080258] [020/133] (875s left) gem_exec_params (invalid-batch-start-offset)
[137.139584] Starting subtest: invalid-batch-start-offset
[137.144336] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[137.288988] [021/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[137.389275] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[144.886250] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.500s)
[145.067484] [022/133] (867s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[145.177071] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[145.179221] Starting dynamic subtest: A-eDP1
[154.046815] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[154.057681] Starting dynamic subtest: B-eDP1
[162.974275] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[162.983142] Starting dynamic subtest: C-eDP1
[171.888676] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[171.896518] Starting dynamic subtest: D-eDP1
[180.735288] Dynamic subtest D-eDP1: SUCCESS (8.846s)
[180.740819] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.561s)
[181.975056] [023/133] (830s left) gem_exec_nop (basic-sequential)
[182.064203] Starting subtest: basic-sequential
[198.031413] Subtest basic-sequential: SUCCESS (15.976s)
[198.273372] [024/133] (814s left) kms_chamelium_frames (hdmi-frame-dump)
[198.664235] Subtest hdmi-frame-dump: SKIP (0.000s)
[199.449458] [025/133] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[199.555787] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[206.856379] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.302s)
[207.040688] [026/133] (805s left) gem_ctx_shared (q-in-order)
[207.101408] Starting subtest: Q-in-order
[207.103688] Starting dynamic subtest: rcs0
[207.216124] Dynamic subtest rcs0: SUCCESS (0.113s)
[207.225809] Starting dynamic subtest: vcs0
[207.310819] Dynamic subtest vcs0: SUCCESS (0.094s)
[207.320615] Starting dynamic subtest: vcs1
[207.389973] Dynamic subtest vcs1: SUCCESS (0.079s)
[207.403519] Starting dynamic subtest: vecs0
[207.466662] Dynamic subtest vecs0: SUCCESS (0.075s)
[207.481696] Starting dynamic subtest: ccs0
[207.545269] Dynamic subtest ccs0: SUCCESS (0.078s)
[207.547816] Subtest Q-in-order: SUCCESS (0.444s)
[209.035789] [027/133] (803s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[209.088515] Starting subtest: single-wait-for-submit-available-submitted
[209.090768] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[209.213066] [028/133] (803s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[209.317831] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[209.320364] Starting dynamic subtest: pipe-A-eDP-1
[225.759621] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.566s)
[225.768968] Starting dynamic subtest: pipe-B-eDP-1
[242.721981] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.422s)
[242.730277] Starting dynamic subtest: pipe-C-eDP-1
[259.704656] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.343s)
[259.713838] Starting dynamic subtest: pipe-D-eDP-1
[276.727596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.361s)
[276.729942] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.697s)
[277.963579] [029/133] (734s left) i915_drm_fdinfo (virtual-busy-hang-all)
[278.006324] Starting subtest: virtual-busy-hang-all
[278.011596] Subtest virtual-busy-hang-all: SKIP (0.000s)
[278.095809] [030/133] (734s left) kms_legacy_colorkey (invalid-plane)
[278.187139] Starting subtest: invalid-plane
[278.189876] Starting dynamic subtest: zero-id
[278.192148] Dynamic subtest zero-id: SUCCESS (0.000s)
[278.200941] Starting dynamic subtest: outrange-id
[278.203337] Dynamic subtest outrange-id: SUCCESS (0.000s)
[278.206276] Subtest invalid-plane: SUCCESS (0.001s)
[278.284420] [031/133] (734s left) gem_exec_flush (basic-wb-ro-default)
[278.348272] Starting subtest: basic-wb-ro-default
[283.809153] Subtest basic-wb-ro-default: SUCCESS (5.458s)
[284.021714] [032/133] (728s left) gem_exec_reloc (basic-wc-active)
[284.090106] Subtest basic-wc-active: SKIP (0.000s)
[284.158677] [033/133] (728s left) gem_mmap_wc (coherency)
[284.219105] Subtest coherency: SKIP (0.000s)
[284.289183] [034/133] (728s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[284.401737] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[291.830581] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.426s)
[292.012113] [035/133] (720s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[292.115002] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[296.064195] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.952s)
[297.224616] [036/133] (715s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[297.333269] Starting subtest: extended-modeset-hang-newfb-with-reset
[297.336153] Starting dynamic subtest: pipe-A
[312.610639] Dynamic subtest pipe-A: SUCCESS (15.271s)
[312.621805] Starting dynamic subtest: pipe-D
[328.694895] Dynamic subtest pipe-D: SUCCESS (16.073s)
[328.697349] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (31.349s)
[329.522047] [037/133] (683s left) gen7_exec_parse (basic-rejected)
[329.592639] Subtest basic-rejected: SKIP (0.000s)
[329.652629] [038/133] (683s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[329.743822] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[329.746153] Starting dynamic subtest: pipe-A-default-mode
[330.038165] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[330.042899] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.294s)
[330.861808] [039/133] (682s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[330.920475] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[331.015088] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.030s)
[331.053630] [040/133] (682s left) gem_userptr_blits (sync-unmap-cycles)
[331.133927] Starting subtest: sync-unmap-cycles
[336.522552] Subtest sync-unmap-cycles: SUCCESS (5.386s)
[336.679247] [041/133] (676s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[336.796873] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[336.800894] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[336.903925] [042/133] (676s left) kms_pm_rpm (system-suspend-modeset)
[338.742943] Starting subtest: system-suspend-modeset
[358.067035] Subtest system-suspend-modeset: SUCCESS (4.614s)
[358.444405] [043/133] (654s left) gem_ctx_param (non-root-set)
[358.500717] Starting subtest: non-root-set
[358.531634] Subtest non-root-set: SUCCESS (0.031s)
[358.654349] [044/133] (654s left) sw_sync (sync_merge_same)
[358.691908] Starting subtest: sync_merge_same
[358.694646] Subtest sync_merge_same: SUCCESS (0.000s)
[358.769492] [045/133] (654s left) gem_ccs (block-copy-compressed)
[358.821681] Starting subtest: block-copy-compressed
[358.826850] Subtest block-copy-compressed: SKIP (0.000s)
[358.961975] [046/133] (654s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[359.060623] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[365.736135] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.671s)
[365.889247] [047/133] (647s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[365.978677] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[365.980980] Starting dynamic subtest: pipe-A-eDP-1
[366.045895] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[366.055925] Starting dynamic subtest: pipe-B-eDP-1
[366.124709] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[366.134159] Starting dynamic subtest: pipe-C-eDP-1
[366.202952] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[366.212779] Starting dynamic subtest: pipe-D-eDP-1
[366.274557] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[366.278992] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[368.254628] [048/133] (645s left) gem_exec_schedule (u-lateslice)
[368.339957] Starting subtest: u-lateslice
[368.342486] Starting dynamic subtest: rcs0
[368.350572] Dynamic subtest rcs0: SUCCESS (0.023s)
[368.360507] Starting dynamic subtest: bcs0
[368.368403] Dynamic subtest bcs0: SUCCESS (0.017s)
[368.377255] Starting dynamic subtest: vcs0
[368.387679] Dynamic subtest vcs0: SUCCESS (0.019s)
[368.396478] Starting dynamic subtest: vcs1
[368.405597] Dynamic subtest vcs1: SUCCESS (0.017s)
[368.414176] Starting dynamic subtest: vecs0
[368.423139] Dynamic subtest vecs0: SUCCESS (0.017s)
[368.431889] Starting dynamic subtest: ccs0
[368.442134] Dynamic subtest ccs0: SUCCESS (0.018s)
[368.444951] Subtest u-lateslice: SUCCESS (0.115s)
[370.450672] [049/133] (643s left) gem_exec_fence (basic-wait)
[370.637644] Starting subtest: basic-wait
[370.639840] Starting dynamic subtest: rcs0
[370.727494] Dynamic subtest rcs0: SUCCESS (0.089s)
[370.741436] Starting dynamic subtest: bcs0
[370.803890] Dynamic subtest bcs0: SUCCESS (0.073s)
[370.815176] Starting dynamic subtest: vcs0
[370.861931] Dynamic subtest vcs0: SUCCESS (0.056s)
[370.873165] Starting dynamic subtest: vcs1
[370.924501] Dynamic subtest vcs1: SUCCESS (0.060s)
[370.935050] Starting dynamic subtest: vecs0
[370.984759] Dynamic subtest vecs0: SUCCESS (0.058s)
[370.994915] Starting dynamic subtest: ccs0
[371.046739] Dynamic subtest ccs0: SUCCESS (0.060s)
[371.049335] Subtest basic-wait: SUCCESS (0.410s)
[372.409153] [050/133] (641s left) kms_invalid_mode (uint-max-clock)
[372.525883] Starting subtest: uint-max-clock
[372.528497] Starting dynamic subtest: pipe-A-eDP-1
[372.829003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[372.839461] Starting dynamic subtest: pipe-B-eDP-1
[372.842055] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[372.850968] Starting dynamic subtest: pipe-C-eDP-1
[372.853517] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[372.861982] Starting dynamic subtest: pipe-D-eDP-1
[372.864576] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[372.867142] Subtest uint-max-clock: SUCCESS (0.307s)
[373.694016] [051/133] (639s left) kms_cursor_crc (cursor-onscreen-max-size)
[374.025544] Starting subtest: cursor-onscreen-max-size
[374.033367] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[374.197657] [052/133] (639s left) gem_exec_balancer (bonded-sync)
[374.289431] Starting subtest: bonded-sync
[374.294061] Subtest bonded-sync: SKIP (0.001s)
[374.596924] [053/133] (639s left) vgem_basic (dmabuf-fence)
[374.638118] Starting subtest: dmabuf-fence
[374.640985] Subtest dmabuf-fence: SUCCESS (0.000s)
[374.725862] [054/133] (639s left) kms_getfb (getfb-repeated-different-handles)
[374.823006] Starting subtest: getfb-repeated-different-handles
[374.825557] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[374.952234] [055/133] (638s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[375.056640] Starting subtest: fbc-1p-pri-indfb-multidraw
[388.521903] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.465s)
[389.929433] [056/133] (623s left) kms_async_flips (alternate-sync-async-flip-atomic)
[390.037919] Starting subtest: alternate-sync-async-flip-atomic
[390.416927] Starting dynamic subtest: pipe-A-eDP-1
[393.177137] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.764s)
[393.548134] Starting dynamic subtest: pipe-B-eDP-1
[396.307528] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[396.679900] Starting dynamic subtest: pipe-C-eDP-1
[399.444028] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[399.808246] Starting dynamic subtest: pipe-D-eDP-1
[402.578709] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[402.580869] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.546s)
[403.775628] [057/133] (610s left) prime_mmap (test_invalid_sync_flags)
[403.844903] Starting subtest: test_invalid_sync_flags
[403.847400] Starting dynamic subtest: test_invalid_sync_flags-smem
[403.849645] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[403.851875] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[403.973393] [058/133] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[404.072108] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[404.077407] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.204525] [059/133] (609s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[404.327910] Starting subtest: cursor-vs-flip-atomic-transitions
[434.169017] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.836s)
[435.011040] [060/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[435.127922] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[435.132720] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[435.261531] [061/133] (578s left) kms_content_protection (lic-type-1)
[435.407968] Starting subtest: lic-type-1
[435.413193] Subtest lic-type-1: SKIP (0.000s)
[435.564628] [062/133] (578s left) gen3_render_tiledx_blits
[435.688181] [063/133] (578s left) sysfs_heartbeat_interval (precise)
[435.752408] Starting subtest: precise
[435.755010] Starting dynamic subtest: vecs0
[443.313148] Dynamic subtest vecs0: SUCCESS (7.558s)
[443.324943] Starting dynamic subtest: ccs0
[444.574475] Dynamic subtest ccs0: SUCCESS (1.258s)
[444.586889] Starting dynamic subtest: vcs0
[452.337930] Dynamic subtest vcs0: SUCCESS (7.760s)
[452.350783] Starting dynamic subtest: bcs0
[453.555709] Dynamic subtest bcs0: SUCCESS (1.216s)
[453.567996] Starting dynamic subtest: rcs0
[454.671222] Dynamic subtest rcs0: SUCCESS (1.114s)
[454.683055] Starting dynamic subtest: vcs1
[462.320806] Dynamic subtest vcs1: SUCCESS (7.646s)
[462.323617] Subtest precise: SUCCESS (26.565s)
[462.431361] [064/133] (551s left) kms_pm_dc (dc5-psr)
[463.536173] Starting subtest: dc5-psr
[466.414118] Subtest dc5-psr: SUCCESS (2.877s)
[467.232411] [065/133] (546s left) gem_madvise (dontneed-before-pwrite)
[467.272271] Starting subtest: dontneed-before-pwrite
[467.295958] Subtest dontneed-before-pwrite: SKIP (0.024s)
[467.367509] [066/133] (546s left) kms_psr (pr-cursor-render)
[467.464120] Starting subtest: pr-cursor-render
[467.469183] Subtest pr-cursor-render: SKIP (0.000s)
[467.561672] [067/133] (546s left) gem_pxp (hw-rejects-pxp-context)
[467.684417] Starting subtest: hw-rejects-pxp-context
[467.690021] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[467.823518] [068/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[467.929073] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[474.306062] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.380s)
[475.532708] [069/133] (538s left) kms_psr (fbc-pr-cursor-render)
[475.633136] Starting subtest: fbc-pr-cursor-render
[475.638194] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[475.732383] [070/133] (538s left) gem_ctx_param (set-priority-range)
[475.793824] Starting subtest: set-priority-range
[475.808120] Subtest set-priority-range: SUCCESS (0.015s)
[475.955622] [071/133] (538s left) vgem_basic (unload)
[475.989708] Starting subtest: unload
[505.184181] Subtest unload: SUCCESS (29.185s)
[505.306423] [072/133] (509s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[505.419733] Starting subtest: y-tiled-64bpp-rotate-180
[505.424894] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[505.552223] [073/133] (509s left) kms_psr2_su (page_flip-nv12)
[505.613736] Subtest page_flip-NV12: SKIP (0.000s)
[505.684642] [074/133] (508s left) gem_ctx_isolation (clean)
[505.744840] Starting subtest: clean
[505.747635] Starting dynamic subtest: rcs0
[505.812986] Dynamic subtest rcs0: SUCCESS (0.067s)
[505.824553] Starting dynamic subtest: bcs0
[505.906996] Dynamic subtest bcs0: SUCCESS (0.093s)
[505.918453] Starting dynamic subtest: vcs0
[505.951304] Dynamic subtest vcs0: SUCCESS (0.044s)
[505.961414] Starting dynamic subtest: vcs1
[507.296499] Dynamic subtest vcs1: SUCCESS (1.343s)
[507.307029] Starting dynamic subtest: vecs0
[509.347166] Dynamic subtest vecs0: SUCCESS (2.049s)
[509.359797] Starting dynamic subtest: ccs0
[511.332830] Dynamic subtest ccs0: SUCCESS (1.984s)
[511.335994] Subtest clean: SUCCESS (5.586s)
[511.606960] [075/133] (503s left) i915_pm_rpm (sysfs-read)
[513.382633] Starting subtest: sysfs-read
[514.544096] Subtest sysfs-read: SUCCESS (1.157s)
[514.934859] [076/133] (499s left) kms_frontbuffer_tracking (psr-2p-rte)
[515.049024] Starting subtest: psr-2p-rte
[515.054135] Subtest psr-2p-rte: SKIP (0.000s)
[515.187249] [077/133] (499s left) gem_exec_whisper (basic-fds-all)
[515.257166] Starting subtest: basic-fds-all
[525.519970] Subtest basic-fds-all: SUCCESS (10.262s)
[525.732411] [078/133] (489s left) i915_drm_fdinfo (virtual-busy)
[525.773925] Starting subtest: virtual-busy
[525.779171] Subtest virtual-busy: SKIP (0.000s)
[525.863437] [079/133] (488s left) gem_spin_batch (legacy)
[525.934425] Starting subtest: legacy
[525.937136] Starting dynamic subtest: default
[529.194404] Dynamic subtest default: SUCCESS (3.237s)
[529.204961] Starting dynamic subtest: render
[532.410778] Dynamic subtest render: SUCCESS (3.231s)
[532.423148] Starting dynamic subtest: bsd
[535.648208] Dynamic subtest bsd: SUCCESS (3.234s)
[535.660782] Starting dynamic subtest: bsd1
[538.885255] Dynamic subtest bsd1: SUCCESS (3.233s)
[538.896785] Starting dynamic subtest: bsd2
[542.121358] Dynamic subtest bsd2: SUCCESS (3.233s)
[542.133731] Starting dynamic subtest: blt
[545.360250] Dynamic subtest blt: SUCCESS (3.234s)
[545.370168] Starting dynamic subtest: vebox
[548.597261] Dynamic subtest vebox: SUCCESS (3.233s)
[548.599849] Subtest legacy: SUCCESS (22.653s)
[549.365375] [080/133] (465s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[549.478118] Starting subtest: x-tiled-64bpp-rotate-0
[551.078822] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.600s)
[551.269672] [081/133] (463s left) gem_exec_nop (basic-parallel)
[551.346461] Starting subtest: basic-parallel
[566.299384] Subtest basic-parallel: SUCCESS (14.968s)
[566.570971] [082/133] (448s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[566.644413] Starting subtest: etime-multi-wait-for-submit-submitted
[566.750531] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.104s)
[566.857444] [083/133] (448s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[566.962869] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[566.965542] Starting dynamic subtest: pipe-A-eDP-1
[566.990346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[567.000593] Starting dynamic subtest: pipe-B-eDP-1
[567.023266] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[567.031601] Starting dynamic subtest: pipe-C-eDP-1
[567.053979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[567.061985] Starting dynamic subtest: pipe-D-eDP-1
[567.084827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[567.089459] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[569.288728] [084/133] (445s left) dmabuf_sync_file (import-basic)
[569.329411] Starting subtest: import-basic
[569.331720] Subtest import-basic: SUCCESS (0.001s)
[569.409662] [085/133] (445s left) gem_wait (write-busy)
[569.479164] Starting subtest: write-busy
[569.481707] Starting dynamic subtest: all-engines
[570.104490] Dynamic subtest all-engines: SUCCESS (0.628s)
[570.123472] Starting dynamic subtest: rcs0
[570.663727] Dynamic subtest rcs0: SUCCESS (0.557s)
[570.681696] Starting dynamic subtest: bcs0
[571.217119] Dynamic subtest bcs0: SUCCESS (0.553s)
[571.233963] Starting dynamic subtest: vcs0
[572.312915] Dynamic subtest vcs0: SUCCESS (1.094s)
[572.330263] Starting dynamic subtest: vcs1
[574.296997] Dynamic subtest vcs1: SUCCESS (1.981s)
[574.314870] Starting dynamic subtest: vecs0
[576.345434] Dynamic subtest vecs0: SUCCESS (2.046s)
[576.362117] Starting dynamic subtest: ccs0
[576.898206] Dynamic subtest ccs0: SUCCESS (0.551s)
[576.901133] Subtest write-busy: SUCCESS (7.424s)
[577.121800] [086/133] (437s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[577.235043] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[577.239998] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[577.369466] [087/133] (437s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[577.468934] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[577.473901] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[577.620307] [088/133] (437s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[577.680902] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[577.683799] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[577.815440] [089/133] (437s left) prime_vgem (sync)
[577.897627] Starting subtest: sync
[577.900129] Starting dynamic subtest: rcs0
[577.948028] Dynamic subtest rcs0: SUCCESS (0.052s)
[577.957819] Starting dynamic subtest: bcs0
[578.013763] Dynamic subtest bcs0: SUCCESS (0.065s)
[578.023172] Starting dynamic subtest: vcs0
[578.061584] Dynamic subtest vcs0: SUCCESS (0.047s)
[578.071014] Starting dynamic subtest: vcs1
[578.106825] Dynamic subtest vcs1: SUCCESS (0.045s)
[578.116154] Starting dynamic subtest: vecs0
[578.153686] Dynamic subtest vecs0: SUCCESS (0.046s)
[578.162532] Starting dynamic subtest: ccs0
[578.199030] Dynamic subtest ccs0: SUCCESS (0.045s)
[578.201556] Subtest sync: SUCCESS (0.304s)
[578.353714] [090/133] (436s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[578.462093] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[579.493544] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.033s)
[579.653129] [091/133] (435s left) kms_vblank (query-forked-busy-hang)
[579.752920] Starting subtest: query-forked-busy-hang
[579.755211] Starting dynamic subtest: pipe-A-eDP-1
[607.078660] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.324s)
[607.097911] Starting dynamic subtest: pipe-D-eDP-1
[622.108007] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.027s)
[622.110938] Subtest query-forked-busy-hang: SUCCESS (42.355s)
[622.942485] [092/133] (392s left) api_intel_allocator (execbuf-with-allocator)
[623.006025] Starting subtest: execbuf-with-allocator
[623.011268] Subtest execbuf-with-allocator: SUCCESS (0.008s)
[623.182563] [093/133] (392s left) kms_plane_multiple (tiling-x)
[623.290929] Starting subtest: tiling-x
[623.294143] Starting dynamic subtest: pipe-A-eDP-1
[626.944881] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.654s)
[626.957164] Starting dynamic subtest: pipe-B-eDP-1
[631.266615] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.321s)
[631.279799] Starting dynamic subtest: pipe-C-eDP-1
[635.582163] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.314s)
[635.593583] Starting dynamic subtest: pipe-D-eDP-1
[639.935008] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.352s)
[639.938017] Subtest tiling-x: SUCCESS (16.645s)
[640.778941] [094/133] (374s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[640.872725] Starting subtest: map-fixed-invalidate-overlap-busy
[640.877410] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[641.034261] [095/133] (374s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[641.135627] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[641.138283] Starting dynamic subtest: pipe-A-default-mode
[641.427013] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[641.432665] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.288s)
[642.347171] [096/133] (373s left) gem_exec_suspend (basic)
[642.427904] Starting subtest: basic
[642.430826] Starting dynamic subtest: smem
[644.314342] Dynamic subtest smem: SUCCESS (1.884s)
[644.317340] Subtest basic: SUCCESS (1.887s)
[644.525813] [097/133] (371s left) kms_psr (psr-cursor-render)
[644.625097] Starting subtest: psr-cursor-render
[644.627402] Starting dynamic subtest: eDP-1
[646.369773] Dynamic subtest eDP-1: SUCCESS (1.746s)
[646.372411] Subtest psr-cursor-render: SUCCESS (1.747s)
[647.263570] [098/133] (368s left) kms_chamelium_hpd (vga-hpd)
[647.657131] Subtest vga-hpd: SKIP (0.000s)
[648.448350] [099/133] (367s left) gem_reg_read (bad-register)
[648.522153] Starting subtest: bad-register
[648.524801] Subtest bad-register: SUCCESS (0.000s)
[648.640414] [100/133] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[648.742159] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[648.747659] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[648.894318] [101/133] (366s left) gem_linear_blits (basic)
[649.300737] Starting subtest: basic
[649.316814] Subtest basic: SUCCESS (0.016s)
[649.509288] [102/133] (366s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[654.634813] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[654.637658] Starting dynamic subtest: pipe-A-eDP-1
[655.429147] Dynamic subtest pipe-A-eDP-1: SKIP (0.791s)
[655.439732] Starting dynamic subtest: pipe-B-eDP-1
[656.674920] Dynamic subtest pipe-B-eDP-1: SKIP (1.244s)
[656.679654] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (2.040s)
[657.879466] [103/133] (358s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[657.956810] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[657.959348] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[658.096053] [104/133] (357s left) kms_plane_alpha_blend (alpha-7efc)
[658.201640] Starting subtest: alpha-7efc
[658.510250] Starting dynamic subtest: pipe-A-eDP-1
[659.110710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[659.138726] Starting dynamic subtest: pipe-D-eDP-1
[660.453946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[660.456799] Subtest alpha-7efc: SUCCESS (2.253s)
[661.345911] [105/133] (354s left) gem_ctx_persistence (heartbeat-many)
[661.407491] Starting subtest: heartbeat-many
[661.412962] Subtest heartbeat-many: SKIP (0.000s)
[661.539777] [106/133] (354s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[661.633676] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[661.638800] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[661.771865] [107/133] (354s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[661.882218] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[668.908047] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.029s)
[669.045888] [108/133] (347s left) gem_exec_schedule (manyslice)
[669.129816] Starting subtest: manyslice
[669.131983] Starting dynamic subtest: rcs0
[674.259942] Dynamic subtest rcs0: SUCCESS (5.140s)
[674.271554] Starting dynamic subtest: bcs0
[681.926656] Dynamic subtest bcs0: SUCCESS (7.664s)
[681.941885] Starting dynamic subtest: vcs0
[688.033065] Dynamic subtest vcs0: SUCCESS (6.104s)
[688.046719] Starting dynamic subtest: vcs1
[694.128272] Dynamic subtest vcs1: SUCCESS (6.092s)
[694.145542] Starting dynamic subtest: vecs0
[700.741610] Dynamic subtest vecs0: SUCCESS (6.611s)
[700.752936] Starting dynamic subtest: ccs0
[707.942336] Dynamic subtest ccs0: SUCCESS (7.197s)
[707.945190] Subtest manyslice: SUCCESS (38.816s)
[708.279497] [109/133] (307s left) kms_vrr (flip-basic-fastset)
[708.394167] Starting subtest: flip-basic-fastset
[708.402030] Subtest flip-basic-fastset: SKIP (0.000s)
[708.490506] [110/133] (307s left) gem_exec_reloc (basic-write-gtt-noreloc)
[708.547033] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[708.625499] [111/133] (307s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[708.734151] Starting subtest: cursorB-vs-flipB-legacy
[708.738946] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[708.901576] [112/133] (307s left) perf_pmu (busy-idle-check-all)
[708.945189] Starting subtest: busy-idle-check-all
[708.947680] Starting dynamic subtest: rcs0
[709.626964] Dynamic subtest rcs0: SUCCESS (0.682s)
[709.639419] Starting dynamic subtest: bcs0
[710.280694] Dynamic subtest bcs0: SUCCESS (0.651s)
[710.294458] Starting dynamic subtest: vcs0
[712.345548] Dynamic subtest vcs0: SUCCESS (2.061s)
[712.359792] Starting dynamic subtest: vcs1
[714.330284] Dynamic subtest vcs1: SUCCESS (1.982s)
[714.343776] Starting dynamic subtest: vecs0
[716.314347] Dynamic subtest vecs0: SUCCESS (1.981s)
[716.327390] Starting dynamic subtest: ccs0
[716.971668] Dynamic subtest ccs0: SUCCESS (0.656s)
[716.974730] Subtest busy-idle-check-all: SUCCESS (8.027s)
[717.095466] [113/133] (299s left) gem_mmap_offset (basic-uaf)
[717.151404] Starting subtest: basic-uaf
[717.153961] Subtest basic-uaf: SUCCESS (0.001s)
[717.273370] [114/133] (299s left) kms_invalid_mode (bad-hsync-start)
[717.371135] Starting subtest: bad-hsync-start
[717.373711] Starting dynamic subtest: pipe-A-eDP-1
[717.665289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[717.677016] Starting dynamic subtest: pipe-B-eDP-1
[717.679465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[717.689899] Starting dynamic subtest: pipe-C-eDP-1
[717.692766] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[717.702177] Starting dynamic subtest: pipe-D-eDP-1
[717.704742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[717.707055] Subtest bad-hsync-start: SUCCESS (0.301s)
[718.574339] [115/133] (297s left) kms_chamelium_color (ctm-0-50)
[718.676667] Subtest ctm-0-50: SKIP (0.000s)
[718.728564] [116/133] (297s left) perf (invalid-oa-format-id)
[718.896691] Starting subtest: invalid-oa-format-id
[718.907684] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[718.947040] [117/133] (297s left) gem_ringfill (legacy-basic)
[724.317177] Starting subtest: legacy-basic
[724.320144] Starting dynamic subtest: default
[724.386457] Dynamic subtest default: SUCCESS (0.070s)
[724.400180] Starting dynamic subtest: render
[724.429700] Dynamic subtest render: SUCCESS (0.041s)
[724.440977] Starting dynamic subtest: bsd
[724.474120] Dynamic subtest bsd: SUCCESS (0.042s)
[724.485163] Starting dynamic subtest: bsd1
[724.517060] Dynamic subtest bsd1: SUCCESS (0.041s)
[724.528672] Starting dynamic subtest: bsd2
[724.556851] Dynamic subtest bsd2: SUCCESS (0.038s)
[724.567452] Starting dynamic subtest: blt
[724.601850] Dynamic subtest blt: SUCCESS (0.043s)
[724.612961] Starting dynamic subtest: vebox
[724.644891] Dynamic subtest vebox: SUCCESS (0.041s)
[724.647627] Subtest legacy-basic: SUCCESS (0.330s)
[724.748265] [118/133] (291s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-wc)
[724.859860] Starting subtest: fbcpsr-argb161616f-draw-mmap-wc
[724.864860] Subtest fbcpsr-argb161616f-draw-mmap-wc: SKIP (0.000s)
[724.999742] [119/133] (291s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[725.100884] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[725.103594] Starting dynamic subtest: pipe-A
[725.121822] Dynamic subtest pipe-A: SKIP (0.017s)
[725.137604] Starting dynamic subtest: pipe-B
[725.152072] Dynamic subtest pipe-B: SKIP (0.029s)
[725.163903] Starting dynamic subtest: pipe-C
[725.191875] Dynamic subtest pipe-C: SKIP (0.039s)
[725.201931] Starting dynamic subtest: pipe-D
[725.223743] Dynamic subtest pipe-D: SKIP (0.031s)
[725.228703] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.119s)
[725.356620] [120/133] (291s left) kms_psr (fbc-psr-primary-blt)
[725.453689] Starting subtest: fbc-psr-primary-blt
[725.456059] Starting dynamic subtest: eDP-1
[725.460442] Dynamic subtest eDP-1: SKIP (0.000s)
[725.464435] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[725.559610] [121/133] (291s left) i915_selftest (perf)
[730.292936] Starting subtest: perf
[730.295634] Starting dynamic subtest: engine_cs
[734.586829] Dynamic subtest engine_cs: SUCCESS (4.291s)
[734.596997] Starting dynamic subtest: request
[741.262313] Dynamic subtest request: SUCCESS (6.671s)
[741.272367] Starting dynamic subtest: migrate
[745.568161] Dynamic subtest migrate: SUCCESS (4.304s)
[745.578840] Starting dynamic subtest: region
[751.274536] Dynamic subtest region: SUCCESS (5.703s)
[751.277720] Subtest perf: SUCCESS (20.977s)
[751.310862] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[751.311572] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[751.315357] [122/133] (265s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[754.267763] Starting subtest: 4-tiled-32bpp-rotate-0
[755.624840] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.362s)
[755.900014] [FACT kms_big_fb (4-tiled-32bpp-rotate-0)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[755.901207] [FACT kms_big_fb (4-tiled-32bpp-rotate-0)] new: kernel.kmod_is_loaded.i915: true
[755.905272] [123/133] (260s left) kms_cursor_crc (cursor-sliding-64x21)
[756.103338] Starting subtest: cursor-sliding-64x21
[756.156762] Subtest cursor-sliding-64x21: SKIP (0.046s)
[756.439674] [124/133] (260s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[756.539138] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[760.513667] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.977s)
[761.694507] [125/133] (255s left) kms_async_flips (crc-atomic)
[761.787297] Starting subtest: crc-atomic
[762.161770] Starting dynamic subtest: pipe-A-eDP-1
[765.059002] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.898s)
[765.435897] Starting dynamic subtest: pipe-B-eDP-1
[768.301252] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.872s)
[768.688707] Starting dynamic subtest: pipe-C-eDP-1
[771.605131] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.924s)
[771.975860] Starting dynamic subtest: pipe-D-eDP-1
[774.840008] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.878s)
[774.843005] Subtest crc-atomic: SUCCESS (13.048s)
[776.028295] [126/133] (240s left) gem_exec_parallel (contexts)
[776.113875] Starting subtest: contexts
[776.116538] Starting dynamic subtest: rcs0
[779.412140] Dynamic subtest rcs0: SUCCESS (3.299s)
[779.424787] Starting dynamic subtest: bcs0
[783.469154] Dynamic subtest bcs0: SUCCESS (4.053s)
[783.479408] Starting dynamic subtest: vcs0
[787.818061] Dynamic subtest vcs0: SUCCESS (4.345s)
[787.830989] Starting dynamic subtest: vcs1
[793.647993] Dynamic subtest vcs1: SUCCESS (5.826s)
[793.658440] Starting dynamic subtest: vecs0
[799.717152] Dynamic subtest vecs0: SUCCESS (6.064s)
[799.730200] Starting dynamic subtest: ccs0
[804.450140] Dynamic subtest ccs0: SUCCESS (4.731s)
[804.453169] Subtest contexts: SUCCESS (28.333s)
[804.667617] [127/133] (212s left) kms_psr (psr2-cursor-mmap-cpu)
[804.760887] Starting subtest: psr2-cursor-mmap-cpu
[804.763647] Starting dynamic subtest: eDP-1
[806.491030] Dynamic subtest eDP-1: SUCCESS (1.730s)
[806.493624] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.731s)
[807.384840] [128/133] (209s left) gem_create (hog-create)
[807.444150] Starting subtest: hog-create
[807.446883] Starting dynamic subtest: smem0
[841.292512] Dynamic subtest smem0: SUCCESS (33.866s)
[841.295743] Subtest hog-create: SUCCESS (33.868s)
[841.508992] [129/133] (175s left) kms_cursor_legacy (forked-bo)
[841.641032] Starting subtest: forked-bo
[841.643480] Starting dynamic subtest: pipe-A
[847.086840] Dynamic subtest pipe-A: SUCCESS (5.446s)
[847.099463] Starting dynamic subtest: pipe-B
[852.569964] Dynamic subtest pipe-B: SUCCESS (5.483s)
[852.581845] Starting dynamic subtest: pipe-C
[858.036417] Dynamic subtest pipe-C: SUCCESS (5.465s)
[858.047892] Starting dynamic subtest: pipe-D
[863.500436] Dynamic subtest pipe-D: SUCCESS (5.463s)
[863.511932] Starting dynamic subtest: all-pipes
[868.984585] Dynamic subtest all-pipes: SUCCESS (5.483s)
[868.987430] Subtest forked-bo: SUCCESS (27.351s)
[869.155936] [130/133] (147s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[869.273224] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[869.278096] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[869.381064] [131/133] (147s left) kms_color_pipeline (plane-lut1d)
[869.481985] Starting subtest: plane-lut1d
[869.495871] Starting dynamic subtest: pipe-A-eDP-1
[870.272600] Dynamic subtest pipe-A-eDP-1: FAIL (0.320s)
[870.911250] Starting dynamic subtest: pipe-B-eDP-1
[871.749576] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[872.233880] Starting dynamic subtest: pipe-C-eDP-1
[873.243017] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[873.574656] Starting dynamic subtest: pipe-D-eDP-1
[874.570758] Dynamic subtest pipe-D-eDP-1: FAIL (0.319s)
[874.572770] Subtest plane-lut1d: FAIL (4.732s)
[875.075169] [132/133] (142s left) gem_pipe_control_store_loop (fresh-buffer)
[875.145957] Starting subtest: fresh-buffer
[877.298546] Subtest fresh-buffer: SUCCESS (2.152s)
[877.438903] [133/133] (139s left) kms_addfb_basic (bo-too-small)
[877.541851] Starting subtest: bo-too-small
[877.544819] Subtest bo-too-small: SUCCESS (0.000s)
[877.662544] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_pwrite
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: gem_lmem_swapping
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_selftest
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_exec_nop
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_shared
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: kms_legacy_colorkey
results: parsing output: 30/ for test: gem_exec_flush
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_busy
results: parsing output: 36/ for test: gen7_exec_parse
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: sriov_basic
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: gem_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_getfb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: gen3_render_tiledx_blits
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: kms_pm_dc
results: parsing output: 64/ for test: gem_madvise
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: vgem_basic
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr2_su
results: parsing output: 73/ for test: gem_ctx_isolation
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: i915_drm_fdinfo
results: parsing output: 78/ for test: gem_spin_batch
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_nop
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: dmabuf_sync_file
results: parsing output: 84/ for test: gem_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_vblank
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: kms_plane_multiple
results: parsing output: 93/ for test: gem_userptr_blits
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: gem_exec_suspend
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: gem_reg_read
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_linear_blits
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_plane_alpha_blend
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_vrr
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_chamelium_color
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: gem_ringfill
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: i915_selftest
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: gem_exec_parallel
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_create
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_color_pipeline
results: parsing output: 131/ for test: gem_pipe_control_store_loop
results: parsing output: 132/ for test: kms_addfb_basic
Done.