[58.961715] Initializing watchdogs
[58.961759]   /dev/watchdog0
[58.976502] [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]
[58.980714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.982821] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.986071] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[59.397117] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[60.193960] [002/133] (959s left) i915_power (sanity)
[60.251154] Starting subtest: sanity
[60.255933] Subtest sanity: SKIP (0.000s)
[60.332029] [003/133] (959s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[60.394653] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[60.469742] [004/133] (959s left) i915_module_load (resize-bar)
[60.503609] Starting subtest: resize-bar
[60.514051] Subtest resize-bar: SKIP (0.006s)
[60.553087] [005/133] (959s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[60.646446] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[60.650630] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[60.707407] [006/133] (958s left) gem_fenced_exec_thrash (no-spare-fences)
[60.772262] Subtest no-spare-fences: SKIP (0.000s)
[60.830744] [007/133] (958s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[60.926142] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[60.928510] Starting dynamic subtest: pipe-A-eDP-1
[60.937909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.946745] Starting dynamic subtest: pipe-B-eDP-1
[60.955718] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.962857] Starting dynamic subtest: pipe-C-eDP-1
[60.971819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.978205] Starting dynamic subtest: pipe-D-eDP-1
[60.986829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.991171] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[63.103363] [008/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[63.213149] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[63.217617] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[63.310145] [009/133] (956s left) perf_pmu (busy-accuracy-50)
[63.348595] Starting subtest: busy-accuracy-50
[63.351043] Starting dynamic subtest: rcs0
[64.889099] Dynamic subtest rcs0: SUCCESS (1.537s)
[64.898817] Starting dynamic subtest: bcs0
[66.433656] Dynamic subtest bcs0: SUCCESS (1.541s)
[66.444063] Starting dynamic subtest: vcs0
[67.969468] Dynamic subtest vcs0: SUCCESS (1.534s)
[67.980208] Starting dynamic subtest: vcs1
[69.512672] Dynamic subtest vcs1: SUCCESS (1.542s)
[69.522260] Starting dynamic subtest: vecs0
[71.054473] Dynamic subtest vecs0: SUCCESS (1.540s)
[71.062636] Starting dynamic subtest: ccs0
[72.603698] Dynamic subtest ccs0: SUCCESS (1.547s)
[72.606307] Subtest busy-accuracy-50: SUCCESS (9.248s)
[72.938758] [010/133] (946s left) kms_flip (2x-nonexisting-fb-interruptible)
[73.034023] Starting subtest: 2x-nonexisting-fb-interruptible
[73.045394] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[73.130503] [011/133] (946s left) gem_exec_whisper (basic-queues-priority-all)
[73.190484] Starting subtest: basic-queues-priority-all
[95.185309] Subtest basic-queues-priority-all: SUCCESS (21.989s)
[95.366841] [012/133] (924s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[95.478557] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[95.482688] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[95.585834] [013/133] (924s left) kms_psr (psr2-primary-render)
[95.668922] Starting subtest: psr2-primary-render
[95.671294] Starting dynamic subtest: eDP-1
[97.391992] Dynamic subtest eDP-1: SUCCESS (1.722s)
[97.394901] Subtest psr2-primary-render: SUCCESS (1.723s)
[98.271294] [014/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[98.367367] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[98.371942] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[98.467126] [015/133] (921s left) syncobj_wait (single-wait-signaled)
[98.515606] Starting subtest: single-wait-signaled
[98.517992] Subtest single-wait-signaled: SUCCESS (0.000s)
[98.597960] [016/133] (921s left) kms_properties (plane-properties-legacy)
[98.684584] Starting subtest: plane-properties-legacy
[98.686896] Starting dynamic subtest: pipe-A-eDP-1
[99.260942] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[99.269239] Starting dynamic subtest: pipe-B-eDP-1
[100.552197] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.291s)
[100.561157] Starting dynamic subtest: pipe-C-eDP-1
[101.790193] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s)
[101.800277] Starting dynamic subtest: pipe-D-eDP-1
[103.035293] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[103.037246] Subtest plane-properties-legacy: SUCCESS (4.349s)
[103.820301] [017/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[103.923680] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[103.928083] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.030655] [018/133] (916s left) kms_prime (basic-modeset-hybrid)
[104.110648] Subtest basic-modeset-hybrid: SKIP (0.000s)
[104.244878] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[104.248547] [019/133] (915s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.314623] Starting subtest: wait-all-for-submit-snapshot
[104.396050] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[104.471884] [020/133] (915s left) gem_exec_schedule (semaphore-power)
[104.660204] Subtest semaphore-power: SKIP (0.000s)
[104.868217] [021/133] (915s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[104.969737] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[108.924193] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.958s)
[110.067065] [022/133] (910s left) kms_cursor_crc (cursor-onscreen-512x512)
[110.344874] Starting subtest: cursor-onscreen-512x512
[110.349237] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[110.524595] [023/133] (909s left) kms_big_fb (linear-32bpp-rotate-180)
[110.619601] Starting subtest: linear-32bpp-rotate-180
[112.174471] Subtest linear-32bpp-rotate-180: SUCCESS (1.556s)
[112.324066] [024/133] (908s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[112.387066] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[112.490129] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[112.564730] [025/133] (907s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[112.625058] Starting subtest: mixed-tiled-to-y-tiled-ccs
[112.629911] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[112.823723] [026/133] (907s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[112.891335] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[112.958831] [027/133] (907s left) gem_partial_pwrite_pread (reads-display)
[113.019269] Subtest reads-display: SKIP (0.000s)
[113.091400] [028/133] (907s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[113.211072] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[113.215654] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[113.356828] [029/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[113.458937] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[113.463385] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[113.547724] [030/133] (907s left) drm_buddy (drm_buddy)
[113.583677] Starting subtest: drm_buddy
[113.588552] Subtest drm_buddy: SKIP (0.000s)
[113.633507] [031/133] (907s left) gem_userptr_blits (set-cache-level)
[113.686030] Starting subtest: set-cache-level
[113.690733] Subtest set-cache-level: SKIP (0.000s)
[113.808111] [032/133] (906s left) kms_addfb_basic (bad-pitch-1024)
[113.855916] Starting subtest: bad-pitch-1024
[113.857790] Subtest bad-pitch-1024: SUCCESS (0.000s)
[114.000314] [033/133] (906s left) gem_exec_alignment (forked)
[114.062725] Starting subtest: forked
[152.572096] Subtest forked: SUCCESS (38.505s)
[153.108797] [034/133] (867s left) prime_self_import (basic-with_one_bo)
[153.181558] Starting subtest: basic-with_one_bo
[153.205752] Subtest basic-with_one_bo: SUCCESS (0.025s)
[153.339634] [035/133] (867s left) gem_exec_schedule (in-order)
[153.415929] Starting subtest: in-order
[153.417792] Starting dynamic subtest: rcs0
[153.576272] Dynamic subtest rcs0: SUCCESS (0.164s)
[153.588776] Starting dynamic subtest: vcs0
[153.680321] Dynamic subtest vcs0: SUCCESS (0.105s)
[153.692350] Starting dynamic subtest: vcs1
[153.793693] Dynamic subtest vcs1: SUCCESS (0.113s)
[153.804695] Starting dynamic subtest: vecs0
[153.903655] Dynamic subtest vecs0: SUCCESS (0.109s)
[153.917576] Starting dynamic subtest: ccs0
[154.034154] Dynamic subtest ccs0: SUCCESS (0.131s)
[154.036645] Subtest in-order: SUCCESS (0.623s)
[154.998226] [036/133] (865s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[155.106803] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[155.109191] Starting dynamic subtest: pipe-A-eDP-1
[155.164495] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[155.172533] Starting dynamic subtest: pipe-B-eDP-1
[155.226711] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[155.234843] Starting dynamic subtest: pipe-C-eDP-1
[155.291653] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[155.300815] Starting dynamic subtest: pipe-D-eDP-1
[155.356666] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[155.360923] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[157.323865] [037/133] (863s left) gem_softpin (32b-excludes-last-page)
[157.386565] Starting subtest: 32b-excludes-last-page
[157.391242] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[157.501444] [038/133] (863s left) kms_rotation_crc (primary-rotation-90)
[157.591685] Starting subtest: primary-rotation-90
[157.596255] Subtest primary-rotation-90: SKIP (0.001s)
[157.668325] [039/133] (863s left) kms_psr (fbc-psr-cursor-render)
[157.766071] Starting subtest: fbc-psr-cursor-render
[157.768377] Starting dynamic subtest: eDP-1
[157.772401] Dynamic subtest eDP-1: SKIP (0.000s)
[157.776442] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[157.859835] [040/133] (863s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[157.954772] Starting subtest: fbc-pr-sprite-mmap-gtt
[157.958811] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[158.041833] [041/133] (863s left) kms_draw_crc (draw-method-mmap-cpu)
[158.129085] Starting subtest: draw-method-mmap-cpu
[158.131054] Starting dynamic subtest: xrgb8888-untiled
[158.372321] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[158.380739] Starting dynamic subtest: rgb565-untiled
[158.583524] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[158.592472] Starting dynamic subtest: xrgb2101010-untiled
[158.805898] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[158.814746] Starting dynamic subtest: xbgr16161616f-untiled
[159.027929] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[159.035607] Starting dynamic subtest: xrgb8888-xtiled
[159.150159] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[159.159147] Starting dynamic subtest: rgb565-xtiled
[159.272258] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[159.279928] Starting dynamic subtest: xrgb2101010-xtiled
[159.383360] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[159.391153] Starting dynamic subtest: xbgr16161616f-xtiled
[159.516981] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[159.529528] Starting dynamic subtest: xrgb8888-4tiled
[159.649983] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[159.657535] Starting dynamic subtest: rgb565-4tiled
[159.861686] Dynamic subtest rgb565-4tiled: SUCCESS (0.211s)
[159.871556] Starting dynamic subtest: xrgb2101010-4tiled
[159.983665] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[159.991890] Starting dynamic subtest: xbgr16161616f-4tiled
[160.127967] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[160.129987] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[160.219931] [042/133] (860s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[160.312981] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[160.314833] Starting dynamic subtest: pipe-A-eDP-1
[160.333064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.340866] Starting dynamic subtest: pipe-B-eDP-1
[160.359819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.370523] Starting dynamic subtest: pipe-C-eDP-1
[160.387469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.394533] Starting dynamic subtest: pipe-D-eDP-1
[160.411611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.414890] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[162.604578] [043/133] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[162.713430] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[185.190255] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.482s)
[185.337428] [044/133] (835s left) gem_exec_capture (capture)
[185.409411] Starting subtest: capture
[185.411306] Starting dynamic subtest: rcs0-smem
[186.240019] Dynamic subtest rcs0-smem: SUCCESS (0.828s)
[186.250681] Starting dynamic subtest: bcs0-smem
[187.180468] Dynamic subtest bcs0-smem: SUCCESS (0.941s)
[187.194791] Starting dynamic subtest: vcs0-smem
[188.005272] Dynamic subtest vcs0-smem: SUCCESS (0.825s)
[188.013406] Starting dynamic subtest: vcs1-smem
[188.827954] Dynamic subtest vcs1-smem: SUCCESS (0.818s)
[188.838292] Starting dynamic subtest: vecs0-smem
[190.235915] Dynamic subtest vecs0-smem: FAIL (1.348s)
[190.245612] Starting dynamic subtest: ccs0-smem
[191.495574] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[191.497988] Subtest capture: FAIL (6.083s)
[191.608472] [045/133] (829s left) perf_pmu (busy-hang)
[191.646203] Starting subtest: busy-hang
[191.648705] Starting dynamic subtest: rcs0
[192.876173] Dynamic subtest rcs0: SUCCESS (1.230s)
[192.885527] Starting dynamic subtest: bcs0
[194.080748] Dynamic subtest bcs0: SUCCESS (1.203s)
[194.091918] Starting dynamic subtest: vcs0
[196.435304] Dynamic subtest vcs0: SUCCESS (2.353s)
[196.445450] Starting dynamic subtest: vcs1
[198.421777] Dynamic subtest vcs1: SUCCESS (1.985s)
[198.431117] Starting dynamic subtest: vecs0
[200.409865] Dynamic subtest vecs0: SUCCESS (1.982s)
[200.419645] Starting dynamic subtest: ccs0
[201.620293] Dynamic subtest ccs0: SUCCESS (1.212s)
[201.622867] Subtest busy-hang: SUCCESS (9.976s)
[201.732764] [046/133] (819s left) prime_vgem (basic-write)
[201.801583] Starting subtest: basic-write
[201.827977] Subtest basic-write: SKIP (0.025s)
[201.948738] [047/133] (819s left) gem_exec_await (wide-all)
[202.171343] Starting subtest: wide-all
[225.660294] Subtest wide-all: SUCCESS (23.486s)
[225.848423] [048/133] (795s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[225.990146] Starting subtest: psr-dirtyfb-ioctl
[225.992467] Starting dynamic subtest: A-eDP-1
[229.829188] Dynamic subtest A-eDP-1: SUCCESS (3.839s)
[229.831654] Subtest psr-dirtyfb-ioctl: SUCCESS (3.840s)
[230.618373] [049/133] (790s left) kms_cursor_crc (cursor-size-hints)
[230.739759] Starting subtest: cursor-size-hints
[230.742119] Starting dynamic subtest: pipe-A-eDP-1
[231.400587] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.659s)
[231.415163] Starting dynamic subtest: pipe-D-eDP-1
[232.678844] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.273s)
[232.681260] Subtest cursor-size-hints: SUCCESS (1.938s)
[233.479985] [050/133] (788s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[233.569183] Starting subtest: addfb25-y-tiled-small-legacy
[233.573578] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[233.657706] [051/133] (787s left) kms_psr (psr-primary-mmap-cpu)
[233.751914] Starting subtest: psr-primary-mmap-cpu
[233.754229] Starting dynamic subtest: eDP-1
[235.460602] Dynamic subtest eDP-1: SUCCESS (1.708s)
[235.462790] Subtest psr-primary-mmap-cpu: SUCCESS (1.709s)
[236.328565] [052/133] (785s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[236.442273] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[236.446702] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[236.564605] [053/133] (785s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[236.663247] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[237.320270] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[237.481640] [054/133] (784s left) gem_exec_balancer (bonded-false-hang)
[237.740047] Starting subtest: bonded-false-hang
[237.744873] Subtest bonded-false-hang: SKIP (0.000s)
[237.834363] [055/133] (783s left) kms_getfb (getfb2-accept-nv12)
[237.928825] Starting subtest: getfb2-accept-nv12
[237.931121] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[238.019118] [056/133] (783s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[238.081450] Subtest writes-after-reads: SKIP (0.000s)
[238.139921] [057/133] (783s left) kms_content_protection (suspend-resume)
[238.281592] Starting subtest: suspend-resume
[238.286076] Subtest suspend-resume: SKIP (0.000s)
[238.395293] [058/133] (783s left) gem_mmap_wc (bad-offset)
[238.460383] Subtest bad-offset: SKIP (0.000s)
[238.518558] [059/133] (783s left) gem_ppgtt (blt-vs-render-ctxn)
[238.580243] Starting subtest: blt-vs-render-ctxN
[271.260050] Subtest blt-vs-render-ctxN: SUCCESS (32.675s)
[271.399902] [060/133] (750s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[271.534072] Starting subtest: crc-primary-basic-y-tiled-ccs
[271.536410] Starting dynamic subtest: pipe-A-eDP-1
[271.559153] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.569763] Starting dynamic subtest: pipe-B-eDP-1
[271.591418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.600066] Starting dynamic subtest: pipe-C-eDP-1
[271.621595] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.629622] Starting dynamic subtest: pipe-D-eDP-1
[271.651623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.655980] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[273.713634] [061/133] (748s left) perf (whitelisted-registers-userspace-config)
[273.856255] Starting subtest: whitelisted-registers-userspace-config
[273.858433] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[273.894158] [062/133] (748s left) kms_invalid_mode (overflow-vrefresh)
[273.995825] Starting subtest: overflow-vrefresh
[273.998091] Starting dynamic subtest: pipe-A-eDP-1
[274.282233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[274.291979] Starting dynamic subtest: pipe-B-eDP-1
[274.294318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[274.302740] Starting dynamic subtest: pipe-C-eDP-1
[274.305088] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[274.313118] Starting dynamic subtest: pipe-D-eDP-1
[274.315055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[274.316977] Subtest overflow-vrefresh: SUCCESS (0.292s)
[275.133480] [063/133] (746s left) gem_spin_batch (resubmit-new-all)
[275.191546] Starting subtest: resubmit-new-all
[275.194032] Starting dynamic subtest: rcs0
[275.203936] Dynamic subtest rcs0: SUCCESS (0.012s)
[275.213179] Starting dynamic subtest: bcs0
[275.217521] Dynamic subtest bcs0: SUCCESS (0.011s)
[275.226129] Starting dynamic subtest: vcs0
[275.228523] Dynamic subtest vcs0: SUCCESS (0.010s)
[275.239829] Starting dynamic subtest: vcs1
[275.244361] Dynamic subtest vcs1: SUCCESS (0.014s)
[275.254174] Starting dynamic subtest: vecs0
[275.256340] Dynamic subtest vecs0: SUCCESS (0.009s)
[275.265080] Starting dynamic subtest: ccs0
[275.267279] Dynamic subtest ccs0: SUCCESS (0.011s)
[275.269334] Subtest resubmit-new-all: SUCCESS (0.073s)
[276.923121] [064/133] (745s left) api_intel_bb (simple-bb)
[276.992416] Starting subtest: simple-bb
[277.000840] Subtest simple-bb: SUCCESS (0.008s)
[277.130080] [065/133] (744s left) syncobj_timeline (etime-multi-wait-all-submitted)
[277.186553] Starting subtest: etime-multi-wait-all-submitted
[277.290335] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[277.364511] [066/133] (744s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[277.469777] Starting subtest: y-tiled-8bpp-rotate-180
[277.474177] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[277.570349] [067/133] (744s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[277.668763] Starting subtest: fbc-pr-cursor-mmap-gtt
[277.673152] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[277.741687] [068/133] (744s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[279.295435] Starting subtest: dpms-mode-unset-non-lpsp
[280.446076] Subtest dpms-mode-unset-non-lpsp: SKIP (1.151s)
[280.828584] [069/133] (741s left) gem_ctx_param (root-set)
[280.890884] Starting subtest: root-set
[280.893384] Subtest root-set: SUCCESS (0.001s)
[280.979200] [070/133] (741s left) syncobj_timeline (device-submit-unordered)
[281.028887] Starting subtest: device-submit-unordered
[281.031184] Subtest device-submit-unordered: SUCCESS (0.000s)
[281.120672] [071/133] (741s left) gem_readwrite (read-write)
[281.168803] Subtest read-write: SKIP (0.000s)
[281.228843] [072/133] (741s left) gem_exec_schedule (u-submit-late-slice)
[281.294048] Starting subtest: u-submit-late-slice
[281.296169] Starting dynamic subtest: rcs0
[281.329539] Dynamic subtest rcs0: SUCCESS (0.040s)
[281.338113] Starting dynamic subtest: bcs0
[281.366423] Dynamic subtest bcs0: SUCCESS (0.036s)
[281.380682] Starting dynamic subtest: vcs0
[281.398968] Dynamic subtest vcs0: SUCCESS (0.031s)
[281.413427] Starting dynamic subtest: vcs1
[281.432407] Dynamic subtest vcs1: SUCCESS (0.033s)
[281.441707] Starting dynamic subtest: vecs0
[281.470849] Dynamic subtest vecs0: SUCCESS (0.037s)
[281.479916] Starting dynamic subtest: ccs0
[281.510791] Dynamic subtest ccs0: SUCCESS (0.039s)
[281.513273] Subtest u-submit-late-slice: SUCCESS (0.222s)
[282.986862] [073/133] (739s left) sriov_basic (enable-vfs-autoprobe-on)
[283.035519] Starting subtest: enable-vfs-autoprobe-on
[283.038070] Starting dynamic subtest: numvfs-1
[283.120826] Dynamic subtest numvfs-1: FAIL (0.026s)
[283.131646] Starting dynamic subtest: numvfs-2
[283.205399] Dynamic subtest numvfs-2: FAIL (0.004s)
[283.215957] Starting dynamic subtest: numvfs-3
[283.288461] Dynamic subtest numvfs-3: FAIL (0.003s)
[283.298623] Starting dynamic subtest: numvfs-4
[283.373257] Dynamic subtest numvfs-4: FAIL (0.003s)
[283.386271] Starting dynamic subtest: numvfs-5
[283.461564] Dynamic subtest numvfs-5: FAIL (0.009s)
[283.471509] Starting dynamic subtest: numvfs-6
[283.544536] Dynamic subtest numvfs-6: FAIL (0.005s)
[283.554836] Starting dynamic subtest: numvfs-7
[283.629970] Dynamic subtest numvfs-7: FAIL (0.004s)
[283.640212] Starting dynamic subtest: numvfs-random
[283.715220] Dynamic subtest numvfs-random: FAIL (0.004s)
[283.725721] Starting dynamic subtest: numvfs-all
[283.799337] Dynamic subtest numvfs-all: FAIL (0.523s)
[283.801365] Subtest enable-vfs-autoprobe-on: FAIL (0.588s)
[283.840452] [074/133] (738s left) kms_plane_multiple (2x-tiling-y)
[283.931833] Starting subtest: 2x-tiling-y
[283.936206] Subtest 2x-tiling-y: SKIP (0.000s)
[284.010985] [075/133] (738s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[284.100932] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[284.104823] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[284.212860] [076/133] (738s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[284.298017] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[284.299775] Starting dynamic subtest: pipe-A-eDP-1
[284.319735] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.329081] Starting dynamic subtest: pipe-B-eDP-1
[284.347992] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.357167] Starting dynamic subtest: pipe-C-eDP-1
[284.376144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.384792] Starting dynamic subtest: pipe-D-eDP-1
[284.404054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.407274] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[286.603811] [077/133] (735s left) gem_userptr_blits (process-exit-busy)
[286.671061] Starting subtest: process-exit-busy
[286.680072] Subtest process-exit-busy: SUCCESS (0.013s)
[286.801157] [078/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[286.909396] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[286.913638] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[286.995697] [079/133] (735s left) kms_vblank (ts-continuation-modeset-rpm)
[287.085830] Starting subtest: ts-continuation-modeset-rpm
[287.087667] Starting dynamic subtest: pipe-A-eDP-1
[289.577055] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.492s)
[289.593071] Starting dynamic subtest: pipe-D-eDP-1
[291.807642] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.226s)
[291.809648] Subtest ts-continuation-modeset-rpm: SUCCESS (4.721s)
[292.690093] [080/133] (730s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[292.800586] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[293.846015] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.044s)
[293.967761] [081/133] (728s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[294.024922] Starting subtest: multi-wait-all-for-submit-signaled
[294.026646] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[294.131108] [082/133] (728s left) kms_plane (plane-panning-top-left)
[294.229186] Starting subtest: plane-panning-top-left
[294.231342] Starting dynamic subtest: pipe-A
[295.866709] Dynamic subtest pipe-A: SUCCESS (1.636s)
[295.877174] Starting dynamic subtest: pipe-B
[298.238197] Dynamic subtest pipe-B: SUCCESS (2.367s)
[298.240199] Subtest plane-panning-top-left: SUCCESS (4.007s)
[299.116402] [083/133] (723s left) gem_exec_parallel (userptr)
[299.176657] Starting subtest: userptr
[299.179095] Starting dynamic subtest: rcs0
[300.620050] Dynamic subtest rcs0: SUCCESS (1.443s)
[300.631669] Starting dynamic subtest: bcs0
[302.104472] Dynamic subtest bcs0: SUCCESS (1.483s)
[302.113826] Starting dynamic subtest: vcs0
[303.908788] Dynamic subtest vcs0: SUCCESS (1.800s)
[303.919232] Starting dynamic subtest: vcs1
[305.941764] Dynamic subtest vcs1: SUCCESS (2.031s)
[305.953956] Starting dynamic subtest: vecs0
[307.861477] Dynamic subtest vecs0: SUCCESS (1.917s)
[307.872248] Starting dynamic subtest: ccs0
[309.347898] Dynamic subtest ccs0: SUCCESS (1.485s)
[309.350902] Subtest userptr: SUCCESS (10.171s)
[309.533563] [084/133] (713s left) kms_hdmi_inject (inject-4k)
[309.871763] Starting subtest: inject-4k
[310.182621] Subtest inject-4k: SUCCESS (0.314s)
[310.770527] [085/133] (712s left) kms_chamelium_edid (hdmi-mode-timings)
[311.149116] Subtest hdmi-mode-timings: SKIP (0.000s)
[311.922410] [086/133] (711s left) syncobj_wait (multi-wait-for-submit-submitted)
[311.985877] Starting subtest: multi-wait-for-submit-submitted
[312.090381] Subtest multi-wait-for-submit-submitted: SUCCESS (0.104s)
[312.165714] [087/133] (710s left) gem_exec_schedule (smoketest-all)
[312.238216] Starting subtest: smoketest-all
[344.608795] Subtest smoketest-all: SUCCESS (32.332s)
[346.050957] [088/133] (676s left) sysfs_heartbeat_interval (mixed)
[346.111254] Starting subtest: mixed
[346.113658] Starting dynamic subtest: vecs0
[351.339177] Dynamic subtest vecs0: SUCCESS (5.222s)
[351.350787] Starting dynamic subtest: ccs0
[356.563039] Dynamic subtest ccs0: SUCCESS (5.227s)
[356.574326] Starting dynamic subtest: vcs0
[361.775369] Dynamic subtest vcs0: SUCCESS (5.211s)
[361.787652] Starting dynamic subtest: bcs0
[366.969998] Dynamic subtest bcs0: SUCCESS (5.192s)
[366.981600] Starting dynamic subtest: rcs0
[372.154868] Dynamic subtest rcs0: SUCCESS (5.183s)
[372.164999] Starting dynamic subtest: vcs1
[377.334302] Dynamic subtest vcs1: SUCCESS (5.177s)
[377.337284] Subtest mixed: SUCCESS (31.224s)
[377.414189] [089/133] (645s left) kms_cursor_crc (cursor-sliding-512x512)
[377.679950] Starting subtest: cursor-sliding-512x512
[377.684286] Subtest cursor-sliding-512x512: SKIP (0.001s)
[377.838967] [090/133] (645s left) perf (sysctl-defaults)
[377.907714] Starting subtest: sysctl-defaults
[377.910029] Subtest sysctl-defaults: SUCCESS (0.000s)
[377.979888] [091/133] (645s left) gem_ctx_persistence (legacy-engines-hostile)
[378.049837] Starting subtest: legacy-engines-hostile
[378.052176] Starting dynamic subtest: render
[378.132407] Dynamic subtest render: SUCCESS (0.085s)
[378.145690] Starting dynamic subtest: bsd1
[378.205621] Dynamic subtest bsd1: SUCCESS (0.069s)
[378.215868] Starting dynamic subtest: bsd2
[378.315340] Dynamic subtest bsd2: SUCCESS (0.108s)
[378.328844] Starting dynamic subtest: blt
[378.336992] Dynamic subtest blt: SUCCESS (0.019s)
[378.345293] Starting dynamic subtest: vebox
[378.447426] Dynamic subtest vebox: SUCCESS (0.109s)
[378.449560] Subtest legacy-engines-hostile: SUCCESS (0.401s)
[378.523132] [092/133] (644s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[378.619926] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[378.621926] Starting dynamic subtest: pipe-A-eDP-1
[378.738515] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[378.748056] Starting dynamic subtest: pipe-B-eDP-1
[379.887243] Dynamic subtest pipe-B-eDP-1: SKIP (1.144s)
[379.891747] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.269s)
[381.137914] [093/133] (642s left) kms_flip (basic-flip-vs-dpms)
[381.232325] Starting subtest: basic-flip-vs-dpms
[381.234735] Starting dynamic subtest: A-eDP1
[383.765707] Dynamic subtest A-eDP1: SUCCESS (2.533s)
[383.776075] Starting dynamic subtest: B-eDP1
[385.979679] Dynamic subtest B-eDP1: SUCCESS (2.211s)
[385.988738] Starting dynamic subtest: C-eDP1
[388.177701] Dynamic subtest C-eDP1: SUCCESS (2.195s)
[388.186829] Starting dynamic subtest: D-eDP1
[390.372608] Dynamic subtest D-eDP1: SUCCESS (2.194s)
[390.378700] Subtest basic-flip-vs-dpms: SUCCESS (9.145s)
[391.229047] [094/133] (632s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[391.322524] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[391.324791] Starting dynamic subtest: pipe-A
[391.549565] Dynamic subtest pipe-A: SUCCESS (0.228s)
[391.558726] Starting dynamic subtest: pipe-B
[392.894577] Dynamic subtest pipe-B: SUCCESS (1.344s)
[392.903603] Starting dynamic subtest: pipe-C
[394.191093] Dynamic subtest pipe-C: SUCCESS (1.295s)
[394.201069] Starting dynamic subtest: pipe-D
[395.515689] Dynamic subtest pipe-D: SUCCESS (1.322s)
[395.518057] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.196s)
[396.732179] [095/133] (626s left) gem_mmap_gtt (cpuset-basic-small-copy)
[396.801364] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[396.867419] [096/133] (626s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[396.961317] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[403.684502] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.726s)
[403.799197] [097/133] (619s left) gem_exec_fence (syncobj-channel)
[404.273421] Starting subtest: syncobj-channel
[405.300413] Subtest syncobj-channel: SUCCESS (1.024s)
[405.992646] [098/133] (617s left) gem_ctx_param (invalid-get-engines)
[406.051177] Starting subtest: invalid-get-engines
[406.053898] Subtest invalid-get-engines: SUCCESS (0.001s)
[406.164042] [099/133] (617s left) gem_exec_flush (basic-wb-rw-before-default)
[406.222525] Starting subtest: basic-wb-rw-before-default
[411.684534] Subtest basic-wb-rw-before-default: SUCCESS (5.463s)
[411.872652] [100/133] (611s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[411.969597] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[411.973792] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[412.057351] [101/133] (611s left) gem_mmap_gtt (zero-extend)
[412.117295] Subtest zero-extend: SKIP (0.000s)
[412.178830] [102/133] (611s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[412.288152] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[413.346264] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.059s)
[413.492464] [103/133] (610s left) gem_exec_flush (basic-batch-kernel-default-uc)
[413.549229] Starting subtest: basic-batch-kernel-default-uc
[420.768084] Subtest basic-batch-kernel-default-uc: SUCCESS (7.218s)
[420.954610] [104/133] (602s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[421.058808] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[421.063083] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.161593] [105/133] (602s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[421.256712] Starting subtest: flip-vs-dpms-on-nop-interruptible
[421.259070] Starting dynamic subtest: A-eDP1
[423.094488] Dynamic subtest A-eDP1: SUCCESS (1.836s)
[423.105894] Starting dynamic subtest: B-eDP1
[424.899156] Dynamic subtest B-eDP1: SUCCESS (1.802s)
[424.912571] Starting dynamic subtest: C-eDP1
[426.771662] Dynamic subtest C-eDP1: SUCCESS (1.870s)
[426.780816] Starting dynamic subtest: D-eDP1
[428.575047] Dynamic subtest D-eDP1: SUCCESS (1.802s)
[428.579930] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.323s)
[429.732910] [106/133] (594s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[429.833841] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[436.280082] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.451s)
[436.395227] [107/133] (587s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[436.488121] Starting subtest: psr-rgb101010-draw-mmap-gtt
[436.492062] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[436.568132] [108/133] (587s left) i915_drm_fdinfo (virtual-busy)
[436.612865] Starting subtest: virtual-busy
[436.617183] Subtest virtual-busy: SKIP (0.000s)
[436.680329] [109/133] (587s left) gem_mmap_gtt (basic-small-copy-odd)
[436.737337] Subtest basic-small-copy-odd: SKIP (0.000s)
[436.797175] [110/133] (587s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[436.891236] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[436.895756] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[436.999834] [111/133] (586s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[437.093698] Starting subtest: basic-max-pipe-crc-check
[437.098467] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[437.139621] [112/133] (586s left) api_intel_allocator (fork-simple-stress-signal)
[437.204585] Starting subtest: fork-simple-stress-signal
[442.606301] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[442.739386] [113/133] (581s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[442.848983] Starting subtest: primary-y-tiled-reflect-x-0
[442.909234] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[443.014912] [114/133] (581s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[443.126292] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[450.176755] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.054s)
[450.303090] [115/133] (573s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[450.396714] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[450.401227] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[450.468180] [116/133] (573s left) gem_create (create-ext-placement-all)
[450.651609] Starting subtest: create-ext-placement-all
[450.654022] Subtest create-ext-placement-all: SUCCESS (0.000s)
[450.732142] [117/133] (573s left) gem_ctx_create (basic)
[450.796046] Starting subtest: basic
[450.798472] Subtest basic: SUCCESS (0.000s)
[450.979818] [118/133] (573s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[451.030259] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[451.032414] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[451.146333] [119/133] (573s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[451.188884] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[451.191091] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[451.271430] [120/133] (573s left) gen9_exec_parse (bb-secure)
[451.332846] Subtest bb-secure: SKIP (0.000s)
[451.401233] [121/133] (572s left) kms_psr (pr-primary-page-flip)
[451.490908] Starting subtest: pr-primary-page-flip
[451.495617] Subtest pr-primary-page-flip: SKIP (0.000s)
[451.565176] [122/133] (572s left) kms_flip (blocking-wf_vblank)
[451.646500] Starting subtest: blocking-wf_vblank
[451.648617] Starting dynamic subtest: A-eDP1
[460.540962] Dynamic subtest A-eDP1: SUCCESS (8.895s)
[460.550236] Starting dynamic subtest: B-eDP1
[469.441532] Dynamic subtest B-eDP1: SUCCESS (8.899s)
[469.454706] Starting dynamic subtest: C-eDP1
[478.326736] Dynamic subtest C-eDP1: SUCCESS (8.882s)
[478.345667] Starting dynamic subtest: D-eDP1
[487.227516] Dynamic subtest D-eDP1: SUCCESS (8.899s)
[487.232934] Subtest blocking-wf_vblank: SUCCESS (35.587s)
[488.420130] [123/133] (536s left) kms_color_pipeline (plane-lut1d-lut1d)
[488.521168] Starting subtest: plane-lut1d-lut1d
[488.699888] Starting dynamic subtest: pipe-A-plane-0
[488.877404] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[488.887392] Starting dynamic subtest: pipe-A-plane-1
[489.010629] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[489.019612] Starting dynamic subtest: pipe-A-plane-2
[489.199817] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[490.380593] Starting dynamic subtest: pipe-B-plane-0
[490.539460] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[490.548819] Starting dynamic subtest: pipe-B-plane-1
[490.750704] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[490.764643] Starting dynamic subtest: pipe-B-plane-2
[490.883838] Dynamic subtest pipe-B-plane-2: SUCCESS (0.131s)
[492.096087] Starting dynamic subtest: pipe-C-plane-0
[492.241472] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[492.251083] Starting dynamic subtest: pipe-C-plane-1
[492.385866] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[492.395717] Starting dynamic subtest: pipe-C-plane-2
[492.541471] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[493.690842] Starting dynamic subtest: pipe-D-plane-0
[493.847068] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[493.856984] Starting dynamic subtest: pipe-D-plane-1
[494.014094] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[494.025676] Starting dynamic subtest: pipe-D-plane-2
[494.180749] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[494.474781] Subtest plane-lut1d-lut1d: SUCCESS (5.955s)
[495.335249] [124/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[495.445672] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[501.888213] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.445s)
[502.009285] [125/133] (522s left) kms_universal_plane (universal-plane-functional)
[502.105746] Starting subtest: universal-plane-functional
[502.108044] Starting dynamic subtest: pipe-A-eDP-1
[506.073097] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.968s)
[506.083223] Starting dynamic subtest: pipe-B-eDP-1
[510.702024] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.626s)
[510.712618] Starting dynamic subtest: pipe-C-eDP-1
[515.126506] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.423s)
[515.136399] Starting dynamic subtest: pipe-D-eDP-1
[519.383441] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.252s)
[519.385724] Subtest universal-plane-functional: SUCCESS (17.276s)
[520.240913] [126/133] (504s left) kms_lease (lease-unleased-connector)
[520.333128] Starting subtest: lease-unleased-connector
[520.335445] Starting dynamic subtest: pipe-A-eDP-1
[520.337683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[520.347595] Starting dynamic subtest: pipe-B-eDP-1
[520.353113] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[520.362829] Starting dynamic subtest: pipe-C-eDP-1
[520.368462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[520.381773] Starting dynamic subtest: pipe-D-eDP-1
[520.384603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[520.386910] Subtest lease-unleased-connector: SUCCESS (0.054s)
[520.492978] [127/133] (504s left) gem_exec_reloc (basic-gtt-wc-active)
[520.553556] Subtest basic-gtt-wc-active: SKIP (0.000s)
[520.617590] [128/133] (504s left) kms_getfb (getfb-handle-zero)
[520.722664] Starting subtest: getfb-handle-zero
[520.724994] Subtest getfb-handle-zero: SUCCESS (0.000s)
[520.822341] [129/133] (503s left) i915_pm_rps (reset)
[520.874382] Starting subtest: reset
[529.340949] Subtest reset: SUCCESS (8.465s)
[529.480275] [130/133] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[529.570788] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[536.304736] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.735s)
[536.432825] [131/133] (488s left) kms_async_flips (test-cursor-atomic)
[536.521074] Starting subtest: test-cursor-atomic
[536.889345] Starting dynamic subtest: pipe-A-eDP-1
[537.678885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s)
[538.060055] Starting dynamic subtest: pipe-B-eDP-1
[538.886537] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.834s)
[539.265545] Starting dynamic subtest: pipe-C-eDP-1
[540.082613] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.826s)
[540.455165] Starting dynamic subtest: pipe-D-eDP-1
[541.282365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.841s)
[541.284644] Subtest test-cursor-atomic: SUCCESS (4.763s)
[542.438138] [132/133] (482s left) gem_exec_reloc (basic-gtt-wc)
[542.501931] Subtest basic-gtt-wc: SKIP (0.000s)
[542.579815] [133/133] (482s left) fbdev (pan)
[542.614903] Starting subtest: pan
[542.638436] Subtest pan: SUCCESS (0.025s)
[542.707321] 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.