[57.360337] Initializing watchdogs
[57.360425]   /dev/watchdog0
[57.375134] [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]
[57.379670] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.381934] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.386229] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[57.504488] Starting subtest: fbcpsr-rgb565-draw-render
[64.448820] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.947s)
[64.602169] [002/133] (953s left) dumb_buffer (create-valid-dumb)
[64.646848] Starting subtest: create-valid-dumb
[64.648727] Subtest create-valid-dumb: SUCCESS (0.000s)
[64.732646] [003/133] (953s left) gem_mmap_gtt (basic-write-gtt)
[64.784823] Subtest basic-write-gtt: SKIP (0.000s)
[64.865423] [004/133] (953s left) kms_psr (pr-cursor-render)
[64.951285] Starting subtest: pr-cursor-render
[64.955277] Subtest pr-cursor-render: SKIP (0.000s)
[65.025404] [005/133] (953s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[65.114870] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[66.160431] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s)
[66.291827] [006/133] (951s left) kms_vblank (query-forked-busy)
[66.397345] Starting subtest: query-forked-busy
[66.399394] Starting dynamic subtest: pipe-A-eDP-1
[68.281954] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[68.296701] Starting dynamic subtest: pipe-D-eDP-1
[70.863577] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[70.865544] Subtest query-forked-busy: SUCCESS (4.468s)
[71.647073] [007/133] (946s left) kms_lease (lease-revoke)
[71.733061] Starting subtest: lease-revoke
[71.735361] Starting dynamic subtest: pipe-A-eDP-1
[71.761484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[71.771750] Starting dynamic subtest: pipe-B-eDP-1
[71.788257] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[71.796229] Starting dynamic subtest: pipe-C-eDP-1
[71.814775] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[71.822629] Starting dynamic subtest: pipe-D-eDP-1
[71.844739] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[71.846639] Subtest lease-revoke: SUCCESS (0.112s)
[71.957185] [008/133] (946s left) i915_hangman (engine-engine-error)
[72.027477] Starting subtest: engine-engine-error
[72.029754] Starting dynamic subtest: rcs0
[73.912474] Dynamic subtest rcs0: SUCCESS (1.884s)
[73.923827] Starting dynamic subtest: bcs0
[75.892566] Dynamic subtest bcs0: SUCCESS (1.979s)
[75.902655] Starting dynamic subtest: vcs0
[77.877045] Dynamic subtest vcs0: SUCCESS (1.983s)
[77.888677] Starting dynamic subtest: vcs1
[79.861327] Dynamic subtest vcs1: SUCCESS (1.983s)
[79.872240] Starting dynamic subtest: vecs0
[81.843865] Dynamic subtest vecs0: SUCCESS (1.981s)
[81.856103] Starting dynamic subtest: ccs0
[83.891163] Dynamic subtest ccs0: SUCCESS (2.046s)
[83.893673] Subtest engine-engine-error: SUCCESS (11.863s)
[83.965944] [009/133] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[84.060782] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[90.753157] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.695s)
[90.874464] [010/133] (927s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[91.004714] Starting subtest: extended-modeset-hang-newfb-with-reset
[91.007046] Starting dynamic subtest: pipe-A
[104.907611] Dynamic subtest pipe-A: SUCCESS (13.903s)
[104.919296] Starting dynamic subtest: pipe-D
[120.994273] Dynamic subtest pipe-D: SUCCESS (16.085s)
[120.996698] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.991s)
[121.795068] [011/133] (896s left) perf_pmu (faulting-read)
[121.841503] Starting subtest: faulting-read
[121.843736] Starting dynamic subtest: wb
[121.846052] Dynamic subtest wb: SUCCESS (0.001s)
[121.854070] Starting dynamic subtest: wc
[121.856175] Dynamic subtest wc: SUCCESS (0.000s)
[121.863648] Starting dynamic subtest: uc
[121.865749] Dynamic subtest uc: SUCCESS (0.000s)
[121.867928] Subtest faulting-read: SUCCESS (0.002s)
[121.956749] [012/133] (896s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[122.344693] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[123.119408] [013/133] (895s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[123.218859] Starting subtest: plane-upscale-20x20-with-modifiers
[123.221199] Starting dynamic subtest: pipe-A
[123.557633] Dynamic subtest pipe-A: SUCCESS (0.338s)
[123.568660] Starting dynamic subtest: pipe-B
[124.939186] Dynamic subtest pipe-B: SUCCESS (1.384s)
[124.948270] Starting dynamic subtest: pipe-C
[126.366647] Dynamic subtest pipe-C: SUCCESS (1.425s)
[126.377674] Starting dynamic subtest: pipe-D
[127.791627] Dynamic subtest pipe-D: SUCCESS (1.426s)
[127.793991] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.576s)
[128.956682] [014/133] (889s left) syncobj_timeline (etime-multi-wait-submitted)
[129.005236] Starting subtest: etime-multi-wait-submitted
[129.113804] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[129.186971] [015/133] (889s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[129.278693] Starting subtest: primary-yf-tiled-reflect-x-270
[129.283263] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[129.354097] [016/133] (889s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[129.450183] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[129.454810] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[130.584015] [017/133] (887s left) gem_mmap_gtt (bad-object)
[130.644714] Subtest bad-object: SKIP (0.000s)
[130.708367] [018/133] (887s left) gem_softpin (noreloc-s3)
[130.768520] Starting subtest: noreloc-S3
[149.731798] Subtest noreloc-S3: SUCCESS (5.412s)
[149.846105] [019/133] (868s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[150.122820] Starting subtest: cursor-rapid-movement-512x512
[150.128490] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[150.295683] [020/133] (868s left) kms_hdmi_inject (inject-4k)
[150.630577] Starting subtest: inject-4k
[150.944077] Subtest inject-4k: SUCCESS (0.314s)
[151.499106] [021/133] (867s left) gem_wait (invalid-flags)
[151.566377] Starting subtest: invalid-flags
[151.568895] Subtest invalid-flags: SUCCESS (0.000s)
[151.768488] [022/133] (866s left) kms_invalid_mode (bad-vsync-end)
[151.861501] Starting subtest: bad-vsync-end
[151.864218] Starting dynamic subtest: pipe-A-eDP-1
[152.149486] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[152.159840] Starting dynamic subtest: pipe-B-eDP-1
[152.162739] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[152.171618] Starting dynamic subtest: pipe-C-eDP-1
[152.174605] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[152.183323] Starting dynamic subtest: pipe-D-eDP-1
[152.185966] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[152.188804] Subtest bad-vsync-end: SUCCESS (0.292s)
[152.969061] [023/133] (865s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[153.113985] Starting subtest: dp-mst-type-1-suspend-resume
[153.119834] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[153.219240] [024/133] (865s left) kms_pm_rpm (drm-resources-equal)
[154.754736] Starting subtest: drm-resources-equal
[160.112598] Subtest drm-resources-equal: SUCCESS (5.359s)
[160.197571] [025/133] (858s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[160.299795] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[161.364900] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.067s)
[161.491082] [026/133] (857s left) gem_readwrite (new-obj)
[161.553283] Subtest new-obj: SKIP (0.000s)
[161.616585] [027/133] (857s left) kms_psr (psr2-cursor-plane-onoff)
[161.707069] Starting subtest: psr2-cursor-plane-onoff
[161.709470] Starting dynamic subtest: eDP-1
[163.429851] Dynamic subtest eDP-1: SUCCESS (1.723s)
[163.432617] Subtest psr2-cursor-plane-onoff: SUCCESS (1.723s)
[164.268198] [028/133] (854s left) sriov_basic (enable-vfs-autoprobe-off)
[164.328717] Starting subtest: enable-vfs-autoprobe-off
[164.331457] Starting dynamic subtest: numvfs-1
[164.422234] Dynamic subtest numvfs-1: FAIL (0.033s)
[164.430650] Starting dynamic subtest: numvfs-2
[164.506012] Dynamic subtest numvfs-2: FAIL (0.003s)
[164.514658] Starting dynamic subtest: numvfs-3
[164.591122] Dynamic subtest numvfs-3: FAIL (0.004s)
[164.599663] Starting dynamic subtest: numvfs-4
[164.677036] Dynamic subtest numvfs-4: FAIL (0.003s)
[164.685297] Starting dynamic subtest: numvfs-5
[164.761529] Dynamic subtest numvfs-5: FAIL (0.003s)
[164.770247] Starting dynamic subtest: numvfs-6
[164.847627] Dynamic subtest numvfs-6: FAIL (0.004s)
[164.856785] Starting dynamic subtest: numvfs-7
[164.940634] Dynamic subtest numvfs-7: FAIL (0.004s)
[164.952790] Starting dynamic subtest: numvfs-random
[165.038685] Dynamic subtest numvfs-random: FAIL (0.003s)
[165.048836] Starting dynamic subtest: numvfs-all
[165.134628] Dynamic subtest numvfs-all: FAIL (0.537s)
[165.137152] Subtest enable-vfs-autoprobe-off: FAIL (0.599s)
[165.174393] [029/133] (853s left) drm_read (fault-buffer)
[165.313080] Starting subtest: fault-buffer
[165.315183] Subtest fault-buffer: SUCCESS (0.000s)
[165.440702] [030/133] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[165.537537] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[165.541470] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[165.629188] [031/133] (853s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[165.721221] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[165.725569] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[165.794709] [032/133] (853s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[165.846402] Starting subtest: multi-wait-available-unsubmitted-signaled
[165.848514] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[165.934753] [033/133] (853s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[166.029597] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[172.638532] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.611s)
[172.779456] [034/133] (846s left) gem_eio (in-flight-suspend)
[173.015238] Starting subtest: in-flight-suspend
[215.770788] Subtest in-flight-suspend: SUCCESS (13.408s)
[215.913662] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[215.917151] [035/133] (803s left) kms_flip (bo-too-big)
[216.021883] Starting subtest: bo-too-big
[216.024025] Starting dynamic subtest: A-eDP1
[217.292183] Dynamic subtest A-eDP1: SUCCESS (1.271s)
[217.303929] Starting dynamic subtest: B-eDP1
[218.583115] Dynamic subtest B-eDP1: SUCCESS (1.289s)
[218.598989] Starting dynamic subtest: C-eDP1
[219.898804] Dynamic subtest C-eDP1: SUCCESS (1.309s)
[219.908351] Starting dynamic subtest: D-eDP1
[221.182436] Dynamic subtest D-eDP1: SUCCESS (1.281s)
[221.187344] Subtest bo-too-big: SUCCESS (5.164s)
[222.400047] [036/133] (796s left) api_intel_bb (blit-reloc-keep-cache)
[222.450218] Starting subtest: blit-reloc-keep-cache
[222.454599] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[222.562591] [037/133] (796s left) kms_rotation_crc (multiplane-rotation)
[222.649023] Starting subtest: multiplane-rotation
[240.277564] Subtest multiplane-rotation: SUCCESS (17.627s)
[240.391282] [038/133] (779s left) perf (non-zero-reason)
[240.528257] Starting subtest: non-zero-reason
[240.530090] Starting dynamic subtest: 0-rcs0
[245.897002] Dynamic subtest 0-rcs0: SUCCESS (5.366s)
[245.909552] Starting dynamic subtest: 1-vecs0
[249.781011] Dynamic subtest 1-vecs0: SUCCESS (3.883s)
[249.783715] Subtest non-zero-reason: SUCCESS (9.251s)
[249.835692] [039/133] (769s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[249.950059] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[250.940501] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[251.063275] [040/133] (768s left) gem_exec_whisper (basic-normal)
[251.137845] Starting subtest: basic-normal
[256.551213] Subtest basic-normal: SUCCESS (5.413s)
[256.742490] [041/133] (762s left) gem_exec_reloc (basic-write-cpu-noreloc)
[256.818072] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[256.882606] [042/133] (762s left) kms_flip (2x-nonexisting-fb-interruptible)
[256.989894] Starting subtest: 2x-nonexisting-fb-interruptible
[257.002346] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[257.077953] [043/133] (762s left) kms_psr (fbc-pr-primary-mmap-cpu)
[257.183227] Starting subtest: fbc-pr-primary-mmap-cpu
[257.187307] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[257.267763] [044/133] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[257.364301] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[257.368698] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[257.455377] [045/133] (762s left) vgem_basic (sysfs)
[257.496922] Starting subtest: sysfs
[257.499075] Subtest sysfs: SUCCESS (0.000s)
[257.553488] [046/133] (762s left) kms_cursor_crc (cursor-alpha-opaque)
[257.647843] Starting subtest: cursor-alpha-opaque
[257.650118] Starting dynamic subtest: pipe-A-eDP-1
[258.244862] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[258.257895] Starting dynamic subtest: pipe-D-eDP-1
[259.511400] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.266s)
[259.513506] Subtest cursor-alpha-opaque: SUCCESS (1.866s)
[260.366833] [047/133] (759s left) kms_psr (fbc-psr2-primary-render)
[260.463685] Starting subtest: fbc-psr2-primary-render
[260.465967] Starting dynamic subtest: eDP-1
[260.470318] Dynamic subtest eDP-1: SKIP (0.000s)
[260.474798] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[260.554012] [048/133] (759s left) kms_chamelium_color (ctm-0-25)
[260.649986] Subtest ctm-0-25: SKIP (0.000s)
[260.696416] [049/133] (759s left) gem_ctx_shared (q-promotion)
[260.760471] Starting subtest: Q-promotion
[260.762776] Starting dynamic subtest: rcs0
[260.878674] Dynamic subtest rcs0: SUCCESS (0.116s)
[260.897720] Starting dynamic subtest: vcs0
[260.969389] Dynamic subtest vcs0: SUCCESS (0.091s)
[260.987588] Starting dynamic subtest: vcs1
[261.049054] Dynamic subtest vcs1: SUCCESS (0.079s)
[261.066202] Starting dynamic subtest: vecs0
[261.129234] Dynamic subtest vecs0: SUCCESS (0.079s)
[261.144309] Starting dynamic subtest: ccs0
[261.230108] Dynamic subtest ccs0: SUCCESS (0.100s)
[261.232609] Subtest Q-promotion: SUCCESS (0.470s)
[262.895475] [050/133] (757s left) core_debugfs (read-all-entries)
[262.954869] Starting subtest: read-all-entries
[263.047313] Subtest read-all-entries: SUCCESS (0.094s)
[263.113990] [051/133] (756s left) perf (whitelisted-registers-userspace-config)
[263.202132] Starting subtest: whitelisted-registers-userspace-config
[263.204479] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[263.248837] [052/133] (756s left) kms_big_fb (4-tiled-addfb)
[263.339482] Starting subtest: 4-tiled-addfb
[263.341793] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[263.444737] [053/133] (756s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[263.532413] Starting subtest: dsc-fractional-bpp-with-bpc
[263.561830] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[263.617178] [054/133] (756s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[263.722794] Starting subtest: fbcpsr-suspend
[304.126933] Subtest fbcpsr-suspend: SUCCESS (10.207s)
[304.243026] [055/133] (715s left) gem_ctx_persistence (engines-queued)
[304.304411] Starting subtest: engines-queued
[304.307569] Starting dynamic subtest: rcs0
[304.349504] Dynamic subtest rcs0: SUCCESS (0.045s)
[304.360521] Starting dynamic subtest: bcs0
[304.415910] Dynamic subtest bcs0: SUCCESS (0.065s)
[304.427913] Starting dynamic subtest: vcs0
[305.975034] Dynamic subtest vcs0: SUCCESS (1.556s)
[305.988616] Starting dynamic subtest: vcs1
[307.956977] Dynamic subtest vcs1: SUCCESS (1.977s)
[307.970698] Starting dynamic subtest: vecs0
[309.941069] Dynamic subtest vecs0: SUCCESS (1.980s)
[309.953723] Starting dynamic subtest: ccs0
[310.120680] Dynamic subtest ccs0: SUCCESS (0.178s)
[310.123405] Subtest engines-queued: SUCCESS (5.813s)
[310.245668] [056/133] (709s left) gem_exec_params (invalid-flag)
[310.306270] Starting subtest: invalid-flag
[310.308872] Subtest invalid-flag: SUCCESS (0.000s)
[310.399622] [057/133] (709s left) perf (non-system-wide-paranoid)
[310.501779] Starting subtest: non-system-wide-paranoid
[310.527632] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[310.573723] [058/133] (709s left) kms_atomic (atomic-plane-damage)
[310.669646] Starting subtest: atomic-plane-damage
[310.718713] Starting dynamic subtest: pipe-A-eDP-1
[311.268918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.550s)
[311.271691] Subtest atomic-plane-damage: SUCCESS (0.600s)
[312.057984] [059/133] (708s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[312.158970] Starting subtest: plane-lut1d-pre-ctm3x4
[312.317404] Starting dynamic subtest: pipe-A-plane-0
[312.710932] Dynamic subtest pipe-A-plane-0: FAIL (0.179s)
[312.721220] Starting dynamic subtest: pipe-A-plane-1
[312.974435] Dynamic subtest pipe-A-plane-1: FAIL (0.161s)
[312.985707] Starting dynamic subtest: pipe-A-plane-2
[313.231643] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[314.011918] Starting dynamic subtest: pipe-B-plane-0
[314.471032] Dynamic subtest pipe-B-plane-0: FAIL (0.153s)
[314.481312] Starting dynamic subtest: pipe-B-plane-1
[314.826146] Dynamic subtest pipe-B-plane-1: FAIL (0.165s)
[314.837242] Starting dynamic subtest: pipe-B-plane-2
[315.181398] Dynamic subtest pipe-B-plane-2: FAIL (0.683s)
[316.233077] Starting dynamic subtest: pipe-C-plane-0
[316.793650] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[316.804321] Starting dynamic subtest: pipe-C-plane-1
[317.238901] Dynamic subtest pipe-C-plane-1: FAIL (0.692s)
[317.248522] Starting dynamic subtest: pipe-C-plane-2
[317.677645] Dynamic subtest pipe-C-plane-2: FAIL (0.151s)
[318.441274] Starting dynamic subtest: pipe-D-plane-0
[319.105508] Dynamic subtest pipe-D-plane-0: FAIL (0.144s)
[319.116408] Starting dynamic subtest: pipe-D-plane-1
[319.623377] Dynamic subtest pipe-D-plane-1: FAIL (0.712s)
[319.634329] Starting dynamic subtest: pipe-D-plane-2
[320.163941] Dynamic subtest pipe-D-plane-2: FAIL (0.618s)
[320.206364] Subtest plane-lut1d-pre-ctm3x4: FAIL (8.046s)
[321.051287] [060/133] (699s left) gem_wait (await)
[321.129895] Starting subtest: await
[321.132542] Starting dynamic subtest: all-engines
[322.244876] Dynamic subtest all-engines: SUCCESS (1.114s)
[322.264368] Starting dynamic subtest: rcs0
[323.322028] Dynamic subtest rcs0: SUCCESS (1.073s)
[323.337917] Starting dynamic subtest: bcs0
[324.385544] Dynamic subtest bcs0: SUCCESS (1.061s)
[324.403816] Starting dynamic subtest: vcs0
[325.445567] Dynamic subtest vcs0: SUCCESS (1.057s)
[325.462487] Starting dynamic subtest: vcs1
[326.502373] Dynamic subtest vcs1: SUCCESS (1.054s)
[326.519167] Starting dynamic subtest: vecs0
[327.562497] Dynamic subtest vecs0: SUCCESS (1.058s)
[327.579882] Starting dynamic subtest: ccs0
[328.624453] Dynamic subtest ccs0: SUCCESS (1.059s)
[328.627346] Subtest await: SUCCESS (7.493s)
[328.844320] [061/133] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[328.948968] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[332.492297] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.544s)
[333.681817] [062/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[333.791210] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[333.796543] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[333.885289] [063/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[333.981336] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[340.607266] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.627s)
[340.740761] [064/133] (679s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[340.841890] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[344.525787] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.687s)
[345.678220] [065/133] (674s left) gem_mmap_wc (write)
[345.736385] Subtest write: SKIP (0.000s)
[345.796312] [066/133] (674s left) gem_exec_schedule (preempt-self)
[345.871263] Starting subtest: preempt-self
[345.873864] Starting dynamic subtest: rcs0
[345.880040] Dynamic subtest rcs0: SUCCESS (0.020s)
[345.890697] Starting dynamic subtest: bcs0
[345.901001] Dynamic subtest bcs0: SUCCESS (0.020s)
[345.914006] Starting dynamic subtest: vcs0
[345.919408] Dynamic subtest vcs0: SUCCESS (0.018s)
[345.930135] Starting dynamic subtest: vcs1
[345.935819] Dynamic subtest vcs1: SUCCESS (0.016s)
[345.945391] Starting dynamic subtest: vecs0
[345.952004] Dynamic subtest vecs0: SUCCESS (0.016s)
[345.961234] Starting dynamic subtest: ccs0
[345.975629] Dynamic subtest ccs0: SUCCESS (0.022s)
[345.978407] Subtest preempt-self: SUCCESS (0.116s)
[347.068130] [067/133] (673s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[347.161264] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[347.163777] Starting dynamic subtest: A-eDP1
[350.802419] Dynamic subtest A-eDP1: SUCCESS (3.635s)
[350.811706] Starting dynamic subtest: B-eDP1
[354.085403] Dynamic subtest B-eDP1: SUCCESS (3.284s)
[354.096131] Starting dynamic subtest: C-eDP1
[357.405272] Dynamic subtest C-eDP1: SUCCESS (3.319s)
[357.415473] Starting dynamic subtest: D-eDP1
[360.698443] Dynamic subtest D-eDP1: SUCCESS (3.291s)
[360.701338] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.536s)
[361.564254] [068/133] (659s left) sysfs_defaults (readonly)
[361.631178] Starting subtest: readonly
[361.633514] Starting dynamic subtest: vecs0
[361.636615] Dynamic subtest vecs0: SUCCESS (0.000s)
[361.646432] Starting dynamic subtest: ccs0
[361.648524] Dynamic subtest ccs0: SUCCESS (0.000s)
[361.657712] Starting dynamic subtest: vcs0
[361.660291] Dynamic subtest vcs0: SUCCESS (0.000s)
[361.669530] Starting dynamic subtest: bcs0
[361.671959] Dynamic subtest bcs0: SUCCESS (0.000s)
[361.680918] Starting dynamic subtest: rcs0
[361.683262] Dynamic subtest rcs0: SUCCESS (0.000s)
[361.692662] Starting dynamic subtest: vcs1
[361.695391] Dynamic subtest vcs1: SUCCESS (0.000s)
[361.697891] Subtest readonly: SUCCESS (0.006s)
[361.747271] [069/133] (658s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[362.122959] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[362.946171] [070/133] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[363.054490] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[363.059901] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[363.159154] [071/133] (657s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[363.258620] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[363.261495] Starting dynamic subtest: pipe-A-eDP-1
[363.729185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[363.740361] Starting dynamic subtest: pipe-B-eDP-1
[365.134651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[365.144228] Starting dynamic subtest: pipe-C-eDP-1
[366.511345] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[366.524151] Starting dynamic subtest: pipe-D-eDP-1
[367.957083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.442s)
[367.959634] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.667s)
[369.185519] [072/133] (651s left) gem_mmap (big-bo)
[369.248303] Subtest big-bo: SKIP (0.000s)
[369.309812] [073/133] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[369.419429] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[369.424472] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[369.529468] [074/133] (651s left) syncobj_timeline (invalid-query-illegal-handle)
[369.596370] Starting subtest: invalid-query-illegal-handle
[369.599063] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[369.703554] [075/133] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[369.800101] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[374.230101] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.432s)
[375.379264] [076/133] (645s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[375.463084] Starting subtest: psr-dirtyfb-ioctl
[375.465429] Starting dynamic subtest: A-eDP-1
[379.419439] Dynamic subtest A-eDP-1: SUCCESS (3.953s)
[379.422307] Subtest psr-dirtyfb-ioctl: SUCCESS (3.955s)
[380.270265] [077/133] (640s left) gem_exec_balancer (invalid-bonds)
[380.325143] Starting subtest: invalid-bonds
[380.330433] Subtest invalid-bonds: SKIP (0.000s)
[380.625176] [078/133] (640s left) syncobj_basic (create-signaled)
[380.683673] Starting subtest: create-signaled
[380.686135] Subtest create-signaled: SUCCESS (0.000s)
[380.789199] [079/133] (640s left) i915_drm_fdinfo (busy-idle-check-all)
[380.832359] Starting subtest: busy-idle-check-all
[380.838246] Starting dynamic subtest: rcs0
[380.843660] Dynamic subtest rcs0: SKIP (0.005s)
[380.856134] Starting dynamic subtest: bcs0
[380.860995] Dynamic subtest bcs0: SKIP (0.000s)
[380.874170] Starting dynamic subtest: vcs0
[380.879255] Dynamic subtest vcs0: SKIP (0.000s)
[380.888657] Starting dynamic subtest: vcs1
[380.894129] Dynamic subtest vcs1: SKIP (0.000s)
[380.903305] Starting dynamic subtest: vecs0
[380.908482] Dynamic subtest vecs0: SKIP (0.000s)
[380.918290] Starting dynamic subtest: ccs0
[380.923380] Dynamic subtest ccs0: SKIP (0.000s)
[380.928578] Subtest busy-idle-check-all: SKIP (0.010s)
[380.967514] [080/133] (640s left) i915_query (query-topology-coherent-slice-mask)
[381.042451] Starting subtest: query-topology-coherent-slice-mask
[381.047666] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[381.131567] [081/133] (640s left) i915_selftest (perf)
[382.896933] Starting subtest: perf
[382.899347] Starting dynamic subtest: engine_cs
[386.494545] Dynamic subtest engine_cs: SUCCESS (3.596s)
[386.504458] Starting dynamic subtest: request
[392.675768] Dynamic subtest request: SUCCESS (6.178s)
[392.688615] Starting dynamic subtest: migrate
[397.876807] Dynamic subtest migrate: SUCCESS (5.198s)
[397.886627] Starting dynamic subtest: region
[402.983962] Dynamic subtest region: SUCCESS (5.103s)
[402.987310] Subtest perf: SUCCESS (20.083s)
[403.021273] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[403.022373] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[403.026254] [082/133] (618s left) kms_prop_blob (invalid-set-prop)
[405.376679] Starting subtest: invalid-set-prop
[405.380142] Subtest invalid-set-prop: SUCCESS (0.000s)
[405.465801] [FACT kms_prop_blob (invalid-set-prop)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[405.467214] [FACT kms_prop_blob (invalid-set-prop)] new: kernel.kmod_is_loaded.i915: true
[405.471541] [083/133] (615s left) gem_softpin (allocator-basic)
[405.540474] Starting subtest: allocator-basic
[405.609968] Subtest allocator-basic: SUCCESS (0.069s)
[405.737788] [084/133] (615s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[405.831482] Starting subtest: pr-overlay-plane-move-continuous-sf
[405.836371] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[405.896670] [085/133] (615s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[405.995004] Starting subtest: basic-modeset-with-all-modifiers-formats
[406.372383] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[407.122165] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.750s)
[407.131879] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[407.143132] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[407.154697] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[407.164676] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[407.174117] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[407.320857] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[407.329723] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[407.343163] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[407.351834] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[407.365233] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[407.373684] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[407.388465] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[407.403533] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[407.409881] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.020s)
[407.419543] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[407.432199] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[407.440947] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[407.454342] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[407.463582] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[407.476486] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[407.485379] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[407.498573] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[407.507364] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[407.654421] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[407.669656] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[407.676379] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[407.684968] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[407.698748] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[407.707634] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[407.721256] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[407.733279] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[407.743445] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[407.751813] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[407.765374] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.020s)
[407.774321] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[407.787583] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[407.796284] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[407.810076] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[407.819416] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[407.832018] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[407.841294] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[407.999474] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[408.010557] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[408.020993] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[408.029624] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[408.043576] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[408.056505] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[408.065946] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[408.077417] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[408.087916] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.020s)
[408.096798] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[408.110113] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[408.118837] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[408.132107] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[408.140511] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[408.154289] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[408.165146] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[408.177012] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[408.564221] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.566s)
[409.406160] [086/133] (612s left) kms_universal_plane (disable-primary-vs-flip)
[409.498510] Starting subtest: disable-primary-vs-flip
[409.501281] Starting dynamic subtest: pipe-A-eDP-1
[411.020116] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[411.031360] Starting dynamic subtest: pipe-B-eDP-1
[413.250492] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.232s)
[413.261091] Starting dynamic subtest: pipe-C-eDP-1
[415.420672] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.167s)
[415.430263] Starting dynamic subtest: pipe-D-eDP-1
[417.599334] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.178s)
[417.602108] Subtest disable-primary-vs-flip: SUCCESS (8.102s)
[418.390970] [087/133] (603s left) perf (invalid-open-flags)
[418.520935] Starting subtest: invalid-open-flags
[418.523300] Subtest invalid-open-flags: SUCCESS (0.000s)
[418.576611] [088/133] (602s left) gem_workarounds (suspend-resume-context)
[418.650268] Starting subtest: suspend-resume-context
[434.604369] Subtest suspend-resume-context: SUCCESS (1.997s)
[434.746683] [089/133] (586s left) kms_plane_multiple (tiling-x)
[434.849487] Starting subtest: tiling-x
[434.851469] Starting dynamic subtest: pipe-A-eDP-1
[438.537015] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.688s)
[438.548237] Starting dynamic subtest: pipe-B-eDP-1
[442.878988] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.340s)
[442.888790] Starting dynamic subtest: pipe-C-eDP-1
[447.209899] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.328s)
[447.218986] Starting dynamic subtest: pipe-D-eDP-1
[451.554628] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[451.556528] Subtest tiling-x: SUCCESS (16.702s)
[452.358117] [090/133] (569s left) kms_pipe_crc_basic (suspend-read-crc)
[452.453811] Starting subtest: suspend-read-crc
[452.455833] Starting dynamic subtest: pipe-A-eDP-1
[470.407676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.506s)
[470.417754] Starting dynamic subtest: pipe-B-eDP-1
[488.425030] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.093s)
[488.435154] Starting dynamic subtest: pipe-C-eDP-1
[506.370528] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.032s)
[506.380232] Starting dynamic subtest: pipe-D-eDP-1
[524.371333] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.070s)
[524.374408] Subtest suspend-read-crc: SUCCESS (11.706s)
[525.218724] [091/133] (496s left) fbdev (write)
[525.286433] Starting subtest: write
[525.642913] Subtest write: SUCCESS (0.358s)
[525.717862] [092/133] (496s left) syncobj_wait (reset-unsignaled)
[525.769473] Starting subtest: reset-unsignaled
[525.772044] Subtest reset-unsignaled: SUCCESS (0.000s)
[525.866767] [093/133] (495s left) gem_mmap_gtt (basic-read)
[525.930753] Subtest basic-read: SKIP (0.000s)
[525.994795] [094/133] (495s left) gem_exec_fence (basic-busy)
[526.174101] Starting subtest: basic-busy
[526.177221] Starting dynamic subtest: rcs0
[526.255373] Dynamic subtest rcs0: SUCCESS (0.080s)
[526.267475] Starting dynamic subtest: bcs0
[526.312750] Dynamic subtest bcs0: SUCCESS (0.055s)
[526.324511] Starting dynamic subtest: vcs0
[526.374159] Dynamic subtest vcs0: SUCCESS (0.059s)
[526.386596] Starting dynamic subtest: vcs1
[526.429477] Dynamic subtest vcs1: SUCCESS (0.053s)
[526.442285] Starting dynamic subtest: vecs0
[526.486305] Dynamic subtest vecs0: SUCCESS (0.055s)
[526.497043] Starting dynamic subtest: ccs0
[526.547987] Dynamic subtest ccs0: SUCCESS (0.059s)
[526.550991] Subtest basic-busy: SUCCESS (0.375s)
[528.191553] [095/133] (493s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[528.302238] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[528.304626] Starting dynamic subtest: pipe-A-eDP-1
[528.329401] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.338864] Starting dynamic subtest: pipe-B-eDP-1
[528.362588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.371452] Starting dynamic subtest: pipe-C-eDP-1
[528.396735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.405228] Starting dynamic subtest: pipe-D-eDP-1
[528.428800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.433176] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[530.507032] [096/133] (491s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[530.571613] Subtest tiled-to-untiled: SKIP (0.000s)
[530.652043] [097/133] (491s left) syncobj_wait (single-wait-for-submit-submitted)
[530.708807] Starting subtest: single-wait-for-submit-submitted
[530.809231] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[530.900171] [098/133] (491s left) kms_hdr (invalid-hdr)
[531.008473] Starting subtest: invalid-hdr
[533.102487] Starting dynamic subtest: pipe-A-eDP-1
[535.978398] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.874s)
[535.981547] Subtest invalid-hdr: SUCCESS (4.970s)
[536.087476] [099/133] (485s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[536.179422] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[536.185116] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[536.249976] [100/133] (485s left) gem_exec_params (invalid-bsd1-flag-on-render)
[536.314318] Starting subtest: invalid-bsd1-flag-on-render
[536.317151] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[536.397827] [101/133] (485s left) gem_exec_fence (syncobj-signal)
[536.807271] Starting subtest: syncobj-signal
[536.814371] Subtest syncobj-signal: SUCCESS (0.006s)
[538.250859] [102/133] (483s left) i915_pm_rps (fence-order)
[538.309495] Starting subtest: fence-order
[541.155825] Subtest fence-order: SUCCESS (2.842s)
[541.283403] [103/133] (480s left) gem_mmap_offset (partial-remap)
[541.334777] Starting subtest: partial-remap
[541.337318] Starting dynamic subtest: smem0
[541.349251] Dynamic subtest smem0: SUCCESS (0.007s)
[541.352048] Subtest partial-remap: SUCCESS (0.007s)
[541.462075] [104/133] (480s left) gem_exec_fence (syncobj-timeline-signal)
[542.008595] Starting subtest: syncobj-timeline-signal
[542.022670] Subtest syncobj-timeline-signal: SUCCESS (0.015s)
[543.228931] [105/133] (479s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[543.338272] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[547.972546] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.636s)
[549.144537] [106/133] (473s left) kms_prime (basic-crc-hybrid)
[549.243161] Subtest basic-crc-hybrid: SKIP (0.000s)
[549.358879] [107/133] (473s left) kms_flip (2x-absolute-wf_vblank)
[549.461498] Starting subtest: 2x-absolute-wf_vblank
[549.469976] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[549.553322] [108/133] (472s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[549.650501] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[549.655334] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[549.748144] [109/133] (472s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[549.799325] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[549.803712] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[549.989856] [110/133] (472s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[550.080485] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[550.082947] Starting dynamic subtest: pipe-A-default-mode
[552.794319] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[552.796805] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.712s)
[553.628200] [111/133] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[553.740629] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[553.746154] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[553.830840] [112/133] (468s left) gem_pread (self)
[553.892112] Subtest self: SKIP (0.000s)
[553.948915] [113/133] (468s left) gen7_exec_parse (chained-batch)
[554.022260] Subtest chained-batch: SKIP (0.000s)
[554.101870] [114/133] (468s left) gem_ctx_engines (execute-allforone)
[554.156046] Starting subtest: execute-allforone
[554.172262] Subtest execute-allforone: SUCCESS (0.016s)
[556.243492] [115/133] (466s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[556.358521] Starting subtest: y-tiled-8bpp-rotate-180
[556.363511] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[556.456940] [116/133] (466s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[556.526249] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[556.625948] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[556.716245] [117/133] (466s left) gem_ctx_persistence (idempotent)
[556.773432] Starting subtest: idempotent
[556.776323] Subtest idempotent: SUCCESS (0.000s)
[556.880361] [118/133] (465s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[556.967355] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[556.970248] Starting dynamic subtest: pipe-A-eDP-1
[556.993820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[557.005905] Starting dynamic subtest: pipe-B-eDP-1
[557.028033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[557.036514] Starting dynamic subtest: pipe-C-eDP-1
[557.059405] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[557.068084] Starting dynamic subtest: pipe-D-eDP-1
[557.091396] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[557.093836] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[559.218909] [119/133] (463s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[559.317120] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[559.319468] Starting dynamic subtest: pipe-A
[560.571111] Dynamic subtest pipe-A: SUCCESS (1.252s)
[560.581088] Starting dynamic subtest: pipe-B
[562.966324] Dynamic subtest pipe-B: SUCCESS (2.395s)
[562.975802] Starting dynamic subtest: pipe-C
[564.138401] Dynamic subtest pipe-C: SUCCESS (1.170s)
[564.152311] Starting dynamic subtest: pipe-D
[565.356911] Dynamic subtest pipe-D: SUCCESS (1.216s)
[565.359291] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.039s)
[566.573533] [120/133] (456s left) gem_exec_gttfill (basic)
[566.641428] Starting subtest: basic
[569.318463] Subtest basic: SUCCESS (2.675s)
[569.518080] [121/133] (453s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[569.676299] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[569.681337] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[569.771061] [122/133] (453s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[569.874473] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[569.879398] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[569.961915] [123/133] (453s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[570.049379] Starting subtest: multi-wait-all-for-submit-unsubmitted
[570.153069] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[570.242361] [124/133] (452s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[570.329115] Starting subtest: fbc-psr2-sprite-mmap-gtt
[570.331462] Starting dynamic subtest: eDP-1
[570.336388] Dynamic subtest eDP-1: SKIP (0.000s)
[570.341869] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[570.416213] [125/133] (452s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[570.478563] Starting subtest: yf-tiled-ccs-to-yf-tiled
[570.484331] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[570.658456] [126/133] (452s left) gem_exec_schedule (noreorder-corked)
[570.833199] Starting subtest: noreorder-corked
[570.836074] Starting dynamic subtest: rcs0
[571.970744] Dynamic subtest rcs0: SUCCESS (1.138s)
[571.981363] Starting dynamic subtest: vcs0
[573.197488] Dynamic subtest vcs0: SUCCESS (1.224s)
[573.210747] Starting dynamic subtest: vcs1
[575.171906] Dynamic subtest vcs1: SUCCESS (1.970s)
[575.186175] Starting dynamic subtest: vecs0
[577.162258] Dynamic subtest vecs0: SUCCESS (1.986s)
[577.174802] Starting dynamic subtest: ccs0
[578.312026] Dynamic subtest ccs0: SUCCESS (1.148s)
[578.315195] Subtest noreorder-corked: SUCCESS (7.477s)
[578.516121] [127/133] (444s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[578.570795] Starting subtest: single-wait-all-for-submit-available-submitted
[578.573427] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[578.669869] [128/133] (444s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[578.800257] Starting subtest: cursorB-vs-flipA-varying-size
[578.805418] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[578.945010] [129/133] (444s left) syncobj_wait (single-wait-signaled)
[578.998414] Starting subtest: single-wait-signaled
[579.001097] Subtest single-wait-signaled: SUCCESS (0.000s)
[579.095530] [130/133] (444s left) gem_lmem_swapping (heavy-verify-random-ccs)
[579.148097] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[579.191489] [131/133] (444s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[579.291340] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[579.296298] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[579.394463] [132/133] (444s left) gem_exec_flush (basic-wb-ro-before-default)
[579.460232] Starting subtest: basic-wb-ro-before-default
[584.935421] Subtest basic-wb-ro-before-default: SUCCESS (5.472s)
[585.131082] [133/133] (438s left) kms_cursor_edge_walk (128x128-right-edge)
[585.229338] Starting subtest: 128x128-right-edge
[585.232178] Starting dynamic subtest: pipe-A-eDP-1
[588.735379] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[588.756112] Starting dynamic subtest: pipe-D-eDP-1
[591.851010] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[591.854346] Subtest 128x128-right-edge: SUCCESS (6.620s)
[592.668842] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: dumb_buffer
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: i915_hangman
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_busy
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_hdmi_inject
results: parsing output: 20/ for test: gem_wait
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_readwrite
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: sriov_basic
results: parsing output: 28/ for test: drm_read
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_rotation_crc
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: vgem_basic
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_chamelium_color
results: parsing output: 48/ for test: gem_ctx_shared
results: parsing output: 49/ for test: core_debugfs
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_dsc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_ctx_persistence
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: kms_color_pipeline
results: parsing output: 59/ for test: gem_wait
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_mmap_wc
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: sysfs_defaults
results: parsing output: 68/ for test: kms_chamelium_frames
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: gem_mmap
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_dirtyfb
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: syncobj_basic
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: i915_selftest
results: parsing output: 81/ for test: kms_prop_blob
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: kms_async_flips
results: parsing output: 85/ for test: kms_universal_plane
results: parsing output: 86/ for test: perf
results: parsing output: 87/ for test: gem_workarounds
results: parsing output: 88/ for test: kms_plane_multiple
results: parsing output: 89/ for test: kms_pipe_crc_basic
results: parsing output: 90/ for test: fbdev
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: gem_set_tiling_vs_blt
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_hdr
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: i915_pm_rps
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_prime
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_pread
results: parsing output: 112/ for test: gen7_exec_parse
results: parsing output: 113/ for test: gem_ctx_engines
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_plane_scaling
results: parsing output: 119/ for test: gem_exec_gttfill
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_exec_flush
results: parsing output: 132/ for test: kms_cursor_edge_walk
Done.