[56.753868] Initializing watchdogs
[56.753921]   /dev/watchdog0
[56.769591] [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]
[56.773927] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.776596] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.779882] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[56.854958] Starting subtest: invalid-bad-pad
[56.857389] Subtest invalid-bad-pad: SUCCESS (0.000s)
[56.983090] [002/131] (960s left) tools_test (tools_test)
[57.031439] Starting subtest: tools_test
[57.089904] Subtest tools_test: SUCCESS (0.074s)
[57.171466] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[57.221043] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[57.275645] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[57.347435] Starting subtest: sync-unmap-cycles
[62.697132] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[62.874313] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[62.989953] Starting subtest: stress-xrgb8888-ytiled
[62.993530] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.087479] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[63.184505] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[63.186193] Starting dynamic subtest: pipe-A-eDP-1
[79.700790] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.076s)
[79.710276] Starting dynamic subtest: pipe-B-eDP-1
[97.730483] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[97.740087] Starting dynamic subtest: pipe-C-eDP-1
[115.727398] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[115.736519] Starting dynamic subtest: pipe-D-eDP-1
[133.719664] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.756s)
[133.721880] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (14.372s)
[141.010768] [007/131] (882s left) api_intel_allocator (gem-pool)
[141.089672] Starting subtest: gem-pool
[141.106485] Subtest gem-pool: SUCCESS (0.017s)
[141.266465] [008/131] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[141.383692] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[147.827042] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.576s)
[147.960668] [009/131] (875s left) kms_atomic_interruptible (universal-setplane-primary)
[148.067554] Starting subtest: universal-setplane-primary
[148.070554] Starting dynamic subtest: pipe-A-eDP-1
[155.479682] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.475s)
[155.482306] Subtest universal-setplane-primary: SUCCESS (7.476s)
[156.302484] [010/131] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[156.423720] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[160.694584] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.290s)
[161.913230] [011/131] (861s left) gem_eio (in-flight-contexts-1us)
[162.120599] Starting subtest: in-flight-contexts-1us
[174.102580] Subtest in-flight-contexts-1us: SUCCESS (11.991s)
[174.244770] [012/131] (849s left) gem_exec_balancer (semaphore)
[174.317434] Starting subtest: semaphore
[176.060779] Subtest semaphore: SUCCESS (1.741s)
[176.393900] [013/131] (847s left) kms_chamelium_hpd (hdmi-hpd)
[176.777368] Subtest hdmi-hpd: SKIP (0.000s)
[177.576860] [014/131] (846s left) kms_flip (wf_vblank-ts-check)
[177.675348] Starting subtest: wf_vblank-ts-check
[177.677612] Starting dynamic subtest: A-eDP1
[186.642442] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[186.652572] Starting dynamic subtest: B-eDP1
[195.566806] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[195.577302] Starting dynamic subtest: C-eDP1
[204.482821] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[204.492845] Starting dynamic subtest: D-eDP1
[213.411261] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[213.413656] Subtest wf_vblank-ts-check: SUCCESS (35.750s)
[214.663989] [015/131] (809s left) gem_exec_reloc (basic-gtt)
[214.735190] Subtest basic-gtt: SKIP (0.000s)
[214.814322] [016/131] (809s left) gem_exec_schedule (reorder-wide)
[214.995639] Subtest reorder-wide: SKIP (0.000s)
[215.198689] [017/131] (808s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[215.295417] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[215.297653] Starting dynamic subtest: pipe-A-eDP-1
[215.320315] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[215.330888] Starting dynamic subtest: pipe-B-eDP-1
[215.352095] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[215.359824] Starting dynamic subtest: pipe-C-eDP-1
[215.381041] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.388673] Starting dynamic subtest: pipe-D-eDP-1
[215.410020] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.414341] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[217.626951] [018/131] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[217.732037] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[217.736466] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[217.883168] [019/131] (806s left) perf (polling)
[218.064940] Starting subtest: polling
[218.067174] Starting dynamic subtest: 0-rcs0
[228.111389] Dynamic subtest 0-rcs0: SUCCESS (10.049s)
[228.121202] Starting dynamic subtest: 1-vcs0
[238.139425] Dynamic subtest 1-vcs0: SUCCESS (10.023s)
[238.143007] Subtest polling: SUCCESS (20.076s)
[238.213851] [020/131] (785s left) gem_userptr_blits (probe)
[238.322864] Starting subtest: probe
[238.550607] Subtest probe: SUCCESS (0.226s)
[238.729011] [021/131] (785s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[238.839201] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[238.843320] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[238.957360] [022/131] (785s left) gem_mmap_offset (pf-nonblock)
[239.005766] Starting subtest: pf-nonblock
[239.009901] Subtest pf-nonblock: SUCCESS (0.007s)
[239.181041] [023/131] (784s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[239.270935] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[239.273220] Starting dynamic subtest: pipe-A-eDP-1
[239.298665] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.308859] Starting dynamic subtest: pipe-B-eDP-1
[239.332813] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.348141] Starting dynamic subtest: pipe-C-eDP-1
[239.373048] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.383289] Starting dynamic subtest: pipe-D-eDP-1
[239.408328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.412600] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[241.496007] [024/131] (782s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[241.609896] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[241.614159] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[241.748595] [025/131] (782s left) core_getstats (basic)
[241.807729] Starting subtest: basic
[241.809910] Subtest basic: SUCCESS (0.000s)
[241.947072] [026/131] (782s left) core_getclient (basic)
[242.001617] Starting subtest: basic
[242.003819] Subtest basic: SUCCESS (0.000s)
[242.150652] [027/131] (782s left) syncobj_timeline (multi-wait-all-available-submitted)
[242.210841] Starting subtest: multi-wait-all-available-submitted
[242.213147] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[242.345710] [028/131] (782s left) gem_exec_reloc (basic-write-wc)
[242.411694] Subtest basic-write-wc: SKIP (0.000s)
[242.498329] [029/131] (781s left) kms_invalid_mode (clock-too-high)
[242.594357] Starting subtest: clock-too-high
[242.596336] Starting dynamic subtest: pipe-A-eDP-1
[242.600135] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.608845] Starting dynamic subtest: pipe-B-eDP-1
[242.612659] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.620575] Starting dynamic subtest: pipe-C-eDP-1
[242.624292] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.632089] Starting dynamic subtest: pipe-D-eDP-1
[242.635671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.639179] Subtest clock-too-high: SKIP (0.004s)
[242.689504] [030/131] (781s left) gem_mmap_offset (bad-object)
[242.743313] Starting subtest: bad-object
[242.745039] Subtest bad-object: SUCCESS (0.001s)
[242.883609] [031/131] (781s left) syncobj_timeline (wait-all-delayed-signal)
[242.937927] Starting subtest: wait-all-delayed-signal
[243.040688] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[243.140270] [032/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[243.235639] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[243.893283] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[244.102741] [033/131] (780s left) gem_exec_suspend (basic-s3)
[244.174659] Starting subtest: basic-S3
[244.177300] Starting dynamic subtest: smem
[265.119380] Dynamic subtest smem: SUCCESS (6.905s)
[265.122349] Subtest basic-S3: SUCCESS (6.907s)
[271.341966] [034/131] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[271.471036] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[271.475663] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[271.616595] [035/131] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[271.727075] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[271.731390] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[271.862272] [036/131] (758s left) kms_chamelium_frames (hdmi-crc-multiple)
[272.246757] Subtest hdmi-crc-multiple: SKIP (0.000s)
[273.004245] [037/131] (757s left) gem_exec_fence (syncobj-import)
[273.483823] Starting subtest: syncobj-import
[273.488955] Subtest syncobj-import: SUCCESS (0.005s)
[275.237003] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[275.240182] [038/131] (755s left) kms_legacy_colorkey (basic)
[275.337113] Starting subtest: basic
[275.339190] Starting dynamic subtest: pipe-A
[275.379380] Dynamic subtest pipe-A: SUCCESS (0.045s)
[275.390395] Starting dynamic subtest: pipe-B
[275.392726] Dynamic subtest pipe-B: SUCCESS (0.001s)
[275.400826] Starting dynamic subtest: pipe-C
[275.403057] Dynamic subtest pipe-C: SUCCESS (0.001s)
[275.411032] Starting dynamic subtest: pipe-D
[275.413299] Dynamic subtest pipe-D: SUCCESS (0.001s)
[275.415397] Subtest basic: SUCCESS (0.053s)
[275.486904] [039/131] (755s left) gem_softpin (allocator-nopin-reserve)
[275.559815] Starting subtest: allocator-nopin-reserve
[275.669632] Subtest allocator-nopin-reserve: SUCCESS (0.110s)
[275.840467] [040/131] (755s left) perf_pmu (enable-race)
[275.887240] Starting subtest: enable-race
[275.889515] Starting dynamic subtest: rcs0
[288.662340] Dynamic subtest rcs0: SUCCESS (12.889s)
[288.671171] Starting dynamic subtest: bcs0
[301.403399] Dynamic subtest bcs0: SUCCESS (12.765s)
[301.411967] Starting dynamic subtest: vcs0
[317.090381] Dynamic subtest vcs0: SUCCESS (15.681s)
[317.100924] Starting dynamic subtest: vcs1
[333.151344] Dynamic subtest vcs1: SUCCESS (16.060s)
[333.162411] Starting dynamic subtest: vecs0
[349.086013] Dynamic subtest vecs0: SUCCESS (15.938s)
[349.095246] Starting dynamic subtest: ccs0
[361.827869] Dynamic subtest ccs0: SUCCESS (12.745s)
[361.830402] Subtest enable-race: SUCCESS (86.087s)
[361.968692] [041/131] (668s left) syncobj_timeline (signal-point-0)
[362.034074] Starting subtest: signal-point-0
[362.036298] Subtest signal-point-0: SUCCESS (0.000s)
[362.160345] [042/131] (668s left) gem_tiled_wb
[362.289373] [043/131] (668s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[362.390262] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[362.392600] Starting dynamic subtest: pipe-A-eDP-1
[362.417712] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[362.428306] Starting dynamic subtest: pipe-B-eDP-1
[362.452031] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[362.460633] Starting dynamic subtest: pipe-C-eDP-1
[362.484251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[362.492571] Starting dynamic subtest: pipe-D-eDP-1
[362.516690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[362.520754] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[364.687899] [044/131] (666s left) gem_ctx_param (set-priority-invalid-size)
[364.748383] Starting subtest: set-priority-invalid-size
[364.750759] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[364.845496] [045/131] (666s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[364.929261] Starting subtest: plane-ctm3x4-lut1d
[364.942553] Starting dynamic subtest: pipe-A-eDP-1
[365.671307] Dynamic subtest pipe-A-eDP-1: FAIL (0.348s)
[366.334556] Starting dynamic subtest: pipe-B-eDP-1
[367.175839] Dynamic subtest pipe-B-eDP-1: FAIL (0.316s)
[367.765544] Starting dynamic subtest: pipe-C-eDP-1
[368.612130] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[369.097866] Starting dynamic subtest: pipe-D-eDP-1
[369.958511] Dynamic subtest pipe-D-eDP-1: FAIL (0.278s)
[369.960845] Subtest plane-ctm3x4-lut1d: FAIL (4.732s)
[370.517784] [046/131] (660s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[370.641819] Starting subtest: 2x-long-cursor-vs-flip-atomic
[370.646537] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[370.809677] [047/131] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[370.907203] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[370.911620] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[371.024699] [048/131] (660s left) kms_feature_discovery (display-1x)
[371.110451] Starting subtest: display-1x
[371.112762] Subtest display-1x: SUCCESS (0.000s)
[371.211623] [049/131] (660s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[371.317657] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[371.322072] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[371.469976] [050/131] (659s left) i915_drm_fdinfo (most-busy-idle-check-all)
[371.508885] Starting subtest: most-busy-idle-check-all
[371.510900] Starting dynamic subtest: rcs0
[371.517384] Dynamic subtest rcs0: SKIP (0.006s)
[371.527300] Starting dynamic subtest: bcs0
[371.530906] Dynamic subtest bcs0: SKIP (0.000s)
[371.539010] Starting dynamic subtest: vcs0
[371.542170] Dynamic subtest vcs0: SKIP (0.000s)
[371.550130] Starting dynamic subtest: vcs1
[371.553728] Dynamic subtest vcs1: SKIP (0.000s)
[371.561703] Starting dynamic subtest: vecs0
[371.565215] Dynamic subtest vecs0: SKIP (0.000s)
[371.573103] Starting dynamic subtest: ccs0
[371.576626] Dynamic subtest ccs0: SKIP (0.000s)
[371.580139] Subtest most-busy-idle-check-all: SKIP (0.011s)
[371.615551] [051/131] (659s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[371.755196] Starting subtest: x-tiled-32bpp-rotate-270
[371.775253] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[371.926943] [052/131] (659s left) gem_exec_schedule (u-submit-early-slice)
[372.004384] Starting subtest: u-submit-early-slice
[372.006378] Starting dynamic subtest: rcs0
[372.045396] Dynamic subtest rcs0: SUCCESS (0.045s)
[372.056399] Starting dynamic subtest: bcs0
[372.081587] Dynamic subtest bcs0: SUCCESS (0.036s)
[372.090980] Starting dynamic subtest: vcs0
[372.120038] Dynamic subtest vcs0: SUCCESS (0.038s)
[372.130884] Starting dynamic subtest: vcs1
[372.158355] Dynamic subtest vcs1: SUCCESS (0.038s)
[372.167091] Starting dynamic subtest: vecs0
[372.193827] Dynamic subtest vecs0: SUCCESS (0.035s)
[372.202617] Starting dynamic subtest: ccs0
[372.229007] Dynamic subtest ccs0: SUCCESS (0.035s)
[372.230991] Subtest u-submit-early-slice: SUCCESS (0.230s)
[373.280240] [053/131] (658s left) gem_pxp (regular-baseline-src-copy-readible)
[373.401357] Starting subtest: regular-baseline-src-copy-readible
[373.458307] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[373.611753] [054/131] (657s left) gem_exec_balancer (full-late-pulse)
[373.679141] Starting subtest: full-late-pulse
[378.011501] Subtest full-late-pulse: SUCCESS (4.330s)
[378.381816] [055/131] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[378.488191] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[378.492206] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[378.608545] [056/131] (652s left) fbdev (read)
[378.655726] Starting subtest: read
[379.184998] Subtest read: SUCCESS (0.527s)
[379.274851] [057/131] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[379.392867] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[379.397370] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[379.521307] [058/131] (652s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[379.624495] Starting subtest: multiplane-rotation-cropping-top
[396.962167] Subtest multiplane-rotation-cropping-top: SUCCESS (17.338s)
[397.137985] [059/131] (634s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[397.246745] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[404.243937] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.997s)
[404.412297] [060/131] (627s left) i915_selftest (mock)
[407.870669] Starting subtest: mock
[407.873591] Starting dynamic subtest: sanitycheck
[408.632484] Dynamic subtest sanitycheck: SUCCESS (0.762s)
[408.642218] Starting dynamic subtest: shmem
[409.370415] Dynamic subtest shmem: SUCCESS (0.736s)
[409.379990] Starting dynamic subtest: fence
[417.308109] Dynamic subtest fence: SUCCESS (7.935s)
[417.316853] Starting dynamic subtest: scatterlist
[419.063035] Dynamic subtest scatterlist: SUCCESS (1.753s)
[419.071541] Starting dynamic subtest: syncmap
[422.701127] Dynamic subtest syncmap: SUCCESS (3.635s)
[422.710879] Starting dynamic subtest: uncore
[423.432359] Dynamic subtest uncore: SUCCESS (0.729s)
[423.442094] Starting dynamic subtest: ring
[424.212477] Dynamic subtest ring: SUCCESS (0.778s)
[424.222000] Starting dynamic subtest: engine
[424.910383] Dynamic subtest engine: SUCCESS (0.696s)
[424.920155] Starting dynamic subtest: timelines
[428.865136] Dynamic subtest timelines: SUCCESS (3.952s)
[428.874817] Starting dynamic subtest: requests
[432.221691] Dynamic subtest requests: SUCCESS (3.355s)
[432.231557] Starting dynamic subtest: objects
[433.089807] Dynamic subtest objects: SUCCESS (0.867s)
[433.099239] Starting dynamic subtest: phys
[433.987652] Dynamic subtest phys: SUCCESS (0.896s)
[433.995797] Starting dynamic subtest: dmabuf
[434.844765] Dynamic subtest dmabuf: SUCCESS (0.855s)
[434.854595] Starting dynamic subtest: vma
[440.307612] Dynamic subtest vma: SUCCESS (5.460s)
[440.317119] Starting dynamic subtest: evict
[441.806369] Dynamic subtest evict: SUCCESS (1.497s)
[441.816229] Starting dynamic subtest: gtt
[445.151369] Dynamic subtest gtt: SUCCESS (3.343s)
[445.160953] Starting dynamic subtest: hugepages
[446.144083] Dynamic subtest hugepages: SUCCESS (0.991s)
[446.153969] Starting dynamic subtest: memory_region
[448.788781] Dynamic subtest memory_region: SUCCESS (2.642s)
[448.791462] Subtest mock: SUCCESS (40.922s)
[448.822869] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[448.823543] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[448.826826] [061/131] (582s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[455.293688] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[455.296035] Starting dynamic subtest: pipe-A-eDP-1
[456.098692] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s)
[456.107871] Starting dynamic subtest: pipe-B-eDP-1
[457.227120] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[457.231475] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.931s)
[458.675191] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[458.677115] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[458.681424] [062/131] (573s left) gem_render_copy_redux (normal)
[458.753720] Starting subtest: normal
[459.020000] Subtest normal: SUCCESS (0.265s)
[459.190198] [063/131] (572s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[459.258199] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[459.330465] [064/131] (572s left) gem_ctx_param (invalid-set-no-zeromap)
[459.383819] Starting subtest: invalid-set-no-zeromap
[459.386199] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[459.480872] [065/131] (572s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[459.583187] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[468.951948] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.371s)
[469.113550] [066/131] (562s left) i915_pm_rps (reset)
[469.193494] Starting subtest: reset
[477.612849] Subtest reset: SUCCESS (8.420s)
[477.787240] [067/131] (554s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[477.893014] Starting subtest: async-flip-with-page-flip-events-linear
[478.289669] Starting dynamic subtest: pipe-A-eDP-1
[481.063848] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.773s)
[481.449528] Starting dynamic subtest: pipe-B-eDP-1
[484.187984] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.747s)
[484.547603] Starting dynamic subtest: pipe-C-eDP-1
[487.312615] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s)
[487.688842] Starting dynamic subtest: pipe-D-eDP-1
[490.444252] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[490.446759] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.553s)
[491.660690] [068/131] (540s left) perf_pmu (module-unload)
[491.760179] Starting subtest: module-unload
[500.101652] Subtest module-unload: FAIL (8.234s)
[500.136355] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[500.137047] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[500.140002] [069/131] (531s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[501.772689] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[501.776960] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[501.886326] [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.887570] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[501.891193] [070/131] (530s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[501.956849] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[502.059391] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[502.160497] [071/131] (530s left) kms_cursor_crc (cursor-random-256x85)
[502.419127] Starting subtest: cursor-random-256x85
[502.470714] Subtest cursor-random-256x85: SKIP (0.047s)
[502.690770] [072/131] (529s left) kms_psr (psr-sprite-plane-move)
[502.794550] Starting subtest: psr-sprite-plane-move
[502.796896] Starting dynamic subtest: eDP-1
[504.591231] Dynamic subtest eDP-1: SUCCESS (1.797s)
[504.593603] Subtest psr-sprite-plane-move: SUCCESS (1.798s)
[505.426501] [073/131] (526s left) kms_psr (fbc-pr-sprite-plane-onoff)
[505.526192] Starting subtest: fbc-pr-sprite-plane-onoff
[505.530629] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[505.625952] [074/131] (526s left) kms_pm_rpm (pm-tiling)
[507.256064] Starting subtest: pm-tiling
[507.261252] Subtest pm-tiling: SKIP (0.000s)
[507.888063] [075/131] (524s left) gem_userptr_blits (invalid-null-pointer)
[507.962165] Starting subtest: invalid-null-pointer
[507.964534] Subtest invalid-null-pointer: SUCCESS (0.001s)
[508.114211] [076/131] (524s left) kms_content_protection (lic-type-1)
[508.252720] Starting subtest: lic-type-1
[508.256673] Subtest lic-type-1: SKIP (0.000s)
[508.393422] [077/131] (524s left) kms_atomic (plane-immutable-zpos)
[508.496421] Starting subtest: plane-immutable-zpos
[508.498633] Starting dynamic subtest: pipe-A-eDP-1
[509.133519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.637s)
[509.135829] Subtest plane-immutable-zpos: SUCCESS (0.638s)
[510.002270] [078/131] (522s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[510.130586] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[510.135305] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[510.322707] [079/131] (522s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[510.419719] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[510.422039] Starting dynamic subtest: pipe-A
[511.523059] Dynamic subtest pipe-A: SUCCESS (1.106s)
[511.533448] Starting dynamic subtest: pipe-B
[513.682072] Dynamic subtest pipe-B: SUCCESS (2.157s)
[513.692475] Starting dynamic subtest: pipe-C
[514.867863] Dynamic subtest pipe-C: SUCCESS (1.183s)
[514.882680] Starting dynamic subtest: pipe-D
[516.127587] Dynamic subtest pipe-D: SUCCESS (1.258s)
[516.129968] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.712s)
[517.319206] [080/131] (515s left) kms_psr (pr-sprite-mmap-cpu)
[517.417406] Starting subtest: pr-sprite-mmap-cpu
[517.421476] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[517.517960] [081/131] (515s left) gem_ctx_persistence (legacy-engines-cleanup)
[517.582761] Starting subtest: legacy-engines-cleanup
[517.584939] Starting dynamic subtest: render
[517.682250] Dynamic subtest render: SUCCESS (0.098s)
[517.694190] Starting dynamic subtest: bsd1
[517.733245] Dynamic subtest bsd1: SUCCESS (0.048s)
[517.743866] Starting dynamic subtest: bsd2
[517.802260] Dynamic subtest bsd2: SUCCESS (0.066s)
[517.813567] Starting dynamic subtest: blt
[517.861263] Dynamic subtest blt: SUCCESS (0.056s)
[517.871971] Starting dynamic subtest: vebox
[517.935646] Dynamic subtest vebox: SUCCESS (0.071s)
[517.938395] Subtest legacy-engines-cleanup: SUCCESS (0.353s)
[518.040672] [082/131] (514s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[518.155357] Starting subtest: cursor-tearing-framebuffer-change
[518.157909] Starting dynamic subtest: pipe-A-eDP-1
[518.723121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[518.732814] Starting dynamic subtest: pipe-D-eDP-1
[519.909241] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.186s)
[519.911657] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.754s)
[520.770509] [083/131] (511s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[520.889812] Starting subtest: 2x-cursor-vs-flip-atomic
[520.894434] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[521.060715] [084/131] (511s left) kms_cursor_crc (cursor-random-32x10)
[521.220453] Starting subtest: cursor-random-32x10
[521.266879] Subtest cursor-random-32x10: SKIP (0.041s)
[521.566978] [085/131] (511s left) kms_psr (fbc-psr-primary-mmap-gtt)
[521.664291] Starting subtest: fbc-psr-primary-mmap-gtt
[521.666599] Starting dynamic subtest: eDP-1
[521.670625] Dynamic subtest eDP-1: SKIP (0.000s)
[521.674684] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[521.761380] [086/131] (511s left) kms_big_fb (linear-8bpp-rotate-0)
[521.861147] Starting subtest: linear-8bpp-rotate-0
[523.072377] Subtest linear-8bpp-rotate-0: SUCCESS (1.213s)
[523.248180] [087/131] (509s left) gem_create (create-ext-cpu-access-sanity-check)
[523.424548] Starting subtest: create-ext-cpu-access-sanity-check
[523.430069] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[523.526569] [088/131] (509s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[523.627039] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[527.861966] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.238s)
[529.064790] [089/131] (503s left) kms_pm_rpm (cursor-dpms)
[531.308145] Starting subtest: cursor-dpms
[531.313040] Subtest cursor-dpms: SKIP (0.000s)
[531.696454] [090/131] (501s left) gem_lmem_swapping (verify-random-ccs)
[531.745266] Subtest verify-random-ccs: SKIP (0.000s)
[531.792254] [091/131] (501s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[531.915780] Starting subtest: flip-vs-cursor-toggle
[540.457556] Subtest flip-vs-cursor-toggle: SUCCESS (8.544s)
[541.307178] [092/131] (491s left) gem_lmem_swapping (heavy-verify-multi)
[541.356731] Subtest heavy-verify-multi: SKIP (0.000s)
[541.401300] [093/131] (491s left) i915_pm_freq_api (freq-reset)
[541.475359] Starting subtest: freq-reset
[541.477263] Starting dynamic subtest: gt0
[541.669692] Dynamic subtest gt0: SUCCESS (0.195s)
[541.677855] Starting dynamic subtest: gt1
[541.833500] Dynamic subtest gt1: SUCCESS (0.163s)
[541.836599] Subtest freq-reset: SUCCESS (0.360s)
[541.932421] [094/131] (491s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[542.033161] Starting subtest: y-tiled-64bpp-rotate-90
[542.037506] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[542.155246] [095/131] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[542.264553] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[542.268794] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[542.399768] [096/131] (490s left) kms_dirtyfb (default-dirtyfb-ioctl)
[542.501706] Starting subtest: default-dirtyfb-ioctl
[542.503624] Starting dynamic subtest: A-eDP-1
[544.075004] Dynamic subtest A-eDP-1: SUCCESS (1.574s)
[544.077359] Subtest default-dirtyfb-ioctl: SUCCESS (1.575s)
[544.947200] [097/131] (488s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[545.043391] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[545.045684] Starting dynamic subtest: pipe-A
[545.394090] Dynamic subtest pipe-A: SUCCESS (0.353s)
[545.403514] Starting dynamic subtest: pipe-B
[546.832541] Dynamic subtest pipe-B: SUCCESS (1.438s)
[546.844343] Starting dynamic subtest: pipe-C
[548.271184] Dynamic subtest pipe-C: SUCCESS (1.438s)
[548.288629] Starting dynamic subtest: pipe-D
[549.676970] Dynamic subtest pipe-D: SUCCESS (1.404s)
[549.679162] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.638s)
[550.871946] [098/131] (482s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[550.977336] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[550.979513] Starting dynamic subtest: pipe-A-default-mode
[551.292380] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[551.296726] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.316s)
[552.101886] [099/131] (481s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[552.221667] Starting subtest: 2x-cursor-vs-flip-legacy
[552.226017] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[552.392548] [100/131] (480s left) gem_readwrite (write-bad-handle)
[552.467745] Subtest write-bad-handle: SKIP (0.000s)
[552.534447] [101/131] (480s left) gem_reg_read (timestamp-monotonic)
[552.596789] Starting subtest: timestamp-monotonic
[556.621678] Subtest timestamp-monotonic: SUCCESS (4.027s)
[556.723850] [102/131] (476s left) kms_psr (fbc-psr2-cursor-plane-move)
[556.831191] Starting subtest: fbc-psr2-cursor-plane-move
[556.833447] Starting dynamic subtest: eDP-1
[556.837512] Dynamic subtest eDP-1: SKIP (0.000s)
[556.841536] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[556.931215] [103/131] (476s left) kms_plane_lowres (tiling-x)
[557.050229] Starting subtest: tiling-x
[557.052602] Starting dynamic subtest: pipe-A-eDP-1
[557.057257] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[557.342636] Starting dynamic subtest: pipe-B-eDP-1
[557.347352] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[557.356263] Starting dynamic subtest: pipe-C-eDP-1
[557.360944] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[557.369968] Starting dynamic subtest: pipe-D-eDP-1
[557.374328] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[557.378535] Subtest tiling-x: SKIP (0.293s)
[558.230552] [104/131] (475s left) kms_force_connector_basic (force-edid)
[558.306433] Starting subtest: force-edid
[558.669899] Subtest force-edid: SUCCESS (0.363s)
[558.833726] [105/131] (474s left) kms_getfb (getfb-handle-zero)
[558.936927] Starting subtest: getfb-handle-zero
[558.939407] Subtest getfb-handle-zero: SUCCESS (0.000s)
[559.073557] [106/131] (474s left) perf (missing-sample-flags)
[559.230159] Starting subtest: missing-sample-flags
[559.232075] Subtest missing-sample-flags: SUCCESS (0.000s)
[559.273848] [107/131] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[559.375126] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[566.000557] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.627s)
[566.179417] [108/131] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[566.281654] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[566.285575] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[566.414722] [109/131] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[566.521181] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[566.525305] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[566.659549] [110/131] (467s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[566.763840] Starting subtest: 4-tiled-8bpp-rotate-180
[568.001060] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[568.179452] [111/131] (465s left) gem_exec_fence (syncobj-timeline-repeat)
[568.742723] Starting subtest: syncobj-timeline-repeat
[569.001106] Subtest syncobj-timeline-repeat: SUCCESS (0.258s)
[570.168905] [112/131] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[570.268569] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[577.596474] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.331s)
[577.776437] [113/131] (456s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[577.836430] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[577.838724] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[577.977259] [114/131] (455s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[578.080923] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[581.800853] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.724s)
[582.955735] [115/131] (451s left) gem_exec_schedule (lateslice)
[583.030775] Starting subtest: lateslice
[583.032707] Starting dynamic subtest: rcs0
[583.040881] Dynamic subtest rcs0: SUCCESS (0.020s)
[583.050011] Starting dynamic subtest: bcs0
[583.060264] Dynamic subtest bcs0: SUCCESS (0.018s)
[583.069497] Starting dynamic subtest: vcs0
[583.080492] Dynamic subtest vcs0: SUCCESS (0.019s)
[583.091235] Starting dynamic subtest: vcs1
[583.099345] Dynamic subtest vcs1: SUCCESS (0.018s)
[583.110028] Starting dynamic subtest: vecs0
[583.117616] Dynamic subtest vecs0: SUCCESS (0.018s)
[583.126303] Starting dynamic subtest: ccs0
[583.134453] Dynamic subtest ccs0: SUCCESS (0.016s)
[583.136656] Subtest lateslice: SUCCESS (0.114s)
[585.254657] [116/131] (448s left) kms_vblank (query-idle-hang)
[585.360518] Starting subtest: query-idle-hang
[585.362735] Starting dynamic subtest: pipe-A-eDP-1
[611.942206] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.586s)
[611.956427] Starting dynamic subtest: pipe-D-eDP-1
[636.896281] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s)
[636.898710] Subtest query-idle-hang: SUCCESS (51.550s)
[637.720662] [117/131] (396s left) syncobj_wait (reset-multiple-signaled)
[637.789625] Starting subtest: reset-multiple-signaled
[637.791932] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[637.932770] [118/131] (396s left) kms_flip_event_leak (basic)
[638.027351] Starting subtest: basic
[638.029467] Starting dynamic subtest: pipe-A-eDP-1
[638.447615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[638.457198] Starting dynamic subtest: pipe-B-eDP-1
[639.588873] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[639.598973] Starting dynamic subtest: pipe-C-eDP-1
[640.672982] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.080s)
[640.682730] Starting dynamic subtest: pipe-D-eDP-1
[641.773515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.102s)
[641.775894] Subtest basic: SUCCESS (3.749s)
[642.637961] [119/131] (391s left) gem_pwrite_snooped
[642.791300] [120/131] (391s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[642.846660] Starting subtest: yf-tiled-ccs-to-y-tiled
[642.851827] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[643.056400] [121/131] (391s left) gem_ctx_shared (q-independent)
[643.118088] Starting subtest: Q-independent
[643.120552] Starting dynamic subtest: rcs0
[643.184608] Dynamic subtest rcs0: SUCCESS (0.065s)
[643.196734] Starting dynamic subtest: vcs0
[643.224344] Dynamic subtest vcs0: SUCCESS (0.040s)
[643.234496] Starting dynamic subtest: vcs1
[643.261613] Dynamic subtest vcs1: SUCCESS (0.037s)
[643.271401] Starting dynamic subtest: vecs0
[643.299031] Dynamic subtest vecs0: SUCCESS (0.037s)
[643.309394] Starting dynamic subtest: ccs0
[643.339015] Dynamic subtest ccs0: SUCCESS (0.039s)
[643.341453] Subtest Q-independent: SUCCESS (0.221s)
[645.272187] [122/131] (389s left) prime_mmap (test_userptr)
[645.325754] Starting subtest: test_userptr
[645.328016] Starting dynamic subtest: test_userptr-smem
[645.329926] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[645.331804] Subtest test_userptr: SUCCESS (0.001s)
[645.464743] [123/131] (388s left) kms_addfb_basic (bad-pitch-65536)
[645.526681] Starting subtest: bad-pitch-65536
[645.528912] Subtest bad-pitch-65536: SUCCESS (0.000s)
[645.708044] [124/131] (388s left) prime_self_import (basic-with_fd_dup)
[645.750489] Starting subtest: basic-with_fd_dup
[645.768391] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[645.896503] [125/131] (388s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[645.991616] Starting subtest: primary-y-tiled-reflect-x-0
[646.050793] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[646.175580] [126/131] (388s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[646.277995] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[646.281786] Starting dynamic subtest: pipe-A-eDP-1
[646.302014] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.312201] Starting dynamic subtest: pipe-B-eDP-1
[646.330230] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.338604] Starting dynamic subtest: pipe-C-eDP-1
[646.356025] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.364403] Starting dynamic subtest: pipe-D-eDP-1
[646.383356] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.386634] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[648.528462] [127/131] (385s left) kms_addfb_basic (unused-modifier)
[648.593706] Starting subtest: unused-modifier
[648.595882] Subtest unused-modifier: SUCCESS (0.000s)
[648.768077] [128/131] (385s left) kms_vblank (wait-idle)
[648.868149] Starting subtest: wait-idle
[648.870197] Starting dynamic subtest: pipe-A-eDP-1
[650.622504] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[650.637027] Starting dynamic subtest: pipe-D-eDP-1
[653.119146] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s)
[653.121626] Subtest wait-idle: SUCCESS (4.250s)
[654.033673] [129/131] (380s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[654.166849] Starting subtest: cursorA-vs-flipA-toggle
[665.314619] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.134s)
[666.136366] [130/131] (368s left) gen9_exec_parse (bb-start-far)
[666.208618] Subtest bb-start-far: SKIP (0.000s)
[666.298751] [131/131] (368s left) kms_addfb_basic (basic)
[666.362290] Starting subtest: basic
[666.364587] Subtest basic: SUCCESS (0.000s)
[666.543689] 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.