[67.200490] Initializing watchdogs
[67.200590]   /dev/watchdog0
[67.231349] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[67.246471] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.251614] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.254971] [001/132] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[68.746973] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[68.748542] Starting dynamic subtest: pipe-A-HDMI-A-1
[68.763715] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[68.772111] Starting dynamic subtest: pipe-B-HDMI-A-1
[68.787580] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[68.795657] Starting dynamic subtest: pipe-C-HDMI-A-1
[68.811740] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[68.820214] Starting dynamic subtest: pipe-D-HDMI-A-1
[68.837654] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[68.841356] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[69.005799] [002/132] (958s left) gem_pipe_control_store_loop (reused-buffer)
[69.061089] Starting subtest: reused-buffer
[71.234938] Subtest reused-buffer: SUCCESS (2.174s)
[71.910108] [003/132] (956s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[73.489661] Starting subtest: extended-modeset-hang-oldfb-with-reset
[73.491181] Starting dynamic subtest: pipe-A
[84.229450] Dynamic subtest pipe-A: SUCCESS (10.746s)
[84.240575] Starting dynamic subtest: pipe-D
[94.955468] Dynamic subtest pipe-D: SUCCESS (10.723s)
[94.956924] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.476s)
[95.142876] [004/132] (932s left) gem_userptr_blits (dmabuf-unsync)
[95.204106] Subtest dmabuf-unsync: SKIP (0.000s)
[95.410387] [005/132] (932s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[95.457969] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[95.459755] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[95.617078] [006/132] (932s left) vgem_basic (busy-fence)
[95.733494] Starting subtest: busy-fence
[95.735087] Subtest busy-fence: SUCCESS (0.001s)
[95.828265] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[95.830765] [007/132] (932s left) gem_exec_balancer (parallel-ordering)
[96.202545] Starting subtest: parallel-ordering
[98.360408] Subtest parallel-ordering: SUCCESS (2.158s)
[98.523789] [008/132] (929s left) gem_pxp (display-protected-crc)
[101.094472] Starting subtest: display-protected-crc
[101.097652] Subtest display-protected-crc: SKIP (0.000s)
[101.202363] [009/132] (927s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[101.253833] Starting subtest: rel-constants-invalid-rel-gen5
[101.255462] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[101.416286] [010/132] (927s left) kms_prime (d3hot)
[102.924604] Subtest D3hot: SKIP (0.000s)
[103.140208] [011/132] (925s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[103.186747] Starting subtest: etime-multi-wait-for-submit-submitted
[103.299291] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[103.431266] [012/132] (925s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[104.922572] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[104.945718] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.021s)
[105.156801] [013/132] (923s left) prime_self_import (export-vs-gem_close-race)
[105.203026] Starting subtest: export-vs-gem_close-race
[110.237203] Subtest export-vs-gem_close-race: SUCCESS (5.035s)
[110.394680] [014/132] (918s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[111.947580] Starting subtest: dp-mst-lic-type-0-hdcp14
[111.950741] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[112.140561] [015/132] (916s left) gem_busy (busy)
[112.202832] Starting subtest: busy
[112.204603] Starting dynamic subtest: all-engines
[112.262169] Dynamic subtest all-engines: SUCCESS (0.060s)
[112.273635] Starting dynamic subtest: rcs0
[112.334735] Dynamic subtest rcs0: SUCCESS (0.072s)
[112.345153] Starting dynamic subtest: bcs0
[112.372921] Dynamic subtest bcs0: SUCCESS (0.038s)
[112.388309] Starting dynamic subtest: vcs0
[112.422670] Dynamic subtest vcs0: SUCCESS (0.039s)
[112.461480] Starting dynamic subtest: vcs1
[112.463326] Dynamic subtest vcs1: SUCCESS (0.043s)
[112.478805] Starting dynamic subtest: vecs0
[112.495263] Dynamic subtest vecs0: SUCCESS (0.038s)
[112.497057] Subtest busy: SUCCESS (0.294s)
[112.934697] [016/132] (916s left) gem_mmap_wc (write-read)
[112.982578] Subtest write-read: SKIP (0.000s)
[113.059438] [017/132] (916s left) kms_psr (fbc-pr-primary-page-flip)
[114.545793] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[114.627775] [018/132] (914s left) vgem_basic (mmap)
[114.682449] Starting subtest: mmap
[114.690856] Subtest mmap: SUCCESS (0.010s)
[114.780993] [019/132] (914s left) gem_exec_reloc (basic-wc)
[114.833369] Subtest basic-wc: SKIP (0.000s)
[114.924152] [020/132] (914s left) gem_vm_create (execbuf)
[114.976119] Starting subtest: execbuf
[114.984146] Subtest execbuf: SUCCESS (0.008s)
[115.185176] [021/132] (914s left) gem_exec_balancer (nohangcheck)
[115.557094] Starting subtest: nohangcheck
[117.652512] Subtest nohangcheck: SUCCESS (2.092s)
[117.817935] [022/132] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[119.313975] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[119.317983] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.512862] [023/132] (910s left) gem_exec_fence (submit3)
[119.717690] Starting subtest: submit3
[119.721274] Subtest submit3: SKIP (0.000s)
[120.354708] [024/132] (909s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[121.849540] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[121.853199] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.044758] [025/132] (907s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[123.535149] Starting subtest: plane-lut1d-ctm3x4
[123.732831] Starting dynamic subtest: pipe-A-plane-0
[123.982860] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[124.018462] Starting dynamic subtest: pipe-A-plane-1
[124.182884] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[124.215397] Starting dynamic subtest: pipe-A-plane-2
[124.382847] Dynamic subtest pipe-A-plane-2: SUCCESS (0.199s)
[124.667124] Starting dynamic subtest: pipe-B-plane-0
[124.821179] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[124.831267] Starting dynamic subtest: pipe-B-plane-1
[124.989224] Dynamic subtest pipe-B-plane-1: SUCCESS (0.167s)
[125.020851] Starting dynamic subtest: pipe-B-plane-2
[125.190209] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s)
[125.463533] Starting dynamic subtest: pipe-C-plane-0
[125.634391] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[125.658986] Starting dynamic subtest: pipe-C-plane-1
[125.834427] Dynamic subtest pipe-C-plane-1: SUCCESS (0.199s)
[125.868826] Starting dynamic subtest: pipe-C-plane-2
[126.051117] Dynamic subtest pipe-C-plane-2: SUCCESS (0.215s)
[126.365427] Starting dynamic subtest: pipe-D-plane-0
[126.536034] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[126.562873] Starting dynamic subtest: pipe-D-plane-1
[126.736144] Dynamic subtest pipe-D-plane-1: SUCCESS (0.199s)
[126.769592] Starting dynamic subtest: pipe-D-plane-2
[126.952943] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s)
[126.991877] Subtest plane-lut1d-ctm3x4: SUCCESS (3.456s)
[127.167416] [026/132] (902s left) syncobj_wait (invalid-reset-illegal-handle)
[127.216487] Starting subtest: invalid-reset-illegal-handle
[127.218106] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[127.340411] [027/132] (902s left) i915_suspend (debugfs-reader)
[127.388503] Starting subtest: debugfs-reader
[150.338171] Subtest debugfs-reader: SUCCESS (11.986s)
[156.485468] [028/132] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[158.040510] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[158.043921] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[158.233433] [029/132] (878s left) kms_psr (fbc-pr-cursor-blt)
[159.778121] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[159.877179] [030/132] (876s left) perf (rc6-disable)
[160.024830] Starting subtest: rc6-disable
[160.243938] Subtest rc6-disable: SUCCESS (0.211s)
[160.384401] [031/132] (876s left) gem_softpin (overlap)
[160.440987] Starting subtest: overlap
[164.224452] Subtest overlap: SUCCESS (3.689s)
[164.365896] [032/132] (872s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[165.877584] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[165.879267] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.895022] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[165.907574] Starting dynamic subtest: pipe-B-HDMI-A-1
[165.923774] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[165.935817] Starting dynamic subtest: pipe-C-HDMI-A-1
[165.952466] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[165.964755] Starting dynamic subtest: pipe-D-HDMI-A-1
[165.991085] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[165.993964] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[166.144056] [033/132] (870s left) kms_tv_load_detect (load-detect)
[166.203281] Subtest load-detect: SKIP (0.000s)
[166.297027] [034/132] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[167.829915] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[167.833080] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[168.029496] [035/132] (868s left) drm_read (empty-nonblock)
[169.617813] Starting subtest: empty-nonblock
[169.619254] Subtest empty-nonblock: SUCCESS (0.000s)
[169.865150] [036/132] (867s left) kms_psr (psr2-cursor-mmap-gtt)
[171.366183] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[171.448599] [037/132] (865s left) kms_hdr (brightness-with-hdr)
[172.948172] Starting subtest: brightness-with-hdr
[172.953568] Subtest brightness-with-hdr: SKIP (0.001s)
[173.147822] [038/132] (864s left) kms_plane_cursor (viewport)
[174.641627] Starting subtest: viewport
[174.644898] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[177.900859] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (3.244s)
[177.980561] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[181.277004] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (3.300s)
[181.356969] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[184.567421] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (3.216s)
[184.689367] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[187.771799] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (3.090s)
[187.850539] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[190.839392] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (3.016s)
[190.902283] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[193.890678] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (3.000s)
[193.995530] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[197.127726] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (3.144s)
[197.194059] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[200.212486] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (3.033s)
[200.273152] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[203.246907] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.983s)
[203.335334] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[206.385862] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (3.063s)
[206.448502] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[209.454202] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (3.016s)
[209.520879] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[212.571822] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (3.066s)
[212.665743] Subtest viewport: SUCCESS (37.978s)
[212.911431] [039/132] (824s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[214.405938] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[214.499050] [040/132] (822s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[215.993813] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[215.995275] Starting dynamic subtest: pipe-A
[218.532031] Dynamic subtest pipe-A: SUCCESS (2.538s)
[218.564591] Starting dynamic subtest: pipe-B
[221.141142] Dynamic subtest pipe-B: SUCCESS (2.606s)
[221.161705] Starting dynamic subtest: pipe-C
[221.449705] Dynamic subtest pipe-C: SUCCESS (0.306s)
[221.474045] Starting dynamic subtest: pipe-D
[221.757656] Dynamic subtest pipe-D: SUCCESS (0.306s)
[221.759428] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.763s)
[221.949588] [041/132] (815s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[223.493765] Starting subtest: yf-tiled-32bpp-rotate-0
[223.497240] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[223.702272] [042/132] (813s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[225.192258] Starting subtest: plane-primary-overlay-mutable-zpos
[226.224339] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.032s)
[226.446430] [043/132] (811s left) gem_spin_batch (resubmit-new-all)
[226.521663] Starting subtest: resubmit-new-all
[226.523268] Starting dynamic subtest: rcs0
[226.546638] Dynamic subtest rcs0: SUCCESS (0.024s)
[226.559328] Starting dynamic subtest: bcs0
[226.561013] Dynamic subtest bcs0: SUCCESS (0.007s)
[226.573718] Starting dynamic subtest: vcs0
[226.575288] Dynamic subtest vcs0: SUCCESS (0.007s)
[226.587481] Starting dynamic subtest: vcs1
[226.589359] Dynamic subtest vcs1: SUCCESS (0.008s)
[226.601476] Starting dynamic subtest: vecs0
[226.603360] Dynamic subtest vecs0: SUCCESS (0.007s)
[226.605182] Subtest resubmit-new-all: SUCCESS (0.061s)
[226.969050] [044/132] (810s left) gem_exec_await (wide-all)
[227.130655] Starting subtest: wide-all
[249.437253] Subtest wide-all: SUCCESS (22.297s)
[249.706035] [045/132] (788s left) gem_exec_params (dr1-dirt)
[249.820299] Starting subtest: DR1-dirt
[249.821777] Subtest DR1-dirt: SUCCESS (0.000s)
[249.960093] [046/132] (787s left) gem_mmap_gtt (isolation)
[250.011412] Subtest isolation: SKIP (0.000s)
[250.083100] [047/132] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[251.589063] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[251.592331] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[251.788461] [048/132] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[253.311268] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[253.314376] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[253.531672] [049/132] (784s left) syncobj_timeline (multi-wait-for-submit-signaled)
[253.588789] Starting subtest: multi-wait-for-submit-signaled
[253.590323] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[253.709430] [050/132] (784s left) kms_cursor_crc (cursor-random-32x10)
[255.313507] Starting subtest: cursor-random-32x10
[255.368669] Subtest cursor-random-32x10: SKIP (0.052s)
[255.759777] [051/132] (782s left) perf_pmu (busy-accuracy-50)
[255.815190] Starting subtest: busy-accuracy-50
[255.816449] Starting dynamic subtest: rcs0
[257.357250] Dynamic subtest rcs0: SUCCESS (1.543s)
[257.370775] Starting dynamic subtest: bcs0
[258.903555] Dynamic subtest bcs0: SUCCESS (1.546s)
[258.917384] Starting dynamic subtest: vcs0
[260.450752] Dynamic subtest vcs0: SUCCESS (1.546s)
[260.464230] Starting dynamic subtest: vcs1
[261.995378] Dynamic subtest vcs1: SUCCESS (1.544s)
[262.008878] Starting dynamic subtest: vecs0
[263.540634] Dynamic subtest vecs0: SUCCESS (1.544s)
[263.542171] Subtest busy-accuracy-50: SUCCESS (7.731s)
[263.732518] [052/132] (774s left) kms_vblank (wait-busy-hang)
[265.219780] Starting subtest: wait-busy-hang
[265.221141] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.449409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (26.231s)
[291.467474] Starting dynamic subtest: pipe-D-HDMI-A-1
[316.466656] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (25.006s)
[316.468435] Subtest wait-busy-hang: SUCCESS (51.245s)
[316.647972] [053/132] (721s left) gem_exec_schedule (manyslice)
[316.710161] Starting subtest: manyslice
[316.711986] Starting dynamic subtest: rcs0
[322.250196] Dynamic subtest rcs0: SUCCESS (5.537s)
[322.264197] Starting dynamic subtest: bcs0
[327.663382] Dynamic subtest bcs0: SUCCESS (5.409s)
[327.680468] Starting dynamic subtest: vcs0
[333.179705] Dynamic subtest vcs0: SUCCESS (5.511s)
[333.215856] Starting dynamic subtest: vcs1
[338.207333] Dynamic subtest vcs1: SUCCESS (5.021s)
[338.231058] Starting dynamic subtest: vecs0
[343.716836] Dynamic subtest vecs0: SUCCESS (5.506s)
[343.718293] Subtest manyslice: SUCCESS (26.999s)
[344.107911] [054/132] (694s left) api_intel_allocator (reloc-allocator)
[344.157654] Starting subtest: reloc-allocator
[344.159168] Starting dynamic subtest: basic
[344.174224] Dynamic subtest basic: SUCCESS (0.016s)
[344.188691] Starting dynamic subtest: parallel-one
[344.190240] Dynamic subtest parallel-one: SUCCESS (0.005s)
[344.204011] Starting dynamic subtest: print
[344.205790] Dynamic subtest print: SUCCESS (0.000s)
[344.219487] Starting dynamic subtest: reuse
[344.221235] Dynamic subtest reuse: SUCCESS (0.000s)
[344.234386] Starting dynamic subtest: fork-reopen-allocator
[344.235977] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[344.237731] Subtest reloc-allocator: SUCCESS (0.044s)
[344.349220] [055/132] (694s left) gem_exec_schedule (fifo)
[344.410643] Starting subtest: fifo
[344.412265] Starting dynamic subtest: rcs0
[344.603715] Dynamic subtest rcs0: SUCCESS (0.191s)
[344.617649] Starting dynamic subtest: bcs0
[344.733786] Dynamic subtest bcs0: SUCCESS (0.132s)
[344.747319] Starting dynamic subtest: vcs0
[344.868770] Dynamic subtest vcs0: SUCCESS (0.134s)
[344.882387] Starting dynamic subtest: vcs1
[345.002817] Dynamic subtest vcs1: SUCCESS (0.133s)
[345.016321] Starting dynamic subtest: vecs0
[345.148372] Dynamic subtest vecs0: SUCCESS (0.144s)
[345.150064] Subtest fifo: SUCCESS (0.740s)
[345.624934] [056/132] (693s left) kms_cursor_crc (cursor-onscreen-256x256)
[347.332869] Starting subtest: cursor-onscreen-256x256
[347.340758] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.161052] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.820s)
[350.198808] Starting dynamic subtest: pipe-D-HDMI-A-1
[352.810994] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.623s)
[352.812246] Subtest cursor-onscreen-256x256: SUCCESS (5.476s)
[353.172972] [057/132] (685s left) kms_flip (flip-vs-rmfb-interruptible)
[354.671814] Starting subtest: flip-vs-rmfb-interruptible
[354.673344] Starting dynamic subtest: A-HDMI-A1
[362.397828] Dynamic subtest A-HDMI-A1: SUCCESS (7.722s)
[362.424887] Starting dynamic subtest: B-HDMI-A1
[370.064824] Dynamic subtest B-HDMI-A1: SUCCESS (7.661s)
[370.107843] Starting dynamic subtest: C-HDMI-A1
[377.752591] Dynamic subtest C-HDMI-A1: SUCCESS (7.681s)
[377.787495] Starting dynamic subtest: D-HDMI-A1
[385.468406] Dynamic subtest D-HDMI-A1: SUCCESS (7.713s)
[385.479610] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.806s)
[385.727160] [058/132] (653s left) sw_sync (alloc_timeline)
[385.781805] Starting subtest: alloc_timeline
[385.783732] Subtest alloc_timeline: SUCCESS (0.000s)
[385.908606] [059/132] (653s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[387.403565] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[387.405201] Starting dynamic subtest: pipe-A-HDMI-A-1
[387.423487] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[387.437234] Starting dynamic subtest: pipe-B-HDMI-A-1
[387.461944] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[387.475016] Starting dynamic subtest: pipe-C-HDMI-A-1
[387.489047] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[387.502178] Starting dynamic subtest: pipe-D-HDMI-A-1
[387.516788] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[387.519434] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[387.728050] [060/132] (651s left) gem_lmem_swapping (verify-random-ccs)
[392.135820] Starting subtest: verify-random-ccs
[392.137383] Starting dynamic subtest: lmem0
[392.140433] Dynamic subtest lmem0: SKIP (0.001s)
[392.144308] Subtest verify-random-ccs: SKIP (0.003s)
[395.942943] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[395.944122] [FACT gem_lmem_swapping (verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[395.949332] [061/132] (643s left) gem_exec_reloc (basic-write-gtt)
[399.342496] Subtest basic-write-gtt: SKIP (0.000s)
[399.490779] [FACT gem_exec_reloc (basic-write-gtt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[399.493860] [FACT gem_exec_reloc (basic-write-gtt)] new: kernel.kmod_is_loaded.i915: true
[399.500734] [062/132] (639s left) gem_exec_schedule (u-semaphore-codependency)
[399.587614] Starting subtest: u-semaphore-codependency
[399.626628] Subtest u-semaphore-codependency: SUCCESS (0.039s)
[400.132602] [063/132] (639s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[401.645576] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[401.648559] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[401.841201] [064/132] (637s left) dumb_buffer (create-clear)
[401.889200] Starting subtest: create-clear
[439.509727] Subtest create-clear: SUCCESS (37.623s)
[439.654490] [065/132] (600s left) kms_vblank (query-busy)
[441.141923] Starting subtest: query-busy
[441.143437] Starting dynamic subtest: pipe-A-HDMI-A-1
[443.704649] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.562s)
[443.721993] Starting dynamic subtest: pipe-D-HDMI-A-1
[446.085090] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.375s)
[446.086650] Subtest query-busy: SUCCESS (4.945s)
[446.252727] [066/132] (593s left) kms_plane_scaling (planes-upscale-20x20)
[447.741424] Starting subtest: planes-upscale-20x20
[447.743141] Starting dynamic subtest: pipe-A
[447.867173] Dynamic subtest pipe-A: SUCCESS (0.127s)
[447.894539] Starting dynamic subtest: pipe-B
[448.063905] Dynamic subtest pipe-B: SUCCESS (0.195s)
[448.076094] Starting dynamic subtest: pipe-C
[448.205252] Dynamic subtest pipe-C: SUCCESS (0.140s)
[448.217420] Starting dynamic subtest: pipe-D
[448.346124] Dynamic subtest pipe-D: SUCCESS (0.139s)
[448.347680] Subtest planes-upscale-20x20: SUCCESS (0.607s)
[448.540113] [067/132] (591s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[450.040557] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[450.044519] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[450.179479] [068/132] (589s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[451.670271] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[451.671737] Starting dynamic subtest: pipe-A-valid-mode
[452.798081] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.126s)
[452.799629] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.129s)
[452.973068] [069/132] (587s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[454.481713] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[454.484847] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[454.689742] [070/132] (585s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[456.179196] Starting subtest: read-crc-frame-sequence
[456.180665] Starting dynamic subtest: pipe-A-HDMI-A-1
[456.844260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.664s)
[456.859919] Starting dynamic subtest: pipe-B-HDMI-A-1
[457.341460] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s)
[457.354490] Starting dynamic subtest: pipe-C-HDMI-A-1
[457.844264] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.499s)
[457.857710] Starting dynamic subtest: pipe-D-HDMI-A-1
[458.388671] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.541s)
[458.390288] Subtest read-crc-frame-sequence: SUCCESS (2.209s)
[458.580761] [071/132] (581s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[460.088817] Starting subtest: y-tiled-8bpp-rotate-270
[460.203861] Subtest y-tiled-8bpp-rotate-270: SKIP (0.112s)
[460.345332] [072/132] (579s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[461.832083] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[461.835887] Starting dynamic subtest: pipe-A-HDMI-A-1
[461.853084] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[461.866179] Starting dynamic subtest: pipe-B-HDMI-A-1
[461.883935] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[461.896277] Starting dynamic subtest: pipe-C-HDMI-A-1
[461.914498] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[461.927420] Starting dynamic subtest: pipe-D-HDMI-A-1
[461.955382] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[461.958456] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.011s)
[462.094198] [073/132] (578s left) kms_chamelium_frames (hdmi-frame-dump)
[463.632691] Subtest hdmi-frame-dump: SKIP (0.000s)
[463.756450] [074/132] (576s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[465.245065] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[465.249617] Starting dynamic subtest: A-HDMI-A1
[465.986637] Dynamic subtest A-HDMI-A1: SUCCESS (0.737s)
[465.999244] Starting dynamic subtest: B-HDMI-A1
[466.657463] Dynamic subtest B-HDMI-A1: SUCCESS (0.668s)
[466.670377] Starting dynamic subtest: C-HDMI-A1
[467.317342] Dynamic subtest C-HDMI-A1: SUCCESS (0.659s)
[467.330319] Starting dynamic subtest: D-HDMI-A1
[467.982906] Dynamic subtest D-HDMI-A1: SUCCESS (0.663s)
[467.986704] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (2.741s)
[468.190240] [075/132] (572s left) gem_exec_whisper (basic-fds-priority-all)
[468.284157] Starting subtest: basic-fds-priority-all
[480.076720] Subtest basic-fds-priority-all: SUCCESS (11.789s)
[480.368405] [076/132] (560s left) gem_mmap_gtt (basic-read)
[480.418874] Subtest basic-read: SKIP (0.000s)
[480.505689] [077/132] (560s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[481.995266] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[481.998443] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[482.144373] [078/132] (558s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[483.638163] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[483.723644] [079/132] (557s left) kms_plane_scaling (2x-scaler-multi-pipe)
[485.219314] Starting subtest: 2x-scaler-multi-pipe
[485.222295] Subtest 2x-scaler-multi-pipe: SKIP (0.003s)
[485.457790] [080/132] (555s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[487.000682] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[487.122752] [081/132] (553s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[488.612986] Starting subtest: primary-4-tiled-reflect-x-180
[488.705141] Subtest primary-4-tiled-reflect-x-180: SKIP (0.092s)
[488.915545] [082/132] (552s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[492.942214] Starting subtest: gem-execbuf-stress-pc8
[493.026883] Subtest gem-execbuf-stress-pc8: SKIP (0.090s)
[493.923116] [083/132] (547s left) gem_close_race (multigpu-basic-threads)
[493.998478] Starting subtest: multigpu-basic-threads
[494.001653] Subtest multigpu-basic-threads: SKIP (0.000s)
[494.335517] [084/132] (547s left) gem_render_copy (yf-tiled-ccs-to-linear)
[494.390983] Starting subtest: yf-tiled-ccs-to-linear
[494.392424] Starting dynamic subtest: smem
[494.476567] Dynamic subtest smem: SUCCESS (0.085s)
[494.490088] Starting dynamic subtest: lmem0
[494.786772] Dynamic subtest lmem0: SUCCESS (0.305s)
[494.788395] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.393s)
[495.086939] [085/132] (546s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[496.592769] Starting subtest: 4-tiled-32bpp-rotate-270
[496.595762] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[496.816409] [086/132] (544s left) kms_draw_crc (draw-method-pwrite)
[498.305865] Starting subtest: draw-method-pwrite
[498.307199] Starting dynamic subtest: xrgb8888-untiled
[498.811345] Dynamic subtest xrgb8888-untiled: SUCCESS (0.505s)
[498.827741] Starting dynamic subtest: rgb565-untiled
[499.261556] Dynamic subtest rgb565-untiled: SUCCESS (0.448s)
[499.279699] Starting dynamic subtest: xrgb2101010-untiled
[499.713062] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.448s)
[499.730992] Starting dynamic subtest: xbgr16161616f-untiled
[500.178323] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.461s)
[500.192519] Starting dynamic subtest: xrgb8888-xtiled
[500.828587] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.648s)
[500.851509] Starting dynamic subtest: rgb565-xtiled
[501.528966] Dynamic subtest rgb565-xtiled: SUCCESS (0.698s)
[501.543433] Starting dynamic subtest: xrgb2101010-xtiled
[502.162164] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.631s)
[502.175871] Starting dynamic subtest: xbgr16161616f-xtiled
[502.913777] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.749s)
[502.931377] Starting dynamic subtest: xrgb8888-ytiled
[503.563671] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.645s)
[503.580857] Starting dynamic subtest: rgb565-ytiled
[504.012339] Dynamic subtest rgb565-ytiled: SUCCESS (0.444s)
[504.028500] Starting dynamic subtest: xrgb2101010-ytiled
[504.645676] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.631s)
[504.659129] Starting dynamic subtest: xbgr16161616f-ytiled
[505.646018] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.998s)
[505.647561] Subtest draw-method-pwrite: SUCCESS (7.340s)
[505.809821] [087/132] (535s left) perf (per-context-mode-unprivileged)
[505.967446] Starting subtest: per-context-mode-unprivileged
[505.970671] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[506.051245] [088/132] (535s left) gem_ctx_persistence (engines-hostile)
[506.108759] Starting subtest: engines-hostile
[506.110421] Starting dynamic subtest: rcs0
[506.182111] Dynamic subtest rcs0: SUCCESS (0.071s)
[506.235514] Starting dynamic subtest: bcs0
[506.250427] Dynamic subtest bcs0: SUCCESS (0.062s)
[506.264849] Starting dynamic subtest: vcs0
[506.341941] Dynamic subtest vcs0: SUCCESS (0.089s)
[506.392902] Starting dynamic subtest: vcs1
[506.406116] Dynamic subtest vcs1: SUCCESS (0.059s)
[506.425305] Starting dynamic subtest: vecs0
[506.494399] Dynamic subtest vecs0: SUCCESS (0.086s)
[506.499621] Subtest engines-hostile: SUCCESS (0.388s)
[506.685543] [089/132] (535s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[506.733039] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[506.844476] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[507.014815] [090/132] (534s left) kms_atomic_interruptible (universal-setplane-cursor)
[508.502512] Starting subtest: universal-setplane-cursor
[508.515864] Starting dynamic subtest: pipe-A-HDMI-A-1
[514.727737] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.222s)
[514.729290] Subtest universal-setplane-cursor: SUCCESS (6.224s)
[514.900855] [091/132] (527s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[516.396630] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[516.399874] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[516.596964] [092/132] (525s left) syncobj_timeline (single-wait-all-available-submitted)
[516.650856] Starting subtest: single-wait-all-available-submitted
[516.652429] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[516.793898] [093/132] (525s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[518.281223] Starting subtest: cursorA-vs-flipA-varying-size
[529.207337] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.924s)
[529.395666] [094/132] (512s left) i915_drm_fdinfo (isolation)
[529.469389] Starting subtest: isolation
[529.470975] Starting dynamic subtest: rcs0
[529.474008] Dynamic subtest rcs0: SKIP (0.001s)
[529.489865] Starting dynamic subtest: bcs0
[529.492748] Dynamic subtest bcs0: SKIP (0.001s)
[529.506130] Starting dynamic subtest: vcs0
[529.509140] Dynamic subtest vcs0: SKIP (0.011s)
[529.522168] Starting dynamic subtest: vcs1
[529.525342] Dynamic subtest vcs1: SKIP (0.000s)
[529.538568] Starting dynamic subtest: vecs0
[529.541976] Dynamic subtest vecs0: SKIP (0.000s)
[529.544970] Subtest isolation: SKIP (0.024s)
[529.612621] [095/132] (512s left) kms_atomic_interruptible (legacy-pageflip)
[531.100405] Starting subtest: legacy-pageflip
[531.104648] Starting dynamic subtest: pipe-A-HDMI-A-1
[537.340359] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.236s)
[537.341757] Subtest legacy-pageflip: SUCCESS (6.239s)
[537.563702] [096/132] (504s left) kms_cursor_edge_walk (64x64-top-bottom)
[539.053874] Starting subtest: 64x64-top-bottom
[539.055190] Starting dynamic subtest: pipe-A-HDMI-A-1
[542.396055] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.339s)
[542.409426] Starting dynamic subtest: pipe-D-HDMI-A-1
[545.615478] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.217s)
[545.617190] Subtest 64x64-top-bottom: SUCCESS (6.561s)
[545.797804] [097/132] (496s left) kms_psr (fbc-psr-sprite-render)
[547.286258] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[547.386228] [098/132] (495s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[548.880336] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[548.881998] Starting dynamic subtest: pipe-A-HDMI-A-1
[548.896501] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[548.910305] Starting dynamic subtest: pipe-B-HDMI-A-1
[548.924986] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[548.938399] Starting dynamic subtest: pipe-C-HDMI-A-1
[548.963435] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[548.976403] Starting dynamic subtest: pipe-D-HDMI-A-1
[548.988841] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s)
[548.990257] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.017s)
[549.143267] [099/132] (493s left) prime_busy (before-wait)
[549.224242] Starting subtest: before-wait
[549.234738] Starting dynamic subtest: rcs0
[549.259051] Dynamic subtest rcs0: SUCCESS (0.024s)
[549.275333] Starting dynamic subtest: bcs0
[549.306578] Dynamic subtest bcs0: SUCCESS (0.046s)
[549.326372] Starting dynamic subtest: vcs0
[549.346942] Dynamic subtest vcs0: SUCCESS (0.038s)
[549.367265] Starting dynamic subtest: vcs1
[549.387481] Dynamic subtest vcs1: SUCCESS (0.038s)
[549.407831] Starting dynamic subtest: vecs0
[549.429012] Dynamic subtest vecs0: SUCCESS (0.039s)
[549.541618] Subtest before-wait: SUCCESS (0.318s)
[549.738522] [100/132] (493s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[551.234653] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[551.238097] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[551.406282] [101/132] (491s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[551.461146] Starting subtest: yf-tiled-ccs-to-y-tiled
[551.462741] Starting dynamic subtest: smem
[551.555141] Dynamic subtest smem: SUCCESS (0.093s)
[551.568751] Starting dynamic subtest: lmem0
[552.490386] Dynamic subtest lmem0: SUCCESS (0.930s)
[552.492194] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (1.027s)
[552.784074] [102/132] (490s left) kms_joiner (invalid-modeset-ultra-joiner)
[554.277297] Starting subtest: invalid-modeset-ultra-joiner
[554.280722] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[554.440020] [103/132] (488s left) api_intel_bb (render-ccs)
[554.489267] Starting subtest: render-ccs
[554.584940] Subtest render-ccs: SUCCESS (0.098s)
[554.771332] [104/132] (488s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[556.278564] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[556.281743] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[556.480057] [105/132] (486s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[556.531116] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[556.638265] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[556.791154] [106/132] (486s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[558.286272] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[558.289724] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[558.511260] [107/132] (485s left) i915_pm_freq_api (freq-reset-multiple)
[558.566443] Starting subtest: freq-reset-multiple
[558.568571] Starting dynamic subtest: gt0
[572.125451] Dynamic subtest gt0: SUCCESS (13.553s)
[572.126967] Subtest freq-reset-multiple: SUCCESS (13.556s)
[572.251771] [108/132] (471s left) gem_reg_read (timestamp-moving)
[572.299741] Starting subtest: timestamp-moving
[573.303366] Subtest timestamp-moving: SUCCESS (1.000s)
[573.426730] [109/132] (470s left) syncobj_timeline (invalid-query-illegal-handle)
[573.474671] Starting subtest: invalid-query-illegal-handle
[573.476220] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[573.592144] [110/132] (470s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[575.086717] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[575.090131] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[575.337354] [111/132] (468s left) gem_render_copy_redux (interruptible)
[575.394307] Starting subtest: interruptible
[576.223795] Subtest interruptible: SUCCESS (0.831s)
[576.388471] [112/132] (467s left) gem_mmap_gtt (big-copy)
[576.438988] Subtest big-copy: SKIP (0.000s)
[576.514851] [113/132] (467s left) gem_lmem_swapping (heavy-random)
[580.816494] Starting subtest: heavy-random
[580.818599] Starting dynamic subtest: lmem0
[586.871902] Dynamic subtest lmem0: SUCCESS (6.052s)
[586.873226] Subtest heavy-random: SUCCESS (6.053s)
[588.239463] [FACT gem_lmem_swapping (heavy-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[588.240654] [FACT gem_lmem_swapping (heavy-random)] deleted: kernel.kmod_is_loaded.i915: true
[588.243478] [114/132] (456s left) gem_ctx_persistence (legacy-engines-persistence)
[591.591243] Starting subtest: legacy-engines-persistence
[591.594889] Starting dynamic subtest: render
[592.385244] Dynamic subtest render: SUCCESS (0.797s)
[592.402642] Starting dynamic subtest: bsd1
[593.128149] Dynamic subtest bsd1: SUCCESS (0.740s)
[593.143402] Starting dynamic subtest: bsd2
[593.921297] Dynamic subtest bsd2: SUCCESS (0.791s)
[593.939764] Starting dynamic subtest: blt
[594.689381] Dynamic subtest blt: SUCCESS (0.764s)
[594.707386] Starting dynamic subtest: vebox
[595.460398] Dynamic subtest vebox: SUCCESS (0.764s)
[595.470038] Subtest legacy-engines-persistence: SUCCESS (3.877s)
[595.615250] [FACT gem_ctx_persistence (legacy-engines-persistence)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[595.618636] [FACT gem_ctx_persistence (legacy-engines-persistence)] new: kernel.kmod_is_loaded.i915: true
[595.625864] [115/132] (448s left) gem_mmap (short-mmap)
[595.677792] Subtest short-mmap: SKIP (0.000s)
[595.764277] [116/132] (448s left) kms_invalid_mode (clock-too-high)
[597.252066] Starting subtest: clock-too-high
[597.253502] Starting dynamic subtest: pipe-A-HDMI-A-1
[597.298573] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.044s)
[597.313179] Starting dynamic subtest: pipe-B-HDMI-A-1
[597.315226] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.010s)
[597.327951] Starting dynamic subtest: pipe-C-HDMI-A-1
[597.329509] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.012s)
[597.342287] Starting dynamic subtest: pipe-D-HDMI-A-1
[597.343829] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[597.345408] Subtest clock-too-high: SUCCESS (0.086s)
[597.517050] [117/132] (447s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[599.013897] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[599.017319] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[599.208109] [118/132] (445s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[600.697413] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[600.862826] [119/132] (443s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[602.352967] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[602.356084] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[602.548424] [120/132] (442s left) gem_sync (basic-store-each)
[602.612130] Starting subtest: basic-store-each
[606.765151] Subtest basic-store-each: SUCCESS (4.153s)
[607.043536] [121/132] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[608.538980] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[608.542419] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[608.724472] [122/132] (436s left) gem_ctx_shared (exec-shared-gtt)
[608.782638] Starting subtest: exec-shared-gtt
[608.784283] Starting dynamic subtest: rcs0
[608.796356] Dynamic subtest rcs0: SUCCESS (0.013s)
[608.811481] Starting dynamic subtest: bcs0
[608.813118] Dynamic subtest bcs0: SUCCESS (0.009s)
[608.827729] Starting dynamic subtest: vcs0
[608.829342] Dynamic subtest vcs0: SUCCESS (0.007s)
[608.844255] Starting dynamic subtest: vcs1
[608.846011] Dynamic subtest vcs1: SUCCESS (0.008s)
[608.858871] Starting dynamic subtest: vecs0
[608.860643] Dynamic subtest vecs0: SUCCESS (0.008s)
[608.862454] Subtest exec-shared-gtt: SUCCESS (0.054s)
[609.119400] [123/132] (436s left) perf_pmu (busy-idle-check-all)
[609.171789] Starting subtest: busy-idle-check-all
[609.173700] Starting dynamic subtest: rcs0
[609.843744] Dynamic subtest rcs0: SUCCESS (0.671s)
[609.862558] Starting dynamic subtest: bcs0
[610.499837] Dynamic subtest bcs0: SUCCESS (0.654s)
[610.517221] Starting dynamic subtest: vcs0
[611.157454] Dynamic subtest vcs0: SUCCESS (0.654s)
[611.204751] Starting dynamic subtest: vcs1
[611.845000] Dynamic subtest vcs1: SUCCESS (0.680s)
[611.869580] Starting dynamic subtest: vecs0
[612.511552] Dynamic subtest vecs0: SUCCESS (0.659s)
[612.520800] Subtest busy-idle-check-all: SUCCESS (3.342s)
[612.673570] [124/132] (432s left) kms_flip (2x-flip-vs-fences-interruptible)
[614.167109] Starting subtest: 2x-flip-vs-fences-interruptible
[614.170446] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[614.329872] [125/132] (431s left) gen7_exec_parse (chained-batch)
[614.381652] Subtest chained-batch: SKIP (0.000s)
[614.466797] [126/132] (431s left) kms_pm_backlight (fade-with-dpms)
[615.956721] Subtest fade-with-dpms: SKIP (0.000s)
[616.124814] [127/132] (429s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[617.613357] Starting subtest: short-flip-after-cursor-atomic-transitions
[618.657410] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.045s)
[618.884691] [128/132] (426s left) gem_userptr_blits (sync-unmap)
[618.948749] Starting subtest: sync-unmap
[618.974683] Subtest sync-unmap: SUCCESS (0.024s)
[619.182798] [129/132] (426s left) kms_psr (fbc-psr-cursor-render)
[620.670394] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[620.749166] [130/132] (425s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[622.243681] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[622.247067] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[622.406249] [131/132] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[623.903384] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[623.906620] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[624.092104] [132/132] (422s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[625.587239] Starting subtest: fbc-rgb101010-draw-pwrite
[628.602652] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.016s)
[628.802767] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_pipe_control_store_loop
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_prime
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: prime_self_import
results: parsing output: 13/ for test: kms_content_protection
results: parsing output: 14/ for test: gem_busy
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: gem_vm_create
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: gem_softpin
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_tv_load_detect
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: drm_read
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_hdr
results: parsing output: 37/ for test: kms_plane_cursor
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: gem_spin_batch
results: parsing output: 43/ for test: gem_exec_await
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: api_intel_allocator
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: sw_sync
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_lmem_swapping
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: dumb_buffer
results: parsing output: 64/ for test: kms_vblank
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_pipe_crc_basic
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: kms_rotation_crc
results: parsing output: 81/ for test: i915_pm_rpm
results: parsing output: 82/ for test: gem_close_race
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_draw_crc
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_atomic_interruptible
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: kms_atomic_interruptible
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_pm_freq_api
results: parsing output: 107/ for test: gem_reg_read
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_render_copy_redux
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_mmap
results: parsing output: 115/ for test: kms_invalid_mode
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: gem_sync
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ctx_shared
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: gen7_exec_parse
results: parsing output: 125/ for test: kms_pm_backlight
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.