[56.568500] Initializing watchdogs
[56.568547]   /dev/watchdog0
[56.582737] [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]
[56.587494] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.589958] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.593315] [001/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[56.712895] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[56.717102] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[56.839327] [002/132] (960s left) kms_cursor_crc (cursor-onscreen-64x21)
[57.032587] Starting subtest: cursor-onscreen-64x21
[57.093218] Subtest cursor-onscreen-64x21: SKIP (0.055s)
[57.358244] [003/132] (959s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[62.413306] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[62.415800] Starting dynamic subtest: pipe-A-eDP-1
[63.201908] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[63.209076] Starting dynamic subtest: pipe-B-eDP-1
[64.334445] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[64.339333] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.913s)
[65.542829] [004/132] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[65.645426] Starting subtest: primary-y-tiled-reflect-x-90
[65.650039] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[65.736914] [005/132] (951s left) kms_vrr (negative-basic)
[65.834827] Starting subtest: negative-basic
[65.841250] Starting dynamic subtest: pipe-A-eDP-1
[71.258510] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.408s)
[71.552089] Subtest negative-basic: SUCCESS (5.711s)
[72.374667] [006/132] (944s left) gem_exec_whisper (basic-fds-priority)
[72.442940] Starting subtest: basic-fds-priority
[96.392081] Subtest basic-fds-priority: SUCCESS (23.935s)
[96.597818] [007/132] (920s left) kms_chamelium_edid (dp-edid-resolution-list)
[96.998353] Subtest dp-edid-resolution-list: SKIP (0.000s)
[97.770085] [008/132] (919s left) kms_frontbuffer_tracking (fbc-suspend)
[97.880059] Starting subtest: fbc-suspend
[135.691839] Subtest fbc-suspend: SUCCESS (11.256s)
[136.931869] [009/132] (880s left) syncobj_timeline (multi-wait-submitted-signaled)
[136.992200] Starting subtest: multi-wait-submitted-signaled
[136.994646] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[137.107986] [010/132] (880s left) syncobj_wait (multi-wait-all-submitted)
[137.170089] Starting subtest: multi-wait-all-submitted
[137.280658] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[137.381806] [011/132] (880s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[137.482953] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[137.487396] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[137.597158] [012/132] (879s left) gem_partial_pwrite_pread (write-uncached)
[137.663276] Subtest write-uncached: SKIP (0.000s)
[137.749484] [013/132] (879s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[137.834649] Starting subtest: fbc-pr-sprite-mmap-gtt
[137.838977] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[137.929513] [014/132] (879s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[138.035077] Starting subtest: x-tiled-32bpp-rotate-270
[138.055019] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[138.206427] [015/132] (879s left) gem_exec_fence (basic-wait)
[138.401607] Starting subtest: basic-wait
[138.404246] Starting dynamic subtest: rcs0
[138.488947] Dynamic subtest rcs0: SUCCESS (0.087s)
[138.499919] Starting dynamic subtest: bcs0
[138.542705] Dynamic subtest bcs0: SUCCESS (0.052s)
[138.553239] Starting dynamic subtest: vcs0
[138.603202] Dynamic subtest vcs0: SUCCESS (0.058s)
[138.613710] Starting dynamic subtest: vcs1
[138.668566] Dynamic subtest vcs1: SUCCESS (0.064s)
[138.679291] Starting dynamic subtest: vecs0
[138.735046] Dynamic subtest vecs0: SUCCESS (0.065s)
[138.746257] Starting dynamic subtest: ccs0
[138.798073] Dynamic subtest ccs0: SUCCESS (0.061s)
[138.800496] Subtest basic-wait: SUCCESS (0.392s)
[140.458717] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[140.461981] [016/132] (877s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[140.562225] Starting subtest: plane-lut1d-post-ctm3x4
[140.575259] Starting dynamic subtest: pipe-A-eDP-1
[141.322089] Dynamic subtest pipe-A-eDP-1: FAIL (0.349s)
[142.048891] Starting dynamic subtest: pipe-B-eDP-1
[142.890543] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[143.490667] Starting dynamic subtest: pipe-C-eDP-1
[144.332113] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[144.834288] Starting dynamic subtest: pipe-D-eDP-1
[145.702496] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[145.704552] Subtest plane-lut1d-post-ctm3x4: FAIL (4.784s)
[146.251254] [017/132] (871s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[146.346127] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[146.348493] Starting dynamic subtest: pipe-A-default-mode
[149.048144] Dynamic subtest pipe-A-default-mode: SUCCESS (2.689s)
[149.050723] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.691s)
[149.951051] [018/132] (867s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[150.061781] Starting subtest: 2x-absolute-wf_vblank-interruptible
[150.073322] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[150.218409] [019/132] (867s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[150.318014] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[156.909465] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.580s)
[157.050830] [020/132] (860s left) gem_exec_params (invalid-bsd2-flag-on-render)
[157.124942] Starting subtest: invalid-bsd2-flag-on-render
[157.127335] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[157.251244] [021/132] (860s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[157.366022] Starting subtest: psr-rgb101010-draw-blt
[164.735275] Subtest psr-rgb101010-draw-blt: SUCCESS (7.363s)
[164.915361] [022/132] (853s left) syncobj_timeline (invalid-wait-bad-flags)
[164.985374] Starting subtest: invalid-wait-bad-flags
[164.987715] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[165.115612] [023/132] (852s left) gem_mmap_gtt (cpuset-big-copy-odd)
[165.178578] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[165.241956] [024/132] (852s left) gem_mmap_wc (bad-size)
[165.303941] Subtest bad-size: SKIP (0.000s)
[165.371299] [025/132] (852s left) gem_exec_balancer (invalid-bonds)
[165.443147] Starting subtest: invalid-bonds
[165.447219] Subtest invalid-bonds: SKIP (0.000s)
[165.783035] [026/132] (852s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[165.888874] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[165.893012] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[166.026882] [027/132] (852s left) kms_lease (lease-get)
[166.128451] Starting subtest: lease-get
[166.130889] Starting dynamic subtest: pipe-A-eDP-1
[166.133270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[166.144439] Starting dynamic subtest: pipe-B-eDP-1
[166.147083] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[166.158294] Starting dynamic subtest: pipe-C-eDP-1
[166.160293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[166.168301] Starting dynamic subtest: pipe-D-eDP-1
[166.170249] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[166.172178] Subtest lease-get: SUCCESS (0.023s)
[166.295476] [028/132] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[166.413120] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[170.723930] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.315s)
[171.925480] [029/132] (846s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[172.319405] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[173.100965] [030/132] (845s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[173.205425] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[176.861089] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.661s)
[178.058476] [031/132] (840s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[178.173035] Starting subtest: yf-tiled-64bpp-rotate-0
[178.177446] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[178.312471] [032/132] (840s left) gem_mmap_gtt (medium-copy-odd)
[178.370889] Subtest medium-copy-odd: SKIP (0.000s)
[178.439498] [033/132] (839s left) gem_pxp (protected-raw-src-copy-not-readible)
[178.558901] Starting subtest: protected-raw-src-copy-not-readible
[178.618756] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.062s)
[178.811840] [034/132] (839s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[178.932862] Starting subtest: flip-vs-cursor-crc-atomic
[179.635981] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.703s)
[180.472057] [035/132] (838s left) kms_atomic_transition (plane-all-transition-fencing)
[180.577575] Starting subtest: plane-all-transition-fencing
[180.580033] Starting dynamic subtest: pipe-A-eDP-1
[183.074652] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[183.392785] Starting dynamic subtest: pipe-B-eDP-1
[186.585769] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.202s)
[186.886360] Subtest plane-all-transition-fencing: SUCCESS (6.307s)
[187.739579] [036/132] (830s left) prime_self_import (basic-with_one_bo_two_files)
[187.778137] Starting subtest: basic-with_one_bo_two_files
[187.803866] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s)
[187.951148] [037/132] (830s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[188.050443] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[188.052654] Starting dynamic subtest: pipe-A-eDP-1
[188.074377] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.085716] Starting dynamic subtest: pipe-B-eDP-1
[188.105951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.114295] Starting dynamic subtest: pipe-C-eDP-1
[188.135462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.143476] Starting dynamic subtest: pipe-D-eDP-1
[188.165026] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.169374] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[190.310896] [038/132] (828s left) i915_drm_fdinfo (all-busy-check-all)
[190.351484] Starting subtest: all-busy-check-all
[190.355793] Subtest all-busy-check-all: SKIP (0.003s)
[190.447023] [039/132] (828s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[190.548276] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[190.550534] Starting dynamic subtest: pipe-A-default-mode
[190.837788] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[190.842232] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.287s)
[191.748214] [040/132] (826s left) kms_addfb_basic (bad-pitch-0)
[191.810825] Starting subtest: bad-pitch-0
[191.813073] Subtest bad-pitch-0: SUCCESS (0.000s)
[191.963799] [041/132] (826s left) gem_ctx_persistence (heartbeat-stop)
[192.025003] Starting subtest: heartbeat-stop
[192.029780] Subtest heartbeat-stop: SKIP (0.000s)
[192.157032] [042/132] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[192.257358] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[192.261696] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[192.367969] [043/132] (826s left) gem_exec_schedule (smoketest)
[192.545187] Starting subtest: smoketest
[192.547357] Starting dynamic subtest: rcs0
[198.079671] Dynamic subtest rcs0: SUCCESS (5.487s)
[198.090361] Starting dynamic subtest: bcs0
[203.595912] Dynamic subtest bcs0: SUCCESS (5.509s)
[203.607649] Starting dynamic subtest: vcs0
[209.096038] Dynamic subtest vcs0: SUCCESS (5.495s)
[209.106490] Starting dynamic subtest: vcs1
[214.592817] Dynamic subtest vcs1: SUCCESS (5.495s)
[214.603306] Starting dynamic subtest: vecs0
[220.093512] Dynamic subtest vecs0: SUCCESS (5.499s)
[220.104017] Starting dynamic subtest: ccs0
[225.602826] Dynamic subtest ccs0: SUCCESS (5.505s)
[225.605127] Subtest smoketest: SUCCESS (32.996s)
[225.766919] [044/132] (793s left) gem_exec_parallel (contexts)
[225.836255] Starting subtest: contexts
[225.838801] Starting dynamic subtest: rcs0
[229.567249] Dynamic subtest rcs0: SUCCESS (3.729s)
[229.576232] Starting dynamic subtest: bcs0
[233.272288] Dynamic subtest bcs0: SUCCESS (3.703s)
[233.282424] Starting dynamic subtest: vcs0
[237.759242] Dynamic subtest vcs0: SUCCESS (4.487s)
[237.769880] Starting dynamic subtest: vcs1
[241.840248] Dynamic subtest vcs1: SUCCESS (4.079s)
[241.850115] Starting dynamic subtest: vecs0
[245.838606] Dynamic subtest vecs0: SUCCESS (3.995s)
[245.850881] Starting dynamic subtest: ccs0
[249.721753] Dynamic subtest ccs0: SUCCESS (3.883s)
[249.724079] Subtest contexts: SUCCESS (23.889s)
[249.934777] [045/132] (768s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[249.998960] Starting subtest: invalid-bsd2-flag-on-blt
[250.001240] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[250.126241] [046/132] (768s left) kms_psr (fbc-psr2-primary-render)
[250.231076] Starting subtest: fbc-psr2-primary-render
[250.233265] Starting dynamic subtest: eDP-1
[250.237097] Dynamic subtest eDP-1: SKIP (0.000s)
[250.241011] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[250.327263] [047/132] (768s left) prime_vgem (coherency-gtt)
[250.427048] Starting subtest: coherency-gtt
[250.431587] Subtest coherency-gtt: SKIP (0.000s)
[250.575183] [048/132] (768s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[250.692519] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[250.696878] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[250.859677] [049/132] (768s left) kms_flip (flip-vs-expired-vblank)
[250.952271] Starting subtest: flip-vs-expired-vblank
[250.954109] Starting dynamic subtest: A-eDP1
[259.622862] Dynamic subtest A-eDP1: SUCCESS (8.670s)
[259.633099] Starting dynamic subtest: B-eDP1
[268.254014] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[268.264291] Starting dynamic subtest: C-eDP1
[276.888677] Dynamic subtest C-eDP1: SUCCESS (8.632s)
[276.905843] Starting dynamic subtest: D-eDP1
[285.514926] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[285.517314] Subtest flip-vs-expired-vblank: SUCCESS (34.563s)
[286.712350] [050/132] (732s left) gem_mmap_wc (write-read)
[286.769033] Subtest write-read: SKIP (0.000s)
[286.836849] [051/132] (732s left) kms_psr (psr-sprite-render)
[286.933319] Starting subtest: psr-sprite-render
[286.935569] Starting dynamic subtest: eDP-1
[288.712493] Dynamic subtest eDP-1: SUCCESS (1.778s)
[288.714383] Subtest psr-sprite-render: SUCCESS (1.779s)
[289.580027] [052/132] (729s left) kms_psr (psr2-cursor-blt)
[289.686267] Starting subtest: psr2-cursor-blt
[289.688456] Starting dynamic subtest: eDP-1
[291.444007] Dynamic subtest eDP-1: SUCCESS (1.756s)
[291.446278] Subtest psr2-cursor-blt: SUCCESS (1.758s)
[292.268035] [053/132] (726s left) kms_prime (basic-modeset-hybrid)
[292.356934] Subtest basic-modeset-hybrid: SKIP (0.000s)
[292.463551] [054/132] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[292.564719] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[292.568785] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[292.697912] [055/132] (726s left) kms_psr (fbc-psr-sprite-plane-onoff)
[292.802352] Starting subtest: fbc-psr-sprite-plane-onoff
[292.804582] Starting dynamic subtest: eDP-1
[292.808636] Dynamic subtest eDP-1: SKIP (0.000s)
[292.812708] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[292.899616] [056/132] (726s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[292.971519] Starting subtest: stress-mm-invalidate-close-overlap
[295.148611] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[295.286933] [057/132] (724s left) gem_exec_params (batch-first)
[295.357622] Starting subtest: batch-first
[295.367516] Subtest batch-first: SUCCESS (0.010s)
[295.530125] [058/132] (723s left) i915_pm_rpm (gem-mmap-type)
[297.562469] Starting subtest: gem-mmap-type
[297.565031] Starting dynamic subtest: wb-smem0
[301.362674] Dynamic subtest wb-smem0: SUCCESS (3.802s)
[301.374413] Starting dynamic subtest: wc-smem0
[304.519509] Dynamic subtest wc-smem0: SUCCESS (3.153s)
[304.528957] Starting dynamic subtest: uc-smem0
[307.676011] Dynamic subtest uc-smem0: SUCCESS (3.154s)
[307.678427] Subtest gem-mmap-type: SUCCESS (10.115s)
[307.789531] [059/132] (711s left) dumb_buffer (create-clear)
[307.856226] Starting subtest: create-clear
[341.647792] Subtest create-clear: SUCCESS (33.779s)
[341.796332] [060/132] (677s left) i915_module_load (resize-bar)
[341.836715] Starting subtest: resize-bar
[341.843282] Subtest resize-bar: SKIP (0.005s)
[341.889585] [061/132] (677s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[341.962177] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[341.966350] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[342.171573] [062/132] (677s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[342.301764] Starting subtest: basic-busy-flip-before-cursor-varying-size
[342.306135] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[342.470275] [063/132] (677s left) gem_eio (kms)
[342.726129] Starting subtest: kms
[364.471530] Subtest kms: SUCCESS (21.743s)
[365.682615] [064/132] (654s left) gem_exec_fence (keep-in-fence)
[365.875863] Starting subtest: keep-in-fence
[365.878184] Starting dynamic subtest: rcs0
[365.948465] Dynamic subtest rcs0: SUCCESS (0.072s)
[365.959931] Starting dynamic subtest: bcs0
[366.001649] Dynamic subtest bcs0: SUCCESS (0.051s)
[366.013776] Starting dynamic subtest: vcs0
[367.356914] Dynamic subtest vcs0: SUCCESS (1.352s)
[367.369870] Starting dynamic subtest: vcs1
[369.404836] Dynamic subtest vcs1: SUCCESS (2.046s)
[369.417557] Starting dynamic subtest: vecs0
[371.388500] Dynamic subtest vecs0: SUCCESS (1.982s)
[371.401062] Starting dynamic subtest: ccs0
[371.612268] Dynamic subtest ccs0: SUCCESS (0.222s)
[371.615120] Subtest keep-in-fence: SUCCESS (5.738s)
[373.495537] [065/132] (646s left) kms_big_fb (linear-8bpp-rotate-270)
[373.615944] Starting subtest: linear-8bpp-rotate-270
[373.637266] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[373.786648] [066/132] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[373.880290] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[380.936724] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.060s)
[381.086753] [067/132] (638s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[381.204468] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[381.208914] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[382.321572] [068/132] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[382.415031] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[382.419489] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[382.537172] [069/132] (637s left) i915_query (query-garbage)
[382.596930] Starting subtest: query-garbage
[382.599234] Subtest query-garbage: SUCCESS (0.000s)
[382.737431] [070/132] (637s left) gem_huc_copy (huc-copy)
[382.797524] Starting subtest: huc-copy
[382.802536] Subtest huc-copy: SUCCESS (0.003s)
[382.969041] [071/132] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[383.067784] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[386.839045] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.775s)
[388.047988] [072/132] (631s left) gem_create (create-invalid-size)
[388.127879] Starting subtest: create-invalid-size
[388.130253] Subtest create-invalid-size: SUCCESS (0.000s)
[388.340383] [073/132] (631s left) kms_pm_rpm (drm-resources-equal)
[390.576703] Starting subtest: drm-resources-equal
[395.556652] Subtest drm-resources-equal: SUCCESS (4.985s)
[395.672811] [074/132] (624s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[395.768306] Starting subtest: random-ccs-data-yf-tiled-ccs
[395.770585] Starting dynamic subtest: pipe-A-eDP-1
[395.796259] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.812812] Starting dynamic subtest: pipe-B-eDP-1
[395.838448] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.849484] Starting dynamic subtest: pipe-C-eDP-1
[395.873335] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.882398] Starting dynamic subtest: pipe-D-eDP-1
[395.906869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.911516] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[398.070915] [075/132] (622s left) kms_lease (empty-lease)
[398.174264] Starting subtest: empty-lease
[398.176460] Starting dynamic subtest: pipe-A-eDP-1
[398.178711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[398.188789] Starting dynamic subtest: pipe-B-eDP-1
[398.190650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[398.199721] Starting dynamic subtest: pipe-C-eDP-1
[398.201619] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[398.210669] Starting dynamic subtest: pipe-D-eDP-1
[398.212632] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[398.214586] Subtest empty-lease: SUCCESS (0.008s)
[398.325234] [076/132] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[398.427627] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[398.431711] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[398.569579] [077/132] (621s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[398.623542] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[398.625776] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[398.753131] [078/132] (621s left) api_intel_allocator (gem-pool)
[398.814822] Starting subtest: gem-pool
[398.820977] Subtest gem-pool: SUCCESS (0.008s)
[398.986912] [079/132] (621s left) core_getclient (basic)
[399.048499] Starting subtest: basic
[399.050432] Subtest basic: SUCCESS (0.000s)
[399.188959] [080/132] (621s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[399.280507] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[399.282456] Starting dynamic subtest: pipe-A
[399.642819] Dynamic subtest pipe-A: SUCCESS (0.364s)
[399.654340] Starting dynamic subtest: pipe-B
[401.065287] Dynamic subtest pipe-B: SUCCESS (1.420s)
[401.077273] Starting dynamic subtest: pipe-C
[402.501591] Dynamic subtest pipe-C: SUCCESS (1.436s)
[402.511118] Starting dynamic subtest: pipe-D
[403.907604] Dynamic subtest pipe-D: SUCCESS (1.405s)
[403.909874] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.629s)
[405.103613] [081/132] (615s left) syncobj_timeline (etime-single-wait-submitted)
[405.167668] Starting subtest: etime-single-wait-submitted
[405.273144] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[405.374740] [082/132] (615s left) gem_basic (create-close)
[405.428928] Starting subtest: create-close
[405.433475] Subtest create-close: SUCCESS (0.000s)
[405.562600] [083/132] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[405.664242] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[412.380237] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.719s)
[412.563675] [084/132] (607s left) gem_spin_batch (legacy-resubmit)
[412.628916] Starting subtest: legacy-resubmit
[412.631263] Starting dynamic subtest: default
[412.635801] Dynamic subtest default: SUCCESS (0.006s)
[412.645479] Starting dynamic subtest: render
[412.647653] Dynamic subtest render: SUCCESS (0.001s)
[412.657152] Starting dynamic subtest: bsd
[412.659276] Dynamic subtest bsd: SUCCESS (0.003s)
[412.668263] Starting dynamic subtest: bsd1
[412.670363] Dynamic subtest bsd1: SUCCESS (0.001s)
[412.679286] Starting dynamic subtest: bsd2
[412.681409] Dynamic subtest bsd2: SUCCESS (0.003s)
[412.690255] Starting dynamic subtest: blt
[412.692434] Dynamic subtest blt: SUCCESS (0.003s)
[412.701106] Starting dynamic subtest: vebox
[412.703319] Dynamic subtest vebox: SUCCESS (0.002s)
[412.705483] Subtest legacy-resubmit: SUCCESS (0.026s)
[412.919482] [085/132] (607s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[413.020246] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[413.022429] Starting dynamic subtest: pipe-A-eDP-1
[413.042633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[413.054151] Starting dynamic subtest: pipe-B-eDP-1
[413.074790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[413.086154] Starting dynamic subtest: pipe-C-eDP-1
[413.106096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[413.116235] Starting dynamic subtest: pipe-D-eDP-1
[413.134455] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[413.136568] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.010s)
[415.288239] [086/132] (605s left) perf_pmu (semaphore-wait-idle)
[415.325395] Starting subtest: semaphore-wait-idle
[415.327788] Starting dynamic subtest: rcs0
[415.839913] Dynamic subtest rcs0: SUCCESS (0.514s)
[415.852695] Starting dynamic subtest: bcs0
[416.354096] Dynamic subtest bcs0: SUCCESS (0.511s)
[416.367129] Starting dynamic subtest: vcs0
[416.868242] Dynamic subtest vcs0: SUCCESS (0.511s)
[416.881169] Starting dynamic subtest: vcs1
[417.380649] Dynamic subtest vcs1: SUCCESS (0.510s)
[417.392274] Starting dynamic subtest: vecs0
[417.892923] Dynamic subtest vecs0: SUCCESS (0.510s)
[417.905611] Starting dynamic subtest: ccs0
[418.408930] Dynamic subtest ccs0: SUCCESS (0.513s)
[418.412005] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[418.561653] [087/132] (602s left) gem_wait (write-wait)
[418.629504] Starting subtest: write-wait
[418.631464] Starting dynamic subtest: all-engines
[419.758907] Dynamic subtest all-engines: SUCCESS (1.132s)
[419.775545] Starting dynamic subtest: rcs0
[420.817169] Dynamic subtest rcs0: SUCCESS (1.056s)
[420.833471] Starting dynamic subtest: bcs0
[421.874239] Dynamic subtest bcs0: SUCCESS (1.055s)
[421.891005] Starting dynamic subtest: vcs0
[422.928850] Dynamic subtest vcs0: SUCCESS (1.052s)
[422.946099] Starting dynamic subtest: vcs1
[423.983007] Dynamic subtest vcs1: SUCCESS (1.052s)
[424.004613] Starting dynamic subtest: vecs0
[425.035943] Dynamic subtest vecs0: SUCCESS (1.051s)
[425.052635] Starting dynamic subtest: ccs0
[426.092448] Dynamic subtest ccs0: SUCCESS (1.054s)
[426.095090] Subtest write-wait: SUCCESS (7.467s)
[426.319096] [088/132] (594s left) kms_atomic (plane-primary-legacy)
[426.412007] Starting subtest: plane-primary-legacy
[426.414405] Starting dynamic subtest: pipe-A-eDP-1
[426.867752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[426.870477] Subtest plane-primary-legacy: SUCCESS (0.457s)
[427.725663] [089/132] (593s left) sysfs_preempt_timeout (invalid)
[427.783686] Starting subtest: invalid
[427.785779] Starting dynamic subtest: vecs0
[427.788057] Dynamic subtest vecs0: SUCCESS (0.000s)
[427.797748] Starting dynamic subtest: ccs0
[427.799640] Dynamic subtest ccs0: SUCCESS (0.000s)
[427.808155] Starting dynamic subtest: vcs0
[427.810073] Dynamic subtest vcs0: SUCCESS (0.000s)
[427.818568] Starting dynamic subtest: bcs0
[427.820435] Dynamic subtest bcs0: SUCCESS (0.000s)
[427.829080] Starting dynamic subtest: rcs0
[427.830973] Dynamic subtest rcs0: SUCCESS (0.000s)
[427.839940] Starting dynamic subtest: vcs1
[427.842140] Dynamic subtest vcs1: SUCCESS (0.000s)
[427.844308] Subtest invalid: SUCCESS (0.006s)
[427.921911] [090/132] (592s left) gem_exec_fence (syncobj-timeline-signal)
[428.434322] Starting subtest: syncobj-timeline-signal
[428.440152] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[429.501509] [091/132] (591s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[429.706497] Starting subtest: cursor-rapid-movement-64x21
[429.749747] Subtest cursor-rapid-movement-64x21: SKIP (0.041s)
[430.028821] [092/132] (590s left) perf (oa-formats)
[430.164493] Starting subtest: oa-formats
[430.166354] Starting dynamic subtest: 0-rcs0
[430.179332] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[430.190426] Starting dynamic subtest: 1-vecs0
[430.202186] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[430.204389] Subtest oa-formats: SUCCESS (0.039s)
[430.251401] [093/132] (590s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[430.343986] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[430.345868] Starting dynamic subtest: pipe-A-eDP-1
[430.410896] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[430.420123] Starting dynamic subtest: pipe-B-eDP-1
[430.477373] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.065s)
[430.492408] Starting dynamic subtest: pipe-C-eDP-1
[430.547397] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.068s)
[430.557149] Starting dynamic subtest: pipe-D-eDP-1
[430.612743] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[430.614585] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.271s)
[432.889620] [094/132] (588s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[432.941595] Starting subtest: invalid-bsd1-flag-on-blt
[432.944011] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[433.071157] [095/132] (587s left) gem_ctx_persistence (engines-cleanup)
[433.127832] Starting subtest: engines-cleanup
[433.130274] Starting dynamic subtest: rcs0
[433.249231] Dynamic subtest rcs0: SUCCESS (0.121s)
[433.262112] Starting dynamic subtest: bcs0
[433.314169] Dynamic subtest bcs0: SUCCESS (0.063s)
[433.325331] Starting dynamic subtest: vcs0
[433.378774] Dynamic subtest vcs0: SUCCESS (0.063s)
[433.390057] Starting dynamic subtest: vcs1
[433.443984] Dynamic subtest vcs1: SUCCESS (0.062s)
[433.456657] Starting dynamic subtest: vecs0
[433.509754] Dynamic subtest vecs0: SUCCESS (0.064s)
[433.521748] Starting dynamic subtest: ccs0
[433.570822] Dynamic subtest ccs0: SUCCESS (0.059s)
[433.573262] Subtest engines-cleanup: SUCCESS (0.445s)
[433.675361] [096/132] (587s left) i915_suspend (debugfs-reader)
[433.740253] Starting subtest: debugfs-reader
[451.124905] Subtest debugfs-reader: SUCCESS (3.091s)
[451.322897] [097/132] (569s left) kms_draw_crc (draw-method-mmap-wc)
[451.437261] Starting subtest: draw-method-mmap-wc
[451.439132] Starting dynamic subtest: xrgb8888-untiled
[451.663616] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[451.674238] Starting dynamic subtest: rgb565-untiled
[451.868624] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[451.878668] Starting dynamic subtest: xrgb2101010-untiled
[452.073682] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[452.083598] Starting dynamic subtest: xbgr16161616f-untiled
[452.301448] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[452.311173] Starting dynamic subtest: xrgb8888-xtiled
[452.437509] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[452.449720] Starting dynamic subtest: rgb565-xtiled
[452.585864] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s)
[452.595418] Starting dynamic subtest: xrgb2101010-xtiled
[452.710706] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[452.720711] Starting dynamic subtest: xbgr16161616f-xtiled
[452.835547] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[452.844959] Starting dynamic subtest: xrgb8888-4tiled
[452.995168] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[453.013479] Starting dynamic subtest: rgb565-4tiled
[453.164703] Dynamic subtest rgb565-4tiled: SUCCESS (0.164s)
[453.174804] Starting dynamic subtest: xrgb2101010-4tiled
[453.335053] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.166s)
[453.344316] Starting dynamic subtest: xbgr16161616f-4tiled
[453.516570] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[453.518494] Subtest draw-method-mmap-wc: SUCCESS (2.034s)
[453.652161] [098/132] (567s left) gem_userptr_blits (sync-unmap)
[453.739624] Starting subtest: sync-unmap
[453.770058] Subtest sync-unmap: SUCCESS (0.032s)
[453.935818] [099/132] (567s left) kms_content_protection (dp-mst-suspend-resume)
[454.087093] Starting subtest: dp-mst-suspend-resume
[454.090735] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[454.247306] [100/132] (567s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[454.339157] Starting subtest: addfb25-y-tiled-small-legacy
[454.342589] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[454.467934] [101/132] (566s left) syncobj_timeline (wait-for-submit-snapshot)
[454.528047] Starting subtest: wait-for-submit-snapshot
[454.608559] Subtest wait-for-submit-snapshot: SUCCESS (0.080s)
[454.708695] [102/132] (566s left) gem_eio (in-flight-internal-1us)
[454.940519] Starting subtest: in-flight-internal-1us
[456.709592] Subtest in-flight-internal-1us: SUCCESS (1.741s)
[456.917347] [103/132] (564s left) gem_create (create-size-update)
[456.978743] Starting subtest: create-size-update
[456.981129] Subtest create-size-update: SUCCESS (0.000s)
[457.222114] [104/132] (564s left) kms_draw_crc (fill-fb)
[457.319199] Starting subtest: fill-fb
[457.764452] Subtest fill-fb: SUCCESS (0.442s)
[457.910660] [105/132] (563s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[458.008436] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[458.010791] Starting dynamic subtest: pipe-A-eDP-1
[458.450700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[458.460468] Starting dynamic subtest: pipe-B-eDP-1
[459.856675] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[459.868150] Starting dynamic subtest: pipe-C-eDP-1
[461.261005] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[461.272602] Starting dynamic subtest: pipe-D-eDP-1
[462.628480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[462.630498] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.553s)
[463.820652] [106/132] (557s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[463.932223] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[463.936786] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[464.084252] [107/132] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[464.186424] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[464.190631] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[464.322655] [108/132] (557s left) gem_mmap_offset (bad-flags)
[464.387971] Starting subtest: bad-flags
[464.390160] Subtest bad-flags: SUCCESS (0.000s)
[464.546232] [109/132] (557s left) gem_mmap_gtt (big-copy)
[464.608085] Subtest big-copy: SKIP (0.000s)
[464.672821] [110/132] (557s left) kms_plane_multiple (tiling-y)
[464.762989] Starting subtest: tiling-y
[464.766497] Subtest tiling-y: SKIP (0.000s)
[464.864014] [111/132] (556s left) kms_plane_scaling (planes-upscale-factor-0-25)
[464.966314] Starting subtest: planes-upscale-factor-0-25
[464.968229] Starting dynamic subtest: pipe-A
[465.027295] Dynamic subtest pipe-A: SUCCESS (0.062s)
[465.038584] Starting dynamic subtest: pipe-B
[466.133629] Dynamic subtest pipe-B: SUCCESS (1.100s)
[466.146432] Starting dynamic subtest: pipe-C
[467.244677] Dynamic subtest pipe-C: SUCCESS (1.105s)
[467.255192] Starting dynamic subtest: pipe-D
[468.376182] Dynamic subtest pipe-D: SUCCESS (1.127s)
[468.378604] Subtest planes-upscale-factor-0-25: SUCCESS (3.399s)
[469.562917] [112/132] (552s left) gem_ctx_param (set-priority-range)
[469.618666] Starting subtest: set-priority-range
[469.635209] Subtest set-priority-range: SUCCESS (0.016s)
[469.779684] [113/132] (552s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[469.889536] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[469.893827] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[470.017871] [114/132] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[470.109302] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[476.758033] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.637s)
[476.921017] [115/132] (545s left) kms_scaling_modes (scaling-mode-center)
[477.032117] Starting subtest: scaling-mode-center
[477.034310] Starting dynamic subtest: pipe-A-eDP-1
[477.124328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[477.135243] Starting dynamic subtest: pipe-B-eDP-1
[478.317769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[478.328619] Starting dynamic subtest: pipe-C-eDP-1
[479.431437] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[479.441532] Starting dynamic subtest: pipe-D-eDP-1
[480.564325] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[480.566624] Subtest scaling-mode-center: SUCCESS (3.531s)
[481.748726] [116/132] (540s left) gen9_exec_parse (secure-batches)
[481.816729] Subtest secure-batches: SKIP (0.000s)
[481.907585] [117/132] (540s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[482.012059] Starting subtest: 4-tiled-64bpp-rotate-180
[483.648067] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.634s)
[483.876525] [118/132] (538s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[488.933547] Starting subtest: psr2-plane-move-sf-dmg-area
[488.936054] Starting dynamic subtest: pipe-A-eDP-1
[494.215698] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.278s)
[494.226649] Starting dynamic subtest: pipe-B-eDP-1
[499.541778] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.323s)
[499.544075] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.606s)
[500.448363] [119/132] (521s left) kms_vblank (query-forked-busy)
[500.565076] Starting subtest: query-forked-busy
[500.566929] Starting dynamic subtest: pipe-A-eDP-1
[502.453058] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[502.469243] Starting dynamic subtest: pipe-D-eDP-1
[505.004673] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[505.007022] Subtest query-forked-busy: SUCCESS (4.441s)
[505.878756] [120/132] (516s left) gem_ccs (block-copy-uncompressed)
[505.947889] Starting subtest: block-copy-uncompressed
[505.949824] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[505.968234] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[505.978559] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[505.985678] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[505.994898] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[506.002681] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[506.014201] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[506.019821] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[506.022066] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[506.167965] [121/132] (516s left) syncobj_eventfd (binary-wait-signaled)
[506.230145] Starting subtest: binary-wait-signaled
[506.232709] Subtest binary-wait-signaled: SUCCESS (0.000s)
[506.381171] [122/132] (515s left) kms_draw_crc (draw-method-mmap-gtt)
[506.482913] Starting subtest: draw-method-mmap-gtt
[506.487383] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[506.615040] [123/132] (515s left) gem_exec_schedule (preempt-other)
[506.694938] Starting subtest: preempt-other
[506.697027] Starting dynamic subtest: rcs0
[506.757439] Dynamic subtest rcs0: SUCCESS (0.069s)
[506.770664] Starting dynamic subtest: bcs0
[506.823570] Dynamic subtest bcs0: SUCCESS (0.065s)
[506.833982] Starting dynamic subtest: vcs0
[506.892462] Dynamic subtest vcs0: SUCCESS (0.068s)
[506.906504] Starting dynamic subtest: vcs1
[506.960948] Dynamic subtest vcs1: SUCCESS (0.067s)
[506.974438] Starting dynamic subtest: vecs0
[507.028070] Dynamic subtest vecs0: SUCCESS (0.066s)
[507.040669] Starting dynamic subtest: ccs0
[507.092813] Dynamic subtest ccs0: SUCCESS (0.064s)
[507.095384] Subtest preempt-other: SUCCESS (0.405s)
[508.812328] [124/132] (513s left) kms_plane_lowres (tiling-4)
[508.915559] Starting subtest: tiling-4
[508.918188] Starting dynamic subtest: pipe-A-eDP-1
[508.922894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.209634] Starting dynamic subtest: pipe-B-eDP-1
[509.214259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.223598] Starting dynamic subtest: pipe-C-eDP-1
[509.228184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.237180] Starting dynamic subtest: pipe-D-eDP-1
[509.240844] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.244858] Subtest tiling-4: SKIP (0.293s)
[510.066211] [125/132] (512s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[510.181627] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[516.392955] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.215s)
[517.556635] [126/132] (504s left) vgem_basic (setversion)
[517.608012] Starting subtest: setversion
[517.612408] Subtest setversion: SUCCESS (0.000s)
[517.691390] [127/132] (504s left) gem_exec_suspend (basic-s3-devices)
[517.754551] Starting subtest: basic-S3-devices
[517.756962] Starting dynamic subtest: smem
[529.669562] Dynamic subtest smem: SUCCESS (11.908s)
[529.672662] Subtest basic-S3-devices: SUCCESS (11.910s)
[529.880202] [128/132] (492s left) gem_eio (in-flight-suspend)
[530.133589] Starting subtest: in-flight-suspend
[572.479299] Subtest in-flight-suspend: SUCCESS (13.556s)
[572.651448] [129/132] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[572.788089] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[580.264152] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.342s)
[580.464340] [130/132] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[580.577398] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[585.033916] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.423s)
[586.227285] [131/132] (436s left) perf (non-zero-reason)
[586.337771] Starting subtest: non-zero-reason
[586.340267] Starting dynamic subtest: 0-rcs0
[591.749846] Dynamic subtest 0-rcs0: SUCCESS (5.389s)
[591.763259] Starting dynamic subtest: 1-vecs0
[595.673012] Dynamic subtest 1-vecs0: SUCCESS (3.913s)
[595.676000] Subtest non-zero-reason: SUCCESS (9.304s)
[595.725397] [132/132] (427s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[595.792565] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[595.892270] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[595.994048] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: kms_chamelium_edid
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_color_pipeline
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: prime_self_import
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_exec_parallel
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: prime_vgem
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_mmap_wc
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_prime
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_userptr_blits
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: dumb_buffer
results: parsing output: 59/ for test: i915_module_load
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: gem_huc_copy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_create
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: core_getclient
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_basic
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_spin_batch
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: perf_pmu
results: parsing output: 86/ for test: gem_wait
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: sysfs_preempt_timeout
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: gem_ctx_persistence
results: parsing output: 95/ for test: i915_suspend
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: kms_draw_crc
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_offset
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_scaling_modes
results: parsing output: 115/ for test: gen9_exec_parse
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_vblank
results: parsing output: 119/ for test: gem_ccs
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_plane_lowres
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: gem_exec_suspend
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: perf
results: parsing output: 131/ for test: syncobj_timeline
Done.