[59.851767] Initializing watchdogs
[59.851821]   /dev/watchdog0
[59.867577] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.872407] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.874802] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.878459] [001/155] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[59.997595] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[60.001989] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[60.086259] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[60.193164] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[60.197288] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.289623] [003/155] (960s left) kms_dsc (dsc-with-formats)
[60.384959] Starting subtest: dsc-with-formats
[60.424779] Subtest dsc-with-formats: SKIP (0.001s)
[60.460798] [004/155] (960s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[60.555599] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[60.559973] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[60.644039] [005/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[60.735449] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[60.739216] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[60.826788] [006/155] (959s left) kms_addfb_basic (basic-x-tiled-legacy)
[60.880182] Starting subtest: basic-x-tiled-legacy
[60.883617] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[61.014455] [007/155] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[61.126078] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[61.129882] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[61.215368] [008/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc)
[61.315057] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc
[61.318483] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[61.439869] [009/155] (959s left) kms_flip (2x-absolute-wf_vblank)
[61.526824] Starting subtest: 2x-absolute-wf_vblank
[61.537720] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[61.626671] [010/155] (959s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[61.720128] Starting subtest: primary-yf-tiled-reflect-x-180
[61.803460] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.082s)
[61.902357] [011/155] (958s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[62.010111] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[62.013768] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[62.088534] [012/155] (958s left) gem_exec_balancer (semaphore)
[62.146919] Starting subtest: semaphore
[63.290696] Subtest semaphore: SUCCESS (1.139s)
[63.631190] [013/155] (957s left) gem_vm_create (create-ext)
[63.690765] Starting subtest: create-ext
[63.695438] Subtest create-ext: SUCCESS (0.007s)
[63.808168] [014/155] (957s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[63.859050] Starting subtest: invalid-signal-one-illegal-handle
[63.861055] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[63.950576] [015/155] (956s left) perf (oa-exponents)
[64.074164] Starting subtest: oa-exponents
[64.076338] Starting dynamic subtest: 0-rcs0
[65.852528] Dynamic subtest 0-rcs0: SUCCESS (1.774s)
[65.862167] Starting dynamic subtest: 1-vcs1
[67.682432] Dynamic subtest 1-vcs1: SUCCESS (1.828s)
[67.684900] Subtest oa-exponents: SUCCESS (3.603s)
[67.727851] [016/155] (953s left) perf_pmu (event-wait)
[67.767812] Starting subtest: event-wait
[67.770323] Starting dynamic subtest: rcs0
[67.774531] Dynamic subtest rcs0: SKIP (0.000s)
[67.778704] Subtest event-wait: SKIP (0.000s)
[67.867826] [017/155] (953s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[67.967930] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[67.972530] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[68.037240] [018/155] (953s left) syncobj_timeline (signal)
[68.099751] Starting subtest: signal
[68.101654] Subtest signal: SUCCESS (0.000s)
[68.220492] [019/155] (952s left) gem_userptr_blits (readonly-pwrite-unsync)
[68.298166] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[68.426214] [020/155] (952s left) gem_exec_reloc (basic-gtt-active)
[68.476656] Subtest basic-gtt-active: SKIP (0.000s)
[68.540635] [021/155] (952s left) gem_partial_pwrite_pread (writes-after-reads-display)
[68.601242] Subtest writes-after-reads-display: SKIP (0.000s)
[68.670953] [022/155] (952s left) gem_mmap_wc (read-write)
[68.726403] Subtest read-write: SKIP (0.000s)
[68.783502] [023/155] (952s left) prime_mmap (test_forked_cpu_write)
[68.836123] Starting subtest: test_forked_cpu_write
[68.837901] Starting dynamic subtest: test_forked_cpu_write-smem
[68.841937] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[68.843568] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[68.949765] [024/155] (952s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[69.050063] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[69.052096] Starting dynamic subtest: pipe-A-eDP-1
[69.149532] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[69.159870] Starting dynamic subtest: pipe-B-eDP-1
[70.269161] Dynamic subtest pipe-B-eDP-1: SKIP (1.116s)
[70.273675] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.221s)
[71.456340] [025/155] (949s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[71.563263] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[71.568101] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[71.667593] [026/155] (949s left) api_intel_allocator (reopen)
[71.725083] Starting subtest: reopen
[71.731069] Subtest reopen: SUCCESS (0.007s)
[71.825716] [027/155] (949s left) kms_lease (setcrtc-implicit-plane)
[71.917797] Starting subtest: setcrtc-implicit-plane
[71.920250] Starting dynamic subtest: pipe-A-eDP-1
[72.389976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s)
[72.401768] Starting dynamic subtest: pipe-B-eDP-1
[73.499410] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.109s)
[73.509902] Starting dynamic subtest: pipe-C-eDP-1
[74.619794] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[74.631690] Starting dynamic subtest: pipe-D-eDP-1
[75.752627] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[75.754928] Subtest setcrtc-implicit-plane: SUCCESS (3.835s)
[76.599114] [028/155] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[76.705133] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[76.709142] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[76.800127] [029/155] (944s left) vgem_basic (second-client)
[76.876072] Starting subtest: second-client
[76.898529] Subtest second-client: SUCCESS (0.022s)
[76.953761] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[76.957021] [030/155] (944s left) gem_busy (semaphore)
[77.140857] Subtest semaphore: SKIP (0.000s)
[77.360797] [031/155] (944s left) kms_chamelium_hpd (vga-hpd)
[77.732954] Subtest vga-hpd: SKIP (0.000s)
[78.513367] [032/155] (943s left) gem_exec_params (rel-constants-invalid-ring)
[78.571072] Starting subtest: rel-constants-invalid-ring
[78.573383] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[78.689206] [033/155] (942s left) kms_psr (pr-cursor-blt)
[78.779981] Starting subtest: pr-cursor-blt
[78.784434] Subtest pr-cursor-blt: SKIP (0.000s)
[78.863469] [034/155] (942s left) kms_cursor_edge_walk (256x256-right-edge)
[78.950669] Starting subtest: 256x256-right-edge
[78.953029] Starting dynamic subtest: pipe-A-eDP-1
[82.405986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[82.418042] Starting dynamic subtest: pipe-D-eDP-1
[85.532374] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[85.534746] Subtest 256x256-right-edge: SUCCESS (6.580s)
[86.346429] [035/155] (935s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[86.450329] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[86.455129] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.547533] [036/155] (935s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.664629] Starting subtest: basic-flip-after-cursor-atomic
[87.582527] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[88.393750] [037/155] (933s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[88.500060] Starting subtest: x-tiled-64bpp-rotate-270
[88.520079] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[88.627089] [038/155] (933s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[88.722269] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[89.535217] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[89.730834] [039/155] (932s left) gem_eio (wait-wedge-1us)
[89.959967] Starting subtest: wait-wedge-1us
[91.394393] Subtest wait-wedge-1us: SUCCESS (1.434s)
[91.527998] [040/155] (930s left) gem_sync (basic-store-each)
[91.606610] Starting subtest: basic-store-each
[93.992202] Subtest basic-store-each: SUCCESS (2.396s)
[94.198177] [041/155] (927s left) kms_vblank (wait-forked-hang)
[94.294036] Starting subtest: wait-forked-hang
[94.295964] Starting dynamic subtest: pipe-A-eDP-1
[121.039149] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.743s)
[121.052965] Starting dynamic subtest: pipe-D-eDP-1
[145.011501] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.969s)
[145.014103] Subtest wait-forked-hang: SUCCESS (50.717s)
[145.873569] [042/155] (876s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[145.969225] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[145.973485] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[146.068162] [043/155] (876s left) kms_cursor_crc (cursor-offscreen-256x256)
[146.324644] Starting subtest: cursor-offscreen-256x256
[146.326967] Starting dynamic subtest: pipe-A-eDP-1
[148.285830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[148.315255] Starting dynamic subtest: pipe-D-eDP-1
[150.897487] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.587s)
[150.899533] Subtest cursor-offscreen-256x256: SUCCESS (4.570s)
[151.751032] [044/155] (870s left) prime_self_import (export-vs-gem_close-race)
[151.786682] Starting subtest: export-vs-gem_close-race
[156.881140] Subtest export-vs-gem_close-race: SUCCESS (5.091s)
[156.959780] [045/155] (865s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[157.018138] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[157.118700] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[157.199751] [046/155] (864s left) kms_chamelium_frames (hdmi-crc-fast)
[157.580742] Subtest hdmi-crc-fast: SKIP (0.000s)
[158.447934] [047/155] (863s left) gem_eio (in-flight-immediate)
[158.674374] Starting subtest: in-flight-immediate
[167.200064] Subtest in-flight-immediate: SUCCESS (8.524s)
[167.316138] [048/155] (854s left) gem_ctx_isolation (nonpriv)
[167.378928] Starting subtest: nonpriv
[167.381068] Starting dynamic subtest: rcs0
[167.625838] Dynamic subtest rcs0: SUCCESS (0.246s)
[167.637110] Starting dynamic subtest: bcs0
[167.885195] Dynamic subtest bcs0: SUCCESS (0.259s)
[167.895207] Starting dynamic subtest: vcs0
[168.137642] Dynamic subtest vcs0: SUCCESS (0.252s)
[168.148672] Starting dynamic subtest: vcs1
[169.483673] Dynamic subtest vcs1: SUCCESS (1.345s)
[169.493566] Starting dynamic subtest: vecs0
[171.500180] Dynamic subtest vecs0: SUCCESS (2.016s)
[171.511811] Starting dynamic subtest: ccs0
[173.583502] Dynamic subtest ccs0: SUCCESS (2.083s)
[173.585936] Subtest nonpriv: SUCCESS (6.204s)
[173.817354] [049/155] (848s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-msflip-blt)
[173.917843] Starting subtest: hdr-1p-primscrn-indfb-msflip-blt
[173.922475] Subtest hdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[174.018407] [050/155] (848s left) kms_frontbuffer_tracking (fbc-1p-rte)
[174.115602] Starting subtest: fbc-1p-rte
[179.584219] Subtest fbc-1p-rte: SUCCESS (5.475s)
[180.810204] [051/155] (841s left) gem_render_copy_redux (interruptible)
[180.867301] Starting subtest: interruptible
[181.172825] Subtest interruptible: SUCCESS (0.306s)
[181.315369] [052/155] (841s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[181.422255] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[185.975375] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.559s)
[187.119297] [053/155] (835s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt)
[187.223135] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt
[187.227765] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[187.321777] [054/155] (835s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[187.421052] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[187.425313] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[187.513598] [055/155] (835s left) gem_softpin (noreloc)
[187.567818] Starting subtest: noreloc
[193.040915] Subtest noreloc: SUCCESS (5.418s)
[193.106245] [056/155] (829s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[193.194266] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[193.196309] Starting dynamic subtest: pipe-A-eDP-1
[193.941037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[193.952340] Starting dynamic subtest: pipe-B-eDP-1
[195.736069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.793s)
[195.747227] Starting dynamic subtest: pipe-C-eDP-1
[197.572835] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.836s)
[197.581896] Starting dynamic subtest: pipe-D-eDP-1
[199.403384] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.830s)
[199.405343] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.203s)
[200.537820] [057/155] (822s left) gem_spin_batch (legacy-resubmit-new)
[200.591967] Starting subtest: legacy-resubmit-new
[200.594386] Starting dynamic subtest: default
[200.600978] Dynamic subtest default: SUCCESS (0.008s)
[200.613327] Starting dynamic subtest: render
[200.615716] Dynamic subtest render: SUCCESS (0.004s)
[200.625291] Starting dynamic subtest: bsd
[200.627675] Dynamic subtest bsd: SUCCESS (0.004s)
[200.636548] Starting dynamic subtest: bsd1
[200.638453] Dynamic subtest bsd1: SUCCESS (0.004s)
[200.646924] Starting dynamic subtest: bsd2
[200.648934] Dynamic subtest bsd2: SUCCESS (0.004s)
[200.657320] Starting dynamic subtest: blt
[200.659251] Dynamic subtest blt: SUCCESS (0.006s)
[200.667504] Starting dynamic subtest: vebox
[200.669513] Dynamic subtest vebox: SUCCESS (0.004s)
[200.671513] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[202.338087] [058/155] (820s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[204.481268] Starting subtest: dpms-mode-unset-lpsp
[208.548625] Subtest dpms-mode-unset-lpsp: SUCCESS (4.070s)
[208.941702] [059/155] (813s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[209.041859] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[209.046067] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[209.119519] [060/155] (813s left) gem_exec_schedule (preempt-other)
[209.188086] Starting subtest: preempt-other
[209.190121] Starting dynamic subtest: rcs0
[209.258734] Dynamic subtest rcs0: SUCCESS (0.075s)
[209.274990] Starting dynamic subtest: bcs0
[209.330401] Dynamic subtest bcs0: SUCCESS (0.071s)
[209.340675] Starting dynamic subtest: vcs0
[209.405563] Dynamic subtest vcs0: SUCCESS (0.075s)
[209.417200] Starting dynamic subtest: vcs1
[209.478260] Dynamic subtest vcs1: SUCCESS (0.072s)
[209.491755] Starting dynamic subtest: vecs0
[209.550091] Dynamic subtest vecs0: SUCCESS (0.072s)
[209.562225] Starting dynamic subtest: ccs0
[209.618624] Dynamic subtest ccs0: SUCCESS (0.066s)
[209.621516] Subtest preempt-other: SUCCESS (0.435s)
[210.393442] [061/155] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[210.485789] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[210.490147] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[210.580263] [062/155] (812s left) gem_exec_balancer (parallel)
[210.834327] Starting subtest: parallel
[211.800548] Subtest parallel: SUCCESS (0.966s)
[212.319916] [063/155] (810s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[212.420674] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[212.423322] Starting dynamic subtest: pipe-A-eDP-1
[212.740604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[212.752099] Starting dynamic subtest: pipe-B-eDP-1
[214.053759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.317s)
[214.063473] Starting dynamic subtest: pipe-C-eDP-1
[215.332533] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[215.344466] Starting dynamic subtest: pipe-D-eDP-1
[216.541647] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[216.543639] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.096s)
[217.754242] [064/155] (805s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[217.849081] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[217.853281] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[217.921984] [065/155] (805s left) gem_lmem_swapping (heavy-multi)
[217.966530] Subtest heavy-multi: SKIP (0.000s)
[218.007913] [066/155] (805s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[218.100961] Starting subtest: primary-4-tiled-reflect-x-0
[225.085214] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.986s)
[226.319112] [067/155] (796s left) perf (whitelisted-registers-userspace-config)
[226.417716] Starting subtest: whitelisted-registers-userspace-config
[226.420285] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[226.460393] [068/155] (796s left) kms_color (ctm-signed)
[226.548309] Starting subtest: ctm-signed
[226.550197] Starting dynamic subtest: pipe-A-eDP-1
[228.701516] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.152s)
[228.711772] Starting dynamic subtest: pipe-B-eDP-1
[231.563799] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.862s)
[231.573331] Starting dynamic subtest: pipe-C-eDP-1
[234.296385] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.730s)
[234.306601] Starting dynamic subtest: pipe-D-eDP-1
[236.973928] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[236.976224] Subtest ctm-signed: SUCCESS (10.425s)
[237.799815] [069/155] (785s left) api_intel_bb (object-reloc-purge-cache)
[237.857102] Starting subtest: object-reloc-purge-cache
[237.861899] Subtest object-reloc-purge-cache: SKIP (0.002s)
[237.982084] [070/155] (785s left) gem_exec_store (pages)
[238.044613] Starting subtest: pages
[238.046728] Starting dynamic subtest: rcs0
[238.145943] Dynamic subtest rcs0: SUCCESS (0.103s)
[238.157361] Starting dynamic subtest: bcs0
[238.218749] Dynamic subtest bcs0: SUCCESS (0.072s)
[238.230626] Starting dynamic subtest: vcs0
[238.288668] Dynamic subtest vcs0: SUCCESS (0.068s)
[238.298079] Starting dynamic subtest: vcs1
[238.356375] Dynamic subtest vcs1: SUCCESS (0.067s)
[238.367780] Starting dynamic subtest: vecs0
[238.419685] Dynamic subtest vecs0: SUCCESS (0.062s)
[238.428643] Starting dynamic subtest: ccs0
[238.492121] Dynamic subtest ccs0: SUCCESS (0.072s)
[238.494510] Subtest pages: SUCCESS (0.450s)
[238.679548] [071/155] (784s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[238.780884] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[238.785125] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[238.917817] [072/155] (784s left) gem_mmap_gtt (big-copy)
[238.971779] Subtest big-copy: SKIP (0.000s)
[239.026243] [073/155] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[239.124497] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[239.128568] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.218796] [074/155] (784s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[239.317281] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[239.321272] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.415838] [075/155] (783s left) drm_buddy (drm_buddy)
[239.450048] Starting subtest: drm_buddy
[239.454845] Subtest drm_buddy: SKIP (0.001s)
[239.501334] [076/155] (783s left) i915_selftest (live)
[241.255074] Starting subtest: live
[241.257320] Starting dynamic subtest: sanitycheck
[245.621846] Dynamic subtest sanitycheck: SUCCESS (4.366s)
[245.630843] Starting dynamic subtest: uncore
[250.062769] Dynamic subtest uncore: SUCCESS (4.439s)
[250.071410] Starting dynamic subtest: workarounds
[268.507151] Dynamic subtest workarounds: FAIL (18.130s)
[268.516319] Starting dynamic subtest: gt_engines
[271.350084] Dynamic subtest gt_engines: SUCCESS (3.152s)
[271.358563] Starting dynamic subtest: gt_timelines
[289.500024] Dynamic subtest gt_timelines: SUCCESS (18.145s)
[289.509274] Starting dynamic subtest: gt_contexts
[293.893327] Dynamic subtest gt_contexts: SUCCESS (4.392s)
[293.903896] Starting dynamic subtest: gt_lrc
[298.248406] Dynamic subtest gt_lrc: SUCCESS (4.352s)
[298.257908] Starting dynamic subtest: gt_mocs
[301.312561] Dynamic subtest gt_mocs: SUCCESS (3.062s)
[301.322344] Starting dynamic subtest: gt_pm
[308.095707] Dynamic subtest gt_pm: SUCCESS (6.779s)
[308.105611] Starting dynamic subtest: gt_heartbeat
[312.488151] Dynamic subtest gt_heartbeat: SUCCESS (4.391s)
[312.496322] Starting dynamic subtest: gt_tlb
[321.843748] Dynamic subtest gt_tlb: SUCCESS (9.352s)
[321.860485] Starting dynamic subtest: requests
[335.573799] Dynamic subtest requests: SUCCESS (13.728s)
[335.583105] Starting dynamic subtest: migrate
[343.486333] Dynamic subtest migrate: SUCCESS (7.911s)
[343.495631] Starting dynamic subtest: active
[347.882542] Dynamic subtest active: SUCCESS (4.394s)
[347.891837] Starting dynamic subtest: objects
[352.647811] Dynamic subtest objects: SUCCESS (4.763s)
[352.657602] Starting dynamic subtest: mman
[357.475509] Dynamic subtest mman: SUCCESS (4.827s)
[357.485431] Starting dynamic subtest: dmabuf
[361.896054] Dynamic subtest dmabuf: SUCCESS (4.419s)
[361.905550] Starting dynamic subtest: vma
[366.292986] Dynamic subtest vma: SUCCESS (4.395s)
[366.302317] Starting dynamic subtest: coherency
[371.368378] Dynamic subtest coherency: SUCCESS (5.073s)
[371.378376] Starting dynamic subtest: gtt
[381.288341] Dynamic subtest gtt: SUCCESS (9.918s)
[381.298117] Starting dynamic subtest: gem
[389.022047] Dynamic subtest gem: SUCCESS (7.732s)
[389.031941] Starting dynamic subtest: evict
[394.510898] Dynamic subtest evict: SUCCESS (5.486s)
[394.520912] Starting dynamic subtest: hugepages
[403.420244] Dynamic subtest hugepages: SUCCESS (8.908s)
[403.429766] Starting dynamic subtest: gem_contexts
[432.157056] Dynamic subtest gem_contexts: SUCCESS (28.733s)
[432.165742] Starting dynamic subtest: client
[436.603360] Dynamic subtest client: SUCCESS (4.445s)
[436.612962] Starting dynamic subtest: gem_migrate
[439.355532] Dynamic subtest gem_migrate: SUCCESS (2.750s)
[439.367449] Starting dynamic subtest: reset
[442.186673] Dynamic subtest reset: SUCCESS (2.829s)
[442.196402] Starting dynamic subtest: memory_region
[446.580561] Dynamic subtest memory_region: SUCCESS (4.393s)
[446.591071] Starting dynamic subtest: hangcheck
[459.698021] Dynamic subtest hangcheck: SUCCESS (13.104s)
[459.710794] Starting dynamic subtest: execlists
[464.066261] Dynamic subtest execlists: SUCCESS (4.376s)
[464.075949] Starting dynamic subtest: ring_submission
[466.845462] Dynamic subtest ring_submission: SUCCESS (2.778s)
[466.854500] Starting dynamic subtest: perf
[471.247098] Dynamic subtest perf: SUCCESS (4.400s)
[471.256518] Starting dynamic subtest: slpc
[485.426376] Dynamic subtest slpc: SUCCESS (14.178s)
[485.436225] Starting dynamic subtest: guc
[489.406273] Dynamic subtest guc: SUCCESS (3.977s)
[489.414375] Starting dynamic subtest: guc_multi_lrc
[493.757423] Dynamic subtest guc_multi_lrc: SUCCESS (4.348s)
[493.771759] Starting dynamic subtest: guc_hang
[498.720533] Dynamic subtest guc_hang: SUCCESS (4.960s)
[498.729263] Starting dynamic subtest: late_gt_pm
[503.090330] Dynamic subtest late_gt_pm: SUCCESS (4.368s)
[503.093109] Subtest live: FAIL (261.822s)
[503.120942] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[503.121778] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[503.124975] [077/155] (520s left) kms_addfb_basic (unused-pitches)
[504.699818] Starting subtest: unused-pitches
[504.702314] Subtest unused-pitches: SUCCESS (0.000s)
[504.831693] [FACT kms_addfb_basic (unused-pitches)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[504.832978] [FACT kms_addfb_basic (unused-pitches)] new: kernel.kmod_is_loaded.i915: true
[504.837303] [078/155] (518s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[504.934434] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[504.936750] Starting dynamic subtest: pipe-A
[504.956856] Dynamic subtest pipe-A: SKIP (0.020s)
[504.965214] Starting dynamic subtest: pipe-B
[504.997924] Dynamic subtest pipe-B: SKIP (0.038s)
[505.006773] Starting dynamic subtest: pipe-C
[505.034285] Dynamic subtest pipe-C: SKIP (0.038s)
[505.042304] Starting dynamic subtest: pipe-D
[505.072842] Dynamic subtest pipe-D: SKIP (0.038s)
[505.077195] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.137s)
[505.169040] [079/155] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[505.272726] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[505.276780] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[505.364325] [080/155] (518s left) gem_fence_thrash (bo-copy)
[505.401400] Starting subtest: bo-copy
[505.425361] Subtest bo-copy: SKIP (0.020s)
[505.506291] [081/155] (518s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[505.589458] Starting subtest: pixel-format-y-tiled-ccs-modifier
[505.592891] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[505.667237] [082/155] (518s left) kms_debugfs (display-on-read-all)
[505.752781] Starting subtest: display-on-read-all
[505.925347] Subtest display-on-read-all: SUCCESS (0.174s)
[506.082079] [083/155] (517s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[506.179860] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[506.181788] Starting dynamic subtest: pipe-A-eDP-1
[522.102953] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.578s)
[522.112439] Starting dynamic subtest: pipe-B-eDP-1
[539.055804] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.434s)
[539.066956] Starting dynamic subtest: pipe-C-eDP-1
[556.018802] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.385s)
[556.028627] Starting dynamic subtest: pipe-D-eDP-1
[573.001869] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.372s)
[573.004663] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.776s)
[574.269156] [084/155] (449s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[574.398789] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[574.402982] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[574.492679] [085/155] (449s left) gem_render_copy_redux (normal)
[574.559403] Starting subtest: normal
[574.831947] Subtest normal: SUCCESS (0.270s)
[574.967509] [086/155] (448s left) i915_drm_fdinfo (isolation)
[575.008507] Starting subtest: isolation
[575.010810] Starting dynamic subtest: rcs0
[575.034098] Dynamic subtest rcs0: SKIP (0.022s)
[575.044808] Starting dynamic subtest: bcs0
[575.049258] Dynamic subtest bcs0: SKIP (0.000s)
[575.058583] Starting dynamic subtest: vcs0
[575.062713] Dynamic subtest vcs0: SKIP (0.000s)
[575.072182] Starting dynamic subtest: vcs1
[575.076591] Dynamic subtest vcs1: SKIP (0.000s)
[575.086122] Starting dynamic subtest: vecs0
[575.090360] Dynamic subtest vecs0: SKIP (0.000s)
[575.099719] Starting dynamic subtest: ccs0
[575.104126] Dynamic subtest ccs0: SKIP (0.000s)
[575.108487] Subtest isolation: SKIP (0.029s)
[575.147800] [087/155] (448s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[575.235460] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[575.237440] Starting dynamic subtest: pipe-A
[575.259342] Dynamic subtest pipe-A: SKIP (0.019s)
[575.269463] Starting dynamic subtest: pipe-B
[575.292312] Dynamic subtest pipe-B: SKIP (0.034s)
[575.302226] Starting dynamic subtest: pipe-C
[575.328975] Dynamic subtest pipe-C: SKIP (0.034s)
[575.339925] Starting dynamic subtest: pipe-D
[575.361577] Dynamic subtest pipe-D: SKIP (0.034s)
[575.364674] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.123s)
[575.472326] [088/155] (448s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[575.679468] Starting subtest: cursor-rapid-movement-64x21
[575.731698] Subtest cursor-rapid-movement-64x21: SKIP (0.047s)
[575.967697] [089/155] (448s left) gem_mmap_offset (partial-unmap)
[576.024837] Starting subtest: partial-unmap
[576.026632] Starting dynamic subtest: smem0
[576.537856] Dynamic subtest smem0: SUCCESS (0.508s)
[576.540730] Subtest partial-unmap: SUCCESS (0.509s)
[576.648786] [090/155] (447s left) gem_exec_fence (syncobj-channel)
[577.085393] Starting subtest: syncobj-channel
[578.103334] Subtest syncobj-channel: SUCCESS (1.010s)
[578.399127] [091/155] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[578.519877] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[585.969656] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.422s)
[586.096892] [092/155] (438s left) gen3_render_tiledx_blits
[586.217248] [093/155] (437s left) kms_psr (psr2-sprite-render)
[586.322384] Starting subtest: psr2-sprite-render
[586.324704] Starting dynamic subtest: eDP-1
[588.067602] Dynamic subtest eDP-1: SUCCESS (1.741s)
[588.069923] Subtest psr2-sprite-render: SUCCESS (1.742s)
[588.938202] [094/155] (435s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[589.037130] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[589.039316] Starting dynamic subtest: pipe-A-eDP-1
[589.134379] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[589.145366] Starting dynamic subtest: pipe-B-eDP-1
[590.315730] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[590.320474] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.279s)
[591.508299] [095/155] (432s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[591.569981] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[591.572215] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[591.675760] [096/155] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[591.770848] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[598.936095] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.163s)
[599.040103] [097/155] (425s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[599.154687] Starting subtest: cursorB-vs-flipA-atomic
[599.159218] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[599.302510] [098/155] (425s left) gem_media_vme
[599.428941] [099/155] (425s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[599.530412] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[599.534922] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[599.630421] [100/155] (424s left) gem_exec_schedule (submit-late-slice)
[599.704721] Starting subtest: submit-late-slice
[599.706912] Starting dynamic subtest: rcs0
[599.735601] Dynamic subtest rcs0: SUCCESS (0.038s)
[599.748974] Starting dynamic subtest: bcs0
[599.768630] Dynamic subtest bcs0: SUCCESS (0.031s)
[599.778843] Starting dynamic subtest: vcs0
[599.803767] Dynamic subtest vcs0: SUCCESS (0.034s)
[599.814065] Starting dynamic subtest: vcs1
[599.830218] Dynamic subtest vcs1: SUCCESS (0.025s)
[599.840488] Starting dynamic subtest: vecs0
[599.859135] Dynamic subtest vecs0: SUCCESS (0.028s)
[599.871153] Starting dynamic subtest: ccs0
[599.896744] Dynamic subtest ccs0: SUCCESS (0.037s)
[599.898755] Subtest submit-late-slice: SUCCESS (0.200s)
[601.339611] [101/155] (423s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[601.435572] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[601.439762] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[601.526760] [102/155] (423s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[601.622244] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[601.626262] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[601.734343] [103/155] (422s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[601.829116] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[601.833422] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[601.941505] [104/155] (422s left) kms_psr (fbc-pr-dpms)
[602.029219] Starting subtest: fbc-pr-dpms
[602.033612] Subtest fbc-pr-dpms: SKIP (0.000s)
[602.102491] [105/155] (422s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[602.194014] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[602.196326] Starting dynamic subtest: pipe-A-eDP-1
[602.219474] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[602.232519] Starting dynamic subtest: pipe-B-eDP-1
[602.255488] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[602.266087] Starting dynamic subtest: pipe-C-eDP-1
[602.288400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[602.300638] Starting dynamic subtest: pipe-D-eDP-1
[602.319920] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[602.323710] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[604.495896] [106/155] (420s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[604.604965] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[604.609232] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[604.727629] [107/155] (420s left) prime_vgem (shrink)
[604.806756] Starting subtest: shrink
[604.823150] Subtest shrink: SUCCESS (0.014s)
[604.941003] [108/155] (419s left) kms_hdr (invalid-metadata-sizes)
[605.044752] Starting subtest: invalid-metadata-sizes
[605.047277] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[605.051675] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[605.062262] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[605.066547] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[605.070966] Subtest invalid-metadata-sizes: SKIP (0.003s)
[605.129059] [109/155] (419s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[605.223065] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[605.227267] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[605.326594] [110/155] (419s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[605.427791] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[605.431155] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[605.531871] [111/155] (419s left) prime_self_import (basic-llseek-bad)
[605.568241] Starting subtest: basic-llseek-bad
[605.583140] Subtest basic-llseek-bad: SUCCESS (0.015s)
[605.695711] [112/155] (419s left) gem_ctx_sseu (mmap-args)
[605.750169] Subtest mmap-args: SKIP (0.000s)
[605.818672] [113/155] (419s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[605.915256] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[605.918865] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[606.011660] [114/155] (419s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[606.116745] Starting subtest: yf-tiled-addfb-size-overflow
[606.120490] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[606.220088] [115/155] (418s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[606.312786] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[606.316762] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[606.422902] [116/155] (418s left) syncobj_timeline (wait-for-submit-complex)
[606.470083] Starting subtest: wait-for-submit-complex
[606.533399] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[606.611848] [117/155] (418s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[606.717813] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[607.830902] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.112s)
[607.948901] [118/155] (417s left) kms_psr (pr-sprite-plane-onoff)
[608.051985] Starting subtest: pr-sprite-plane-onoff
[608.055736] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[608.127155] [119/155] (417s left) gem_pxp (create-regular-context-2)
[608.241088] Starting subtest: create-regular-context-2
[608.243053] Subtest create-regular-context-2: SUCCESS (0.002s)
[608.352612] [120/155] (416s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[608.449608] Starting subtest: 4-tiled-64bpp-rotate-90
[608.469126] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[608.611856] [121/155] (416s left) gem_linear_blits (interruptible)
[609.099951] Starting subtest: interruptible
[613.213154] Subtest interruptible: SUCCESS (4.060s)
[613.295865] [122/155] (412s left) kms_rotation_crc (exhaust-fences)
[613.450997] Starting subtest: exhaust-fences
[613.454977] Subtest exhaust-fences: SKIP (0.000s)
[613.525148] [123/155] (411s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[613.645752] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[613.650294] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[613.730353] [124/155] (411s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[613.821836] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[613.826260] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[613.912472] [125/155] (411s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[614.029447] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[615.035392] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.008s)
[615.936600] [126/155] (409s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[615.996609] Starting subtest: y-tiled-ccs-to-yf-tiled
[616.000944] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[616.195364] [127/155] (409s left) kms_flip (plain-flip-ts-check)
[616.294255] Starting subtest: plain-flip-ts-check
[616.296522] Starting dynamic subtest: A-eDP1
[625.247432] Dynamic subtest A-eDP1: SUCCESS (8.924s)
[625.260517] Starting dynamic subtest: B-eDP1
[634.056375] Dynamic subtest B-eDP1: SUCCESS (8.836s)
[634.069218] Starting dynamic subtest: C-eDP1
[642.929777] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[642.941394] Starting dynamic subtest: D-eDP1
[651.758820] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[651.760869] Subtest plain-flip-ts-check: SUCCESS (35.418s)
[652.913231] [128/155] (372s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[652.993891] Starting subtest: etime-single-wait-for-submit-unsubmitted
[653.096139] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[653.176140] [129/155] (372s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[653.235156] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[653.239230] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[653.428848] [130/155] (372s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[653.480388] Starting subtest: invalid-bsd1-flag-on-blt
[653.482775] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[653.578249] [131/155] (372s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[653.679551] Starting subtest: stress-xrgb8888-yftiled
[653.684093] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[653.768727] [132/155] (372s left) kms_getfb (getfb-handle-zero)
[653.873201] Starting subtest: getfb-handle-zero
[653.875075] Subtest getfb-handle-zero: SUCCESS (0.000s)
[653.990003] [133/155] (371s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[654.090108] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[654.094243] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[654.194714] [134/155] (371s left) kms_invalid_mode (bad-vsync-start)
[654.300373] Starting subtest: bad-vsync-start
[654.302750] Starting dynamic subtest: pipe-A-eDP-1
[654.590164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[654.601741] Starting dynamic subtest: pipe-B-eDP-1
[654.603695] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[654.618274] Starting dynamic subtest: pipe-C-eDP-1
[654.620661] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[654.632129] Starting dynamic subtest: pipe-D-eDP-1
[654.634523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[654.636812] Subtest bad-vsync-start: SUCCESS (0.295s)
[655.443457] [135/155] (370s left) kms_async_flips (test-time-stamp)
[655.530546] Starting subtest: test-time-stamp
[655.901597] Starting dynamic subtest: pipe-A-eDP-1
[656.741071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.837s)
[657.134092] Starting dynamic subtest: pipe-B-eDP-1
[657.973987] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.845s)
[658.364568] Starting dynamic subtest: pipe-C-eDP-1
[659.204606] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.849s)
[659.571119] Starting dynamic subtest: pipe-D-eDP-1
[660.331058] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[660.333487] Subtest test-time-stamp: SUCCESS (4.800s)
[661.493365] [136/155] (364s left) kms_frontbuffer_tracking (fbchdr-stridechange)
[661.590686] Starting subtest: fbchdr-stridechange
[661.594878] Subtest fbchdr-stridechange: SKIP (0.000s)
[661.702989] [137/155] (364s left) kms_prop_blob (blob-prop-core)
[661.761566] Starting subtest: blob-prop-core
[661.763880] Subtest blob-prop-core: SUCCESS (0.000s)
[661.863132] [138/155] (364s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[661.955296] Starting subtest: bad-pixel-format-yf-tiled-ccs
[661.957456] Starting dynamic subtest: pipe-A-eDP-1
[661.979242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[661.992327] Starting dynamic subtest: pipe-B-eDP-1
[662.013566] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[662.023995] Starting dynamic subtest: pipe-C-eDP-1
[662.045740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[662.055752] Starting dynamic subtest: pipe-D-eDP-1
[662.078107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[662.082233] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[664.256328] [139/155] (361s left) kms_psr (fbc-psr2-cursor-blt)
[664.366128] Starting subtest: fbc-psr2-cursor-blt
[664.368459] Starting dynamic subtest: eDP-1
[664.372756] Dynamic subtest eDP-1: SKIP (0.000s)
[664.377253] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[664.445288] [140/155] (361s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[664.536845] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[664.540839] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[664.628394] [141/155] (361s left) gem_close_race (multigpu-basic-threads)
[664.685751] Starting subtest: multigpu-basic-threads
[664.690321] Subtest multigpu-basic-threads: SKIP (0.000s)
[664.921660] [142/155] (361s left) i915_pm_rps (basic-api)
[664.979978] Starting subtest: basic-api
[664.984089] Subtest basic-api: SKIP (0.001s)
[665.125434] [143/155] (361s left) gem_mmap_gtt (fault-concurrent)
[665.169232] Subtest fault-concurrent: SKIP (0.000s)
[665.232661] [144/155] (361s left) kms_universal_plane (universal-plane-functional)
[665.325926] Starting subtest: universal-plane-functional
[665.328166] Starting dynamic subtest: pipe-A-eDP-1
[669.341328] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.013s)
[669.353249] Starting dynamic subtest: pipe-B-eDP-1
[673.903075] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.562s)
[673.915046] Starting dynamic subtest: pipe-C-eDP-1
[678.263703] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.360s)
[678.275846] Starting dynamic subtest: pipe-D-eDP-1
[682.653582] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.388s)
[682.655891] Subtest universal-plane-functional: SUCCESS (17.329s)
[683.551899] [145/155] (342s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[683.658310] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[683.662393] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[683.731475] [146/155] (342s left) kms_vrr (seamless-rr-switch-drrs)
[683.829198] Starting subtest: seamless-rr-switch-drrs
[683.835773] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[683.903517] [147/155] (342s left) kms_content_protection (uevent)
[684.036130] Starting subtest: uevent
[684.040526] Subtest uevent: SKIP (0.000s)
[684.160134] [148/155] (342s left) gem_ctx_persistence (smoketest)
[684.216784] Starting subtest: smoketest
[724.236131] Subtest smoketest: SUCCESS (40.015s)
[724.316161] [149/155] (302s left) gen9_exec_parse (batch-without-end)
[724.384297] Subtest batch-without-end: SKIP (0.000s)
[724.458903] [150/155] (302s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[724.557214] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[724.561199] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[724.652088] [151/155] (302s left) gem_eio (wait-immediate)
[724.877841] Starting subtest: wait-immediate
[725.254341] Subtest wait-immediate: SUCCESS (0.377s)
[725.384013] [152/155] (301s left) i915_pm_freq_api (freq-basic-api)
[725.454596] Starting subtest: freq-basic-api
[725.456718] Starting dynamic subtest: gt0
[725.458775] Dynamic subtest gt0: SUCCESS (0.003s)
[725.472918] Starting dynamic subtest: gt1
[725.474803] Dynamic subtest gt1: SUCCESS (0.003s)
[725.476639] Subtest freq-basic-api: SUCCESS (0.007s)
[725.576814] [153/155] (301s left) gem_exec_fence (syncobj-unused-fence)
[726.011569] Starting subtest: syncobj-unused-fence
[726.017001] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[727.365107] [154/155] (299s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[727.473343] Starting subtest: psr-1p-primscrn-spr-indfb-move
[734.925218] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.456s)
[735.075546] [155/155] (291s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[735.199081] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[742.648490] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.453s)
[742.794823] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_dsc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: gem_vm_create
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: prime_mmap
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: api_intel_allocator
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: gem_busy
results: parsing output: 30/ for test: kms_chamelium_hpd
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: gem_sync
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_chamelium_frames
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_render_copy_redux
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: gem_lmem_swapping
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: kms_color
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_store
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: drm_buddy
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_fence_thrash
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: kms_debugfs
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_render_copy_redux
results: parsing output: 85/ for test: i915_drm_fdinfo
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gen3_render_tiledx_blits
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_media_vme
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: kms_hdr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: prime_self_import
results: parsing output: 111/ for test: gem_ctx_sseu
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_linear_blits
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_pipe_stress
results: parsing output: 131/ for test: kms_getfb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_invalid_mode
results: parsing output: 134/ for test: kms_async_flips
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_prop_blob
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_close_race
results: parsing output: 141/ for test: i915_pm_rps
results: parsing output: 142/ for test: gem_mmap_gtt
results: parsing output: 143/ for test: kms_universal_plane
results: parsing output: 144/ for test: kms_flip_scaled_crc
results: parsing output: 145/ for test: kms_vrr
results: parsing output: 146/ for test: kms_content_protection
results: parsing output: 147/ for test: gem_ctx_persistence
results: parsing output: 148/ for test: gen9_exec_parse
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_eio
results: parsing output: 151/ for test: i915_pm_freq_api
results: parsing output: 152/ for test: gem_exec_fence
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.