[58.053992] Initializing watchdogs
[58.054215]   /dev/watchdog0
[58.067583] [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.071546] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.073775] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.076914] [001/128] (960s left) prime_mmap (test_invalid_sync_flags)
[58.206671] Starting subtest: test_invalid_sync_flags
[58.209061] Starting dynamic subtest: test_invalid_sync_flags-smem
[58.211051] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[58.213046] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[58.317921] [002/128] (960s left) gem_exec_balancer (hog)
[58.379439] Starting subtest: hog
[58.384150] Subtest hog: SKIP (0.000s)
[58.659622] [003/128] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[58.776789] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[58.781141] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[58.890759] [004/128] (959s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[58.985780] Starting subtest: fbc-indfb-scaledprimary
[62.948108] Subtest fbc-indfb-scaledprimary: SUCCESS (3.967s)
[63.078206] [005/128] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[63.191262] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[67.948149] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.759s)
[68.063628] [006/128] (950s left) kms_psr (pr-sprite-render)
[68.162804] Starting subtest: pr-sprite-render
[68.167413] Subtest pr-sprite-render: SKIP (0.000s)
[68.230409] [007/128] (950s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[68.332754] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[68.335260] Starting dynamic subtest: pipe-A-default-mode
[68.621519] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[68.626297] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.283s)
[69.419847] [008/128] (949s left) i915_query (query-topology-matches-eu-total)
[69.478462] Starting subtest: query-topology-matches-eu-total
[69.480677] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[69.565958] [009/128] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[69.667442] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[69.672057] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[69.757768] [010/128] (949s left) gem_exec_schedule (lateslice)
[69.827697] Starting subtest: lateslice
[69.829636] Starting dynamic subtest: rcs0
[69.838940] Dynamic subtest rcs0: SUCCESS (0.021s)
[69.847721] Starting dynamic subtest: bcs0
[69.856645] Dynamic subtest bcs0: SUCCESS (0.018s)
[69.863442] Starting dynamic subtest: vcs0
[69.873063] Dynamic subtest vcs0: SUCCESS (0.017s)
[69.879640] Starting dynamic subtest: vcs1
[69.890600] Dynamic subtest vcs1: SUCCESS (0.017s)
[69.897174] Starting dynamic subtest: vecs0
[69.906603] Dynamic subtest vecs0: SUCCESS (0.016s)
[69.914918] Starting dynamic subtest: ccs0
[69.923423] Dynamic subtest ccs0: SUCCESS (0.017s)
[69.925612] Subtest lateslice: SUCCESS (0.105s)
[71.114859] [011/128] (947s left) debugfs_test (sysfs)
[71.289963] Starting subtest: sysfs
[71.364961] Subtest sysfs: SUCCESS (0.072s)
[71.502964] [012/128] (947s left) gen7_exec_parse (chained-batch)
[71.642742] Subtest chained-batch: SKIP (0.000s)
[71.758947] [013/128] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[71.876864] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[75.378073] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.506s)
[75.517607] [014/128] (943s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[75.621359] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[75.623372] Starting dynamic subtest: A-eDP1
[79.144533] Dynamic subtest A-eDP1: SUCCESS (3.521s)
[79.153613] Starting dynamic subtest: B-eDP1
[82.234068] Dynamic subtest B-eDP1: SUCCESS (3.086s)
[82.242560] Starting dynamic subtest: C-eDP1
[85.329838] Dynamic subtest C-eDP1: SUCCESS (3.096s)
[85.337860] Starting dynamic subtest: D-eDP1
[88.397969] Dynamic subtest D-eDP1: SUCCESS (3.069s)
[88.400444] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.777s)
[89.191737] [015/128] (929s left) gem_exec_whisper (basic-contexts-all)
[89.253570] Starting subtest: basic-contexts-all
[100.878318] Subtest basic-contexts-all: SUCCESS (11.619s)
[101.053927] [016/128] (918s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[101.118846] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[101.222809] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[101.292875] [017/128] (917s left) gem_exec_reloc (basic-wc-read-active)
[101.364074] Subtest basic-wc-read-active: SKIP (0.000s)
[101.439174] [018/128] (917s left) syncobj_wait (wait-all-interrupted)
[101.498701] Starting subtest: wait-all-interrupted
[101.600740] Subtest wait-all-interrupted: SUCCESS (0.101s)
[101.668539] [019/128] (917s left) kms_flip (dpms-off-confusion-interruptible)
[101.769435] Starting subtest: dpms-off-confusion-interruptible
[101.771617] Starting dynamic subtest: A-eDP1
[110.495039] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[110.504624] Starting dynamic subtest: B-eDP1
[119.224114] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[119.239065] Starting dynamic subtest: C-eDP1
[127.943606] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[127.953059] Starting dynamic subtest: D-eDP1
[136.569531] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[136.571885] Subtest dpms-off-confusion-interruptible: SUCCESS (34.800s)
[137.730666] [020/128] (881s left) kms_addfb_basic (master-rmfb)
[137.793636] Starting subtest: master-rmfb
[137.795747] Subtest master-rmfb: SUCCESS (0.001s)
[137.954889] [021/128] (881s left) kms_color (invalid-gamma-lut-sizes)
[138.052801] Starting subtest: invalid-gamma-lut-sizes
[138.055091] Starting dynamic subtest: pipe-A
[138.337615] Dynamic subtest pipe-A: SUCCESS (0.282s)
[138.349699] Starting dynamic subtest: pipe-B
[138.352189] Dynamic subtest pipe-B: SUCCESS (0.001s)
[138.361417] Starting dynamic subtest: pipe-C
[138.363708] Dynamic subtest pipe-C: SUCCESS (0.001s)
[138.370915] Starting dynamic subtest: pipe-D
[138.373192] Dynamic subtest pipe-D: SUCCESS (0.001s)
[138.375471] Subtest invalid-gamma-lut-sizes: SUCCESS (0.285s)
[139.154715] [022/128] (880s left) kms_flip (nonblocking-read)
[139.258423] Starting subtest: nonblocking-read
[139.260668] Subtest nonblocking-read: SUCCESS (0.000s)
[139.368079] [023/128] (880s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[139.470641] Starting subtest: psr-1p-pri-indfb-multidraw
[159.395908] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (19.927s)
[159.510078] [024/128] (859s left) gem_mmap_offset (bad-flags)
[159.571380] Starting subtest: bad-flags
[159.573574] Subtest bad-flags: SUCCESS (0.000s)
[159.669867] [025/128] (859s left) gem_fence_thrash (bo-write-verify-x)
[159.704912] Starting subtest: bo-write-verify-x
[159.723821] Subtest bo-write-verify-x: SKIP (0.018s)
[159.774347] [026/128] (859s left) gem_mmap_gtt (big-copy)
[159.836190] Subtest big-copy: SKIP (0.000s)
[159.909260] [027/128] (859s left) gem_pxp (verify-pxp-stale-buf-execution)
[160.037255] Starting subtest: verify-pxp-stale-buf-execution
[161.096770] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.061s)
[161.229539] [028/128] (858s left) gem_softpin (allocator-fork)
[161.299149] Starting subtest: allocator-fork
[163.513051] Subtest allocator-fork: SUCCESS (2.212s)
[163.668385] [029/128] (855s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[163.878776] Starting subtest: cursor-rapid-movement-256x256
[163.883698] Starting dynamic subtest: pipe-A-eDP-1
[164.436547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[164.461473] Starting dynamic subtest: pipe-D-eDP-1
[165.621515] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.166s)
[165.623909] Subtest cursor-rapid-movement-256x256: SUCCESS (1.741s)
[166.464857] [030/128] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[166.570405] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[166.574730] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[166.671299] [031/128] (852s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[166.797899] Starting subtest: basic-busy-flip-before-cursor-legacy
[166.802059] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[166.888884] [032/128] (852s left) drm_fdinfo (most-busy-check-all)
[166.928871] Starting subtest: most-busy-check-all
[166.931351] Starting dynamic subtest: rcs0
[166.936254] Dynamic subtest rcs0: SKIP (0.005s)
[166.943910] Starting dynamic subtest: bcs0
[166.948084] Dynamic subtest bcs0: SKIP (0.000s)
[166.956051] Starting dynamic subtest: vcs0
[166.960646] Dynamic subtest vcs0: SKIP (0.000s)
[166.970261] Starting dynamic subtest: vcs1
[166.974255] Dynamic subtest vcs1: SKIP (0.000s)
[166.981322] Starting dynamic subtest: vecs0
[166.985305] Dynamic subtest vecs0: SKIP (0.000s)
[166.992398] Starting dynamic subtest: ccs0
[166.996300] Dynamic subtest ccs0: SKIP (0.000s)
[167.000192] Subtest most-busy-check-all: SKIP (0.009s)
[167.031546] [033/128] (852s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[167.157269] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[167.159555] Starting dynamic subtest: pipe-A-eDP-1
[167.181974] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.191609] Starting dynamic subtest: pipe-B-eDP-1
[167.212167] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.219607] Starting dynamic subtest: pipe-C-eDP-1
[167.240973] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.248271] Starting dynamic subtest: pipe-D-eDP-1
[167.270184] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.274638] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[169.321173] [034/128] (850s left) kms_psr (fbc-pr-primary-render)
[169.425955] Starting subtest: fbc-pr-primary-render
[169.430061] Subtest fbc-pr-primary-render: SKIP (0.000s)
[169.492443] [035/128] (850s left) kms_lease (simple-lease)
[169.592994] Starting subtest: simple-lease
[169.595372] Starting dynamic subtest: pipe-A-eDP-1
[170.107490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.517s)
[170.116784] Starting dynamic subtest: pipe-B-eDP-1
[171.547630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[171.555249] Starting dynamic subtest: pipe-C-eDP-1
[172.932084] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[172.945475] Starting dynamic subtest: pipe-D-eDP-1
[174.334524] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[174.336890] Subtest simple-lease: SUCCESS (4.744s)
[175.132808] [036/128] (844s left) i915_pm_freq_api (freq-suspend)
[175.198389] Starting subtest: freq-suspend
[175.200639] Starting dynamic subtest: gt0
[191.493528] Dynamic subtest gt0: SUCCESS (1.302s)
[191.508146] Starting dynamic subtest: gt1
[207.406162] Dynamic subtest gt1: SUCCESS (1.124s)
[207.423686] Subtest freq-suspend: SUCCESS (2.428s)
[208.475004] [037/128] (842s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[208.576898] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[211.873837] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.300s)
[211.982115] [038/128] (838s left) perf_pmu (busy-accuracy-98)
[212.022147] Starting subtest: busy-accuracy-98
[212.024032] Starting dynamic subtest: rcs0
[215.059685] Dynamic subtest rcs0: SUCCESS (3.033s)
[215.068045] Starting dynamic subtest: bcs0
[218.112202] Dynamic subtest bcs0: SUCCESS (3.049s)
[218.120776] Starting dynamic subtest: vcs0
[221.155541] Dynamic subtest vcs0: SUCCESS (3.041s)
[221.166655] Starting dynamic subtest: vcs1
[224.199599] Dynamic subtest vcs1: SUCCESS (3.042s)
[224.209820] Starting dynamic subtest: vecs0
[227.241326] Dynamic subtest vecs0: SUCCESS (3.039s)
[227.252098] Starting dynamic subtest: ccs0
[230.291867] Dynamic subtest ccs0: SUCCESS (3.048s)
[230.293912] Subtest busy-accuracy-98: SUCCESS (18.265s)
[230.397249] [039/128] (820s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[230.452674] Starting subtest: multi-wait-all-for-submit-available-submitted
[230.454942] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[230.558000] [040/128] (820s left) kms_cursor_crc (cursor-dpms)
[230.674303] Starting subtest: cursor-dpms
[230.676722] Starting dynamic subtest: pipe-A-eDP-1
[233.704589] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.026s)
[233.713706] Starting dynamic subtest: pipe-D-eDP-1
[237.258350] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.554s)
[237.260270] Subtest cursor-dpms: SUCCESS (6.582s)
[238.083984] [041/128] (812s left) kms_getfb (getfb-handle-valid)
[238.148825] Starting subtest: getfb-handle-valid
[238.151346] Subtest getfb-handle-valid: SUCCESS (0.000s)
[238.268226] [042/128] (812s left) vgem_slow (nohang)
[238.368276] Starting subtest: nohang
[248.535877] Subtest nohang: SUCCESS (10.160s)
[248.594286] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[248.597471] [043/128] (802s left) syncobj_wait (wait-any-interrupted)
[248.661987] Starting subtest: wait-any-interrupted
[248.762019] Subtest wait-any-interrupted: SUCCESS (0.102s)
[248.834413] [044/128] (802s left) syncobj_timeline (single-wait-available-submitted)
[248.891560] Starting subtest: single-wait-available-submitted
[248.893918] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[249.000781] [045/128] (801s left) gem_pxp (hw-rejects-pxp-context)
[249.107775] Starting subtest: hw-rejects-pxp-context
[249.112608] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[249.210941] [046/128] (801s left) gem_userptr_blits (sync-unmap-after-close)
[249.288825] Starting subtest: sync-unmap-after-close
[249.304859] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[249.453702] [047/128] (801s left) gem_basic (multigpu-create-close)
[249.499569] Starting subtest: multigpu-create-close
[249.504258] Subtest multigpu-create-close: SKIP (0.000s)
[249.588803] [048/128] (801s left) syncobj_wait (invalid-single-wait-unsubmitted)
[249.664587] Starting subtest: invalid-single-wait-unsubmitted
[249.666778] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[249.772622] [049/128] (801s left) gem_exec_schedule (u-lateslice)
[249.849680] Starting subtest: u-lateslice
[249.851665] Starting dynamic subtest: rcs0
[249.873010] Dynamic subtest rcs0: SUCCESS (0.029s)
[249.881743] Starting dynamic subtest: bcs0
[249.894105] Dynamic subtest bcs0: SUCCESS (0.021s)
[249.902696] Starting dynamic subtest: vcs0
[249.918798] Dynamic subtest vcs0: SUCCESS (0.024s)
[249.926731] Starting dynamic subtest: vcs1
[249.938207] Dynamic subtest vcs1: SUCCESS (0.019s)
[249.946952] Starting dynamic subtest: vecs0
[249.955185] Dynamic subtest vecs0: SUCCESS (0.016s)
[249.962794] Starting dynamic subtest: ccs0
[249.978548] Dynamic subtest ccs0: SUCCESS (0.023s)
[249.981597] Subtest u-lateslice: SUCCESS (0.134s)
[251.812219] [050/128] (799s left) gem_exec_flush (basic-wb-pro-default)
[251.880017] Starting subtest: basic-wb-pro-default
[257.382590] Subtest basic-wb-pro-default: SUCCESS (5.499s)
[257.569885] [051/128] (793s left) kms_vblank (ts-continuation-idle-hang)
[257.672270] Starting subtest: ts-continuation-idle-hang
[257.674572] Starting dynamic subtest: pipe-A-eDP-1
[285.423239] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.742s)
[285.437786] Starting dynamic subtest: pipe-D-eDP-1
[310.512969] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.085s)
[310.515510] Subtest ts-continuation-idle-hang: SUCCESS (52.830s)
[311.345156] [052/128] (739s left) gem_lmem_swapping (random)
[311.398041] Subtest random: SKIP (0.000s)
[311.435457] [053/128] (739s left) kms_chamelium_frames (dp-frame-dump)
[311.829687] Subtest dp-frame-dump: SKIP (0.000s)
[312.654440] [054/128] (738s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[312.721473] Starting subtest: saturated-hostile-nopreempt
[312.723895] Starting dynamic subtest: rcs0
[312.838075] Dynamic subtest rcs0: SKIP (0.114s)
[312.848580] Starting dynamic subtest: bcs0
[312.861773] Dynamic subtest bcs0: SKIP (0.022s)
[312.869770] Starting dynamic subtest: vcs0
[312.885745] Dynamic subtest vcs0: SKIP (0.023s)
[312.893967] Starting dynamic subtest: vcs1
[312.909940] Dynamic subtest vcs1: SKIP (0.023s)
[312.918407] Starting dynamic subtest: vecs0
[312.933818] Dynamic subtest vecs0: SKIP (0.022s)
[312.942282] Starting dynamic subtest: ccs0
[312.958890] Dynamic subtest ccs0: SKIP (0.023s)
[312.963347] Subtest saturated-hostile-nopreempt: SKIP (0.236s)
[313.028291] [055/128] (738s left) kms_pm_rpm (basic-rte)
[313.065079] Starting subtest: basic-rte
[316.312720] Subtest basic-rte: SUCCESS (3.252s)
[318.083506] [056/128] (733s left) api_intel_allocator (reloc-allocator)
[318.145907] Starting subtest: reloc-allocator
[318.148468] Starting dynamic subtest: basic
[318.150972] Dynamic subtest basic: SUCCESS (0.004s)
[318.162414] Starting dynamic subtest: parallel-one
[318.164545] Dynamic subtest parallel-one: SUCCESS (0.008s)
[318.173117] Starting dynamic subtest: print
[318.175620] Dynamic subtest print: SUCCESS (0.000s)
[318.186246] Starting dynamic subtest: reuse
[318.188400] Dynamic subtest reuse: SUCCESS (0.000s)
[318.196961] Starting dynamic subtest: fork-reopen-allocator
[318.199189] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[318.201355] Subtest reloc-allocator: SUCCESS (0.030s)
[318.296417] [057/128] (733s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[318.426363] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[318.430664] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[318.557540] [058/128] (732s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[318.616951] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[318.619340] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[318.715697] [059/128] (732s left) gem_spin_batch (legacy-resubmit)
[318.779693] Starting subtest: legacy-resubmit
[318.782094] Starting dynamic subtest: default
[318.787882] Dynamic subtest default: SUCCESS (0.006s)
[318.799449] Starting dynamic subtest: render
[318.801713] Dynamic subtest render: SUCCESS (0.001s)
[318.810276] Starting dynamic subtest: bsd
[318.812146] Dynamic subtest bsd: SUCCESS (0.002s)
[318.820366] Starting dynamic subtest: bsd1
[318.822428] Dynamic subtest bsd1: SUCCESS (0.002s)
[318.831809] Starting dynamic subtest: bsd2
[318.833716] Dynamic subtest bsd2: SUCCESS (0.001s)
[318.841809] Starting dynamic subtest: blt
[318.843865] Dynamic subtest blt: SUCCESS (0.002s)
[318.853364] Starting dynamic subtest: vebox
[318.855282] Dynamic subtest vebox: SUCCESS (0.003s)
[318.857153] Subtest legacy-resubmit: SUCCESS (0.022s)
[319.037103] [060/128] (732s left) gem_exec_balancer (busy)
[319.100998] Starting subtest: busy
[320.724427] Subtest busy: SUCCESS (1.621s)
[321.048487] [061/128] (730s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[326.020008] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[326.022645] Starting dynamic subtest: pipe-A-eDP-1
[326.825223] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[326.834116] Starting dynamic subtest: pipe-B-eDP-1
[327.949083] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[327.953648] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.928s)
[329.121715] [062/128] (722s left) kms_prime (basic-crc-vgem)
[331.229237] Starting subtest: basic-crc-vgem
[331.231468] Starting dynamic subtest: second-to-first
[332.133451] Dynamic subtest second-to-first: SUCCESS (0.908s)
[332.135778] Subtest basic-crc-vgem: SUCCESS (0.908s)
[332.206503] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.amdgpu: true
[332.207171] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.xe: true
[332.210457] [063/128] (719s left) gem_caching (writes)
[332.302897] Subtest writes: SKIP (0.000s)
[332.363179] [064/128] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[332.461783] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[332.465115] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[332.571969] [065/128] (719s left) i915_suspend (fence-restore-tiled2untiled)
[332.634318] Starting subtest: fence-restore-tiled2untiled
[332.637927] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[332.747247] [066/128] (718s left) prime_vgem (shrink)
[332.823167] Starting subtest: shrink
[332.836330] Subtest shrink: SUCCESS (0.011s)
[332.959486] [067/128] (718s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[333.064980] Starting subtest: crc-primary-basic-yf-tiled-ccs
[333.066821] Starting dynamic subtest: pipe-A-eDP-1
[333.085776] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[333.095558] Starting dynamic subtest: pipe-B-eDP-1
[333.113335] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[333.121794] Starting dynamic subtest: pipe-C-eDP-1
[333.139940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.149123] Starting dynamic subtest: pipe-D-eDP-1
[333.167493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.170964] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.008s)
[335.178740] [068/128] (716s left) sw_sync (sync_busy_fork_unixsocket)
[335.215346] Starting subtest: sync_busy_fork_unixsocket
[335.224024] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s)
[335.283611] [069/128] (716s left) gem_linear_blits (basic)
[335.713492] Starting subtest: basic
[335.724920] Subtest basic: SUCCESS (0.011s)
[335.873160] [070/128] (715s left) prime_busy (before)
[335.979120] Starting subtest: before
[335.984413] Starting dynamic subtest: rcs0
[336.028605] Dynamic subtest rcs0: SUCCESS (0.045s)
[336.039470] Starting dynamic subtest: bcs0
[336.110885] Dynamic subtest bcs0: SUCCESS (0.081s)
[336.120622] Starting dynamic subtest: vcs0
[336.151309] Dynamic subtest vcs0: SUCCESS (0.040s)
[336.160125] Starting dynamic subtest: vcs1
[336.192754] Dynamic subtest vcs1: SUCCESS (0.041s)
[336.201583] Starting dynamic subtest: vecs0
[336.233296] Dynamic subtest vecs0: SUCCESS (0.040s)
[336.242106] Starting dynamic subtest: ccs0
[336.274343] Dynamic subtest ccs0: SUCCESS (0.041s)
[336.383786] Subtest before: SUCCESS (0.403s)
[336.454356] [071/128] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[336.551793] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[341.686719] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.137s)
[341.829334] [072/128] (710s left) kms_psr (fbc-psr2-sprite-blt)
[341.939102] Starting subtest: fbc-psr2-sprite-blt
[341.941429] Starting dynamic subtest: eDP-1
[341.945819] Dynamic subtest eDP-1: SKIP (0.000s)
[341.950241] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[342.007948] [073/128] (709s left) gem_exec_schedule (semaphore-power)
[342.198856] Subtest semaphore-power: SKIP (0.000s)
[342.373416] [074/128] (709s left) kms_psr (psr-no-drrs)
[342.462578] Starting subtest: psr-no-drrs
[342.464975] Starting dynamic subtest: eDP-1
[344.091761] Dynamic subtest eDP-1: SUCCESS (1.628s)
[344.094060] Subtest psr-no-drrs: SUCCESS (1.629s)
[344.961872] [075/128] (707s left) gem_exec_flush (basic-uc-set-default)
[345.031805] Starting subtest: basic-uc-set-default
[350.510577] Subtest basic-uc-set-default: SUCCESS (5.478s)
[350.687418] [076/128] (701s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[350.794337] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[350.796695] Starting dynamic subtest: pipe-A-default-mode
[351.102518] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[351.107212] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.304s)
[351.886503] [077/128] (700s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[351.949581] Starting subtest: etime-single-wait-all-for-submit-submitted
[352.054684] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[352.125934] [078/128] (699s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[352.221271] Starting subtest: nonblocking-crc-frame-sequence
[352.223619] Starting dynamic subtest: pipe-A-eDP-1
[352.949933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[352.959770] Starting dynamic subtest: pipe-B-eDP-1
[354.391945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s)
[354.401020] Starting dynamic subtest: pipe-C-eDP-1
[355.780101] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[355.789676] Starting dynamic subtest: pipe-D-eDP-1
[357.132788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[357.135173] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.910s)
[357.997757] [079/128] (694s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[358.112747] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[359.134974] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.022s)
[359.287012] [080/128] (692s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[359.392016] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[360.583143] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.189s)
[360.713430] [081/128] (691s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[361.104558] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[361.894075] [082/128] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[362.005715] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[362.009942] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[362.094370] [083/128] (690s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[362.199246] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[362.203686] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[363.346414] [084/128] (688s left) kms_plane (plane-panning-bottom-right)
[363.459004] Starting subtest: plane-panning-bottom-right
[363.461419] Starting dynamic subtest: pipe-A
[365.089823] Dynamic subtest pipe-A: SUCCESS (1.628s)
[365.100088] Starting dynamic subtest: pipe-B
[367.353767] Dynamic subtest pipe-B: SUCCESS (2.262s)
[367.356129] Subtest plane-panning-bottom-right: SUCCESS (3.893s)
[368.156280] [085/128] (684s left) gem_ctx_exec (basic-nohangcheck)
[368.229070] Starting subtest: basic-nohangcheck
[368.475836] Subtest basic-nohangcheck: SUCCESS (0.248s)
[368.604316] [086/128] (683s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[368.713313] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[368.717167] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[368.812746] [087/128] (683s left) gem_exec_basic (basic)
[368.878817] Starting subtest: basic
[368.881328] Starting dynamic subtest: rcs0-smem
[368.883702] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[368.894781] Starting dynamic subtest: bcs0-smem
[368.896716] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[368.905220] Starting dynamic subtest: vcs0-smem
[368.907112] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[368.915725] Starting dynamic subtest: vcs1-smem
[368.917672] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[368.926115] Starting dynamic subtest: vecs0-smem
[368.927999] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[368.936331] Starting dynamic subtest: ccs0-smem
[368.938184] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[368.940077] Subtest basic: SUCCESS (0.012s)
[370.717657] [088/128] (681s left) kms_psr (pr-basic)
[370.823019] Starting subtest: pr-basic
[370.827479] Subtest pr-basic: SKIP (0.000s)
[370.894736] [089/128] (681s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[371.001664] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[371.005942] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[371.106580] [090/128] (681s left) kms_cursor_crc (cursor-random-128x42)
[371.298553] Starting subtest: cursor-random-128x42
[371.339843] Subtest cursor-random-128x42: SKIP (0.036s)
[371.521279] [091/128] (681s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[371.574824] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[371.627495] [092/128] (681s left) drm_fdinfo (all-busy-idle-check-all)
[371.668126] Starting subtest: all-busy-idle-check-all
[371.675080] Subtest all-busy-idle-check-all: SKIP (0.004s)
[371.728005] [093/128] (680s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[371.870266] Starting subtest: 2x-flip-vs-rmfb-interruptible
[371.882467] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[371.999548] [094/128] (680s left) kms_writeback (writeback-invalid-parameters)
[372.109656] Subtest writeback-invalid-parameters: SKIP (0.000s)
[372.150616] [095/128] (680s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[372.257923] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[372.261406] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[372.357901] [096/128] (680s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[377.402416] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[377.407378] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[378.253581] [097/128] (674s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[378.354837] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[378.358683] Starting dynamic subtest: pipe-A-default-mode
[378.642871] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[378.647867] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.284s)
[379.475755] [098/128] (673s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[379.579626] Starting subtest: x-tiled-64bpp-rotate-180
[381.834115] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.255s)
[382.108122] [099/128] (670s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[382.210201] Starting subtest: bad-rotation-90-y-tiled-ccs
[382.212550] Starting dynamic subtest: pipe-A-eDP-1
[382.236296] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[382.246366] Starting dynamic subtest: pipe-B-eDP-1
[382.268780] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[382.278648] Starting dynamic subtest: pipe-C-eDP-1
[382.301321] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[382.311762] Starting dynamic subtest: pipe-D-eDP-1
[382.334954] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[382.339130] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[384.322879] [100/128] (668s left) gem_ctx_param (invalid-get-no-zeromap)
[384.390495] Starting subtest: invalid-get-no-zeromap
[384.392679] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[384.501070] [101/128] (668s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[384.559489] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[384.662351] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[384.737463] [102/128] (668s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[384.834339] Starting subtest: fbcpsr-indfb-scaledprimary
[390.536801] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.705s)
[390.673374] [103/128] (662s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[390.786569] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[390.790695] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[390.889206] [104/128] (662s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[390.988358] Starting subtest: yf-tiled-64bpp-rotate-180
[390.993112] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[391.082126] [105/128] (662s left) kms_plane_scaling (planes-upscale-20x20)
[391.179224] Starting subtest: planes-upscale-20x20
[391.181498] Starting dynamic subtest: pipe-A
[391.245499] Dynamic subtest pipe-A: SUCCESS (0.066s)
[391.255769] Starting dynamic subtest: pipe-B
[392.390717] Dynamic subtest pipe-B: SUCCESS (1.144s)
[392.401823] Starting dynamic subtest: pipe-C
[393.492511] Dynamic subtest pipe-C: SUCCESS (1.101s)
[393.502982] Starting dynamic subtest: pipe-D
[394.613151] Dynamic subtest pipe-D: SUCCESS (1.120s)
[394.615412] Subtest planes-upscale-20x20: SUCCESS (3.434s)
[395.759121] [106/128] (657s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[395.867270] Starting subtest: 4-tiled-32bpp-rotate-0
[397.467833] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.600s)
[397.653531] [107/128] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[397.765730] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[397.770141] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[397.858504] [108/128] (655s left) kms_getfb (getfb-handle-closed)
[397.908799] Starting subtest: getfb-handle-closed
[397.911058] Subtest getfb-handle-closed: SUCCESS (0.000s)
[398.009598] [109/128] (655s left) kms_hdmi_inject (inject-4k)
[398.351626] Starting subtest: inject-4k
[398.654426] Subtest inject-4k: SUCCESS (0.304s)
[399.219659] [110/128] (654s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[399.334527] Starting subtest: psr-rgb101010-draw-mmap-wc
[404.230276] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.898s)
[404.338784] [111/128] (648s left) gem_exec_nop (basic-sequential)
[404.416496] Starting subtest: basic-sequential
[419.180720] Subtest basic-sequential: SUCCESS (14.772s)
[419.420029] [112/128] (633s left) kms_flip (modeset-vs-vblank-race)
[419.516252] Starting subtest: modeset-vs-vblank-race
[419.518556] Starting dynamic subtest: A-eDP1
[424.284501] Dynamic subtest A-eDP1: SUCCESS (4.767s)
[424.295888] Starting dynamic subtest: B-eDP1
[428.980350] Dynamic subtest B-eDP1: SUCCESS (4.693s)
[428.992394] Starting dynamic subtest: C-eDP1
[433.658460] Dynamic subtest C-eDP1: SUCCESS (4.676s)
[433.668213] Starting dynamic subtest: D-eDP1
[438.359818] Dynamic subtest D-eDP1: SUCCESS (4.699s)
[438.362091] Subtest modeset-vs-vblank-race: SUCCESS (18.846s)
[439.583738] [113/128] (613s left) kms_flip (plain-flip-ts-check-interruptible)
[439.684021] Starting subtest: plain-flip-ts-check-interruptible
[439.686227] Starting dynamic subtest: A-eDP1
[448.559222] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[448.569898] Starting dynamic subtest: B-eDP1
[457.444370] Dynamic subtest B-eDP1: SUCCESS (8.884s)
[457.454990] Starting dynamic subtest: C-eDP1
[466.332275] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[466.342617] Starting dynamic subtest: D-eDP1
[475.231996] Dynamic subtest D-eDP1: SUCCESS (8.899s)
[475.237341] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.553s)
[476.478494] [114/128] (576s left) gen9_exec_parse (bb-start-param)
[476.544311] Subtest bb-start-param: SKIP (0.000s)
[476.623675] [115/128] (576s left) kms_draw_crc (draw-method-mmap-gtt)
[476.732044] Starting subtest: draw-method-mmap-gtt
[476.736492] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[476.832967] [116/128] (576s left) i915_pm_rps (min-max-config-idle)
[476.901139] Starting subtest: min-max-config-idle
[476.905581] Subtest min-max-config-idle: SKIP (0.000s)
[476.980365] [117/128] (576s left) gem_mmap_gtt (pf-nonblock)
[477.035684] Subtest pf-nonblock: SKIP (0.000s)
[477.098697] [118/128] (576s left) kms_cdclk (mode-transition-all-outputs)
[477.208195] Starting subtest: mode-transition-all-outputs
[477.495281] Subtest mode-transition-all-outputs: SKIP (0.284s)
[478.298514] [119/128] (575s left) kms_getfb (getfb2-handle-protection)
[478.363121] Starting subtest: getfb2-handle-protection
[478.386818] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[478.514035] [120/128] (575s left) prime_mmap (test_aperture_limit)
[478.569515] Starting subtest: test_aperture_limit
[478.571400] Starting dynamic subtest: test_aperture_limit-smem
[478.576348] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.007s)
[478.578592] Subtest test_aperture_limit: SUCCESS (0.008s)
[478.676961] [121/128] (575s left) gem_userptr_blits (map-fixed-invalidate)
[478.753128] Starting subtest: map-fixed-invalidate
[478.757377] Subtest map-fixed-invalidate: SKIP (0.000s)
[478.903535] [122/128] (574s left) gem_exec_gttfill (multigpu-basic)
[479.080742] Starting subtest: multigpu-basic
[495.101504] Subtest multigpu-basic: SUCCESS (16.020s)
[495.149563] [123/128] (558s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[495.241109] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[495.349141] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[495.422030] [124/128] (558s left) kms_scaling_modes (scaling-mode-full)
[495.535183] Starting subtest: scaling-mode-full
[495.537416] Starting dynamic subtest: pipe-A-eDP-1
[495.650148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[495.660190] Starting dynamic subtest: pipe-B-eDP-1
[496.874275] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s)
[496.888122] Starting dynamic subtest: pipe-C-eDP-1
[498.050791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.173s)
[498.060989] Starting dynamic subtest: pipe-D-eDP-1
[499.251662] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.200s)
[499.254383] Subtest scaling-mode-full: SUCCESS (3.717s)
[500.476401] [125/128] (553s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[500.581679] Starting subtest: plane-upscale-20x20-with-modifiers
[500.584899] Starting dynamic subtest: pipe-A
[500.916707] Dynamic subtest pipe-A: SUCCESS (0.338s)
[500.926270] Starting dynamic subtest: pipe-B
[502.343957] Dynamic subtest pipe-B: SUCCESS (1.426s)
[502.355588] Starting dynamic subtest: pipe-C
[503.739645] Dynamic subtest pipe-C: SUCCESS (1.395s)
[503.748767] Starting dynamic subtest: pipe-D
[505.141136] Dynamic subtest pipe-D: SUCCESS (1.400s)
[505.143299] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.563s)
[506.273528] [126/128] (547s left) gen3_render_tiledy_blits
[506.402921] [127/128] (547s left) kms_invalid_mode (bad-vsync-end)
[506.513426] Starting subtest: bad-vsync-end
[506.515780] Starting dynamic subtest: pipe-A-eDP-1
[506.793817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[506.804090] Starting dynamic subtest: pipe-B-eDP-1
[506.806514] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[506.815303] Starting dynamic subtest: pipe-C-eDP-1
[506.817816] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.826347] Starting dynamic subtest: pipe-D-eDP-1
[506.828385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.830506] Subtest bad-vsync-end: SUCCESS (0.287s)
[507.577357] [128/128] (546s left) gem_userptr_blits (unsync-overlap)
[507.652980] Subtest unsync-overlap: SKIP (0.000s)
[507.775146] Closing watchdogs
Done.