[59.185820] Initializing watchdogs
[59.185887]   /dev/watchdog0
[59.199532] [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]
[59.203834] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.205935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.209482] [001/134] (960s left) kms_properties (connector-properties-legacy)
[59.326053] Starting subtest: connector-properties-legacy
[59.328497] Starting dynamic subtest: pipe-A-eDP-1
[67.125643] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.782s)
[67.135064] Starting dynamic subtest: pipe-None-DP-1
[67.139842] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[67.146503] Starting dynamic subtest: pipe-None-HDMI-A-1
[67.151171] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[67.157629] Starting dynamic subtest: pipe-None-DP-2
[67.161761] Dynamic subtest pipe-None-DP-2: SUCCESS (0.004s)
[67.168939] Starting dynamic subtest: pipe-None-HDMI-A-2
[67.173408] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.003s)
[67.179911] Starting dynamic subtest: pipe-None-DP-3
[67.184453] Dynamic subtest pipe-None-DP-3: SUCCESS (0.002s)
[67.191151] Starting dynamic subtest: pipe-None-DP-4
[67.195669] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s)
[67.197975] Subtest connector-properties-legacy: SUCCESS (7.806s)
[68.008921] [002/134] (951s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[68.130263] Starting subtest: cursor-vs-flip-toggle
[98.792075] Subtest cursor-vs-flip-toggle: SUCCESS (30.650s)
[99.652402] [003/134] (920s left) kms_psr (psr2-cursor-render)
[99.756275] Starting subtest: psr2-cursor-render
[99.758623] Starting dynamic subtest: eDP-1
[101.416880] Dynamic subtest eDP-1: SUCCESS (1.662s)
[101.419369] Subtest psr2-cursor-render: SUCCESS (1.663s)
[102.221612] [004/134] (917s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[102.321295] Starting subtest: fbcpsr-rgb565-draw-render
[109.379014] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.060s)
[109.534642] [005/134] (910s left) kms_vblank (ts-continuation-dpms-suspend)
[109.631513] Starting subtest: ts-continuation-dpms-suspend
[109.633816] Starting dynamic subtest: pipe-A-eDP-1
[126.504497] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.001s)
[126.518099] Starting dynamic subtest: pipe-D-eDP-1
[144.505766] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.457s)
[144.508136] Subtest ts-continuation-dpms-suspend: SUCCESS (4.462s)
[145.331516] [006/134] (874s left) gem_userptr_blits (sync-unmap-after-close)
[145.409303] Starting subtest: sync-unmap-after-close
[145.420236] Subtest sync-unmap-after-close: SUCCESS (0.014s)
[145.583892] [007/134] (874s left) kms_addfb_basic (no-handle)
[145.642584] Starting subtest: no-handle
[145.645041] Subtest no-handle: SUCCESS (0.000s)
[145.814306] [008/134] (874s left) kms_flip (modeset-vs-vblank-race)
[145.926892] Starting subtest: modeset-vs-vblank-race
[145.928889] Starting dynamic subtest: A-eDP1
[150.732700] Dynamic subtest A-eDP1: SUCCESS (4.745s)
[150.744715] Starting dynamic subtest: B-eDP1
[155.508623] Dynamic subtest B-eDP1: SUCCESS (4.741s)
[155.519342] Starting dynamic subtest: C-eDP1
[160.059753] Dynamic subtest C-eDP1: SUCCESS (4.531s)
[160.070088] Starting dynamic subtest: D-eDP1
[164.613079] Dynamic subtest D-eDP1: SUCCESS (4.542s)
[164.615390] Subtest modeset-vs-vblank-race: SUCCESS (18.566s)
[165.795108] [009/134] (854s left) gem_mmap_gtt (cpuset-big-copy)
[165.860829] Subtest cpuset-big-copy: SKIP (0.000s)
[165.925824] [010/134] (854s left) gem_userptr_blits (dmabuf-sync)
[165.994674] Starting subtest: dmabuf-sync
[165.999142] Subtest dmabuf-sync: SKIP (0.002s)
[166.174674] [011/134] (853s left) gem_huc_copy (huc-copy)
[166.238366] Starting subtest: huc-copy
[166.241067] Subtest huc-copy: SUCCESS (0.003s)
[166.399572] [012/134] (853s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[166.518821] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[166.522863] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.644268] [013/134] (853s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[166.740819] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[166.742909] Starting dynamic subtest: pipe-A-eDP-1
[168.852550] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[168.861394] Starting dynamic subtest: pipe-B-eDP-1
[171.201769] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.342s)
[171.209828] Starting dynamic subtest: pipe-C-eDP-1
[173.240788] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.037s)
[173.248919] Starting dynamic subtest: pipe-D-eDP-1
[175.383649] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.143s)
[175.385553] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.637s)
[176.558046] [014/134] (843s left) gem_ctx_persistence (engines-cleanup)
[176.624211] Starting subtest: engines-cleanup
[176.626755] Starting dynamic subtest: rcs0
[176.749690] Dynamic subtest rcs0: SUCCESS (0.125s)
[176.761544] Starting dynamic subtest: bcs0
[176.802274] Dynamic subtest bcs0: SUCCESS (0.051s)
[176.812437] Starting dynamic subtest: vcs0
[176.866419] Dynamic subtest vcs0: SUCCESS (0.062s)
[176.877087] Starting dynamic subtest: vcs1
[176.932277] Dynamic subtest vcs1: SUCCESS (0.064s)
[176.942282] Starting dynamic subtest: vecs0
[177.005349] Dynamic subtest vecs0: SUCCESS (0.071s)
[177.015876] Starting dynamic subtest: ccs0
[177.075394] Dynamic subtest ccs0: SUCCESS (0.068s)
[177.078287] Subtest engines-cleanup: SUCCESS (0.453s)
[177.163756] [015/134] (843s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[177.264520] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[177.268980] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[177.386453] [016/134] (842s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[177.519061] Starting subtest: cursor-vs-flip-legacy
[206.777416] Subtest cursor-vs-flip-legacy: SUCCESS (29.255s)
[207.577570] [017/134] (812s left) gem_busy (close-race)
[207.652408] Starting subtest: close-race
[231.275868] Subtest close-race: SUCCESS (23.614s)
[231.673037] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[231.677980] [018/134] (788s left) gem_mmap_offset (mmap-boundaries)
[231.775772] Starting subtest: mmap-boundaries
[231.777779] Starting dynamic subtest: smem0
[232.052262] Dynamic subtest smem0: SUCCESS (0.279s)
[232.054824] Subtest mmap-boundaries: SUCCESS (0.279s)
[232.205510] [019/134] (788s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[232.323923] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[232.328323] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[232.433559] [020/134] (788s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[232.535027] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[232.537362] Starting dynamic subtest: pipe-A
[232.555304] Dynamic subtest pipe-A: SKIP (0.018s)
[232.564758] Starting dynamic subtest: pipe-B
[232.588511] Dynamic subtest pipe-B: SKIP (0.033s)
[232.597144] Starting dynamic subtest: pipe-C
[232.620078] Dynamic subtest pipe-C: SKIP (0.031s)
[232.628325] Starting dynamic subtest: pipe-D
[232.652321] Dynamic subtest pipe-D: SKIP (0.031s)
[232.656644] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.114s)
[232.795861] [021/134] (787s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[232.918654] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[232.922878] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[233.045498] [022/134] (787s left) kms_pm_rpm (pm-caching)
[234.593870] Starting subtest: pm-caching
[234.598429] Subtest pm-caching: SKIP (0.000s)
[235.337735] [023/134] (785s left) kms_cursor_crc (cursor-sliding-512x512)
[235.597011] Starting subtest: cursor-sliding-512x512
[235.601736] Subtest cursor-sliding-512x512: SKIP (0.001s)
[235.783784] [024/134] (784s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[235.836304] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[235.943423] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[236.031948] [025/134] (784s left) kms_psr (fbc-pr-cursor-plane-onoff)
[236.123736] Starting subtest: fbc-pr-cursor-plane-onoff
[236.128031] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[236.205712] [026/134] (784s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[236.298541] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[236.300773] Starting dynamic subtest: pipe-A
[236.319016] Dynamic subtest pipe-A: SKIP (0.016s)
[236.327905] Starting dynamic subtest: pipe-B
[236.347575] Dynamic subtest pipe-B: SKIP (0.030s)
[236.355506] Starting dynamic subtest: pipe-C
[236.378803] Dynamic subtest pipe-C: SKIP (0.029s)
[236.388940] Starting dynamic subtest: pipe-D
[236.406410] Dynamic subtest pipe-D: SKIP (0.029s)
[236.410863] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.106s)
[236.533155] [027/134] (784s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[236.638128] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[236.642437] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[236.771183] [028/134] (784s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[236.860531] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[236.862815] Starting dynamic subtest: pipe-A-eDP-1
[236.916696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[236.925692] Starting dynamic subtest: pipe-B-eDP-1
[236.976637] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.059s)
[236.986415] Starting dynamic subtest: pipe-C-eDP-1
[237.039414] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[237.051414] Starting dynamic subtest: pipe-D-eDP-1
[237.099343] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[237.101223] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.242s)
[239.299072] [029/134] (781s left) kms_hdr (static-toggle-suspend)
[239.410426] Starting subtest: static-toggle-suspend
[239.416536] Subtest static-toggle-suspend: SKIP (0.000s)
[239.506795] [030/134] (781s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[239.558406] Starting subtest: single-wait-all-for-submit-available-signaled
[239.560832] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[239.676502] [031/134] (781s left) prime_mmap (test_map_unmap)
[239.735157] Starting subtest: test_map_unmap
[239.736984] Starting dynamic subtest: test_map_unmap-smem
[239.764656] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[239.766957] Subtest test_map_unmap: SUCCESS (0.032s)
[239.882143] [032/134] (781s left) kms_plane (pixel-format-x-tiled-modifier)
[239.980424] Starting subtest: pixel-format-x-tiled-modifier
[240.006559] Starting dynamic subtest: pipe-A-plane-0
[240.616476] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[240.624580] Starting dynamic subtest: pipe-A-plane-3
[241.028083] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[241.036303] Starting dynamic subtest: pipe-A-plane-5
[241.040248] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[242.165532] Starting dynamic subtest: pipe-B-plane-0
[242.791474] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s)
[242.800073] Starting dynamic subtest: pipe-B-plane-3
[243.202363] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[243.212715] Starting dynamic subtest: pipe-B-plane-5
[243.216401] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[243.522176] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.545s)
[244.361777] [033/134] (776s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[244.417348] Starting subtest: multi-wait-for-submit-submitted-signaled
[244.419605] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[244.533949] [034/134] (776s left) api_intel_bb (offset-control)
[244.594799] Starting subtest: offset-control
[244.600567] Subtest offset-control: SUCCESS (0.007s)
[244.708275] [035/134] (776s left) kms_pm_rpm (basic-rte)
[244.749618] Starting subtest: basic-rte
[247.880341] Subtest basic-rte: SUCCESS (3.132s)
[249.682728] [036/134] (771s left) kms_addfb_basic (master-rmfb)
[249.743932] Starting subtest: master-rmfb
[249.746208] Subtest master-rmfb: SUCCESS (0.001s)
[249.919325] [037/134] (771s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[250.120427] Starting subtest: cursor-rapid-movement-128x128
[250.125147] Starting dynamic subtest: pipe-A-eDP-1
[250.669227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[250.695587] Starting dynamic subtest: pipe-D-eDP-1
[251.870716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[251.872975] Subtest cursor-rapid-movement-128x128: SUCCESS (1.749s)
[252.732082] [038/134] (768s left) gem_userptr_blits (map-fixed-invalidate-busy)
[252.794464] Starting subtest: map-fixed-invalidate-busy
[252.798733] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[252.941596] [039/134] (768s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[253.004901] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[253.007262] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[253.121966] [040/134] (768s left) gem_exec_schedule (preempt-contexts)
[253.189275] Starting subtest: preempt-contexts
[253.191253] Starting dynamic subtest: rcs0
[253.233547] Dynamic subtest rcs0: SUCCESS (0.049s)
[253.242384] Starting dynamic subtest: bcs0
[253.287079] Dynamic subtest bcs0: SUCCESS (0.053s)
[253.295779] Starting dynamic subtest: vcs0
[253.332251] Dynamic subtest vcs0: SUCCESS (0.044s)
[253.340847] Starting dynamic subtest: vcs1
[253.371876] Dynamic subtest vcs1: SUCCESS (0.038s)
[253.380339] Starting dynamic subtest: vecs0
[253.412888] Dynamic subtest vecs0: SUCCESS (0.038s)
[253.422135] Starting dynamic subtest: ccs0
[253.454949] Dynamic subtest ccs0: SUCCESS (0.043s)
[253.457052] Subtest preempt-contexts: SUCCESS (0.271s)
[255.398471] [041/134] (765s left) gem_eio (kms)
[255.701070] Starting subtest: kms
[276.424303] Subtest kms: SUCCESS (20.723s)
[277.629610] [042/134] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[277.737226] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[277.741225] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[277.871402] [043/134] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[277.985015] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[277.989070] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[278.115019] [044/134] (743s left) gen9_exec_parse (bb-start-param)
[278.176811] Subtest bb-start-param: SKIP (0.000s)
[278.257542] [045/134] (743s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[278.383934] Starting subtest: flip-vs-cursor-atomic-transitions
[285.865845] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.478s)
[286.752759] [046/134] (734s left) sriov_basic (enable-vfs-autoprobe-off)
[286.823245] Starting subtest: enable-vfs-autoprobe-off
[286.825133] Starting dynamic subtest: numvfs-1
[286.904065] Dynamic subtest numvfs-1: FAIL (0.027s)
[286.914048] Starting dynamic subtest: numvfs-2
[286.986522] Dynamic subtest numvfs-2: FAIL (0.003s)
[286.997669] Starting dynamic subtest: numvfs-3
[287.070811] Dynamic subtest numvfs-3: FAIL (0.004s)
[287.080719] Starting dynamic subtest: numvfs-4
[287.152961] Dynamic subtest numvfs-4: FAIL (0.003s)
[287.162805] Starting dynamic subtest: numvfs-5
[287.235057] Dynamic subtest numvfs-5: FAIL (0.003s)
[287.245791] Starting dynamic subtest: numvfs-6
[287.318925] Dynamic subtest numvfs-6: FAIL (0.003s)
[287.329021] Starting dynamic subtest: numvfs-7
[287.402498] Dynamic subtest numvfs-7: FAIL (0.004s)
[287.411450] Starting dynamic subtest: numvfs-random
[287.483419] Dynamic subtest numvfs-random: FAIL (0.003s)
[287.493927] Starting dynamic subtest: numvfs-all
[287.566712] Dynamic subtest numvfs-all: FAIL (0.510s)
[287.569066] Subtest enable-vfs-autoprobe-off: FAIL (0.569s)
[287.608517] [047/134] (733s left) gem_userptr_blits (nohangcheck)
[287.685928] Starting subtest: nohangcheck
[287.958039] Subtest nohangcheck: SUCCESS (0.268s)
[288.095059] [048/134] (733s left) sysfs_defaults (readonly)
[288.166756] Starting subtest: readonly
[288.168994] Starting dynamic subtest: vecs0
[288.171355] Dynamic subtest vecs0: SUCCESS (0.000s)
[288.181156] Starting dynamic subtest: ccs0
[288.183264] Dynamic subtest ccs0: SUCCESS (0.000s)
[288.190999] Starting dynamic subtest: vcs0
[288.192829] Dynamic subtest vcs0: SUCCESS (0.000s)
[288.201194] Starting dynamic subtest: bcs0
[288.203305] Dynamic subtest bcs0: SUCCESS (0.000s)
[288.211413] Starting dynamic subtest: rcs0
[288.213524] Dynamic subtest rcs0: SUCCESS (0.000s)
[288.221587] Starting dynamic subtest: vcs1
[288.223703] Dynamic subtest vcs1: SUCCESS (0.000s)
[288.225862] Subtest readonly: SUCCESS (0.006s)
[288.261553] [049/134] (733s left) kms_chamelium_frames (hdmi-crc-fast)
[288.660055] Subtest hdmi-crc-fast: SKIP (0.000s)
[289.454157] [050/134] (732s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[289.566446] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[289.568767] Starting dynamic subtest: pipe-A-eDP-1
[289.707145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[289.717885] Starting dynamic subtest: pipe-B-eDP-1
[289.736716] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[289.745218] Starting dynamic subtest: pipe-C-eDP-1
[289.763491] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[289.771463] Starting dynamic subtest: pipe-D-eDP-1
[289.789782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[289.791544] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.141s)
[291.952688] [051/134] (729s left) kms_flip (flip-vs-fences-interruptible)
[292.057505] Starting subtest: flip-vs-fences-interruptible
[292.061496] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[292.208309] [052/134] (729s left) perf (global-sseu-config)
[292.350403] Starting subtest: global-sseu-config
[292.353956] Subtest global-sseu-config: SKIP (0.000s)
[292.392278] [053/134] (729s left) kms_color (ctm-0-25)
[292.496119] Starting subtest: ctm-0-25
[292.498385] Starting dynamic subtest: pipe-A-eDP-1
[296.050012] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.553s)
[296.059984] Starting dynamic subtest: pipe-B-eDP-1
[300.255652] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.202s)
[300.265288] Starting dynamic subtest: pipe-C-eDP-1
[304.301412] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.044s)
[304.310817] Starting dynamic subtest: pipe-D-eDP-1
[308.298774] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s)
[308.300674] Subtest ctm-0-25: SUCCESS (15.799s)
[309.158461] [054/134] (712s left) perf (invalid-remove-userspace-config)
[309.288147] Starting subtest: invalid-remove-userspace-config
[309.296662] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[309.340671] [055/134] (712s left) kms_cdclk (mode-transition-all-outputs)
[309.437119] Starting subtest: mode-transition-all-outputs
[309.726149] Subtest mode-transition-all-outputs: SKIP (0.287s)
[310.577612] [056/134] (711s left) gem_ctx_persistence (engines-queued)
[310.626434] Starting subtest: engines-queued
[310.628757] Starting dynamic subtest: rcs0
[310.702787] Dynamic subtest rcs0: SUCCESS (0.076s)
[310.715290] Starting dynamic subtest: bcs0
[310.733688] Dynamic subtest bcs0: SUCCESS (0.029s)
[310.742428] Starting dynamic subtest: vcs0
[312.268458] Dynamic subtest vcs0: SUCCESS (1.532s)
[312.280684] Starting dynamic subtest: vcs1
[314.250838] Dynamic subtest vcs1: SUCCESS (1.978s)
[314.263475] Starting dynamic subtest: vecs0
[316.234814] Dynamic subtest vecs0: SUCCESS (1.980s)
[316.246873] Starting dynamic subtest: ccs0
[316.448743] Dynamic subtest ccs0: SUCCESS (0.212s)
[316.451664] Subtest engines-queued: SUCCESS (5.822s)
[316.544134] [057/134] (705s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[316.618539] Subtest tiled-to-untiled: SKIP (0.000s)
[316.684717] [058/134] (705s left) kms_addfb_basic (bad-pitch-999)
[316.734491] Starting subtest: bad-pitch-999
[316.736678] Subtest bad-pitch-999: SUCCESS (0.000s)
[316.897987] [059/134] (705s left) kms_cursor_crc (cursor-offscreen-128x42)
[317.140433] Starting subtest: cursor-offscreen-128x42
[317.187411] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[317.424765] [060/134] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[317.536546] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[317.539991] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[317.651995] [061/134] (704s left) kms_content_protection (suspend-resume)
[317.798209] Starting subtest: suspend-resume
[317.802293] Subtest suspend-resume: SKIP (0.000s)
[317.965418] [062/134] (704s left) syncobj_timeline (invalid-wait-bad-flags)
[318.026863] Starting subtest: invalid-wait-bad-flags
[318.028833] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[318.177056] [063/134] (704s left) syncobj_wait (multi-wait-submitted-signaled)
[318.243679] Starting subtest: multi-wait-submitted-signaled
[318.245585] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[318.364000] [064/134] (703s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[318.459728] Starting subtest: crc-primary-suspend-y-tiled-ccs
[318.461640] Starting dynamic subtest: pipe-A-eDP-1
[318.468977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.478522] Starting dynamic subtest: pipe-B-eDP-1
[318.485923] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.494889] Starting dynamic subtest: pipe-C-eDP-1
[318.501923] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.510445] Starting dynamic subtest: pipe-D-eDP-1
[318.517609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.521179] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[320.742149] [065/134] (701s left) kms_flip (dpms-vs-vblank-race-interruptible)
[320.842161] Starting subtest: dpms-vs-vblank-race-interruptible
[320.844556] Starting dynamic subtest: A-eDP1
[324.770880] Dynamic subtest A-eDP1: SUCCESS (3.924s)
[324.780104] Starting dynamic subtest: B-eDP1
[329.396752] Dynamic subtest B-eDP1: SUCCESS (4.625s)
[329.408959] Starting dynamic subtest: C-eDP1
[334.020245] Dynamic subtest C-eDP1: SUCCESS (4.621s)
[334.030238] Starting dynamic subtest: D-eDP1
[338.632072] Dynamic subtest D-eDP1: SUCCESS (4.608s)
[338.634008] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.786s)
[339.525166] [066/134] (682s left) kms_rotation_crc (exhaust-fences)
[339.632395] Starting subtest: exhaust-fences
[339.636621] Subtest exhaust-fences: SKIP (0.000s)
[339.736502] [067/134] (682s left) kms_cursor_legacy (forked-move)
[339.857905] Starting subtest: forked-move
[339.860113] Starting dynamic subtest: pipe-A
[345.344284] Dynamic subtest pipe-A: SUCCESS (5.483s)
[345.358255] Starting dynamic subtest: pipe-B
[350.849098] Dynamic subtest pipe-B: SUCCESS (5.500s)
[350.860106] Starting dynamic subtest: pipe-C
[356.321872] Dynamic subtest pipe-C: SUCCESS (5.470s)
[356.333125] Starting dynamic subtest: pipe-D
[361.848628] Dynamic subtest pipe-D: SUCCESS (5.522s)
[361.860968] Starting dynamic subtest: all-pipes
[367.385202] Dynamic subtest all-pipes: SUCCESS (5.534s)
[367.387684] Subtest forked-move: SUCCESS (27.520s)
[367.539952] [068/134] (654s left) gem_exec_schedule (smoketest)
[367.738398] Starting subtest: smoketest
[367.740751] Starting dynamic subtest: rcs0
[373.282459] Dynamic subtest rcs0: SUCCESS (5.497s)
[373.294567] Starting dynamic subtest: bcs0
[378.801438] Dynamic subtest bcs0: SUCCESS (5.518s)
[378.814294] Starting dynamic subtest: vcs0
[384.313815] Dynamic subtest vcs0: SUCCESS (5.515s)
[384.326282] Starting dynamic subtest: vcs1
[389.829868] Dynamic subtest vcs1: SUCCESS (5.509s)
[389.845663] Starting dynamic subtest: vecs0
[395.329796] Dynamic subtest vecs0: SUCCESS (5.504s)
[395.340240] Starting dynamic subtest: ccs0
[400.844104] Dynamic subtest ccs0: SUCCESS (5.515s)
[400.846357] Subtest smoketest: SUCCESS (33.066s)
[401.100544] [069/134] (621s left) kms_feature_discovery (psr1)
[401.199217] Starting subtest: psr1
[401.201589] Subtest psr1: SUCCESS (0.000s)
[401.297077] [070/134] (621s left) gem_exec_balancer (parallel-contexts)
[401.563414] Starting subtest: parallel-contexts
[404.517895] Subtest parallel-contexts: SUCCESS (2.955s)
[405.439171] [071/134] (617s left) drm_read (short-buffer-nonblock)
[405.598764] Starting subtest: short-buffer-nonblock
[405.601206] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[405.772938] [072/134] (616s left) gem_exec_fence (syncobj-export)
[406.253207] Starting subtest: syncobj-export
[406.259050] Subtest syncobj-export: SUCCESS (0.006s)
[407.383528] [073/134] (615s left) syncobj_timeline (multi-wait-for-submit-signaled)
[407.448332] Starting subtest: multi-wait-for-submit-signaled
[407.450826] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[407.566499] [074/134] (615s left) kms_flip_event_leak (basic)
[407.659297] Starting subtest: basic
[407.661124] Starting dynamic subtest: pipe-A-eDP-1
[408.121066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[408.134145] Starting dynamic subtest: pipe-B-eDP-1
[409.263494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[409.273817] Starting dynamic subtest: pipe-C-eDP-1
[410.340544] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.072s)
[410.350664] Starting dynamic subtest: pipe-D-eDP-1
[411.471511] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[411.473687] Subtest basic: SUCCESS (3.812s)
[412.338649] [075/134] (610s left) gem_softpin (reverse)
[412.407425] Starting subtest: reverse
[412.412889] Subtest reverse: SUCCESS (0.005s)
[412.561168] [076/134] (610s left) kms_psr (fbc-pr-suspend)
[412.663333] Starting subtest: fbc-pr-suspend
[412.667646] Subtest fbc-pr-suspend: SKIP (0.000s)
[412.746516] [077/134] (610s left) kms_draw_crc (fill-fb)
[412.857457] Starting subtest: fill-fb
[413.375092] Subtest fill-fb: SUCCESS (0.520s)
[413.483144] [078/134] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[413.589819] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[413.593411] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[413.700188] [079/134] (609s left) kms_atomic (plane-overlay-legacy)
[413.803903] Starting subtest: plane-overlay-legacy
[413.805785] Starting dynamic subtest: pipe-A-eDP-1
[414.215469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[414.217349] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[415.085657] [080/134] (607s left) kms_chamelium_hpd (dp-hpd-fast)
[415.468420] Subtest dp-hpd-fast: SKIP (0.000s)
[416.265211] [081/134] (606s left) i915_query (hwconfig_table)
[416.321510] Starting subtest: hwconfig_table
[416.623785] Subtest hwconfig_table: SUCCESS (0.001s)
[416.661642] [082/134] (606s left) api_intel_allocator (default-alignment)
[416.712884] Starting subtest: default-alignment
[416.715168] Subtest default-alignment: SUCCESS (0.003s)
[416.840429] [083/134] (606s left) kms_invalid_mode (zero-clock)
[416.933679] Starting subtest: zero-clock
[416.935897] Starting dynamic subtest: pipe-A-eDP-1
[417.232731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[417.246320] Starting dynamic subtest: pipe-B-eDP-1
[417.248547] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[417.262557] Starting dynamic subtest: pipe-C-eDP-1
[417.264643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[417.279101] Starting dynamic subtest: pipe-D-eDP-1
[417.281618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[417.284047] Subtest zero-clock: SUCCESS (0.307s)
[418.043700] [084/134] (605s left) syncobj_wait (multi-wait-submitted)
[418.099193] Starting subtest: multi-wait-submitted
[418.208166] Subtest multi-wait-submitted: SUCCESS (0.108s)
[418.295805] [085/134] (604s left) gem_ctx_engines (execute-oneforall)
[418.351478] Starting subtest: execute-oneforall
[418.979112] Subtest execute-oneforall: SUCCESS (0.627s)
[420.418543] [086/134] (602s left) gem_exec_balancer (hog)
[420.496116] Starting subtest: hog
[420.500728] Subtest hog: SKIP (0.000s)
[420.812865] [087/134] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[420.912613] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[420.916968] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[421.036267] [088/134] (602s left) kms_psr (pr-primary-blt)
[421.129168] Starting subtest: pr-primary-blt
[421.133487] Subtest pr-primary-blt: SKIP (0.000s)
[421.229380] [089/134] (602s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[421.332611] Starting subtest: yf-tiled-32bpp-rotate-0
[421.336608] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[421.453135] [090/134] (601s left) gem_exec_gttfill (engines)
[421.514944] Starting subtest: engines
[421.517324] Starting dynamic subtest: rcs0
[444.277106] Dynamic subtest rcs0: SUCCESS (22.761s)
[444.289034] Starting dynamic subtest: bcs0
[467.550604] Dynamic subtest bcs0: SUCCESS (23.271s)
[467.562669] Starting dynamic subtest: vcs0
[490.892456] Dynamic subtest vcs0: SUCCESS (23.336s)
[490.903100] Starting dynamic subtest: vcs1
[514.164575] Dynamic subtest vcs1: SUCCESS (23.267s)
[514.182328] Starting dynamic subtest: vecs0
[537.450146] Dynamic subtest vecs0: SUCCESS (23.277s)
[537.461407] Starting dynamic subtest: ccs0
[560.773841] Dynamic subtest ccs0: SUCCESS (23.317s)
[560.776719] Subtest engines: SUCCESS (139.242s)
[560.993979] [091/134] (462s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[561.089037] Starting subtest: y-tiled-to-vebox-x-tiled
[561.093638] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[561.298392] [092/134] (462s left) perf_pmu (enable-race)
[561.340094] Starting subtest: enable-race
[561.342628] Starting dynamic subtest: rcs0
[574.107186] Dynamic subtest rcs0: SUCCESS (12.765s)
[574.116837] Starting dynamic subtest: bcs0
[586.847493] Dynamic subtest bcs0: SUCCESS (12.735s)
[586.859436] Starting dynamic subtest: vcs0
[602.219699] Dynamic subtest vcs0: SUCCESS (15.364s)
[602.230339] Starting dynamic subtest: vcs1
[618.220529] Dynamic subtest vcs1: SUCCESS (15.995s)
[618.232304] Starting dynamic subtest: vecs0
[634.283764] Dynamic subtest vecs0: SUCCESS (16.061s)
[634.294658] Starting dynamic subtest: ccs0
[647.073105] Dynamic subtest ccs0: SUCCESS (12.790s)
[647.075981] Subtest enable-race: SUCCESS (85.726s)
[647.217798] [093/134] (376s left) gem_ccs (block-copy-uncompressed)
[647.279570] Starting subtest: block-copy-uncompressed
[647.281923] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[647.311518] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.031s)
[647.323240] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[647.333958] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[647.342890] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[647.353704] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[647.362378] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[647.375267] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.020s)
[647.377563] Subtest block-copy-uncompressed: SUCCESS (0.097s)
[647.543947] [094/134] (375s left) prime_self_import (export-vs-gem_close-race)
[647.581301] Starting subtest: export-vs-gem_close-race
[652.688849] Subtest export-vs-gem_close-race: SUCCESS (5.110s)
[652.781885] [095/134] (370s left) syncobj_wait (single-wait-for-submit-signaled)
[652.869357] Starting subtest: single-wait-for-submit-signaled
[652.871648] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[652.998634] [096/134] (370s left) syncobj_eventfd (invalid-illegal-handle)
[653.068991] Starting subtest: invalid-illegal-handle
[653.071379] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[653.199624] [097/134] (370s left) gem_exec_whisper (basic-contexts-forked)
[653.265935] Starting subtest: basic-contexts-forked
[676.720440] Subtest basic-contexts-forked: SUCCESS (23.453s)
[676.913593] [098/134] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[677.030890] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[677.034896] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[677.148086] [099/134] (346s left) kms_big_fb (linear-16bpp-rotate-180)
[677.258751] Starting subtest: linear-16bpp-rotate-180
[678.616171] Subtest linear-16bpp-rotate-180: SUCCESS (1.357s)
[678.762318] [100/134] (345s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[678.869837] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[678.873522] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[678.966156] [101/134] (344s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[679.060065] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[679.063601] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[679.195014] [102/134] (344s left) i915_drm_fdinfo (memory-info-resident)
[679.235573] Starting subtest: memory-info-resident
[679.237462] Starting dynamic subtest: smem0
[681.694482] Dynamic subtest smem0: SUCCESS (2.459s)
[681.696419] Subtest memory-info-resident: SUCCESS (2.459s)
[681.781022] [103/134] (342s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[681.880803] Starting subtest: primary-x-tiled-reflect-x-180
[689.218671] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.339s)
[690.507747] [104/134] (333s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[690.609505] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[690.611808] Starting dynamic subtest: pipe-A-default-mode
[691.755133] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[691.759232] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.145s)
[691.934734] [105/134] (332s left) kms_plane_lowres (tiling-y)
[692.041392] Starting subtest: tiling-y
[692.045439] Subtest tiling-y: SKIP (0.000s)
[692.124063] [106/134] (331s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[697.098049] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[697.102759] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[697.944476] [107/134] (326s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[698.049702] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[699.059957] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[699.255803] [108/134] (324s left) core_setmaster (master-drop-set-shared-fd)
[699.356206] Starting subtest: master-drop-set-shared-fd
[699.366616] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[699.403975] [109/134] (324s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[699.499745] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[699.501694] Starting dynamic subtest: pipe-A-eDP-1
[699.518674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[699.529807] Starting dynamic subtest: pipe-B-eDP-1
[699.545468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[699.555020] Starting dynamic subtest: pipe-C-eDP-1
[699.571431] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[699.582201] Starting dynamic subtest: pipe-D-eDP-1
[699.598407] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[699.600190] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[701.728617] [110/134] (322s left) gem_exec_flush (basic-uc-pro-default)
[701.794883] Starting subtest: basic-uc-pro-default
[707.258755] Subtest basic-uc-pro-default: SUCCESS (5.464s)
[707.459435] [111/134] (316s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[707.575635] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[707.579577] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[707.703249] [112/134] (316s left) kms_flip (flip-vs-panning-interruptible)
[707.797797] Starting subtest: flip-vs-panning-interruptible
[707.800176] Starting dynamic subtest: A-eDP1
[716.532540] Dynamic subtest A-eDP1: SUCCESS (8.735s)
[716.548849] Starting dynamic subtest: B-eDP1
[725.266212] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[725.277444] Starting dynamic subtest: C-eDP1
[733.991385] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[734.004144] Starting dynamic subtest: D-eDP1
[742.725463] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[742.729712] Subtest flip-vs-panning-interruptible: SUCCESS (34.932s)
[744.011512] [113/134] (280s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[744.122110] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[745.134982] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.011s)
[745.290674] [114/134] (279s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[745.395604] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[745.399119] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[745.525278] [115/134] (278s left) i915_pm_rps (min-max-config-loaded)
[745.598383] Starting subtest: min-max-config-loaded
[745.602008] Subtest min-max-config-loaded: SKIP (0.001s)
[745.730162] [116/134] (278s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[745.831148] Starting subtest: fbcpsr-suspend
[786.567914] Subtest fbcpsr-suspend: SUCCESS (10.883s)
[786.729839] [117/134] (237s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[791.755941] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[791.758266] Starting dynamic subtest: pipe-A-eDP-1
[803.792688] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.045s)
[803.803062] Starting dynamic subtest: pipe-B-eDP-1
[815.818525] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.030s)
[815.821054] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.079s)
[816.669031] [118/134] (207s left) gem_pread (self)
[816.742362] Subtest self: SKIP (0.000s)
[816.813986] [119/134] (207s left) gem_ppgtt (blt-vs-render-ctxn)
[816.878029] Starting subtest: blt-vs-render-ctxN
[849.776364] Subtest blt-vs-render-ctxN: SUCCESS (32.896s)
[849.934499] [120/134] (174s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[850.096663] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[854.189992] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.098s)
[855.365805] [121/134] (169s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[855.496069] Starting subtest: verify-pxp-execution-after-suspend-resume
[862.531073] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.039s)
[862.703817] [122/134] (162s left) kms_pipe_crc_basic (suspend-read-crc)
[862.805996] Starting subtest: suspend-read-crc
[862.808279] Starting dynamic subtest: pipe-A-eDP-1
[880.862503] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.569s)
[880.878555] Starting dynamic subtest: pipe-B-eDP-1
[898.862450] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.138s)
[898.873668] Starting dynamic subtest: pipe-C-eDP-1
[916.847754] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.152s)
[916.859558] Starting dynamic subtest: pipe-D-eDP-1
[934.812267] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.039s)
[934.814621] Subtest suspend-read-crc: SUCCESS (11.904s)
[935.666558] [123/134] ( 89s left) gem_mmap_wc (read-write-distinct)
[935.719638] Subtest read-write-distinct: SKIP (0.000s)
[935.794458] [124/134] ( 89s left) kms_selftest (drm_plane_helper)
[935.843059] Starting subtest: drm_plane_helper
[935.888585] Starting dynamic subtest: drm_test_check_plane_state
[936.011333] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.125s)
[936.022319] Starting dynamic subtest: drm_test_check_invalid_plane_state
[936.165054] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.152s)
[936.167032] Subtest drm_plane_helper: SUCCESS (0.322s)
[936.363938] [125/134] ( 88s left) gem_userptr_blits (usage-restrictions)
[936.439043] Starting subtest: usage-restrictions
[936.442980] Subtest usage-restrictions: SUCCESS (0.000s)
[936.576953] [126/134] ( 88s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[936.683636] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[936.687775] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[936.796809] [127/134] ( 88s left) kms_lease (lease-unleased-connector)
[936.897473] Starting subtest: lease-unleased-connector
[936.899702] Starting dynamic subtest: pipe-A-eDP-1
[936.901967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[936.913026] Starting dynamic subtest: pipe-B-eDP-1
[936.915191] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[936.925624] Starting dynamic subtest: pipe-C-eDP-1
[936.927796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[936.937543] Starting dynamic subtest: pipe-D-eDP-1
[936.939383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[936.941294] Subtest lease-unleased-connector: SUCCESS (0.036s)
[937.064444] [128/134] ( 87s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[937.173890] Starting subtest: yf-tiled-32bpp-rotate-90
[937.178357] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[937.299476] [129/134] ( 87s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[937.409297] Starting subtest: fbc-psr-sprite-mmap-cpu
[937.411192] Starting dynamic subtest: eDP-1
[937.414607] Dynamic subtest eDP-1: SKIP (0.000s)
[937.417988] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[937.493459] [130/134] ( 87s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[937.585002] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[937.588800] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[937.709787] [131/134] ( 87s left) i915_module_load (fault-injection)
[937.744220] Starting subtest: fault-injection
[937.772223] Starting dynamic subtest: __uc_init
[941.555723] Dynamic subtest __uc_init: SUCCESS (3.788s)
[941.572029] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[941.576437] Starting dynamic subtest: i915_driver_mmio_probe
[941.773015] Dynamic subtest i915_driver_mmio_probe: SUCCESS (0.216s)
[941.775343] Starting dynamic subtest: i915_driver_hw_probe
[941.968042] Dynamic subtest i915_driver_hw_probe: SUCCESS (0.194s)
[941.970311] Starting dynamic subtest: i915_pci_probe
[942.109166] Dynamic subtest i915_pci_probe: SUCCESS (0.140s)
[942.111614] Starting dynamic subtest: __fw_domain_init
[942.315073] Dynamic subtest __fw_domain_init: SUCCESS (0.204s)
[942.317449] Starting dynamic subtest: intel_connector_register
[944.302112] Dynamic subtest intel_connector_register: SUCCESS (1.989s)
[944.304543] Starting dynamic subtest: i915_driver_early_probe
[944.434170] Dynamic subtest i915_driver_early_probe: SUCCESS (0.130s)
[944.436395] Starting dynamic subtest: intel_gt_init-ENODEV
[945.574235] Dynamic subtest intel_gt_init-ENODEV: SUCCESS (1.140s)
[945.576636] Starting dynamic subtest: intel_guc_ct_init
[946.749461] Dynamic subtest intel_guc_ct_init: SUCCESS (1.175s)
[946.751459] Starting dynamic subtest: uc_fw_rsa_data_create
[947.903370] Dynamic subtest uc_fw_rsa_data_create: SUCCESS (1.153s)
[1037.022436] Killing the test because the kernel is tainted.
[1037.821719] [FACT i915_module_load (fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1037.821785] [FACT i915_module_load (fault-injection)] new: kernel.is_tainted.taint_warn: true
[1037.822555] Closing watchdogs
results: parsing output: 0/ for test: kms_properties
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: gem_huc_copy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_ctx_persistence
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_busy
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: prime_mmap
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: sriov_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: sysfs_defaults
results: parsing output: 48/ for test: kms_chamelium_frames
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_color
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_cdclk
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: gem_set_tiling_vs_blt
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_content_protection
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_feature_discovery
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: drm_read
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_flip_event_leak
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_draw_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_atomic
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: i915_query
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_invalid_mode
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_ctx_engines
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_gttfill
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: gem_ccs
results: parsing output: 93/ for test: prime_self_import
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_plane_lowres
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: core_setmaster
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: i915_pm_rps
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: gem_pread
results: parsing output: 118/ for test: gem_ppgtt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: kms_pipe_crc_basic
results: parsing output: 122/ for test: gem_mmap_wc
results: parsing output: 123/ for test: kms_selftest
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_module_load
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
igt_resultgen: Added ignore regex '.*Failed to register driver for userspace access!|.*Device initialization failed.*|.*probe with driver i915 failed with error.*|.*GT1: GSC proxy handler failed to init.*|.*GT0: GUC: failed with -ENXIO.*|.*GuC fw rsa data creation failed -ENXIO.*|.*GUC: failed with -ENXIO.*|.*Failed to register driver for userspace access.*|.*GT0: GuC fw rsa data creation failed -ENXIO.*'
results: parsing output: 131/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 133/ for test: kms_psr
results: no output, setting notrun
Done.