[57.312285] Initializing watchdogs
[57.312417]   /dev/watchdog0
[57.331173] [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.335533] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.337819] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.341036] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.411860] Starting subtest: invalid-bad-pad
[57.414182] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.546046] [002/131] (960s left) tools_test (tools_test)
[57.597727] Starting subtest: tools_test
[57.648632] Subtest tools_test: SUCCESS (0.063s)
[57.733814] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[57.791982] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[57.853562] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[57.917643] Starting subtest: sync-unmap-cycles
[63.286562] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[63.433117] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.531644] Starting subtest: stress-xrgb8888-ytiled
[63.535448] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.623856] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[63.710187] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[63.712146] Starting dynamic subtest: pipe-A-eDP-1
[80.404897] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.216s)
[80.414058] Starting dynamic subtest: pipe-B-eDP-1
[98.385095] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.845s)
[98.392722] Starting dynamic subtest: pipe-C-eDP-1
[116.325253] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.786s)
[116.337183] Starting dynamic subtest: pipe-D-eDP-1
[134.336402] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.790s)
[134.338327] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (14.642s)
[145.616298] [007/131] (882s left) api_intel_allocator (gem-pool)
[145.695875] Starting subtest: gem-pool
[145.716140] Subtest gem-pool: SUCCESS (0.021s)
[145.843667] [008/131] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[145.957026] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[152.567826] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.610s)
[152.716862] [009/131] (875s left) kms_atomic_interruptible (universal-setplane-primary)
[152.825428] Starting subtest: universal-setplane-primary
[152.827821] Starting dynamic subtest: pipe-A-eDP-1
[160.258482] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.431s)
[160.260898] Subtest universal-setplane-primary: SUCCESS (7.432s)
[161.123730] [010/131] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[161.222218] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[165.502862] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.283s)
[166.733670] [011/131] (861s left) gem_eio (in-flight-contexts-1us)
[166.949729] Starting subtest: in-flight-contexts-1us
[178.910639] Subtest in-flight-contexts-1us: SUCCESS (11.959s)
[179.120428] [012/131] (849s left) gem_exec_balancer (semaphore)
[179.189036] Starting subtest: semaphore
[180.888067] Subtest semaphore: SUCCESS (1.697s)
[181.249864] [013/131] (847s left) kms_chamelium_hpd (hdmi-hpd)
[181.627193] Subtest hdmi-hpd: SKIP (0.000s)
[182.401663] [014/131] (845s left) kms_flip (wf_vblank-ts-check)
[182.524644] Starting subtest: wf_vblank-ts-check
[182.529511] Starting dynamic subtest: A-eDP1
[191.470040] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[191.480146] Starting dynamic subtest: B-eDP1
[200.402153] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[200.411871] Starting dynamic subtest: C-eDP1
[209.319508] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[209.329215] Starting dynamic subtest: D-eDP1
[218.243840] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[218.249810] Subtest wf_vblank-ts-check: SUCCESS (35.726s)
[219.491708] [015/131] (808s left) gem_exec_reloc (basic-gtt)
[219.557447] Subtest basic-gtt: SKIP (0.000s)
[219.617867] [016/131] (808s left) gem_exec_schedule (reorder-wide)
[219.807580] Subtest reorder-wide: SKIP (0.000s)
[220.012414] [017/131] (808s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[220.101948] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[220.104227] Starting dynamic subtest: pipe-A-eDP-1
[220.126125] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[220.136396] Starting dynamic subtest: pipe-B-eDP-1
[220.158062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.167638] Starting dynamic subtest: pipe-C-eDP-1
[220.188395] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.196077] Starting dynamic subtest: pipe-D-eDP-1
[220.217545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.221919] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[222.356587] [018/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[222.461985] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[222.466272] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[222.581613] [019/131] (805s left) perf (polling)
[222.722629] Starting subtest: polling
[222.724713] Starting dynamic subtest: 0-rcs0
[232.734466] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[232.742635] Starting dynamic subtest: 1-vecs0
[242.756041] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[242.758364] Subtest polling: SUCCESS (20.033s)
[242.801310] [020/131] (785s left) gem_userptr_blits (probe)
[242.883475] Starting subtest: probe
[242.961630] Subtest probe: SUCCESS (0.078s)
[243.138660] [021/131] (785s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[243.248977] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[243.253479] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[243.374667] [022/131] (785s left) gem_mmap_offset (pf-nonblock)
[243.437871] Starting subtest: pf-nonblock
[243.442912] Subtest pf-nonblock: SUCCESS (0.006s)
[243.608003] [023/131] (785s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[243.717669] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[243.719985] Starting dynamic subtest: pipe-A-eDP-1
[243.744940] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[243.755196] Starting dynamic subtest: pipe-B-eDP-1
[243.776010] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[243.784434] Starting dynamic subtest: pipe-C-eDP-1
[243.803973] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[243.812331] Starting dynamic subtest: pipe-D-eDP-1
[243.832067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[243.835415] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[245.934195] [024/131] (782s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[246.040160] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[246.044794] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[246.182062] [025/131] (782s left) core_getstats (basic)
[246.247367] Starting subtest: basic
[246.249641] Subtest basic: SUCCESS (0.000s)
[246.393579] [026/131] (782s left) core_getclient (basic)
[246.445935] Starting subtest: basic
[246.448337] Subtest basic: SUCCESS (0.000s)
[246.592477] [027/131] (782s left) syncobj_timeline (multi-wait-all-available-submitted)
[246.650931] Starting subtest: multi-wait-all-available-submitted
[246.652871] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[246.785005] [028/131] (782s left) gem_exec_reloc (basic-write-wc)
[246.849770] Subtest basic-write-wc: SKIP (0.000s)
[246.931564] [029/131] (782s left) kms_invalid_mode (clock-too-high)
[247.042171] Starting subtest: clock-too-high
[247.044224] Starting dynamic subtest: pipe-A-eDP-1
[247.048308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.061363] Starting dynamic subtest: pipe-B-eDP-1
[247.064766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.072794] Starting dynamic subtest: pipe-C-eDP-1
[247.076389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.084010] Starting dynamic subtest: pipe-D-eDP-1
[247.087720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.091362] Subtest clock-too-high: SKIP (0.008s)
[247.138706] [030/131] (781s left) gem_mmap_offset (bad-object)
[247.205924] Starting subtest: bad-object
[247.208074] Subtest bad-object: SUCCESS (0.001s)
[247.342906] [031/131] (781s left) syncobj_timeline (wait-all-delayed-signal)
[247.398030] Starting subtest: wait-all-delayed-signal
[247.500465] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[247.597391] [032/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[247.713663] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[248.382204] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[248.566446] [033/131] (780s left) gem_exec_suspend (basic-s3)
[248.636931] Starting subtest: basic-S3
[248.638961] Starting dynamic subtest: smem
[268.672495] Dynamic subtest smem: SUCCESS (6.215s)
[268.675418] Subtest basic-S3: SUCCESS (6.217s)
[272.888442] [034/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[273.030397] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[273.035377] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[273.140456] [035/131] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[273.243960] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[273.248959] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[273.348863] [036/131] (759s left) kms_chamelium_frames (hdmi-crc-multiple)
[273.727792] Subtest hdmi-crc-multiple: SKIP (0.000s)
[274.573883] [037/131] (758s left) gem_exec_fence (syncobj-import)
[275.066667] Starting subtest: syncobj-import
[275.069388] Subtest syncobj-import: SUCCESS (0.006s)
[276.823286] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[276.826888] [038/131] (756s left) kms_legacy_colorkey (basic)
[276.937230] Starting subtest: basic
[276.939930] Starting dynamic subtest: pipe-A
[276.982994] Dynamic subtest pipe-A: SUCCESS (0.045s)
[276.994174] Starting dynamic subtest: pipe-B
[276.996960] Dynamic subtest pipe-B: SUCCESS (0.000s)
[277.005930] Starting dynamic subtest: pipe-C
[277.008140] Dynamic subtest pipe-C: SUCCESS (0.000s)
[277.016477] Starting dynamic subtest: pipe-D
[277.018632] Dynamic subtest pipe-D: SUCCESS (0.000s)
[277.020870] Subtest basic: SUCCESS (0.049s)
[277.076419] [039/131] (756s left) gem_softpin (allocator-nopin-reserve)
[277.152007] Starting subtest: allocator-nopin-reserve
[277.258181] Subtest allocator-nopin-reserve: SUCCESS (0.105s)
[277.432047] [040/131] (756s left) perf_pmu (enable-race)
[277.476998] Starting subtest: enable-race
[277.479997] Starting dynamic subtest: rcs0
[290.239019] Dynamic subtest rcs0: SUCCESS (12.761s)
[290.250816] Starting dynamic subtest: bcs0
[302.979786] Dynamic subtest bcs0: SUCCESS (12.738s)
[302.989020] Starting dynamic subtest: vcs0
[318.721888] Dynamic subtest vcs0: SUCCESS (15.739s)
[318.732923] Starting dynamic subtest: vcs1
[334.721016] Dynamic subtest vcs1: SUCCESS (15.996s)
[334.731310] Starting dynamic subtest: vecs0
[350.720429] Dynamic subtest vecs0: SUCCESS (15.997s)
[350.730767] Starting dynamic subtest: ccs0
[363.464897] Dynamic subtest ccs0: SUCCESS (12.742s)
[363.467710] Subtest enable-race: SUCCESS (85.983s)
[363.601978] [041/131] (669s left) syncobj_timeline (signal-point-0)
[363.658485] Starting subtest: signal-point-0
[363.661212] Subtest signal-point-0: SUCCESS (0.000s)
[363.770871] [042/131] (669s left) gem_tiled_wb
[363.902189] [043/131] (669s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[364.003638] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[364.006096] Starting dynamic subtest: pipe-A-eDP-1
[364.033130] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.042019] Starting dynamic subtest: pipe-B-eDP-1
[364.070889] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.079705] Starting dynamic subtest: pipe-C-eDP-1
[364.108134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.116992] Starting dynamic subtest: pipe-D-eDP-1
[364.145884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.150978] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[366.194602] [044/131] (667s left) gem_ctx_param (set-priority-invalid-size)
[366.254657] Starting subtest: set-priority-invalid-size
[366.257433] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[366.353708] [045/131] (667s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[366.455893] Starting subtest: plane-ctm3x4-lut1d
[366.469110] Starting dynamic subtest: pipe-A-eDP-1
[367.248983] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[367.856054] Starting dynamic subtest: pipe-B-eDP-1
[368.779905] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[369.187460] Starting dynamic subtest: pipe-C-eDP-1
[370.172450] Dynamic subtest pipe-C-eDP-1: FAIL (0.290s)
[370.527776] Starting dynamic subtest: pipe-D-eDP-1
[371.463766] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[371.466628] Subtest plane-ctm3x4-lut1d: FAIL (4.608s)
[371.925741] [046/131] (661s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[372.049760] Starting subtest: 2x-long-cursor-vs-flip-atomic
[372.054865] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[372.217302] [047/131] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[372.326345] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[372.331297] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[372.465254] [048/131] (661s left) kms_feature_discovery (display-1x)
[372.566658] Starting subtest: display-1x
[372.569093] Subtest display-1x: SUCCESS (0.000s)
[372.673127] [049/131] (661s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[372.766948] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[372.771149] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[372.885171] [050/131] (660s left) i915_drm_fdinfo (most-busy-idle-check-all)
[372.925915] Starting subtest: most-busy-idle-check-all
[372.928147] Starting dynamic subtest: rcs0
[372.935761] Dynamic subtest rcs0: SKIP (0.007s)
[372.945649] Starting dynamic subtest: bcs0
[372.949826] Dynamic subtest bcs0: SKIP (0.000s)
[372.958656] Starting dynamic subtest: vcs0
[372.962841] Dynamic subtest vcs0: SKIP (0.000s)
[372.971341] Starting dynamic subtest: vcs1
[372.975394] Dynamic subtest vcs1: SKIP (0.000s)
[372.983951] Starting dynamic subtest: vecs0
[372.987774] Dynamic subtest vecs0: SKIP (0.001s)
[372.995542] Starting dynamic subtest: ccs0
[372.999069] Dynamic subtest ccs0: SKIP (0.001s)
[373.002400] Subtest most-busy-idle-check-all: SKIP (0.015s)
[373.037669] [051/131] (660s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[373.166216] Starting subtest: x-tiled-32bpp-rotate-270
[373.186410] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[373.325940] [052/131] (660s left) gem_exec_schedule (u-submit-early-slice)
[373.398846] Starting subtest: u-submit-early-slice
[373.400954] Starting dynamic subtest: rcs0
[373.448361] Dynamic subtest rcs0: SUCCESS (0.049s)
[373.458642] Starting dynamic subtest: bcs0
[373.485310] Dynamic subtest bcs0: SUCCESS (0.037s)
[373.493770] Starting dynamic subtest: vcs0
[373.526135] Dynamic subtest vcs0: SUCCESS (0.040s)
[373.537485] Starting dynamic subtest: vcs1
[373.566009] Dynamic subtest vcs1: SUCCESS (0.039s)
[373.574693] Starting dynamic subtest: vecs0
[373.614878] Dynamic subtest vecs0: SUCCESS (0.048s)
[373.624339] Starting dynamic subtest: ccs0
[373.651553] Dynamic subtest ccs0: SUCCESS (0.035s)
[373.653988] Subtest u-submit-early-slice: SUCCESS (0.253s)
[374.861157] [053/131] (659s left) gem_pxp (regular-baseline-src-copy-readible)
[374.991918] Starting subtest: regular-baseline-src-copy-readible
[375.050411] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[375.208904] [054/131] (658s left) gem_exec_balancer (full-late-pulse)
[375.279081] Starting subtest: full-late-pulse
[379.595643] Subtest full-late-pulse: SUCCESS (4.316s)
[379.959640] [055/131] (654s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[380.053978] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[380.058933] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[380.169347] [056/131] (653s left) fbdev (read)
[380.228195] Starting subtest: read
[380.755888] Subtest read: SUCCESS (0.528s)
[380.845863] [057/131] (653s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[380.943282] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[380.948847] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[381.071434] [058/131] (653s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[381.165669] Starting subtest: multiplane-rotation-cropping-top
[398.651143] Subtest multiplane-rotation-cropping-top: SUCCESS (17.485s)
[398.798441] [059/131] (635s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[398.895422] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[405.866662] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.971s)
[406.027021] [060/131] (628s left) i915_selftest (mock)
[409.589758] Starting subtest: mock
[409.592630] Starting dynamic subtest: sanitycheck
[411.627502] Dynamic subtest sanitycheck: SUCCESS (2.037s)
[411.637460] Starting dynamic subtest: shmem
[413.716558] Dynamic subtest shmem: SUCCESS (2.087s)
[413.726727] Starting dynamic subtest: fence
[422.915794] Dynamic subtest fence: SUCCESS (9.197s)
[422.927062] Starting dynamic subtest: scatterlist
[425.993099] Dynamic subtest scatterlist: SUCCESS (3.076s)
[426.002922] Starting dynamic subtest: syncmap
[430.674564] Dynamic subtest syncmap: SUCCESS (4.679s)
[430.684905] Starting dynamic subtest: uncore
[432.660390] Dynamic subtest uncore: SUCCESS (1.983s)
[432.670519] Starting dynamic subtest: ring
[434.660444] Dynamic subtest ring: SUCCESS (1.998s)
[434.670471] Starting dynamic subtest: engine
[436.702170] Dynamic subtest engine: SUCCESS (2.039s)
[436.712510] Starting dynamic subtest: timelines
[441.900483] Dynamic subtest timelines: SUCCESS (5.196s)
[441.909157] Starting dynamic subtest: requests
[446.545927] Dynamic subtest requests: SUCCESS (4.643s)
[446.555096] Starting dynamic subtest: objects
[448.739517] Dynamic subtest objects: SUCCESS (2.191s)
[448.748638] Starting dynamic subtest: phys
[450.911051] Dynamic subtest phys: SUCCESS (2.169s)
[450.921385] Starting dynamic subtest: dmabuf
[453.160136] Dynamic subtest dmabuf: SUCCESS (2.247s)
[453.169976] Starting dynamic subtest: vma
[459.809522] Dynamic subtest vma: SUCCESS (6.647s)
[459.819267] Starting dynamic subtest: evict
[462.557752] Dynamic subtest evict: SUCCESS (2.746s)
[462.567716] Starting dynamic subtest: gtt
[467.136041] Dynamic subtest gtt: SUCCESS (4.577s)
[467.151525] Starting dynamic subtest: hugepages
[469.501475] Dynamic subtest hugepages: SUCCESS (2.363s)
[469.511470] Starting dynamic subtest: memory_region
[473.481464] Dynamic subtest memory_region: SUCCESS (3.978s)
[473.484814] Subtest mock: SUCCESS (63.889s)
[473.517090] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[473.517768] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[473.521361] [061/131] (560s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[481.454956] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[481.457920] Starting dynamic subtest: pipe-A-eDP-1
[482.257137] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[482.266801] Starting dynamic subtest: pipe-B-eDP-1
[483.387399] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[483.392492] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.930s)
[484.605046] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[484.606262] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[484.610283] [062/131] (549s left) gem_render_copy_redux (normal)
[484.697058] Starting subtest: normal
[484.977199] Subtest normal: SUCCESS (0.279s)
[485.142125] [063/131] (549s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[485.203057] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[485.268396] [064/131] (549s left) gem_ctx_param (invalid-set-no-zeromap)
[485.321935] Starting subtest: invalid-set-no-zeromap
[485.324993] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[485.419994] [065/131] (549s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[485.522778] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[494.854992] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.333s)
[495.015976] [066/131] (539s left) i915_pm_rps (reset)
[495.086201] Starting subtest: reset
[503.530589] Subtest reset: SUCCESS (8.443s)
[503.680351] [067/131] (530s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[503.785937] Starting subtest: async-flip-with-page-flip-events-linear
[504.157138] Starting dynamic subtest: pipe-A-eDP-1
[506.961294] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s)
[507.340467] Starting dynamic subtest: pipe-B-eDP-1
[510.097780] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[510.470146] Starting dynamic subtest: pipe-C-eDP-1
[513.235228] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[513.628568] Starting dynamic subtest: pipe-D-eDP-1
[516.371041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.748s)
[516.374138] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.585s)
[517.588036] [068/131] (517s left) perf_pmu (module-unload)
[517.686772] Starting subtest: module-unload
[524.291011] Subtest module-unload: FAIL (6.471s)
[524.323401] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[524.324077] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[524.327362] [069/131] (510s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[527.288001] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[527.293258] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[527.388870] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[527.390057] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[527.393963] [070/131] (507s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[527.466711] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[527.572972] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[527.673937] [071/131] (507s left) kms_cursor_crc (cursor-random-256x85)
[527.929809] Starting subtest: cursor-random-256x85
[527.988294] Subtest cursor-random-256x85: SKIP (0.046s)
[528.214835] [072/131] (506s left) kms_psr (psr-sprite-plane-move)
[528.310880] Starting subtest: psr-sprite-plane-move
[528.313496] Starting dynamic subtest: eDP-1
[530.119905] Dynamic subtest eDP-1: SUCCESS (1.810s)
[530.122675] Subtest psr-sprite-plane-move: SUCCESS (1.811s)
[530.968403] [073/131] (503s left) kms_psr (fbc-pr-sprite-plane-onoff)
[531.079936] Starting subtest: fbc-pr-sprite-plane-onoff
[531.084956] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[531.177892] [074/131] (503s left) kms_pm_rpm (pm-tiling)
[532.906501] Starting subtest: pm-tiling
[532.912288] Subtest pm-tiling: SKIP (0.000s)
[533.511110] [075/131] (501s left) gem_userptr_blits (invalid-null-pointer)
[533.586388] Starting subtest: invalid-null-pointer
[533.589123] Subtest invalid-null-pointer: SUCCESS (0.001s)
[533.749863] [076/131] (501s left) kms_content_protection (lic-type-1)
[533.904044] Starting subtest: lic-type-1
[533.909187] Subtest lic-type-1: SKIP (0.000s)
[534.077141] [077/131] (500s left) kms_atomic (plane-immutable-zpos)
[534.173668] Starting subtest: plane-immutable-zpos
[534.175984] Starting dynamic subtest: pipe-A-eDP-1
[534.800196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s)
[534.802895] Subtest plane-immutable-zpos: SUCCESS (0.629s)
[535.634658] [078/131] (499s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[535.759595] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[535.764422] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[535.926656] [079/131] (499s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[536.024282] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[536.027159] Starting dynamic subtest: pipe-A
[537.093601] Dynamic subtest pipe-A: SUCCESS (1.072s)
[537.103485] Starting dynamic subtest: pipe-B
[539.222157] Dynamic subtest pipe-B: SUCCESS (2.127s)
[539.236347] Starting dynamic subtest: pipe-C
[540.417141] Dynamic subtest pipe-C: SUCCESS (1.192s)
[540.425737] Starting dynamic subtest: pipe-D
[541.652022] Dynamic subtest pipe-D: SUCCESS (1.235s)
[541.654731] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.631s)
[542.868514] [080/131] (492s left) kms_psr (pr-sprite-mmap-cpu)
[542.976137] Starting subtest: pr-sprite-mmap-cpu
[542.988382] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[543.073532] [081/131] (492s left) gem_ctx_persistence (legacy-engines-cleanup)
[543.130684] Starting subtest: legacy-engines-cleanup
[543.133310] Starting dynamic subtest: render
[543.223473] Dynamic subtest render: SUCCESS (0.096s)
[543.236429] Starting dynamic subtest: bsd1
[543.299452] Dynamic subtest bsd1: SUCCESS (0.073s)
[543.312490] Starting dynamic subtest: bsd2
[543.329172] Dynamic subtest bsd2: SUCCESS (0.028s)
[543.337761] Starting dynamic subtest: blt
[543.417935] Dynamic subtest blt: SUCCESS (0.087s)
[543.429438] Starting dynamic subtest: vebox
[543.464532] Dynamic subtest vebox: SUCCESS (0.044s)
[543.467290] Subtest legacy-engines-cleanup: SUCCESS (0.338s)
[543.573461] [082/131] (491s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[543.687921] Starting subtest: cursor-tearing-framebuffer-change
[543.690292] Starting dynamic subtest: pipe-A-eDP-1
[544.250309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[544.259536] Starting dynamic subtest: pipe-D-eDP-1
[545.475177] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[545.477898] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.785s)
[546.334443] [083/131] (488s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[546.468887] Starting subtest: 2x-cursor-vs-flip-atomic
[546.474129] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[546.637958] [084/131] (488s left) kms_cursor_crc (cursor-random-32x10)
[546.813671] Starting subtest: cursor-random-32x10
[546.857835] Subtest cursor-random-32x10: SKIP (0.040s)
[547.163795] [085/131] (488s left) kms_psr (fbc-psr-primary-mmap-gtt)
[547.265541] Starting subtest: fbc-psr-primary-mmap-gtt
[547.267896] Starting dynamic subtest: eDP-1
[547.273062] Dynamic subtest eDP-1: SKIP (0.000s)
[547.277956] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[547.404852] [086/131] (488s left) kms_big_fb (linear-8bpp-rotate-0)
[547.519517] Starting subtest: linear-8bpp-rotate-0
[548.845807] Subtest linear-8bpp-rotate-0: SUCCESS (1.325s)
[548.994753] [087/131] (486s left) gem_create (create-ext-cpu-access-sanity-check)
[549.178127] Starting subtest: create-ext-cpu-access-sanity-check
[549.183770] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[549.279006] [088/131] (486s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[549.391598] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[553.603518] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.216s)
[554.749168] [089/131] (480s left) kms_pm_rpm (cursor-dpms)
[556.796539] Starting subtest: cursor-dpms
[556.802952] Subtest cursor-dpms: SKIP (0.000s)
[557.221485] [090/131] (478s left) gem_lmem_swapping (verify-random-ccs)
[557.265057] Subtest verify-random-ccs: SKIP (0.000s)
[557.314816] [091/131] (478s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[557.448920] Starting subtest: flip-vs-cursor-toggle
[566.010031] Subtest flip-vs-cursor-toggle: SUCCESS (8.558s)
[566.843455] [092/131] (468s left) gem_lmem_swapping (heavy-verify-multi)
[566.902586] Subtest heavy-verify-multi: SKIP (0.000s)
[566.951234] [093/131] (468s left) i915_pm_freq_api (freq-reset)
[567.016700] Starting subtest: freq-reset
[567.018810] Starting dynamic subtest: gt0
[567.215072] Dynamic subtest gt0: SUCCESS (0.198s)
[567.223980] Starting dynamic subtest: gt1
[567.379869] Dynamic subtest gt1: SUCCESS (0.165s)
[567.382581] Subtest freq-reset: SUCCESS (0.366s)
[567.483686] [094/131] (468s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[567.581624] Starting subtest: y-tiled-64bpp-rotate-90
[567.586538] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[567.720116] [095/131] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[567.824088] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[567.829190] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[567.953463] [096/131] (467s left) kms_dirtyfb (default-dirtyfb-ioctl)
[568.063539] Starting subtest: default-dirtyfb-ioctl
[568.066172] Starting dynamic subtest: A-eDP-1
[569.640045] Dynamic subtest A-eDP-1: SUCCESS (1.576s)
[569.643123] Subtest default-dirtyfb-ioctl: SUCCESS (1.578s)
[570.481546] [097/131] (465s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[570.588175] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[570.590708] Starting dynamic subtest: pipe-A
[570.984681] Dynamic subtest pipe-A: SUCCESS (0.398s)
[571.000831] Starting dynamic subtest: pipe-B
[572.425180] Dynamic subtest pipe-B: SUCCESS (1.438s)
[572.434190] Starting dynamic subtest: pipe-C
[573.822940] Dynamic subtest pipe-C: SUCCESS (1.396s)
[573.834217] Starting dynamic subtest: pipe-D
[575.231918] Dynamic subtest pipe-D: SUCCESS (1.408s)
[575.234358] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.646s)
[576.431397] [098/131] (459s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[576.520715] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[576.522946] Starting dynamic subtest: pipe-A-default-mode
[576.847132] Dynamic subtest pipe-A-default-mode: SKIP (0.325s)
[576.852186] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.326s)
[577.653792] [099/131] (458s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[577.779145] Starting subtest: 2x-cursor-vs-flip-legacy
[577.783987] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[577.950007] [100/131] (458s left) gem_readwrite (write-bad-handle)
[578.009612] Subtest write-bad-handle: SKIP (0.000s)
[578.076411] [101/131] (458s left) gem_reg_read (timestamp-monotonic)
[578.138589] Starting subtest: timestamp-monotonic
[582.238018] Subtest timestamp-monotonic: SUCCESS (4.101s)
[582.337690] [102/131] (453s left) kms_psr (fbc-psr2-cursor-plane-move)
[582.438158] Starting subtest: fbc-psr2-cursor-plane-move
[582.440785] Starting dynamic subtest: eDP-1
[582.445843] Dynamic subtest eDP-1: SKIP (0.000s)
[582.450876] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[582.536771] [103/131] (453s left) kms_plane_lowres (tiling-x)
[582.632508] Starting subtest: tiling-x
[582.634706] Starting dynamic subtest: pipe-A-eDP-1
[582.638960] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[582.922754] Starting dynamic subtest: pipe-B-eDP-1
[582.927734] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[582.936847] Starting dynamic subtest: pipe-C-eDP-1
[582.941834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[582.952300] Starting dynamic subtest: pipe-D-eDP-1
[582.956719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[582.961410] Subtest tiling-x: SKIP (0.289s)
[583.770625] [104/131] (452s left) kms_force_connector_basic (force-edid)
[583.861679] Starting subtest: force-edid
[584.227908] Subtest force-edid: SUCCESS (0.369s)
[584.395347] [105/131] (451s left) kms_getfb (getfb-handle-zero)
[584.499697] Starting subtest: getfb-handle-zero
[584.502169] Subtest getfb-handle-zero: SUCCESS (0.000s)
[584.631918] [106/131] (451s left) perf (missing-sample-flags)
[584.775556] Starting subtest: missing-sample-flags
[584.777906] Subtest missing-sample-flags: SUCCESS (0.000s)
[584.821675] [107/131] (451s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[584.916936] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[591.597065] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.680s)
[591.767233] [108/131] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[591.872976] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[591.877962] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[591.996602] [109/131] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[592.095643] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[592.100606] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[592.209676] [110/131] (444s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[592.307138] Starting subtest: 4-tiled-8bpp-rotate-180
[593.554837] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[593.725078] [111/131] (442s left) gem_exec_fence (syncobj-timeline-repeat)
[594.292091] Starting subtest: syncobj-timeline-repeat
[594.518802] Subtest syncobj-timeline-repeat: SUCCESS (0.227s)
[595.782060] [112/131] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[595.896021] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[603.110941] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.217s)
[603.295912] [113/131] (433s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[603.352319] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[603.355067] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[603.492492] [114/131] (433s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[603.599689] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[607.293693] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.698s)
[608.507645] [115/131] (428s left) gem_exec_schedule (lateslice)
[608.584642] Starting subtest: lateslice
[608.586806] Starting dynamic subtest: rcs0
[608.594887] Dynamic subtest rcs0: SUCCESS (0.021s)
[608.603859] Starting dynamic subtest: bcs0
[608.612618] Dynamic subtest bcs0: SUCCESS (0.017s)
[608.621676] Starting dynamic subtest: vcs0
[608.631907] Dynamic subtest vcs0: SUCCESS (0.019s)
[608.640602] Starting dynamic subtest: vcs1
[608.651632] Dynamic subtest vcs1: SUCCESS (0.019s)
[608.660474] Starting dynamic subtest: vecs0
[608.671760] Dynamic subtest vecs0: SUCCESS (0.020s)
[608.680714] Starting dynamic subtest: ccs0
[608.689735] Dynamic subtest ccs0: SUCCESS (0.017s)
[608.692330] Subtest lateslice: SUCCESS (0.116s)
[609.868514] [116/131] (426s left) kms_vblank (query-idle-hang)
[609.966992] Starting subtest: query-idle-hang
[609.969379] Starting dynamic subtest: pipe-A-eDP-1
[636.492005] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.521s)
[636.507818] Starting dynamic subtest: pipe-D-eDP-1
[661.452161] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.957s)
[661.454881] Subtest query-idle-hang: SUCCESS (51.482s)
[662.312622] [117/131] (374s left) syncobj_wait (reset-multiple-signaled)
[662.380535] Starting subtest: reset-multiple-signaled
[662.383078] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[662.511276] [118/131] (374s left) kms_flip_event_leak (basic)
[662.610668] Starting subtest: basic
[662.613210] Starting dynamic subtest: pipe-A-eDP-1
[663.039630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[663.049077] Starting dynamic subtest: pipe-B-eDP-1
[664.162873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.122s)
[664.172368] Starting dynamic subtest: pipe-C-eDP-1
[665.244157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.081s)
[665.254792] Starting dynamic subtest: pipe-D-eDP-1
[666.337696] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s)
[666.340465] Subtest basic: SUCCESS (3.729s)
[667.185091] [119/131] (369s left) gem_pwrite_snooped
[667.343515] [120/131] (369s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[667.402195] Starting subtest: yf-tiled-ccs-to-y-tiled
[667.407939] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[667.613739] [121/131] (369s left) gem_ctx_shared (q-independent)
[667.685256] Starting subtest: Q-independent
[667.688335] Starting dynamic subtest: rcs0
[667.756135] Dynamic subtest rcs0: SUCCESS (0.071s)
[667.768380] Starting dynamic subtest: vcs0
[667.814128] Dynamic subtest vcs0: SUCCESS (0.058s)
[667.826134] Starting dynamic subtest: vcs1
[667.851905] Dynamic subtest vcs1: SUCCESS (0.037s)
[667.862137] Starting dynamic subtest: vecs0
[667.890827] Dynamic subtest vecs0: SUCCESS (0.038s)
[667.900305] Starting dynamic subtest: ccs0
[667.936885] Dynamic subtest ccs0: SUCCESS (0.045s)
[667.939592] Subtest Q-independent: SUCCESS (0.252s)
[669.837868] [122/131] (367s left) prime_mmap (test_userptr)
[669.898038] Starting subtest: test_userptr
[669.901121] Starting dynamic subtest: test_userptr-smem
[669.903993] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[669.907145] Subtest test_userptr: SUCCESS (0.001s)
[670.035643] [123/131] (367s left) kms_addfb_basic (bad-pitch-65536)
[670.096904] Starting subtest: bad-pitch-65536
[670.099211] Subtest bad-pitch-65536: SUCCESS (0.000s)
[670.257200] [124/131] (366s left) prime_self_import (basic-with_fd_dup)
[670.303388] Starting subtest: basic-with_fd_dup
[670.319339] Subtest basic-with_fd_dup: SUCCESS (0.022s)
[670.429289] [125/131] (366s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[670.527284] Starting subtest: primary-y-tiled-reflect-x-0
[670.587915] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[670.713315] [126/131] (366s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[670.810887] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[670.812932] Starting dynamic subtest: pipe-A-eDP-1
[670.833092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[670.843165] Starting dynamic subtest: pipe-B-eDP-1
[670.864470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[670.874166] Starting dynamic subtest: pipe-C-eDP-1
[670.895158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[670.903872] Starting dynamic subtest: pipe-D-eDP-1
[670.925367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[670.929365] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[673.087960] [127/131] (364s left) kms_addfb_basic (unused-modifier)
[673.157006] Starting subtest: unused-modifier
[673.159418] Subtest unused-modifier: SUCCESS (0.000s)
[673.319572] [128/131] (363s left) kms_vblank (wait-idle)
[673.424014] Starting subtest: wait-idle
[673.426931] Starting dynamic subtest: pipe-A-eDP-1
[675.180883] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[675.206852] Starting dynamic subtest: pipe-D-eDP-1
[677.597331] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.415s)
[677.600314] Subtest wait-idle: SUCCESS (4.172s)
[678.494154] [129/131] (358s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[678.610418] Starting subtest: cursorA-vs-flipA-toggle
[689.736341] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s)
[690.590171] [130/131] (346s left) gen9_exec_parse (bb-start-far)
[690.652076] Subtest bb-start-far: SKIP (0.000s)
[690.738685] [131/131] (346s left) kms_addfb_basic (basic)
[690.802410] Starting subtest: basic
[690.804779] Subtest basic: SUCCESS (0.000s)
[690.985084] 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.