[58.004384] Initializing watchdogs
[58.004435]   /dev/watchdog0
[58.019625] [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.024452] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.027299] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.030433] [001/155] (960s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[59.629892] Starting subtest: dpms-mode-unset-lpsp
[63.705651] Subtest dpms-mode-unset-lpsp: SUCCESS (4.079s)
[64.123497] [002/155] (954s left) kms_flip (flip-vs-suspend)
[64.227570] Starting subtest: flip-vs-suspend
[64.229863] Starting dynamic subtest: A-eDP1
[209.726361] Dynamic subtest A-eDP1: SUCCESS (12.086s)
[209.728512] Subtest flip-vs-suspend: SUCCESS (12.088s)
[209.854912] [003/155] (808s left) gem_exec_reloc (basic-cpu-gtt-active)
[209.941175] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[210.025255] [004/155] (808s left) kms_cursor_edge_walk (256x256-top-edge)
[210.112591] Starting subtest: 256x256-top-edge
[210.114944] Starting dynamic subtest: pipe-A-eDP-1
[213.554323] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[213.566884] Starting dynamic subtest: pipe-D-eDP-1
[216.774548] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.217s)
[216.776887] Subtest 256x256-top-edge: SUCCESS (6.658s)
[217.580716] [005/155] (801s left) kms_vblank (query-forked-hang)
[217.681943] Starting subtest: query-forked-hang
[217.684226] Starting dynamic subtest: pipe-A-eDP-1
[244.479687] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.794s)
[244.495372] Starting dynamic subtest: pipe-D-eDP-1
[259.502921] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.023s)
[259.505204] Subtest query-forked-hang: SUCCESS (41.821s)
[260.354133] [006/155] (758s left) perf_pmu (busy-start)
[260.396764] Starting subtest: busy-start
[260.399192] Starting dynamic subtest: rcs0
[262.955918] Dynamic subtest rcs0: SUCCESS (2.559s)
[262.966495] Starting dynamic subtest: bcs0
[265.505133] Dynamic subtest bcs0: SUCCESS (2.548s)
[265.518911] Starting dynamic subtest: vcs0
[268.718825] Dynamic subtest vcs0: SUCCESS (3.210s)
[268.730848] Starting dynamic subtest: vcs1
[272.686061] Dynamic subtest vcs1: SUCCESS (3.966s)
[272.697521] Starting dynamic subtest: vecs0
[276.719301] Dynamic subtest vecs0: SUCCESS (4.032s)
[276.730526] Starting dynamic subtest: ccs0
[279.266223] Dynamic subtest ccs0: SUCCESS (2.547s)
[279.268704] Subtest busy-start: SUCCESS (18.872s)
[279.386140] [007/155] (739s left) kms_joiner (basic-ultra-joiner)
[279.491355] Starting subtest: basic-ultra-joiner
[279.495929] Subtest basic-ultra-joiner: SKIP (0.000s)
[279.558006] [008/155] (739s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[279.655130] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[279.659776] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[279.753196] [009/155] (739s left) gem_busy (extended)
[279.938198] Starting subtest: extended
[279.940598] Starting dynamic subtest: rcs0
[280.016803] Dynamic subtest rcs0: SUCCESS (0.078s)
[280.029015] Starting dynamic subtest: bcs0
[280.057332] Dynamic subtest bcs0: SUCCESS (0.040s)
[280.066893] Starting dynamic subtest: vcs0
[281.711631] Dynamic subtest vcs0: SUCCESS (1.650s)
[281.723234] Starting dynamic subtest: vcs1
[283.695255] Dynamic subtest vcs1: SUCCESS (1.983s)
[283.706523] Starting dynamic subtest: vecs0
[285.743319] Dynamic subtest vecs0: SUCCESS (2.046s)
[285.755149] Starting dynamic subtest: ccs0
[285.788113] Dynamic subtest ccs0: SUCCESS (0.045s)
[285.790498] Subtest extended: SUCCESS (5.851s)
[286.026353] [010/155] (732s left) gem_ctx_shared (q-independent)
[286.092209] Starting subtest: Q-independent
[286.094561] Starting dynamic subtest: rcs0
[286.219514] Dynamic subtest rcs0: SUCCESS (0.125s)
[286.232314] Starting dynamic subtest: vcs0
[286.285935] Dynamic subtest vcs0: SUCCESS (0.067s)
[286.298886] Starting dynamic subtest: vcs1
[286.351712] Dynamic subtest vcs1: SUCCESS (0.066s)
[286.364313] Starting dynamic subtest: vecs0
[286.424278] Dynamic subtest vecs0: SUCCESS (0.072s)
[286.436514] Starting dynamic subtest: ccs0
[286.506402] Dynamic subtest ccs0: SUCCESS (0.081s)
[286.509450] Subtest Q-independent: SUCCESS (0.414s)
[287.827754] [011/155] (731s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[287.879617] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[287.987633] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[288.063543] [012/155] (730s left) api_intel_allocator (reopen-fork)
[288.124989] Starting subtest: reopen-fork
[291.551436] Subtest reopen-fork: SUCCESS (3.427s)
[291.641059] [013/155] (727s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[291.774902] Starting subtest: cursor-vs-flip-toggle
[323.154251] Subtest cursor-vs-flip-toggle: SUCCESS (31.379s)
[323.966141] [014/155] (695s left) i915_pm_freq_api (freq-basic-api)
[324.033557] Starting subtest: freq-basic-api
[324.035852] Starting dynamic subtest: gt0
[324.038128] Dynamic subtest gt0: SUCCESS (0.003s)
[324.047693] Starting dynamic subtest: gt1
[324.049620] Dynamic subtest gt1: SUCCESS (0.003s)
[324.051528] Subtest freq-basic-api: SUCCESS (0.006s)
[324.132214] [015/155] (694s left) kms_draw_crc (draw-method-mmap-wc)
[324.233748] Starting subtest: draw-method-mmap-wc
[324.235688] Starting dynamic subtest: xrgb8888-untiled
[324.487892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[324.497964] Starting dynamic subtest: rgb565-untiled
[324.698769] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[324.709661] Starting dynamic subtest: xrgb2101010-untiled
[324.909864] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[324.919350] Starting dynamic subtest: xbgr16161616f-untiled
[325.120946] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[325.130373] Starting dynamic subtest: xrgb8888-xtiled
[325.243150] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[325.254348] Starting dynamic subtest: rgb565-xtiled
[325.365049] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[325.374564] Starting dynamic subtest: xrgb2101010-xtiled
[325.487017] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[325.500571] Starting dynamic subtest: xbgr16161616f-xtiled
[325.609367] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[325.618476] Starting dynamic subtest: xrgb8888-4tiled
[325.754512] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[325.764423] Starting dynamic subtest: rgb565-4tiled
[325.898327] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[325.907336] Starting dynamic subtest: xrgb2101010-4tiled
[326.054288] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[326.063543] Starting dynamic subtest: xbgr16161616f-4tiled
[326.231794] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[326.233880] Subtest draw-method-mmap-wc: SUCCESS (2.000s)
[326.338548] [016/155] (692s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[326.445283] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[326.448813] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.535222] [017/155] (692s left) gem_ctx_param (root-set)
[326.584031] Starting subtest: root-set
[326.585955] Subtest root-set: SUCCESS (0.001s)
[326.679115] [018/155] (692s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[326.774035] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[326.777915] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[326.870606] [019/155] (692s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move)
[326.973237] Starting subtest: hdr-1p-primscrn-cur-indfb-move
[326.976482] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[327.070110] [020/155] (692s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[327.166955] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[327.170449] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[327.270636] [021/155] (692s left) gem_exec_reloc (basic-gtt-read)
[327.334639] Subtest basic-gtt-read: SKIP (0.000s)
[327.402238] [022/155] (691s left) kms_flip (absolute-wf_vblank-interruptible)
[327.497318] Starting subtest: absolute-wf_vblank-interruptible
[327.501123] Starting dynamic subtest: A-eDP1
[336.230124] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[336.241902] Starting dynamic subtest: B-eDP1
[344.959235] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[344.972546] Starting dynamic subtest: C-eDP1
[353.671918] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[353.681981] Starting dynamic subtest: D-eDP1
[362.396167] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[362.400628] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.903s)
[363.613308] [023/155] (655s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[363.719989] Starting subtest: yf-tiled-64bpp-rotate-0
[363.724512] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[363.813065] [024/155] (655s left) gem_exec_balancer (parallel-out-fence)
[364.076866] Starting subtest: parallel-out-fence
[365.250651] Subtest parallel-out-fence: SUCCESS (1.174s)
[365.330948] [025/155] (654s left) perf (gen12-oa-tlb-invalidate)
[365.460556] Starting subtest: gen12-oa-tlb-invalidate
[365.462778] Starting dynamic subtest: 0-rcs0
[375.506991] Dynamic subtest 0-rcs0: SUCCESS (10.045s)
[375.517146] Starting dynamic subtest: 1-vcs0
[385.558686] Dynamic subtest 1-vcs0: SUCCESS (10.050s)
[385.561337] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.097s)
[385.604409] [026/155] (633s left) gem_mmap_offset (bad-flags)
[385.664108] Starting subtest: bad-flags
[385.666385] Subtest bad-flags: SUCCESS (0.000s)
[385.751623] [027/155] (633s left) syncobj_wait (invalid-reset-bad-pad)
[385.797907] Starting subtest: invalid-reset-bad-pad
[385.800006] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[385.921179] [028/155] (633s left) gem_exec_schedule (u-semaphore-noskip)
[385.991261] Starting subtest: u-semaphore-noskip
[386.437730] Subtest u-semaphore-noskip: SUCCESS (0.451s)
[386.773064] [029/155] (632s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[386.885880] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[386.890432] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[386.966560] [030/155] (632s left) gem_spin_batch (spin-all-new)
[387.028222] Starting subtest: spin-all-new
[387.043382] Subtest spin-all-new: SUCCESS (0.013s)
[388.768560] [031/155] (630s left) kms_addfb_basic (invalid-set-prop)
[388.812892] Starting subtest: invalid-set-prop
[388.814740] Subtest invalid-set-prop: SUCCESS (0.000s)
[388.936339] [032/155] (630s left) kms_psr (psr2-sprite-render)
[389.028380] Starting subtest: psr2-sprite-render
[389.030614] Starting dynamic subtest: eDP-1
[390.800162] Dynamic subtest eDP-1: SUCCESS (1.773s)
[390.802463] Subtest psr2-sprite-render: SUCCESS (1.774s)
[391.662952] [033/155] (628s left) gem_exec_await (wide-contexts)
[391.876819] Starting subtest: wide-contexts
[415.642806] Subtest wide-contexts: SUCCESS (23.765s)
[415.832347] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[415.836798] [034/155] (604s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[415.984642] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[415.989131] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[416.080917] [035/155] (603s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[416.203402] Starting subtest: y-tiled-64bpp-rotate-180
[416.207632] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[416.314793] [036/155] (603s left) i915_selftest (perf)
[420.973807] Starting subtest: perf
[420.977256] Starting dynamic subtest: engine_cs
[425.418757] Dynamic subtest engine_cs: SUCCESS (4.444s)
[425.429483] Starting dynamic subtest: request
[432.675700] Dynamic subtest request: SUCCESS (7.257s)
[432.690444] Starting dynamic subtest: migrate
[435.586172] Dynamic subtest migrate: SUCCESS (2.908s)
[435.597513] Starting dynamic subtest: region
[441.372735] Dynamic subtest region: SUCCESS (5.785s)
[441.375545] Subtest perf: SUCCESS (20.398s)
[441.404132] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[441.404863] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[441.407806] [037/155] (578s left) kms_psr (pr-primary-page-flip)
[442.990431] Starting subtest: pr-primary-page-flip
[442.994578] Subtest pr-primary-page-flip: SKIP (0.000s)
[443.097274] [FACT kms_psr (pr-primary-page-flip)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[443.098606] [FACT kms_psr (pr-primary-page-flip)] new: kernel.kmod_is_loaded.i915: true
[443.102169] [038/155] (576s left) kms_flip (2x-flip-vs-panning-vs-hang)
[443.197246] Starting subtest: 2x-flip-vs-panning-vs-hang
[443.201567] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[443.334146] [039/155] (576s left) gem_lmem_swapping (heavy-multi)
[443.382237] Subtest heavy-multi: SKIP (0.000s)
[443.429330] [040/155] (576s left) kms_cursor_crc (cursor-size-hints)
[443.569972] Starting subtest: cursor-size-hints
[443.572321] Starting dynamic subtest: pipe-A-eDP-1
[444.253718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.682s)
[444.263710] Starting dynamic subtest: pipe-D-eDP-1
[445.498548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[445.500770] Subtest cursor-size-hints: SUCCESS (1.927s)
[446.308741] [041/155] (573s left) gem_sync (basic-all)
[446.377973] Starting subtest: basic-all
[451.660515] Subtest basic-all: SUCCESS (5.288s)
[451.847344] [042/155] (568s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[451.889652] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[451.891954] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[451.981626] [043/155] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[452.089910] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[452.094006] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[452.187433] [044/155] (568s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt)
[452.288275] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt
[452.292690] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[452.398551] [045/155] (567s left) core_getclient (basic)
[452.459269] Starting subtest: basic
[452.461211] Subtest basic: SUCCESS (0.000s)
[452.570906] [046/155] (567s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[452.669294] Starting subtest: plane-lut1d-pre-ctm3x4
[452.793186] Starting dynamic subtest: pipe-A-plane-0
[452.959861] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[452.969593] Starting dynamic subtest: pipe-A-plane-1
[453.105454] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[453.115126] Starting dynamic subtest: pipe-A-plane-2
[453.248679] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[454.414803] Starting dynamic subtest: pipe-B-plane-0
[454.592659] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[454.603256] Starting dynamic subtest: pipe-B-plane-1
[454.760417] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[454.770753] Starting dynamic subtest: pipe-B-plane-2
[454.927232] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[456.154541] Starting dynamic subtest: pipe-C-plane-0
[456.301858] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[456.312316] Starting dynamic subtest: pipe-C-plane-1
[456.467921] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[456.477982] Starting dynamic subtest: pipe-C-plane-2
[456.624347] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[457.824193] Starting dynamic subtest: pipe-D-plane-0
[457.956902] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[457.967109] Starting dynamic subtest: pipe-D-plane-1
[458.112231] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[458.122498] Starting dynamic subtest: pipe-D-plane-2
[458.256687] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[458.559267] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.890s)
[459.368779] [047/155] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[459.480228] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[459.484433] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[459.570367] [048/155] (560s left) kms_frontbuffer_tracking (psrhdr-modesetfrombusy)
[459.675977] Starting subtest: psrhdr-modesetfrombusy
[459.680298] Subtest psrhdr-modesetfrombusy: SKIP (0.000s)
[459.758105] [049/155] (560s left) prime_vgem (wait)
[459.835442] Starting subtest: wait
[459.837810] Starting dynamic subtest: rcs0
[459.884036] Dynamic subtest rcs0: SUCCESS (0.048s)
[459.894820] Starting dynamic subtest: bcs0
[459.937048] Dynamic subtest bcs0: SUCCESS (0.052s)
[459.946965] Starting dynamic subtest: vcs0
[459.985272] Dynamic subtest vcs0: SUCCESS (0.047s)
[459.995068] Starting dynamic subtest: vcs1
[460.028167] Dynamic subtest vcs1: SUCCESS (0.042s)
[460.037895] Starting dynamic subtest: vecs0
[460.077957] Dynamic subtest vecs0: SUCCESS (0.049s)
[460.088422] Starting dynamic subtest: ccs0
[460.120825] Dynamic subtest ccs0: SUCCESS (0.042s)
[460.123281] Subtest wait: SUCCESS (0.286s)
[460.260959] [050/155] (560s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[460.355907] Starting subtest: multiplane-rotation-cropping-top
[477.785757] Subtest multiplane-rotation-cropping-top: SUCCESS (17.427s)
[477.897873] [051/155] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[478.005633] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[485.290767] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.287s)
[485.420839] [052/155] (535s left) syncobj_basic (bad-pad-fd-to-handle)
[485.484908] Starting subtest: bad-pad-fd-to-handle
[485.487201] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[485.573957] [053/155] (535s left) gem_exec_schedule (pi-ringfull)
[485.760806] Starting subtest: pi-ringfull
[485.763083] Starting dynamic subtest: rcs0
[485.789355] Dynamic subtest rcs0: SUCCESS (0.030s)
[485.807953] Starting dynamic subtest: bcs0
[485.821391] Dynamic subtest bcs0: SUCCESS (0.031s)
[485.836732] Starting dynamic subtest: vcs0
[485.849363] Dynamic subtest vcs0: SUCCESS (0.028s)
[485.864664] Starting dynamic subtest: vcs1
[485.876640] Dynamic subtest vcs1: SUCCESS (0.026s)
[485.891118] Starting dynamic subtest: vecs0
[485.904885] Dynamic subtest vecs0: SUCCESS (0.027s)
[485.919134] Starting dynamic subtest: ccs0
[485.933914] Dynamic subtest ccs0: SUCCESS (0.028s)
[485.936050] Subtest pi-ringfull: SUCCESS (0.176s)
[486.170981] [054/155] (534s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt)
[486.265363] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt
[486.269868] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[486.385475] [055/155] (534s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[486.478510] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[486.482892] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[486.571004] [056/155] (534s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[486.619325] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[486.621558] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[486.723316] [057/155] (534s left) gem_caching (reads)
[486.781815] Subtest reads: SKIP (0.000s)
[486.854672] [058/155] (533s left) prime_vgem (basic-write)
[486.916117] Starting subtest: basic-write
[486.924701] Subtest basic-write: SKIP (0.005s)
[487.035547] [059/155] (533s left) gem_mmap_wc (read-write)
[487.085589] Subtest read-write: SKIP (0.000s)
[487.148777] [060/155] (533s left) kms_addfb_basic (master-rmfb)
[487.203939] Starting subtest: master-rmfb
[487.205786] Subtest master-rmfb: SUCCESS (0.001s)
[487.346944] [061/155] (533s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[487.433113] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[487.435008] Starting dynamic subtest: pipe-A-eDP-1
[488.181136] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[488.191610] Starting dynamic subtest: pipe-B-eDP-1
[489.975682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[489.986692] Starting dynamic subtest: pipe-C-eDP-1
[491.819413] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.842s)
[491.829429] Starting dynamic subtest: pipe-D-eDP-1
[493.639822] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.816s)
[493.641677] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.198s)
[494.781255] [062/155] (526s left) kms_lease (lessee-list)
[494.875279] Starting subtest: lessee-list
[494.877629] Starting dynamic subtest: pipe-A-eDP-1
[494.880154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[494.891353] Starting dynamic subtest: pipe-B-eDP-1
[494.893612] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[494.903657] Starting dynamic subtest: pipe-C-eDP-1
[494.905915] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[494.915662] Starting dynamic subtest: pipe-D-eDP-1
[494.917926] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[494.920142] Subtest lessee-list: SUCCESS (0.011s)
[495.002401] [063/155] (526s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[495.100699] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[495.128241] Starting dynamic subtest: pipe-A-plane-0
[495.417600] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[495.430610] Starting dynamic subtest: pipe-A-plane-3
[495.663512] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[496.780986] Starting dynamic subtest: pipe-B-plane-0
[497.070676] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[497.081273] Starting dynamic subtest: pipe-B-plane-3
[497.303581] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[497.617185] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.517s)
[498.467439] [064/155] (522s left) kms_atomic (plane-immutable-zpos)
[498.572634] Starting subtest: plane-immutable-zpos
[498.574930] Starting dynamic subtest: pipe-A-eDP-1
[499.212936] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s)
[499.215277] Subtest plane-immutable-zpos: SUCCESS (0.640s)
[500.084712] [065/155] (521s left) kms_frontbuffer_tracking (fbchdr-1p-shrfb-fliptrack-mmap-gtt)
[500.192461] Starting subtest: fbchdr-1p-shrfb-fliptrack-mmap-gtt
[500.196598] Subtest fbchdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[500.299945] [066/155] (520s left) gem_exec_reloc (basic-softpin)
[500.355428] Subtest basic-softpin: SKIP (0.000s)
[500.437817] [067/155] (520s left) gem_render_copy_redux (flink)
[500.499209] Starting subtest: flink
[501.243246] Subtest flink: SUCCESS (0.744s)
[501.388348] [068/155] (519s left) kms_psr (fbc-psr2-sprite-blt)
[501.477876] Starting subtest: fbc-psr2-sprite-blt
[501.479800] Starting dynamic subtest: eDP-1
[501.483232] Dynamic subtest eDP-1: SKIP (0.000s)
[501.486665] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[501.551545] [069/155] (519s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[501.600997] Starting subtest: y-tiled-to-vebox-yf-tiled
[501.604819] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[501.788049] [070/155] (519s left) gem_mmap_wc (write-wc-read-gtt)
[501.851784] Subtest write-wc-read-gtt: SKIP (0.000s)
[501.912736] [071/155] (519s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[502.460862] Starting subtest: syncobj-timeline-invalid-wait
[502.467368] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[503.782384] [072/155] (517s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[503.880140] Starting subtest: x-tiled-16bpp-rotate-0
[505.226719] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.347s)
[505.384781] [073/155] (516s left) gem_userptr_blits (sync-unmap-after-close)
[505.442096] Starting subtest: sync-unmap-after-close
[505.454286] Subtest sync-unmap-after-close: SUCCESS (0.013s)
[505.577651] [074/155] (515s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[505.676453] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[505.679727] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[505.764623] [075/155] (515s left) kms_prop_blob (invalid-get-prop-any)
[505.813885] Starting subtest: invalid-get-prop-any
[505.816240] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[505.904371] [076/155] (515s left) gen9_exec_parse (shadow-peek)
[505.960188] Subtest shadow-peek: SKIP (0.000s)
[506.029175] [077/155] (515s left) kms_chamelium_frames (hdmi-aspect-ratio)
[506.406495] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[507.207043] [078/155] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[507.315069] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[507.319344] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[507.414236] [079/155] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[507.511555] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[507.516093] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[507.619324] [080/155] (514s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[507.720432] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[507.724588] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[507.792605] [081/155] (514s left) gem_mmap_gtt (basic)
[507.839042] Subtest basic: SKIP (0.000s)
[507.899767] [082/155] (513s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[508.000940] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[508.004963] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[508.084627] [083/155] (513s left) kms_psr2_su (page_flip-p010)
[508.134968] Subtest page_flip-P010: SKIP (0.000s)
[508.190262] [084/155] (513s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[508.285195] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[508.288907] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[508.386287] [085/155] (513s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[508.480633] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[508.484660] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[508.592413] [086/155] (513s left) kms_big_fb (linear-16bpp-rotate-270)
[508.701828] Starting subtest: linear-16bpp-rotate-270
[508.721294] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[508.860308] [087/155] (513s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt)
[508.968136] Starting subtest: fbchdr-rgb101010-draw-blt
[508.971549] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s)
[509.066723] [088/155] (513s left) gem_exec_reloc (basic-gtt-cpu-active)
[509.124681] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[509.191234] [089/155] (512s left) dmabuf_sync_file (export-basic)
[509.235352] Starting subtest: export-basic
[509.237196] Subtest export-basic: SUCCESS (0.001s)
[509.290242] [090/155] (512s left) i915_drm_fdinfo (virtual-busy-all)
[509.328710] Starting subtest: virtual-busy-all
[509.332347] Subtest virtual-busy-all: SKIP (0.000s)
[509.389774] [091/155] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[509.490139] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[509.493671] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[509.577742] [092/155] (512s left) gem_ctx_bad_destroy (double-destroy)
[509.634543] Starting subtest: double-destroy
[509.636589] Subtest double-destroy: SUCCESS (0.000s)
[509.711088] [093/155] (512s left) kms_frontbuffer_tracking (psr-slowdraw)
[509.812135] Starting subtest: psr-slowdraw
[535.089458] Subtest psr-slowdraw: SUCCESS (25.280s)
[535.206253] [094/155] (487s left) sw_sync (alloc_merge_fence)
[535.255078] Starting subtest: alloc_merge_fence
[535.257470] Subtest alloc_merge_fence: SUCCESS (0.000s)
[535.318155] [095/155] (487s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[535.410914] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[535.413184] Starting dynamic subtest: pipe-A-eDP-1
[546.733522] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.325s)
[546.745645] Starting dynamic subtest: pipe-B-eDP-1
[558.785737] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.047s)
[558.788173] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.375s)
[559.654345] [096/155] (462s left) kms_frontbuffer_tracking (psrhdr-2p-rte)
[559.754145] Starting subtest: psrhdr-2p-rte
[559.758565] Subtest psrhdr-2p-rte: SKIP (0.000s)
[559.851453] [097/155] (462s left) kms_getfb (getfb2-accept-nv12)
[559.939199] Starting subtest: getfb2-accept-nv12
[559.941481] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[560.051927] [098/155] (462s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[560.135811] Starting subtest: crc-primary-basic-yf-tiled-ccs
[560.138109] Starting dynamic subtest: pipe-A-eDP-1
[560.160816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[560.173147] Starting dynamic subtest: pipe-B-eDP-1
[560.194923] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[560.206015] Starting dynamic subtest: pipe-C-eDP-1
[560.228303] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[560.238077] Starting dynamic subtest: pipe-D-eDP-1
[560.260154] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[560.264239] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[562.405537] [099/155] (460s left) gem_render_copy (yf-tiled)
[562.458458] Starting subtest: yf-tiled
[562.462926] Subtest yf-tiled: SKIP (0.000s)
[562.642785] [100/155] (459s left) sysfs_timeslice_duration (timeout)
[562.698585] Starting subtest: timeout
[562.700658] Starting dynamic subtest: vecs0
[572.719201] Dynamic subtest vecs0: SUCCESS (10.015s)
[572.735023] Starting dynamic subtest: ccs0
[574.034009] Dynamic subtest ccs0: SUCCESS (1.314s)
[574.044634] Starting dynamic subtest: vcs0
[583.724469] Dynamic subtest vcs0: SUCCESS (9.687s)
[583.738284] Starting dynamic subtest: bcs0
[584.343806] Dynamic subtest bcs0: SUCCESS (0.620s)
[584.356005] Starting dynamic subtest: rcs0
[585.630061] Dynamic subtest rcs0: SUCCESS (1.282s)
[585.647499] Starting dynamic subtest: vcs1
[594.728552] Dynamic subtest vcs1: SUCCESS (9.096s)
[594.731144] Subtest timeout: SUCCESS (32.026s)
[594.803275] [101/155] (427s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[594.908103] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[594.912255] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[595.011141] [102/155] (427s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[595.109884] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[595.121926] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[595.221420] [103/155] (427s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[595.362857] Starting subtest: dp-mst-lic-type-0-hdcp14
[595.367379] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[595.726331] [104/155] (427s left) kms_properties (get_properties-sanity-atomic)
[595.815573] Starting subtest: get_properties-sanity-atomic
[595.817481] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[595.891335] [105/155] (426s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[595.989298] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[595.991275] Starting dynamic subtest: pipe-A-eDP-1
[596.010057] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[596.022190] Starting dynamic subtest: pipe-B-eDP-1
[596.040209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[596.053506] Starting dynamic subtest: pipe-C-eDP-1
[596.071674] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[596.081349] Starting dynamic subtest: pipe-D-eDP-1
[596.099686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[596.103151] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[598.250308] [106/155] (424s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[598.350173] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[599.462441] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.112s)
[599.589316] [107/155] (423s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[599.698759] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[599.748989] [108/155] (423s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[599.845700] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[603.895232] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.054s)
[605.036947] [109/155] (417s left) kms_plane_lowres (tiling-y)
[605.133507] Starting subtest: tiling-y
[605.137934] Subtest tiling-y: SKIP (0.000s)
[605.208758] [110/155] (417s left) gem_lmem_swapping (verify-random-ccs)
[605.254822] Subtest verify-random-ccs: SKIP (0.000s)
[605.311553] [111/155] (417s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[605.413468] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[606.514172] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.101s)
[606.650255] [112/155] (416s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[606.774236] Starting subtest: short-flip-before-cursor-atomic-transitions
[607.739870] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.964s)
[608.557409] [113/155] (414s left) gem_ctx_persistence (processes)
[608.620684] Starting subtest: processes
[610.740289] Subtest processes: SUCCESS (2.119s)
[610.821926] [114/155] (412s left) prime_mmap_coherency (write)
[610.881538] Starting subtest: write
[616.262085] Subtest write: SUCCESS (5.376s)
[616.397872] [115/155] (406s left) gem_exec_reloc (basic-cpu-gtt)
[616.456464] Subtest basic-cpu-gtt: SKIP (0.000s)
[616.534250] [116/155] (406s left) kms_busy (extended-pageflip-hang-newfb)
[616.638909] Starting subtest: extended-pageflip-hang-newfb
[616.641130] Starting dynamic subtest: pipe-A
[642.512084] Dynamic subtest pipe-A: SUCCESS (25.871s)
[642.523603] Starting dynamic subtest: pipe-D
[657.491668] Dynamic subtest pipe-D: SUCCESS (14.978s)
[657.493838] Subtest extended-pageflip-hang-newfb: SUCCESS (40.854s)
[658.331045] [117/155] (365s left) gem_close_race (multigpu-basic-threads)
[658.395544] Starting subtest: multigpu-basic-threads
[658.399539] Subtest multigpu-basic-threads: SKIP (0.000s)
[658.630969] [118/155] (364s left) gem_userptr_blits (nohangcheck)
[658.707215] Starting subtest: nohangcheck
[658.962547] Subtest nohangcheck: SUCCESS (0.251s)
[659.069900] [119/155] (364s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[659.177185] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[663.889379] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.717s)
[664.000382] [120/155] (359s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[664.098282] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[670.855535] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.763s)
[670.984311] [121/155] (352s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[671.093687] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[671.097899] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[671.195370] [122/155] (352s left) gem_userptr_blits (stress-mm-invalidate-close)
[671.253386] Starting subtest: stress-mm-invalidate-close
[673.399883] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[673.542093] [123/155] (350s left) gem_ctx_persistence (engines-hostile)
[673.598232] Starting subtest: engines-hostile
[673.600671] Starting dynamic subtest: rcs0
[673.713577] Dynamic subtest rcs0: SUCCESS (0.114s)
[673.727357] Starting dynamic subtest: bcs0
[673.860424] Dynamic subtest bcs0: SUCCESS (0.145s)
[673.873903] Starting dynamic subtest: vcs0
[673.970348] Dynamic subtest vcs0: SUCCESS (0.108s)
[673.983304] Starting dynamic subtest: vcs1
[674.075413] Dynamic subtest vcs1: SUCCESS (0.103s)
[674.088161] Starting dynamic subtest: vecs0
[674.148355] Dynamic subtest vecs0: SUCCESS (0.071s)
[674.161221] Starting dynamic subtest: ccs0
[674.238792] Dynamic subtest ccs0: SUCCESS (0.088s)
[674.241390] Subtest engines-hostile: SUCCESS (0.641s)
[674.386667] [124/155] (349s left) gem_eio (in-flight-internal-immediate)
[674.611907] Starting subtest: in-flight-internal-immediate
[675.776988] Subtest in-flight-internal-immediate: SUCCESS (1.164s)
[675.933139] [125/155] (347s left) sw_sync (sync_merge_same)
[675.970647] Starting subtest: sync_merge_same
[675.972765] Subtest sync_merge_same: SUCCESS (0.000s)
[676.041559] [126/155] (347s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[676.144122] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[676.148105] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[676.258283] [127/155] (347s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[676.355942] Starting subtest: fbcpsrhdr-tiling-4
[676.360130] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[676.463581] [128/155] (347s left) gem_exec_whisper (basic-fds-priority-all)
[676.518204] Starting subtest: basic-fds-priority-all
[699.967869] Subtest basic-fds-priority-all: SUCCESS (23.444s)
[700.155800] [129/155] (323s left) gem_exec_balancer (parallel-balancer)
[700.425354] Starting subtest: parallel-balancer
[701.347406] Subtest parallel-balancer: SUCCESS (0.922s)
[701.464425] [130/155] (322s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[701.566570] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[701.571021] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[701.662903] [131/155] (322s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[701.750516] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[701.752763] Starting dynamic subtest: pipe-A
[701.772135] Dynamic subtest pipe-A: SKIP (0.018s)
[701.783881] Starting dynamic subtest: pipe-B
[701.803627] Dynamic subtest pipe-B: SKIP (0.031s)
[701.815007] Starting dynamic subtest: pipe-C
[701.837568] Dynamic subtest pipe-C: SKIP (0.031s)
[701.848702] Starting dynamic subtest: pipe-D
[701.866417] Dynamic subtest pipe-D: SKIP (0.030s)
[701.870125] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[701.971360] [132/155] (322s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[702.068260] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[702.072644] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[702.169350] [133/155] (321s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[702.271783] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[702.275674] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[702.391968] [134/155] (321s left) i915_pm_rc6_residency (media-rc6-accuracy)
[702.445640] Starting subtest: media-rc6-accuracy
[702.449240] Subtest media-rc6-accuracy: SKIP (0.000s)
[702.565990] [135/155] (321s left) kms_debugfs (display-on-read-all)
[702.658475] Starting subtest: display-on-read-all
[702.829076] Subtest display-on-read-all: SUCCESS (0.171s)
[702.941812] [136/155] (321s left) gem_exec_params (no-vebox)
[702.995526] Starting subtest: no-vebox
[702.999750] Subtest no-vebox: SUCCESS (0.002s)
[704.817056] [137/155] (319s left) syncobj_timeline (wait-any-complex)
[704.869005] Starting subtest: wait-any-complex
[704.930135] Subtest wait-any-complex: SUCCESS (0.062s)
[705.012632] [138/155] (319s left) kms_cursor_crc (cursor-offscreen-64x21)
[705.207227] Starting subtest: cursor-offscreen-64x21
[705.253899] Subtest cursor-offscreen-64x21: SKIP (0.046s)
[705.489931] [139/155] (318s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[705.886245] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[706.714070] [140/155] (317s left) kms_psr (fbc-psr-cursor-render)
[706.798401] Starting subtest: fbc-psr-cursor-render
[706.800583] Starting dynamic subtest: eDP-1
[706.804560] Dynamic subtest eDP-1: SKIP (0.000s)
[706.808669] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[706.874149] [141/155] (317s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[706.972684] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[706.974955] Starting dynamic subtest: pipe-A-eDP-1
[706.983972] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[706.996017] Starting dynamic subtest: pipe-B-eDP-1
[707.005140] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[707.016410] Starting dynamic subtest: pipe-C-eDP-1
[707.025209] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[707.036855] Starting dynamic subtest: pipe-D-eDP-1
[707.045594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[707.049994] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[709.292764] [142/155] (315s left) kms_plane_scaling (invalid-parameters)
[709.375494] Starting subtest: invalid-parameters
[709.377720] Starting dynamic subtest: less-than-1-height-src
[709.389424] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[709.402886] Starting dynamic subtest: less-than-1-width-src
[709.405179] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[709.407071] Subtest invalid-parameters: SUCCESS (0.027s)
[709.513484] [143/155] (315s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[709.619798] Starting subtest: hdr-rgb565-draw-blt
[709.624142] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[709.738567] [144/155] (314s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[709.852725] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[711.263630] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.411s)
[712.076231] [145/155] (312s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[712.179243] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[712.183303] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[712.290972] [146/155] (312s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[712.385303] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[712.389531] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[712.481031] [147/155] (312s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[712.574571] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[712.579024] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[712.665264] [148/155] (312s left) gem_exec_parallel (fds)
[712.723558] Starting subtest: fds
[712.725855] Starting dynamic subtest: rcs0
[716.043612] Dynamic subtest rcs0: SUCCESS (3.318s)
[716.055938] Starting dynamic subtest: bcs0
[720.164450] Dynamic subtest bcs0: SUCCESS (4.120s)
[720.186448] Starting dynamic subtest: vcs0
[724.004205] Dynamic subtest vcs0: SUCCESS (3.836s)
[724.016898] Starting dynamic subtest: vcs1
[728.043639] Dynamic subtest vcs1: SUCCESS (4.038s)
[728.056567] Starting dynamic subtest: vecs0
[732.017414] Dynamic subtest vecs0: SUCCESS (3.970s)
[732.029305] Starting dynamic subtest: ccs0
[736.359035] Dynamic subtest ccs0: SUCCESS (4.339s)
[736.361489] Subtest fds: SUCCESS (23.633s)
[736.568164] [149/155] (288s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[736.675528] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[740.415894] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.745s)
[741.613269] [150/155] (283s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[741.723345] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[741.727379] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[741.825501] [151/155] (283s left) gem_exec_params (larger-than-life-batch)
[741.880806] Starting subtest: larger-than-life-batch
[744.215684] Subtest larger-than-life-batch: SUCCESS (2.336s)
[744.747279] [152/155] (280s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[744.853331] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[744.855923] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[744.976994] [153/155] (280s left) kms_plane_alpha_blend (constant-alpha-max)
[745.091631] Starting subtest: constant-alpha-max
[745.385499] Starting dynamic subtest: pipe-A-eDP-1
[746.440018] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.052s)
[746.451454] Starting dynamic subtest: pipe-D-eDP-1
[748.135933] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.693s)
[748.138267] Subtest constant-alpha-max: SUCCESS (3.044s)
[748.950031] [154/155] (276s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[749.054664] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[749.057001] Starting dynamic subtest: pipe-A-eDP-1
[749.114894] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[749.127370] Starting dynamic subtest: pipe-B-eDP-1
[749.185730] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[749.198732] Starting dynamic subtest: pipe-C-eDP-1
[749.255805] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[749.268023] Starting dynamic subtest: pipe-D-eDP-1
[749.328749] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[749.334045] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[751.326726] [155/155] (273s left) gem_mmap_gtt (basic-small-bo-tiledy)
[751.383410] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[751.445075] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_joiner
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_busy
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: api_intel_allocator
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: i915_pm_freq_api
results: parsing output: 14/ for test: kms_draw_crc
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gem_mmap_offset
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_addfb_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_await
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: i915_selftest
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gem_sync
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: core_getclient
results: parsing output: 45/ for test: kms_color_pipeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: prime_vgem
results: parsing output: 49/ for test: kms_rotation_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_basic
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_caching
results: parsing output: 57/ for test: prime_vgem
results: parsing output: 58/ for test: gem_mmap_wc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_lease
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_render_copy_redux
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_mmap_wc
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_prop_blob
results: parsing output: 75/ for test: gen9_exec_parse
results: parsing output: 76/ for test: kms_chamelium_frames
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_su
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_reloc
results: parsing output: 88/ for test: dmabuf_sync_file
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_ctx_bad_destroy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: sysfs_timeslice_duration
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_properties
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_tiled_display
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane_lowres
results: parsing output: 109/ for test: gem_lmem_swapping
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: prime_mmap_coherency
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_busy
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: i915_pm_rc6_residency
results: parsing output: 134/ for test: kms_debugfs
results: parsing output: 135/ for test: gem_exec_params
results: parsing output: 136/ for test: syncobj_timeline
results: parsing output: 137/ for test: kms_cursor_crc
results: parsing output: 138/ for test: kms_chamelium_hpd
results: parsing output: 139/ for test: kms_psr
results: parsing output: 140/ for test: kms_ccs
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_cursor_legacy
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_parallel
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_params
results: parsing output: 151/ for test: syncobj_timeline
results: parsing output: 152/ for test: kms_plane_alpha_blend
results: parsing output: 153/ for test: kms_ccs
results: parsing output: 154/ for test: gem_mmap_gtt
Done.