[57.453904] Initializing watchdogs
[57.453946]   /dev/watchdog0
[57.468650] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.472792] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.474828] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.477241] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[57.528586] Starting subtest: invalid-bad-pad
[57.529667] Subtest invalid-bad-pad: SUCCESS (0.000s)
[57.659797] [002/131] (960s left) tools_test (tools_test)
[57.693278] Starting subtest: tools_test
[57.748622] Subtest tools_test: SUCCESS (0.063s)
[57.824853] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[57.875164] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[57.944170] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[58.003882] Starting subtest: sync-unmap-cycles
[63.339939] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[63.516439] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[63.630887] Starting subtest: stress-xrgb8888-ytiled
[63.632545] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[63.707463] [006/131] (954s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[63.819098] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[63.820050] Starting dynamic subtest: pipe-A-eDP-1
[80.621571] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.292s)
[80.628446] Starting dynamic subtest: pipe-B-eDP-1
[98.572616] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.790s)
[98.580521] Starting dynamic subtest: pipe-C-eDP-1
[116.549068] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.714s)
[116.558239] Starting dynamic subtest: pipe-D-eDP-1
[134.562202] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[134.563122] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (14.539s)
[140.836140] [007/131] (882s left) api_intel_allocator (gem-pool)
[140.904401] Starting subtest: gem-pool
[140.919426] Subtest gem-pool: SUCCESS (0.015s)
[141.065427] [008/131] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[141.168013] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[147.499176] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.497s)
[147.623789] [009/131] (875s left) kms_atomic_interruptible (universal-setplane-primary)
[147.723491] Starting subtest: universal-setplane-primary
[147.724361] Starting dynamic subtest: pipe-A-eDP-1
[155.180405] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.538s)
[155.181382] Subtest universal-setplane-primary: SUCCESS (7.539s)
[156.071082] [010/131] (867s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[156.151572] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[160.499289] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.368s)
[161.681245] [011/131] (861s left) gem_eio (in-flight-contexts-1us)
[161.904070] Starting subtest: in-flight-contexts-1us
[172.190771] Subtest in-flight-contexts-1us: SUCCESS (10.300s)
[172.331356] [012/131] (850s left) gem_exec_balancer (semaphore)
[172.401882] Starting subtest: semaphore
[174.127445] Subtest semaphore: SUCCESS (1.723s)
[174.490811] [013/131] (848s left) kms_chamelium_hpd (hdmi-hpd)
[174.873804] Subtest hdmi-hpd: SKIP (0.000s)
[175.641045] [014/131] (847s left) kms_flip (wf_vblank-ts-check)
[175.732967] Starting subtest: wf_vblank-ts-check
[175.735756] Starting dynamic subtest: A-eDP1
[184.623104] Dynamic subtest A-eDP1: SUCCESS (8.889s)
[184.631926] Starting dynamic subtest: B-eDP1
[193.802311] Dynamic subtest B-eDP1: SUCCESS (9.181s)
[193.812977] Starting dynamic subtest: C-eDP1
[202.713477] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[202.736461] Starting dynamic subtest: D-eDP1
[211.646509] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[211.648936] Subtest wf_vblank-ts-check: SUCCESS (35.926s)
[212.891858] [015/131] (810s left) gem_exec_reloc (basic-gtt)
[212.964761] Subtest basic-gtt: SKIP (0.000s)
[213.066973] [016/131] (810s left) gem_exec_schedule (reorder-wide)
[213.248532] Subtest reorder-wide: SKIP (0.000s)
[213.440204] [017/131] (810s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[213.543013] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[213.544091] Starting dynamic subtest: pipe-A-eDP-1
[213.553477] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.560570] Starting dynamic subtest: pipe-B-eDP-1
[213.569679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.576784] Starting dynamic subtest: pipe-C-eDP-1
[213.585462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.592337] Starting dynamic subtest: pipe-D-eDP-1
[213.603874] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.605775] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[215.759365] [018/131] (807s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[215.852443] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[215.854084] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[215.970489] [019/131] (807s left) perf (polling)
[216.086000] Starting subtest: polling
[216.086880] Starting dynamic subtest: 0-rcs0
[226.115446] Dynamic subtest 0-rcs0: SUCCESS (10.032s)
[226.127272] Starting dynamic subtest: 1-vecs0
[236.136459] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[236.137380] Subtest polling: SUCCESS (20.052s)
[236.174610] [020/131] (787s left) gem_userptr_blits (probe)
[236.259292] Starting subtest: probe
[236.334857] Subtest probe: SUCCESS (0.074s)
[236.504127] [021/131] (787s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[236.611840] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[236.613640] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[236.745501] [022/131] (786s left) gem_mmap_offset (pf-nonblock)
[236.803371] Starting subtest: pf-nonblock
[236.809425] Subtest pf-nonblock: SUCCESS (0.007s)
[236.939700] [023/131] (786s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[237.038638] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[237.039592] Starting dynamic subtest: pipe-A-eDP-1
[237.049187] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[237.056837] Starting dynamic subtest: pipe-B-eDP-1
[237.065961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[237.072798] Starting dynamic subtest: pipe-C-eDP-1
[237.081559] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[237.088588] Starting dynamic subtest: pipe-D-eDP-1
[237.097647] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[237.099208] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[239.228000] [024/131] (784s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[239.327832] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[239.329663] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[239.465572] [025/131] (784s left) core_getstats (basic)
[239.524214] Starting subtest: basic
[239.525240] Subtest basic: SUCCESS (0.000s)
[239.646867] [026/131] (784s left) core_getclient (basic)
[239.706892] Starting subtest: basic
[239.708126] Subtest basic: SUCCESS (0.000s)
[239.838095] [027/131] (783s left) syncobj_timeline (multi-wait-all-available-submitted)
[239.896594] Starting subtest: multi-wait-all-available-submitted
[239.897731] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[240.005824] [028/131] (783s left) gem_exec_reloc (basic-write-wc)
[240.069558] Subtest basic-write-wc: SKIP (0.000s)
[240.153744] [029/131] (783s left) kms_invalid_mode (clock-too-high)
[240.249752] Starting subtest: clock-too-high
[240.250821] Starting dynamic subtest: pipe-A-eDP-1
[240.252694] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.260643] Starting dynamic subtest: pipe-B-eDP-1
[240.262397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.269245] Starting dynamic subtest: pipe-C-eDP-1
[240.271042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.277890] Starting dynamic subtest: pipe-D-eDP-1
[240.279704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.281489] Subtest clock-too-high: SKIP (0.004s)
[240.339640] [030/131] (783s left) gem_mmap_offset (bad-object)
[240.399348] Starting subtest: bad-object
[240.400594] Subtest bad-object: SUCCESS (0.001s)
[240.530028] [031/131] (783s left) syncobj_timeline (wait-all-delayed-signal)
[240.584000] Starting subtest: wait-all-delayed-signal
[240.689159] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[240.778423] [032/131] (783s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[240.890019] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[241.548589] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[241.736933] [033/131] (782s left) gem_exec_suspend (basic-s3)
[241.801221] Starting subtest: basic-S3
[241.802326] Starting dynamic subtest: smem
[261.977326] Dynamic subtest smem: SUCCESS (6.323s)
[261.979301] Subtest basic-S3: SUCCESS (6.324s)
[268.189347] [034/131] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[268.291158] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[268.293081] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[268.413042] [035/131] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[268.514282] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[268.515890] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[268.647080] [036/131] (761s left) kms_chamelium_frames (hdmi-crc-multiple)
[269.015890] Subtest hdmi-crc-multiple: SKIP (0.000s)
[269.816972] [037/131] (760s left) gem_exec_fence (syncobj-import)
[270.261314] Starting subtest: syncobj-import
[270.264646] Subtest syncobj-import: SUCCESS (0.005s)
[272.101167] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[272.103142] [038/131] (758s left) kms_legacy_colorkey (basic)
[272.190049] Starting subtest: basic
[272.191033] Starting dynamic subtest: pipe-A
[272.234189] Dynamic subtest pipe-A: SUCCESS (0.045s)
[272.245265] Starting dynamic subtest: pipe-B
[272.246127] Dynamic subtest pipe-B: SUCCESS (0.001s)
[272.252804] Starting dynamic subtest: pipe-C
[272.253664] Dynamic subtest pipe-C: SUCCESS (0.000s)
[272.260299] Starting dynamic subtest: pipe-D
[272.261169] Dynamic subtest pipe-D: SUCCESS (0.000s)
[272.261980] Subtest basic: SUCCESS (0.051s)
[272.318367] [039/131] (757s left) gem_softpin (allocator-nopin-reserve)
[272.373133] Starting subtest: allocator-nopin-reserve
[272.493683] Subtest allocator-nopin-reserve: SUCCESS (0.121s)
[272.640753] [040/131] (757s left) perf_pmu (enable-race)
[272.674658] Starting subtest: enable-race
[272.675473] Starting dynamic subtest: rcs0
[285.436757] Dynamic subtest rcs0: SUCCESS (12.905s)
[285.445755] Starting dynamic subtest: bcs0
[298.178968] Dynamic subtest bcs0: SUCCESS (12.771s)
[298.188293] Starting dynamic subtest: vcs0
[314.008999] Dynamic subtest vcs0: SUCCESS (15.822s)
[314.019161] Starting dynamic subtest: vcs1
[330.007811] Dynamic subtest vcs1: SUCCESS (15.998s)
[330.017425] Starting dynamic subtest: vecs0
[345.944913] Dynamic subtest vecs0: SUCCESS (15.939s)
[345.954816] Starting dynamic subtest: ccs0
[358.689215] Dynamic subtest ccs0: SUCCESS (12.749s)
[358.692146] Subtest enable-race: SUCCESS (86.196s)
[358.826688] [041/131] (671s left) syncobj_timeline (signal-point-0)
[358.872071] Starting subtest: signal-point-0
[358.873440] Subtest signal-point-0: SUCCESS (0.000s)
[359.000808] [042/131] (671s left) gem_tiled_wb
[359.128752] [043/131] (671s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[359.217948] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[359.218870] Starting dynamic subtest: pipe-A-eDP-1
[359.228356] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[359.235885] Starting dynamic subtest: pipe-B-eDP-1
[359.245535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[359.252514] Starting dynamic subtest: pipe-C-eDP-1
[359.261771] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[359.268215] Starting dynamic subtest: pipe-D-eDP-1
[359.277781] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[359.279648] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[361.382357] [044/131] (668s left) gem_ctx_param (set-priority-invalid-size)
[361.432366] Starting subtest: set-priority-invalid-size
[361.433450] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[361.517337] [045/131] (668s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[361.604356] Starting subtest: plane-ctm3x4-lut1d
[361.620323] Starting dynamic subtest: pipe-A-eDP-1
[362.068793] Dynamic subtest pipe-A-eDP-1: FAIL (0.301s)
[362.954509] Starting dynamic subtest: pipe-B-eDP-1
[363.409333] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[364.290392] Starting dynamic subtest: pipe-C-eDP-1
[364.753852] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[365.626262] Starting dynamic subtest: pipe-D-eDP-1
[366.120411] Dynamic subtest pipe-D-eDP-1: FAIL (0.284s)
[366.201198] Subtest plane-ctm3x4-lut1d: FAIL (4.598s)
[367.019361] [046/131] (663s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[367.144795] Starting subtest: 2x-long-cursor-vs-flip-atomic
[367.147682] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[367.309064] [047/131] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[367.407125] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[367.408839] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[367.549729] [048/131] (662s left) kms_feature_discovery (display-1x)
[367.641133] Starting subtest: display-1x
[367.642001] Subtest display-1x: SUCCESS (0.000s)
[367.732952] [049/131] (662s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[367.825719] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[367.827543] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[367.944139] [050/131] (662s left) i915_drm_fdinfo (most-busy-idle-check-all)
[367.985972] Starting subtest: most-busy-idle-check-all
[367.986978] Starting dynamic subtest: rcs0
[367.991535] Dynamic subtest rcs0: SKIP (0.004s)
[367.998899] Starting dynamic subtest: bcs0
[368.000770] Dynamic subtest bcs0: SKIP (0.000s)
[368.008034] Starting dynamic subtest: vcs0
[368.009830] Dynamic subtest vcs0: SKIP (0.000s)
[368.016732] Starting dynamic subtest: vcs1
[368.018543] Dynamic subtest vcs1: SKIP (0.000s)
[368.025703] Starting dynamic subtest: vecs0
[368.027539] Dynamic subtest vecs0: SKIP (0.000s)
[368.034473] Starting dynamic subtest: ccs0
[368.036258] Dynamic subtest ccs0: SKIP (0.000s)
[368.037982] Subtest most-busy-idle-check-all: SKIP (0.009s)
[368.080298] [051/131] (662s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[368.205253] Starting subtest: x-tiled-32bpp-rotate-270
[368.227627] Subtest x-tiled-32bpp-rotate-270: SKIP (0.022s)
[368.371787] [052/131] (662s left) gem_exec_schedule (u-submit-early-slice)
[368.442119] Starting subtest: u-submit-early-slice
[368.443436] Starting dynamic subtest: rcs0
[368.488260] Dynamic subtest rcs0: SUCCESS (0.045s)
[368.499077] Starting dynamic subtest: bcs0
[368.525298] Dynamic subtest bcs0: SUCCESS (0.037s)
[368.534274] Starting dynamic subtest: vcs0
[368.565766] Dynamic subtest vcs0: SUCCESS (0.040s)
[368.573942] Starting dynamic subtest: vcs1
[368.601069] Dynamic subtest vcs1: SUCCESS (0.035s)
[368.608331] Starting dynamic subtest: vecs0
[368.638014] Dynamic subtest vecs0: SUCCESS (0.036s)
[368.645236] Starting dynamic subtest: ccs0
[368.676819] Dynamic subtest ccs0: SUCCESS (0.038s)
[368.678499] Subtest u-submit-early-slice: SUCCESS (0.235s)
[370.166459] [053/131] (660s left) gem_pxp (regular-baseline-src-copy-readible)
[370.305826] Starting subtest: regular-baseline-src-copy-readible
[370.363528] Subtest regular-baseline-src-copy-readible: SUCCESS (0.059s)
[370.533614] [054/131] (660s left) gem_exec_balancer (full-late-pulse)
[370.603376] Starting subtest: full-late-pulse
[374.865483] Subtest full-late-pulse: SUCCESS (4.262s)
[375.226255] [055/131] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[375.340288] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[375.342519] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[375.479904] [056/131] (655s left) fbdev (read)
[375.525071] Starting subtest: read
[376.241450] Subtest read: SUCCESS (0.715s)
[376.324645] [057/131] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[376.419038] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[376.420776] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[376.559281] [058/131] (654s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[376.654141] Starting subtest: multiplane-rotation-cropping-top
[394.069592] Subtest multiplane-rotation-cropping-top: SUCCESS (17.415s)
[394.229327] [059/131] (636s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[394.335299] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[401.214714] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.877s)
[401.380955] [060/131] (629s left) i915_selftest (mock)
[406.159323] Starting subtest: mock
[406.160487] Starting dynamic subtest: sanitycheck
[406.798833] Dynamic subtest sanitycheck: SUCCESS (0.642s)
[406.805853] Starting dynamic subtest: shmem
[407.503826] Dynamic subtest shmem: SUCCESS (0.702s)
[407.511048] Starting dynamic subtest: fence
[415.174013] Dynamic subtest fence: SUCCESS (7.667s)
[415.187635] Starting dynamic subtest: scatterlist
[416.820473] Dynamic subtest scatterlist: SUCCESS (1.645s)
[416.828035] Starting dynamic subtest: syncmap
[420.071857] Dynamic subtest syncmap: SUCCESS (3.249s)
[420.081109] Starting dynamic subtest: uncore
[420.744846] Dynamic subtest uncore: SUCCESS (0.671s)
[420.752935] Starting dynamic subtest: ring
[421.395892] Dynamic subtest ring: SUCCESS (0.649s)
[421.404084] Starting dynamic subtest: engine
[422.064702] Dynamic subtest engine: SUCCESS (0.667s)
[422.072068] Starting dynamic subtest: timelines
[426.001627] Dynamic subtest timelines: SUCCESS (3.934s)
[426.008977] Starting dynamic subtest: requests
[429.153442] Dynamic subtest requests: SUCCESS (3.150s)
[429.161939] Starting dynamic subtest: objects
[429.917044] Dynamic subtest objects: SUCCESS (0.762s)
[429.925118] Starting dynamic subtest: phys
[430.727989] Dynamic subtest phys: SUCCESS (0.809s)
[430.734126] Starting dynamic subtest: dmabuf
[431.550128] Dynamic subtest dmabuf: SUCCESS (0.820s)
[431.564178] Starting dynamic subtest: vma
[437.175856] Dynamic subtest vma: SUCCESS (5.624s)
[437.182982] Starting dynamic subtest: evict
[438.553794] Dynamic subtest evict: SUCCESS (1.375s)
[438.561935] Starting dynamic subtest: gtt
[441.766699] Dynamic subtest gtt: SUCCESS (3.211s)
[441.774991] Starting dynamic subtest: hugepages
[442.653191] Dynamic subtest hugepages: SUCCESS (0.885s)
[442.661580] Starting dynamic subtest: memory_region
[445.238523] Dynamic subtest memory_region: SUCCESS (2.583s)
[445.239835] Subtest mock: SUCCESS (39.086s)
[445.261134] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[445.261810] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[445.264783] [061/131] (585s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[451.760807] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[451.764677] Starting dynamic subtest: pipe-A-eDP-1
[452.547440] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[452.555664] Starting dynamic subtest: pipe-B-eDP-1
[453.682621] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[453.684508] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.922s)
[454.895037] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[454.896310] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[454.898588] [062/131] (576s left) gem_render_copy_redux (normal)
[454.966604] Starting subtest: normal
[455.225869] Subtest normal: SUCCESS (0.259s)
[455.385271] [063/131] (575s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[455.438956] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[455.532217] [064/131] (575s left) gem_ctx_param (invalid-set-no-zeromap)
[455.582451] Starting subtest: invalid-set-no-zeromap
[455.583483] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[455.682715] [065/131] (575s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[455.786323] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[465.032692] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.245s)
[465.176882] [066/131] (565s left) i915_pm_rps (reset)
[465.245198] Starting subtest: reset
[473.770023] Subtest reset: SUCCESS (8.525s)
[473.940906] [067/131] (557s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[474.037396] Starting subtest: async-flip-with-page-flip-events-linear
[474.426072] Starting dynamic subtest: pipe-A-eDP-1
[477.172624] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s)
[477.531993] Starting dynamic subtest: pipe-B-eDP-1
[480.300419] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[480.659931] Starting dynamic subtest: pipe-C-eDP-1
[483.436684] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.781s)
[483.803402] Starting dynamic subtest: pipe-D-eDP-1
[486.568486] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[486.570224] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.533s)
[487.774388] [068/131] (543s left) perf_pmu (module-unload)
[487.865807] Starting subtest: module-unload
[497.242140] Subtest module-unload: FAIL (9.340s)
[497.265620] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[497.266376] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[497.268258] [069/131] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[498.769135] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[498.770861] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[498.879310] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[498.880528] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[498.882746] [070/131] (532s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[498.936374] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[499.044980] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[499.135698] [071/131] (532s left) kms_cursor_crc (cursor-random-256x85)
[499.385945] Starting subtest: cursor-random-256x85
[499.426770] Subtest cursor-random-256x85: SKIP (0.040s)
[499.632927] [072/131] (531s left) kms_psr (psr-sprite-plane-move)
[499.734761] Starting subtest: psr-sprite-plane-move
[499.735930] Starting dynamic subtest: eDP-1
[501.518855] Dynamic subtest eDP-1: SUCCESS (1.784s)
[501.519827] Subtest psr-sprite-plane-move: SUCCESS (1.785s)
[502.352533] [073/131] (528s left) kms_psr (fbc-pr-sprite-plane-onoff)
[502.447752] Starting subtest: fbc-pr-sprite-plane-onoff
[502.449794] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[502.540311] [074/131] (528s left) kms_pm_rpm (pm-tiling)
[504.161411] Starting subtest: pm-tiling
[504.164398] Subtest pm-tiling: SKIP (0.000s)
[504.788157] [075/131] (526s left) gem_userptr_blits (invalid-null-pointer)
[504.837573] Starting subtest: invalid-null-pointer
[504.838599] Subtest invalid-null-pointer: SUCCESS (0.001s)
[504.990504] [076/131] (526s left) kms_content_protection (lic-type-1)
[505.120621] Starting subtest: lic-type-1
[505.122712] Subtest lic-type-1: SKIP (0.000s)
[505.272591] [077/131] (526s left) kms_atomic (plane-immutable-zpos)
[505.366327] Starting subtest: plane-immutable-zpos
[505.367294] Starting dynamic subtest: pipe-A-eDP-1
[505.989219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[505.990195] Subtest plane-immutable-zpos: SUCCESS (0.625s)
[506.809670] [078/131] (524s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[506.925100] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[506.926881] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[507.089666] [079/131] (524s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[507.173343] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[507.174291] Starting dynamic subtest: pipe-A
[508.222115] Dynamic subtest pipe-A: SUCCESS (1.050s)
[508.230256] Starting dynamic subtest: pipe-B
[510.328847] Dynamic subtest pipe-B: SUCCESS (2.106s)
[510.335971] Starting dynamic subtest: pipe-C
[511.523100] Dynamic subtest pipe-C: SUCCESS (1.194s)
[511.531435] Starting dynamic subtest: pipe-D
[512.751131] Dynamic subtest pipe-D: SUCCESS (1.227s)
[512.753690] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.581s)
[513.961985] [080/131] (517s left) kms_psr (pr-sprite-mmap-cpu)
[514.058214] Starting subtest: pr-sprite-mmap-cpu
[514.059992] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[514.148698] [081/131] (517s left) gem_ctx_persistence (legacy-engines-cleanup)
[514.207410] Starting subtest: legacy-engines-cleanup
[514.208524] Starting dynamic subtest: render
[514.321850] Dynamic subtest render: SUCCESS (0.113s)
[514.333542] Starting dynamic subtest: bsd1
[514.389453] Dynamic subtest bsd1: SUCCESS (0.064s)
[514.401601] Starting dynamic subtest: bsd2
[514.461635] Dynamic subtest bsd2: SUCCESS (0.069s)
[514.473162] Starting dynamic subtest: blt
[514.493927] Dynamic subtest blt: SUCCESS (0.029s)
[514.501887] Starting dynamic subtest: vebox
[514.595628] Dynamic subtest vebox: SUCCESS (0.100s)
[514.597042] Subtest legacy-engines-cleanup: SUCCESS (0.389s)
[514.693065] [082/131] (516s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[514.801265] Starting subtest: cursor-tearing-framebuffer-change
[514.802182] Starting dynamic subtest: pipe-A-eDP-1
[515.355067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[515.362370] Starting dynamic subtest: pipe-D-eDP-1
[516.565595] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[516.566460] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.764s)
[517.414593] [083/131] (514s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[517.517028] Starting subtest: 2x-cursor-vs-flip-atomic
[517.518830] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[517.678400] [084/131] (514s left) kms_cursor_crc (cursor-random-32x10)
[517.836406] Starting subtest: cursor-random-32x10
[517.876687] Subtest cursor-random-32x10: SKIP (0.037s)
[518.177706] [085/131] (513s left) kms_psr (fbc-psr-primary-mmap-gtt)
[518.274314] Starting subtest: fbc-psr-primary-mmap-gtt
[518.275234] Starting dynamic subtest: eDP-1
[518.276902] Dynamic subtest eDP-1: SKIP (0.000s)
[518.278641] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[518.367520] [086/131] (513s left) kms_big_fb (linear-8bpp-rotate-0)
[518.464379] Starting subtest: linear-8bpp-rotate-0
[519.567249] Subtest linear-8bpp-rotate-0: SUCCESS (1.103s)
[519.741776] [087/131] (512s left) gem_create (create-ext-cpu-access-sanity-check)
[519.912289] Starting subtest: create-ext-cpu-access-sanity-check
[519.914806] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[520.003551] [088/131] (511s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[520.093800] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[524.247619] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.156s)
[525.414461] [089/131] (506s left) kms_pm_rpm (cursor-dpms)
[527.142744] Starting subtest: cursor-dpms
[527.145437] Subtest cursor-dpms: SKIP (0.000s)
[527.746138] [090/131] (504s left) gem_lmem_swapping (verify-random-ccs)
[527.784742] Subtest verify-random-ccs: SKIP (0.000s)
[527.820120] [091/131] (504s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[527.933744] Starting subtest: flip-vs-cursor-toggle
[536.535264] Subtest flip-vs-cursor-toggle: SUCCESS (8.602s)
[537.366265] [092/131] (494s left) gem_lmem_swapping (heavy-verify-multi)
[537.400048] Subtest heavy-verify-multi: SKIP (0.000s)
[537.436152] [093/131] (494s left) i915_pm_freq_api (freq-reset)
[537.507629] Starting subtest: freq-reset
[537.508794] Starting dynamic subtest: gt0
[537.705887] Dynamic subtest gt0: SUCCESS (0.197s)
[537.713040] Starting dynamic subtest: gt1
[537.874679] Dynamic subtest gt1: SUCCESS (0.166s)
[537.876169] Subtest freq-reset: SUCCESS (0.365s)
[537.966973] [094/131] (494s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[538.053326] Starting subtest: y-tiled-64bpp-rotate-90
[538.055162] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[538.189563] [095/131] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[538.296787] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[538.298546] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[538.425108] [096/131] (493s left) kms_dirtyfb (default-dirtyfb-ioctl)
[538.518343] Starting subtest: default-dirtyfb-ioctl
[538.519305] Starting dynamic subtest: A-eDP-1
[540.082982] Dynamic subtest A-eDP-1: SUCCESS (1.564s)
[540.083985] Subtest default-dirtyfb-ioctl: SUCCESS (1.566s)
[540.903780] [097/131] (491s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[541.000151] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[541.000943] Starting dynamic subtest: pipe-A
[541.353199] Dynamic subtest pipe-A: SUCCESS (0.353s)
[541.362237] Starting dynamic subtest: pipe-B
[542.784583] Dynamic subtest pipe-B: SUCCESS (1.430s)
[542.795120] Starting dynamic subtest: pipe-C
[544.202642] Dynamic subtest pipe-C: SUCCESS (1.416s)
[544.210400] Starting dynamic subtest: pipe-D
[545.629208] Dynamic subtest pipe-D: SUCCESS (1.426s)
[545.630347] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.631s)
[546.827310] [098/131] (485s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[546.928394] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[546.929242] Starting dynamic subtest: pipe-A-default-mode
[547.241292] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[547.243297] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s)
[548.054090] [099/131] (484s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[548.173127] Starting subtest: 2x-cursor-vs-flip-legacy
[548.176220] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[548.334239] [100/131] (483s left) gem_readwrite (write-bad-handle)
[548.398213] Subtest write-bad-handle: SKIP (0.000s)
[548.459954] [101/131] (483s left) gem_reg_read (timestamp-monotonic)
[548.513429] Starting subtest: timestamp-monotonic
[553.467100] Subtest timestamp-monotonic: SUCCESS (4.953s)
[553.560703] [102/131] (478s left) kms_psr (fbc-psr2-cursor-plane-move)
[553.666058] Starting subtest: fbc-psr2-cursor-plane-move
[553.666982] Starting dynamic subtest: eDP-1
[553.668955] Dynamic subtest eDP-1: SKIP (0.000s)
[553.670761] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[553.763331] [103/131] (478s left) kms_plane_lowres (tiling-x)
[553.859282] Starting subtest: tiling-x
[553.860244] Starting dynamic subtest: pipe-A-eDP-1
[553.862073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[554.149911] Starting dynamic subtest: pipe-B-eDP-1
[554.152145] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[554.159532] Starting dynamic subtest: pipe-C-eDP-1
[554.161507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[554.168875] Starting dynamic subtest: pipe-D-eDP-1
[554.170859] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[554.172869] Subtest tiling-x: SKIP (0.290s)
[554.986882] [104/131] (477s left) kms_force_connector_basic (force-edid)
[555.066303] Starting subtest: force-edid
[555.428288] Subtest force-edid: SUCCESS (0.363s)
[555.582516] [105/131] (476s left) kms_getfb (getfb-handle-zero)
[555.667194] Starting subtest: getfb-handle-zero
[555.668089] Subtest getfb-handle-zero: SUCCESS (0.000s)
[555.791715] [106/131] (476s left) perf (missing-sample-flags)
[555.916741] Starting subtest: missing-sample-flags
[555.917546] Subtest missing-sample-flags: SUCCESS (0.000s)
[555.951199] [107/131] (476s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[556.042242] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[562.597196] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.557s)
[562.787525] [108/131] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[562.893178] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[562.894899] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[563.015478] [109/131] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[563.113635] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[563.115450] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[563.249100] [110/131] (469s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[563.353379] Starting subtest: 4-tiled-8bpp-rotate-180
[564.475762] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.123s)
[564.642437] [111/131] (467s left) gem_exec_fence (syncobj-timeline-repeat)
[565.197668] Starting subtest: syncobj-timeline-repeat
[565.419187] Subtest syncobj-timeline-repeat: SUCCESS (0.222s)
[567.105980] [112/131] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[567.198500] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[574.352776] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.157s)
[574.506799] [113/131] (458s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[574.567547] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[574.568458] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[574.697013] [114/131] (458s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[574.786602] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[578.437662] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.652s)
[579.619256] [115/131] (453s left) gem_exec_schedule (lateslice)
[579.679644] Starting subtest: lateslice
[579.680653] Starting dynamic subtest: rcs0
[579.701682] Dynamic subtest rcs0: SUCCESS (0.022s)
[579.710101] Starting dynamic subtest: bcs0
[579.720452] Dynamic subtest bcs0: SUCCESS (0.018s)
[579.729794] Starting dynamic subtest: vcs0
[579.739468] Dynamic subtest vcs0: SUCCESS (0.018s)
[579.747219] Starting dynamic subtest: vcs1
[579.760184] Dynamic subtest vcs1: SUCCESS (0.020s)
[579.767805] Starting dynamic subtest: vecs0
[579.779444] Dynamic subtest vecs0: SUCCESS (0.018s)
[579.786975] Starting dynamic subtest: ccs0
[579.797230] Dynamic subtest ccs0: SUCCESS (0.017s)
[579.798308] Subtest lateslice: SUCCESS (0.118s)
[581.138743] [116/131] (451s left) kms_vblank (query-idle-hang)
[581.229335] Starting subtest: query-idle-hang
[581.230305] Starting dynamic subtest: pipe-A-eDP-1
[607.848881] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.626s)
[607.859980] Starting dynamic subtest: pipe-D-eDP-1
[622.731242] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.882s)
[622.732158] Subtest query-idle-hang: SUCCESS (41.513s)
[623.576822] [117/131] (409s left) syncobj_wait (reset-multiple-signaled)
[623.641804] Starting subtest: reset-multiple-signaled
[623.642830] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[623.780289] [118/131] (409s left) kms_flip_event_leak (basic)
[623.869526] Starting subtest: basic
[623.870522] Starting dynamic subtest: pipe-A-eDP-1
[624.289903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[624.298771] Starting dynamic subtest: pipe-B-eDP-1
[625.447152] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[625.454883] Starting dynamic subtest: pipe-C-eDP-1
[626.542049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[626.549799] Starting dynamic subtest: pipe-D-eDP-1
[627.639158] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[627.640163] Subtest basic: SUCCESS (3.772s)
[628.499639] [119/131] (404s left) gem_pwrite_snooped
[628.642584] [120/131] (404s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[628.708235] Starting subtest: yf-tiled-ccs-to-y-tiled
[628.710213] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[628.910257] [121/131] (404s left) gem_ctx_shared (q-independent)
[628.971249] Starting subtest: Q-independent
[628.972236] Starting dynamic subtest: rcs0
[629.044658] Dynamic subtest rcs0: SUCCESS (0.073s)
[629.054948] Starting dynamic subtest: vcs0
[629.087036] Dynamic subtest vcs0: SUCCESS (0.042s)
[629.095352] Starting dynamic subtest: vcs1
[629.131032] Dynamic subtest vcs1: SUCCESS (0.043s)
[629.140090] Starting dynamic subtest: vecs0
[629.171653] Dynamic subtest vecs0: SUCCESS (0.040s)
[629.180186] Starting dynamic subtest: ccs0
[629.216532] Dynamic subtest ccs0: SUCCESS (0.044s)
[629.217483] Subtest Q-independent: SUCCESS (0.246s)
[631.145292] [122/131] (401s left) prime_mmap (test_userptr)
[631.203129] Starting subtest: test_userptr
[631.203999] Starting dynamic subtest: test_userptr-smem
[631.204795] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[631.205554] Subtest test_userptr: SUCCESS (0.001s)
[631.338648] [123/131] (401s left) kms_addfb_basic (bad-pitch-65536)
[631.381690] Starting subtest: bad-pitch-65536
[631.382742] Subtest bad-pitch-65536: SUCCESS (0.000s)
[631.561730] [124/131] (401s left) prime_self_import (basic-with_fd_dup)
[631.598331] Starting subtest: basic-with_fd_dup
[631.615077] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[631.748054] [125/131] (401s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[631.849356] Starting subtest: primary-y-tiled-reflect-x-0
[631.920403] Subtest primary-y-tiled-reflect-x-0: SKIP (0.070s)
[632.037713] [126/131] (401s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[632.129450] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[632.130405] Starting dynamic subtest: pipe-A-eDP-1
[632.138998] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.146896] Starting dynamic subtest: pipe-B-eDP-1
[632.155326] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.163235] Starting dynamic subtest: pipe-C-eDP-1
[632.171598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.178704] Starting dynamic subtest: pipe-D-eDP-1
[632.187416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.189096] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[634.404721] [127/131] (398s left) kms_addfb_basic (unused-modifier)
[634.467985] Starting subtest: unused-modifier
[634.469019] Subtest unused-modifier: SUCCESS (0.000s)
[634.638868] [128/131] (398s left) kms_vblank (wait-idle)
[634.749529] Starting subtest: wait-idle
[634.750543] Starting dynamic subtest: pipe-A-eDP-1
[636.510960] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.761s)
[636.520428] Starting dynamic subtest: pipe-D-eDP-1
[638.983560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.471s)
[638.984480] Subtest wait-idle: SUCCESS (4.236s)
[639.874303] [129/131] (393s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[639.989861] Starting subtest: cursorA-vs-flipA-toggle
[651.116419] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s)
[651.977199] [130/131] (381s left) gen9_exec_parse (bb-start-far)
[652.049359] Subtest bb-start-far: SKIP (0.000s)
[652.125491] [131/131] (381s left) kms_addfb_basic (basic)
[652.179409] Starting subtest: basic
[652.180351] Subtest basic: SUCCESS (0.000s)
[652.326437] 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.