[105.303977] Initializing watchdogs
[105.304085]   /dev/watchdog0
[105.317447] [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]
[105.321636] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[105.323869] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[105.327208] [001/131] (960s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[105.404108] Starting subtest: multi-wait-all-for-submit-signaled
[105.406381] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[105.482989] [002/131] (960s left) perf (gen12-group-exclusive-stream-ctx-handle)
[105.594060] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[105.620159] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[105.660523] [003/131] (960s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[106.922972] Starting subtest: x-tiled-64bpp-rotate-180
[108.488983] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.567s)
[108.653587] [004/131] (957s left) kms_lease (lease-again)
[108.743505] Starting subtest: lease-again
[108.746165] Starting dynamic subtest: pipe-A-eDP-1
[108.748682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[108.756145] Starting dynamic subtest: pipe-B-eDP-1
[108.758185] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[108.766156] Starting dynamic subtest: pipe-C-eDP-1
[108.768054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[108.774493] Starting dynamic subtest: pipe-D-eDP-1
[108.776410] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[108.778313] Subtest lease-again: SUCCESS (0.011s)
[108.857185] [005/131] (957s left) kms_sequence (get-forked-busy)
[108.944497] Starting subtest: get-forked-busy
[108.946219] Starting dynamic subtest: pipe-A-eDP-1
[110.886091] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[110.895956] Starting dynamic subtest: pipe-B-eDP-1
[113.475791] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.591s)
[113.484728] Starting dynamic subtest: pipe-C-eDP-1
[116.111569] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.633s)
[116.120616] Starting dynamic subtest: pipe-D-eDP-1
[118.720604] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[118.722973] Subtest get-forked-busy: SUCCESS (9.776s)
[119.528124] [006/131] (946s left) gem_spin_batch (engines)
[119.595567] Starting subtest: engines
[119.598054] Starting dynamic subtest: rcs0
[122.836963] Dynamic subtest rcs0: SUCCESS (3.236s)
[122.846476] Starting dynamic subtest: bcs0
[126.125378] Dynamic subtest bcs0: SUCCESS (3.235s)
[126.138628] Starting dynamic subtest: vcs0
[129.308901] Dynamic subtest vcs0: SUCCESS (3.235s)
[129.316383] Starting dynamic subtest: vcs1
[132.598803] Dynamic subtest vcs1: SUCCESS (3.237s)
[132.610947] Starting dynamic subtest: vecs0
[135.834810] Dynamic subtest vecs0: SUCCESS (3.235s)
[135.844273] Starting dynamic subtest: ccs0
[139.066828] Dynamic subtest ccs0: SUCCESS (3.231s)
[139.069802] Subtest engines: SUCCESS (19.415s)
[139.263180] [007/131] (926s left) gem_exec_fence (long-history)
[139.724074] Starting subtest: long-history
[146.608575] Subtest long-history: SUCCESS (6.885s)
[147.930448] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[147.933685] [008/131] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[148.036477] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[169.964919] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (21.931s)
[170.099414] [009/131] (896s left) gem_ctx_param (invalid-get-engines)
[170.158398] Starting subtest: invalid-get-engines
[170.160549] Subtest invalid-get-engines: SUCCESS (0.001s)
[170.284201] [010/131] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[170.371114] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[170.374481] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[170.473318] [011/131] (895s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[170.559929] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[170.561726] Starting dynamic subtest: pipe-A-eDP-1
[203.053801] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.961s)
[203.063064] Starting dynamic subtest: pipe-B-eDP-1
[236.001612] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.640s)
[236.010564] Starting dynamic subtest: pipe-C-eDP-1
[268.971782] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.631s)
[268.985368] Starting dynamic subtest: pipe-D-eDP-1
[301.963044] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.636s)
[301.965860] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.873s)
[303.232860] [012/131] (763s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[303.338764] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[304.306758] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.967s)
[304.416482] [013/131] (761s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[304.543860] Starting subtest: verify-pxp-key-change-after-suspend-resume
[311.701067] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.152s)
[311.811509] [014/131] (754s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[311.909582] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[311.914202] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[311.979414] [015/131] (754s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[312.069395] Starting subtest: psr-rgb101010-draw-pwrite
[319.691279] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.621s)
[319.793187] [016/131] (746s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[319.884331] Starting subtest: psr-2p-pri-indfb-multidraw
[319.889599] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[319.965389] [017/131] (746s left) kms_psr (psr-sprite-plane-move)
[320.063018] Starting subtest: psr-sprite-plane-move
[320.065770] Starting dynamic subtest: eDP-1
[321.816809] Dynamic subtest eDP-1: SUCCESS (1.755s)
[321.819692] Subtest psr-sprite-plane-move: SUCCESS (1.755s)
[322.635814] [018/131] (743s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[322.733723] Starting subtest: y-tiled-16bpp-rotate-180
[322.739061] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[322.827100] [019/131] (743s left) kms_flip (2x-blocking-absolute-wf_vblank)
[322.914720] Starting subtest: 2x-blocking-absolute-wf_vblank
[322.931075] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[323.013201] [020/131] (743s left) kms_draw_crc (draw-method-render)
[323.104869] Starting subtest: draw-method-render
[323.107500] Starting dynamic subtest: xrgb8888-untiled
[323.346267] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[323.354242] Starting dynamic subtest: rgb565-untiled
[323.568621] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[323.576572] Starting dynamic subtest: xrgb2101010-untiled
[323.790687] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[323.800976] Starting dynamic subtest: xbgr16161616f-untiled
[324.012805] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.220s)
[324.021335] Starting dynamic subtest: xrgb8888-xtiled
[324.135033] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[324.143077] Starting dynamic subtest: rgb565-xtiled
[324.257779] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[324.269487] Starting dynamic subtest: xrgb2101010-xtiled
[324.380196] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[324.388747] Starting dynamic subtest: xbgr16161616f-xtiled
[324.513429] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[324.522389] Starting dynamic subtest: xrgb8888-4tiled
[324.635175] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[324.643155] Starting dynamic subtest: rgb565-4tiled
[324.746657] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[324.754650] Starting dynamic subtest: xrgb2101010-4tiled
[324.857777] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[324.867457] Starting dynamic subtest: xbgr16161616f-4tiled
[324.991514] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[324.993685] Subtest draw-method-render: SUCCESS (1.890s)
[325.073877] [021/131] (741s left) gem_mmap_wc (write)
[325.138349] Subtest write: SKIP (0.000s)
[325.195316] [022/131] (741s left) kms_invalid_mode (bad-vtotal)
[325.299934] Starting subtest: bad-vtotal
[325.302188] Starting dynamic subtest: pipe-A-eDP-1
[325.587813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[325.596682] Starting dynamic subtest: pipe-B-eDP-1
[325.599164] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[325.607184] Starting dynamic subtest: pipe-C-eDP-1
[325.609450] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[325.617640] Starting dynamic subtest: pipe-D-eDP-1
[325.619894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[325.622312] Subtest bad-vtotal: SUCCESS (0.299s)
[326.458451] [023/131] (740s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[326.512287] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[326.574705] [024/131] (740s left) kms_psr (fbc-pr-primary-mmap-gtt)
[326.671783] Starting subtest: fbc-pr-primary-mmap-gtt
[326.676965] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[326.748714] [025/131] (740s left) api_intel_bb (misplaced-blitter)
[326.800841] Starting subtest: misplaced-blitter
[326.807060] Subtest misplaced-blitter: SUCCESS (0.009s)
[326.915171] [026/131] (739s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[327.021635] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[333.618757] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.597s)
[333.749025] [027/131] (733s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[333.804382] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[333.873975] [028/131] (733s left) gem_lmem_swapping (massive)
[333.918027] Subtest massive: SKIP (0.000s)
[333.967969] [029/131] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[334.069721] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[334.074810] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[334.166548] [030/131] (732s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[334.258829] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[334.263685] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[334.339775] [031/131] (732s left) gem_basic (create-fd-close)
[334.382600] Starting subtest: create-fd-close
[334.386694] Subtest create-fd-close: SUCCESS (0.000s)
[334.463643] [032/131] (732s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[334.559556] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[334.563971] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[334.668717] [033/131] (732s left) gem_ctx_param (invalid-ctx-set)
[334.720681] Starting subtest: invalid-ctx-set
[334.722788] Subtest invalid-ctx-set: SUCCESS (0.001s)
[334.808451] [034/131] (732s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[334.894589] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[334.896724] Starting dynamic subtest: pipe-A-default-mode
[337.611296] Dynamic subtest pipe-A-default-mode: SUCCESS (2.714s)
[337.613952] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.716s)
[338.482074] [035/131] (728s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[338.595829] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[338.600545] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[338.740844] [036/131] (728s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[338.834405] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[339.780450] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.944s)
[339.904292] [037/131] (727s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[339.990347] Starting subtest: yf-tiled-32bpp-rotate-180
[339.995225] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[340.085902] [038/131] (727s left) gem_ctx_shared (create-shared-gtt)
[340.150054] Starting subtest: create-shared-gtt
[342.302208] Subtest create-shared-gtt: SUCCESS (2.152s)
[342.669600] [039/131] (724s left) kms_chamelium_frames (dp-crc-multiple)
[343.068802] Subtest dp-crc-multiple: SKIP (0.000s)
[343.903456] [040/131] (723s left) kms_psr (fbc-pr-primary-blt)
[343.997883] Starting subtest: fbc-pr-primary-blt
[344.002775] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[344.087834] [041/131] (723s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[344.179935] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[344.185015] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[344.274757] [042/131] (723s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[344.391377] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[344.396326] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[344.503799] [043/131] (723s left) i915_pm_rps (basic-api)
[344.556194] Starting subtest: basic-api
[344.561894] Subtest basic-api: SKIP (0.001s)
[344.666281] [044/131] (722s left) i915_hangman (detector)
[344.735773] Starting subtest: detector
[344.738519] Starting dynamic subtest: rcs0
[356.418371] Dynamic subtest rcs0: SUCCESS (11.678s)
[356.430047] Starting dynamic subtest: bcs0
[368.385244] Dynamic subtest bcs0: SUCCESS (11.958s)
[368.397044] Starting dynamic subtest: vcs0
[380.353411] Dynamic subtest vcs0: SUCCESS (11.959s)
[380.365203] Starting dynamic subtest: vcs1
[392.321788] Dynamic subtest vcs1: SUCCESS (11.959s)
[392.333023] Starting dynamic subtest: vecs0
[402.371055] Dynamic subtest vecs0: SUCCESS (10.041s)
[402.383061] Starting dynamic subtest: ccs0
[414.401355] Dynamic subtest ccs0: SUCCESS (12.021s)
[414.404212] Subtest detector: SUCCESS (69.634s)
[414.481980] [045/131] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[414.594860] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[414.599785] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[414.694312] [046/131] (652s left) gem_exec_balancer (sequential)
[414.759905] Starting subtest: sequential
[417.846011] Subtest sequential: SUCCESS (3.084s)
[418.132747] [047/131] (649s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[418.233848] Starting subtest: bad-pixel-format-yf-tiled-ccs
[418.236753] Starting dynamic subtest: pipe-A-eDP-1
[418.262586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.275682] Starting dynamic subtest: pipe-B-eDP-1
[418.302256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.311030] Starting dynamic subtest: pipe-C-eDP-1
[418.336549] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.345295] Starting dynamic subtest: pipe-D-eDP-1
[418.370896] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.375877] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[420.525653] [048/131] (647s left) kms_psr (psr2-sprite-render)
[420.607877] Starting subtest: psr2-sprite-render
[420.610537] Starting dynamic subtest: eDP-1
[422.320949] Dynamic subtest eDP-1: SUCCESS (1.711s)
[422.323561] Subtest psr2-sprite-render: SUCCESS (1.712s)
[423.194179] [049/131] (644s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[423.296866] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[423.302699] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[423.395579] [050/131] (644s left) gem_lmem_swapping (random-engines)
[423.437916] Subtest random-engines: SKIP (0.000s)
[423.489963] [051/131] (644s left) sriov_basic (enable-vfs-autoprobe-off)
[423.545912] Starting subtest: enable-vfs-autoprobe-off
[423.548259] Starting dynamic subtest: numvfs-1
[423.635047] Dynamic subtest numvfs-1: FAIL (0.021s)
[423.645486] Starting dynamic subtest: numvfs-2
[423.731779] Dynamic subtest numvfs-2: FAIL (0.004s)
[423.741613] Starting dynamic subtest: numvfs-3
[423.826682] Dynamic subtest numvfs-3: FAIL (0.004s)
[423.836037] Starting dynamic subtest: numvfs-4
[423.921575] Dynamic subtest numvfs-4: FAIL (0.004s)
[423.931021] Starting dynamic subtest: numvfs-5
[424.017955] Dynamic subtest numvfs-5: FAIL (0.004s)
[424.027578] Starting dynamic subtest: numvfs-6
[424.113904] Dynamic subtest numvfs-6: FAIL (0.003s)
[424.122962] Starting dynamic subtest: numvfs-7
[424.200023] Dynamic subtest numvfs-7: FAIL (0.004s)
[424.208658] Starting dynamic subtest: numvfs-random
[424.281240] Dynamic subtest numvfs-random: FAIL (0.010s)
[424.290308] Starting dynamic subtest: numvfs-all
[424.364883] Dynamic subtest numvfs-all: FAIL (0.582s)
[424.367459] Subtest enable-vfs-autoprobe-off: FAIL (0.645s)
[424.405229] [052/131] (643s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[424.500481] Starting subtest: pr-plane-move-sf-dmg-area
[424.504759] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[424.561340] [053/131] (643s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[424.622682] Subtest writes-after-reads-snoop: SKIP (0.000s)
[424.703621] [054/131] (643s left) perf_pmu (most-busy-check-all)
[424.748249] Starting subtest: most-busy-check-all
[424.750645] Starting dynamic subtest: rcs0
[426.403764] Dynamic subtest rcs0: SUCCESS (1.653s)
[426.416691] Starting dynamic subtest: bcs0
[428.450965] Dynamic subtest bcs0: SUCCESS (2.043s)
[428.463674] Starting dynamic subtest: vcs0
[430.436948] Dynamic subtest vcs0: SUCCESS (1.982s)
[430.449698] Starting dynamic subtest: vcs1
[432.418939] Dynamic subtest vcs1: SUCCESS (1.978s)
[432.431033] Starting dynamic subtest: vecs0
[434.404225] Dynamic subtest vecs0: SUCCESS (1.981s)
[434.416248] Starting dynamic subtest: ccs0
[436.451599] Dynamic subtest ccs0: SUCCESS (2.043s)
[436.454626] Subtest most-busy-check-all: SUCCESS (11.698s)
[436.556862] [055/131] (631s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[436.661492] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[436.666528] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[436.727854] [056/131] (631s left) kms_rmfb (close-fd)
[436.818762] Starting subtest: close-fd
[436.820896] Starting dynamic subtest: pipe-A-eDP-1
[436.929036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[436.941257] Starting dynamic subtest: pipe-B-eDP-1
[438.144031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.212s)
[438.154161] Starting dynamic subtest: pipe-C-eDP-1
[439.278824] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[439.288880] Starting dynamic subtest: pipe-D-eDP-1
[440.420369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[440.422886] Subtest close-fd: SUCCESS (3.601s)
[441.626910] [057/131] (626s left) gem_exec_schedule (thriceslice)
[441.705620] Starting subtest: thriceslice
[441.708385] Starting dynamic subtest: rcs0
[441.729774] Dynamic subtest rcs0: SUCCESS (0.033s)
[441.739679] Starting dynamic subtest: bcs0
[441.763027] Dynamic subtest bcs0: SUCCESS (0.031s)
[441.772202] Starting dynamic subtest: vcs0
[441.792929] Dynamic subtest vcs0: SUCCESS (0.029s)
[441.802017] Starting dynamic subtest: vcs1
[441.823030] Dynamic subtest vcs1: SUCCESS (0.029s)
[441.832059] Starting dynamic subtest: vecs0
[441.853656] Dynamic subtest vecs0: SUCCESS (0.030s)
[441.862867] Starting dynamic subtest: ccs0
[441.905362] Dynamic subtest ccs0: SUCCESS (0.051s)
[441.908293] Subtest thriceslice: SUCCESS (0.210s)
[443.468685] [058/131] (624s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[443.519593] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[443.622660] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[443.699387] [059/131] (624s left) gem_userptr_blits (vma-merge)
[443.770012] Starting subtest: vma-merge
[443.810975] Subtest vma-merge: SUCCESS (0.041s)
[443.920465] [060/131] (624s left) gem_flink_basic (flink-lifetime)
[443.975607] Starting subtest: flink-lifetime
[443.978066] Subtest flink-lifetime: SUCCESS (0.002s)
[444.068061] [061/131] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[444.168908] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[444.174048] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[444.258069] [062/131] (624s left) kms_flip (2x-flip-vs-dpms)
[444.350006] Starting subtest: 2x-flip-vs-dpms
[444.358936] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[444.465473] [063/131] (623s left) prime_mmap (test_forked_cpu_write)
[444.520028] Starting subtest: test_forked_cpu_write
[444.522689] Starting dynamic subtest: test_forked_cpu_write-smem
[444.528301] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.010s)
[444.530980] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[444.640403] [064/131] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[444.736356] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[452.099070] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.362s)
[452.222078] [065/131] (616s left) gem_pxp (create-valid-protected-context)
[452.280739] Starting subtest: create-valid-protected-context
[452.283485] Subtest create-valid-protected-context: SUCCESS (0.001s)
[452.394288] [066/131] (616s left) gem_mmap_gtt (hang)
[452.452634] Subtest hang: SKIP (0.000s)
[452.511104] [067/131] (616s left) kms_plane (pixel-format-linear-modifier)
[452.595881] Starting subtest: pixel-format-linear-modifier
[452.621318] Starting dynamic subtest: pipe-A-plane-0
[456.389457] Dynamic subtest pipe-A-plane-0: SUCCESS (3.766s)
[456.398673] Starting dynamic subtest: pipe-A-plane-3
[458.079051] Dynamic subtest pipe-A-plane-3: SUCCESS (1.688s)
[458.089094] Starting dynamic subtest: pipe-A-plane-5
[458.290507] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[459.353061] Starting dynamic subtest: pipe-B-plane-0
[463.181180] Dynamic subtest pipe-B-plane-0: SUCCESS (3.833s)
[463.199449] Starting dynamic subtest: pipe-B-plane-3
[464.971039] Dynamic subtest pipe-B-plane-3: SUCCESS (1.786s)
[464.980511] Starting dynamic subtest: pipe-B-plane-5
[465.181666] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[465.495674] Subtest pixel-format-linear-modifier: SUCCESS (12.896s)
[466.323078] [068/131] (602s left) i915_selftest (perf)
[468.076035] Starting subtest: perf
[468.078852] Starting dynamic subtest: engine_cs
[471.636620] Dynamic subtest engine_cs: SUCCESS (3.558s)
[471.646906] Starting dynamic subtest: request
[479.685498] Dynamic subtest request: SUCCESS (8.043s)
[479.694704] Starting dynamic subtest: migrate
[484.758799] Dynamic subtest migrate: SUCCESS (5.068s)
[484.768346] Starting dynamic subtest: region
[491.205532] Dynamic subtest region: SUCCESS (6.442s)
[491.208631] Subtest perf: SUCCESS (23.119s)
[491.240050] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[491.240787] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[491.244341] [069/131] (577s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[493.606958] Starting subtest: plane-lut1d-ctm3x4
[493.784826] Starting dynamic subtest: pipe-A-plane-0
[493.939892] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[493.949031] Starting dynamic subtest: pipe-A-plane-1
[494.084240] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[494.095325] Starting dynamic subtest: pipe-A-plane-2
[494.273224] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[495.494619] Starting dynamic subtest: pipe-B-plane-0
[495.624541] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[495.634205] Starting dynamic subtest: pipe-B-plane-1
[495.791881] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[495.799940] Starting dynamic subtest: pipe-B-plane-2
[495.969807] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[497.184776] Starting dynamic subtest: pipe-C-plane-0
[497.322573] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[497.331973] Starting dynamic subtest: pipe-C-plane-1
[497.467008] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[497.475870] Starting dynamic subtest: pipe-C-plane-2
[497.622677] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[498.789083] Starting dynamic subtest: pipe-D-plane-0
[498.915401] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[498.924054] Starting dynamic subtest: pipe-D-plane-1
[499.059983] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[499.069195] Starting dynamic subtest: pipe-D-plane-2
[499.204775] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[499.504643] Subtest plane-lut1d-ctm3x4: SUCCESS (5.894s)
[500.390182] [FACT kms_color_pipeline (plane-lut1d-ctm3x4)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[500.391454] [FACT kms_color_pipeline (plane-lut1d-ctm3x4)] new: kernel.kmod_is_loaded.i915: true
[500.397613] [070/131] (568s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[500.498026] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[500.502947] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[500.588597] [071/131] (568s left) gem_mmap_offset (oob-read)
[500.642728] Starting subtest: oob-read
[500.644846] Subtest oob-read: SUCCESS (0.000s)
[500.738186] [072/131] (568s left) kms_cursor_edge_walk (256x256-top-edge)
[500.824885] Starting subtest: 256x256-top-edge
[500.827298] Starting dynamic subtest: pipe-A-eDP-1
[504.253538] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[504.263040] Starting dynamic subtest: pipe-D-eDP-1
[507.384851] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[507.387622] Subtest 256x256-top-edge: SUCCESS (6.557s)
[508.188036] [073/131] (560s left) dmabuf_sync_file (import-multiple-read-write)
[508.239599] Starting subtest: import-multiple-read-write
[508.242069] Subtest import-multiple-read-write: SUCCESS (0.003s)
[508.296570] [074/131] (560s left) kms_flip (plain-flip-fb-recreate)
[508.394293] Starting subtest: plain-flip-fb-recreate
[508.396877] Starting dynamic subtest: A-eDP1
[517.287711] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[517.295446] Starting dynamic subtest: B-eDP1
[526.132873] Dynamic subtest B-eDP1: SUCCESS (8.840s)
[526.145046] Starting dynamic subtest: C-eDP1
[534.958356] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[534.966557] Starting dynamic subtest: D-eDP1
[543.786461] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[543.790640] Subtest plain-flip-fb-recreate: SUCCESS (35.381s)
[544.963909] [075/131] (523s left) gem_ctx_shared (q-smoketest)
[545.057061] Starting subtest: Q-smoketest
[545.059693] Starting dynamic subtest: rcs0
[550.701311] Dynamic subtest rcs0: SUCCESS (5.537s)
[550.711488] Starting dynamic subtest: bcs0
[556.190773] Dynamic subtest bcs0: SUCCESS (5.492s)
[556.199169] Starting dynamic subtest: vcs0
[561.680669] Dynamic subtest vcs0: SUCCESS (5.480s)
[561.691491] Starting dynamic subtest: vcs1
[567.161680] Dynamic subtest vcs1: SUCCESS (5.474s)
[567.171734] Starting dynamic subtest: vecs0
[572.650721] Dynamic subtest vecs0: SUCCESS (5.484s)
[572.660308] Starting dynamic subtest: ccs0
[578.152651] Dynamic subtest ccs0: SUCCESS (5.516s)
[578.154954] Subtest Q-smoketest: SUCCESS (32.991s)
[578.253472] [076/131] (490s left) gem_close_race (multigpu-basic-process)
[578.312881] Starting subtest: multigpu-basic-process
[578.318615] Subtest multigpu-basic-process: SKIP (0.000s)
[578.545527] [077/131] (490s left) kms_psr (fbc-psr2-sprite-plane-move)
[578.642853] Starting subtest: fbc-psr2-sprite-plane-move
[578.645641] Starting dynamic subtest: eDP-1
[578.650705] Dynamic subtest eDP-1: SKIP (0.000s)
[578.655716] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[578.716559] [078/131] (490s left) gem_madvise (dontneed-after-mmap)
[578.756522] Starting subtest: dontneed-after-mmap
[578.774244] Subtest dontneed-after-mmap: SUCCESS (0.024s)
[578.872733] [079/131] (490s left) gem_exec_balancer (nop)
[578.931284] Starting subtest: nop
[625.653329] Subtest nop: SUCCESS (46.702s)
[625.959079] [080/131] (443s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[626.007874] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[626.010454] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[626.118167] [081/131] (443s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[626.176370] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[626.277572] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[626.375397] [082/131] (442s left) vgem_basic (create)
[626.420195] Starting subtest: create
[626.422808] Subtest create: SUCCESS (0.000s)
[626.487697] [083/131] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[626.587276] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[626.592298] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[626.688407] [084/131] (442s left) kms_psr (pr-dpms)
[626.790010] Starting subtest: pr-dpms
[626.795071] Subtest pr-dpms: SKIP (0.000s)
[626.878417] [085/131] (442s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[626.934326] Starting subtest: multi-wait-available-unsubmitted-submitted
[626.936915] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[627.044899] [086/131] (442s left) dumb_buffer (map-valid)
[627.103263] Starting subtest: map-valid
[627.105463] Subtest map-valid: SUCCESS (0.000s)
[627.194165] [087/131] (442s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[627.277884] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[627.280332] Starting dynamic subtest: pipe-A-eDP-1
[627.337582] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[627.347120] Starting dynamic subtest: pipe-B-eDP-1
[627.409411] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[627.418059] Starting dynamic subtest: pipe-C-eDP-1
[627.476010] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[627.484789] Starting dynamic subtest: pipe-D-eDP-1
[627.538272] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[627.541710] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[629.467726] [088/131] (439s left) kms_content_protection (srm)
[629.615623] Starting subtest: srm
[629.620842] Subtest srm: SKIP (0.003s)
[629.730483] [089/131] (439s left) i915_drm_fdinfo (memory-info-resident)
[629.771112] Starting subtest: memory-info-resident
[629.773768] Starting dynamic subtest: smem0
[632.559768] Dynamic subtest smem0: SUCCESS (2.788s)
[632.562278] Subtest memory-info-resident: SUCCESS (2.789s)
[632.637366] [090/131] (436s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[632.744795] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[632.748823] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[632.834704] [091/131] (436s left) kms_properties (plane-properties-atomic)
[632.924334] Starting subtest: plane-properties-atomic
[632.926586] Starting dynamic subtest: pipe-A-eDP-1
[633.471748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[633.481905] Starting dynamic subtest: pipe-B-eDP-1
[634.736815] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.264s)
[634.748438] Starting dynamic subtest: pipe-C-eDP-1
[635.976212] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[635.987804] Starting dynamic subtest: pipe-D-eDP-1
[637.208068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[637.211047] Subtest plane-properties-atomic: SUCCESS (4.284s)
[638.000726] [092/131] (431s left) kms_flip (bo-too-big-interruptible)
[638.112325] Starting subtest: bo-too-big-interruptible
[638.114775] Starting dynamic subtest: A-eDP1
[639.365542] Dynamic subtest A-eDP1: SUCCESS (1.252s)
[639.375339] Starting dynamic subtest: B-eDP1
[640.603232] Dynamic subtest B-eDP1: SUCCESS (1.236s)
[640.613149] Starting dynamic subtest: C-eDP1
[641.834782] Dynamic subtest C-eDP1: SUCCESS (1.230s)
[641.844962] Starting dynamic subtest: D-eDP1
[643.161352] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[643.168903] Subtest bo-too-big-interruptible: SUCCESS (5.053s)
[644.375427] [093/131] (425s left) sysfs_timeslice_duration (invalid)
[644.429560] Starting subtest: invalid
[644.432221] Starting dynamic subtest: vecs0
[644.434869] Dynamic subtest vecs0: SUCCESS (0.000s)
[644.445201] Starting dynamic subtest: ccs0
[644.447913] Dynamic subtest ccs0: SUCCESS (0.000s)
[644.456358] Starting dynamic subtest: vcs0
[644.458930] Dynamic subtest vcs0: SUCCESS (0.000s)
[644.467323] Starting dynamic subtest: bcs0
[644.469878] Dynamic subtest bcs0: SUCCESS (0.000s)
[644.478195] Starting dynamic subtest: rcs0
[644.480838] Dynamic subtest rcs0: SUCCESS (0.000s)
[644.490093] Starting dynamic subtest: vcs1
[644.492506] Dynamic subtest vcs1: SUCCESS (0.000s)
[644.494713] Subtest invalid: SUCCESS (0.005s)
[644.555413] [094/131] (425s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[644.670799] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[644.676605] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[644.778385] [095/131] (424s left) gem_exec_schedule (pi-shared-iova)
[644.953036] Starting subtest: pi-shared-iova
[644.955854] Starting dynamic subtest: rcs0
[645.039055] Dynamic subtest rcs0: SUCCESS (0.089s)
[645.049360] Starting dynamic subtest: vcs0
[645.092623] Dynamic subtest vcs0: SUCCESS (0.053s)
[645.102882] Starting dynamic subtest: vcs1
[645.146343] Dynamic subtest vcs1: SUCCESS (0.053s)
[645.156365] Starting dynamic subtest: vecs0
[645.195377] Dynamic subtest vecs0: SUCCESS (0.048s)
[645.207036] Starting dynamic subtest: ccs0
[645.255726] Dynamic subtest ccs0: SUCCESS (0.059s)
[645.258750] Subtest pi-shared-iova: SUCCESS (0.306s)
[646.517919] [096/131] (423s left) kms_vblank (ts-continuation-suspend)
[646.624901] Starting subtest: ts-continuation-suspend
[646.627886] Starting dynamic subtest: pipe-A-eDP-1
[663.097707] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.513s)
[663.113873] Starting dynamic subtest: pipe-D-eDP-1
[680.126108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.203s)
[680.128413] Subtest ts-continuation-suspend: SUCCESS (3.720s)
[680.925751] [097/131] (388s left) gem_linear_blits (interruptible)
[681.454346] Starting subtest: interruptible
[685.669376] Subtest interruptible: SUCCESS (4.153s)
[685.774718] [098/131] (384s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[685.884682] Starting subtest: y-tiled-to-vebox-y-tiled
[685.889186] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[686.068438] [099/131] (383s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[686.169591] Starting subtest: read-crc-frame-sequence
[686.171958] Starting dynamic subtest: pipe-A-eDP-1
[686.884599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[686.894436] Starting dynamic subtest: pipe-B-eDP-1
[688.224989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.337s)
[688.235350] Starting dynamic subtest: pipe-C-eDP-1
[689.545166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.319s)
[689.554929] Starting dynamic subtest: pipe-D-eDP-1
[690.852997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[690.854904] Subtest read-crc-frame-sequence: SUCCESS (4.678s)
[691.698198] [100/131] (378s left) kms_chamelium_color (ctm-max)
[691.803964] Subtest ctm-max: SKIP (0.000s)
[691.850013] [101/131] (378s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[692.239440] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[693.013081] [102/131] (377s left) prime_vgem (basic-fence-mmap)
[693.103793] Starting subtest: basic-fence-mmap
[693.108393] Subtest basic-fence-mmap: SKIP (0.000s)
[693.238040] [103/131] (376s left) api_intel_allocator (reopen-fork)
[693.297373] Starting subtest: reopen-fork
[696.676265] Subtest reopen-fork: SUCCESS (3.378s)
[696.766235] [104/131] (373s left) kms_cursor_crc (cursor-offscreen-128x42)
[696.989489] Starting subtest: cursor-offscreen-128x42
[697.033477] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[697.260682] [105/131] (372s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[697.361722] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[697.365844] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[697.444500] [106/131] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[697.544179] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[697.548558] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[697.670046] [107/131] (372s left) core_auth (basic-auth)
[697.726107] Starting subtest: basic-auth
[697.728065] Subtest basic-auth: SUCCESS (0.001s)
[697.838124] [108/131] (372s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[697.934783] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[705.119637] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.183s)
[705.248584] [109/131] (365s left) gem_exec_fence (syncobj-wait)
[705.708132] Starting subtest: syncobj-wait
[707.206487] Subtest syncobj-wait: SUCCESS (1.496s)
[707.551021] [110/131] (362s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[707.631857] Starting subtest: single-wait-for-submit-available-signaled
[707.634442] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[707.704972] [111/131] (362s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[707.823917] Starting subtest: cursorB-vs-flipB-atomic
[707.828125] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[707.983743] [112/131] (362s left) gem_ctx_exec (basic)
[708.037681] Starting subtest: basic
[708.049546] Subtest basic: SUCCESS (0.012s)
[708.170007] [113/131] (362s left) kms_pm_backlight (fade-with-suspend)
[708.260199] Starting subtest: fade-with-suspend
[724.829876] Starting dynamic subtest: eDP-1
[727.295766] Dynamic subtest eDP-1: SUCCESS (2.461s)
[727.298672] Subtest fade-with-suspend: SUCCESS (3.724s)
[728.167711] [114/131] (342s left) gem_render_copy_redux (flink)
[728.231344] Starting subtest: flink
[729.022734] Subtest flink: SUCCESS (0.792s)
[729.149472] [115/131] (341s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[729.198163] Starting subtest: invalid-single-wait-all-unsubmitted
[729.200670] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[729.291465] [116/131] (341s left) gem_exec_params (invalid-fence-in)
[729.347854] Starting subtest: invalid-fence-in
[729.350811] Subtest invalid-fence-in: SUCCESS (0.000s)
[729.446615] [117/131] (341s left) kms_async_flips (alternate-sync-async-flip)
[729.543316] Starting subtest: alternate-sync-async-flip
[729.915059] Starting dynamic subtest: pipe-A-eDP-1
[732.669704] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[733.040938] Starting dynamic subtest: pipe-B-eDP-1
[735.804788] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[736.185776] Starting dynamic subtest: pipe-C-eDP-1
[738.950606] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[739.317717] Starting dynamic subtest: pipe-D-eDP-1
[742.088851] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[742.091438] Subtest alternate-sync-async-flip: SUCCESS (12.534s)
[743.257230] [118/131] (327s left) gem_exec_capture (userptr)
[743.325225] Starting subtest: userptr
[744.154217] Subtest userptr: SUCCESS (0.830s)
[744.275272] [119/131] (326s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[744.362380] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[744.366848] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[744.452995] [120/131] (326s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[744.682505] Starting subtest: cursor-rapid-movement-128x42
[744.726300] Subtest cursor-rapid-movement-128x42: SKIP (0.037s)
[744.942145] [121/131] (325s left) gen9_exec_parse (allowed-all)
[745.016770] Subtest allowed-all: SKIP (0.000s)
[745.087119] [122/131] (325s left) gem_exec_flush (basic-batch-kernel-default-uc)
[745.150493] Starting subtest: basic-batch-kernel-default-uc
[751.110085] Subtest basic-batch-kernel-default-uc: SUCCESS (5.955s)
[751.295028] [123/131] (319s left) kms_atomic (test-only)
[751.386672] Starting subtest: test-only
[751.435543] Starting dynamic subtest: pipe-A-eDP-1
[753.937785] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[753.940777] Subtest test-only: SUCCESS (2.552s)
[754.741431] [124/131] (316s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[754.842911] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[754.848520] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[754.942140] [125/131] (316s left) gem_exec_store (cachelines)
[755.005815] Starting subtest: cachelines
[755.008185] Starting dynamic subtest: rcs0
[755.093370] Dynamic subtest rcs0: SUCCESS (0.091s)
[755.105245] Starting dynamic subtest: bcs0
[755.148082] Dynamic subtest bcs0: SUCCESS (0.051s)
[755.161927] Starting dynamic subtest: vcs0
[755.209311] Dynamic subtest vcs0: SUCCESS (0.061s)
[755.221529] Starting dynamic subtest: vcs1
[755.267948] Dynamic subtest vcs1: SUCCESS (0.056s)
[755.278962] Starting dynamic subtest: vecs0
[755.324823] Dynamic subtest vecs0: SUCCESS (0.056s)
[755.335091] Starting dynamic subtest: ccs0
[755.376915] Dynamic subtest ccs0: SUCCESS (0.050s)
[755.379907] Subtest cachelines: SUCCESS (0.376s)
[755.573811] [126/131] (315s left) syncobj_basic (bad-flags-fd-to-handle)
[755.629636] Starting subtest: bad-flags-fd-to-handle
[755.631954] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[755.722762] [127/131] (315s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[755.814795] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[755.817448] Starting dynamic subtest: pipe-A
[755.837573] Dynamic subtest pipe-A: SKIP (0.016s)
[755.852511] Starting dynamic subtest: pipe-B
[755.861702] Dynamic subtest pipe-B: SKIP (0.027s)
[755.870958] Starting dynamic subtest: pipe-C
[755.890369] Dynamic subtest pipe-C: SKIP (0.028s)
[755.899423] Starting dynamic subtest: pipe-D
[755.917438] Dynamic subtest pipe-D: SKIP (0.027s)
[755.921753] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.101s)
[755.995608] [128/131] (315s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[756.102638] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[756.107859] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[756.248458] [129/131] (314s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[756.332177] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[756.334624] Starting dynamic subtest: pipe-A-eDP-1
[757.128218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[757.137923] Starting dynamic subtest: pipe-B-eDP-1
[758.656583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.526s)
[758.666580] Starting dynamic subtest: pipe-C-eDP-1
[760.168291] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[760.178658] Starting dynamic subtest: pipe-D-eDP-1
[761.692729] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.524s)
[761.695313] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.357s)
[762.876802] [130/131] (308s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[762.967231] Starting subtest: plane-downscale-factor-0-75-with-rotation
[762.969562] Starting dynamic subtest: pipe-A
[763.193834] Dynamic subtest pipe-A: SUCCESS (0.230s)
[763.203932] Starting dynamic subtest: pipe-B
[764.467925] Dynamic subtest pipe-B: SUCCESS (1.274s)
[764.477732] Starting dynamic subtest: pipe-C
[765.798618] Dynamic subtest pipe-C: SUCCESS (1.330s)
[765.807811] Starting dynamic subtest: pipe-D
[767.126437] Dynamic subtest pipe-D: SUCCESS (1.327s)
[767.128912] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.165s)
[768.313479] [131/131] (302s left) prime_self_import (basic-with_one_bo_two_files)
[768.348761] Starting subtest: basic-with_one_bo_two_files
[768.372686] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[768.461951] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_spin_batch
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_draw_crc
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_pipe_b_c_ivb
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: api_intel_bb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_basic
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_ctx_param
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_ctx_shared
results: parsing output: 38/ for test: kms_chamelium_frames
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_pm_rps
results: parsing output: 43/ for test: i915_hangman
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_lmem_swapping
results: parsing output: 50/ for test: sriov_basic
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: gem_partial_pwrite_pread
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_rmfb
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_flink_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: prime_mmap
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_pxp
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: i915_selftest
results: parsing output: 68/ for test: kms_color_pipeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_cursor_edge_walk
results: parsing output: 72/ for test: dmabuf_sync_file
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_ctx_shared
results: parsing output: 75/ for test: gem_close_race
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_madvise
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: dumb_buffer
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: sysfs_timeslice_duration
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_schedule
results: parsing output: 95/ for test: kms_vblank
results: parsing output: 96/ for test: gem_linear_blits
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_pipe_crc_basic
results: parsing output: 99/ for test: kms_chamelium_color
results: parsing output: 100/ for test: kms_chamelium_hpd
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: core_auth
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_ctx_exec
results: parsing output: 112/ for test: kms_pm_backlight
results: parsing output: 113/ for test: gem_render_copy_redux
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_exec_capture
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gen9_exec_parse
results: parsing output: 121/ for test: gem_exec_flush
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_store
results: parsing output: 125/ for test: syncobj_basic
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: prime_self_import
Done.