[59.117279] Initializing watchdogs
[59.117328]   /dev/watchdog0
[59.132164] [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]
[59.136865] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.139403] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.142731] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[59.221689] Starting subtest: invalid-bad-pad
[59.224110] Subtest invalid-bad-pad: SUCCESS (0.000s)
[59.337779] [002/131] (960s left) tools_test (tools_test)
[59.386410] Starting subtest: tools_test
[59.446973] Subtest tools_test: SUCCESS (0.075s)
[59.527085] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[59.596695] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[59.667940] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[59.762414] Starting subtest: sync-unmap-cycles
[65.134571] Subtest sync-unmap-cycles: SUCCESS (5.373s)
[65.319531] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[65.432648] Starting subtest: stress-xrgb8888-ytiled
[65.436448] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[65.508612] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[65.588610] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[65.590670] Starting dynamic subtest: pipe-A-eDP-1
[81.775707] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.821s)
[81.785005] Starting dynamic subtest: pipe-B-eDP-1
[98.775109] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[98.784263] Starting dynamic subtest: pipe-C-eDP-1
[115.723594] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.395s)
[115.732779] Starting dynamic subtest: pipe-D-eDP-1
[132.742754] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.370s)
[132.745068] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (13.044s)
[133.964564] [007/131] (885s left) api_intel_allocator (gem-pool)
[134.037176] Starting subtest: gem-pool
[134.044167] Subtest gem-pool: SUCCESS (0.010s)
[134.195544] [008/131] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[134.304648] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[140.750970] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.449s)
[140.902548] [009/131] (879s left) kms_atomic_interruptible (universal-setplane-primary)
[141.013928] Starting subtest: universal-setplane-primary
[141.016516] Starting dynamic subtest: pipe-A-eDP-1
[148.396277] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.380s)
[148.398956] Subtest universal-setplane-primary: SUCCESS (7.382s)
[149.246328] [010/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[149.357527] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[153.653093] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.300s)
[154.848775] [011/131] (865s left) gem_eio (in-flight-contexts-1us)
[155.051941] Starting subtest: in-flight-contexts-1us
[167.053275] Subtest in-flight-contexts-1us: SUCCESS (12.003s)
[167.261489] [012/131] (852s left) gem_exec_balancer (semaphore)
[167.331352] Starting subtest: semaphore
[169.023523] Subtest semaphore: SUCCESS (1.690s)
[169.340629] [013/131] (850s left) kms_chamelium_hpd (hdmi-hpd)
[169.728566] Subtest hdmi-hpd: SKIP (0.000s)
[170.557391] [014/131] (849s left) kms_flip (wf_vblank-ts-check)
[170.660032] Starting subtest: wf_vblank-ts-check
[170.662998] Starting dynamic subtest: A-eDP1
[179.590066] Dynamic subtest A-eDP1: SUCCESS (8.931s)
[179.601769] Starting dynamic subtest: B-eDP1
[188.520238] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[188.530418] Starting dynamic subtest: C-eDP1
[197.445908] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[197.458162] Starting dynamic subtest: D-eDP1
[206.371051] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[206.373803] Subtest wf_vblank-ts-check: SUCCESS (35.716s)
[207.631649] [015/131] (812s left) gem_exec_reloc (basic-gtt)
[207.713133] Subtest basic-gtt: SKIP (0.000s)
[207.796316] [016/131] (812s left) gem_exec_schedule (reorder-wide)
[207.979502] Subtest reorder-wide: SKIP (0.000s)
[208.181530] [017/131] (812s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[208.283181] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[208.285488] Starting dynamic subtest: pipe-A-eDP-1
[208.309719] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.320775] Starting dynamic subtest: pipe-B-eDP-1
[208.348363] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.356672] Starting dynamic subtest: pipe-C-eDP-1
[208.382882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.392823] Starting dynamic subtest: pipe-D-eDP-1
[208.420233] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.425235] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[210.584279] [018/131] (809s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[210.710501] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[210.715469] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[210.848478] [019/131] (809s left) perf (polling)
[210.990244] Starting subtest: polling
[210.992405] Starting dynamic subtest: 0-rcs0
[221.021467] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[221.030208] Starting dynamic subtest: 1-vcs1
[231.042314] Dynamic subtest 1-vcs1: SUCCESS (10.018s)
[231.045120] Subtest polling: SUCCESS (20.051s)
[231.092150] [020/131] (789s left) gem_userptr_blits (probe)
[231.173793] Starting subtest: probe
[231.250962] Subtest probe: SUCCESS (0.077s)
[231.395022] [021/131] (789s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[231.496672] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[231.502283] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[231.619581] [022/131] (788s left) gem_mmap_offset (pf-nonblock)
[231.677298] Starting subtest: pf-nonblock
[231.685081] Subtest pf-nonblock: SUCCESS (0.011s)
[231.846753] [023/131] (788s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[231.950502] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[231.953452] Starting dynamic subtest: pipe-A-eDP-1
[231.981792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.990984] Starting dynamic subtest: pipe-B-eDP-1
[232.015396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.023639] Starting dynamic subtest: pipe-C-eDP-1
[232.052087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.060332] Starting dynamic subtest: pipe-D-eDP-1
[232.086286] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.090816] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[234.254658] [024/131] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[234.365470] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[234.370253] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[234.482392] [025/131] (786s left) core_getstats (basic)
[234.541301] Starting subtest: basic
[234.543495] Subtest basic: SUCCESS (0.000s)
[234.673202] [026/131] (786s left) core_getclient (basic)
[234.727514] Starting subtest: basic
[234.730479] Subtest basic: SUCCESS (0.000s)
[234.854255] [027/131] (785s left) syncobj_timeline (multi-wait-all-available-submitted)
[234.912491] Starting subtest: multi-wait-all-available-submitted
[234.914970] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[235.039745] [028/131] (785s left) gem_exec_reloc (basic-write-wc)
[235.107748] Subtest basic-write-wc: SKIP (0.000s)
[235.190808] [029/131] (785s left) kms_invalid_mode (clock-too-high)
[235.292326] Starting subtest: clock-too-high
[235.294837] Starting dynamic subtest: pipe-A-eDP-1
[235.298894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.307956] Starting dynamic subtest: pipe-B-eDP-1
[235.312795] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.321323] Starting dynamic subtest: pipe-C-eDP-1
[235.326011] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.334186] Starting dynamic subtest: pipe-D-eDP-1
[235.338288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.342771] Subtest clock-too-high: SKIP (0.004s)
[235.383706] [030/131] (785s left) gem_mmap_offset (bad-object)
[235.441390] Starting subtest: bad-object
[235.444196] Subtest bad-object: SUCCESS (0.001s)
[235.558661] [031/131] (785s left) syncobj_timeline (wait-all-delayed-signal)
[235.617048] Starting subtest: wait-all-delayed-signal
[235.718412] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[235.822389] [032/131] (785s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[235.926097] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[236.618205] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[236.805947] [033/131] (784s left) gem_exec_suspend (basic-s3)
[236.874491] Starting subtest: basic-S3
[236.877137] Starting dynamic subtest: smem
[256.474748] Dynamic subtest smem: SUCCESS (6.116s)
[256.477550] Subtest basic-S3: SUCCESS (6.118s)
[256.683764] [034/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[256.796948] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[256.802110] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[256.914381] [035/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[257.006721] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[257.010671] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[257.143397] [036/131] (763s left) kms_chamelium_frames (hdmi-crc-multiple)
[257.539579] Subtest hdmi-crc-multiple: SKIP (0.000s)
[258.329196] [037/131] (762s left) gem_exec_fence (syncobj-import)
[258.810046] Starting subtest: syncobj-import
[258.815371] Subtest syncobj-import: SUCCESS (0.005s)
[260.620028] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[260.623830] [038/131] (760s left) kms_legacy_colorkey (basic)
[260.717393] Starting subtest: basic
[260.720171] Starting dynamic subtest: pipe-A
[260.760131] Dynamic subtest pipe-A: SUCCESS (0.045s)
[260.772212] Starting dynamic subtest: pipe-B
[260.774379] Dynamic subtest pipe-B: SUCCESS (0.001s)
[260.783552] Starting dynamic subtest: pipe-C
[260.786389] Dynamic subtest pipe-C: SUCCESS (0.000s)
[260.795531] Starting dynamic subtest: pipe-D
[260.798347] Dynamic subtest pipe-D: SUCCESS (0.000s)
[260.801151] Subtest basic: SUCCESS (0.050s)
[260.856648] [039/131] (760s left) gem_softpin (allocator-nopin-reserve)
[260.928377] Starting subtest: allocator-nopin-reserve
[261.029894] Subtest allocator-nopin-reserve: SUCCESS (0.102s)
[261.188541] [040/131] (760s left) perf_pmu (enable-race)
[261.227451] Starting subtest: enable-race
[261.230398] Starting dynamic subtest: rcs0
[274.013151] Dynamic subtest rcs0: SUCCESS (12.785s)
[274.022416] Starting dynamic subtest: bcs0
[286.757555] Dynamic subtest bcs0: SUCCESS (12.741s)
[286.769302] Starting dynamic subtest: vcs0
[302.489409] Dynamic subtest vcs0: SUCCESS (15.730s)
[302.499726] Starting dynamic subtest: vcs1
[318.489029] Dynamic subtest vcs1: SUCCESS (15.997s)
[318.499701] Starting dynamic subtest: vecs0
[334.490342] Dynamic subtest vecs0: SUCCESS (15.997s)
[334.500812] Starting dynamic subtest: ccs0
[347.237410] Dynamic subtest ccs0: SUCCESS (12.746s)
[347.240483] Subtest enable-race: SUCCESS (86.007s)
[347.372984] [041/131] (673s left) syncobj_timeline (signal-point-0)
[347.434575] Starting subtest: signal-point-0
[347.437559] Subtest signal-point-0: SUCCESS (0.000s)
[347.578844] [042/131] (673s left) gem_tiled_wb
[347.704962] [043/131] (673s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[347.807253] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[347.809741] Starting dynamic subtest: pipe-A-eDP-1
[347.836248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.846110] Starting dynamic subtest: pipe-B-eDP-1
[347.874141] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.882565] Starting dynamic subtest: pipe-C-eDP-1
[347.910464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.918852] Starting dynamic subtest: pipe-D-eDP-1
[347.946315] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.951231] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[350.043582] [044/131] (671s left) gem_ctx_param (set-priority-invalid-size)
[350.108123] Starting subtest: set-priority-invalid-size
[350.111180] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[350.209756] [045/131] (671s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[350.308004] Starting subtest: plane-ctm3x4-lut1d
[350.320876] Starting dynamic subtest: pipe-A-eDP-1
[351.074547] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s)
[351.700706] Starting dynamic subtest: pipe-B-eDP-1
[352.596814] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[353.033120] Starting dynamic subtest: pipe-C-eDP-1
[354.073590] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[354.358013] Starting dynamic subtest: pipe-D-eDP-1
[355.428331] Dynamic subtest pipe-D-eDP-1: FAIL (0.302s)
[355.431232] Subtest plane-ctm3x4-lut1d: FAIL (4.636s)
[355.765278] [046/131] (665s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[355.880336] Starting subtest: 2x-long-cursor-vs-flip-atomic
[355.885845] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[356.045200] [047/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[356.155466] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[356.161330] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[356.268878] [048/131] (665s left) kms_feature_discovery (display-1x)
[356.377289] Starting subtest: display-1x
[356.379618] Subtest display-1x: SUCCESS (0.000s)
[356.473875] [049/131] (665s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[356.571014] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[356.576525] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[356.709313] [050/131] (664s left) i915_drm_fdinfo (most-busy-idle-check-all)
[356.759282] Starting subtest: most-busy-idle-check-all
[356.761610] Starting dynamic subtest: rcs0
[356.766354] Dynamic subtest rcs0: SKIP (0.005s)
[356.775165] Starting dynamic subtest: bcs0
[356.779977] Dynamic subtest bcs0: SKIP (0.000s)
[356.788863] Starting dynamic subtest: vcs0
[356.793281] Dynamic subtest vcs0: SKIP (0.000s)
[356.801759] Starting dynamic subtest: vcs1
[356.806582] Dynamic subtest vcs1: SKIP (0.000s)
[356.815366] Starting dynamic subtest: vecs0
[356.820473] Dynamic subtest vecs0: SKIP (0.000s)
[356.829167] Starting dynamic subtest: ccs0
[356.834221] Dynamic subtest ccs0: SKIP (0.000s)
[356.839348] Subtest most-busy-idle-check-all: SKIP (0.010s)
[356.877127] [051/131] (664s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[357.030461] Starting subtest: x-tiled-32bpp-rotate-270
[357.053670] Subtest x-tiled-32bpp-rotate-270: SKIP (0.022s)
[357.212900] [052/131] (664s left) gem_exec_schedule (u-submit-early-slice)
[357.284947] Starting subtest: u-submit-early-slice
[357.286689] Starting dynamic subtest: rcs0
[357.323031] Dynamic subtest rcs0: SUCCESS (0.044s)
[357.333901] Starting dynamic subtest: bcs0
[357.366381] Dynamic subtest bcs0: SUCCESS (0.043s)
[357.375631] Starting dynamic subtest: vcs0
[357.405596] Dynamic subtest vcs0: SUCCESS (0.039s)
[357.414764] Starting dynamic subtest: vcs1
[357.441636] Dynamic subtest vcs1: SUCCESS (0.036s)
[357.449849] Starting dynamic subtest: vecs0
[357.483004] Dynamic subtest vecs0: SUCCESS (0.040s)
[357.492063] Starting dynamic subtest: ccs0
[357.516943] Dynamic subtest ccs0: SUCCESS (0.034s)
[357.519122] Subtest u-submit-early-slice: SUCCESS (0.239s)
[358.613405] [053/131] (663s left) gem_pxp (regular-baseline-src-copy-readible)
[358.738318] Starting subtest: regular-baseline-src-copy-readible
[358.797825] Subtest regular-baseline-src-copy-readible: SUCCESS (0.061s)
[358.966128] [054/131] (662s left) gem_exec_balancer (full-late-pulse)
[359.028549] Starting subtest: full-late-pulse
[363.390916] Subtest full-late-pulse: SUCCESS (4.362s)
[363.763063] [055/131] (658s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[363.865913] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[363.870583] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[364.022143] [056/131] (657s left) fbdev (read)
[364.067530] Starting subtest: read
[364.644875] Subtest read: SUCCESS (0.576s)
[364.733181] [057/131] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[364.831834] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[364.836581] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[364.982864] [058/131] (657s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[365.082367] Starting subtest: multiplane-rotation-cropping-top
[382.595574] Subtest multiplane-rotation-cropping-top: SUCCESS (17.516s)
[382.750370] [059/131] (639s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[382.854195] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[389.912416] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.059s)
[390.110603] [060/131] (632s left) i915_selftest (mock)
[393.617374] Starting subtest: mock
[393.620064] Starting dynamic subtest: sanitycheck
[395.577326] Dynamic subtest sanitycheck: SUCCESS (1.959s)
[395.587334] Starting dynamic subtest: shmem
[397.601023] Dynamic subtest shmem: SUCCESS (2.022s)
[397.611044] Starting dynamic subtest: fence
[406.647960] Dynamic subtest fence: SUCCESS (9.045s)
[406.657824] Starting dynamic subtest: scatterlist
[409.708770] Dynamic subtest scatterlist: SUCCESS (3.059s)
[409.722461] Starting dynamic subtest: syncmap
[414.283908] Dynamic subtest syncmap: SUCCESS (4.572s)
[414.300523] Starting dynamic subtest: uncore
[416.334592] Dynamic subtest uncore: SUCCESS (2.048s)
[416.343577] Starting dynamic subtest: ring
[418.284904] Dynamic subtest ring: SUCCESS (1.947s)
[418.301236] Starting dynamic subtest: engine
[420.317817] Dynamic subtest engine: SUCCESS (2.031s)
[420.328480] Starting dynamic subtest: timelines
[425.583550] Dynamic subtest timelines: SUCCESS (5.264s)
[425.591862] Starting dynamic subtest: requests
[430.543807] Dynamic subtest requests: SUCCESS (4.958s)
[430.552113] Starting dynamic subtest: objects
[432.626108] Dynamic subtest objects: SUCCESS (2.080s)
[432.635585] Starting dynamic subtest: phys
[434.861839] Dynamic subtest phys: SUCCESS (2.234s)
[434.871447] Starting dynamic subtest: dmabuf
[436.981303] Dynamic subtest dmabuf: SUCCESS (2.117s)
[436.991431] Starting dynamic subtest: vma
[443.674848] Dynamic subtest vma: SUCCESS (6.691s)
[443.684484] Starting dynamic subtest: evict
[446.505972] Dynamic subtest evict: SUCCESS (2.829s)
[446.515362] Starting dynamic subtest: gtt
[451.129724] Dynamic subtest gtt: SUCCESS (4.621s)
[451.139829] Starting dynamic subtest: hugepages
[453.333866] Dynamic subtest hugepages: SUCCESS (2.202s)
[453.343489] Starting dynamic subtest: memory_region
[457.292763] Dynamic subtest memory_region: SUCCESS (3.957s)
[457.295426] Subtest mock: SUCCESS (63.673s)
[457.326917] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[457.327702] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[457.331328] [061/131] (564s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[465.201437] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[465.204493] Starting dynamic subtest: pipe-A-eDP-1
[465.998370] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[466.006973] Starting dynamic subtest: pipe-B-eDP-1
[467.130344] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[467.134612] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.927s)
[468.360833] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[468.362147] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[468.365982] [062/131] (553s left) gem_render_copy_redux (normal)
[468.438340] Starting subtest: normal
[468.762310] Subtest normal: SUCCESS (0.324s)
[468.930095] [063/131] (553s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[469.003599] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[469.071928] [064/131] (553s left) gem_ctx_param (invalid-set-no-zeromap)
[469.131076] Starting subtest: invalid-set-no-zeromap
[469.133895] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[469.230391] [065/131] (553s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[469.332272] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[478.921161] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.590s)
[479.070958] [066/131] (543s left) i915_pm_rps (reset)
[479.132703] Starting subtest: reset
[487.555411] Subtest reset: SUCCESS (8.420s)
[487.706442] [067/131] (534s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[487.820420] Starting subtest: async-flip-with-page-flip-events-linear
[488.197354] Starting dynamic subtest: pipe-A-eDP-1
[490.997741] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[491.361572] Starting dynamic subtest: pipe-B-eDP-1
[494.121127] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[494.501113] Starting dynamic subtest: pipe-C-eDP-1
[497.257480] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s)
[497.647336] Starting dynamic subtest: pipe-D-eDP-1
[500.382347] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.758s)
[500.385302] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.563s)
[501.588836] [068/131] (520s left) perf_pmu (module-unload)
[501.704070] Starting subtest: module-unload
[509.848127] Subtest module-unload: FAIL (8.007s)
[509.884083] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[509.884833] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[509.888332] [069/131] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[512.742100] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[512.746455] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[512.850549] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[512.852830] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[512.858183] [070/131] (509s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[512.924826] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[513.027298] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[513.132554] [071/131] (509s left) kms_cursor_crc (cursor-random-256x85)
[513.391503] Starting subtest: cursor-random-256x85
[513.441253] Subtest cursor-random-256x85: SKIP (0.044s)
[513.658409] [072/131] (508s left) kms_psr (psr-sprite-plane-move)
[513.745543] Starting subtest: psr-sprite-plane-move
[513.748006] Starting dynamic subtest: eDP-1
[515.497982] Dynamic subtest eDP-1: SUCCESS (1.753s)
[515.500575] Subtest psr-sprite-plane-move: SUCCESS (1.754s)
[516.349498] [073/131] (506s left) kms_psr (fbc-pr-sprite-plane-onoff)
[516.445323] Starting subtest: fbc-pr-sprite-plane-onoff
[516.450494] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[516.539015] [074/131] (506s left) kms_pm_rpm (pm-tiling)
[518.666891] Starting subtest: pm-tiling
[518.672549] Subtest pm-tiling: SKIP (0.000s)
[519.052932] [075/131] (503s left) gem_userptr_blits (invalid-null-pointer)
[519.130587] Starting subtest: invalid-null-pointer
[519.132949] Subtest invalid-null-pointer: SUCCESS (0.001s)
[519.301324] [076/131] (503s left) kms_content_protection (lic-type-1)
[519.451451] Starting subtest: lic-type-1
[519.456748] Subtest lic-type-1: SKIP (0.000s)
[519.616923] [077/131] (503s left) kms_atomic (plane-immutable-zpos)
[519.722020] Starting subtest: plane-immutable-zpos
[519.724357] Starting dynamic subtest: pipe-A-eDP-1
[520.345576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[520.348596] Subtest plane-immutable-zpos: SUCCESS (0.625s)
[521.187479] [078/131] (501s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[521.313038] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[521.318006] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[521.486294] [079/131] (501s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[521.585377] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[521.588356] Starting dynamic subtest: pipe-A
[522.632281] Dynamic subtest pipe-A: SUCCESS (1.050s)
[522.642854] Starting dynamic subtest: pipe-B
[524.784119] Dynamic subtest pipe-B: SUCCESS (2.151s)
[524.792566] Starting dynamic subtest: pipe-C
[525.963422] Dynamic subtest pipe-C: SUCCESS (1.178s)
[525.972593] Starting dynamic subtest: pipe-D
[527.192371] Dynamic subtest pipe-D: SUCCESS (1.228s)
[527.194860] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.610s)
[528.417358] [080/131] (494s left) kms_psr (pr-sprite-mmap-cpu)
[528.519542] Starting subtest: pr-sprite-mmap-cpu
[528.525089] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[528.616418] [081/131] (494s left) gem_ctx_persistence (legacy-engines-cleanup)
[528.682323] Starting subtest: legacy-engines-cleanup
[528.685554] Starting dynamic subtest: render
[528.784952] Dynamic subtest render: SUCCESS (0.102s)
[528.797569] Starting dynamic subtest: bsd1
[528.839817] Dynamic subtest bsd1: SUCCESS (0.052s)
[528.850950] Starting dynamic subtest: bsd2
[528.887731] Dynamic subtest bsd2: SUCCESS (0.045s)
[528.898616] Starting dynamic subtest: blt
[528.951904] Dynamic subtest blt: SUCCESS (0.062s)
[528.964913] Starting dynamic subtest: vebox
[528.979534] Dynamic subtest vebox: SUCCESS (0.025s)
[528.982562] Subtest legacy-engines-cleanup: SUCCESS (0.298s)
[529.141117] [082/131] (493s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[529.251559] Starting subtest: cursor-tearing-framebuffer-change
[529.254380] Starting dynamic subtest: pipe-A-eDP-1
[529.811488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[529.821393] Starting dynamic subtest: pipe-D-eDP-1
[531.011245] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s)
[531.013541] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.756s)
[531.871270] [083/131] (491s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[531.992733] Starting subtest: 2x-cursor-vs-flip-atomic
[531.997225] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[532.161824] [084/131] (491s left) kms_cursor_crc (cursor-random-32x10)
[532.320215] Starting subtest: cursor-random-32x10
[532.364987] Subtest cursor-random-32x10: SKIP (0.040s)
[532.657796] [085/131] (490s left) kms_psr (fbc-psr-primary-mmap-gtt)
[532.761465] Starting subtest: fbc-psr-primary-mmap-gtt
[532.764381] Starting dynamic subtest: eDP-1
[532.769448] Dynamic subtest eDP-1: SKIP (0.000s)
[532.774958] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[532.861762] [086/131] (490s left) kms_big_fb (linear-8bpp-rotate-0)
[532.960801] Starting subtest: linear-8bpp-rotate-0
[534.220498] Subtest linear-8bpp-rotate-0: SUCCESS (1.259s)
[534.359247] [087/131] (488s left) gem_create (create-ext-cpu-access-sanity-check)
[534.539411] Starting subtest: create-ext-cpu-access-sanity-check
[534.544869] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[534.635723] [088/131] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[534.742715] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[538.906082] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.167s)
[540.075555] [089/131] (483s left) kms_pm_rpm (cursor-dpms)
[541.615847] Starting subtest: cursor-dpms
[541.621504] Subtest cursor-dpms: SKIP (0.000s)
[542.409862] [090/131] (481s left) gem_lmem_swapping (verify-random-ccs)
[542.460623] Subtest verify-random-ccs: SKIP (0.000s)
[542.508874] [091/131] (480s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[542.629941] Starting subtest: flip-vs-cursor-toggle
[551.302826] Subtest flip-vs-cursor-toggle: SUCCESS (8.672s)
[552.135358] [092/131] (471s left) gem_lmem_swapping (heavy-verify-multi)
[552.184205] Subtest heavy-verify-multi: SKIP (0.000s)
[552.230131] [093/131] (471s left) i915_pm_freq_api (freq-reset)
[552.315341] Starting subtest: freq-reset
[552.318387] Starting dynamic subtest: gt0
[552.512376] Dynamic subtest gt0: SUCCESS (0.200s)
[552.522896] Starting dynamic subtest: gt1
[552.678420] Dynamic subtest gt1: SUCCESS (0.164s)
[552.681587] Subtest freq-reset: SUCCESS (0.367s)
[552.782983] [094/131] (470s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[552.889494] Starting subtest: y-tiled-64bpp-rotate-90
[552.895069] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[553.026046] [095/131] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[553.136301] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[553.141995] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[553.269970] [096/131] (470s left) kms_dirtyfb (default-dirtyfb-ioctl)
[553.377354] Starting subtest: default-dirtyfb-ioctl
[553.379560] Starting dynamic subtest: A-eDP-1
[554.971439] Dynamic subtest A-eDP-1: SUCCESS (1.592s)
[554.974498] Subtest default-dirtyfb-ioctl: SUCCESS (1.593s)
[555.855085] [097/131] (467s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[555.965414] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[555.967817] Starting dynamic subtest: pipe-A
[556.329180] Dynamic subtest pipe-A: SUCCESS (0.365s)
[556.339117] Starting dynamic subtest: pipe-B
[557.741403] Dynamic subtest pipe-B: SUCCESS (1.410s)
[557.751137] Starting dynamic subtest: pipe-C
[559.169714] Dynamic subtest pipe-C: SUCCESS (1.427s)
[559.178830] Starting dynamic subtest: pipe-D
[560.625460] Dynamic subtest pipe-D: SUCCESS (1.454s)
[560.628033] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.663s)
[561.880160] [098/131] (461s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[561.980077] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[561.982323] Starting dynamic subtest: pipe-A-default-mode
[562.295983] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[562.301119] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.316s)
[563.094977] [099/131] (460s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[563.215851] Starting subtest: 2x-cursor-vs-flip-legacy
[563.221357] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[563.388079] [100/131] (460s left) gem_readwrite (write-bad-handle)
[563.438328] Subtest write-bad-handle: SKIP (0.000s)
[563.502818] [101/131] (460s left) gem_reg_read (timestamp-monotonic)
[563.562496] Starting subtest: timestamp-monotonic
[568.010735] Subtest timestamp-monotonic: SUCCESS (4.449s)
[568.116502] [102/131] (455s left) kms_psr (fbc-psr2-cursor-plane-move)
[568.215701] Starting subtest: fbc-psr2-cursor-plane-move
[568.218320] Starting dynamic subtest: eDP-1
[568.223036] Dynamic subtest eDP-1: SKIP (0.000s)
[568.227567] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[568.315745] [103/131] (455s left) kms_plane_lowres (tiling-x)
[568.420007] Starting subtest: tiling-x
[568.422320] Starting dynamic subtest: pipe-A-eDP-1
[568.426953] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[568.722027] Starting dynamic subtest: pipe-B-eDP-1
[568.726770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[568.741443] Starting dynamic subtest: pipe-C-eDP-1
[568.747385] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[568.759569] Starting dynamic subtest: pipe-D-eDP-1
[568.765162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[568.770436] Subtest tiling-x: SKIP (0.296s)
[569.536391] [104/131] (454s left) kms_force_connector_basic (force-edid)
[569.618216] Starting subtest: force-edid
[569.983558] Subtest force-edid: SUCCESS (0.366s)
[570.156824] [105/131] (453s left) kms_getfb (getfb-handle-zero)
[570.257281] Starting subtest: getfb-handle-zero
[570.260075] Subtest getfb-handle-zero: SUCCESS (0.000s)
[570.398193] [106/131] (453s left) perf (missing-sample-flags)
[570.538947] Starting subtest: missing-sample-flags
[570.541228] Subtest missing-sample-flags: SUCCESS (0.000s)
[570.581949] [107/131] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[570.688259] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[577.281202] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.595s)
[577.443132] [108/131] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[577.551594] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[577.557078] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[577.680969] [109/131] (446s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[577.773416] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[577.778775] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[577.898290] [110/131] (446s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[578.000314] Starting subtest: 4-tiled-8bpp-rotate-180
[579.244961] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.247s)
[579.419389] [111/131] (444s left) gem_exec_fence (syncobj-timeline-repeat)
[579.970556] Starting subtest: syncobj-timeline-repeat
[580.202028] Subtest syncobj-timeline-repeat: SUCCESS (0.231s)
[581.681994] [112/131] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[581.786710] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[589.120728] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.337s)
[589.270207] [113/131] (435s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[589.330060] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[589.332587] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[589.473997] [114/131] (435s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[589.578434] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[593.369586] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.795s)
[594.563815] [115/131] (429s left) gem_exec_schedule (lateslice)
[594.633907] Starting subtest: lateslice
[594.636182] Starting dynamic subtest: rcs0
[594.646570] Dynamic subtest rcs0: SUCCESS (0.025s)
[594.656350] Starting dynamic subtest: bcs0
[594.665947] Dynamic subtest bcs0: SUCCESS (0.019s)
[594.675269] Starting dynamic subtest: vcs0
[594.685095] Dynamic subtest vcs0: SUCCESS (0.018s)
[594.694427] Starting dynamic subtest: vcs1
[594.704618] Dynamic subtest vcs1: SUCCESS (0.019s)
[594.713849] Starting dynamic subtest: vecs0
[594.726290] Dynamic subtest vecs0: SUCCESS (0.021s)
[594.735588] Starting dynamic subtest: ccs0
[594.745994] Dynamic subtest ccs0: SUCCESS (0.018s)
[594.748384] Subtest lateslice: SUCCESS (0.124s)
[596.636584] [116/131] (427s left) kms_vblank (query-idle-hang)
[596.731839] Starting subtest: query-idle-hang
[596.734107] Starting dynamic subtest: pipe-A-eDP-1
[623.259406] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.525s)
[623.275320] Starting dynamic subtest: pipe-D-eDP-1
[648.280138] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.017s)
[648.282763] Subtest query-idle-hang: SUCCESS (51.547s)
[649.158578] [117/131] (375s left) syncobj_wait (reset-multiple-signaled)
[649.236501] Starting subtest: reset-multiple-signaled
[649.239453] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[649.377126] [118/131] (375s left) kms_flip_event_leak (basic)
[649.478547] Starting subtest: basic
[649.481166] Starting dynamic subtest: pipe-A-eDP-1
[649.907909] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[649.918027] Starting dynamic subtest: pipe-B-eDP-1
[651.010262] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.101s)
[651.020473] Starting dynamic subtest: pipe-C-eDP-1
[652.103713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.090s)
[652.113227] Starting dynamic subtest: pipe-D-eDP-1
[653.192502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.088s)
[653.195452] Subtest basic: SUCCESS (3.716s)
[654.058964] [119/131] (370s left) gem_pwrite_snooped
[654.186233] [120/131] (370s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[654.247955] Starting subtest: yf-tiled-ccs-to-y-tiled
[654.253379] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[654.451094] [121/131] (370s left) gem_ctx_shared (q-independent)
[654.516290] Starting subtest: Q-independent
[654.519173] Starting dynamic subtest: rcs0
[654.591539] Dynamic subtest rcs0: SUCCESS (0.075s)
[654.604909] Starting dynamic subtest: vcs0
[654.634100] Dynamic subtest vcs0: SUCCESS (0.042s)
[654.645598] Starting dynamic subtest: vcs1
[654.672421] Dynamic subtest vcs1: SUCCESS (0.038s)
[654.683788] Starting dynamic subtest: vecs0
[654.713595] Dynamic subtest vecs0: SUCCESS (0.040s)
[654.724809] Starting dynamic subtest: ccs0
[654.757167] Dynamic subtest ccs0: SUCCESS (0.043s)
[654.759959] Subtest Q-independent: SUCCESS (0.242s)
[656.614273] [122/131] (368s left) prime_mmap (test_userptr)
[656.664417] Starting subtest: test_userptr
[656.667358] Starting dynamic subtest: test_userptr-smem
[656.669547] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[656.671876] Subtest test_userptr: SUCCESS (0.001s)
[656.801874] [123/131] (368s left) kms_addfb_basic (bad-pitch-65536)
[656.870573] Starting subtest: bad-pitch-65536
[656.873000] Subtest bad-pitch-65536: SUCCESS (0.000s)
[657.048935] [124/131] (367s left) prime_self_import (basic-with_fd_dup)
[657.086604] Starting subtest: basic-with_fd_dup
[657.112364] Subtest basic-with_fd_dup: SUCCESS (0.027s)
[657.236191] [125/131] (367s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[657.326331] Starting subtest: primary-y-tiled-reflect-x-0
[657.386449] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[657.512856] [126/131] (367s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[657.617008] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[657.619355] Starting dynamic subtest: pipe-A-eDP-1
[657.639802] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[657.650684] Starting dynamic subtest: pipe-B-eDP-1
[657.671424] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[657.680384] Starting dynamic subtest: pipe-C-eDP-1
[657.703182] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[657.711782] Starting dynamic subtest: pipe-D-eDP-1
[657.734053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[657.738315] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[659.850972] [127/131] (365s left) kms_addfb_basic (unused-modifier)
[659.913873] Starting subtest: unused-modifier
[659.916007] Subtest unused-modifier: SUCCESS (0.000s)
[660.089938] [128/131] (365s left) kms_vblank (wait-idle)
[660.191106] Starting subtest: wait-idle
[660.193367] Starting dynamic subtest: pipe-A-eDP-1
[661.951679] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.759s)
[661.969271] Starting dynamic subtest: pipe-D-eDP-1
[664.444802] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[664.447551] Subtest wait-idle: SUCCESS (4.255s)
[665.355094] [129/131] (359s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[665.481190] Starting subtest: cursorA-vs-flipA-toggle
[676.613549] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.129s)
[677.454079] [130/131] (347s left) gen9_exec_parse (bb-start-far)
[677.528569] Subtest bb-start-far: SKIP (0.000s)
[677.596760] [131/131] (347s left) kms_addfb_basic (basic)
[677.650438] Starting subtest: basic
[677.652855] Subtest basic: SUCCESS (0.000s)
[677.804560] 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.