[61.625279] Initializing watchdogs
[61.625322]   /dev/watchdog0
[61.639805] [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]
[61.644440] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.646908] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.650404] [001/132] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[61.772545] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[61.776826] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[61.884620] [002/132] (960s left) kms_cursor_crc (cursor-onscreen-64x21)
[62.087379] Starting subtest: cursor-onscreen-64x21
[62.139277] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[62.413194] [003/132] (959s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[67.498918] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[67.501493] Starting dynamic subtest: pipe-A-eDP-1
[68.305747] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[68.313586] Starting dynamic subtest: pipe-B-eDP-1
[69.438902] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[69.443262] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.941s)
[70.743236] [004/132] (951s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[70.847995] Starting subtest: primary-y-tiled-reflect-x-90
[70.852369] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[70.938592] [005/132] (951s left) kms_vrr (negative-basic)
[71.034336] Starting subtest: negative-basic
[71.041268] Starting dynamic subtest: pipe-A-eDP-1
[76.458162] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[76.757311] Subtest negative-basic: SUCCESS (5.723s)
[77.565112] [006/132] (944s left) gem_exec_whisper (basic-fds-priority)
[77.636808] Starting subtest: basic-fds-priority
[102.904397] Subtest basic-fds-priority: SUCCESS (25.266s)
[103.112351] [007/132] (919s left) kms_chamelium_edid (dp-edid-resolution-list)
[103.511999] Subtest dp-edid-resolution-list: SKIP (0.000s)
[104.341807] [008/132] (918s left) kms_frontbuffer_tracking (fbc-suspend)
[104.448113] Starting subtest: fbc-suspend
[142.438059] Subtest fbc-suspend: SUCCESS (11.285s)
[143.647113] [009/132] (878s left) syncobj_timeline (multi-wait-submitted-signaled)
[143.721058] Starting subtest: multi-wait-submitted-signaled
[143.723460] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[143.864700] [010/132] (878s left) syncobj_wait (multi-wait-all-submitted)
[143.926194] Starting subtest: multi-wait-all-submitted
[144.032249] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[144.130961] [011/132] (878s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[144.245357] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[144.249389] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[144.388293] [012/132] (878s left) gem_partial_pwrite_pread (write-uncached)
[144.456778] Subtest write-uncached: SKIP (0.000s)
[144.544252] [013/132] (878s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[144.641184] Starting subtest: fbc-pr-sprite-mmap-gtt
[144.645606] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[144.732282] [014/132] (877s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[144.841589] Starting subtest: x-tiled-32bpp-rotate-270
[144.860877] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[145.020164] [015/132] (877s left) gem_exec_fence (basic-wait)
[145.204998] Starting subtest: basic-wait
[145.207583] Starting dynamic subtest: rcs0
[145.310516] Dynamic subtest rcs0: SUCCESS (0.105s)
[145.321501] Starting dynamic subtest: bcs0
[145.374782] Dynamic subtest bcs0: SUCCESS (0.063s)
[145.388694] Starting dynamic subtest: vcs0
[145.440933] Dynamic subtest vcs0: SUCCESS (0.066s)
[145.451777] Starting dynamic subtest: vcs1
[145.502845] Dynamic subtest vcs1: SUCCESS (0.060s)
[145.513473] Starting dynamic subtest: vecs0
[145.565637] Dynamic subtest vecs0: SUCCESS (0.063s)
[145.576010] Starting dynamic subtest: ccs0
[145.624163] Dynamic subtest ccs0: SUCCESS (0.057s)
[145.626492] Subtest basic-wait: SUCCESS (0.419s)
[147.745993] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[147.748915] [016/132] (874s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[147.844247] Starting subtest: plane-lut1d-post-ctm3x4
[147.857377] Starting dynamic subtest: pipe-A-eDP-1
[148.602091] Dynamic subtest pipe-A-eDP-1: FAIL (0.358s)
[149.295530] Starting dynamic subtest: pipe-B-eDP-1
[150.109237] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[150.629475] Starting dynamic subtest: pipe-C-eDP-1
[151.481812] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[151.960986] Starting dynamic subtest: pipe-D-eDP-1
[152.786649] Dynamic subtest pipe-D-eDP-1: FAIL (0.250s)
[152.788665] Subtest plane-lut1d-post-ctm3x4: FAIL (4.645s)
[153.359403] [017/132] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[153.455850] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[153.458167] Starting dynamic subtest: pipe-A-default-mode
[156.194894] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s)
[156.197337] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.740s)
[157.057781] [018/132] (865s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[157.147058] Starting subtest: 2x-absolute-wf_vblank-interruptible
[157.158320] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[157.287466] [019/132] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[157.395864] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[163.910267] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.515s)
[164.094056] [020/132] (858s left) gem_exec_params (invalid-bsd2-flag-on-render)
[164.166087] Starting subtest: invalid-bsd2-flag-on-render
[164.168292] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[164.299533] [021/132] (858s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[164.394631] Starting subtest: psr-rgb101010-draw-blt
[171.702630] Subtest psr-rgb101010-draw-blt: SUCCESS (7.309s)
[171.886980] [022/132] (851s left) syncobj_timeline (invalid-wait-bad-flags)
[171.945575] Starting subtest: invalid-wait-bad-flags
[171.947652] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[172.074430] [023/132] (850s left) gem_mmap_gtt (cpuset-big-copy-odd)
[172.127611] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[172.204575] [024/132] (850s left) gem_mmap_wc (bad-size)
[172.263898] Subtest bad-size: SKIP (0.000s)
[172.326150] [025/132] (850s left) gem_exec_balancer (invalid-bonds)
[172.384059] Starting subtest: invalid-bonds
[172.388227] Subtest invalid-bonds: SKIP (0.000s)
[172.703044] [026/132] (850s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[172.807103] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[172.811036] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[172.945859] [027/132] (850s left) kms_lease (lease-get)
[173.055211] Starting subtest: lease-get
[173.057400] Starting dynamic subtest: pipe-A-eDP-1
[173.059654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[173.073605] Starting dynamic subtest: pipe-B-eDP-1
[173.075571] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[173.088715] Starting dynamic subtest: pipe-C-eDP-1
[173.090684] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[173.100676] Starting dynamic subtest: pipe-D-eDP-1
[173.102596] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[173.104454] Subtest lease-get: SUCCESS (0.009s)
[173.198463] [028/132] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[173.312247] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[177.578412] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.272s)
[178.813783] [029/132] (844s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[179.205457] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[179.974776] [030/132] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[180.082758] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[183.708687] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.630s)
[184.904339] [031/132] (838s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[185.019081] Starting subtest: yf-tiled-64bpp-rotate-0
[185.023690] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[185.132256] [032/132] (838s left) gem_mmap_gtt (medium-copy-odd)
[185.189433] Subtest medium-copy-odd: SKIP (0.000s)
[185.255665] [033/132] (838s left) gem_pxp (protected-raw-src-copy-not-readible)
[185.380610] Starting subtest: protected-raw-src-copy-not-readible
[185.441593] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.063s)
[185.603634] [034/132] (837s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[185.726888] Starting subtest: flip-vs-cursor-crc-atomic
[186.397484] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.672s)
[187.221563] [035/132] (836s left) kms_atomic_transition (plane-all-transition-fencing)
[187.325877] Starting subtest: plane-all-transition-fencing
[187.328131] Starting dynamic subtest: pipe-A-eDP-1
[189.820128] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[190.136848] Starting dynamic subtest: pipe-B-eDP-1
[193.332803] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s)
[193.640690] Subtest plane-all-transition-fencing: SUCCESS (6.315s)
[194.485377] [036/132] (829s left) prime_self_import (basic-with_one_bo_two_files)
[194.529588] Starting subtest: basic-with_one_bo_two_files
[194.562824] Subtest basic-with_one_bo_two_files: SUCCESS (0.032s)
[194.693035] [037/132] (828s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[194.789875] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[194.792145] Starting dynamic subtest: pipe-A-eDP-1
[194.813834] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[194.823866] Starting dynamic subtest: pipe-B-eDP-1
[194.844178] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.852082] Starting dynamic subtest: pipe-C-eDP-1
[194.872360] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.880075] Starting dynamic subtest: pipe-D-eDP-1
[194.901402] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.905702] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[196.947225] [038/132] (826s left) i915_drm_fdinfo (all-busy-check-all)
[196.990180] Starting subtest: all-busy-check-all
[196.997809] Subtest all-busy-check-all: SKIP (0.004s)
[197.079559] [039/132] (826s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[197.209191] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[197.211369] Starting dynamic subtest: pipe-A-default-mode
[197.500181] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[197.504441] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.287s)
[198.374779] [040/132] (825s left) kms_addfb_basic (bad-pitch-0)
[198.444556] Starting subtest: bad-pitch-0
[198.446505] Subtest bad-pitch-0: SUCCESS (0.000s)
[198.603505] [041/132] (825s left) gem_ctx_persistence (heartbeat-stop)
[198.663289] Starting subtest: heartbeat-stop
[198.667826] Subtest heartbeat-stop: SKIP (0.000s)
[198.794746] [042/132] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[198.895654] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[198.899654] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[199.040117] [043/132] (824s left) gem_exec_schedule (smoketest)
[199.236630] Starting subtest: smoketest
[199.238790] Starting dynamic subtest: rcs0
[204.775299] Dynamic subtest rcs0: SUCCESS (5.487s)
[204.786480] Starting dynamic subtest: bcs0
[210.275168] Dynamic subtest bcs0: SUCCESS (5.500s)
[210.298371] Starting dynamic subtest: vcs0
[215.788835] Dynamic subtest vcs0: SUCCESS (5.508s)
[215.805755] Starting dynamic subtest: vcs1
[221.287485] Dynamic subtest vcs1: SUCCESS (5.492s)
[221.297922] Starting dynamic subtest: vecs0
[226.783714] Dynamic subtest vecs0: SUCCESS (5.496s)
[226.793553] Starting dynamic subtest: ccs0
[232.296718] Dynamic subtest ccs0: SUCCESS (5.512s)
[232.298777] Subtest smoketest: SUCCESS (33.006s)
[232.507628] [044/132] (791s left) gem_exec_parallel (contexts)
[232.569210] Starting subtest: contexts
[232.571914] Starting dynamic subtest: rcs0
[236.364190] Dynamic subtest rcs0: SUCCESS (3.793s)
[236.372939] Starting dynamic subtest: bcs0
[239.967008] Dynamic subtest bcs0: SUCCESS (3.601s)
[239.978627] Starting dynamic subtest: vcs0
[244.086807] Dynamic subtest vcs0: SUCCESS (4.120s)
[244.096108] Starting dynamic subtest: vcs1
[248.102113] Dynamic subtest vcs1: SUCCESS (4.014s)
[248.113115] Starting dynamic subtest: vecs0
[252.213964] Dynamic subtest vecs0: SUCCESS (4.110s)
[252.227651] Starting dynamic subtest: ccs0
[255.723666] Dynamic subtest ccs0: SUCCESS (3.507s)
[255.726213] Subtest contexts: SUCCESS (23.158s)
[255.940119] [045/132] (768s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[255.999765] Starting subtest: invalid-bsd2-flag-on-blt
[256.002144] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[256.120406] [046/132] (767s left) kms_psr (fbc-psr2-primary-render)
[256.219257] Starting subtest: fbc-psr2-primary-render
[256.221490] Starting dynamic subtest: eDP-1
[256.225589] Dynamic subtest eDP-1: SKIP (0.000s)
[256.229698] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[256.322093] [047/132] (767s left) prime_vgem (coherency-gtt)
[256.435584] Starting subtest: coherency-gtt
[256.440075] Subtest coherency-gtt: SKIP (0.000s)
[256.585849] [048/132] (767s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[256.709404] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[256.713782] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[256.876866] [049/132] (767s left) kms_flip (flip-vs-expired-vblank)
[256.974780] Starting subtest: flip-vs-expired-vblank
[256.976667] Starting dynamic subtest: A-eDP1
[265.656411] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[265.666124] Starting dynamic subtest: B-eDP1
[274.380659] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[274.390903] Starting dynamic subtest: C-eDP1
[283.000856] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[283.012284] Starting dynamic subtest: D-eDP1
[291.634217] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[291.639043] Subtest flip-vs-expired-vblank: SUCCESS (34.662s)
[292.827143] [050/132] (731s left) gem_mmap_wc (write-read)
[292.886333] Subtest write-read: SKIP (0.000s)
[292.943996] [051/132] (731s left) kms_psr (psr-sprite-render)
[293.043306] Starting subtest: psr-sprite-render
[293.045601] Starting dynamic subtest: eDP-1
[294.829250] Dynamic subtest eDP-1: SUCCESS (1.787s)
[294.831540] Subtest psr-sprite-render: SUCCESS (1.788s)
[295.702266] [052/132] (728s left) kms_psr (psr2-cursor-blt)
[295.802180] Starting subtest: psr2-cursor-blt
[295.804299] Starting dynamic subtest: eDP-1
[297.537162] Dynamic subtest eDP-1: SUCCESS (1.735s)
[297.539359] Subtest psr2-cursor-blt: SUCCESS (1.736s)
[298.358764] [053/132] (725s left) kms_prime (basic-modeset-hybrid)
[298.445598] Subtest basic-modeset-hybrid: SKIP (0.000s)
[298.559473] [054/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[298.663430] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[298.667315] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[298.799633] [055/132] (725s left) kms_psr (fbc-psr-sprite-plane-onoff)
[298.899772] Starting subtest: fbc-psr-sprite-plane-onoff
[298.901915] Starting dynamic subtest: eDP-1
[298.906309] Dynamic subtest eDP-1: SKIP (0.000s)
[298.910075] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.002s)
[298.999491] [056/132] (725s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[299.078431] Starting subtest: stress-mm-invalidate-close-overlap
[301.225548] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[301.397864] [057/132] (723s left) gem_exec_params (batch-first)
[301.476109] Starting subtest: batch-first
[301.483349] Subtest batch-first: SUCCESS (0.010s)
[301.646831] [058/132] (722s left) i915_pm_rpm (gem-mmap-type)
[303.775404] Starting subtest: gem-mmap-type
[303.778323] Starting dynamic subtest: wb-smem0
[307.524702] Dynamic subtest wb-smem0: SUCCESS (3.747s)
[307.533911] Starting dynamic subtest: wc-smem0
[311.003134] Dynamic subtest wc-smem0: SUCCESS (3.477s)
[311.012365] Starting dynamic subtest: uc-smem0
[313.897472] Dynamic subtest uc-smem0: SUCCESS (2.893s)
[313.899756] Subtest gem-mmap-type: SUCCESS (10.121s)
[314.046264] [059/132] (710s left) dumb_buffer (create-clear)
[314.102264] Starting subtest: create-clear
[348.483928] Subtest create-clear: SUCCESS (34.374s)
[348.614657] [060/132] (675s left) i915_module_load (resize-bar)
[348.653794] Starting subtest: resize-bar
[348.662894] Subtest resize-bar: SKIP (0.006s)
[348.705119] [061/132] (675s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[348.772992] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[348.777579] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[348.982442] [062/132] (675s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[349.119453] Starting subtest: basic-busy-flip-before-cursor-varying-size
[349.123847] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[349.286883] [063/132] (675s left) gem_eio (kms)
[349.564193] Starting subtest: kms
[370.237695] Subtest kms: SUCCESS (20.671s)
[370.405544] [064/132] (654s left) gem_exec_fence (keep-in-fence)
[370.593390] Starting subtest: keep-in-fence
[370.595327] Starting dynamic subtest: rcs0
[370.657445] Dynamic subtest rcs0: SUCCESS (0.066s)
[370.669350] Starting dynamic subtest: bcs0
[370.713558] Dynamic subtest bcs0: SUCCESS (0.054s)
[370.724842] Starting dynamic subtest: vcs0
[372.644078] Dynamic subtest vcs0: SUCCESS (1.927s)
[372.656373] Starting dynamic subtest: vcs1
[374.628009] Dynamic subtest vcs1: SUCCESS (1.982s)
[374.640819] Starting dynamic subtest: vecs0
[376.612061] Dynamic subtest vecs0: SUCCESS (1.982s)
[376.624199] Starting dynamic subtest: ccs0
[376.847290] Dynamic subtest ccs0: SUCCESS (0.235s)
[376.849752] Subtest keep-in-fence: SUCCESS (6.259s)
[378.732446] [065/132] (646s left) kms_big_fb (linear-8bpp-rotate-270)
[378.844159] Starting subtest: linear-8bpp-rotate-270
[378.865910] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[379.028917] [066/132] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[379.130792] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[386.173950] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.046s)
[386.307857] [067/132] (638s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[386.399334] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[386.403918] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[387.559953] [068/132] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[387.661520] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[387.665628] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.791874] [069/132] (637s left) i915_query (query-garbage)
[387.858463] Starting subtest: query-garbage
[387.860443] Subtest query-garbage: SUCCESS (0.000s)
[387.999080] [070/132] (636s left) gem_huc_copy (huc-copy)
[388.064048] Starting subtest: huc-copy
[388.069571] Subtest huc-copy: SUCCESS (0.005s)
[388.228285] [071/132] (636s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[388.316678] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[392.078694] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.766s)
[393.264215] [072/132] (631s left) gem_create (create-invalid-size)
[393.321655] Starting subtest: create-invalid-size
[393.323858] Subtest create-invalid-size: SUCCESS (0.000s)
[393.535390] [073/132] (631s left) kms_pm_rpm (drm-resources-equal)
[395.764719] Starting subtest: drm-resources-equal
[400.778403] Subtest drm-resources-equal: SUCCESS (5.014s)
[400.898247] [074/132] (624s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[400.998171] Starting subtest: random-ccs-data-yf-tiled-ccs
[401.000356] Starting dynamic subtest: pipe-A-eDP-1
[401.025765] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[401.036630] Starting dynamic subtest: pipe-B-eDP-1
[401.060422] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[401.068846] Starting dynamic subtest: pipe-C-eDP-1
[401.092562] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[401.101084] Starting dynamic subtest: pipe-D-eDP-1
[401.125612] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[401.130059] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[403.203242] [075/132] (621s left) kms_lease (empty-lease)
[403.305746] Starting subtest: empty-lease
[403.308314] Starting dynamic subtest: pipe-A-eDP-1
[403.310571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[403.319892] Starting dynamic subtest: pipe-B-eDP-1
[403.322068] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[403.331400] Starting dynamic subtest: pipe-C-eDP-1
[403.333626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[403.342392] Starting dynamic subtest: pipe-D-eDP-1
[403.344606] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[403.346817] Subtest empty-lease: SUCCESS (0.009s)
[403.482140] [076/132] (621s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[403.569565] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[403.573627] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[403.690866] [077/132] (621s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[403.749750] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[403.751827] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[403.877247] [078/132] (621s left) api_intel_allocator (gem-pool)
[403.933560] Starting subtest: gem-pool
[403.938507] Subtest gem-pool: SUCCESS (0.007s)
[404.097607] [079/132] (621s left) core_getclient (basic)
[404.159566] Starting subtest: basic
[404.161186] Subtest basic: SUCCESS (0.000s)
[404.306084] [080/132] (621s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[404.403217] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[404.405093] Starting dynamic subtest: pipe-A
[404.743778] Dynamic subtest pipe-A: SUCCESS (0.342s)
[404.752937] Starting dynamic subtest: pipe-B
[406.187981] Dynamic subtest pipe-B: SUCCESS (1.443s)
[406.197247] Starting dynamic subtest: pipe-C
[407.600084] Dynamic subtest pipe-C: SUCCESS (1.411s)
[407.610311] Starting dynamic subtest: pipe-D
[409.024678] Dynamic subtest pipe-D: SUCCESS (1.424s)
[409.027001] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.623s)
[410.199643] [081/132] (615s left) syncobj_timeline (etime-single-wait-submitted)
[410.259866] Starting subtest: etime-single-wait-submitted
[410.368055] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[410.469110] [082/132] (615s left) gem_basic (create-close)
[410.536011] Starting subtest: create-close
[410.540682] Subtest create-close: SUCCESS (0.000s)
[410.673777] [083/132] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[410.772952] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[417.495358] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.725s)
[417.679464] [084/132] (607s left) gem_spin_batch (legacy-resubmit)
[417.737575] Starting subtest: legacy-resubmit
[417.739578] Starting dynamic subtest: default
[417.742006] Dynamic subtest default: SUCCESS (0.005s)
[417.752834] Starting dynamic subtest: render
[417.755154] Dynamic subtest render: SUCCESS (0.001s)
[417.764113] Starting dynamic subtest: bsd
[417.765965] Dynamic subtest bsd: SUCCESS (0.003s)
[417.774479] Starting dynamic subtest: bsd1
[417.776394] Dynamic subtest bsd1: SUCCESS (0.001s)
[417.784807] Starting dynamic subtest: bsd2
[417.786696] Dynamic subtest bsd2: SUCCESS (0.002s)
[417.795415] Starting dynamic subtest: blt
[417.797324] Dynamic subtest blt: SUCCESS (0.003s)
[417.806094] Starting dynamic subtest: vebox
[417.807947] Dynamic subtest vebox: SUCCESS (0.003s)
[417.809864] Subtest legacy-resubmit: SUCCESS (0.024s)
[418.019837] [085/132] (607s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[418.123330] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[418.125609] Starting dynamic subtest: pipe-A-eDP-1
[418.145979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[418.157593] Starting dynamic subtest: pipe-B-eDP-1
[418.177220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[418.186047] Starting dynamic subtest: pipe-C-eDP-1
[418.205600] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[418.214061] Starting dynamic subtest: pipe-D-eDP-1
[418.232217] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[418.234330] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[420.311806] [086/132] (605s left) perf_pmu (semaphore-wait-idle)
[420.357505] Starting subtest: semaphore-wait-idle
[420.359463] Starting dynamic subtest: rcs0
[420.872910] Dynamic subtest rcs0: SUCCESS (0.514s)
[420.885521] Starting dynamic subtest: bcs0
[421.387312] Dynamic subtest bcs0: SUCCESS (0.511s)
[421.399250] Starting dynamic subtest: vcs0
[421.901865] Dynamic subtest vcs0: SUCCESS (0.511s)
[421.914632] Starting dynamic subtest: vcs1
[422.415524] Dynamic subtest vcs1: SUCCESS (0.510s)
[422.428208] Starting dynamic subtest: vecs0
[422.928550] Dynamic subtest vecs0: SUCCESS (0.510s)
[422.940932] Starting dynamic subtest: ccs0
[423.444580] Dynamic subtest ccs0: SUCCESS (0.513s)
[423.447812] Subtest semaphore-wait-idle: SUCCESS (3.088s)
[424.646157] [087/132] (601s left) gem_wait (write-wait)
[424.712257] Starting subtest: write-wait
[424.714560] Starting dynamic subtest: all-engines
[425.872279] Dynamic subtest all-engines: SUCCESS (1.158s)
[425.889664] Starting dynamic subtest: rcs0
[426.929451] Dynamic subtest rcs0: SUCCESS (1.055s)
[426.946527] Starting dynamic subtest: bcs0
[427.986099] Dynamic subtest bcs0: SUCCESS (1.055s)
[428.003423] Starting dynamic subtest: vcs0
[429.040254] Dynamic subtest vcs0: SUCCESS (1.052s)
[429.057383] Starting dynamic subtest: vcs1
[430.091264] Dynamic subtest vcs1: SUCCESS (1.049s)
[430.108898] Starting dynamic subtest: vecs0
[431.144253] Dynamic subtest vecs0: SUCCESS (1.051s)
[431.161479] Starting dynamic subtest: ccs0
[432.201067] Dynamic subtest ccs0: SUCCESS (1.055s)
[432.203509] Subtest write-wait: SUCCESS (7.489s)
[432.425543] [088/132] (593s left) kms_atomic (plane-primary-legacy)
[432.529922] Starting subtest: plane-primary-legacy
[432.532249] Starting dynamic subtest: pipe-A-eDP-1
[432.978269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[432.980565] Subtest plane-primary-legacy: SUCCESS (0.450s)
[433.840055] [089/132] (591s left) sysfs_preempt_timeout (invalid)
[433.909771] Starting subtest: invalid
[433.912184] Starting dynamic subtest: vecs0
[433.914451] Dynamic subtest vecs0: SUCCESS (0.000s)
[433.925052] Starting dynamic subtest: ccs0
[433.927175] Dynamic subtest ccs0: SUCCESS (0.000s)
[433.936470] Starting dynamic subtest: vcs0
[433.938748] Dynamic subtest vcs0: SUCCESS (0.000s)
[433.950240] Starting dynamic subtest: bcs0
[433.952342] Dynamic subtest bcs0: SUCCESS (0.000s)
[433.962078] Starting dynamic subtest: rcs0
[433.963907] Dynamic subtest rcs0: SUCCESS (0.000s)
[433.973093] Starting dynamic subtest: vcs1
[433.975164] Dynamic subtest vcs1: SUCCESS (0.000s)
[433.977239] Subtest invalid: SUCCESS (0.006s)
[434.046778] [090/132] (591s left) gem_exec_fence (syncobj-timeline-signal)
[434.566106] Starting subtest: syncobj-timeline-signal
[434.573150] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[435.769522] [091/132] (590s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[435.970673] Starting subtest: cursor-rapid-movement-64x21
[436.016269] Subtest cursor-rapid-movement-64x21: SKIP (0.041s)
[436.292191] [092/132] (589s left) perf (oa-formats)
[436.425726] Starting subtest: oa-formats
[436.427874] Starting dynamic subtest: 0-rcs0
[436.440421] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[436.450211] Starting dynamic subtest: 1-vcs1
[436.463337] Dynamic subtest 1-vcs1: SUCCESS (0.022s)
[436.465608] Subtest oa-formats: SUCCESS (0.039s)
[436.518302] [093/132] (589s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[436.613319] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[436.615533] Starting dynamic subtest: pipe-A-eDP-1
[436.677089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[436.687212] Starting dynamic subtest: pipe-B-eDP-1
[436.741783] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.064s)
[436.752068] Starting dynamic subtest: pipe-C-eDP-1
[436.805127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[436.814750] Starting dynamic subtest: pipe-D-eDP-1
[436.869287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s)
[436.871178] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.259s)
[439.105254] [094/132] (586s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[439.170731] Starting subtest: invalid-bsd1-flag-on-blt
[439.173112] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[439.321145] [095/132] (586s left) gem_ctx_persistence (engines-cleanup)
[439.385436] Starting subtest: engines-cleanup
[439.387803] Starting dynamic subtest: rcs0
[439.454232] Dynamic subtest rcs0: SUCCESS (0.069s)
[439.465999] Starting dynamic subtest: bcs0
[439.536911] Dynamic subtest bcs0: SUCCESS (0.081s)
[439.548316] Starting dynamic subtest: vcs0
[439.596974] Dynamic subtest vcs0: SUCCESS (0.057s)
[439.608672] Starting dynamic subtest: vcs1
[439.658045] Dynamic subtest vcs1: SUCCESS (0.059s)
[439.669636] Starting dynamic subtest: vecs0
[439.722873] Dynamic subtest vecs0: SUCCESS (0.063s)
[439.734776] Starting dynamic subtest: ccs0
[439.782360] Dynamic subtest ccs0: SUCCESS (0.057s)
[439.784955] Subtest engines-cleanup: SUCCESS (0.398s)
[439.885112] [096/132] (586s left) i915_suspend (debugfs-reader)
[439.960086] Starting subtest: debugfs-reader
[458.133413] Subtest debugfs-reader: SUCCESS (3.332s)
[458.315733] [097/132] (567s left) kms_draw_crc (draw-method-mmap-wc)
[458.420197] Starting subtest: draw-method-mmap-wc
[458.422430] Starting dynamic subtest: xrgb8888-untiled
[458.652176] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[458.662156] Starting dynamic subtest: rgb565-untiled
[458.852934] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[458.862684] Starting dynamic subtest: xrgb2101010-untiled
[459.111273] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.253s)
[459.120654] Starting dynamic subtest: xbgr16161616f-untiled
[459.455144] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.343s)
[459.467426] Starting dynamic subtest: xrgb8888-xtiled
[459.610918] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.152s)
[459.622315] Starting dynamic subtest: rgb565-xtiled
[459.765948] Dynamic subtest rgb565-xtiled: SUCCESS (0.153s)
[459.775909] Starting dynamic subtest: xrgb2101010-xtiled
[459.899677] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[459.909164] Starting dynamic subtest: xbgr16161616f-xtiled
[460.022453] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[460.034373] Starting dynamic subtest: xrgb8888-4tiled
[460.178212] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.152s)
[460.187471] Starting dynamic subtest: rgb565-4tiled
[460.333941] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[460.343746] Starting dynamic subtest: xrgb2101010-4tiled
[460.478797] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[460.488179] Starting dynamic subtest: xbgr16161616f-4tiled
[460.656894] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[460.658658] Subtest draw-method-mmap-wc: SUCCESS (2.234s)
[460.797539] [098/132] (565s left) gem_userptr_blits (sync-unmap)
[460.868578] Starting subtest: sync-unmap
[460.884175] Subtest sync-unmap: SUCCESS (0.014s)
[461.037697] [099/132] (565s left) kms_content_protection (dp-mst-suspend-resume)
[461.176696] Starting subtest: dp-mst-suspend-resume
[461.180643] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[461.356459] [100/132] (565s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[461.464060] Starting subtest: addfb25-y-tiled-small-legacy
[461.467719] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[461.606199] [101/132] (564s left) syncobj_timeline (wait-for-submit-snapshot)
[461.667505] Starting subtest: wait-for-submit-snapshot
[461.748089] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[461.848612] [102/132] (564s left) gem_eio (in-flight-internal-1us)
[462.072696] Starting subtest: in-flight-internal-1us
[463.510003] Subtest in-flight-internal-1us: SUCCESS (1.435s)
[463.695182] [103/132] (562s left) gem_create (create-size-update)
[463.757419] Starting subtest: create-size-update
[463.759723] Subtest create-size-update: SUCCESS (0.000s)
[464.007049] [104/132] (562s left) kms_draw_crc (fill-fb)
[464.108083] Starting subtest: fill-fb
[464.549254] Subtest fill-fb: SUCCESS (0.442s)
[464.689728] [105/132] (561s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[464.795190] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[464.797178] Starting dynamic subtest: pipe-A-eDP-1
[465.222906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.404s)
[465.233499] Starting dynamic subtest: pipe-B-eDP-1
[466.647381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[466.658767] Starting dynamic subtest: pipe-C-eDP-1
[468.054937] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[468.064880] Starting dynamic subtest: pipe-D-eDP-1
[469.358374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.299s)
[469.360275] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.531s)
[470.562209] [106/132] (556s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[470.669997] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[470.674051] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[470.785902] [107/132] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[470.887824] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[470.892290] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[471.011754] [108/132] (555s left) gem_mmap_offset (bad-flags)
[471.075981] Starting subtest: bad-flags
[471.078329] Subtest bad-flags: SUCCESS (0.000s)
[471.197087] [109/132] (555s left) gem_mmap_gtt (big-copy)
[471.262485] Subtest big-copy: SKIP (0.000s)
[471.327039] [110/132] (555s left) kms_plane_multiple (tiling-y)
[471.425714] Starting subtest: tiling-y
[471.430090] Subtest tiling-y: SKIP (0.000s)
[471.522605] [111/132] (555s left) kms_plane_scaling (planes-upscale-factor-0-25)
[471.609249] Starting subtest: planes-upscale-factor-0-25
[471.611215] Starting dynamic subtest: pipe-A
[471.669692] Dynamic subtest pipe-A: SUCCESS (0.062s)
[471.681134] Starting dynamic subtest: pipe-B
[472.767686] Dynamic subtest pipe-B: SUCCESS (1.096s)
[472.780887] Starting dynamic subtest: pipe-C
[473.898004] Dynamic subtest pipe-C: SUCCESS (1.126s)
[473.908141] Starting dynamic subtest: pipe-D
[475.041535] Dynamic subtest pipe-D: SUCCESS (1.141s)
[475.043735] Subtest planes-upscale-factor-0-25: SUCCESS (3.433s)
[476.312365] [112/132] (550s left) gem_ctx_param (set-priority-range)
[476.375844] Starting subtest: set-priority-range
[476.390789] Subtest set-priority-range: SUCCESS (0.014s)
[476.535153] [113/132] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[476.634375] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[476.638904] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[476.769885] [114/132] (550s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[476.870240] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[483.512726] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.640s)
[483.676974] [115/132] (543s left) kms_scaling_modes (scaling-mode-center)
[483.789264] Starting subtest: scaling-mode-center
[483.791545] Starting dynamic subtest: pipe-A-eDP-1
[483.882852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[483.895145] Starting dynamic subtest: pipe-B-eDP-1
[485.033534] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[485.044518] Starting dynamic subtest: pipe-C-eDP-1
[486.138122] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[486.147954] Starting dynamic subtest: pipe-D-eDP-1
[487.270467] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[487.272648] Subtest scaling-mode-center: SUCCESS (3.484s)
[488.465256] [116/132] (538s left) gen9_exec_parse (secure-batches)
[488.538262] Subtest secure-batches: SKIP (0.000s)
[488.630177] [117/132] (538s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[488.732113] Starting subtest: 4-tiled-64bpp-rotate-180
[490.376588] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.645s)
[490.570373] [118/132] (536s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[495.611523] Starting subtest: psr2-plane-move-sf-dmg-area
[495.613839] Starting dynamic subtest: pipe-A-eDP-1
[500.905766] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.295s)
[500.916123] Starting dynamic subtest: pipe-B-eDP-1
[506.224161] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.317s)
[506.226474] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.616s)
[507.121306] [119/132] (520s left) kms_vblank (query-forked-busy)
[507.215876] Starting subtest: query-forked-busy
[507.217718] Starting dynamic subtest: pipe-A-eDP-1
[509.092049] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[509.107417] Starting dynamic subtest: pipe-D-eDP-1
[511.651168] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[511.653539] Subtest query-forked-busy: SUCCESS (4.436s)
[512.473173] [120/132] (514s left) gem_ccs (block-copy-uncompressed)
[512.537984] Starting subtest: block-copy-uncompressed
[512.540237] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[512.561693] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.023s)
[512.571406] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[512.579284] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[512.590243] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[512.599235] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[512.609041] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[512.617803] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[512.620061] Subtest block-copy-uncompressed: SUCCESS (0.080s)
[512.794331] [121/132] (514s left) syncobj_eventfd (binary-wait-signaled)
[512.860506] Starting subtest: binary-wait-signaled
[512.862721] Subtest binary-wait-signaled: SUCCESS (0.000s)
[512.995592] [122/132] (514s left) kms_draw_crc (draw-method-mmap-gtt)
[513.085049] Starting subtest: draw-method-mmap-gtt
[513.089054] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[513.211621] [123/132] (514s left) gem_exec_schedule (preempt-other)
[513.290254] Starting subtest: preempt-other
[513.292188] Starting dynamic subtest: rcs0
[513.358815] Dynamic subtest rcs0: SUCCESS (0.070s)
[513.373611] Starting dynamic subtest: bcs0
[513.423839] Dynamic subtest bcs0: SUCCESS (0.065s)
[513.434479] Starting dynamic subtest: vcs0
[513.492160] Dynamic subtest vcs0: SUCCESS (0.067s)
[513.502937] Starting dynamic subtest: vcs1
[513.559019] Dynamic subtest vcs1: SUCCESS (0.066s)
[513.570559] Starting dynamic subtest: vecs0
[513.626716] Dynamic subtest vecs0: SUCCESS (0.067s)
[513.638309] Starting dynamic subtest: ccs0
[513.693671] Dynamic subtest ccs0: SUCCESS (0.067s)
[513.695734] Subtest preempt-other: SUCCESS (0.407s)
[514.585009] [124/132] (512s left) kms_plane_lowres (tiling-4)
[514.678113] Starting subtest: tiling-4
[514.680397] Starting dynamic subtest: pipe-A-eDP-1
[514.685078] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[514.974162] Starting dynamic subtest: pipe-B-eDP-1
[514.978975] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[514.994350] Starting dynamic subtest: pipe-C-eDP-1
[514.998987] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[515.013808] Starting dynamic subtest: pipe-D-eDP-1
[515.018521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[515.023196] Subtest tiling-4: SKIP (0.291s)
[515.796673] [125/132] (511s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[515.904471] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[522.293838] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.392s)
[523.519617] [126/132] (503s left) vgem_basic (setversion)
[523.567964] Starting subtest: setversion
[523.572079] Subtest setversion: SUCCESS (0.000s)
[523.652244] [127/132] (503s left) gem_exec_suspend (basic-s3-devices)
[523.727158] Starting subtest: basic-S3-devices
[523.729075] Starting dynamic subtest: smem
[535.453873] Dynamic subtest smem: SUCCESS (11.726s)
[535.456258] Subtest basic-S3-devices: SUCCESS (11.728s)
[535.666126] [128/132] (491s left) gem_eio (in-flight-suspend)
[535.917581] Starting subtest: in-flight-suspend
[579.534365] Subtest in-flight-suspend: SUCCESS (13.850s)
[579.710602] [129/132] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[579.814319] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[587.282998] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.469s)
[587.454989] [130/132] (440s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[587.566389] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[592.003000] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.438s)
[593.214779] [131/132] (434s left) perf (non-zero-reason)
[593.317441] Starting subtest: non-zero-reason
[593.319625] Starting dynamic subtest: 0-rcs0
[598.701027] Dynamic subtest 0-rcs0: SUCCESS (5.381s)
[598.713495] Starting dynamic subtest: 1-vcs1
[602.609832] Dynamic subtest 1-vcs1: SUCCESS (3.906s)
[602.612742] Subtest non-zero-reason: SUCCESS (9.289s)
[602.662561] [132/132] (425s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[602.725400] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[602.827350] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[602.942911] 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.