[57.305123] Initializing watchdogs
[57.305272]   /dev/watchdog0
[57.319849] [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]
[57.324050] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.326238] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.329838] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[57.420084] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[57.422710] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[57.554316] [002/133] (960s left) gem_exec_reloc (basic-cpu-wc-active)
[57.626863] Subtest basic-cpu-wc-active: SKIP (0.000s)
[57.720067] [003/133] (960s left) gem_flink_basic (basic)
[57.786030] Starting subtest: basic
[57.788069] Subtest basic: SUCCESS (0.000s)
[57.921890] [004/133] (960s left) kms_psr (fbc-pr-primary-render)
[58.021938] Starting subtest: fbc-pr-primary-render
[58.026252] Subtest fbc-pr-primary-render: SKIP (0.000s)
[58.102252] [005/133] (959s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[58.184805] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[58.186896] Starting dynamic subtest: pipe-A
[58.271557] Dynamic subtest pipe-A: SUCCESS (0.086s)
[58.280218] Starting dynamic subtest: pipe-B
[59.473742] Dynamic subtest pipe-B: SUCCESS (1.194s)
[59.483406] Starting dynamic subtest: pipe-C
[60.593777] Dynamic subtest pipe-C: SUCCESS (1.113s)
[60.602529] Starting dynamic subtest: pipe-D
[61.724280] Dynamic subtest pipe-D: SUCCESS (1.125s)
[61.726561] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.520s)
[62.898877] [006/133] (955s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[63.006180] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[67.309525] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.297s)
[68.548857] [007/133] (949s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[68.655465] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[68.657894] Starting dynamic subtest: pipe-A-eDP-1
[68.681895] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.690677] Starting dynamic subtest: pipe-B-eDP-1
[68.711614] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.718056] Starting dynamic subtest: pipe-C-eDP-1
[68.740419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.748967] Starting dynamic subtest: pipe-D-eDP-1
[68.773436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.777711] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[70.819216] [008/133] (947s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[70.933471] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[70.937629] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[71.055364] [009/133] (947s left) kms_vblank (wait-forked-busy-hang)
[71.161400] Starting subtest: wait-forked-busy-hang
[71.163752] Starting dynamic subtest: pipe-A-eDP-1
[97.685244] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.504s)
[97.696709] Starting dynamic subtest: pipe-D-eDP-1
[112.667412] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[112.669793] Subtest wait-forked-busy-hang: SUCCESS (41.485s)
[113.499968] [010/133] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[113.601499] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[113.605619] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[113.737217] [011/133] (904s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[113.797818] Starting subtest: multi-wait-all-available-submitted-signaled
[113.800026] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[113.925622] [012/133] (904s left) gem_exec_whisper (basic-normal-all)
[114.004671] Starting subtest: basic-normal-all
[116.334887] Subtest basic-normal-all: SUCCESS (2.330s)
[116.527174] [013/133] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[116.631375] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[120.346848] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.719s)
[121.502376] [014/133] (896s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[121.600093] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[121.602411] Starting dynamic subtest: pipe-A-eDP-1
[121.661179] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[121.670635] Starting dynamic subtest: pipe-B-eDP-1
[121.728212] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[121.737086] Starting dynamic subtest: pipe-C-eDP-1
[121.793420] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[121.801699] Starting dynamic subtest: pipe-D-eDP-1
[121.858727] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[121.863244] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[123.849397] [015/133] (894s left) gem_partial_pwrite_pread (reads-display)
[123.920417] Subtest reads-display: SKIP (0.000s)
[123.997096] [016/133] (894s left) gem_ctx_bad_destroy (double-destroy)
[124.052597] Starting subtest: double-destroy
[124.054833] Subtest double-destroy: SUCCESS (0.000s)
[124.134154] [017/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[124.226378] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[131.001993] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.778s)
[131.176952] [018/133] (887s left) kms_getfb (getfb-reject-nv12)
[131.282132] Starting subtest: getfb-reject-nv12
[131.284444] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[131.406786] [019/133] (887s left) gem_media_fill (media-fill)
[131.479452] Subtest media-fill: SKIP (0.000s)
[131.600421] [020/133] (886s left) prime_mmap (test_aperture_limit)
[131.646070] Starting subtest: test_aperture_limit
[131.648039] Starting dynamic subtest: test_aperture_limit-smem
[131.654772] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[131.659244] Subtest test_aperture_limit: SKIP (0.007s)
[131.770347] [021/133] (886s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[132.326654] Starting subtest: syncobj-timeline-invalid-wait
[132.329087] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[133.991993] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[133.995105] [022/133] (884s left) gem_exec_params (no-blt)
[134.066281] Starting subtest: no-blt
[134.070063] Subtest no-blt: SUCCESS (0.006s)
[134.260937] [023/133] (884s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[134.368452] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[135.181409] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[135.368827] [024/133] (883s left) kms_async_flips (async-flip-dpms)
[135.466708] Starting subtest: async-flip-dpms
[135.843748] Starting dynamic subtest: pipe-A-eDP-1
[139.674185] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.831s)
[140.043366] Starting dynamic subtest: pipe-B-eDP-1
[142.853290] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.818s)
[143.245949] Starting dynamic subtest: pipe-C-eDP-1
[146.020799] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.782s)
[146.394951] Starting dynamic subtest: pipe-D-eDP-1
[149.189294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[149.191580] Subtest async-flip-dpms: SUCCESS (13.724s)
[150.380186] [025/133] (868s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[150.617955] Starting subtest: cursor-rapid-movement-256x256
[150.622985] Starting dynamic subtest: pipe-A-eDP-1
[151.164506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[151.190893] Starting dynamic subtest: pipe-D-eDP-1
[152.395884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[152.398260] Subtest cursor-rapid-movement-256x256: SUCCESS (1.778s)
[153.257253] [026/133] (865s left) kms_prop_blob (basic)
[153.317727] Starting subtest: basic
[153.320033] Subtest basic: SUCCESS (0.000s)
[153.430885] [027/133] (865s left) perf (gen12-unprivileged-single-ctx-counters)
[153.556632] Starting subtest: gen12-unprivileged-single-ctx-counters
[153.558797] Starting dynamic subtest: rcs0
[153.593550] Dynamic subtest rcs0: SUCCESS (0.038s)
[153.595854] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.039s)
[153.641950] [028/133] (865s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[153.787156] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[153.789483] Starting dynamic subtest: pipe-A
[154.904116] Dynamic subtest pipe-A: SUCCESS (1.117s)
[154.913353] Starting dynamic subtest: pipe-B
[157.101594] Dynamic subtest pipe-B: SUCCESS (2.197s)
[157.109848] Starting dynamic subtest: pipe-C
[158.245245] Dynamic subtest pipe-C: SUCCESS (1.143s)
[158.254209] Starting dynamic subtest: pipe-D
[159.396029] Dynamic subtest pipe-D: SUCCESS (1.150s)
[159.398300] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.609s)
[160.599277] [029/133] (858s left) gem_exec_alignment (single)
[160.672310] Starting subtest: single
[160.674649] Subtest single: SUCCESS (0.003s)
[160.832837] [030/133] (858s left) api_intel_bb (add-remove-objects)
[160.888284] Starting subtest: add-remove-objects
[160.893050] Subtest add-remove-objects: SUCCESS (0.007s)
[161.047893] [031/133] (857s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[161.144249] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[161.148463] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[161.261374] [032/133] (857s left) kms_lease (multimaster-lease)
[161.359111] Starting subtest: multimaster-lease
[161.361431] Subtest multimaster-lease: SUCCESS (0.004s)
[161.497182] [033/133] (857s left) kms_joiner (basic-ultra-joiner)
[161.585782] Starting subtest: basic-ultra-joiner
[161.589332] Subtest basic-ultra-joiner: SKIP (0.000s)
[161.688374] [034/133] (857s left) syncobj_eventfd (binary-wait)
[161.747553] Starting subtest: binary-wait
[161.756367] Subtest binary-wait: SUCCESS (0.010s)
[161.872432] [035/133] (857s left) gem_mmap_wc (pf-nonblock)
[161.918676] Subtest pf-nonblock: SKIP (0.000s)
[161.981834] [036/133] (857s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[162.084239] Starting subtest: fbc-rgb565-draw-render
[166.315656] Subtest fbc-rgb565-draw-render: SUCCESS (4.233s)
[167.526393] [037/133] (851s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[167.631294] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[167.642867] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[167.743354] [038/133] (851s left) kms_scaling_modes (scaling-mode-full-aspect)
[167.838137] Starting subtest: scaling-mode-full-aspect
[167.840338] Starting dynamic subtest: pipe-A-eDP-1
[167.936943] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.101s)
[167.945959] Starting dynamic subtest: pipe-B-eDP-1
[169.109420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[169.118928] Starting dynamic subtest: pipe-C-eDP-1
[170.227274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[170.235501] Starting dynamic subtest: pipe-D-eDP-1
[171.359312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[171.361581] Subtest scaling-mode-full-aspect: SUCCESS (3.524s)
[172.554352] [039/133] (846s left) api_intel_bb (object-reloc-keep-cache)
[172.606624] Starting subtest: object-reloc-keep-cache
[172.611046] Subtest object-reloc-keep-cache: SKIP (0.002s)
[172.751545] [040/133] (846s left) kms_feature_discovery (display-1x)
[172.864240] Starting subtest: display-1x
[172.866317] Subtest display-1x: SUCCESS (0.000s)
[172.948235] [041/133] (846s left) syncobj_eventfd (timeline-wait)
[173.019276] Starting subtest: timeline-wait
[173.029196] Subtest timeline-wait: SUCCESS (0.010s)
[173.168634] [042/133] (846s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[173.260042] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[173.264390] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[173.341215] [043/133] (846s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[173.450474] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[173.454431] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[173.576982] [044/133] (845s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[173.675245] Starting subtest: y-tiled-8bpp-rotate-270
[173.678862] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[173.819938] [045/133] (845s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[173.929281] Starting subtest: psr-rgb101010-draw-render
[181.125848] Subtest psr-rgb101010-draw-render: SUCCESS (7.198s)
[181.275112] [046/133] (838s left) prime_self_import (export-vs-gem_close-race)
[181.312938] Starting subtest: export-vs-gem_close-race
[186.396985] Subtest export-vs-gem_close-race: SUCCESS (5.086s)
[186.542495] [047/133] (833s left) kms_addfb_basic (too-wide)
[186.638437] Starting subtest: too-wide
[186.640661] Subtest too-wide: SUCCESS (0.000s)
[186.777081] [048/133] (832s left) kms_prop_blob (invalid-set-prop-any)
[186.836402] Starting subtest: invalid-set-prop-any
[186.838605] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[186.966783] [049/133] (832s left) fbdev (read)
[187.011685] Starting subtest: read
[187.535412] Subtest read: SUCCESS (0.522s)
[187.611112] [050/133] (832s left) i915_pm_rps (fence-order)
[187.666388] Starting subtest: fence-order
[190.539019] Subtest fence-order: SUCCESS (2.870s)
[190.640589] [051/133] (829s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[190.746021] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[190.748408] Starting dynamic subtest: pipe-A-eDP-1
[190.771772] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[190.782059] Starting dynamic subtest: pipe-B-eDP-1
[190.804214] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[190.812268] Starting dynamic subtest: pipe-C-eDP-1
[190.833736] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[190.842213] Starting dynamic subtest: pipe-D-eDP-1
[190.865581] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[190.869777] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.009s)
[192.932838] [052/133] (826s left) gem_pxp (reject-modify-context-protection-off-3)
[193.039596] Starting subtest: reject-modify-context-protection-off-3
[193.042206] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[193.156414] [053/133] (826s left) gem_ccs (suspend-resume)
[193.216456] Starting subtest: suspend-resume
[193.221104] Subtest suspend-resume: SKIP (0.000s)
[193.336732] [054/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[193.448766] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[193.452706] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[193.569305] [055/133] (826s left) gem_exec_params (rs-invalid)
[193.630883] Starting subtest: rs-invalid
[193.637041] Subtest rs-invalid: SUCCESS (0.003s)
[193.782514] [056/133] (826s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[193.886575] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[193.889759] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[194.007137] [057/133] (826s left) gem_ctx_persistence (legacy-engines-mixed-process)
[194.061964] Starting subtest: legacy-engines-mixed-process
[194.064088] Starting dynamic subtest: render
[195.943978] Dynamic subtest render: SUCCESS (1.881s)
[195.954383] Starting dynamic subtest: bsd1
[197.932893] Dynamic subtest bsd1: SUCCESS (1.987s)
[197.943774] Starting dynamic subtest: bsd2
[199.914945] Dynamic subtest bsd2: SUCCESS (1.980s)
[199.926240] Starting dynamic subtest: blt
[201.908840] Dynamic subtest blt: SUCCESS (1.992s)
[201.918747] Starting dynamic subtest: vebox
[203.892390] Dynamic subtest vebox: SUCCESS (1.981s)
[203.895224] Subtest legacy-engines-mixed-process: SUCCESS (9.830s)
[203.994255] [058/133] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[204.122465] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[204.126303] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.244326] [059/133] (815s left) kms_flip (2x-flip-vs-dpms-on-nop)
[204.346302] Starting subtest: 2x-flip-vs-dpms-on-nop
[204.354503] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[204.486374] [060/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[204.586393] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[204.590482] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[204.708558] [061/133] (815s left) gem_mmap_offset (bad-extensions)
[204.766775] Starting subtest: bad-extensions
[204.769032] Subtest bad-extensions: SUCCESS (0.000s)
[204.894517] [062/133] (815s left) kms_pipe_crc_basic (nonblocking-crc)
[205.005820] Starting subtest: nonblocking-crc
[205.007780] Starting dynamic subtest: pipe-A-eDP-1
[205.741096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[205.752043] Starting dynamic subtest: pipe-B-eDP-1
[207.114639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[207.124361] Starting dynamic subtest: pipe-C-eDP-1
[208.517876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.400s)
[208.530803] Starting dynamic subtest: pipe-D-eDP-1
[209.846176] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[209.848412] Subtest nonblocking-crc: SUCCESS (4.839s)
[210.661579] [063/133] (809s left) kms_sequence (get-busy)
[210.770048] Starting subtest: get-busy
[210.772242] Starting dynamic subtest: pipe-A-eDP-1
[212.717637] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s)
[212.727688] Starting dynamic subtest: pipe-B-eDP-1
[215.354947] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.634s)
[215.363875] Starting dynamic subtest: pipe-C-eDP-1
[217.958276] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.602s)
[217.967149] Starting dynamic subtest: pipe-D-eDP-1
[220.491178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[220.493628] Subtest get-busy: SUCCESS (9.721s)
[221.306311] [064/133] (799s left) perf (sysctl-defaults)
[221.375063] Starting subtest: sysctl-defaults
[221.377456] Subtest sysctl-defaults: SUCCESS (0.000s)
[221.439677] [065/133] (798s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[221.547350] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[221.551184] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[221.658273] [066/133] (798s left) kms_chamelium_edid (hdmi-mode-timings)
[222.049057] Subtest hdmi-mode-timings: SKIP (0.000s)
[222.825178] [067/133] (797s left) kms_flip (basic-flip-vs-dpms)
[222.926993] Starting subtest: basic-flip-vs-dpms
[222.929231] Starting dynamic subtest: A-eDP1
[225.531645] Dynamic subtest A-eDP1: SUCCESS (2.606s)
[225.540250] Starting dynamic subtest: B-eDP1
[227.708075] Dynamic subtest B-eDP1: SUCCESS (2.172s)
[227.716661] Starting dynamic subtest: C-eDP1
[229.777681] Dynamic subtest C-eDP1: SUCCESS (2.069s)
[229.786070] Starting dynamic subtest: D-eDP1
[231.848460] Dynamic subtest D-eDP1: SUCCESS (2.067s)
[231.850614] Subtest basic-flip-vs-dpms: SUCCESS (8.924s)
[232.654384] [068/133] (787s left) kms_big_fb (4-tiled-addfb-size-overflow)
[232.757380] Starting subtest: 4-tiled-addfb-size-overflow
[232.759656] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[232.881958] [069/133] (787s left) kms_cursor_crc (cursor-offscreen-32x32)
[233.023044] Starting subtest: cursor-offscreen-32x32
[233.064065] Subtest cursor-offscreen-32x32: SKIP (0.039s)
[233.377140] [070/133] (787s left) gem_exec_balancer (bonded-true-hang)
[233.626941] Starting subtest: bonded-true-hang
[233.631865] Subtest bonded-true-hang: SKIP (0.000s)
[233.739060] [071/133] (786s left) kms_plane_lowres (tiling-y)
[233.841304] Starting subtest: tiling-y
[233.845423] Subtest tiling-y: SKIP (0.000s)
[233.924237] [072/133] (786s left) gem_eio (create)
[234.150703] Starting subtest: create
[234.474352] Subtest create: SUCCESS (0.322s)
[234.653578] [073/133] (786s left) kms_color (ctm-blue-to-red)
[234.760511] Starting subtest: ctm-blue-to-red
[234.762068] Starting dynamic subtest: pipe-A-eDP-1
[235.437866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s)
[235.446700] Starting dynamic subtest: pipe-B-eDP-1
[236.846102] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[236.856415] Starting dynamic subtest: pipe-C-eDP-1
[238.192575] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[238.201206] Starting dynamic subtest: pipe-D-eDP-1
[239.549453] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[239.551727] Subtest ctm-blue-to-red: SUCCESS (4.789s)
[240.359367] [074/133] (780s left) kms_flip (busy-flip)
[240.449086] Starting subtest: busy-flip
[240.451310] Starting dynamic subtest: A-eDP1
[242.153406] Dynamic subtest A-eDP1: SUCCESS (1.703s)
[242.162340] Starting dynamic subtest: B-eDP1
[243.882860] Dynamic subtest B-eDP1: SUCCESS (1.727s)
[243.892060] Starting dynamic subtest: C-eDP1
[245.510491] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[245.523276] Starting dynamic subtest: D-eDP1
[247.142593] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[247.148012] Subtest busy-flip: SUCCESS (6.697s)
[248.407848] [075/133] (772s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[248.519727] Starting subtest: cursor-tearing-framebuffer-change
[248.521956] Starting dynamic subtest: pipe-A-eDP-1
[249.072073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[249.080535] Starting dynamic subtest: pipe-D-eDP-1
[250.318195] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[250.320447] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.797s)
[251.158492] [076/133] (769s left) gem_exercise_blt (fast-copy)
[251.219400] Starting subtest: fast-copy
[251.221757] Starting dynamic subtest: linear-smem-smem
[251.240432] Dynamic subtest linear-smem-smem: SUCCESS (0.021s)
[251.250862] Starting dynamic subtest: xmajor-smem-smem
[251.257311] Dynamic subtest xmajor-smem-smem: SUCCESS (0.016s)
[251.265605] Starting dynamic subtest: tile4-smem-smem
[251.275000] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[251.283184] Starting dynamic subtest: tile64-smem-smem
[251.292620] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[251.294922] Subtest fast-copy: SUCCESS (0.074s)
[251.453834] [077/133] (769s left) kms_flip (2x-flip-vs-modeset)
[251.547360] Starting subtest: 2x-flip-vs-modeset
[251.555447] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[251.649524] [078/133] (769s left) gem_exec_reloc (basic-cpu-read)
[251.709631] Subtest basic-cpu-read: SKIP (0.000s)
[251.776154] [079/133] (769s left) gem_ctx_freq (sysfs)
[251.842457] Starting subtest: sysfs
[251.844703] Starting dynamic subtest: gt0
[257.370918] Dynamic subtest gt0: SUCCESS (5.527s)
[257.380919] Starting dynamic subtest: gt1
[297.877423] Dynamic subtest gt1: SUCCESS (40.503s)
[297.880080] Subtest sysfs: SUCCESS (46.033s)
[298.038030] [080/133] (722s left) core_setmaster (master-drop-set-shared-fd)
[298.124228] Starting subtest: master-drop-set-shared-fd
[298.143446] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[298.181208] [081/133] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[298.291261] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[298.295662] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.426382] [082/133] (722s left) syncobj_wait (single-wait-all-signaled)
[298.494559] Starting subtest: single-wait-all-signaled
[298.496915] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[298.596284] [083/133] (722s left) gem_exec_balancer (parallel-keep-submit-fence)
[298.851583] Starting subtest: parallel-keep-submit-fence
[299.920514] Subtest parallel-keep-submit-fence: SUCCESS (1.069s)
[300.051422] [084/133] (721s left) gem_exec_params (invalid-flag)
[300.111359] Starting subtest: invalid-flag
[300.113730] Subtest invalid-flag: SUCCESS (0.000s)
[300.230414] [085/133] (720s left) kms_content_protection (legacy-hdcp14)
[300.366881] Starting subtest: legacy-hdcp14
[300.372412] Subtest legacy-hdcp14: SKIP (0.000s)
[300.516333] [086/133] (720s left) syncobj_wait (invalid-reset-bad-pad)
[300.592925] Starting subtest: invalid-reset-bad-pad
[300.595152] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[300.729387] [087/133] (720s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[300.780741] Starting subtest: yf-tiled-to-vebox-yf-tiled
[300.785219] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[300.986387] [088/133] (720s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[301.086108] Starting subtest: x-tiled-8bpp-rotate-180
[302.338216] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.251s)
[302.492610] [089/133] (718s left) gem_wait (invalid-buf)
[302.544034] Starting subtest: invalid-buf
[302.545904] Subtest invalid-buf: SUCCESS (0.000s)
[302.776144] [090/133] (718s left) prime_vgem (basic-fence-flip)
[302.836340] Starting subtest: basic-fence-flip
[303.138460] Subtest basic-fence-flip: SUCCESS (0.302s)
[303.254464] [091/133] (718s left) syncobj_timeline (single-wait-available-signaled)
[303.318229] Starting subtest: single-wait-available-signaled
[303.320596] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[303.415818] [092/133] (718s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[303.544154] Starting subtest: cursor-vs-flip-atomic
[332.838245] Subtest cursor-vs-flip-atomic: SUCCESS (29.291s)
[333.686875] [093/133] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[333.804359] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[333.808265] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[333.922508] [094/133] (687s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[333.972964] Starting subtest: multi-wait-for-submit-submitted-signaled
[333.975345] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[334.083162] [095/133] (687s left) perf_pmu (busy-idle-no-semaphores)
[334.118490] Starting subtest: busy-idle-no-semaphores
[334.120449] Starting dynamic subtest: rcs0
[334.783217] Dynamic subtest rcs0: SUCCESS (0.664s)
[334.793749] Starting dynamic subtest: bcs0
[335.434745] Dynamic subtest bcs0: SUCCESS (0.649s)
[335.446167] Starting dynamic subtest: vcs0
[336.085639] Dynamic subtest vcs0: SUCCESS (0.648s)
[336.097031] Starting dynamic subtest: vcs1
[337.532065] Dynamic subtest vcs1: SUCCESS (1.444s)
[337.543613] Starting dynamic subtest: vecs0
[339.517526] Dynamic subtest vecs0: SUCCESS (1.983s)
[339.528984] Starting dynamic subtest: ccs0
[341.501054] Dynamic subtest ccs0: SUCCESS (1.981s)
[341.504028] Subtest busy-idle-no-semaphores: SUCCESS (7.383s)
[341.631976] [096/133] (679s left) gem_fence_thrash (bo-write-verify-x)
[341.673324] Starting subtest: bo-write-verify-x
[341.697274] Subtest bo-write-verify-x: SKIP (0.023s)
[341.776711] [097/133] (679s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[341.839321] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[341.841314] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[341.965193] [098/133] (679s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[342.064327] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[342.066606] Starting dynamic subtest: pipe-A-eDP-1
[342.089194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[342.099129] Starting dynamic subtest: pipe-B-eDP-1
[342.119782] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[342.128015] Starting dynamic subtest: pipe-C-eDP-1
[342.148699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[342.156748] Starting dynamic subtest: pipe-D-eDP-1
[342.178733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[342.182817] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[344.258244] [099/133] (677s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[344.364844] Starting subtest: primary-y-tiled-reflect-x-180
[344.424290] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[344.540093] [100/133] (677s left) gem_exec_schedule (u-lateslice)
[344.621528] Starting subtest: u-lateslice
[344.623512] Starting dynamic subtest: rcs0
[344.631086] Dynamic subtest rcs0: SUCCESS (0.020s)
[344.641050] Starting dynamic subtest: bcs0
[344.647208] Dynamic subtest bcs0: SUCCESS (0.016s)
[344.655128] Starting dynamic subtest: vcs0
[344.664505] Dynamic subtest vcs0: SUCCESS (0.017s)
[344.672583] Starting dynamic subtest: vcs1
[344.682110] Dynamic subtest vcs1: SUCCESS (0.017s)
[344.690086] Starting dynamic subtest: vecs0
[344.698082] Dynamic subtest vecs0: SUCCESS (0.015s)
[344.706163] Starting dynamic subtest: ccs0
[344.716922] Dynamic subtest ccs0: SUCCESS (0.018s)
[344.719067] Subtest u-lateslice: SUCCESS (0.107s)
[346.007820] [101/133] (675s left) kms_flip (blocking-absolute-wf_vblank)
[346.106806] Starting subtest: blocking-absolute-wf_vblank
[346.108734] Starting dynamic subtest: A-eDP1
[354.806539] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[354.815879] Starting dynamic subtest: B-eDP1
[363.531734] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[363.549652] Starting dynamic subtest: C-eDP1
[372.247889] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[372.256134] Starting dynamic subtest: D-eDP1
[380.970496] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[380.976007] Subtest blocking-absolute-wf_vblank: SUCCESS (34.871s)
[382.189266] [102/133] (639s left) gem_exec_reloc (basic-write-cpu-active)
[382.252642] Subtest basic-write-cpu-active: SKIP (0.000s)
[382.347288] [103/133] (639s left) kms_pm_rpm (cursor-dpms)
[384.076334] Starting subtest: cursor-dpms
[384.081745] Subtest cursor-dpms: SKIP (0.000s)
[384.633168] [104/133] (637s left) gem_exec_schedule (preempt-queue-contexts)
[384.694061] Subtest preempt-queue-contexts: SKIP (0.000s)
[384.992504] [105/133] (637s left) gem_tiled_blits (interruptible)
[385.053317] Subtest interruptible: SKIP (0.000s)
[385.136926] [106/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[385.245614] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[385.249724] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[385.354210] [107/133] (636s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[385.414575] Starting subtest: etime-single-wait-available-unsubmitted
[385.522225] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[385.612383] [108/133] (636s left) i915_drm_fdinfo (memory-info-idle)
[385.658402] Starting subtest: memory-info-idle
[385.660577] Starting dynamic subtest: smem0
[385.752839] Dynamic subtest smem0: SUCCESS (0.094s)
[385.755898] Subtest memory-info-idle: SUCCESS (0.096s)
[385.856991] [109/133] (636s left) kms_cursor_legacy (forked-move)
[385.977447] Starting subtest: forked-move
[385.979547] Starting dynamic subtest: pipe-A
[391.450530] Dynamic subtest pipe-A: SUCCESS (5.470s)
[391.460918] Starting dynamic subtest: pipe-B
[396.921660] Dynamic subtest pipe-B: SUCCESS (5.470s)
[396.932201] Starting dynamic subtest: pipe-C
[402.392642] Dynamic subtest pipe-C: SUCCESS (5.467s)
[402.403552] Starting dynamic subtest: pipe-D
[407.858752] Dynamic subtest pipe-D: SUCCESS (5.464s)
[407.869440] Starting dynamic subtest: all-pipes
[413.359486] Dynamic subtest all-pipes: SUCCESS (5.498s)
[413.361946] Subtest forked-move: SUCCESS (27.379s)
[413.516153] [110/133] (608s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[413.629169] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[413.654680] Starting dynamic subtest: pipe-A-plane-0
[413.659326] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[413.669823] Starting dynamic subtest: pipe-A-plane-3
[413.674780] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[413.689456] Starting dynamic subtest: pipe-A-plane-5
[413.693730] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[414.788419] Starting dynamic subtest: pipe-B-plane-0
[414.792743] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[414.800692] Starting dynamic subtest: pipe-B-plane-3
[414.805325] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[414.813407] Starting dynamic subtest: pipe-B-plane-5
[414.817630] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[415.110305] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (1.479s)
[415.978384] [111/133] (606s left) kms_psr (pr-no-drrs)
[416.079071] Starting subtest: pr-no-drrs
[416.083235] Subtest pr-no-drrs: SKIP (0.000s)
[416.164476] [112/133] (606s left) kms_big_fb (x-tiled-addfb-size-overflow)
[416.264277] Starting subtest: x-tiled-addfb-size-overflow
[416.266166] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[416.399185] [113/133] (605s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[416.499475] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[416.501715] Starting dynamic subtest: pipe-A-eDP-1
[416.617983] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[416.628481] Starting dynamic subtest: pipe-B-eDP-1
[417.743276] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[417.748033] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.248s)
[419.057394] [114/133] (603s left) i915_drm_fdinfo (virtual-busy-idle-all)
[419.095568] Starting subtest: virtual-busy-idle-all
[419.100131] Subtest virtual-busy-idle-all: SKIP (0.000s)
[419.178288] [115/133] (603s left) kms_psr (psr2-sprite-plane-onoff)
[419.276986] Starting subtest: psr2-sprite-plane-onoff
[419.279401] Starting dynamic subtest: eDP-1
[421.029512] Dynamic subtest eDP-1: SUCCESS (1.751s)
[421.031963] Subtest psr2-sprite-plane-onoff: SUCCESS (1.752s)
[421.891161] [116/133] (600s left) gem_userptr_blits (vma-merge)
[421.979535] Starting subtest: vma-merge
[422.018594] Subtest vma-merge: SUCCESS (0.039s)
[422.144451] [117/133] (600s left) i915_selftest (live)
[425.609356] Starting subtest: live
[425.611573] Starting dynamic subtest: sanitycheck
[430.101234] Dynamic subtest sanitycheck: SUCCESS (4.493s)
[430.110078] Starting dynamic subtest: uncore
[434.576956] Dynamic subtest uncore: SUCCESS (4.473s)
[434.585762] Starting dynamic subtest: workarounds
[453.154022] Dynamic subtest workarounds: FAIL (18.378s)
[453.162999] Starting dynamic subtest: gt_engines
[456.098645] Dynamic subtest gt_engines: SUCCESS (3.139s)
[456.105754] Starting dynamic subtest: gt_timelines
[473.897288] Dynamic subtest gt_timelines: SUCCESS (17.795s)
[473.906072] Starting dynamic subtest: gt_contexts
[476.748080] Dynamic subtest gt_contexts: SUCCESS (2.848s)
[476.757578] Starting dynamic subtest: gt_lrc
[483.096351] Dynamic subtest gt_lrc: SUCCESS (6.345s)
[483.108158] Starting dynamic subtest: gt_mocs
[486.200286] Dynamic subtest gt_mocs: SUCCESS (3.101s)
[486.209550] Starting dynamic subtest: gt_pm
[493.079481] Dynamic subtest gt_pm: SUCCESS (6.876s)
[493.089104] Starting dynamic subtest: gt_heartbeat
[497.517463] Dynamic subtest gt_heartbeat: SUCCESS (4.435s)
[497.526413] Starting dynamic subtest: gt_tlb
[506.908936] Dynamic subtest gt_tlb: SUCCESS (9.389s)
[506.917742] Starting dynamic subtest: requests
[520.481592] Dynamic subtest requests: SUCCESS (13.569s)
[520.490678] Starting dynamic subtest: migrate
[526.662451] Dynamic subtest migrate: SUCCESS (6.178s)
[526.670965] Starting dynamic subtest: active
[531.175267] Dynamic subtest active: SUCCESS (4.510s)
[531.183997] Starting dynamic subtest: objects
[534.524422] Dynamic subtest objects: SUCCESS (3.347s)
[534.533504] Starting dynamic subtest: mman
[539.501311] Dynamic subtest mman: SUCCESS (4.975s)
[539.509858] Starting dynamic subtest: dmabuf
[543.969037] Dynamic subtest dmabuf: SUCCESS (4.466s)
[543.978088] Starting dynamic subtest: vma
[548.441057] Dynamic subtest vma: SUCCESS (4.470s)
[548.450062] Starting dynamic subtest: coherency
[553.646291] Dynamic subtest coherency: SUCCESS (5.203s)
[553.655516] Starting dynamic subtest: gtt
[563.672798] Dynamic subtest gtt: SUCCESS (10.021s)
[563.681710] Starting dynamic subtest: gem
[571.769030] Dynamic subtest gem: SUCCESS (8.098s)
[571.777573] Starting dynamic subtest: evict
[577.312995] Dynamic subtest evict: SUCCESS (5.542s)
[577.322262] Starting dynamic subtest: hugepages
[586.434435] Dynamic subtest hugepages: SUCCESS (9.118s)
[586.443047] Starting dynamic subtest: gem_contexts
[612.993368] Dynamic subtest gem_contexts: SUCCESS (26.557s)
[613.002482] Starting dynamic subtest: client
[615.792956] Dynamic subtest client: SUCCESS (2.799s)
[615.801974] Starting dynamic subtest: gem_migrate
[620.298718] Dynamic subtest gem_migrate: SUCCESS (4.504s)
[620.313108] Starting dynamic subtest: reset
[623.220735] Dynamic subtest reset: SUCCESS (2.915s)
[623.230168] Starting dynamic subtest: memory_region
[626.024949] Dynamic subtest memory_region: SUCCESS (2.806s)
[626.033821] Starting dynamic subtest: hangcheck
[639.368078] Dynamic subtest hangcheck: SUCCESS (13.340s)
[639.377692] Starting dynamic subtest: execlists
[643.870992] Dynamic subtest execlists: SUCCESS (4.500s)
[643.879934] Starting dynamic subtest: ring_submission
[648.357435] Dynamic subtest ring_submission: SUCCESS (4.483s)
[648.366548] Starting dynamic subtest: perf
[651.313454] Dynamic subtest perf: SUCCESS (2.954s)
[651.322399] Starting dynamic subtest: slpc
[665.543650] Dynamic subtest slpc: SUCCESS (14.228s)
[665.552959] Starting dynamic subtest: guc
[669.510303] Dynamic subtest guc: SUCCESS (3.964s)
[669.519854] Starting dynamic subtest: guc_multi_lrc
[673.894455] Dynamic subtest guc_multi_lrc: SUCCESS (4.382s)
[673.902980] Starting dynamic subtest: guc_hang
[678.933065] Dynamic subtest guc_hang: SUCCESS (5.037s)
[678.942353] Starting dynamic subtest: late_gt_pm
[681.784375] Dynamic subtest late_gt_pm: SUCCESS (2.848s)
[681.787523] Subtest live: FAIL (256.167s)
[681.814691] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[681.815393] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[681.818414] [118/133] (340s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[683.354460] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[689.893794] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.540s)
[690.047706] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[690.048886] [FACT kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[690.052494] [119/133] (332s left) kms_async_flips (test-time-stamp-atomic)
[690.151027] Starting subtest: test-time-stamp-atomic
[690.554449] Starting dynamic subtest: pipe-A-eDP-1
[691.327051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[691.717511] Starting dynamic subtest: pipe-B-eDP-1
[692.479916] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[692.842816] Starting dynamic subtest: pipe-C-eDP-1
[693.611776] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.772s)
[693.980962] Starting dynamic subtest: pipe-D-eDP-1
[694.733828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.757s)
[694.736299] Subtest test-time-stamp-atomic: SUCCESS (4.584s)
[695.902949] [120/133] (326s left) gem_softpin (allocator-fork)
[695.975204] Starting subtest: allocator-fork
[698.182322] Subtest allocator-fork: SUCCESS (2.206s)
[698.346471] [121/133] (324s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[698.452165] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[702.717931] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.269s)
[703.916380] [122/133] (318s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[704.022540] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[704.026794] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[704.154510] [123/133] (318s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[704.543409] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[705.310297] [124/133] (317s left) gem_exec_flush (basic-uc-prw-default)
[705.381095] Starting subtest: basic-uc-prw-default
[710.848553] Subtest basic-uc-prw-default: SUCCESS (5.467s)
[711.091043] [125/133] (311s left) kms_chamelium_color (ctm-blue-to-red)
[711.198584] Subtest ctm-blue-to-red: SKIP (0.000s)
[711.243321] [126/133] (311s left) kms_psr (fbc-psr-cursor-plane-onoff)
[711.337995] Starting subtest: fbc-psr-cursor-plane-onoff
[711.340234] Starting dynamic subtest: eDP-1
[711.344207] Dynamic subtest eDP-1: SKIP (0.000s)
[711.348249] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[711.435321] [127/133] (311s left) gem_exec_reloc (basic-write-gtt-noreloc)
[711.499876] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[711.596620] [128/133] (311s left) vgem_basic (bad-pad)
[711.640485] Starting subtest: bad-pad
[711.642620] Subtest bad-pad: SUCCESS (0.000s)
[711.720414] [129/133] (311s left) gem_exec_reloc (basic-write-cpu)
[711.794564] Subtest basic-write-cpu: SKIP (0.000s)
[711.875611] [130/133] (311s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[711.966862] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[711.969163] Starting dynamic subtest: pipe-A-eDP-1
[717.791122] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.830s)
[717.800087] Starting dynamic subtest: pipe-B-eDP-1
[724.450225] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[724.452327] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.488s)
[725.313617] [131/133] (297s left) gen7_exec_parse (bitmasks)
[725.367707] Subtest bitmasks: SKIP (0.000s)
[725.448896] [132/133] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[725.542755] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[725.547190] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[725.658580] [133/133] (297s left) gem_render_copy (x-tiled)
[725.712043] Starting subtest: x-tiled
[725.714417] Starting dynamic subtest: smem
[725.760462] Dynamic subtest smem: SUCCESS (0.048s)
[725.762759] Subtest x-tiled: SUCCESS (0.049s)
[726.016931] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_flink_basic
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_vblank
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_exec_whisper
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_partial_pwrite_pread
results: parsing output: 15/ for test: gem_ctx_bad_destroy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: gem_media_fill
results: parsing output: 19/ for test: prime_mmap
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: gem_exec_alignment
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_lease
results: parsing output: 32/ for test: kms_joiner
results: parsing output: 33/ for test: syncobj_eventfd
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_scaling_modes
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: syncobj_eventfd
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: prime_self_import
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: fbdev
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: gem_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_mmap_offset
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: kms_sequence
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_plane_lowres
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_exercise_blt
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_ctx_freq
results: parsing output: 79/ for test: core_setmaster
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_content_protection
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_wait
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: gem_fence_thrash
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_rotation_crc
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_pm_rpm
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: gem_tiled_blits
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_selftest
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: gem_exec_flush
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: vgem_basic
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: gen7_exec_parse
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_render_copy
Done.