[57.053167] Initializing watchdogs
[57.053281]   /dev/watchdog0
[57.087455] [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.091741] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.094129] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.097516] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.179854] Starting subtest: invalid-bad-pad
[57.182304] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.311909] [002/131] (960s left) tools_test (tools_test)
[57.368421] Starting subtest: tools_test
[57.419567] Subtest tools_test: SUCCESS (0.068s)
[57.505472] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[57.564204] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[57.631014] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[57.716605] Starting subtest: sync-unmap-cycles
[63.083242] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[63.237333] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.348076] Starting subtest: stress-xrgb8888-ytiled
[63.351892] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.423373] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[63.509026] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[63.511167] Starting dynamic subtest: pipe-A-eDP-1
[79.607226] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.974s)
[79.615720] Starting dynamic subtest: pipe-B-eDP-1
[97.492603] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.462s)
[97.502298] Starting dynamic subtest: pipe-C-eDP-1
[114.477029] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[114.486437] Starting dynamic subtest: pipe-D-eDP-1
[131.441082] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.312s)
[131.443519] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.166s)
[132.702176] [007/131] (885s left) api_intel_allocator (gem-pool)
[132.768563] Starting subtest: gem-pool
[132.773271] Subtest gem-pool: SUCCESS (0.007s)
[132.889295] [008/131] (884s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[133.000377] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[139.547960] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.572s)
[139.684494] [009/131] (878s left) kms_atomic_interruptible (universal-setplane-primary)
[139.797136] Starting subtest: universal-setplane-primary
[139.799446] Starting dynamic subtest: pipe-A-eDP-1
[147.206744] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s)
[147.208699] Subtest universal-setplane-primary: SUCCESS (7.420s)
[148.065903] [010/131] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[148.168698] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[152.435000] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.273s)
[153.662543] [011/131] (864s left) gem_eio (in-flight-contexts-1us)
[153.878178] Starting subtest: in-flight-contexts-1us
[165.762143] Subtest in-flight-contexts-1us: SUCCESS (11.886s)
[165.906770] [012/131] (852s left) gem_exec_balancer (semaphore)
[165.967752] Starting subtest: semaphore
[167.692236] Subtest semaphore: SUCCESS (1.722s)
[168.005762] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[168.384353] Subtest hdmi-hpd: SKIP (0.000s)
[169.241443] [014/131] (848s left) kms_flip (wf_vblank-ts-check)
[169.341303] Starting subtest: wf_vblank-ts-check
[169.343553] Starting dynamic subtest: A-eDP1
[178.313074] Dynamic subtest A-eDP1: SUCCESS (8.972s)
[178.322320] Starting dynamic subtest: B-eDP1
[187.247203] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[187.258340] Starting dynamic subtest: C-eDP1
[196.168800] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[196.179869] Starting dynamic subtest: D-eDP1
[205.104160] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[205.109340] Subtest wf_vblank-ts-check: SUCCESS (35.774s)
[206.347106] [015/131] (811s left) gem_exec_reloc (basic-gtt)
[206.422668] Subtest basic-gtt: SKIP (0.000s)
[206.513733] [016/131] (811s left) gem_exec_schedule (reorder-wide)
[206.704123] Subtest reorder-wide: SKIP (0.000s)
[206.904967] [017/131] (811s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[207.005048] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[207.007363] Starting dynamic subtest: pipe-A-eDP-1
[207.030303] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[207.041770] Starting dynamic subtest: pipe-B-eDP-1
[207.063351] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[207.071641] Starting dynamic subtest: pipe-C-eDP-1
[207.093010] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[207.100967] Starting dynamic subtest: pipe-D-eDP-1
[207.122624] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[207.127037] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[209.230569] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[209.339252] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[209.343669] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[209.476616] [019/131] (808s left) perf (polling)
[209.622681] Starting subtest: polling
[209.624873] Starting dynamic subtest: 0-rcs0
[219.643357] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[219.652662] Starting dynamic subtest: 1-vcs0
[229.668439] Dynamic subtest 1-vcs0: SUCCESS (10.021s)
[229.670732] Subtest polling: SUCCESS (20.047s)
[229.717300] [020/131] (788s left) gem_userptr_blits (probe)
[229.791570] Starting subtest: probe
[229.868730] Subtest probe: SUCCESS (0.076s)
[230.012374] [021/131] (788s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[230.117287] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[230.121152] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[230.248943] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[230.308774] Starting subtest: pf-nonblock
[230.314129] Subtest pf-nonblock: SUCCESS (0.006s)
[230.433228] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[230.533109] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[230.535359] Starting dynamic subtest: pipe-A-eDP-1
[230.560361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.572040] Starting dynamic subtest: pipe-B-eDP-1
[230.596964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.610936] Starting dynamic subtest: pipe-C-eDP-1
[230.635855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.645709] Starting dynamic subtest: pipe-D-eDP-1
[230.668691] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.672570] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[232.799624] [024/131] (785s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[232.905867] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[232.910133] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[233.029283] [025/131] (785s left) core_getstats (basic)
[233.077625] Starting subtest: basic
[233.079947] Subtest basic: SUCCESS (0.000s)
[233.202716] [026/131] (785s left) core_getclient (basic)
[233.260780] Starting subtest: basic
[233.262739] Subtest basic: SUCCESS (0.000s)
[233.380080] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[233.438918] Starting subtest: multi-wait-all-available-submitted
[233.441252] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[233.570291] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[233.628667] Subtest basic-write-wc: SKIP (0.000s)
[233.697837] [029/131] (784s left) kms_invalid_mode (clock-too-high)
[233.783211] Starting subtest: clock-too-high
[233.785191] Starting dynamic subtest: pipe-A-eDP-1
[233.788688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.798401] Starting dynamic subtest: pipe-B-eDP-1
[233.801868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.811136] Starting dynamic subtest: pipe-C-eDP-1
[233.814480] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.822240] Starting dynamic subtest: pipe-D-eDP-1
[233.825551] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.828850] Subtest clock-too-high: SKIP (0.003s)
[233.874018] [030/131] (784s left) gem_mmap_offset (bad-object)
[233.932313] Starting subtest: bad-object
[233.934379] Subtest bad-object: SUCCESS (0.001s)
[234.049519] [031/131] (784s left) syncobj_timeline (wait-all-delayed-signal)
[234.099017] Starting subtest: wait-all-delayed-signal
[234.199792] Subtest wait-all-delayed-signal: SUCCESS (0.101s)
[234.297638] [032/131] (784s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[234.399762] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[235.114123] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.715s)
[235.307275] [033/131] (783s left) gem_exec_suspend (basic-s3)
[235.373601] Starting subtest: basic-S3
[235.376064] Starting dynamic subtest: smem
[257.305825] Dynamic subtest smem: SUCCESS (8.372s)
[257.308947] Subtest basic-S3: SUCCESS (8.374s)
[265.527955] [034/131] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[265.653073] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[265.657825] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[265.770730] [035/131] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[265.879283] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[265.883698] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[266.032343] [036/131] (760s left) kms_chamelium_frames (hdmi-crc-multiple)
[266.436918] Subtest hdmi-crc-multiple: SKIP (0.000s)
[267.277462] [037/131] (759s left) gem_exec_fence (syncobj-import)
[267.753699] Starting subtest: syncobj-import
[267.760205] Subtest syncobj-import: SUCCESS (0.009s)
[269.405655] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[269.409956] [038/131] (757s left) kms_legacy_colorkey (basic)
[269.509960] Starting subtest: basic
[269.511749] Starting dynamic subtest: pipe-A
[269.553839] Dynamic subtest pipe-A: SUCCESS (0.045s)
[269.567274] Starting dynamic subtest: pipe-B
[269.569073] Dynamic subtest pipe-B: SUCCESS (0.001s)
[269.578422] Starting dynamic subtest: pipe-C
[269.581065] Dynamic subtest pipe-C: SUCCESS (0.000s)
[269.600475] Starting dynamic subtest: pipe-D
[269.602798] Dynamic subtest pipe-D: SUCCESS (0.000s)
[269.605059] Subtest basic: SUCCESS (0.051s)
[269.650669] [039/131] (757s left) gem_softpin (allocator-nopin-reserve)
[269.706752] Starting subtest: allocator-nopin-reserve
[269.808221] Subtest allocator-nopin-reserve: SUCCESS (0.101s)
[269.964721] [040/131] (757s left) perf_pmu (enable-race)
[270.002215] Starting subtest: enable-race
[270.004460] Starting dynamic subtest: rcs0
[282.777227] Dynamic subtest rcs0: SUCCESS (12.800s)
[282.788234] Starting dynamic subtest: bcs0
[295.514336] Dynamic subtest bcs0: SUCCESS (12.746s)
[295.525272] Starting dynamic subtest: vcs0
[311.256550] Dynamic subtest vcs0: SUCCESS (15.736s)
[311.266877] Starting dynamic subtest: vcs1
[327.261450] Dynamic subtest vcs1: SUCCESS (16.004s)
[327.272179] Starting dynamic subtest: vecs0
[343.257219] Dynamic subtest vecs0: SUCCESS (15.998s)
[343.267242] Starting dynamic subtest: ccs0
[356.000199] Dynamic subtest ccs0: SUCCESS (12.746s)
[356.002684] Subtest enable-race: SUCCESS (86.040s)
[356.152916] [041/131] (671s left) syncobj_timeline (signal-point-0)
[356.197035] Starting subtest: signal-point-0
[356.199395] Subtest signal-point-0: SUCCESS (0.000s)
[356.312727] [042/131] (670s left) gem_tiled_wb
[356.458271] [043/131] (670s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[356.552083] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[356.554416] Starting dynamic subtest: pipe-A-eDP-1
[356.579867] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[356.589608] Starting dynamic subtest: pipe-B-eDP-1
[356.613201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[356.623944] Starting dynamic subtest: pipe-C-eDP-1
[356.647563] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[356.656377] Starting dynamic subtest: pipe-D-eDP-1
[356.679698] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[356.684055] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[358.812588] [044/131] (668s left) gem_ctx_param (set-priority-invalid-size)
[358.872032] Starting subtest: set-priority-invalid-size
[358.874371] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[358.970609] [045/131] (668s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[359.060504] Starting subtest: plane-ctm3x4-lut1d
[359.073599] Starting dynamic subtest: pipe-A-eDP-1
[359.782219] Dynamic subtest pipe-A-eDP-1: FAIL (0.338s)
[360.480199] Starting dynamic subtest: pipe-B-eDP-1
[361.325455] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s)
[361.908895] Starting dynamic subtest: pipe-C-eDP-1
[362.742618] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[363.242327] Starting dynamic subtest: pipe-D-eDP-1
[364.064388] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[364.066826] Subtest plane-ctm3x4-lut1d: FAIL (4.712s)
[364.652038] [046/131] (662s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[364.768663] Starting subtest: 2x-long-cursor-vs-flip-atomic
[364.773298] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[364.936999] [047/131] (662s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[365.041226] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[365.045285] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[365.179109] [048/131] (662s left) kms_feature_discovery (display-1x)
[365.270097] Starting subtest: display-1x
[365.272394] Subtest display-1x: SUCCESS (0.000s)
[365.370607] [049/131] (662s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[365.479904] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[365.484062] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[365.610107] [050/131] (661s left) i915_drm_fdinfo (most-busy-idle-check-all)
[365.660511] Starting subtest: most-busy-idle-check-all
[365.662414] Starting dynamic subtest: rcs0
[365.668089] Dynamic subtest rcs0: SKIP (0.004s)
[365.677017] Starting dynamic subtest: bcs0
[365.680417] Dynamic subtest bcs0: SKIP (0.000s)
[365.689216] Starting dynamic subtest: vcs0
[365.692678] Dynamic subtest vcs0: SKIP (0.000s)
[365.700947] Starting dynamic subtest: vcs1
[365.704335] Dynamic subtest vcs1: SKIP (0.000s)
[365.712206] Starting dynamic subtest: vecs0
[365.715476] Dynamic subtest vecs0: SKIP (0.000s)
[365.723650] Starting dynamic subtest: ccs0
[365.727036] Dynamic subtest ccs0: SKIP (0.000s)
[365.730432] Subtest most-busy-idle-check-all: SKIP (0.009s)
[365.765613] [051/131] (661s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[365.931772] Starting subtest: x-tiled-32bpp-rotate-270
[365.951720] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[366.110988] [052/131] (661s left) gem_exec_schedule (u-submit-early-slice)
[366.175803] Starting subtest: u-submit-early-slice
[366.177988] Starting dynamic subtest: rcs0
[366.214287] Dynamic subtest rcs0: SUCCESS (0.043s)
[366.225713] Starting dynamic subtest: bcs0
[366.254531] Dynamic subtest bcs0: SUCCESS (0.040s)
[366.263650] Starting dynamic subtest: vcs0
[366.295415] Dynamic subtest vcs0: SUCCESS (0.040s)
[366.304182] Starting dynamic subtest: vcs1
[366.332509] Dynamic subtest vcs1: SUCCESS (0.037s)
[366.342154] Starting dynamic subtest: vecs0
[366.375151] Dynamic subtest vecs0: SUCCESS (0.042s)
[366.383999] Starting dynamic subtest: ccs0
[366.419592] Dynamic subtest ccs0: SUCCESS (0.043s)
[366.421687] Subtest u-submit-early-slice: SUCCESS (0.250s)
[367.396591] [053/131] (660s left) gem_pxp (regular-baseline-src-copy-readible)
[367.524802] Starting subtest: regular-baseline-src-copy-readible
[367.581973] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[367.742123] [054/131] (660s left) gem_exec_balancer (full-late-pulse)
[367.807824] Starting subtest: full-late-pulse
[372.209908] Subtest full-late-pulse: SUCCESS (4.400s)
[372.575366] [055/131] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[372.684629] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[372.689040] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[372.830947] [056/131] (655s left) fbdev (read)
[372.869750] Starting subtest: read
[373.397685] Subtest read: SUCCESS (0.527s)
[373.491016] [057/131] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[373.596845] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[373.601423] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[373.727393] [058/131] (654s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[373.830519] Starting subtest: multiplane-rotation-cropping-top
[391.226018] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[391.388202] [059/131] (636s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[391.511019] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[398.451864] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.950s)
[398.636679] [060/131] (629s left) i915_selftest (mock)
[402.160349] Starting subtest: mock
[402.162512] Starting dynamic subtest: sanitycheck
[402.892343] Dynamic subtest sanitycheck: SUCCESS (0.732s)
[402.902594] Starting dynamic subtest: shmem
[403.699468] Dynamic subtest shmem: SUCCESS (0.805s)
[403.709766] Starting dynamic subtest: fence
[411.506696] Dynamic subtest fence: SUCCESS (7.805s)
[411.516590] Starting dynamic subtest: scatterlist
[413.266158] Dynamic subtest scatterlist: SUCCESS (1.758s)
[413.276524] Starting dynamic subtest: syncmap
[416.580939] Dynamic subtest syncmap: SUCCESS (3.313s)
[416.590973] Starting dynamic subtest: uncore
[417.363397] Dynamic subtest uncore: SUCCESS (0.780s)
[417.373509] Starting dynamic subtest: ring
[418.137318] Dynamic subtest ring: SUCCESS (0.772s)
[418.147331] Starting dynamic subtest: engine
[418.898639] Dynamic subtest engine: SUCCESS (0.759s)
[418.909215] Starting dynamic subtest: timelines
[422.915182] Dynamic subtest timelines: SUCCESS (4.014s)
[422.924826] Starting dynamic subtest: requests
[426.558568] Dynamic subtest requests: SUCCESS (3.641s)
[426.568524] Starting dynamic subtest: objects
[427.467737] Dynamic subtest objects: SUCCESS (0.907s)
[427.477505] Starting dynamic subtest: phys
[428.342187] Dynamic subtest phys: SUCCESS (0.872s)
[428.352004] Starting dynamic subtest: dmabuf
[429.168372] Dynamic subtest dmabuf: SUCCESS (0.824s)
[429.178276] Starting dynamic subtest: vma
[434.616342] Dynamic subtest vma: SUCCESS (5.447s)
[434.626293] Starting dynamic subtest: evict
[436.075520] Dynamic subtest evict: SUCCESS (1.456s)
[436.085236] Starting dynamic subtest: gtt
[439.388376] Dynamic subtest gtt: SUCCESS (3.311s)
[439.397872] Starting dynamic subtest: hugepages
[440.362194] Dynamic subtest hugepages: SUCCESS (0.972s)
[440.372176] Starting dynamic subtest: memory_region
[443.053850] Dynamic subtest memory_region: SUCCESS (2.690s)
[443.056525] Subtest mock: SUCCESS (40.901s)
[443.084978] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[443.085721] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[443.088997] [061/131] (584s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[449.688563] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[449.690791] Starting dynamic subtest: pipe-A-eDP-1
[450.481573] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[450.490316] Starting dynamic subtest: pipe-B-eDP-1
[451.605629] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[451.609792] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.914s)
[452.840412] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[452.841697] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[452.845775] [062/131] (575s left) gem_render_copy_redux (normal)
[452.919322] Starting subtest: normal
[453.179469] Subtest normal: SUCCESS (0.259s)
[453.349465] [063/131] (574s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[453.408761] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[453.505408] [064/131] (574s left) gem_ctx_param (invalid-set-no-zeromap)
[453.566725] Starting subtest: invalid-set-no-zeromap
[453.568929] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[453.661862] [065/131] (574s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[453.768819] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[463.077131] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.312s)
[463.251364] [066/131] (564s left) i915_pm_rps (reset)
[463.323994] Starting subtest: reset
[471.740783] Subtest reset: SUCCESS (8.421s)
[471.885913] [067/131] (556s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[472.003247] Starting subtest: async-flip-with-page-flip-events-linear
[472.380730] Starting dynamic subtest: pipe-A-eDP-1
[475.107485] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.727s)
[475.470848] Starting dynamic subtest: pipe-B-eDP-1
[478.231581] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[478.604120] Starting dynamic subtest: pipe-C-eDP-1
[481.355481] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[481.714618] Starting dynamic subtest: pipe-D-eDP-1
[484.480453] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[484.483109] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.482s)
[485.711629] [068/131] (542s left) perf_pmu (module-unload)
[485.826271] Starting subtest: module-unload
[492.764348] Subtest module-unload: FAIL (6.828s)
[492.799144] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[492.799933] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[492.803139] [069/131] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[494.426787] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[494.431207] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[494.545651] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[494.546913] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[494.551532] [070/131] (533s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[494.617622] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[494.725420] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[494.826968] [071/131] (533s left) kms_cursor_crc (cursor-random-256x85)
[495.071774] Starting subtest: cursor-random-256x85
[495.125326] Subtest cursor-random-256x85: SKIP (0.049s)
[495.343300] [072/131] (533s left) kms_psr (psr-sprite-plane-move)
[495.439986] Starting subtest: psr-sprite-plane-move
[495.442210] Starting dynamic subtest: eDP-1
[497.163503] Dynamic subtest eDP-1: SUCCESS (1.721s)
[497.165927] Subtest psr-sprite-plane-move: SUCCESS (1.723s)
[498.027439] [073/131] (530s left) kms_psr (fbc-pr-sprite-plane-onoff)
[498.124361] Starting subtest: fbc-pr-sprite-plane-onoff
[498.128724] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[498.222874] [074/131] (530s left) kms_pm_rpm (pm-tiling)
[500.456638] Starting subtest: pm-tiling
[500.462471] Subtest pm-tiling: SKIP (0.000s)
[500.861843] [075/131] (527s left) gem_userptr_blits (invalid-null-pointer)
[500.935813] Starting subtest: invalid-null-pointer
[500.937922] Subtest invalid-null-pointer: SUCCESS (0.001s)
[501.106043] [076/131] (527s left) kms_content_protection (lic-type-1)
[501.248694] Starting subtest: lic-type-1
[501.253404] Subtest lic-type-1: SKIP (0.000s)
[501.417960] [077/131] (527s left) kms_atomic (plane-immutable-zpos)
[501.512961] Starting subtest: plane-immutable-zpos
[501.515520] Starting dynamic subtest: pipe-A-eDP-1
[502.163012] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.647s)
[502.165210] Subtest plane-immutable-zpos: SUCCESS (0.648s)
[502.978606] [078/131] (525s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[503.108264] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[503.112528] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[503.279791] [079/131] (525s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[503.386901] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[503.389070] Starting dynamic subtest: pipe-A
[504.447521] Dynamic subtest pipe-A: SUCCESS (1.062s)
[504.456224] Starting dynamic subtest: pipe-B
[506.587600] Dynamic subtest pipe-B: SUCCESS (2.138s)
[506.598222] Starting dynamic subtest: pipe-C
[507.759673] Dynamic subtest pipe-C: SUCCESS (1.169s)
[507.769133] Starting dynamic subtest: pipe-D
[508.990823] Dynamic subtest pipe-D: SUCCESS (1.230s)
[508.993092] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.604s)
[510.212354] [080/131] (518s left) kms_psr (pr-sprite-mmap-cpu)
[510.306173] Starting subtest: pr-sprite-mmap-cpu
[510.310333] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[510.423012] [081/131] (518s left) gem_ctx_persistence (legacy-engines-cleanup)
[510.484107] Starting subtest: legacy-engines-cleanup
[510.486377] Starting dynamic subtest: render
[510.574448] Dynamic subtest render: SUCCESS (0.089s)
[510.586138] Starting dynamic subtest: bsd1
[510.627185] Dynamic subtest bsd1: SUCCESS (0.050s)
[510.638891] Starting dynamic subtest: bsd2
[510.669611] Dynamic subtest bsd2: SUCCESS (0.040s)
[510.680001] Starting dynamic subtest: blt
[510.720796] Dynamic subtest blt: SUCCESS (0.049s)
[510.731623] Starting dynamic subtest: vebox
[510.790590] Dynamic subtest vebox: SUCCESS (0.066s)
[510.793382] Subtest legacy-engines-cleanup: SUCCESS (0.307s)
[510.896678] [082/131] (518s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[511.006332] Starting subtest: cursor-tearing-framebuffer-change
[511.008627] Starting dynamic subtest: pipe-A-eDP-1
[511.575448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[511.584861] Starting dynamic subtest: pipe-D-eDP-1
[512.804527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[512.807056] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.797s)
[513.669716] [083/131] (515s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[513.802715] Starting subtest: 2x-cursor-vs-flip-atomic
[513.807255] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[513.973824] [084/131] (515s left) kms_cursor_crc (cursor-random-32x10)
[514.140314] Starting subtest: cursor-random-32x10
[514.187314] Subtest cursor-random-32x10: SKIP (0.041s)
[514.460648] [085/131] (514s left) kms_psr (fbc-psr-primary-mmap-gtt)
[514.554213] Starting subtest: fbc-psr-primary-mmap-gtt
[514.556473] Starting dynamic subtest: eDP-1
[514.560735] Dynamic subtest eDP-1: SKIP (0.000s)
[514.564986] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[514.652053] [086/131] (514s left) kms_big_fb (linear-8bpp-rotate-0)
[514.763091] Starting subtest: linear-8bpp-rotate-0
[516.068383] Subtest linear-8bpp-rotate-0: SUCCESS (1.304s)
[516.233960] [087/131] (512s left) gem_create (create-ext-cpu-access-sanity-check)
[516.400578] Starting subtest: create-ext-cpu-access-sanity-check
[516.405345] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[516.497548] [088/131] (512s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[516.601191] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[520.797170] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.198s)
[521.981435] [089/131] (507s left) kms_pm_rpm (cursor-dpms)
[523.503211] Starting subtest: cursor-dpms
[523.508757] Subtest cursor-dpms: SKIP (0.000s)
[524.313800] [090/131] (505s left) gem_lmem_swapping (verify-random-ccs)
[524.367298] Subtest verify-random-ccs: SKIP (0.000s)
[524.411521] [091/131] (504s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[524.541377] Starting subtest: flip-vs-cursor-toggle
[533.189767] Subtest flip-vs-cursor-toggle: SUCCESS (8.646s)
[534.020471] [092/131] (495s left) gem_lmem_swapping (heavy-verify-multi)
[534.064230] Subtest heavy-verify-multi: SKIP (0.000s)
[534.105045] [093/131] (495s left) i915_pm_freq_api (freq-reset)
[534.157493] Starting subtest: freq-reset
[534.159866] Starting dynamic subtest: gt0
[534.354071] Dynamic subtest gt0: SUCCESS (0.195s)
[534.364664] Starting dynamic subtest: gt1
[534.520212] Dynamic subtest gt1: SUCCESS (0.164s)
[534.522884] Subtest freq-reset: SUCCESS (0.361s)
[534.622746] [094/131] (494s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[534.717392] Starting subtest: y-tiled-64bpp-rotate-90
[534.721718] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[534.858176] [095/131] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[534.961529] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[534.965579] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[535.098378] [096/131] (494s left) kms_dirtyfb (default-dirtyfb-ioctl)
[535.202773] Starting subtest: default-dirtyfb-ioctl
[535.204950] Starting dynamic subtest: A-eDP-1
[536.799752] Dynamic subtest A-eDP-1: SUCCESS (1.597s)
[536.802201] Subtest default-dirtyfb-ioctl: SUCCESS (1.598s)
[537.656475] [097/131] (491s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[537.758508] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[537.760885] Starting dynamic subtest: pipe-A
[538.120437] Dynamic subtest pipe-A: SUCCESS (0.364s)
[538.129686] Starting dynamic subtest: pipe-B
[539.534755] Dynamic subtest pipe-B: SUCCESS (1.413s)
[539.544348] Starting dynamic subtest: pipe-C
[540.974591] Dynamic subtest pipe-C: SUCCESS (1.439s)
[540.986928] Starting dynamic subtest: pipe-D
[542.405738] Dynamic subtest pipe-D: SUCCESS (1.430s)
[542.408010] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.651s)
[543.578356] [098/131] (486s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[543.667498] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[543.669859] Starting dynamic subtest: pipe-A-default-mode
[543.983560] Dynamic subtest pipe-A-default-mode: SKIP (0.315s)
[543.988192] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.317s)
[544.835556] [099/131] (484s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[544.959512] Starting subtest: 2x-cursor-vs-flip-legacy
[544.963982] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[545.129574] [100/131] (484s left) gem_readwrite (write-bad-handle)
[545.199801] Subtest write-bad-handle: SKIP (0.000s)
[545.265814] [101/131] (484s left) gem_reg_read (timestamp-monotonic)
[545.329981] Starting subtest: timestamp-monotonic
[549.745053] Subtest timestamp-monotonic: SUCCESS (4.416s)
[549.862705] [102/131] (480s left) kms_psr (fbc-psr2-cursor-plane-move)
[549.961213] Starting subtest: fbc-psr2-cursor-plane-move
[549.963564] Starting dynamic subtest: eDP-1
[549.967966] Dynamic subtest eDP-1: SKIP (0.000s)
[549.972357] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[550.056163] [103/131] (479s left) kms_plane_lowres (tiling-x)
[550.154696] Starting subtest: tiling-x
[550.156877] Starting dynamic subtest: pipe-A-eDP-1
[550.161259] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[550.455615] Starting dynamic subtest: pipe-B-eDP-1
[550.459975] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[550.469102] Starting dynamic subtest: pipe-C-eDP-1
[550.473540] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[550.482849] Starting dynamic subtest: pipe-D-eDP-1
[550.486898] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[550.490965] Subtest tiling-x: SKIP (0.301s)
[551.335449] [104/131] (478s left) kms_force_connector_basic (force-edid)
[551.421453] Starting subtest: force-edid
[551.789083] Subtest force-edid: SUCCESS (0.368s)
[551.954534] [105/131] (478s left) kms_getfb (getfb-handle-zero)
[552.055090] Starting subtest: getfb-handle-zero
[552.057438] Subtest getfb-handle-zero: SUCCESS (0.000s)
[552.193243] [106/131] (477s left) perf (missing-sample-flags)
[552.327927] Starting subtest: missing-sample-flags
[552.329974] Subtest missing-sample-flags: SUCCESS (0.000s)
[552.371736] [107/131] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[552.472481] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[559.075324] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.604s)
[559.247813] [108/131] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[559.351650] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[559.356106] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[559.496408] [109/131] (470s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[559.604560] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[559.608974] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[559.748675] [110/131] (470s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[559.850342] Starting subtest: 4-tiled-8bpp-rotate-180
[561.063592] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[561.221541] [111/131] (469s left) gem_exec_fence (syncobj-timeline-repeat)
[561.783160] Starting subtest: syncobj-timeline-repeat
[562.011253] Subtest syncobj-timeline-repeat: SUCCESS (0.228s)
[563.403538] [112/131] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[563.506870] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[570.763235] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.260s)
[570.934907] [113/131] (459s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[570.990285] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[570.992600] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[571.139942] [114/131] (459s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[571.236973] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[574.889175] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.657s)
[576.064929] [115/131] (454s left) gem_exec_schedule (lateslice)
[576.143340] Starting subtest: lateslice
[576.145503] Starting dynamic subtest: rcs0
[576.155354] Dynamic subtest rcs0: SUCCESS (0.022s)
[576.164926] Starting dynamic subtest: bcs0
[576.175474] Dynamic subtest bcs0: SUCCESS (0.019s)
[576.184918] Starting dynamic subtest: vcs0
[576.194873] Dynamic subtest vcs0: SUCCESS (0.018s)
[576.205390] Starting dynamic subtest: vcs1
[576.212386] Dynamic subtest vcs1: SUCCESS (0.017s)
[576.221488] Starting dynamic subtest: vecs0
[576.229926] Dynamic subtest vecs0: SUCCESS (0.017s)
[576.239717] Starting dynamic subtest: ccs0
[576.247397] Dynamic subtest ccs0: SUCCESS (0.017s)
[576.249643] Subtest lateslice: SUCCESS (0.115s)
[577.348599] [116/131] (453s left) kms_vblank (query-idle-hang)
[577.453127] Starting subtest: query-idle-hang
[577.455494] Starting dynamic subtest: pipe-A-eDP-1
[604.062949] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.611s)
[604.076870] Starting dynamic subtest: pipe-D-eDP-1
[619.047046] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[619.049335] Subtest query-idle-hang: SUCCESS (41.598s)
[619.942673] [117/131] (410s left) syncobj_wait (reset-multiple-signaled)
[620.017197] Starting subtest: reset-multiple-signaled
[620.019558] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[620.157209] [118/131] (410s left) kms_flip_event_leak (basic)
[620.244793] Starting subtest: basic
[620.247204] Starting dynamic subtest: pipe-A-eDP-1
[620.663591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[620.673422] Starting dynamic subtest: pipe-B-eDP-1
[621.801377] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[621.811659] Starting dynamic subtest: pipe-C-eDP-1
[622.893850] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.091s)
[622.904500] Starting dynamic subtest: pipe-D-eDP-1
[623.996485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[623.998362] Subtest basic: SUCCESS (3.750s)
[624.845267] [119/131] (405s left) gem_pwrite_snooped
[624.999025] [120/131] (405s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[625.076305] Starting subtest: yf-tiled-ccs-to-y-tiled
[625.080821] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[625.282789] [121/131] (405s left) gem_ctx_shared (q-independent)
[625.343464] Starting subtest: Q-independent
[625.345857] Starting dynamic subtest: rcs0
[625.411788] Dynamic subtest rcs0: SUCCESS (0.067s)
[625.424965] Starting dynamic subtest: vcs0
[625.451013] Dynamic subtest vcs0: SUCCESS (0.039s)
[625.463097] Starting dynamic subtest: vcs1
[625.488172] Dynamic subtest vcs1: SUCCESS (0.037s)
[625.500488] Starting dynamic subtest: vecs0
[625.525585] Dynamic subtest vecs0: SUCCESS (0.037s)
[625.537863] Starting dynamic subtest: ccs0
[625.575695] Dynamic subtest ccs0: SUCCESS (0.049s)
[625.578124] Subtest Q-independent: SUCCESS (0.233s)
[627.430260] [122/131] (403s left) prime_mmap (test_userptr)
[627.499349] Starting subtest: test_userptr
[627.501874] Starting dynamic subtest: test_userptr-smem
[627.504124] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[627.506408] Subtest test_userptr: SUCCESS (0.001s)
[627.645939] [123/131] (403s left) kms_addfb_basic (bad-pitch-65536)
[627.710691] Starting subtest: bad-pitch-65536
[627.712976] Subtest bad-pitch-65536: SUCCESS (0.000s)
[627.892545] [124/131] (402s left) prime_self_import (basic-with_fd_dup)
[627.930324] Starting subtest: basic-with_fd_dup
[627.958309] Subtest basic-with_fd_dup: SUCCESS (0.028s)
[628.127034] [125/131] (402s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[628.231365] Starting subtest: primary-y-tiled-reflect-x-0
[628.291183] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[628.416876] [126/131] (402s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[628.511031] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[628.513087] Starting dynamic subtest: pipe-A-eDP-1
[628.531774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[628.543188] Starting dynamic subtest: pipe-B-eDP-1
[628.559944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[628.568829] Starting dynamic subtest: pipe-C-eDP-1
[628.586269] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[628.594536] Starting dynamic subtest: pipe-D-eDP-1
[628.612049] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[628.615542] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[630.746263] [127/131] (400s left) kms_addfb_basic (unused-modifier)
[630.807821] Starting subtest: unused-modifier
[630.810209] Subtest unused-modifier: SUCCESS (0.000s)
[630.982795] [128/131] (400s left) kms_vblank (wait-idle)
[631.085936] Starting subtest: wait-idle
[631.088225] Starting dynamic subtest: pipe-A-eDP-1
[632.839194] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[632.853741] Starting dynamic subtest: pipe-D-eDP-1
[635.318957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.477s)
[635.321229] Subtest wait-idle: SUCCESS (4.233s)
[636.151877] [129/131] (394s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[636.276615] Starting subtest: cursorA-vs-flipA-toggle
[647.399350] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.126s)
[648.239625] [130/131] (382s left) gen9_exec_parse (bb-start-far)
[648.304721] Subtest bb-start-far: SKIP (0.000s)
[648.387672] [131/131] (382s left) kms_addfb_basic (basic)
[648.450226] Starting subtest: basic
[648.452600] Subtest basic: SUCCESS (0.000s)
[648.641579] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: tools_test
results: parsing output: 2/ for test: kms_psr2_su
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_pipe_stress
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_userptr_blits
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: core_getstats
results: parsing output: 25/ for test: core_getclient
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: gem_mmap_offset
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_legacy_colorkey
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_tiled_wb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: gem_ctx_param
results: parsing output: 44/ for test: kms_color_pipeline
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_feature_discovery
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_pxp
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: fbdev
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_selftest
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_render_copy_redux
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_pm_rpm
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_atomic
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: gem_lmem_swapping
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_lmem_swapping
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_dirtyfb
results: parsing output: 96/ for test: kms_plane_scaling
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_readwrite
results: parsing output: 100/ for test: gem_reg_read
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_lowres
results: parsing output: 103/ for test: kms_force_connector_basic
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: kms_flip_event_leak
results: parsing output: 118/ for test: gem_pwrite_snooped
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: prime_self_import
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: gen9_exec_parse
results: parsing output: 130/ for test: kms_addfb_basic
Done.