[58.998929] Initializing watchdogs
[58.998976]   /dev/watchdog0
[59.033867] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.038360] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.040782] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.044782] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[59.469649] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[60.326691] [002/133] (959s left) i915_power (sanity)
[60.386225] Starting subtest: sanity
[64.441803] Subtest sanity: SUCCESS (4.049s)
[65.955425] [003/133] (953s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[66.016095] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[66.093520] [004/133] (953s left) i915_module_load (resize-bar)
[66.127774] Starting subtest: resize-bar
[66.134459] Subtest resize-bar: SKIP (0.007s)
[66.174532] [005/133] (953s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[66.289188] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[66.293509] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[66.357046] [006/133] (953s left) gem_fenced_exec_thrash (no-spare-fences)
[66.423657] Subtest no-spare-fences: SKIP (0.000s)
[66.505681] [007/133] (953s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[66.608433] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[66.610787] Starting dynamic subtest: pipe-A-eDP-1
[66.619268] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.626783] Starting dynamic subtest: pipe-B-eDP-1
[66.635585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.644033] Starting dynamic subtest: pipe-C-eDP-1
[66.652626] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.659768] Starting dynamic subtest: pipe-D-eDP-1
[66.668107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.672194] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[68.895969] [008/133] (950s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[68.992482] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[68.996994] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[69.083016] [009/133] (950s left) perf_pmu (busy-accuracy-50)
[69.127990] Starting subtest: busy-accuracy-50
[69.130456] Starting dynamic subtest: rcs0
[70.660187] Dynamic subtest rcs0: SUCCESS (1.531s)
[70.670501] Starting dynamic subtest: bcs0
[72.204722] Dynamic subtest bcs0: SUCCESS (1.544s)
[72.214420] Starting dynamic subtest: vcs0
[73.746461] Dynamic subtest vcs0: SUCCESS (1.541s)
[73.754597] Starting dynamic subtest: vcs1
[75.288352] Dynamic subtest vcs1: SUCCESS (1.541s)
[75.297352] Starting dynamic subtest: vecs0
[76.832793] Dynamic subtest vecs0: SUCCESS (1.543s)
[76.842408] Starting dynamic subtest: ccs0
[78.381861] Dynamic subtest ccs0: SUCCESS (1.547s)
[78.384290] Subtest busy-accuracy-50: SUCCESS (9.254s)
[78.507215] [010/133] (941s left) kms_flip (2x-nonexisting-fb-interruptible)
[78.606087] Starting subtest: 2x-nonexisting-fb-interruptible
[78.618078] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[78.689737] [011/133] (941s left) gem_exec_whisper (basic-queues-priority-all)
[78.742779] Starting subtest: basic-queues-priority-all
[100.052074] Subtest basic-queues-priority-all: SUCCESS (21.303s)
[100.239173] [012/133] (919s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[100.340479] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[100.344745] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.429735] [013/133] (919s left) kms_psr (psr2-primary-render)
[100.526864] Starting subtest: psr2-primary-render
[100.529186] Starting dynamic subtest: eDP-1
[102.279805] Dynamic subtest eDP-1: SUCCESS (1.754s)
[102.282271] Subtest psr2-primary-render: SUCCESS (1.755s)
[103.154942] [014/133] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[103.257517] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[103.261835] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[103.354224] [015/133] (916s left) syncobj_wait (single-wait-signaled)
[103.404624] Starting subtest: single-wait-signaled
[103.406848] Subtest single-wait-signaled: SUCCESS (0.000s)
[103.501621] [016/133] (916s left) kms_properties (plane-properties-legacy)
[103.595339] Starting subtest: plane-properties-legacy
[103.597539] Starting dynamic subtest: pipe-A-eDP-1
[104.181049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[104.191401] Starting dynamic subtest: pipe-B-eDP-1
[105.435609] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[105.444463] Starting dynamic subtest: pipe-C-eDP-1
[106.666624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.231s)
[106.678037] Starting dynamic subtest: pipe-D-eDP-1
[107.900660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[107.903071] Subtest plane-properties-legacy: SUCCESS (4.304s)
[108.689953] [017/133] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[108.791326] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[108.795695] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[108.898542] [018/133] (911s left) kms_prime (basic-modeset-hybrid)
[108.978538] Subtest basic-modeset-hybrid: SKIP (0.000s)
[109.105527] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[109.108665] [019/133] (911s left) syncobj_timeline (wait-all-for-submit-snapshot)
[109.159505] Starting subtest: wait-all-for-submit-snapshot
[109.241089] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[109.316452] [020/133] (910s left) gem_exec_schedule (semaphore-power)
[109.498725] Subtest semaphore-power: SKIP (0.000s)
[109.686291] [021/133] (910s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[109.778398] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[113.781561] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.007s)
[114.979575] [022/133] (905s left) kms_cursor_crc (cursor-onscreen-512x512)
[115.246131] Starting subtest: cursor-onscreen-512x512
[115.250530] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[115.390517] [023/133] (904s left) kms_big_fb (linear-32bpp-rotate-180)
[115.477307] Starting subtest: linear-32bpp-rotate-180
[116.945348] Subtest linear-32bpp-rotate-180: SUCCESS (1.467s)
[117.074742] [024/133] (903s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[117.127368] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[117.236234] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[117.323517] [025/133] (903s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[117.379399] Starting subtest: mixed-tiled-to-y-tiled-ccs
[117.384154] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[117.560768] [026/133] (902s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[117.625863] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[117.706226] [027/133] (902s left) gem_partial_pwrite_pread (reads-display)
[117.772426] Subtest reads-display: SKIP (0.000s)
[117.847327] [028/133] (902s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[117.977533] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[117.982324] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[118.132381] [029/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[118.235170] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[118.239494] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[118.351309] [030/133] (902s left) drm_buddy (drm_buddy)
[118.383615] Starting subtest: drm_buddy
[118.388207] Subtest drm_buddy: SKIP (0.001s)
[118.440483] [031/133] (902s left) gem_userptr_blits (set-cache-level)
[118.508569] Starting subtest: set-cache-level
[118.512464] Subtest set-cache-level: SKIP (0.000s)
[118.641049] [032/133] (902s left) kms_addfb_basic (bad-pitch-1024)
[118.691944] Starting subtest: bad-pitch-1024
[118.693537] Subtest bad-pitch-1024: SUCCESS (0.000s)
[118.843178] [033/133] (901s left) gem_exec_alignment (forked)
[118.907748] Starting subtest: forked
[158.088217] Subtest forked: SUCCESS (39.178s)
[158.202181] [034/133] (862s left) prime_self_import (basic-with_one_bo)
[158.273502] Starting subtest: basic-with_one_bo
[158.284918] Subtest basic-with_one_bo: SUCCESS (0.015s)
[158.422054] [035/133] (862s left) gem_exec_schedule (in-order)
[158.495200] Starting subtest: in-order
[158.497481] Starting dynamic subtest: rcs0
[158.672691] Dynamic subtest rcs0: SUCCESS (0.179s)
[158.684074] Starting dynamic subtest: vcs0
[158.785045] Dynamic subtest vcs0: SUCCESS (0.113s)
[158.796764] Starting dynamic subtest: vcs1
[158.898494] Dynamic subtest vcs1: SUCCESS (0.113s)
[158.908238] Starting dynamic subtest: vecs0
[159.007867] Dynamic subtest vecs0: SUCCESS (0.108s)
[159.019225] Starting dynamic subtest: ccs0
[159.145050] Dynamic subtest ccs0: SUCCESS (0.137s)
[159.147994] Subtest in-order: SUCCESS (0.653s)
[159.987334] [036/133] (860s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[160.088353] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[160.090589] Starting dynamic subtest: pipe-A-eDP-1
[160.147971] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[160.158029] Starting dynamic subtest: pipe-B-eDP-1
[160.214080] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[160.224135] Starting dynamic subtest: pipe-C-eDP-1
[160.280976] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[160.290754] Starting dynamic subtest: pipe-D-eDP-1
[160.347138] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[160.351520] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[162.330088] [037/133] (858s left) gem_softpin (32b-excludes-last-page)
[162.391435] Starting subtest: 32b-excludes-last-page
[162.393679] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[162.510626] [038/133] (858s left) kms_rotation_crc (primary-rotation-90)
[162.612217] Starting subtest: primary-rotation-90
[162.616300] Subtest primary-rotation-90: SKIP (0.001s)
[162.680287] [039/133] (858s left) kms_psr (fbc-psr-cursor-render)
[162.770049] Starting subtest: fbc-psr-cursor-render
[162.772249] Starting dynamic subtest: eDP-1
[162.776604] Dynamic subtest eDP-1: SKIP (0.000s)
[162.781672] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[162.843172] [040/133] (858s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[162.933239] Starting subtest: fbc-pr-sprite-mmap-gtt
[162.937241] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[163.015766] [041/133] (858s left) kms_draw_crc (draw-method-mmap-cpu)
[163.108376] Starting subtest: draw-method-mmap-cpu
[163.110643] Starting dynamic subtest: xrgb8888-untiled
[163.374808] Dynamic subtest xrgb8888-untiled: SUCCESS (0.268s)
[163.384555] Starting dynamic subtest: rgb565-untiled
[163.600623] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[163.610175] Starting dynamic subtest: xrgb2101010-untiled
[163.819111] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[163.828374] Starting dynamic subtest: xbgr16161616f-untiled
[164.052329] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[164.060996] Starting dynamic subtest: xrgb8888-xtiled
[164.196782] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[164.205227] Starting dynamic subtest: rgb565-xtiled
[164.330043] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[164.340060] Starting dynamic subtest: xrgb2101010-xtiled
[164.452334] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[164.461859] Starting dynamic subtest: xbgr16161616f-xtiled
[164.585571] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[164.596349] Starting dynamic subtest: xrgb8888-4tiled
[164.741884] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[164.756849] Starting dynamic subtest: rgb565-4tiled
[164.896521] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[164.905578] Starting dynamic subtest: xrgb2101010-4tiled
[165.030019] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[165.039080] Starting dynamic subtest: xbgr16161616f-4tiled
[165.185575] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[165.187406] Subtest draw-method-mmap-cpu: SUCCESS (2.079s)
[165.289132] [042/133] (855s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[165.384650] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[165.386546] Starting dynamic subtest: pipe-A-eDP-1
[165.404981] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.413908] Starting dynamic subtest: pipe-B-eDP-1
[165.431189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.439545] Starting dynamic subtest: pipe-C-eDP-1
[165.456512] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.464723] Starting dynamic subtest: pipe-D-eDP-1
[165.482325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.485758] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[167.692209] [043/133] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[167.803218] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[190.930504] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.129s)
[191.067616] [044/133] (830s left) gem_exec_capture (capture)
[191.129475] Starting subtest: capture
[191.131128] Starting dynamic subtest: rcs0-smem
[191.965277] Dynamic subtest rcs0-smem: SUCCESS (0.835s)
[191.976128] Starting dynamic subtest: bcs0-smem
[192.793043] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[192.803451] Starting dynamic subtest: vcs0-smem
[193.616832] Dynamic subtest vcs0-smem: SUCCESS (0.824s)
[193.627219] Starting dynamic subtest: vcs1-smem
[194.940835] Dynamic subtest vcs1-smem: SUCCESS (1.323s)
[194.951447] Starting dynamic subtest: vecs0-smem
[195.827979] Dynamic subtest vecs0-smem: FAIL (0.827s)
[195.838191] Starting dynamic subtest: ccs0-smem
[197.091067] Dynamic subtest ccs0-smem: SUCCESS (1.323s)
[197.093468] Subtest capture: FAIL (5.960s)
[197.226697] [045/133] (824s left) perf_pmu (busy-hang)
[197.269567] Starting subtest: busy-hang
[197.271773] Starting dynamic subtest: rcs0
[198.525255] Dynamic subtest rcs0: SUCCESS (1.257s)
[198.536318] Starting dynamic subtest: bcs0
[199.755804] Dynamic subtest bcs0: SUCCESS (1.228s)
[199.767382] Starting dynamic subtest: vcs0
[201.435201] Dynamic subtest vcs0: SUCCESS (1.674s)
[201.444597] Starting dynamic subtest: vcs1
[203.414186] Dynamic subtest vcs1: SUCCESS (1.980s)
[203.424674] Starting dynamic subtest: vecs0
[205.401780] Dynamic subtest vecs0: SUCCESS (1.983s)
[205.413047] Starting dynamic subtest: ccs0
[206.610829] Dynamic subtest ccs0: SUCCESS (1.207s)
[206.613128] Subtest busy-hang: SUCCESS (9.341s)
[206.706086] [046/133] (814s left) prime_vgem (basic-write)
[206.778954] Starting subtest: basic-write
[206.803851] Subtest basic-write: SKIP (0.023s)
[206.924123] [047/133] (814s left) gem_exec_await (wide-all)
[207.276543] Starting subtest: wide-all
[230.538716] Subtest wide-all: SUCCESS (23.263s)
[230.731625] [048/133] (790s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[230.872743] Starting subtest: psr-dirtyfb-ioctl
[230.875169] Starting dynamic subtest: A-eDP-1
[234.793719] Dynamic subtest A-eDP-1: SUCCESS (3.922s)
[234.796163] Subtest psr-dirtyfb-ioctl: SUCCESS (3.924s)
[235.606985] [049/133] (785s left) kms_cursor_crc (cursor-size-hints)
[235.739152] Starting subtest: cursor-size-hints
[235.741445] Starting dynamic subtest: pipe-A-eDP-1
[236.390760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.650s)
[236.399790] Starting dynamic subtest: pipe-D-eDP-1
[237.666068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[237.668235] Subtest cursor-size-hints: SUCCESS (1.927s)
[238.466525] [050/133] (783s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[238.567093] Starting subtest: addfb25-y-tiled-small-legacy
[238.571355] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[238.671937] [051/133] (782s left) kms_psr (psr-primary-mmap-cpu)
[238.760926] Starting subtest: psr-primary-mmap-cpu
[238.763129] Starting dynamic subtest: eDP-1
[240.462682] Dynamic subtest eDP-1: SUCCESS (1.701s)
[240.464997] Subtest psr-primary-mmap-cpu: SUCCESS (1.702s)
[241.332170] [052/133] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[241.436655] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[241.440987] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[241.536392] [053/133] (780s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[241.632606] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[242.290406] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[242.474609] [054/133] (779s left) gem_exec_balancer (bonded-false-hang)
[242.742271] Starting subtest: bonded-false-hang
[242.747403] Subtest bonded-false-hang: SKIP (0.000s)
[242.839168] [055/133] (778s left) kms_getfb (getfb2-accept-nv12)
[242.934310] Starting subtest: getfb2-accept-nv12
[242.936643] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[243.042594] [056/133] (778s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[243.100060] Subtest writes-after-reads: SKIP (0.000s)
[243.168903] [057/133] (778s left) kms_content_protection (suspend-resume)
[243.308669] Starting subtest: suspend-resume
[243.313260] Subtest suspend-resume: SKIP (0.000s)
[243.453634] [058/133] (778s left) gem_mmap_wc (bad-offset)
[243.508265] Subtest bad-offset: SKIP (0.000s)
[243.562283] [059/133] (778s left) gem_ppgtt (blt-vs-render-ctxn)
[243.619471] Starting subtest: blt-vs-render-ctxN
[276.371712] Subtest blt-vs-render-ctxN: SUCCESS (32.749s)
[276.500768] [060/133] (745s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[276.644092] Starting subtest: crc-primary-basic-y-tiled-ccs
[276.646343] Starting dynamic subtest: pipe-A-eDP-1
[276.668066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[276.678216] Starting dynamic subtest: pipe-B-eDP-1
[276.699952] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.709044] Starting dynamic subtest: pipe-C-eDP-1
[276.730290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[276.739432] Starting dynamic subtest: pipe-D-eDP-1
[276.761435] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[276.765550] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[278.830535] [061/133] (743s left) perf (whitelisted-registers-userspace-config)
[278.974048] Starting subtest: whitelisted-registers-userspace-config
[278.976415] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[279.014744] [062/133] (743s left) kms_invalid_mode (overflow-vrefresh)
[279.109343] Starting subtest: overflow-vrefresh
[279.111622] Starting dynamic subtest: pipe-A-eDP-1
[279.393445] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[279.406831] Starting dynamic subtest: pipe-B-eDP-1
[279.410752] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[279.420057] Starting dynamic subtest: pipe-C-eDP-1
[279.422177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[279.434539] Starting dynamic subtest: pipe-D-eDP-1
[279.436752] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[279.439065] Subtest overflow-vrefresh: SUCCESS (0.292s)
[280.256633] [063/133] (741s left) gem_spin_batch (resubmit-new-all)
[280.326979] Starting subtest: resubmit-new-all
[280.329223] Starting dynamic subtest: rcs0
[280.338760] Dynamic subtest rcs0: SUCCESS (0.012s)
[280.350599] Starting dynamic subtest: bcs0
[280.355887] Dynamic subtest bcs0: SUCCESS (0.013s)
[280.365792] Starting dynamic subtest: vcs0
[280.368019] Dynamic subtest vcs0: SUCCESS (0.009s)
[280.377398] Starting dynamic subtest: vcs1
[280.379648] Dynamic subtest vcs1: SUCCESS (0.009s)
[280.389046] Starting dynamic subtest: vecs0
[280.391149] Dynamic subtest vecs0: SUCCESS (0.010s)
[280.403414] Starting dynamic subtest: ccs0
[280.405597] Dynamic subtest ccs0: SUCCESS (0.010s)
[280.407752] Subtest resubmit-new-all: SUCCESS (0.067s)
[281.989019] [064/133] (740s left) api_intel_bb (simple-bb)
[282.040575] Starting subtest: simple-bb
[282.044191] Subtest simple-bb: SUCCESS (0.006s)
[282.164829] [065/133] (739s left) syncobj_timeline (etime-multi-wait-all-submitted)
[282.214789] Starting subtest: etime-multi-wait-all-submitted
[282.324591] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[282.415594] [066/133] (739s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[282.517784] Starting subtest: y-tiled-8bpp-rotate-180
[282.522126] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[282.618216] [067/133] (739s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[282.715076] Starting subtest: fbc-pr-cursor-mmap-gtt
[282.719482] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[282.791144] [068/133] (739s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[285.051561] Starting subtest: dpms-mode-unset-non-lpsp
[286.212071] Subtest dpms-mode-unset-non-lpsp: SKIP (1.161s)
[286.585664] [069/133] (735s left) gem_ctx_param (root-set)
[286.635929] Starting subtest: root-set
[286.638381] Subtest root-set: SUCCESS (0.001s)
[286.735401] [070/133] (735s left) syncobj_timeline (device-submit-unordered)
[286.789928] Starting subtest: device-submit-unordered
[286.792091] Subtest device-submit-unordered: SUCCESS (0.001s)
[286.898301] [071/133] (735s left) gem_readwrite (read-write)
[286.952660] Subtest read-write: SKIP (0.000s)
[287.012076] [072/133] (735s left) gem_exec_schedule (u-submit-late-slice)
[287.072596] Starting subtest: u-submit-late-slice
[287.074977] Starting dynamic subtest: rcs0
[287.106174] Dynamic subtest rcs0: SUCCESS (0.041s)
[287.116319] Starting dynamic subtest: bcs0
[287.144385] Dynamic subtest bcs0: SUCCESS (0.037s)
[287.160690] Starting dynamic subtest: vcs0
[287.184805] Dynamic subtest vcs0: SUCCESS (0.040s)
[287.196943] Starting dynamic subtest: vcs1
[287.221563] Dynamic subtest vcs1: SUCCESS (0.036s)
[287.233534] Starting dynamic subtest: vecs0
[287.256513] Dynamic subtest vecs0: SUCCESS (0.034s)
[287.265856] Starting dynamic subtest: ccs0
[287.296389] Dynamic subtest ccs0: SUCCESS (0.038s)
[287.298770] Subtest u-submit-late-slice: SUCCESS (0.232s)
[289.001398] [073/133] (733s left) sriov_basic (enable-vfs-autoprobe-on)
[289.062811] Starting subtest: enable-vfs-autoprobe-on
[289.065310] Starting dynamic subtest: numvfs-1
[289.147313] Dynamic subtest numvfs-1: FAIL (0.029s)
[289.158080] Starting dynamic subtest: numvfs-2
[289.230320] Dynamic subtest numvfs-2: FAIL (0.004s)
[289.241404] Starting dynamic subtest: numvfs-3
[289.314919] Dynamic subtest numvfs-3: FAIL (0.003s)
[289.325514] Starting dynamic subtest: numvfs-4
[289.398331] Dynamic subtest numvfs-4: FAIL (0.003s)
[289.409484] Starting dynamic subtest: numvfs-5
[289.481847] Dynamic subtest numvfs-5: FAIL (0.003s)
[289.492616] Starting dynamic subtest: numvfs-6
[289.566624] Dynamic subtest numvfs-6: FAIL (0.004s)
[289.577553] Starting dynamic subtest: numvfs-7
[289.654421] Dynamic subtest numvfs-7: FAIL (0.004s)
[289.666792] Starting dynamic subtest: numvfs-random
[289.738986] Dynamic subtest numvfs-random: FAIL (0.003s)
[289.749419] Starting dynamic subtest: numvfs-all
[289.821895] Dynamic subtest numvfs-all: FAIL (0.515s)
[289.824394] Subtest enable-vfs-autoprobe-on: FAIL (0.577s)
[289.864775] [074/133] (732s left) kms_plane_multiple (2x-tiling-y)
[289.953658] Starting subtest: 2x-tiling-y
[289.958362] Subtest 2x-tiling-y: SKIP (0.000s)
[290.036769] [075/133] (732s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[290.124755] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[290.128579] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[290.217222] [076/133] (732s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[290.304872] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[290.306863] Starting dynamic subtest: pipe-A-eDP-1
[290.328753] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[290.339405] Starting dynamic subtest: pipe-B-eDP-1
[290.359367] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[290.368306] Starting dynamic subtest: pipe-C-eDP-1
[290.388788] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[290.397778] Starting dynamic subtest: pipe-D-eDP-1
[290.417898] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[290.421387] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[292.539679] [077/133] (730s left) gem_userptr_blits (process-exit-busy)
[292.601068] Starting subtest: process-exit-busy
[292.611592] Subtest process-exit-busy: SUCCESS (0.013s)
[292.722976] [078/133] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[292.821978] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[292.826034] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[292.928617] [079/133] (729s left) kms_vblank (ts-continuation-modeset-rpm)
[293.022105] Starting subtest: ts-continuation-modeset-rpm
[293.023957] Starting dynamic subtest: pipe-A-eDP-1
[295.537376] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.514s)
[295.551347] Starting dynamic subtest: pipe-D-eDP-1
[297.781256] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[297.783555] Subtest ts-continuation-modeset-rpm: SUCCESS (4.760s)
[298.578660] [080/133] (724s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[298.689065] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[299.803325] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.111s)
[299.920407] [081/133] (722s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[299.973090] Starting subtest: multi-wait-all-for-submit-signaled
[299.974998] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[300.070344] [082/133] (722s left) kms_plane (plane-panning-top-left)
[300.156692] Starting subtest: plane-panning-top-left
[300.158698] Starting dynamic subtest: pipe-A
[301.857904] Dynamic subtest pipe-A: SUCCESS (1.702s)
[301.867868] Starting dynamic subtest: pipe-B
[304.336193] Dynamic subtest pipe-B: SUCCESS (2.477s)
[304.338509] Subtest plane-panning-top-left: SUCCESS (4.182s)
[305.204091] [083/133] (717s left) gem_exec_parallel (userptr)
[305.269777] Starting subtest: userptr
[305.272280] Starting dynamic subtest: rcs0
[306.709802] Dynamic subtest rcs0: SUCCESS (1.439s)
[306.720594] Starting dynamic subtest: bcs0
[308.194888] Dynamic subtest bcs0: SUCCESS (1.484s)
[308.204725] Starting dynamic subtest: vcs0
[309.873630] Dynamic subtest vcs0: SUCCESS (1.676s)
[309.885136] Starting dynamic subtest: vcs1
[311.895072] Dynamic subtest vcs1: SUCCESS (2.018s)
[311.906673] Starting dynamic subtest: vecs0
[313.879703] Dynamic subtest vecs0: SUCCESS (1.983s)
[313.889758] Starting dynamic subtest: ccs0
[315.382204] Dynamic subtest ccs0: SUCCESS (1.501s)
[315.384898] Subtest userptr: SUCCESS (10.112s)
[315.571488] [084/133] (707s left) kms_hdmi_inject (inject-4k)
[315.931921] Starting subtest: inject-4k
[316.247024] Subtest inject-4k: SUCCESS (0.317s)
[316.763743] [085/133] (706s left) kms_chamelium_edid (hdmi-mode-timings)
[317.134231] Subtest hdmi-mode-timings: SKIP (0.000s)
[317.910868] [086/133] (705s left) syncobj_wait (multi-wait-for-submit-submitted)
[317.966191] Starting subtest: multi-wait-for-submit-submitted
[318.067073] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[318.147481] [087/133] (704s left) gem_exec_schedule (smoketest-all)
[318.219802] Starting subtest: smoketest-all
[350.586942] Subtest smoketest-all: SUCCESS (32.325s)
[352.023151] [088/133] (671s left) sysfs_heartbeat_interval (mixed)
[352.082899] Starting subtest: mixed
[352.085453] Starting dynamic subtest: vecs0
[357.335153] Dynamic subtest vecs0: SUCCESS (5.252s)
[357.349586] Starting dynamic subtest: ccs0
[362.532251] Dynamic subtest ccs0: SUCCESS (5.193s)
[362.544289] Starting dynamic subtest: vcs0
[367.780301] Dynamic subtest vcs0: SUCCESS (5.246s)
[367.793551] Starting dynamic subtest: bcs0
[372.962045] Dynamic subtest bcs0: SUCCESS (5.179s)
[372.972776] Starting dynamic subtest: rcs0
[378.164169] Dynamic subtest rcs0: SUCCESS (5.199s)
[378.175737] Starting dynamic subtest: vcs1
[383.346617] Dynamic subtest vcs1: SUCCESS (5.182s)
[383.349447] Subtest mixed: SUCCESS (31.264s)
[383.425930] [089/133] (639s left) kms_cursor_crc (cursor-sliding-512x512)
[383.710947] Starting subtest: cursor-sliding-512x512
[383.715334] Subtest cursor-sliding-512x512: SKIP (0.001s)
[383.871772] [090/133] (639s left) perf (sysctl-defaults)
[383.938868] Starting subtest: sysctl-defaults
[383.941558] Subtest sysctl-defaults: SUCCESS (0.000s)
[384.002560] [091/133] (639s left) gem_ctx_persistence (legacy-engines-hostile)
[384.058503] Starting subtest: legacy-engines-hostile
[384.060939] Starting dynamic subtest: render
[384.186039] Dynamic subtest render: SUCCESS (0.127s)
[384.198501] Starting dynamic subtest: bsd1
[384.279948] Dynamic subtest bsd1: SUCCESS (0.091s)
[384.298688] Starting dynamic subtest: bsd2
[384.365303] Dynamic subtest bsd2: SUCCESS (0.083s)
[384.380148] Starting dynamic subtest: blt
[384.472373] Dynamic subtest blt: SUCCESS (0.104s)
[384.485157] Starting dynamic subtest: vebox
[384.558381] Dynamic subtest vebox: SUCCESS (0.084s)
[384.560558] Subtest legacy-engines-hostile: SUCCESS (0.502s)
[384.644512] [092/133] (638s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[384.737470] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[384.739471] Starting dynamic subtest: pipe-A-eDP-1
[384.855679] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[384.865927] Starting dynamic subtest: pipe-B-eDP-1
[386.062248] Dynamic subtest pipe-B-eDP-1: SKIP (1.204s)
[386.066671] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.328s)
[387.220536] [093/133] (636s left) kms_flip (basic-flip-vs-dpms)
[387.324342] Starting subtest: basic-flip-vs-dpms
[387.326591] Starting dynamic subtest: A-eDP1
[389.861066] Dynamic subtest A-eDP1: SUCCESS (2.537s)
[389.871568] Starting dynamic subtest: B-eDP1
[392.071093] Dynamic subtest B-eDP1: SUCCESS (2.206s)
[392.081248] Starting dynamic subtest: C-eDP1
[394.261280] Dynamic subtest C-eDP1: SUCCESS (2.186s)
[394.270929] Starting dynamic subtest: D-eDP1
[396.466314] Dynamic subtest D-eDP1: SUCCESS (2.204s)
[396.468693] Subtest basic-flip-vs-dpms: SUCCESS (9.146s)
[397.328504] [094/133] (626s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[397.426059] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[397.428365] Starting dynamic subtest: pipe-A
[397.653325] Dynamic subtest pipe-A: SUCCESS (0.229s)
[397.662684] Starting dynamic subtest: pipe-B
[398.973134] Dynamic subtest pipe-B: SUCCESS (1.319s)
[398.982782] Starting dynamic subtest: pipe-C
[400.270040] Dynamic subtest pipe-C: SUCCESS (1.296s)
[400.279586] Starting dynamic subtest: pipe-D
[401.572368] Dynamic subtest pipe-D: SUCCESS (1.302s)
[401.574723] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.149s)
[402.728277] [095/133] (620s left) gem_mmap_gtt (cpuset-basic-small-copy)
[402.793034] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[402.861816] [096/133] (620s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[402.956546] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[409.787774] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.833s)
[409.901092] [097/133] (613s left) gem_exec_fence (syncobj-channel)
[410.366399] Starting subtest: syncobj-channel
[411.385882] Subtest syncobj-channel: SUCCESS (1.015s)
[412.012684] [098/133] (611s left) gem_ctx_param (invalid-get-engines)
[412.065256] Starting subtest: invalid-get-engines
[412.067766] Subtest invalid-get-engines: SUCCESS (0.001s)
[412.179741] [099/133] (611s left) gem_exec_flush (basic-wb-rw-before-default)
[412.240654] Starting subtest: basic-wb-rw-before-default
[417.695623] Subtest basic-wb-rw-before-default: SUCCESS (5.455s)
[417.897599] [100/133] (605s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[418.006164] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[418.010687] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[418.078560] [101/133] (605s left) gem_mmap_gtt (zero-extend)
[418.124886] Subtest zero-extend: SKIP (0.000s)
[418.185324] [102/133] (605s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[418.279336] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[419.325479] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[419.447725] [103/133] (604s left) gem_exec_flush (basic-batch-kernel-default-uc)
[419.510924] Starting subtest: basic-batch-kernel-default-uc
[426.593557] Subtest basic-batch-kernel-default-uc: SUCCESS (7.084s)
[426.783482] [104/133] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[426.889792] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[426.893954] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[427.001216] [105/133] (596s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[427.100145] Starting subtest: flip-vs-dpms-on-nop-interruptible
[427.102459] Starting dynamic subtest: A-eDP1
[428.989575] Dynamic subtest A-eDP1: SUCCESS (1.888s)
[429.000130] Starting dynamic subtest: B-eDP1
[430.873867] Dynamic subtest B-eDP1: SUCCESS (1.882s)
[430.887635] Starting dynamic subtest: C-eDP1
[432.664379] Dynamic subtest C-eDP1: SUCCESS (1.787s)
[432.673993] Starting dynamic subtest: D-eDP1
[434.473567] Dynamic subtest D-eDP1: SUCCESS (1.808s)
[434.475967] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.376s)
[435.638926] [106/133] (588s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[435.736683] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[442.189726] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.457s)
[442.322696] [107/133] (581s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[442.430199] Starting subtest: psr-rgb101010-draw-mmap-gtt
[442.434125] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[442.550569] [108/133] (581s left) i915_drm_fdinfo (virtual-busy)
[442.595342] Starting subtest: virtual-busy
[442.599407] Subtest virtual-busy: SKIP (0.000s)
[442.670847] [109/133] (581s left) gem_mmap_gtt (basic-small-copy-odd)
[442.732945] Subtest basic-small-copy-odd: SKIP (0.000s)
[442.798388] [110/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[442.893568] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[442.897391] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.002964] [111/133] (581s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[443.094171] Starting subtest: basic-max-pipe-crc-check
[443.098585] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[443.143611] [112/133] (581s left) api_intel_allocator (fork-simple-stress-signal)
[443.187409] Starting subtest: fork-simple-stress-signal
[448.589196] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[448.711366] [113/133] (575s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[448.820980] Starting subtest: primary-y-tiled-reflect-x-0
[448.881376] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[449.001183] [114/133] (575s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[449.096692] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[456.185463] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.091s)
[456.288530] [115/133] (567s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[456.396477] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[456.400858] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[456.485562] [116/133] (567s left) gem_create (create-ext-placement-all)
[456.651232] Starting subtest: create-ext-placement-all
[456.654213] Subtest create-ext-placement-all: SUCCESS (0.000s)
[456.762390] [117/133] (567s left) gem_ctx_create (basic)
[456.827642] Starting subtest: basic
[456.830045] Subtest basic: SUCCESS (0.000s)
[457.027309] [118/133] (567s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[457.088535] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[457.090893] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[457.204044] [119/133] (567s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[457.266669] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[457.268940] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[457.382508] [120/133] (567s left) gen9_exec_parse (bb-secure)
[457.441856] Subtest bb-secure: SKIP (0.000s)
[457.521328] [121/133] (567s left) kms_psr (pr-primary-page-flip)
[457.612377] Starting subtest: pr-primary-page-flip
[457.616373] Subtest pr-primary-page-flip: SKIP (0.000s)
[457.688951] [122/133] (566s left) kms_flip (blocking-wf_vblank)
[457.786204] Starting subtest: blocking-wf_vblank
[457.788748] Starting dynamic subtest: A-eDP1
[466.739787] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[466.753728] Starting dynamic subtest: B-eDP1
[475.626847] Dynamic subtest B-eDP1: SUCCESS (8.884s)
[475.643297] Starting dynamic subtest: C-eDP1
[484.514899] Dynamic subtest C-eDP1: SUCCESS (8.884s)
[484.527817] Starting dynamic subtest: D-eDP1
[493.419568] Dynamic subtest D-eDP1: SUCCESS (8.905s)
[493.424599] Subtest blocking-wf_vblank: SUCCESS (35.641s)
[494.616968] [123/133] (530s left) kms_color_pipeline (plane-lut1d-lut1d)
[494.712317] Starting subtest: plane-lut1d-lut1d
[494.858787] Starting dynamic subtest: pipe-A-plane-0
[495.036602] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[495.046934] Starting dynamic subtest: pipe-A-plane-1
[495.213044] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[495.222883] Starting dynamic subtest: pipe-A-plane-2
[495.401813] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[496.586348] Starting dynamic subtest: pipe-B-plane-0
[496.744709] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[496.755520] Starting dynamic subtest: pipe-B-plane-1
[496.933858] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[496.943976] Starting dynamic subtest: pipe-B-plane-2
[497.100676] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[498.284782] Starting dynamic subtest: pipe-C-plane-0
[498.432088] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[498.442174] Starting dynamic subtest: pipe-C-plane-1
[498.598780] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[498.608785] Starting dynamic subtest: pipe-C-plane-2
[498.766028] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[499.990977] Starting dynamic subtest: pipe-D-plane-0
[500.138597] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[500.148332] Starting dynamic subtest: pipe-D-plane-1
[500.292364] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[500.302630] Starting dynamic subtest: pipe-D-plane-2
[500.448151] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[500.733479] Subtest plane-lut1d-lut1d: SUCCESS (6.021s)
[501.615239] [124/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[501.726641] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[508.186090] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.462s)
[508.315504] [125/133] (516s left) kms_universal_plane (universal-plane-functional)
[508.401879] Starting subtest: universal-plane-functional
[508.404280] Starting dynamic subtest: pipe-A-eDP-1
[512.422246] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.022s)
[512.432674] Starting dynamic subtest: pipe-B-eDP-1
[517.016622] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.592s)
[517.027294] Starting dynamic subtest: pipe-C-eDP-1
[521.374852] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.357s)
[521.385661] Starting dynamic subtest: pipe-D-eDP-1
[525.691931] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.314s)
[525.694345] Subtest universal-plane-functional: SUCCESS (17.291s)
[526.520351] [126/133] (498s left) kms_lease (lease-unleased-connector)
[526.617231] Starting subtest: lease-unleased-connector
[526.619654] Starting dynamic subtest: pipe-A-eDP-1
[526.621891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[526.632404] Starting dynamic subtest: pipe-B-eDP-1
[526.634577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[526.645438] Starting dynamic subtest: pipe-C-eDP-1
[526.648630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[526.658484] Starting dynamic subtest: pipe-D-eDP-1
[526.660702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[526.662890] Subtest lease-unleased-connector: SUCCESS (0.032s)
[526.759608] [127/133] (498s left) gem_exec_reloc (basic-gtt-wc-active)
[526.813220] Subtest basic-gtt-wc-active: SKIP (0.000s)
[526.891234] [128/133] (497s left) kms_getfb (getfb-handle-zero)
[526.992451] Starting subtest: getfb-handle-zero
[526.994776] Subtest getfb-handle-zero: SUCCESS (0.000s)
[527.100189] [129/133] (497s left) i915_pm_rps (reset)
[527.161706] Starting subtest: reset
[535.626186] Subtest reset: SUCCESS (8.464s)
[535.746817] [130/133] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[535.848263] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[542.499374] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.652s)
[542.650419] [131/133] (482s left) kms_async_flips (test-cursor-atomic)
[542.741110] Starting subtest: test-cursor-atomic
[543.120681] Starting dynamic subtest: pipe-A-eDP-1
[543.866571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[544.236586] Starting dynamic subtest: pipe-B-eDP-1
[544.975928] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[545.369212] Starting dynamic subtest: pipe-C-eDP-1
[546.165134] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.804s)
[546.535756] Starting dynamic subtest: pipe-D-eDP-1
[547.281228] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.753s)
[547.283515] Subtest test-cursor-atomic: SUCCESS (4.543s)
[548.508830] [132/133] (476s left) gem_exec_reloc (basic-gtt-wc)
[548.564718] Subtest basic-gtt-wc: SKIP (0.000s)
[548.635727] [133/133] (476s left) fbdev (pan)
[548.673808] Starting subtest: pan
[548.697577] Subtest pan: SUCCESS (0.025s)
[548.766632] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: i915_power
results: parsing output: 2/ for test: gem_fenced_exec_thrash
results: parsing output: 3/ for test: i915_module_load
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_fenced_exec_thrash
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_prime
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_cursor_crc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_partial_pwrite_pread
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: drm_buddy
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: kms_addfb_basic
results: parsing output: 32/ for test: gem_exec_alignment
results: parsing output: 33/ for test: prime_self_import
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_draw_crc
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_capture
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: gem_exec_await
results: parsing output: 47/ for test: kms_dirtyfb
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_getfb
results: parsing output: 55/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: gem_ppgtt
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_invalid_mode
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: api_intel_bb
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_readwrite
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: sriov_basic
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: gem_exec_parallel
results: parsing output: 83/ for test: kms_hdmi_inject
results: parsing output: 84/ for test: kms_chamelium_edid
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: perf
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_plane_scaling
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_fence
results: parsing output: 97/ for test: gem_ctx_param
results: parsing output: 98/ for test: gem_exec_flush
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_flush
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_drm_fdinfo
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_multipipe_modeset
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: gem_ctx_create
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_color_pipeline
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_universal_plane
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_getfb
results: parsing output: 128/ for test: i915_pm_rps
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: gem_exec_reloc
results: parsing output: 132/ for test: fbdev
Done.