[58.925357] Initializing watchdogs
[58.925403]   /dev/watchdog0
[58.940033] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.944378] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.946543] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.949730] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[59.079401] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[63.468236] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.368s)
[64.662508] [002/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[64.754870] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[72.407956] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.639s)
[72.538093] [003/133] (946s left) gem_mmap_wc (close)
[72.604631] Subtest close: SKIP (0.000s)
[72.664190] [004/133] (946s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[72.768188] Starting subtest: crc-primary-basic-y-tiled-ccs
[72.770557] Starting dynamic subtest: pipe-A-eDP-1
[72.794870] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[72.804269] Starting dynamic subtest: pipe-B-eDP-1
[72.825654] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[72.832654] Starting dynamic subtest: pipe-C-eDP-1
[72.853488] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[72.862213] Starting dynamic subtest: pipe-D-eDP-1
[72.884260] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[72.888633] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.007s)
[75.078684] [005/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[75.186847] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[82.092137] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.903s)
[82.216539] [006/133] (937s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[82.311466] Starting subtest: disable-crc-after-crtc
[82.313787] Starting dynamic subtest: pipe-A-eDP-1
[83.932693] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.622s)
[83.942406] Starting dynamic subtest: pipe-B-eDP-1
[86.227654] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.291s)
[86.238139] Starting dynamic subtest: pipe-C-eDP-1
[88.467950] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s)
[88.477127] Starting dynamic subtest: pipe-D-eDP-1
[90.721388] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.252s)
[90.723642] Subtest disable-crc-after-crtc: SUCCESS (8.406s)
[91.555772] [007/133] (928s left) kms_properties (get_properties-sanity-atomic)
[91.660372] Starting subtest: get_properties-sanity-atomic
[91.662699] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[91.738043] [008/133] (927s left) perf_pmu (busy-accuracy-2)
[91.787650] Starting subtest: busy-accuracy-2
[91.789895] Starting dynamic subtest: rcs0
[94.833088] Dynamic subtest rcs0: SUCCESS (3.039s)
[94.843357] Starting dynamic subtest: bcs0
[97.953154] Dynamic subtest bcs0: SUCCESS (3.060s)
[97.962536] Starting dynamic subtest: vcs0
[100.990603] Dynamic subtest vcs0: SUCCESS (3.045s)
[101.000529] Starting dynamic subtest: vcs1
[104.038387] Dynamic subtest vcs1: SUCCESS (3.048s)
[104.048108] Starting dynamic subtest: vecs0
[107.088906] Dynamic subtest vecs0: SUCCESS (3.047s)
[107.100893] Starting dynamic subtest: ccs0
[110.150440] Dynamic subtest ccs0: SUCCESS (3.059s)
[110.152819] Subtest busy-accuracy-2: SUCCESS (18.306s)
[110.211952] [009/133] (909s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[110.326715] Starting subtest: yf-tiled-64bpp-rotate-0
[110.330895] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[110.420915] [010/133] (909s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[110.528437] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[110.532791] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[110.623078] [011/133] (909s left) kms_pm_rpm (package-g7)
[112.189683] Starting subtest: package-g7
[112.194395] Subtest package-g7: SKIP (0.000s)
[112.909737] [012/133] (906s left) gem_ctx_sseu (invalid-args)
[112.973975] Subtest invalid-args: SKIP (0.000s)
[113.057208] [013/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[113.165707] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[113.170243] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[113.267399] [014/133] (906s left) drm_read (short-buffer-nonblock)
[113.418927] Starting subtest: short-buffer-nonblock
[113.421490] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[113.549984] [015/133] (906s left) syncobj_wait (single-wait-for-submit-submitted)
[113.614112] Starting subtest: single-wait-for-submit-submitted
[113.722409] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[113.805856] [016/133] (906s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[113.867857] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[113.870236] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[113.968551] [017/133] (906s left) gem_exec_schedule (submit-late-slice)
[114.047686] Starting subtest: submit-late-slice
[114.050064] Starting dynamic subtest: rcs0
[114.076615] Dynamic subtest rcs0: SUCCESS (0.037s)
[114.088374] Starting dynamic subtest: bcs0
[114.107551] Dynamic subtest bcs0: SUCCESS (0.031s)
[114.115645] Starting dynamic subtest: vcs0
[114.139446] Dynamic subtest vcs0: SUCCESS (0.032s)
[114.147019] Starting dynamic subtest: vcs1
[114.170740] Dynamic subtest vcs1: SUCCESS (0.031s)
[114.178838] Starting dynamic subtest: vecs0
[114.201844] Dynamic subtest vecs0: SUCCESS (0.031s)
[114.210355] Starting dynamic subtest: ccs0
[114.231809] Dynamic subtest ccs0: SUCCESS (0.029s)
[114.234171] Subtest submit-late-slice: SUCCESS (0.192s)
[115.992935] [018/133] (904s left) device_reset (cold-reset-bound)
[116.052069] Starting subtest: cold-reset-bound
[116.056319] Subtest cold-reset-bound: SKIP (0.000s)
[116.120687] [019/133] (904s left) gem_eio (in-flight-10ms)
[116.347561] Starting subtest: in-flight-10ms
[124.819932] Subtest in-flight-10ms: SUCCESS (8.469s)
[124.943305] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[124.946388] [020/133] (895s left) kms_addfb_basic (addfb25-4-tiled)
[125.046224] Starting subtest: addfb25-4-tiled
[125.048418] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[125.162444] [021/133] (895s left) kms_psr (pr-sprite-render)
[125.258287] Starting subtest: pr-sprite-render
[125.262660] Subtest pr-sprite-render: SKIP (0.000s)
[125.343930] [022/133] (894s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[125.430949] Starting subtest: fbc-psr-sprite-mmap-gtt
[125.433367] Starting dynamic subtest: eDP-1
[125.437768] Dynamic subtest eDP-1: SKIP (0.000s)
[125.442229] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[125.502087] [023/133] (894s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[125.596779] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[125.607248] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[125.682719] [024/133] (894s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[125.788039] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[129.942952] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.157s)
[131.118417] [025/133] (889s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[131.205456] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[131.207647] Starting dynamic subtest: pipe-A-eDP-1
[131.229660] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[131.238320] Starting dynamic subtest: pipe-B-eDP-1
[131.259142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[131.267068] Starting dynamic subtest: pipe-C-eDP-1
[131.288356] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.296149] Starting dynamic subtest: pipe-D-eDP-1
[131.319020] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.323563] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[133.477049] [026/133] (886s left) gem_partial_pwrite_pread (reads)
[133.546514] Subtest reads: SKIP (0.000s)
[133.619477] [027/133] (886s left) kms_content_protection (uevent)
[133.764326] Starting subtest: uevent
[133.769034] Subtest uevent: SKIP (0.000s)
[133.890893] [028/133] (886s left) kms_frontbuffer_tracking (psr-slowdraw)
[133.996732] Starting subtest: psr-slowdraw
[159.164438] Subtest psr-slowdraw: SUCCESS (25.169s)
[159.308955] [029/133] (861s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[159.424175] Starting subtest: cursorA-vs-flipA-atomic-transitions
[170.581929] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.155s)
[171.415143] [030/133] (849s left) gem_mmap_wc (coherency)
[171.477146] Subtest coherency: SKIP (0.000s)
[171.538512] [031/133] (849s left) kms_atomic_interruptible (legacy-cursor)
[171.645724] Starting subtest: legacy-cursor
[171.647973] Starting dynamic subtest: pipe-A-eDP-1
[179.030536] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.383s)
[179.032451] Subtest legacy-cursor: SUCCESS (7.384s)
[179.898438] [032/133] (840s left) kms_flip (2x-flip-vs-dpms)
[179.996355] Starting subtest: 2x-flip-vs-dpms
[180.005766] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[180.124818] [033/133] (840s left) gem_ctx_param (invalid-get-engines)
[180.180082] Starting subtest: invalid-get-engines
[180.182479] Subtest invalid-get-engines: SUCCESS (0.001s)
[180.269377] [034/133] (840s left) kms_atomic (test-only)
[180.366354] Starting subtest: test-only
[180.419082] Starting dynamic subtest: pipe-A-eDP-1
[182.879346] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.463s)
[182.881692] Subtest test-only: SUCCESS (2.515s)
[183.679587] [035/133] (837s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[184.053302] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[184.890490] [036/133] (836s left) gem_ctx_persistence (saturated-hostile)
[184.943570] Starting subtest: saturated-hostile
[184.945748] Starting dynamic subtest: rcs0
[185.761515] Dynamic subtest rcs0: SUCCESS (0.820s)
[185.774069] Starting dynamic subtest: bcs0
[186.550646] Dynamic subtest bcs0: SUCCESS (0.787s)
[186.562553] Starting dynamic subtest: vcs0
[187.347220] Dynamic subtest vcs0: SUCCESS (0.794s)
[187.358697] Starting dynamic subtest: vcs1
[188.164890] Dynamic subtest vcs1: SUCCESS (0.815s)
[188.177331] Starting dynamic subtest: vecs0
[188.969066] Dynamic subtest vecs0: SUCCESS (0.803s)
[188.980240] Starting dynamic subtest: ccs0
[189.810071] Dynamic subtest ccs0: SUCCESS (0.839s)
[189.812551] Subtest saturated-hostile: SUCCESS (4.870s)
[189.891761] [037/133] (831s left) gem_userptr_blits (relocations)
[189.948917] Starting subtest: relocations
[189.953369] Subtest relocations: SKIP (0.000s)
[190.090753] [038/133] (830s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[190.217247] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[190.221590] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[190.364678] [039/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[190.464802] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[190.468763] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[190.560157] [040/133] (830s left) kms_color (ctm-blue-to-red)
[190.651151] Starting subtest: ctm-blue-to-red
[190.653075] Starting dynamic subtest: pipe-A-eDP-1
[191.348995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[191.359439] Starting dynamic subtest: pipe-B-eDP-1
[192.735459] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[192.744220] Starting dynamic subtest: pipe-C-eDP-1
[194.106321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[194.115728] Starting dynamic subtest: pipe-D-eDP-1
[195.432682] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[195.434986] Subtest ctm-blue-to-red: SUCCESS (4.782s)
[196.243309] [041/133] (824s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[196.302170] Starting subtest: multi-wait-for-submit-available-signaled
[196.304556] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.002s)
[196.400138] [042/133] (824s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[196.485412] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[196.490044] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[197.585063] [043/133] (823s left) gem_fence_thrash (bo-write-verify-threaded-x)
[197.624725] Starting subtest: bo-write-verify-threaded-x
[197.643232] Subtest bo-write-verify-threaded-x: SKIP (0.016s)
[197.712530] [044/133] (823s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[197.806247] Starting subtest: plane-upscale-20x20-with-modifiers
[197.808566] Starting dynamic subtest: pipe-A
[198.141337] Dynamic subtest pipe-A: SUCCESS (0.338s)
[198.150697] Starting dynamic subtest: pipe-B
[199.577075] Dynamic subtest pipe-B: SUCCESS (1.435s)
[199.585780] Starting dynamic subtest: pipe-C
[201.001502] Dynamic subtest pipe-C: SUCCESS (1.423s)
[201.012219] Starting dynamic subtest: pipe-D
[202.437038] Dynamic subtest pipe-D: SUCCESS (1.435s)
[202.439250] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.634s)
[203.617876] [045/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[203.713415] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[203.717792] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[203.809446] [046/133] (817s left) gem_busy (semaphore)
[203.994088] Subtest semaphore: SKIP (0.000s)
[204.240689] [047/133] (817s left) kms_flip (flip-vs-dpms-on-nop)
[204.327349] Starting subtest: flip-vs-dpms-on-nop
[204.329651] Starting dynamic subtest: A-eDP1
[206.214807] Dynamic subtest A-eDP1: SUCCESS (1.889s)
[206.226061] Starting dynamic subtest: B-eDP1
[208.066855] Dynamic subtest B-eDP1: SUCCESS (1.850s)
[208.078527] Starting dynamic subtest: C-eDP1
[209.882242] Dynamic subtest C-eDP1: SUCCESS (1.812s)
[209.891126] Starting dynamic subtest: D-eDP1
[211.712224] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[211.718058] Subtest flip-vs-dpms-on-nop: SUCCESS (7.392s)
[212.912483] [048/133] (808s left) gem_gpgpu_fill (offset-16x16)
[212.981140] Starting subtest: offset-16x16
[212.986771] Subtest offset-16x16: SUCCESS (0.006s)
[213.125678] [049/133] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[213.223543] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[213.227656] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.348030] [050/133] (808s left) api_intel_bb (crc32)
[213.406874] Starting subtest: crc32
[213.409098] Starting dynamic subtest: rcs0-smem0
[213.726231] Dynamic subtest rcs0-smem0: SUCCESS (0.316s)
[213.738497] Starting dynamic subtest: bcs0-smem0
[214.027739] Dynamic subtest bcs0-smem0: SUCCESS (0.299s)
[214.039351] Starting dynamic subtest: vcs0-smem0
[214.337289] Dynamic subtest vcs0-smem0: SUCCESS (0.308s)
[214.347613] Starting dynamic subtest: vcs1-smem0
[214.704091] Dynamic subtest vcs1-smem0: SUCCESS (0.363s)
[214.715658] Starting dynamic subtest: vecs0-smem0
[215.037205] Dynamic subtest vecs0-smem0: SUCCESS (0.330s)
[215.049344] Starting dynamic subtest: ccs0-smem0
[215.364842] Dynamic subtest ccs0-smem0: SUCCESS (0.324s)
[215.367834] Subtest crc32: SUCCESS (1.957s)
[215.492502] [051/133] (806s left) kms_cursor_crc (cursor-random-128x42)
[215.761623] Starting subtest: cursor-random-128x42
[215.807639] Subtest cursor-random-128x42: SKIP (0.040s)
[216.009367] [052/133] (805s left) kms_cursor_edge_walk (128x128-top-edge)
[216.109202] Starting subtest: 128x128-top-edge
[216.111532] Starting dynamic subtest: pipe-A-eDP-1
[219.558398] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[219.567333] Starting dynamic subtest: pipe-D-eDP-1
[222.697537] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[222.699779] Subtest 128x128-top-edge: SUCCESS (6.590s)
[223.498260] [053/133] (798s left) kms_lease (lease-again)
[223.603278] Starting subtest: lease-again
[223.605584] Starting dynamic subtest: pipe-A-eDP-1
[223.607824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[223.617179] Starting dynamic subtest: pipe-B-eDP-1
[223.619300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[223.627115] Starting dynamic subtest: pipe-C-eDP-1
[223.628950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[223.636887] Starting dynamic subtest: pipe-D-eDP-1
[223.638756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[223.640658] Subtest lease-again: SUCCESS (0.012s)
[223.734218] [054/133] (797s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[223.826387] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[223.828643] Starting dynamic subtest: pipe-A-eDP-1
[223.853688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.865054] Starting dynamic subtest: pipe-B-eDP-1
[223.888745] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.896830] Starting dynamic subtest: pipe-C-eDP-1
[223.920213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.928224] Starting dynamic subtest: pipe-D-eDP-1
[223.952142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.956462] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[225.989485] [055/133] (795s left) i915_drm_fdinfo (memory-info-idle)
[226.033680] Starting subtest: memory-info-idle
[226.035617] Starting dynamic subtest: smem0
[226.096705] Dynamic subtest smem0: SUCCESS (0.065s)
[226.099355] Subtest memory-info-idle: SUCCESS (0.065s)
[226.168679] [056/133] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[226.256185] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[226.260139] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[226.359178] [057/133] (795s left) gem_userptr_blits (create-destroy-sync)
[226.435081] Starting subtest: create-destroy-sync
[231.517343] Subtest create-destroy-sync: SUCCESS (5.018s)
[231.569973] [058/133] (790s left) kms_plane_lowres (tiling-4)
[231.663068] Starting subtest: tiling-4
[231.665242] Starting dynamic subtest: pipe-A-eDP-1
[231.669680] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.964427] Starting dynamic subtest: pipe-B-eDP-1
[231.969677] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.988288] Starting dynamic subtest: pipe-C-eDP-1
[231.992699] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.001587] Starting dynamic subtest: pipe-D-eDP-1
[232.005981] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.010233] Subtest tiling-4: SKIP (0.294s)
[232.805124] [059/133] (789s left) gem_userptr_blits (stress-purge)
[232.874305] Starting subtest: stress-purge
[238.286029] Subtest stress-purge: SUCCESS (5.415s)
[238.405033] [060/133] (783s left) gem_close (many-handles-one-vma)
[238.515064] Starting subtest: many-handles-one-vma
[238.558343] Subtest many-handles-one-vma: SUCCESS (0.043s)
[238.675210] [061/133] (783s left) kms_psr (psr2-suspend)
[238.774988] Starting subtest: psr2-suspend
[238.776771] Starting dynamic subtest: eDP-1
[256.651158] Dynamic subtest eDP-1: SUCCESS (2.971s)
[256.653495] Subtest psr2-suspend: SUCCESS (2.972s)
[257.461208] [062/133] (764s left) kms_feature_discovery (display-3x)
[257.572185] Starting subtest: display-3x
[257.576304] Subtest display-3x: SKIP (0.000s)
[257.660269] [063/133] (764s left) gem_create (create-size-update)
[257.717115] Starting subtest: create-size-update
[257.719376] Subtest create-size-update: SUCCESS (0.000s)
[257.944351] [064/133] (764s left) gem_media_vme
[258.077734] [065/133] (764s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[258.138803] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[258.248518] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[258.340929] [066/133] (763s left) gem_pxp (create-regular-context-1)
[258.467309] Starting subtest: create-regular-context-1
[258.470166] Subtest create-regular-context-1: SUCCESS (0.002s)
[258.586460] [067/133] (763s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[258.708762] Starting subtest: 2x-cursor-vs-flip-legacy
[258.713504] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[258.857428] [068/133] (763s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[258.940566] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[258.945098] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[259.031526] [069/133] (763s left) i915_selftest (live)
[262.344080] Starting subtest: live
[262.347708] Starting dynamic subtest: sanitycheck
[266.708237] Dynamic subtest sanitycheck: SUCCESS (4.309s)
[266.718882] Starting dynamic subtest: uncore
[271.036305] Dynamic subtest uncore: SUCCESS (4.292s)
[271.046520] Starting dynamic subtest: workarounds
[288.678192] Dynamic subtest workarounds: FAIL (17.126s)
[288.686738] Starting dynamic subtest: gt_engines
[292.767225] Dynamic subtest gt_engines: SUCCESS (4.557s)
[292.777538] Starting dynamic subtest: gt_timelines
[308.224159] Dynamic subtest gt_timelines: SUCCESS (15.449s)
[308.234468] Starting dynamic subtest: gt_contexts
[310.955491] Dynamic subtest gt_contexts: SUCCESS (2.729s)
[310.965244] Starting dynamic subtest: gt_lrc
[316.985567] Dynamic subtest gt_lrc: SUCCESS (6.025s)
[316.996476] Starting dynamic subtest: gt_mocs
[319.901592] Dynamic subtest gt_mocs: SUCCESS (2.913s)
[319.911951] Starting dynamic subtest: gt_pm
[326.555645] Dynamic subtest gt_pm: SUCCESS (6.650s)
[326.570564] Starting dynamic subtest: gt_heartbeat
[330.893941] Dynamic subtest gt_heartbeat: SUCCESS (4.335s)
[330.904248] Starting dynamic subtest: gt_tlb
[340.185577] Dynamic subtest gt_tlb: SUCCESS (9.285s)
[340.194642] Starting dynamic subtest: requests
[351.730512] Dynamic subtest requests: SUCCESS (11.537s)
[351.741469] Starting dynamic subtest: migrate
[357.391827] Dynamic subtest migrate: SUCCESS (5.662s)
[357.404830] Starting dynamic subtest: active
[361.760962] Dynamic subtest active: SUCCESS (4.369s)
[361.770613] Starting dynamic subtest: objects
[366.398937] Dynamic subtest objects: SUCCESS (4.638s)
[366.407683] Starting dynamic subtest: mman
[371.160805] Dynamic subtest mman: SUCCESS (4.762s)
[371.169665] Starting dynamic subtest: dmabuf
[375.526714] Dynamic subtest dmabuf: SUCCESS (4.364s)
[375.536764] Starting dynamic subtest: vma
[379.851061] Dynamic subtest vma: SUCCESS (4.323s)
[379.861241] Starting dynamic subtest: coherency
[384.778830] Dynamic subtest coherency: SUCCESS (4.927s)
[384.789326] Starting dynamic subtest: gtt
[396.528502] Dynamic subtest gtt: SUCCESS (11.746s)
[396.538851] Starting dynamic subtest: gem
[404.435341] Dynamic subtest gem: SUCCESS (7.904s)
[404.445222] Starting dynamic subtest: evict
[408.360397] Dynamic subtest evict: SUCCESS (3.923s)
[408.375639] Starting dynamic subtest: hugepages
[417.149881] Dynamic subtest hugepages: SUCCESS (8.786s)
[417.157750] Starting dynamic subtest: gem_contexts
[443.732896] Dynamic subtest gem_contexts: SUCCESS (26.573s)
[443.742581] Starting dynamic subtest: client
[446.463910] Dynamic subtest client: SUCCESS (2.729s)
[446.473622] Starting dynamic subtest: gem_migrate
[450.800965] Dynamic subtest gem_migrate: SUCCESS (4.335s)
[450.809833] Starting dynamic subtest: reset
[453.498757] Dynamic subtest reset: SUCCESS (2.694s)
[453.507678] Starting dynamic subtest: memory_region
[457.798835] Dynamic subtest memory_region: SUCCESS (4.296s)
[457.809368] Starting dynamic subtest: hangcheck
[470.593152] Dynamic subtest hangcheck: SUCCESS (12.789s)
[470.603088] Starting dynamic subtest: execlists
[474.940641] Dynamic subtest execlists: SUCCESS (4.345s)
[474.949465] Starting dynamic subtest: ring_submission
[479.397736] Dynamic subtest ring_submission: SUCCESS (4.453s)
[479.421172] Starting dynamic subtest: perf
[483.969111] Dynamic subtest perf: SUCCESS (4.572s)
[483.979637] Starting dynamic subtest: slpc
[497.952251] Dynamic subtest slpc: SUCCESS (13.984s)
[497.966162] Starting dynamic subtest: guc
[501.824068] Dynamic subtest guc: SUCCESS (3.870s)
[501.834725] Starting dynamic subtest: guc_multi_lrc
[506.111961] Dynamic subtest guc_multi_lrc: SUCCESS (4.287s)
[506.122376] Starting dynamic subtest: guc_hang
[509.491929] Dynamic subtest guc_hang: SUCCESS (3.379s)
[509.502669] Starting dynamic subtest: late_gt_pm
[512.319077] Dynamic subtest late_gt_pm: SUCCESS (2.826s)
[512.321620] Subtest live: FAIL (249.807s)
[512.349369] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[512.350128] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[512.353706] [070/133] (509s left) gem_exec_fence (submit67)
[513.981023] Starting subtest: submit67
[513.985100] Subtest submit67: SKIP (0.000s)
[515.845890] [FACT gem_exec_fence (submit67)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[515.847085] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.i915: true
[515.851020] [071/133] (506s left) gem_exec_whisper (basic-normal-all)
[515.908130] Starting subtest: basic-normal-all
[519.021162] Subtest basic-normal-all: SUCCESS (3.113s)
[519.209431] [072/133] (503s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[519.329226] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[519.986168] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.658s)
[520.167387] [073/133] (502s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[520.265704] Starting subtest: pr-plane-move-sf-dmg-area
[520.269918] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[520.330792] [074/133] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[520.428303] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[520.432529] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[520.520053] [075/133] (502s left) i915_pm_rpm (debugfs-forcewake-user)
[522.046700] Starting subtest: debugfs-forcewake-user
[533.452343] Subtest debugfs-forcewake-user: SUCCESS (11.409s)
[533.841908] [076/133] (488s left) syncobj_wait (single-wait-signaled)
[533.904060] Starting subtest: single-wait-signaled
[533.906332] Subtest single-wait-signaled: SUCCESS (0.000s)
[534.017501] [077/133] (488s left) kms_psr (fbc-pr-suspend)
[534.108849] Starting subtest: fbc-pr-suspend
[534.112830] Subtest fbc-pr-suspend: SKIP (0.000s)
[534.183444] [078/133] (488s left) gem_exec_params (invalid-ring)
[534.250617] Starting subtest: invalid-ring
[534.252963] Subtest invalid-ring: SUCCESS (0.000s)
[534.372635] [079/133] (488s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[534.457688] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[534.483662] Starting dynamic subtest: pipe-A-plane-0
[534.905457] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[534.914502] Starting dynamic subtest: pipe-A-plane-3
[535.171869] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[535.180816] Starting dynamic subtest: pipe-A-plane-5
[535.184648] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[536.310286] Starting dynamic subtest: pipe-B-plane-0
[536.746562] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[536.755963] Starting dynamic subtest: pipe-B-plane-3
[537.002402] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[537.012035] Starting dynamic subtest: pipe-B-plane-5
[537.016598] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[537.331811] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.874s)
[538.225689] [080/133] (484s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[538.294296] Starting subtest: etime-multi-wait-all-for-submit-submitted
[538.400625] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[538.479736] [081/133] (484s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[538.583787] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[539.596053] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.014s)
[539.752611] [082/133] (483s left) vgem_basic (unload)
[539.789513] Starting subtest: unload
[568.881943] Subtest unload: SUCCESS (29.039s)
[568.930951] [083/133] (453s left) gem_pxp (protected-raw-src-copy-not-readible)
[569.052333] Starting subtest: protected-raw-src-copy-not-readible
[569.114548] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.064s)
[569.268482] [084/133] (453s left) syncobj_timeline (invalid-wait-illegal-handle)
[569.323049] Starting subtest: invalid-wait-illegal-handle
[569.325269] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[569.443546] [085/133] (453s left) kms_frontbuffer_tracking (psr-2p-rte)
[569.548997] Starting subtest: psr-2p-rte
[569.553197] Subtest psr-2p-rte: SKIP (0.000s)
[569.652801] [086/133] (453s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[569.746271] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[569.750568] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[569.836785] [087/133] (453s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[569.945869] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[569.947697] Starting dynamic subtest: pipe-A-eDP-1
[570.020082] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[570.032824] Starting dynamic subtest: pipe-B-eDP-1
[571.171492] Dynamic subtest pipe-B-eDP-1: SKIP (1.148s)
[571.175584] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.228s)
[572.367185] [088/133] (450s left) syncobj_wait (invalid-wait-illegal-handle)
[572.431081] Starting subtest: invalid-wait-illegal-handle
[572.433476] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[572.564458] [089/133] (450s left) gem_ringfill (legacy-basic)
[577.808581] Starting subtest: legacy-basic
[577.811321] Starting dynamic subtest: default
[577.871798] Dynamic subtest default: SUCCESS (0.062s)
[577.884462] Starting dynamic subtest: render
[577.913736] Dynamic subtest render: SUCCESS (0.040s)
[577.923541] Starting dynamic subtest: bsd
[577.955732] Dynamic subtest bsd: SUCCESS (0.039s)
[577.969103] Starting dynamic subtest: bsd1
[577.998914] Dynamic subtest bsd1: SUCCESS (0.041s)
[578.009659] Starting dynamic subtest: bsd2
[578.043223] Dynamic subtest bsd2: SUCCESS (0.042s)
[578.056548] Starting dynamic subtest: blt
[578.088563] Dynamic subtest blt: SUCCESS (0.043s)
[578.098691] Starting dynamic subtest: vebox
[578.130898] Dynamic subtest vebox: SUCCESS (0.040s)
[578.133204] Subtest legacy-basic: SUCCESS (0.324s)
[578.225054] [090/133] (444s left) gem_exec_balancer (full-late-pulse)
[578.298502] Starting subtest: full-late-pulse
[582.691535] Subtest full-late-pulse: SUCCESS (4.392s)
[583.022163] [091/133] (440s left) i915_drm_fdinfo (virtual-busy-idle-all)
[583.059775] Starting subtest: virtual-busy-idle-all
[583.063975] Subtest virtual-busy-idle-all: SKIP (0.000s)
[583.134099] [092/133] (440s left) kms_rotation_crc (cursor-rotation-180)
[583.237597] Starting subtest: cursor-rotation-180
[584.753010] Subtest cursor-rotation-180: SUCCESS (1.514s)
[585.945501] [093/133] (437s left) gem_ctx_bad_destroy (double-destroy)
[586.001828] Starting subtest: double-destroy
[586.004379] Subtest double-destroy: SUCCESS (0.000s)
[586.076298] [094/133] (437s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[586.170069] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[586.794395] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.625s)
[586.958072] [095/133] (436s left) syncobj_timeline (wait-all-for-submit-complex)
[587.021606] Starting subtest: wait-all-for-submit-complex
[587.234146] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[587.326807] [096/133] (436s left) gem_exec_params (sol-reset-not-gen7)
[587.376639] Starting subtest: sol-reset-not-gen7
[587.379195] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[587.498279] [097/133] (436s left) prime_self_import (basic-llseek-size)
[587.538501] Starting subtest: basic-llseek-size
[587.555516] Subtest basic-llseek-size: SUCCESS (0.021s)
[587.670744] [098/133] (435s left) kms_cursor_crc (cursor-offscreen-32x10)
[587.832692] Starting subtest: cursor-offscreen-32x10
[587.879824] Subtest cursor-offscreen-32x10: SKIP (0.045s)
[588.160261] [099/133] (435s left) kms_flip (2x-absolute-wf_vblank)
[588.257713] Starting subtest: 2x-absolute-wf_vblank
[588.266074] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[588.357028] [100/133] (435s left) vgem_basic (dmabuf-fence)
[588.398779] Starting subtest: dmabuf-fence
[588.400842] Subtest dmabuf-fence: SUCCESS (0.001s)
[588.458209] [101/133] (435s left) gem_tiled_blits (normal)
[588.522930] Subtest normal: SKIP (0.000s)
[588.603263] [102/133] (435s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[588.696242] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[588.699790] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[588.802406] [103/133] (434s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[588.893526] Starting subtest: plane-downscale-factor-0-5-with-rotation
[588.895457] Starting dynamic subtest: pipe-A
[588.917551] Dynamic subtest pipe-A: SKIP (0.020s)
[588.926894] Starting dynamic subtest: pipe-B
[588.949154] Dynamic subtest pipe-B: SKIP (0.030s)
[588.958037] Starting dynamic subtest: pipe-C
[588.984338] Dynamic subtest pipe-C: SKIP (0.035s)
[588.993173] Starting dynamic subtest: pipe-D
[589.016735] Dynamic subtest pipe-D: SKIP (0.033s)
[589.020218] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.121s)
[589.111676] [104/133] (434s left) kms_invalid_mode (bad-hsync-start)
[589.219103] Starting subtest: bad-hsync-start
[589.221361] Starting dynamic subtest: pipe-A-eDP-1
[589.508269] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[589.518618] Starting dynamic subtest: pipe-B-eDP-1
[589.520561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[589.529967] Starting dynamic subtest: pipe-C-eDP-1
[589.532250] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[589.541924] Starting dynamic subtest: pipe-D-eDP-1
[589.544170] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[589.546480] Subtest bad-hsync-start: SUCCESS (0.297s)
[590.366367] [105/133] (433s left) api_intel_bb (object-reloc-keep-cache)
[590.421531] Starting subtest: object-reloc-keep-cache
[590.425678] Subtest object-reloc-keep-cache: SKIP (0.003s)
[590.518680] [106/133] (433s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[590.624014] Starting subtest: psr-rgb101010-draw-mmap-wc
[597.724810] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.103s)
[597.833537] [107/133] (426s left) gem_eio (in-flight-suspend)
[598.072947] Starting subtest: in-flight-suspend
[640.517555] Subtest in-flight-suspend: SUCCESS (13.733s)
[640.683940] [108/133] (383s left) gem_exec_flush (basic-batch-kernel-default-uc)
[640.750596] Starting subtest: basic-batch-kernel-default-uc
[648.310228] Subtest basic-batch-kernel-default-uc: SUCCESS (7.375s)
[648.509880] [109/133] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[648.604465] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[655.994619] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.325s)
[656.134591] [110/133] (367s left) prime_busy (hang-wait)
[656.198254] Starting subtest: hang-wait
[656.200494] Starting dynamic subtest: rcs0
[682.968798] Dynamic subtest rcs0: SUCCESS (26.713s)
[682.981565] Starting dynamic subtest: bcs0
[690.113712] Dynamic subtest bcs0: SUCCESS (7.154s)
[690.130152] Starting dynamic subtest: vcs0
[697.150136] Dynamic subtest vcs0: SUCCESS (7.030s)
[697.163112] Starting dynamic subtest: vcs1
[704.199653] Dynamic subtest vcs1: SUCCESS (7.035s)
[704.213064] Starting dynamic subtest: vecs0
[711.112741] Dynamic subtest vecs0: SUCCESS (6.907s)
[711.125040] Starting dynamic subtest: ccs0
[725.004647] Dynamic subtest ccs0: SUCCESS (13.895s)
[725.007277] Subtest hang-wait: SUCCESS (68.746s)
[725.124597] [111/133] (298s left) gem_exec_schedule (implicit-boths)
[725.212231] Starting subtest: implicit-boths
[725.214593] Starting dynamic subtest: rcs0
[725.378839] Dynamic subtest rcs0: SUCCESS (0.171s)
[725.393079] Starting dynamic subtest: vcs0
[725.490168] Dynamic subtest vcs0: SUCCESS (0.112s)
[725.504113] Starting dynamic subtest: vcs1
[725.596413] Dynamic subtest vcs1: SUCCESS (0.104s)
[725.610379] Starting dynamic subtest: vecs0
[725.701077] Dynamic subtest vecs0: SUCCESS (0.104s)
[725.714640] Starting dynamic subtest: ccs0
[725.836588] Dynamic subtest ccs0: SUCCESS (0.133s)
[725.839442] Subtest implicit-boths: SUCCESS (0.630s)
[726.608016] [112/133] (297s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[726.728236] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[726.732946] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[726.829368] [113/133] (297s left) gen9_exec_parse (basic-rejected-ctx-param)
[726.890656] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[726.949742] [114/133] (297s left) kms_getfb (getfb-repeated-different-handles)
[727.029879] Starting subtest: getfb-repeated-different-handles
[727.032174] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[727.122563] [115/133] (297s left) kms_addfb_basic (bad-pitch-0)
[727.169605] Starting subtest: bad-pitch-0
[727.171685] Subtest bad-pitch-0: SUCCESS (0.000s)
[727.311672] [116/133] (297s left) vgem_basic (busy-fence)
[727.353444] Starting subtest: busy-fence
[727.355744] Subtest busy-fence: SUCCESS (0.000s)
[727.406157] [117/133] (296s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[727.793708] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[728.650314] [118/133] (295s left) gem_exec_schedule (preempt)
[728.712417] Starting subtest: preempt
[728.714803] Starting dynamic subtest: rcs0
[728.730582] Dynamic subtest rcs0: SUCCESS (0.023s)
[728.743874] Starting dynamic subtest: bcs0
[728.748478] Dynamic subtest bcs0: SUCCESS (0.017s)
[728.758947] Starting dynamic subtest: vcs0
[728.778433] Dynamic subtest vcs0: SUCCESS (0.029s)
[728.793508] Starting dynamic subtest: vcs1
[728.799836] Dynamic subtest vcs1: SUCCESS (0.020s)
[728.810688] Starting dynamic subtest: vecs0
[728.820505] Dynamic subtest vecs0: SUCCESS (0.020s)
[728.831057] Starting dynamic subtest: ccs0
[728.843247] Dynamic subtest ccs0: SUCCESS (0.022s)
[728.845596] Subtest preempt: SUCCESS (0.137s)
[730.620184] [119/133] (293s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[730.734212] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[730.738578] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[730.842974] [120/133] (293s left) perf_pmu (gt-awake)
[730.881445] Starting subtest: gt-awake
[739.506007] Subtest gt-awake: SUCCESS (8.623s)
[739.595843] [121/133] (284s left) kms_vblank (query-idle)
[739.700324] Starting subtest: query-idle
[739.702492] Starting dynamic subtest: pipe-A-eDP-1
[741.444248] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.744s)
[741.460492] Starting dynamic subtest: pipe-D-eDP-1
[743.868856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[743.871136] Subtest query-idle: SUCCESS (4.171s)
[744.704790] [122/133] (279s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[744.808309] Starting subtest: fbcpsr-modesetfrombusy
[751.013336] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.211s)
[751.154898] [123/133] (273s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[751.246371] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[751.248731] Starting dynamic subtest: pipe-A-eDP-1
[751.297498] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[751.312379] Starting dynamic subtest: pipe-B-eDP-1
[751.360434] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[751.371685] Starting dynamic subtest: pipe-C-eDP-1
[751.419822] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[751.430583] Starting dynamic subtest: pipe-D-eDP-1
[751.477213] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[751.480902] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[753.541704] [124/133] (271s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[753.633871] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[753.638265] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[753.730974] [125/133] (271s left) gem_exec_fence (basic-await)
[753.905846] Starting subtest: basic-await
[753.908336] Starting dynamic subtest: rcs0
[753.979902] Dynamic subtest rcs0: SUCCESS (0.074s)
[753.994021] Starting dynamic subtest: bcs0
[754.057271] Dynamic subtest bcs0: SUCCESS (0.076s)
[754.075388] Starting dynamic subtest: vcs0
[754.129767] Dynamic subtest vcs0: SUCCESS (0.071s)
[754.143336] Starting dynamic subtest: vcs1
[754.203148] Dynamic subtest vcs1: SUCCESS (0.071s)
[754.216210] Starting dynamic subtest: vecs0
[754.276590] Dynamic subtest vecs0: SUCCESS (0.071s)
[754.292049] Starting dynamic subtest: ccs0
[754.351884] Dynamic subtest ccs0: SUCCESS (0.073s)
[754.354741] Subtest basic-await: SUCCESS (0.448s)
[756.626635] [126/133] (268s left) gem_softpin (full)
[756.682140] Starting subtest: full
[756.691696] Subtest full: SUCCESS (0.010s)
[756.826506] [127/133] (268s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[756.913557] Starting subtest: multiplane-rotation-cropping-bottom
[774.404319] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.493s)
[774.533913] [128/133] (250s left) kms_selftest (drm_cmdline_parser)
[774.574380] Starting subtest: drm_cmdline_parser
[774.591302] Starting dynamic subtest: drm_test_cmdline_force_d_only
[774.689117] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.096s)
[774.700794] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[774.773109] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.083s)
[774.783952] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[774.866611] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.092s)
[774.877090] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[774.956317] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.090s)
[774.967624] Starting dynamic subtest: drm_test_cmdline_force_e_only
[775.034892] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.078s)
[775.045890] Starting dynamic subtest: drm_test_cmdline_res
[775.121132] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.085s)
[775.132102] Starting dynamic subtest: drm_test_cmdline_res_vesa
[775.224214] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.101s)
[775.234647] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[775.334016] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.109s)
[775.344774] Starting dynamic subtest: drm_test_cmdline_res_rblank
[775.434429] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.099s)
[775.445179] Starting dynamic subtest: drm_test_cmdline_res_bpp
[775.557530] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.122s)
[775.568359] Starting dynamic subtest: drm_test_cmdline_res_refresh
[775.650922] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.093s)
[775.661691] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[775.734975] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.085s)
[775.744654] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[775.841559] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.104s)
[775.852808] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[775.930572] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s)
[775.941944] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[776.025850] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.097s)
[776.035775] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[776.117058] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.087s)
[776.127213] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[776.226377] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.107s)
[776.237051] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[776.318829] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.092s)
[776.333496] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[776.414615] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.096s)
[776.427413] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[776.509464] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.094s)
[776.519247] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[776.614033] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.105s)
[776.623679] Starting dynamic subtest: drm_test_cmdline_name
[776.708609] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.094s)
[776.717609] Starting dynamic subtest: drm_test_cmdline_name_bpp
[776.803251] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.094s)
[776.814232] Starting dynamic subtest: drm_test_cmdline_name_option
[776.898996] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.095s)
[776.910145] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[776.992915] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.093s)
[777.002359] Starting dynamic subtest: drm_test_cmdline_rotate_0
[777.097124] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.103s)
[777.107343] Starting dynamic subtest: drm_test_cmdline_rotate_90
[777.184313] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.086s)
[777.202500] Starting dynamic subtest: drm_test_cmdline_rotate_180
[777.285141] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.101s)
[777.295764] Starting dynamic subtest: drm_test_cmdline_rotate_270
[777.390208] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.103s)
[777.400614] Starting dynamic subtest: drm_test_cmdline_hmirror
[777.489727] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.098s)
[777.511124] Starting dynamic subtest: drm_test_cmdline_vmirror
[777.614072] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.117s)
[777.625045] Starting dynamic subtest: drm_test_cmdline_margin_options
[777.708008] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.098s)
[777.717899] Starting dynamic subtest: drm_test_cmdline_multiple_options
[777.813913] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.105s)
[777.824443] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[777.911979] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.097s)
[777.922052] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[778.004000] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.091s)
[778.013795] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[778.110220] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.106s)
[778.123484] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[778.222562] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.111s)
[778.233585] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[778.304704] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.082s)
[778.315877] Starting dynamic subtest: drm_test_cmdline_invalid
[778.392126] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.088s)
[778.402910] Starting dynamic subtest: drm_test_cmdline_tv_options
[778.483733] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.089s)
[778.485505] Subtest drm_cmdline_parser: SUCCESS (3.908s)
[778.666935] [129/133] (246s left) kms_addfb_basic (invalid-set-prop)
[778.721743] Starting subtest: invalid-set-prop
[778.723646] Subtest invalid-set-prop: SUCCESS (0.000s)
[778.871589] [130/133] (246s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[778.970835] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[778.975128] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[779.072935] [131/133] (245s left) gem_mmap_gtt (pf-nonblock)
[779.131398] Subtest pf-nonblock: SKIP (0.000s)
[779.193096] [132/133] (245s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[779.295169] Starting subtest: psr2-overlay-plane-move-continuous-sf
[779.297318] Starting dynamic subtest: pipe-A-eDP-1
[785.274701] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.982s)
[785.284752] Starting dynamic subtest: pipe-B-eDP-1
[791.938867] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s)
[791.941059] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.648s)
[792.810760] [133/133] (232s left) kms_pm_backlight (fade)
[792.916781] Starting subtest: fade
[792.968175] Starting dynamic subtest: eDP-1
[795.455921] Dynamic subtest eDP-1: SUCCESS (2.488s)
[795.458189] Subtest fade: SUCCESS (2.539s)
[796.254614] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_mmap_wc
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_properties
results: parsing output: 7/ for test: perf_pmu
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: gem_ctx_sseu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: drm_read
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: device_reset
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: gem_mmap_wc
results: parsing output: 30/ for test: kms_atomic_interruptible
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_ctx_param
results: parsing output: 33/ for test: kms_atomic
results: parsing output: 34/ for test: kms_chamelium_edid
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_fence_thrash
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_busy
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_gpgpu_fill
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_cursor_edge_walk
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: kms_plane_lowres
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_close
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_feature_discovery
results: parsing output: 62/ for test: gem_create
results: parsing output: 63/ for test: gem_media_vme
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_pxp
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: i915_selftest
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: vgem_basic
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_ctx_bad_destroy
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: prime_self_import
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: vgem_basic
results: parsing output: 100/ for test: gem_tiled_blits
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_invalid_mode
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: prime_busy
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen9_exec_parse
results: parsing output: 113/ for test: kms_getfb
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: vgem_basic
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_selftest
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: kms_pm_backlight
Done.