[57.716401] Initializing watchdogs
[57.716452]   /dev/watchdog0
[57.731213] [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.736177] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.738531] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.741760] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.822152] Starting subtest: invalid-bad-pad
[57.824551] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.935533] [002/131] (960s left) tools_test (tools_test)
[57.986615] Starting subtest: tools_test
[58.040076] Subtest tools_test: SUCCESS (0.074s)
[58.125237] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[58.180378] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[58.239669] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[58.307041] Starting subtest: sync-unmap-cycles
[63.661842] Subtest sync-unmap-cycles: SUCCESS (5.374s)
[63.846865] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.948046] Starting subtest: stress-xrgb8888-ytiled
[63.951842] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[64.032463] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[64.135289] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[64.137239] Starting dynamic subtest: pipe-A-eDP-1
[80.894568] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.267s)
[80.903840] Starting dynamic subtest: pipe-B-eDP-1
[98.917617] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.870s)
[98.927015] Starting dynamic subtest: pipe-C-eDP-1
[116.862531] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.786s)
[116.872461] Starting dynamic subtest: pipe-D-eDP-1
[134.876613] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[134.879547] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (14.698s)
[141.145158] [007/131] (882s left) api_intel_allocator (gem-pool)
[141.215709] Starting subtest: gem-pool
[141.229694] Subtest gem-pool: SUCCESS (0.017s)
[141.392918] [008/131] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[141.500856] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[147.896066] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.513s)
[148.041700] [009/131] (875s left) kms_atomic_interruptible (universal-setplane-primary)
[148.138261] Starting subtest: universal-setplane-primary
[148.140742] Starting dynamic subtest: pipe-A-eDP-1
[155.500825] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.415s)
[155.503393] Subtest universal-setplane-primary: SUCCESS (7.416s)
[156.305983] [010/131] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[156.414265] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[160.688804] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.293s)
[161.910602] [011/131] (861s left) gem_eio (in-flight-contexts-1us)
[162.119478] Starting subtest: in-flight-contexts-1us
[173.997716] Subtest in-flight-contexts-1us: SUCCESS (11.888s)
[174.145387] [012/131] (849s left) gem_exec_balancer (semaphore)
[174.208787] Starting subtest: semaphore
[175.956598] Subtest semaphore: SUCCESS (1.746s)
[176.310015] [013/131] (847s left) kms_chamelium_hpd (hdmi-hpd)
[176.710676] Subtest hdmi-hpd: SKIP (0.000s)
[177.483632] [014/131] (846s left) kms_flip (wf_vblank-ts-check)
[177.581594] Starting subtest: wf_vblank-ts-check
[177.584116] Starting dynamic subtest: A-eDP1
[186.547759] Dynamic subtest A-eDP1: SUCCESS (8.969s)
[186.558228] Starting dynamic subtest: B-eDP1
[195.480712] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[195.489759] Starting dynamic subtest: C-eDP1
[204.400787] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[204.409793] Starting dynamic subtest: D-eDP1
[213.330647] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[213.333405] Subtest wf_vblank-ts-check: SUCCESS (35.767s)
[214.581129] [015/131] (809s left) gem_exec_reloc (basic-gtt)
[214.651755] Subtest basic-gtt: SKIP (0.000s)
[214.739113] [016/131] (809s left) gem_exec_schedule (reorder-wide)
[214.922581] Subtest reorder-wide: SKIP (0.000s)
[215.127316] [017/131] (808s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[215.214430] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[215.216772] Starting dynamic subtest: pipe-A-eDP-1
[215.241101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.250601] Starting dynamic subtest: pipe-B-eDP-1
[215.273489] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.281680] Starting dynamic subtest: pipe-C-eDP-1
[215.304617] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.312792] Starting dynamic subtest: pipe-D-eDP-1
[215.336138] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.340335] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[217.542861] [018/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[217.658780] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[217.664285] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[217.779619] [019/131] (806s left) perf (polling)
[217.973280] Starting subtest: polling
[217.975467] Starting dynamic subtest: 0-rcs0
[227.994789] Dynamic subtest 0-rcs0: SUCCESS (10.026s)
[228.003920] Starting dynamic subtest: 1-vecs0
[238.019274] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[238.022028] Subtest polling: SUCCESS (20.049s)
[238.067902] [020/131] (785s left) gem_userptr_blits (probe)
[238.143129] Starting subtest: probe
[238.215295] Subtest probe: SUCCESS (0.072s)
[238.387169] [021/131] (785s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[238.502393] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[238.507005] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[238.621301] [022/131] (785s left) gem_mmap_offset (pf-nonblock)
[238.678797] Starting subtest: pf-nonblock
[238.683560] Subtest pf-nonblock: SUCCESS (0.006s)
[238.847537] [023/131] (785s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[238.936141] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[238.938464] Starting dynamic subtest: pipe-A-eDP-1
[238.963812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.973379] Starting dynamic subtest: pipe-B-eDP-1
[238.998080] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.006513] Starting dynamic subtest: pipe-C-eDP-1
[239.030218] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.038436] Starting dynamic subtest: pipe-D-eDP-1
[239.059005] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.062309] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[241.111170] [024/131] (783s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[241.208768] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[241.213683] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[241.336374] [025/131] (782s left) core_getstats (basic)
[241.387456] Starting subtest: basic
[241.389789] Subtest basic: SUCCESS (0.000s)
[241.501269] [026/131] (782s left) core_getclient (basic)
[241.558065] Starting subtest: basic
[241.560568] Subtest basic: SUCCESS (0.000s)
[241.685569] [027/131] (782s left) syncobj_timeline (multi-wait-all-available-submitted)
[241.743766] Starting subtest: multi-wait-all-available-submitted
[241.746548] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[241.863829] [028/131] (782s left) gem_exec_reloc (basic-write-wc)
[241.926240] Subtest basic-write-wc: SKIP (0.000s)
[242.012791] [029/131] (782s left) kms_invalid_mode (clock-too-high)
[242.117444] Starting subtest: clock-too-high
[242.119770] Starting dynamic subtest: pipe-A-eDP-1
[242.124517] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.135543] Starting dynamic subtest: pipe-B-eDP-1
[242.140348] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.150433] Starting dynamic subtest: pipe-C-eDP-1
[242.154588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.162815] Starting dynamic subtest: pipe-D-eDP-1
[242.167564] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.172106] Subtest clock-too-high: SKIP (0.003s)
[242.207868] [030/131] (782s left) gem_mmap_offset (bad-object)
[242.266395] Starting subtest: bad-object
[242.268481] Subtest bad-object: SUCCESS (0.001s)
[242.387797] [031/131] (782s left) syncobj_timeline (wait-all-delayed-signal)
[242.445576] Starting subtest: wait-all-delayed-signal
[242.546103] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[242.651485] [032/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[242.759713] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[243.439628] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[243.621806] [033/131] (780s left) gem_exec_suspend (basic-s3)
[243.695820] Starting subtest: basic-S3
[243.698641] Starting dynamic subtest: smem
[264.190861] Dynamic subtest smem: SUCCESS (6.234s)
[264.193870] Subtest basic-S3: SUCCESS (6.236s)
[272.412254] [034/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[272.521805] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[272.526198] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[272.634522] [035/131] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[272.738120] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[272.742146] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[272.873264] [036/131] (759s left) kms_chamelium_frames (hdmi-crc-multiple)
[273.259419] Subtest hdmi-crc-multiple: SKIP (0.000s)
[274.022194] [037/131] (758s left) gem_exec_fence (syncobj-import)
[274.507205] Starting subtest: syncobj-import
[274.512306] Subtest syncobj-import: SUCCESS (0.004s)
[276.352418] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[276.355842] [038/131] (756s left) kms_legacy_colorkey (basic)
[276.453997] Starting subtest: basic
[276.455877] Starting dynamic subtest: pipe-A
[276.496908] Dynamic subtest pipe-A: SUCCESS (0.045s)
[276.508748] Starting dynamic subtest: pipe-B
[276.511072] Dynamic subtest pipe-B: SUCCESS (0.001s)
[276.521741] Starting dynamic subtest: pipe-C
[276.523549] Dynamic subtest pipe-C: SUCCESS (0.000s)
[276.531439] Starting dynamic subtest: pipe-D
[276.533347] Dynamic subtest pipe-D: SUCCESS (0.000s)
[276.535193] Subtest basic: SUCCESS (0.049s)
[276.587965] [039/131] (756s left) gem_softpin (allocator-nopin-reserve)
[276.647724] Starting subtest: allocator-nopin-reserve
[276.737717] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[276.903207] [040/131] (755s left) perf_pmu (enable-race)
[276.946576] Starting subtest: enable-race
[276.948714] Starting dynamic subtest: rcs0
[289.726396] Dynamic subtest rcs0: SUCCESS (12.880s)
[289.735037] Starting dynamic subtest: bcs0
[302.462412] Dynamic subtest bcs0: SUCCESS (12.758s)
[302.471689] Starting dynamic subtest: vcs0
[318.205793] Dynamic subtest vcs0: SUCCESS (15.738s)
[318.217715] Starting dynamic subtest: vcs1
[334.206502] Dynamic subtest vcs1: SUCCESS (15.999s)
[334.217865] Starting dynamic subtest: vecs0
[350.205722] Dynamic subtest vecs0: SUCCESS (16.001s)
[350.215932] Starting dynamic subtest: ccs0
[362.949536] Dynamic subtest ccs0: SUCCESS (12.747s)
[362.952193] Subtest enable-race: SUCCESS (86.132s)
[363.092515] [041/131] (669s left) syncobj_timeline (signal-point-0)
[363.152613] Starting subtest: signal-point-0
[363.154954] Subtest signal-point-0: SUCCESS (0.000s)
[363.292904] [042/131] (669s left) gem_tiled_wb
[363.429892] [043/131] (669s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[363.534299] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[363.536623] Starting dynamic subtest: pipe-A-eDP-1
[363.561684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[363.572202] Starting dynamic subtest: pipe-B-eDP-1
[363.596844] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[363.607255] Starting dynamic subtest: pipe-C-eDP-1
[363.630751] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[363.639306] Starting dynamic subtest: pipe-D-eDP-1
[363.663070] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[363.667102] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[365.842527] [044/131] (667s left) gem_ctx_param (set-priority-invalid-size)
[365.917958] Starting subtest: set-priority-invalid-size
[365.920398] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[366.023121] [045/131] (667s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[366.132629] Starting subtest: plane-ctm3x4-lut1d
[366.145059] Starting dynamic subtest: pipe-A-eDP-1
[366.847278] Dynamic subtest pipe-A-eDP-1: FAIL (0.325s)
[367.596623] Starting dynamic subtest: pipe-B-eDP-1
[368.416220] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[368.940224] Starting dynamic subtest: pipe-C-eDP-1
[369.774681] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[370.265265] Starting dynamic subtest: pipe-D-eDP-1
[371.096812] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[371.099105] Subtest plane-ctm3x4-lut1d: FAIL (4.665s)
[371.663301] [046/131] (661s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[371.792602] Starting subtest: 2x-long-cursor-vs-flip-atomic
[371.796893] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[371.960849] [047/131] (661s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[372.059041] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[372.063174] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[372.204806] [048/131] (660s left) kms_feature_discovery (display-1x)
[372.303096] Starting subtest: display-1x
[372.305044] Subtest display-1x: SUCCESS (0.000s)
[372.399050] [049/131] (660s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[372.507484] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[372.511700] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[372.626425] [050/131] (660s left) i915_drm_fdinfo (most-busy-idle-check-all)
[372.670513] Starting subtest: most-busy-idle-check-all
[372.672484] Starting dynamic subtest: rcs0
[372.678398] Dynamic subtest rcs0: SKIP (0.006s)
[372.691034] Starting dynamic subtest: bcs0
[372.694731] Dynamic subtest bcs0: SKIP (0.000s)
[372.705108] Starting dynamic subtest: vcs0
[372.708721] Dynamic subtest vcs0: SKIP (0.000s)
[372.716455] Starting dynamic subtest: vcs1
[372.719774] Dynamic subtest vcs1: SKIP (0.000s)
[372.727592] Starting dynamic subtest: vecs0
[372.731023] Dynamic subtest vecs0: SKIP (0.000s)
[372.739056] Starting dynamic subtest: ccs0
[372.742488] Dynamic subtest ccs0: SKIP (0.000s)
[372.745820] Subtest most-busy-idle-check-all: SKIP (0.011s)
[372.780799] [051/131] (660s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[372.932987] Starting subtest: x-tiled-32bpp-rotate-270
[372.952932] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[373.093804] [052/131] (660s left) gem_exec_schedule (u-submit-early-slice)
[373.175891] Starting subtest: u-submit-early-slice
[373.177810] Starting dynamic subtest: rcs0
[373.211405] Dynamic subtest rcs0: SUCCESS (0.041s)
[373.220920] Starting dynamic subtest: bcs0
[373.251428] Dynamic subtest bcs0: SUCCESS (0.039s)
[373.260344] Starting dynamic subtest: vcs0
[373.290975] Dynamic subtest vcs0: SUCCESS (0.039s)
[373.300657] Starting dynamic subtest: vcs1
[373.335366] Dynamic subtest vcs1: SUCCESS (0.044s)
[373.345400] Starting dynamic subtest: vecs0
[373.373096] Dynamic subtest vecs0: SUCCESS (0.037s)
[373.382514] Starting dynamic subtest: ccs0
[373.411088] Dynamic subtest ccs0: SUCCESS (0.037s)
[373.413112] Subtest u-submit-early-slice: SUCCESS (0.241s)
[375.346430] [053/131] (658s left) gem_pxp (regular-baseline-src-copy-readible)
[375.477199] Starting subtest: regular-baseline-src-copy-readible
[375.538182] Subtest regular-baseline-src-copy-readible: SUCCESS (0.063s)
[375.707169] [054/131] (657s left) gem_exec_balancer (full-late-pulse)
[375.785825] Starting subtest: full-late-pulse
[380.079618] Subtest full-late-pulse: SUCCESS (4.295s)
[380.457306] [055/131] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[380.561695] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[380.565610] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[380.693587] [056/131] (652s left) fbdev (read)
[380.742363] Starting subtest: read
[381.271946] Subtest read: SUCCESS (0.527s)
[381.360069] [057/131] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[381.469689] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[381.474242] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[381.631730] [058/131] (651s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[381.734763] Starting subtest: multiplane-rotation-cropping-top
[399.294354] Subtest multiplane-rotation-cropping-top: SUCCESS (17.560s)
[399.446571] [059/131] (634s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[399.563821] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[406.517734] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.954s)
[406.693354] [060/131] (627s left) i915_selftest (mock)
[410.183309] Starting subtest: mock
[410.185951] Starting dynamic subtest: sanitycheck
[410.911726] Dynamic subtest sanitycheck: SUCCESS (0.728s)
[410.921513] Starting dynamic subtest: shmem
[411.667676] Dynamic subtest shmem: SUCCESS (0.754s)
[411.677310] Starting dynamic subtest: fence
[419.347319] Dynamic subtest fence: SUCCESS (7.677s)
[419.357073] Starting dynamic subtest: scatterlist
[421.044832] Dynamic subtest scatterlist: SUCCESS (1.695s)
[421.054454] Starting dynamic subtest: syncmap
[424.427665] Dynamic subtest syncmap: SUCCESS (3.381s)
[424.437961] Starting dynamic subtest: uncore
[425.124574] Dynamic subtest uncore: SUCCESS (0.695s)
[425.134343] Starting dynamic subtest: ring
[425.832509] Dynamic subtest ring: SUCCESS (0.706s)
[425.842687] Starting dynamic subtest: engine
[426.565514] Dynamic subtest engine: SUCCESS (0.731s)
[426.575316] Starting dynamic subtest: timelines
[430.504671] Dynamic subtest timelines: SUCCESS (3.936s)
[430.513887] Starting dynamic subtest: requests
[433.893511] Dynamic subtest requests: SUCCESS (3.387s)
[433.902864] Starting dynamic subtest: objects
[434.776672] Dynamic subtest objects: SUCCESS (0.882s)
[434.786454] Starting dynamic subtest: phys
[435.691567] Dynamic subtest phys: SUCCESS (0.913s)
[435.701301] Starting dynamic subtest: dmabuf
[436.494731] Dynamic subtest dmabuf: SUCCESS (0.801s)
[436.504350] Starting dynamic subtest: vma
[441.923724] Dynamic subtest vma: SUCCESS (5.426s)
[441.932265] Starting dynamic subtest: evict
[443.435756] Dynamic subtest evict: SUCCESS (1.510s)
[443.445942] Starting dynamic subtest: gtt
[446.720566] Dynamic subtest gtt: SUCCESS (3.283s)
[446.729044] Starting dynamic subtest: hugepages
[447.663481] Dynamic subtest hugepages: SUCCESS (0.940s)
[447.673219] Starting dynamic subtest: memory_region
[450.277112] Dynamic subtest memory_region: SUCCESS (2.612s)
[450.280186] Subtest mock: SUCCESS (40.097s)
[450.307212] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[450.307903] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[450.311136] [061/131] (583s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[456.923726] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[456.926133] Starting dynamic subtest: pipe-A-eDP-1
[457.716602] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[457.726760] Starting dynamic subtest: pipe-B-eDP-1
[458.841931] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[458.846148] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.916s)
[460.064620] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[460.065843] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[460.069381] [062/131] (573s left) gem_render_copy_redux (normal)
[460.145700] Starting subtest: normal
[460.404265] Subtest normal: SUCCESS (0.258s)
[460.569675] [063/131] (573s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[460.639984] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[460.726501] [064/131] (573s left) gem_ctx_param (invalid-set-no-zeromap)
[460.785551] Starting subtest: invalid-set-no-zeromap
[460.787844] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[460.883111] [065/131] (573s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[460.999431] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[470.331707] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.334s)
[470.473195] [066/131] (563s left) i915_pm_rps (reset)
[470.542970] Starting subtest: reset
[478.963526] Subtest reset: SUCCESS (8.422s)
[479.071003] [067/131] (554s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[479.170194] Starting subtest: async-flip-with-page-flip-events-linear
[479.541929] Starting dynamic subtest: pipe-A-eDP-1
[482.349680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.808s)
[482.724885] Starting dynamic subtest: pipe-B-eDP-1
[485.481407] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[485.854173] Starting dynamic subtest: pipe-C-eDP-1
[488.609143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[488.967771] Starting dynamic subtest: pipe-D-eDP-1
[491.744201] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.782s)
[491.746726] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.577s)
[492.956660] [068/131] (541s left) perf_pmu (module-unload)
[493.067087] Starting subtest: module-unload
[499.713553] Subtest module-unload: FAIL (6.544s)
[499.743928] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[499.744614] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[499.747540] [069/131] (534s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[501.324073] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[501.328382] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[501.434219] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[501.435455] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[501.439065] [070/131] (532s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[501.496284] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[501.602578] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[501.701372] [071/131] (532s left) kms_cursor_crc (cursor-random-256x85)
[501.945366] Starting subtest: cursor-random-256x85
[501.996664] Subtest cursor-random-256x85: SKIP (0.047s)
[502.199439] [072/131] (532s left) kms_psr (psr-sprite-plane-move)
[502.293448] Starting subtest: psr-sprite-plane-move
[502.295940] Starting dynamic subtest: eDP-1
[504.082507] Dynamic subtest eDP-1: SUCCESS (1.789s)
[504.084421] Subtest psr-sprite-plane-move: SUCCESS (1.790s)
[504.916104] [073/131] (529s left) kms_psr (fbc-pr-sprite-plane-onoff)
[505.011194] Starting subtest: fbc-pr-sprite-plane-onoff
[505.015655] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[505.114120] [074/131] (529s left) kms_pm_rpm (pm-tiling)
[507.352193] Starting subtest: pm-tiling
[507.357338] Subtest pm-tiling: SKIP (0.000s)
[507.755327] [075/131] (526s left) gem_userptr_blits (invalid-null-pointer)
[507.829995] Starting subtest: invalid-null-pointer
[507.832037] Subtest invalid-null-pointer: SUCCESS (0.001s)
[507.995927] [076/131] (526s left) kms_content_protection (lic-type-1)
[508.136299] Starting subtest: lic-type-1
[508.140970] Subtest lic-type-1: SKIP (0.000s)
[508.312768] [077/131] (526s left) kms_atomic (plane-immutable-zpos)
[508.417981] Starting subtest: plane-immutable-zpos
[508.420279] Starting dynamic subtest: pipe-A-eDP-1
[509.049191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[509.051530] Subtest plane-immutable-zpos: SUCCESS (0.630s)
[509.883042] [078/131] (524s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[510.017601] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[510.021811] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[510.189960] [079/131] (524s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[510.296815] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[510.299046] Starting dynamic subtest: pipe-A
[511.388429] Dynamic subtest pipe-A: SUCCESS (1.094s)
[511.398000] Starting dynamic subtest: pipe-B
[513.568819] Dynamic subtest pipe-B: SUCCESS (2.179s)
[513.578520] Starting dynamic subtest: pipe-C
[514.754996] Dynamic subtest pipe-C: SUCCESS (1.185s)
[514.764558] Starting dynamic subtest: pipe-D
[515.983259] Dynamic subtest pipe-D: SUCCESS (1.227s)
[515.985442] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.691s)
[517.200677] [080/131] (517s left) kms_psr (pr-sprite-mmap-cpu)
[517.300427] Starting subtest: pr-sprite-mmap-cpu
[517.304685] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[517.401624] [081/131] (517s left) gem_ctx_persistence (legacy-engines-cleanup)
[517.472515] Starting subtest: legacy-engines-cleanup
[517.474886] Starting dynamic subtest: render
[517.574044] Dynamic subtest render: SUCCESS (0.101s)
[517.589088] Starting dynamic subtest: bsd1
[517.642323] Dynamic subtest bsd1: SUCCESS (0.065s)
[517.653497] Starting dynamic subtest: bsd2
[517.671745] Dynamic subtest bsd2: SUCCESS (0.027s)
[517.679706] Starting dynamic subtest: blt
[517.764329] Dynamic subtest blt: SUCCESS (0.090s)
[517.776046] Starting dynamic subtest: vebox
[517.837182] Dynamic subtest vebox: SUCCESS (0.070s)
[517.839631] Subtest legacy-engines-cleanup: SUCCESS (0.366s)
[517.941436] [082/131] (516s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[518.063835] Starting subtest: cursor-tearing-framebuffer-change
[518.066211] Starting dynamic subtest: pipe-A-eDP-1
[518.651322] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[518.659922] Starting dynamic subtest: pipe-D-eDP-1
[519.900849] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s)
[519.903279] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.838s)
[520.767503] [083/131] (513s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[520.898084] Starting subtest: 2x-cursor-vs-flip-atomic
[520.902634] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[521.080975] [084/131] (513s left) kms_cursor_crc (cursor-random-32x10)
[521.241971] Starting subtest: cursor-random-32x10
[521.304871] Subtest cursor-random-32x10: SKIP (0.057s)
[521.612511] [085/131] (513s left) kms_psr (fbc-psr-primary-mmap-gtt)
[521.721569] Starting subtest: fbc-psr-primary-mmap-gtt
[521.723525] Starting dynamic subtest: eDP-1
[521.727020] Dynamic subtest eDP-1: SKIP (0.000s)
[521.730547] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[521.821166] [086/131] (513s left) kms_big_fb (linear-8bpp-rotate-0)
[521.923726] Starting subtest: linear-8bpp-rotate-0
[523.148844] Subtest linear-8bpp-rotate-0: SUCCESS (1.225s)
[523.344207] [087/131] (511s left) gem_create (create-ext-cpu-access-sanity-check)
[523.530275] Starting subtest: create-ext-cpu-access-sanity-check
[523.534826] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[523.628518] [088/131] (511s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[523.739909] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[527.868167] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.132s)
[529.071411] [089/131] (505s left) kms_pm_rpm (cursor-dpms)
[531.412907] Starting subtest: cursor-dpms
[531.418009] Subtest cursor-dpms: SKIP (0.000s)
[531.803579] [090/131] (503s left) gem_lmem_swapping (verify-random-ccs)
[531.845130] Subtest verify-random-ccs: SKIP (0.000s)
[531.888345] [091/131] (503s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[532.005765] Starting subtest: flip-vs-cursor-toggle
[540.534109] Subtest flip-vs-cursor-toggle: SUCCESS (8.529s)
[541.430619] [092/131] (493s left) gem_lmem_swapping (heavy-verify-multi)
[541.477783] Subtest heavy-verify-multi: SKIP (0.000s)
[541.526693] [093/131] (493s left) i915_pm_freq_api (freq-reset)
[541.597821] Starting subtest: freq-reset
[541.600081] Starting dynamic subtest: gt0
[541.794921] Dynamic subtest gt0: SUCCESS (0.195s)
[541.803538] Starting dynamic subtest: gt1
[541.960669] Dynamic subtest gt1: SUCCESS (0.165s)
[541.963325] Subtest freq-reset: SUCCESS (0.362s)
[542.062213] [094/131] (493s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[542.168274] Starting subtest: y-tiled-64bpp-rotate-90
[542.172745] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[542.294465] [095/131] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[542.394445] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[542.398839] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[542.548269] [096/131] (492s left) kms_dirtyfb (default-dirtyfb-ioctl)
[542.639654] Starting subtest: default-dirtyfb-ioctl
[542.641841] Starting dynamic subtest: A-eDP-1
[544.232596] Dynamic subtest A-eDP-1: SUCCESS (1.594s)
[544.234922] Subtest default-dirtyfb-ioctl: SUCCESS (1.595s)
[545.066626] [097/131] (490s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[545.166887] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[545.169315] Starting dynamic subtest: pipe-A
[545.516639] Dynamic subtest pipe-A: SUCCESS (0.352s)
[545.525609] Starting dynamic subtest: pipe-B
[546.973927] Dynamic subtest pipe-B: SUCCESS (1.457s)
[546.983164] Starting dynamic subtest: pipe-C
[548.388575] Dynamic subtest pipe-C: SUCCESS (1.414s)
[548.398010] Starting dynamic subtest: pipe-D
[549.798323] Dynamic subtest pipe-D: SUCCESS (1.409s)
[549.800571] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.636s)
[550.999629] [098/131] (484s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[551.107691] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[551.109956] Starting dynamic subtest: pipe-A-default-mode
[551.422387] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[551.427041] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.315s)
[552.230990] [099/131] (483s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[552.364626] Starting subtest: 2x-cursor-vs-flip-legacy
[552.369413] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[552.534693] [100/131] (482s left) gem_readwrite (write-bad-handle)
[552.593922] Subtest write-bad-handle: SKIP (0.000s)
[552.669877] [101/131] (482s left) gem_reg_read (timestamp-monotonic)
[552.726541] Starting subtest: timestamp-monotonic
[556.767925] Subtest timestamp-monotonic: SUCCESS (4.042s)
[556.868585] [102/131] (478s left) kms_psr (fbc-psr2-cursor-plane-move)
[556.966398] Starting subtest: fbc-psr2-cursor-plane-move
[556.968709] Starting dynamic subtest: eDP-1
[556.972921] Dynamic subtest eDP-1: SKIP (0.000s)
[556.977151] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[557.066756] [103/131] (478s left) kms_plane_lowres (tiling-x)
[557.163553] Starting subtest: tiling-x
[557.165813] Starting dynamic subtest: pipe-A-eDP-1
[557.170321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.457335] Starting dynamic subtest: pipe-B-eDP-1
[557.461983] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.473075] Starting dynamic subtest: pipe-C-eDP-1
[557.478546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.487355] Starting dynamic subtest: pipe-D-eDP-1
[557.491708] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.495770] Subtest tiling-x: SKIP (0.294s)
[558.273899] [104/131] (477s left) kms_force_connector_basic (force-edid)
[558.356650] Starting subtest: force-edid
[558.723639] Subtest force-edid: SUCCESS (0.370s)
[558.886779] [105/131] (476s left) kms_getfb (getfb-handle-zero)
[558.981541] Starting subtest: getfb-handle-zero
[558.983773] Subtest getfb-handle-zero: SUCCESS (0.000s)
[559.100614] [106/131] (476s left) perf (missing-sample-flags)
[559.239612] Starting subtest: missing-sample-flags
[559.241281] Subtest missing-sample-flags: SUCCESS (0.000s)
[559.299355] [107/131] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[559.406379] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[566.021849] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.620s)
[566.182805] [108/131] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[566.291533] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[566.295712] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[566.437064] [109/131] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[566.534199] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[566.538425] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[566.664134] [110/131] (469s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[566.770442] Starting subtest: 4-tiled-8bpp-rotate-180
[568.049823] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.280s)
[568.232997] [111/131] (467s left) gem_exec_fence (syncobj-timeline-repeat)
[568.781561] Starting subtest: syncobj-timeline-repeat
[569.008270] Subtest syncobj-timeline-repeat: SUCCESS (0.227s)
[570.361372] [112/131] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[570.476700] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[577.719183] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.246s)
[577.892419] [113/131] (458s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[577.961352] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[577.963843] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[578.111483] [114/131] (457s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[578.211234] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[581.921689] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.716s)
[583.103060] [115/131] (452s left) gem_exec_schedule (lateslice)
[583.184386] Starting subtest: lateslice
[583.186541] Starting dynamic subtest: rcs0
[583.194827] Dynamic subtest rcs0: SUCCESS (0.022s)
[583.206534] Starting dynamic subtest: bcs0
[583.213054] Dynamic subtest bcs0: SUCCESS (0.018s)
[583.222491] Starting dynamic subtest: vcs0
[583.232317] Dynamic subtest vcs0: SUCCESS (0.018s)
[583.241711] Starting dynamic subtest: vcs1
[583.250919] Dynamic subtest vcs1: SUCCESS (0.018s)
[583.259872] Starting dynamic subtest: vecs0
[583.270504] Dynamic subtest vecs0: SUCCESS (0.019s)
[583.279778] Starting dynamic subtest: ccs0
[583.289450] Dynamic subtest ccs0: SUCCESS (0.018s)
[583.291677] Subtest lateslice: SUCCESS (0.117s)
[585.336111] [116/131] (450s left) kms_vblank (query-idle-hang)
[585.433512] Starting subtest: query-idle-hang
[585.435707] Starting dynamic subtest: pipe-A-eDP-1
[611.972711] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.543s)
[611.987421] Starting dynamic subtest: pipe-D-eDP-1
[627.006887] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.036s)
[627.008808] Subtest query-idle-hang: SUCCESS (41.584s)
[627.877208] [117/131] (408s left) syncobj_wait (reset-multiple-signaled)
[627.936070] Starting subtest: reset-multiple-signaled
[627.938388] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[628.041714] [118/131] (408s left) kms_flip_event_leak (basic)
[628.141426] Starting subtest: basic
[628.143845] Starting dynamic subtest: pipe-A-eDP-1
[628.567700] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[628.577233] Starting dynamic subtest: pipe-B-eDP-1
[629.735651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[629.744901] Starting dynamic subtest: pipe-C-eDP-1
[630.816151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.080s)
[630.827041] Starting dynamic subtest: pipe-D-eDP-1
[631.905102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.086s)
[631.907083] Subtest basic: SUCCESS (3.762s)
[632.775673] [119/131] (403s left) gem_pwrite_snooped
[632.974663] [120/131] (403s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[633.053222] Starting subtest: yf-tiled-ccs-to-y-tiled
[633.057385] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[633.259918] [121/131] (403s left) gem_ctx_shared (q-independent)
[633.324968] Starting subtest: Q-independent
[633.327506] Starting dynamic subtest: rcs0
[633.395698] Dynamic subtest rcs0: SUCCESS (0.069s)
[633.410662] Starting dynamic subtest: vcs0
[633.443150] Dynamic subtest vcs0: SUCCESS (0.047s)
[633.454425] Starting dynamic subtest: vcs1
[633.485724] Dynamic subtest vcs1: SUCCESS (0.042s)
[633.497999] Starting dynamic subtest: vecs0
[633.525184] Dynamic subtest vecs0: SUCCESS (0.039s)
[633.536567] Starting dynamic subtest: ccs0
[633.567069] Dynamic subtest ccs0: SUCCESS (0.041s)
[633.569372] Subtest Q-independent: SUCCESS (0.242s)
[635.329655] [122/131] (401s left) prime_mmap (test_userptr)
[635.394524] Starting subtest: test_userptr
[635.396881] Starting dynamic subtest: test_userptr-smem
[635.399022] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[635.401163] Subtest test_userptr: SUCCESS (0.001s)
[635.542952] [123/131] (400s left) kms_addfb_basic (bad-pitch-65536)
[635.592273] Starting subtest: bad-pitch-65536
[635.594555] Subtest bad-pitch-65536: SUCCESS (0.000s)
[635.758338] [124/131] (400s left) prime_self_import (basic-with_fd_dup)
[635.796399] Starting subtest: basic-with_fd_dup
[635.818150] Subtest basic-with_fd_dup: SUCCESS (0.024s)
[635.941510] [125/131] (400s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[636.028530] Starting subtest: primary-y-tiled-reflect-x-0
[636.088757] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[636.216537] [126/131] (400s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[636.316166] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[636.318029] Starting dynamic subtest: pipe-A-eDP-1
[636.336891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[636.346730] Starting dynamic subtest: pipe-B-eDP-1
[636.363133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[636.372009] Starting dynamic subtest: pipe-C-eDP-1
[636.389742] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[636.398049] Starting dynamic subtest: pipe-D-eDP-1
[636.417517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[636.421297] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[638.569048] [127/131] (398s left) kms_addfb_basic (unused-modifier)
[638.637094] Starting subtest: unused-modifier
[638.639053] Subtest unused-modifier: SUCCESS (0.000s)
[638.806786] [128/131] (397s left) kms_vblank (wait-idle)
[638.910755] Starting subtest: wait-idle
[638.912891] Starting dynamic subtest: pipe-A-eDP-1
[640.663203] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[640.677713] Starting dynamic subtest: pipe-D-eDP-1
[643.161126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.495s)
[643.163639] Subtest wait-idle: SUCCESS (4.252s)
[644.075826] [129/131] (392s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[644.190028] Starting subtest: cursorA-vs-flipA-toggle
[655.300952] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.114s)
[656.165803] [130/131] (380s left) gen9_exec_parse (bb-start-far)
[656.235287] Subtest bb-start-far: SKIP (0.000s)
[656.308511] [131/131] (380s left) kms_addfb_basic (basic)
[656.367519] Starting subtest: basic
[656.369738] Subtest basic: SUCCESS (0.000s)
[656.515615] 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.