[47.805428] Initializing watchdogs
[47.805493]   /dev/watchdog0
[47.820361] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.826229] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.828704] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.830760] [001/131] (960s left) syncobj_eventfd (invalid-bad-pad)
[47.867134] Starting subtest: invalid-bad-pad
[47.867847] Subtest invalid-bad-pad: SUCCESS (0.000s)
[47.952889] [002/131] (960s left) tools_test (tools_test)
[47.987081] Starting subtest: tools_test
[48.059423] Subtest tools_test: SUCCESS (0.077s)
[48.136111] [003/131] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[48.167842] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[48.203631] [004/131] (960s left) gem_userptr_blits (sync-unmap-cycles)
[48.249032] Starting subtest: sync-unmap-cycles
[53.653493] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[53.752362] [005/131] (954s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[53.841351] Starting subtest: stress-xrgb8888-ytiled
[61.363708] Subtest stress-xrgb8888-ytiled: SUCCESS (7.522s)
[61.509021] [006/131] (947s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[61.597481] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[61.598177] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.600828] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[61.606076] Starting dynamic subtest: pipe-B-HDMI-A-1
[61.608747] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[61.613930] Starting dynamic subtest: pipe-C-HDMI-A-1
[61.616580] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[61.621640] Starting dynamic subtest: pipe-D-HDMI-A-1
[61.624314] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[61.625697] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[61.832950] [007/131] (946s left) api_intel_allocator (gem-pool)
[61.864908] Starting subtest: gem-pool
[61.871548] Subtest gem-pool: SUCCESS (0.007s)
[62.007214] [008/131] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[62.093622] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[62.095071] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[62.197908] [009/131] (946s left) kms_atomic_interruptible (universal-setplane-primary)
[62.283569] Starting subtest: universal-setplane-primary
[62.284322] Starting dynamic subtest: pipe-A-HDMI-A-1
[68.488461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.204s)
[68.489144] Subtest universal-setplane-primary: SUCCESS (6.206s)
[68.640591] [010/131] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[68.732581] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[70.393139] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (1.661s)
[70.554910] [011/131] (938s left) gem_eio (in-flight-contexts-1us)
[70.600110] Starting subtest: in-flight-contexts-1us
[83.880771] Subtest in-flight-contexts-1us: SUCCESS (13.276s)
[84.017470] [012/131] (924s left) gem_exec_balancer (semaphore)
[84.057390] Starting subtest: semaphore
[85.334757] Subtest semaphore: SUCCESS (1.277s)
[85.529790] [013/131] (923s left) kms_chamelium_hpd (hdmi-hpd)
[85.666373] Subtest hdmi-hpd: SKIP (0.000s)
[85.760998] [014/131] (923s left) kms_flip (wf_vblank-ts-check)
[85.847515] Starting subtest: wf_vblank-ts-check
[85.849857] Starting dynamic subtest: A-HDMI-A1
[93.677341] Dynamic subtest A-HDMI-A1: SUCCESS (7.808s)
[93.683030] Starting dynamic subtest: B-HDMI-A1
[101.484024] Dynamic subtest B-HDMI-A1: SUCCESS (7.796s)
[101.489694] Starting dynamic subtest: C-HDMI-A1
[109.290982] Dynamic subtest C-HDMI-A1: SUCCESS (7.806s)
[109.296533] Starting dynamic subtest: D-HDMI-A1
[117.065736] Dynamic subtest D-HDMI-A1: SUCCESS (7.798s)
[117.066428] Subtest wf_vblank-ts-check: SUCCESS (31.216s)
[117.211701] [015/131] (891s left) gem_exec_reloc (basic-gtt)
[117.255714] Starting subtest: basic-gtt
[117.262648] Subtest basic-gtt: SUCCESS (0.007s)
[117.395954] [016/131] (891s left) gem_exec_schedule (reorder-wide)
[117.559200] Starting subtest: reorder-wide
[117.560221] Starting dynamic subtest: rcs0
[117.656456] Dynamic subtest rcs0: SUCCESS (0.097s)
[117.666196] Starting dynamic subtest: bcs0
[117.727045] Dynamic subtest bcs0: SUCCESS (0.070s)
[117.736122] Starting dynamic subtest: vcs0
[117.796535] Dynamic subtest vcs0: SUCCESS (0.069s)
[117.805753] Starting dynamic subtest: vcs1
[117.867128] Dynamic subtest vcs1: SUCCESS (0.070s)
[117.876488] Starting dynamic subtest: vecs0
[117.939359] Dynamic subtest vecs0: SUCCESS (0.071s)
[117.940337] Subtest reorder-wide: SUCCESS (0.380s)
[118.133756] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[118.135712] [017/131] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[118.218644] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[118.219361] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.356304] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.134s)
[118.364152] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.458217] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.101s)
[118.464324] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.564371] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.105s)
[118.570450] Starting dynamic subtest: pipe-D-HDMI-A-1
[118.667894] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.102s)
[118.668581] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.447s)
[118.962293] [018/131] (889s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[119.051658] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[119.053072] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[119.149224] [019/131] (889s left) perf (polling)
[119.250420] Starting subtest: polling
[119.251115] Starting dynamic subtest: 0-rcs0
[129.299241] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[129.300217] Subtest polling: SUCCESS (10.015s)
[129.361095] [020/131] (879s left) gem_userptr_blits (probe)
[129.420576] Starting subtest: probe
[129.524794] Subtest probe: SUCCESS (0.104s)
[129.652629] [021/131] (879s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[129.747063] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[129.748404] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[129.861484] [022/131] (879s left) gem_mmap_offset (pf-nonblock)
[129.892648] Starting subtest: pf-nonblock
[129.895997] Subtest pf-nonblock: SUCCESS (0.004s)
[130.035810] [023/131] (879s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[130.118840] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[130.119564] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.127178] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[130.135068] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.142438] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[130.149953] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.157310] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[130.164477] Starting dynamic subtest: pipe-D-HDMI-A-1
[130.172006] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[130.173382] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[130.364884] [024/131] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[130.452232] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[130.453540] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[130.570108] [025/131] (878s left) core_getstats (basic)
[130.600642] Starting subtest: basic
[130.601347] Subtest basic: SUCCESS (0.000s)
[130.685175] [026/131] (878s left) core_getclient (basic)
[130.715823] Starting subtest: basic
[130.716491] Subtest basic: SUCCESS (0.000s)
[130.800141] [027/131] (878s left) syncobj_timeline (multi-wait-all-available-submitted)
[130.832406] Starting subtest: multi-wait-all-available-submitted
[130.833126] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[130.918314] [028/131] (878s left) gem_exec_reloc (basic-write-wc)
[130.954605] Starting subtest: basic-write-wc
[130.959965] Subtest basic-write-wc: SUCCESS (0.005s)
[131.096040] [029/131] (878s left) kms_invalid_mode (clock-too-high)
[131.179406] Starting subtest: clock-too-high
[131.180126] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.236682] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[131.246287] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.249871] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.012s)
[131.259600] Starting dynamic subtest: pipe-C-HDMI-A-1
[131.262073] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.011s)
[131.271562] Starting dynamic subtest: pipe-D-HDMI-A-1
[131.275741] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.012s)
[131.276422] Subtest clock-too-high: SUCCESS (0.096s)
[131.432827] [030/131] (878s left) gem_mmap_offset (bad-object)
[131.466895] Starting subtest: bad-object
[131.468382] Subtest bad-object: SUCCESS (0.001s)
[131.574711] [031/131] (877s left) syncobj_timeline (wait-all-delayed-signal)
[131.606558] Starting subtest: wait-all-delayed-signal
[131.708321] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[131.796647] [032/131] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[131.889909] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[132.182398] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.293s)
[132.366862] [033/131] (877s left) gem_exec_suspend (basic-s3)
[132.406774] Starting subtest: basic-S3
[132.407495] Starting dynamic subtest: smem
[149.973646] Dynamic subtest smem: SUCCESS (3.152s)
[149.974398] Subtest basic-S3: SUCCESS (3.153s)
[158.201671] [034/131] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[158.292958] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[158.294300] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[158.407275] [035/131] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[158.493892] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[158.495256] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[158.614279] [036/131] (859s left) kms_chamelium_frames (hdmi-crc-multiple)
[158.752461] Subtest hdmi-crc-multiple: SKIP (0.000s)
[158.844356] [037/131] (858s left) gem_exec_fence (syncobj-import)
[159.168517] Starting subtest: syncobj-import
[159.170956] Subtest syncobj-import: SUCCESS (0.002s)
[159.486814] [038/131] (858s left) kms_legacy_colorkey (basic)
[159.569027] Starting subtest: basic
[159.569702] Starting dynamic subtest: pipe-A
[159.619302] Dynamic subtest pipe-A: SUCCESS (0.050s)
[159.634712] Starting dynamic subtest: pipe-B
[159.635550] Dynamic subtest pipe-B: SUCCESS (0.001s)
[159.644376] Starting dynamic subtest: pipe-C
[159.645054] Dynamic subtest pipe-C: SUCCESS (0.001s)
[159.650972] Starting dynamic subtest: pipe-D
[159.651644] Dynamic subtest pipe-D: SUCCESS (0.001s)
[159.652317] Subtest basic: SUCCESS (0.058s)
[159.742380] [039/131] (858s left) gem_softpin (allocator-nopin-reserve)
[159.777893] Starting subtest: allocator-nopin-reserve
[159.855999] Subtest allocator-nopin-reserve: SUCCESS (0.078s)
[159.993249] [040/131] (857s left) perf_pmu (enable-race)
[160.027063] Starting subtest: enable-race
[160.027814] Starting dynamic subtest: rcs0
[172.619456] Dynamic subtest rcs0: SUCCESS (12.566s)
[172.634323] Starting dynamic subtest: bcs0
[185.199217] Dynamic subtest bcs0: SUCCESS (12.581s)
[185.213765] Starting dynamic subtest: vcs0
[197.784522] Dynamic subtest vcs0: SUCCESS (12.577s)
[197.793875] Starting dynamic subtest: vcs1
[210.353990] Dynamic subtest vcs1: SUCCESS (12.573s)
[210.368673] Starting dynamic subtest: vecs0
[222.924941] Dynamic subtest vecs0: SUCCESS (12.583s)
[222.925650] Subtest enable-race: SUCCESS (62.883s)
[223.013683] [041/131] (794s left) syncobj_timeline (signal-point-0)
[223.045848] Starting subtest: signal-point-0
[223.046564] Subtest signal-point-0: SUCCESS (0.000s)
[223.132223] [042/131] (794s left) gem_tiled_wb
[227.807917] [043/131] (790s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[227.894227] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[227.895836] Starting dynamic subtest: pipe-A-HDMI-A-1
[228.422814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[228.429509] Starting dynamic subtest: pipe-B-HDMI-A-1
[228.998009] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.574s)
[229.006326] Starting dynamic subtest: pipe-C-HDMI-A-1
[229.581268] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.582s)
[229.588002] Starting dynamic subtest: pipe-D-HDMI-A-1
[230.156169] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.573s)
[230.157000] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.260s)
[230.314619] [044/131] (787s left) gem_ctx_param (set-priority-invalid-size)
[230.348068] Starting subtest: set-priority-invalid-size
[230.348759] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[230.433416] [045/131] (787s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[230.523999] Starting subtest: plane-ctm3x4-lut1d
[230.536817] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.703700] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s)
[230.847665] Starting dynamic subtest: pipe-B-HDMI-A-1
[230.998006] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.157s)
[231.153243] Starting dynamic subtest: pipe-C-HDMI-A-1
[231.301855] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.156s)
[231.440465] Starting dynamic subtest: pipe-D-HDMI-A-1
[231.582362] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.148s)
[231.647286] Subtest plane-ctm3x4-lut1d: SUCCESS (1.124s)
[231.766494] [046/131] (786s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[231.855281] Starting subtest: 2x-long-cursor-vs-flip-atomic
[231.857509] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[231.947068] [047/131] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[232.036274] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[233.351030] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.315s)
[233.483219] [048/131] (784s left) kms_feature_discovery (display-1x)
[233.570990] Starting subtest: display-1x
[233.571675] Subtest display-1x: SUCCESS (0.000s)
[233.648412] [049/131] (784s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[233.742154] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[234.000362] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.258s)
[234.166031] [050/131] (784s left) i915_drm_fdinfo (most-busy-idle-check-all)
[234.201453] Starting subtest: most-busy-idle-check-all
[234.202145] Starting dynamic subtest: rcs0
[234.863043] Dynamic subtest rcs0: SUCCESS (0.661s)
[234.879258] Starting dynamic subtest: bcs0
[235.498758] Dynamic subtest bcs0: SUCCESS (0.634s)
[235.510173] Starting dynamic subtest: vcs0
[236.136703] Dynamic subtest vcs0: SUCCESS (0.636s)
[236.147941] Starting dynamic subtest: vcs1
[236.784681] Dynamic subtest vcs1: SUCCESS (0.646s)
[236.796280] Starting dynamic subtest: vecs0
[237.424699] Dynamic subtest vecs0: SUCCESS (0.639s)
[237.425797] Subtest most-busy-idle-check-all: SUCCESS (3.224s)
[237.519008] [051/131] (780s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[237.628472] Starting subtest: x-tiled-32bpp-rotate-270
[237.706759] Subtest x-tiled-32bpp-rotate-270: SKIP (0.078s)
[237.804799] [052/131] (780s left) gem_exec_schedule (u-submit-early-slice)
[237.850266] Starting subtest: u-submit-early-slice
[237.850992] Starting dynamic subtest: rcs0
[237.880323] Dynamic subtest rcs0: SUCCESS (0.030s)
[237.887636] Starting dynamic subtest: bcs0
[237.906364] Dynamic subtest bcs0: SUCCESS (0.025s)
[237.913612] Starting dynamic subtest: vcs0
[237.931218] Dynamic subtest vcs0: SUCCESS (0.024s)
[237.938220] Starting dynamic subtest: vcs1
[237.957266] Dynamic subtest vcs1: SUCCESS (0.025s)
[237.964436] Starting dynamic subtest: vecs0
[237.987547] Dynamic subtest vecs0: SUCCESS (0.030s)
[237.988267] Subtest u-submit-early-slice: SUCCESS (0.138s)
[238.312602] [053/131] (780s left) gem_pxp (regular-baseline-src-copy-readible)
[238.414005] Starting subtest: regular-baseline-src-copy-readible
[238.459905] Subtest regular-baseline-src-copy-readible: SUCCESS (0.048s)
[238.610700] [054/131] (779s left) gem_exec_balancer (full-late-pulse)
[238.651728] Starting subtest: full-late-pulse
[240.209829] Subtest full-late-pulse: SUCCESS (1.558s)
[240.415364] [055/131] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[240.509220] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[240.510598] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[240.618274] [056/131] (777s left) fbdev (read)
[240.653313] Starting subtest: read
[241.317520] Subtest read: SUCCESS (0.655s)
[241.386919] [057/131] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[241.475273] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[241.476668] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[241.578504] [058/131] (777s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[241.664334] Starting subtest: multiplane-rotation-cropping-top
[267.590176] Subtest multiplane-rotation-cropping-top: SUCCESS (25.927s)
[267.738939] [059/131] (750s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[267.838203] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[267.839627] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[267.938958] [060/131] (750s left) i915_selftest (mock)
[268.945081] Starting subtest: mock
[268.945971] Starting dynamic subtest: sanitycheck
[269.709423] Dynamic subtest sanitycheck: SUCCESS (0.719s)
[269.714678] Starting dynamic subtest: shmem
[270.382156] Dynamic subtest shmem: SUCCESS (0.712s)
[270.396962] Starting dynamic subtest: fence
[278.404028] Dynamic subtest fence: SUCCESS (8.020s)
[278.414004] Starting dynamic subtest: scatterlist
[280.113872] Dynamic subtest scatterlist: SUCCESS (1.707s)
[280.122443] Starting dynamic subtest: syncmap
[283.069984] Dynamic subtest syncmap: SUCCESS (2.954s)
[283.075796] Starting dynamic subtest: uncore
[283.812088] Dynamic subtest uncore: SUCCESS (0.740s)
[283.822134] Starting dynamic subtest: ring
[284.553060] Dynamic subtest ring: SUCCESS (0.739s)
[284.562883] Starting dynamic subtest: engine
[285.281153] Dynamic subtest engine: SUCCESS (0.726s)
[285.291125] Starting dynamic subtest: timelines
[289.722969] Dynamic subtest timelines: SUCCESS (4.440s)
[289.731239] Starting dynamic subtest: requests
[292.522237] Dynamic subtest requests: SUCCESS (2.797s)
[292.535254] Starting dynamic subtest: objects
[293.359130] Dynamic subtest objects: SUCCESS (0.835s)
[293.368085] Starting dynamic subtest: phys
[294.155092] Dynamic subtest phys: SUCCESS (0.793s)
[294.164251] Starting dynamic subtest: dmabuf
[294.981162] Dynamic subtest dmabuf: SUCCESS (0.824s)
[294.990378] Starting dynamic subtest: vma
[302.355128] Dynamic subtest vma: SUCCESS (7.371s)
[302.363746] Starting dynamic subtest: evict
[304.017186] Dynamic subtest evict: SUCCESS (1.660s)
[304.025846] Starting dynamic subtest: gtt
[307.754069] Dynamic subtest gtt: SUCCESS (3.734s)
[307.759740] Starting dynamic subtest: hugepages
[308.721098] Dynamic subtest hugepages: SUCCESS (0.964s)
[308.731151] Starting dynamic subtest: memory_region
[312.005233] Dynamic subtest memory_region: SUCCESS (3.282s)
[312.006223] Subtest mock: SUCCESS (43.058s)
[312.035725] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[312.036589] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[312.038705] [061/131] (706s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[313.151456] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[313.205297] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[313.206992] [FACT kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[313.210106] [062/131] (705s left) gem_render_copy_redux (normal)
[313.252322] Starting subtest: normal
[313.589232] Subtest normal: SUCCESS (0.328s)
[313.720358] [063/131] (705s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[313.757920] Starting subtest: basic-cpu-wc-noreloc
[313.761647] Subtest basic-cpu-wc-noreloc: SUCCESS (0.004s)
[313.894904] [064/131] (704s left) gem_ctx_param (invalid-set-no-zeromap)
[313.927791] Starting subtest: invalid-set-no-zeromap
[313.928498] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[314.016996] [065/131] (704s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[314.109037] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[314.110374] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[314.243522] [066/131] (704s left) i915_pm_rps (reset)
[314.282195] Starting subtest: reset
[318.847076] Subtest reset: SUCCESS (4.533s)
[318.964239] [067/131] (700s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[319.057314] Starting subtest: async-flip-with-page-flip-events-linear
[319.182254] Starting dynamic subtest: pipe-A-HDMI-A-1
[321.263770] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.073s)
[321.398437] Starting dynamic subtest: pipe-B-HDMI-A-1
[323.474283] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.073s)
[323.596537] Starting dynamic subtest: pipe-C-HDMI-A-1
[325.665844] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.067s)
[325.782593] Starting dynamic subtest: pipe-D-HDMI-A-1
[327.855003] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.071s)
[327.855703] Subtest async-flip-with-page-flip-events-linear: SUCCESS (8.789s)
[328.088667] [068/131] (690s left) perf_pmu (module-unload)
[328.137411] Starting subtest: module-unload
[330.954881] Subtest module-unload: FAIL (2.792s)
[330.977552] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[330.978344] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[330.980414] [069/131] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[332.099848] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[332.101259] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[332.196326] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[332.197725] [FACT kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[332.199963] [070/131] (686s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[332.235206] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[332.349655] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[332.433170] [071/131] (686s left) kms_cursor_crc (cursor-random-256x85)
[332.520731] Starting subtest: cursor-random-256x85
[332.534821] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.758495] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.051s)
[333.765409] Starting dynamic subtest: pipe-D-HDMI-A-1
[335.603984] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.981s)
[335.604693] Subtest cursor-random-256x85: FAIL (3.084s)
[335.770240] [072/131] (683s left) kms_psr (psr-sprite-plane-move)
[335.859019] Subtest psr-sprite-plane-move: SKIP (0.000s)
[335.898444] [073/131] (683s left) kms_psr (fbc-pr-sprite-plane-onoff)
[335.982992] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[336.023498] [074/131] (683s left) kms_pm_rpm (pm-tiling)
[337.418980] Starting subtest: pm-tiling
[341.311485] Subtest pm-tiling: SUCCESS (3.894s)
[341.402552] [075/131] (677s left) gem_userptr_blits (invalid-null-pointer)
[341.449744] Starting subtest: invalid-null-pointer
[341.450727] Subtest invalid-null-pointer: SUCCESS (0.004s)
[341.600528] [076/131] (677s left) kms_content_protection (lic-type-1)
[341.688258] Starting subtest: lic-type-1
[341.700943] Subtest lic-type-1: SKIP (0.012s)
[341.807590] [077/131] (677s left) kms_atomic (plane-immutable-zpos)
[341.892491] Starting subtest: plane-immutable-zpos
[341.893326] Starting dynamic subtest: pipe-A-HDMI-A-1
[342.199555] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.306s)
[342.200296] Subtest plane-immutable-zpos: SUCCESS (0.308s)
[342.355176] [078/131] (677s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[342.442655] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[342.444880] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[342.532970] [079/131] (676s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[342.616436] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[342.617202] Starting dynamic subtest: pipe-A
[343.727899] Dynamic subtest pipe-A: SUCCESS (1.111s)
[343.737229] Starting dynamic subtest: pipe-B
[344.914162] Dynamic subtest pipe-B: SUCCESS (1.185s)
[344.921743] Starting dynamic subtest: pipe-C
[345.117937] Dynamic subtest pipe-C: SUCCESS (0.203s)
[345.127937] Starting dynamic subtest: pipe-D
[345.327379] Dynamic subtest pipe-D: SUCCESS (0.208s)
[345.328067] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.711s)
[345.538202] [080/131] (673s left) kms_psr (pr-sprite-mmap-cpu)
[345.625486] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[345.673423] [081/131] (673s left) gem_ctx_persistence (legacy-engines-cleanup)
[345.712001] Starting subtest: legacy-engines-cleanup
[345.713796] Starting dynamic subtest: render
[345.763047] Dynamic subtest render: SUCCESS (0.050s)
[345.780303] Starting dynamic subtest: bsd1
[345.820117] Dynamic subtest bsd1: SUCCESS (0.053s)
[345.838886] Starting dynamic subtest: bsd2
[345.878114] Dynamic subtest bsd2: SUCCESS (0.054s)
[345.897685] Starting dynamic subtest: blt
[345.943319] Dynamic subtest blt: SUCCESS (0.062s)
[345.962050] Starting dynamic subtest: vebox
[346.000150] Dynamic subtest vebox: SUCCESS (0.053s)
[346.001398] Subtest legacy-engines-cleanup: SUCCESS (0.289s)
[346.095177] [082/131] (673s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[346.180830] Starting subtest: cursor-tearing-framebuffer-change
[346.182598] Starting dynamic subtest: pipe-A-HDMI-A-1
[346.430191] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.248s)
[346.439689] Starting dynamic subtest: pipe-D-HDMI-A-1
[346.661072] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.227s)
[346.662831] Subtest cursor-tearing-framebuffer-change: SUCCESS (0.481s)
[346.836768] [083/131] (672s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[346.924699] Starting subtest: 2x-cursor-vs-flip-atomic
[346.927220] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[347.013510] [084/131] (672s left) kms_cursor_crc (cursor-random-32x10)
[347.099561] Starting subtest: cursor-random-32x10
[347.150293] Subtest cursor-random-32x10: SKIP (0.050s)
[347.276487] [085/131] (672s left) kms_psr (fbc-psr-primary-mmap-gtt)
[347.364122] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[347.407756] [086/131] (672s left) kms_big_fb (linear-8bpp-rotate-0)
[347.501890] Starting subtest: linear-8bpp-rotate-0
[348.485949] Subtest linear-8bpp-rotate-0: SUCCESS (0.983s)
[348.652180] [087/131] (671s left) gem_create (create-ext-cpu-access-sanity-check)
[348.805508] Starting subtest: create-ext-cpu-access-sanity-check
[348.807404] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[348.885595] [088/131] (670s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[348.981563] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[350.105198] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.124s)
[350.250055] [089/131] (669s left) kms_pm_rpm (cursor-dpms)
[351.646354] Starting subtest: cursor-dpms
[363.648168] Subtest cursor-dpms: SUCCESS (12.001s)
[363.858392] [090/131] (656s left) gem_lmem_swapping (verify-random-ccs)
[363.896662] Subtest verify-random-ccs: SKIP (0.000s)
[363.942969] [091/131] (656s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[364.027500] Starting subtest: flip-vs-cursor-toggle
[372.438848] Subtest flip-vs-cursor-toggle: SUCCESS (8.411s)
[372.583885] [092/131] (647s left) gem_lmem_swapping (heavy-verify-multi)
[372.622635] Subtest heavy-verify-multi: SKIP (0.000s)
[372.663427] [093/131] (647s left) i915_pm_freq_api (freq-reset)
[372.699823] Subtest freq-reset: SKIP (0.000s)
[372.746310] [094/131] (647s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[372.844832] Starting subtest: y-tiled-64bpp-rotate-90
[372.894670] Subtest y-tiled-64bpp-rotate-90: SKIP (0.049s)
[373.039976] [095/131] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[373.128287] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[373.129686] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[373.240722] [096/131] (646s left) kms_dirtyfb (default-dirtyfb-ioctl)
[373.326606] Starting subtest: default-dirtyfb-ioctl
[373.327334] Starting dynamic subtest: A-HDMI-A-1
[374.515461] Dynamic subtest A-HDMI-A-1: SUCCESS (1.188s)
[374.517374] Subtest default-dirtyfb-ioctl: SUCCESS (1.190s)
[374.645808] [097/131] (645s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[374.733508] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[374.734231] Starting dynamic subtest: pipe-A
[375.179276] Dynamic subtest pipe-A: SUCCESS (0.446s)
[375.189525] Starting dynamic subtest: pipe-B
[375.613351] Dynamic subtest pipe-B: SUCCESS (0.433s)
[375.625956] Starting dynamic subtest: pipe-C
[376.046721] Dynamic subtest pipe-C: SUCCESS (0.432s)
[376.054931] Starting dynamic subtest: pipe-D
[376.481446] Dynamic subtest pipe-D: SUCCESS (0.434s)
[376.482218] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (1.749s)
[376.692992] [098/131] (643s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[376.783029] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[376.785219] Starting dynamic subtest: pipe-A-valid-mode
[376.840991] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[376.842435] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.058s)
[376.962860] [099/131] (643s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[377.048647] Starting subtest: 2x-cursor-vs-flip-legacy
[377.051646] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[377.139734] [100/131] (643s left) gem_readwrite (write-bad-handle)
[377.172844] Starting subtest: write-bad-handle
[377.174254] Subtest write-bad-handle: SUCCESS (0.000s)
[377.299399] [101/131] (643s left) gem_reg_read (timestamp-monotonic)
[377.332415] Starting subtest: timestamp-monotonic
[381.771790] Subtest timestamp-monotonic: SUCCESS (4.405s)
[381.826504] [102/131] (638s left) kms_psr (fbc-psr2-cursor-plane-move)
[381.915171] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[381.955652] [103/131] (638s left) kms_plane_lowres (tiling-x)
[382.040898] Starting subtest: tiling-x
[382.043162] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.025773] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.985s)
[389.072925] Starting dynamic subtest: pipe-B-HDMI-A-1
[395.844368] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.778s)
[395.918649] Starting dynamic subtest: pipe-C-HDMI-A-1
[402.708663] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.798s)
[402.759770] Starting dynamic subtest: pipe-D-HDMI-A-1
[409.538929] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.789s)
[409.604162] Subtest tiling-x: SUCCESS (27.566s)
[409.769477] [104/131] (610s left) kms_force_connector_basic (force-edid)
[409.903938] Starting subtest: force-edid
[410.047967] Subtest force-edid: SUCCESS (0.147s)
[410.218723] [105/131] (610s left) kms_getfb (getfb-handle-zero)
[410.304589] Starting subtest: getfb-handle-zero
[410.305305] Subtest getfb-handle-zero: SUCCESS (0.000s)
[410.410762] [106/131] (610s left) perf (missing-sample-flags)
[410.503169] Starting subtest: missing-sample-flags
[410.503916] Subtest missing-sample-flags: SUCCESS (0.000s)
[410.542166] [107/131] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[410.631433] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[410.632820] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[410.749821] [108/131] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[410.838012] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[410.839346] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[410.983060] [109/131] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[411.071249] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[411.072590] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[411.199441] [110/131] (609s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[411.293124] Starting subtest: 4-tiled-8bpp-rotate-180
[411.294605] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[411.415121] [111/131] (609s left) gem_exec_fence (syncobj-timeline-repeat)
[411.890640] Starting subtest: syncobj-timeline-repeat
[412.217933] Subtest syncobj-timeline-repeat: SUCCESS (0.327s)
[412.392389] [112/131] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[412.485339] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[412.486733] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[412.590868] [113/131] (608s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[412.623966] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[412.624653] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[412.715277] [114/131] (608s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[412.803193] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[414.050772] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.247s)
[414.224492] [115/131] (606s left) gem_exec_schedule (lateslice)
[414.266982] Starting subtest: lateslice
[414.267704] Starting dynamic subtest: rcs0
[414.284573] Dynamic subtest rcs0: SUCCESS (0.017s)
[414.293548] Starting dynamic subtest: bcs0
[414.302537] Dynamic subtest bcs0: SUCCESS (0.017s)
[414.311493] Starting dynamic subtest: vcs0
[414.318558] Dynamic subtest vcs0: SUCCESS (0.015s)
[414.327919] Starting dynamic subtest: vcs1
[414.336750] Dynamic subtest vcs1: SUCCESS (0.017s)
[414.345304] Starting dynamic subtest: vecs0
[414.352527] Dynamic subtest vecs0: SUCCESS (0.015s)
[414.353344] Subtest lateslice: SUCCESS (0.086s)
[414.677933] [116/131] (606s left) kms_vblank (query-idle-hang)
[414.766568] Starting subtest: query-idle-hang
[414.767466] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.276937] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.510s)
[429.290024] Starting dynamic subtest: pipe-D-HDMI-A-1
[443.093228] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.811s)
[443.093933] Subtest query-idle-hang: SUCCESS (28.328s)
[443.272417] [117/131] (577s left) syncobj_wait (reset-multiple-signaled)
[443.308725] Starting subtest: reset-multiple-signaled
[443.309430] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[443.401517] [118/131] (577s left) kms_flip_event_leak (basic)
[443.487524] Starting subtest: basic
[443.489331] Starting dynamic subtest: pipe-A-HDMI-A-1
[443.669636] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.180s)
[443.677196] Starting dynamic subtest: pipe-B-HDMI-A-1
[443.821874] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.151s)
[443.832948] Starting dynamic subtest: pipe-C-HDMI-A-1
[443.988104] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.164s)
[443.996820] Starting dynamic subtest: pipe-D-HDMI-A-1
[444.138873] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.149s)
[444.139743] Subtest basic: SUCCESS (0.652s)
[444.291350] [119/131] (576s left) gem_pwrite_snooped
[444.473289] [120/131] (576s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[444.511090] Starting subtest: yf-tiled-ccs-to-y-tiled
[444.511846] Starting dynamic subtest: smem
[444.613232] Dynamic subtest smem: SUCCESS (0.101s)
[444.613983] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.103s)
[444.816962] [121/131] (576s left) gem_ctx_shared (q-independent)
[444.857572] Starting subtest: Q-independent
[444.858256] Starting dynamic subtest: rcs0
[444.879803] Dynamic subtest rcs0: SUCCESS (0.022s)
[444.888911] Starting dynamic subtest: bcs0
[444.899558] Dynamic subtest bcs0: SUCCESS (0.018s)
[444.908680] Starting dynamic subtest: vcs0
[444.918922] Dynamic subtest vcs0: SUCCESS (0.018s)
[444.928881] Starting dynamic subtest: vcs1
[444.939406] Dynamic subtest vcs1: SUCCESS (0.019s)
[444.949869] Starting dynamic subtest: vecs0
[444.960734] Dynamic subtest vecs0: SUCCESS (0.020s)
[444.961506] Subtest Q-independent: SUCCESS (0.104s)
[445.164376] [122/131] (576s left) prime_mmap (test_userptr)
[445.196215] Starting subtest: test_userptr
[445.196875] Starting dynamic subtest: test_userptr-smem
[445.197610] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[445.198340] Subtest test_userptr: SUCCESS (0.001s)
[445.323230] [123/131] (575s left) kms_addfb_basic (bad-pitch-65536)
[445.355479] Starting subtest: bad-pitch-65536
[445.356299] Subtest bad-pitch-65536: SUCCESS (0.000s)
[445.520217] [124/131] (575s left) prime_self_import (basic-with_fd_dup)
[445.551655] Starting subtest: basic-with_fd_dup
[445.554272] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[445.679591] [125/131] (575s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[445.765507] Starting subtest: primary-y-tiled-reflect-x-0
[450.721245] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.956s)
[450.946633] [126/131] (570s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[451.034890] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[451.037088] Starting dynamic subtest: pipe-A-HDMI-A-1
[451.043910] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[451.053480] Starting dynamic subtest: pipe-B-HDMI-A-1
[451.067603] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[451.077852] Starting dynamic subtest: pipe-C-HDMI-A-1
[451.084301] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[451.091513] Starting dynamic subtest: pipe-D-HDMI-A-1
[451.098629] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[451.099956] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[451.327964] [127/131] (570s left) kms_addfb_basic (unused-modifier)
[451.361010] Starting subtest: unused-modifier
[451.361691] Subtest unused-modifier: SUCCESS (0.000s)
[451.547518] [128/131] (569s left) kms_vblank (wait-idle)
[451.631511] Starting subtest: wait-idle
[451.633291] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.812135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.180s)
[452.822954] Starting dynamic subtest: pipe-D-HDMI-A-1
[453.968059] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.152s)
[453.968798] Subtest wait-idle: SUCCESS (2.338s)
[454.151385] [129/131] (567s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[454.240409] Starting subtest: cursorA-vs-flipA-toggle
[465.098486] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.858s)
[465.243005] [130/131] (556s left) gen9_exec_parse (bb-start-far)
[465.282287] Subtest bb-start-far: SKIP (0.000s)
[465.330010] [131/131] (556s left) kms_addfb_basic (basic)
[465.362328] Starting subtest: basic
[465.363050] Subtest basic: SUCCESS (0.000s)
[465.538056] 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.