[53.628081] Initializing watchdogs
[53.628165]   /dev/watchdog0
[53.642114] [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]
[53.646223] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.648289] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.652060] [001/131] (960s left) gem_blits (basic)
[53.727830] Starting subtest: basic
[55.826046] Subtest basic: SUCCESS (2.142s)
[55.941964] [002/131] (958s left) gem_exec_reloc (basic-scanout)
[56.008452] Subtest basic-scanout: SKIP (0.000s)
[56.070440] [003/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[56.174908] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[56.178755] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[56.272214] [004/131] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[56.368473] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[56.372919] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[56.459331] [005/131] (957s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[56.853549] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[57.643186] [006/131] (956s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[57.740068] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[57.742506] Starting dynamic subtest: pipe-A-default-mode
[58.035472] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[58.040217] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.297s)
[58.875703] [007/131] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[58.973794] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[58.978302] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[59.074877] [008/131] (955s left) kms_big_fb (linear-8bpp-rotate-0)
[59.170419] Starting subtest: linear-8bpp-rotate-0
[60.446096] Subtest linear-8bpp-rotate-0: SUCCESS (1.291s)
[60.618177] [009/131] (953s left) gem_vm_create (invalid-create)
[60.672430] Starting subtest: invalid-create
[60.676413] Subtest invalid-create: SUCCESS (0.002s)
[60.771052] [010/131] (953s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[60.873595] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[60.876881] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.967116] [011/131] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[61.070074] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[61.073795] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.172592] [012/131] (953s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[61.271352] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[61.282848] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[61.350437] [013/131] (953s left) kms_vblank (query-busy)
[61.444424] Starting subtest: query-busy
[61.446408] Starting dynamic subtest: pipe-A-eDP-1
[63.319209] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[63.336181] Starting dynamic subtest: pipe-D-eDP-1
[65.881270] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[65.883423] Subtest query-busy: SUCCESS (4.464s)
[66.662723] [014/131] (947s left) kms_plane_lowres (tiling-y)
[66.777164] Starting subtest: tiling-y
[66.781740] Subtest tiling-y: SKIP (0.000s)
[66.846963] [015/131] (947s left) prime_vgem (basic-fence-blt)
[66.992784] Starting subtest: basic-fence-blt
[67.069037] Subtest basic-fence-blt: SUCCESS (0.076s)
[67.200176] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[67.203819] [016/131] (947s left) kms_chamelium_hpd (dp-hpd-fast)
[67.581401] Subtest dp-hpd-fast: SKIP (0.000s)
[68.359197] [017/131] (946s left) gem_pread (bench)
[68.421391] Subtest bench: SKIP (0.000s)
[68.490831] [018/131] (946s left) kms_psr (fbc-psr2-primary-page-flip)
[68.584012] Starting subtest: fbc-psr2-primary-page-flip
[68.586266] Starting dynamic subtest: eDP-1
[68.590648] Dynamic subtest eDP-1: SKIP (0.000s)
[68.594943] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[68.655568] [019/131] (946s left) gem_fence_thrash (bo-write-verify-x)
[68.688688] Starting subtest: bo-write-verify-x
[68.703230] Subtest bo-write-verify-x: SKIP (0.013s)
[68.772656] [020/131] (946s left) gem_ctx_exec (basic-norecovery)
[68.825339] Starting subtest: basic-norecovery
[69.096945] Subtest basic-norecovery: SUCCESS (0.272s)
[69.242366] [021/131] (945s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[69.292793] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[69.348715] [022/131] (945s left) kms_feature_discovery (display-4x)
[69.429059] Starting subtest: display-4x
[69.432505] Subtest display-4x: SKIP (0.000s)
[69.498050] [023/131] (945s left) kms_flip (basic-flip-vs-wf_vblank)
[69.588622] Starting subtest: basic-flip-vs-wf_vblank
[69.590589] Starting dynamic subtest: A-eDP1
[71.506687] Dynamic subtest A-eDP1: SUCCESS (1.922s)
[71.515651] Starting dynamic subtest: B-eDP1
[73.432292] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[73.441194] Starting dynamic subtest: C-eDP1
[75.338311] Dynamic subtest C-eDP1: SUCCESS (1.909s)
[75.345896] Starting dynamic subtest: D-eDP1
[77.260465] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[77.262839] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.689s)
[78.470887] [024/131] (936s left) kms_async_flips (test-time-stamp-atomic)
[78.568868] Starting subtest: test-time-stamp-atomic
[78.953704] Starting dynamic subtest: pipe-A-eDP-1
[79.773980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[80.137555] Starting dynamic subtest: pipe-B-eDP-1
[80.896577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[81.271071] Starting dynamic subtest: pipe-C-eDP-1
[82.023302] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.758s)
[82.384858] Starting dynamic subtest: pipe-D-eDP-1
[83.149026] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[83.151446] Subtest test-time-stamp-atomic: SUCCESS (4.580s)
[84.294965] [025/131] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[84.386968] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[88.024869] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.642s)
[89.199657] [026/131] (925s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[89.258099] Starting subtest: etime-single-wait-for-submit-unsubmitted
[89.358238] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[89.430147] [027/131] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[89.524397] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[89.528352] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[89.615559] [028/131] (925s left) syncobj_timeline (invalid-signal-bad-pad)
[89.672362] Starting subtest: invalid-signal-bad-pad
[89.674689] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[89.757528] [029/131] (925s left) i915_pm_rpm (gem-execbuf)
[92.091509] Starting subtest: gem-execbuf
[92.094716] Starting dynamic subtest: smem0
[93.824902] Dynamic subtest smem0: SUCCESS (1.732s)
[93.827363] Subtest gem-execbuf: SUCCESS (1.733s)
[93.941982] [030/131] (921s left) gem_ctx_persistence (legacy-engines-queued)
[94.004180] Starting subtest: legacy-engines-queued
[94.006700] Starting dynamic subtest: render
[94.060526] Dynamic subtest render: SUCCESS (0.056s)
[94.068680] Starting dynamic subtest: bsd1
[95.859819] Dynamic subtest bsd1: SUCCESS (1.797s)
[95.868714] Starting dynamic subtest: bsd2
[97.841912] Dynamic subtest bsd2: SUCCESS (1.980s)
[97.852205] Starting dynamic subtest: blt
[97.921289] Dynamic subtest blt: SUCCESS (0.079s)
[97.929674] Starting dynamic subtest: vebox
[99.889767] Dynamic subtest vebox: SUCCESS (1.966s)
[99.892782] Subtest legacy-engines-queued: SUCCESS (5.884s)
[99.966184] [031/131] (915s left) sysfs_timeslice_duration (timeout)
[100.014334] Starting subtest: timeout
[100.016573] Starting dynamic subtest: vecs0
[109.930100] Dynamic subtest vecs0: SUCCESS (9.912s)
[109.940742] Starting dynamic subtest: ccs0
[111.355563] Dynamic subtest ccs0: SUCCESS (1.426s)
[111.365657] Starting dynamic subtest: vcs0
[120.936748] Dynamic subtest vcs0: SUCCESS (9.579s)
[120.944873] Starting dynamic subtest: bcs0
[121.628023] Dynamic subtest bcs0: SUCCESS (0.691s)
[121.637733] Starting dynamic subtest: rcs0
[122.972916] Dynamic subtest rcs0: SUCCESS (1.345s)
[122.983975] Starting dynamic subtest: vcs1
[132.895025] Dynamic subtest vcs1: SUCCESS (9.920s)
[132.897556] Subtest timeout: SUCCESS (32.877s)
[132.966405] [032/131] (882s left) gem_exec_schedule (u-submit-golden-slice)
[133.045352] Starting subtest: u-submit-golden-slice
[133.047664] Starting dynamic subtest: rcs0
[133.096839] Dynamic subtest rcs0: SUCCESS (0.058s)
[133.105111] Starting dynamic subtest: bcs0
[133.152157] Dynamic subtest bcs0: SUCCESS (0.056s)
[133.159408] Starting dynamic subtest: vcs0
[133.210479] Dynamic subtest vcs0: SUCCESS (0.058s)
[133.219851] Starting dynamic subtest: vcs1
[133.262045] Dynamic subtest vcs1: SUCCESS (0.052s)
[133.272870] Starting dynamic subtest: vecs0
[133.307912] Dynamic subtest vecs0: SUCCESS (0.045s)
[133.315484] Starting dynamic subtest: ccs0
[133.362650] Dynamic subtest ccs0: SUCCESS (0.055s)
[133.365054] Subtest u-submit-golden-slice: SUCCESS (0.324s)
[135.044331] [033/131] (880s left) api_intel_bb (misplaced-blitter)
[135.104676] Starting subtest: misplaced-blitter
[135.114491] Subtest misplaced-blitter: SUCCESS (0.010s)
[135.258441] [034/131] (880s left) fbdev (pan)
[135.289074] Starting subtest: pan
[135.317920] Subtest pan: SUCCESS (0.031s)
[135.387594] [035/131] (880s left) gem_ctx_persistence (heartbeat-hang)
[135.446758] Starting subtest: heartbeat-hang
[135.451381] Subtest heartbeat-hang: SKIP (0.000s)
[135.551052] [036/131] (879s left) syncobj_timeline (single-wait-all-available-signaled)
[135.591762] Starting subtest: single-wait-all-available-signaled
[135.594084] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[135.699246] [037/131] (879s left) kms_tv_load_detect (load-detect)
[135.748905] Subtest load-detect: SKIP (0.000s)
[135.815245] [038/131] (879s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[136.065317] Starting subtest: parallel-dmabuf-import-out-fence
[137.148708] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.083s)
[137.242413] [039/131] (878s left) perf (disabled-read-error)
[137.353317] Starting subtest: disabled-read-error
[137.382483] Subtest disabled-read-error: SUCCESS (0.029s)
[137.432560] [040/131] (878s left) gem_exec_schedule (preempt-other-chain)
[137.512522] Starting subtest: preempt-other-chain
[137.515229] Starting dynamic subtest: rcs0
[137.646520] Dynamic subtest rcs0: SUCCESS (0.138s)
[137.659263] Starting dynamic subtest: bcs0
[137.777803] Dynamic subtest bcs0: SUCCESS (0.132s)
[137.790363] Starting dynamic subtest: vcs0
[137.905549] Dynamic subtest vcs0: SUCCESS (0.126s)
[137.916523] Starting dynamic subtest: vcs1
[138.036312] Dynamic subtest vcs1: SUCCESS (0.132s)
[138.047617] Starting dynamic subtest: vecs0
[138.163079] Dynamic subtest vecs0: SUCCESS (0.126s)
[138.174034] Starting dynamic subtest: ccs0
[138.288800] Dynamic subtest ccs0: SUCCESS (0.126s)
[138.291078] Subtest preempt-other-chain: SUCCESS (0.781s)
[138.985125] [041/131] (876s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[139.091422] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[139.095458] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[139.174982] [042/131] (876s left) kms_setmode (invalid-clone-single-crtc)
[139.221688] Starting subtest: invalid-clone-single-crtc
[139.228151] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[139.313187] [043/131] (876s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[139.406064] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[139.408391] Starting dynamic subtest: pipe-A
[139.417377] Dynamic subtest pipe-A: SKIP (0.005s)
[139.427685] Starting dynamic subtest: pipe-B
[139.436746] Dynamic subtest pipe-B: SKIP (0.018s)
[139.444767] Starting dynamic subtest: pipe-C
[139.453871] Dynamic subtest pipe-C: SKIP (0.018s)
[139.461687] Starting dynamic subtest: pipe-D
[139.470711] Dynamic subtest pipe-D: SKIP (0.018s)
[139.475068] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.059s)
[139.578081] [044/131] (876s left) perf_pmu (module-unload)
[139.674983] Starting subtest: module-unload
[144.843711] Subtest module-unload: FAIL (5.060s)
[144.873961] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[144.874693] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[144.877524] [045/131] (870s left) perf (polling)
[146.312060] Starting subtest: polling
[146.314396] Starting dynamic subtest: 0-rcs0
[156.338298] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[156.346091] Starting dynamic subtest: 1-vecs0
[166.358537] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[166.361320] Subtest polling: SUCCESS (20.044s)
[166.400075] [FACT perf (polling)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[166.401242] [FACT perf (polling)] new: kernel.kmod_is_loaded.i915: true
[166.404744] [046/131] (849s left) kms_flip (flip-vs-rmfb)
[166.522236] Starting subtest: flip-vs-rmfb
[166.524601] Starting dynamic subtest: A-eDP1
[175.170340] Dynamic subtest A-eDP1: SUCCESS (8.647s)
[175.180329] Starting dynamic subtest: B-eDP1
[183.802268] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[183.810591] Starting dynamic subtest: C-eDP1
[192.520823] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[192.530248] Starting dynamic subtest: D-eDP1
[201.142792] Dynamic subtest D-eDP1: SUCCESS (8.620s)
[201.147118] Subtest flip-vs-rmfb: SUCCESS (34.622s)
[202.320798] [047/131] (813s left) kms_psr (psr-primary-blt)
[202.423604] Starting subtest: psr-primary-blt
[202.425988] Starting dynamic subtest: eDP-1
[204.213724] Dynamic subtest eDP-1: SUCCESS (1.791s)
[204.215927] Subtest psr-primary-blt: SUCCESS (1.792s)
[205.070041] [048/131] (810s left) i915_pm_rps (basic-api)
[205.129489] Starting subtest: basic-api
[205.133897] Subtest basic-api: SKIP (0.001s)
[205.209427] [049/131] (810s left) kms_addfb_basic (invalid-set-prop-any)
[205.269174] Starting subtest: invalid-set-prop-any
[205.271585] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[205.415376] [050/131] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[205.516595] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[205.520964] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[205.632468] [051/131] (810s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[205.685840] Starting subtest: yf-tiled-to-vebox-x-tiled
[205.690369] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[205.867259] [052/131] (810s left) i915_selftest (perf)
[209.304789] Starting subtest: perf
[209.306895] Starting dynamic subtest: engine_cs
[213.759967] Dynamic subtest engine_cs: SUCCESS (4.454s)
[213.768390] Starting dynamic subtest: request
[219.103042] Dynamic subtest request: SUCCESS (5.341s)
[219.111855] Starting dynamic subtest: migrate
[222.051505] Dynamic subtest migrate: SUCCESS (2.946s)
[222.060964] Starting dynamic subtest: region
[227.896284] Dynamic subtest region: SUCCESS (5.843s)
[227.899073] Subtest perf: SUCCESS (18.591s)
[227.926327] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[227.927089] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[227.930210] [053/131] (788s left) kms_cursor_crc (cursor-size-hints)
[229.441796] Starting subtest: cursor-size-hints
[229.444283] Starting dynamic subtest: pipe-A-eDP-1
[230.105662] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.662s)
[230.113642] Starting dynamic subtest: pipe-D-eDP-1
[231.392153] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[231.394493] Subtest cursor-size-hints: SUCCESS (1.950s)
[232.179676] [FACT kms_cursor_crc (cursor-size-hints)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[232.180811] [FACT kms_cursor_crc (cursor-size-hints)] new: kernel.kmod_is_loaded.i915: true
[232.184407] [054/131] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[232.306971] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[232.311028] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[232.405517] [055/131] (783s left) syncobj_timeline (wait-all-complex)
[232.463874] Starting subtest: wait-all-complex
[232.677534] Subtest wait-all-complex: SUCCESS (0.213s)
[232.750524] [056/131] (783s left) gem_exec_reloc (basic-gtt-cpu-active)
[232.808488] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[232.883281] [057/131] (783s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[232.938569] Starting subtest: invalid-bsd1-flag-on-blt
[232.940781] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[233.065934] [058/131] (783s left) kms_pm_dc (dc5-psr)
[234.156879] Starting subtest: dc5-psr
[237.030223] Subtest dc5-psr: SUCCESS (2.874s)
[237.899317] [059/131] (778s left) gem_tiled_fence_blits (normal)
[237.958862] Subtest normal: SKIP (0.000s)
[238.046818] [060/131] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[238.146645] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[238.151091] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.255271] [061/131] (778s left) i915_drm_fdinfo (virtual-idle)
[238.293694] Starting subtest: virtual-idle
[241.377452] Subtest virtual-idle: SUCCESS (3.085s)
[241.450249] [062/131] (774s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[241.557281] Starting subtest: y-tiled-8bpp-rotate-270
[241.561350] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[241.655990] [063/131] (774s left) kms_atomic_interruptible (universal-setplane-primary)
[241.758328] Starting subtest: universal-setplane-primary
[241.760587] Starting dynamic subtest: pipe-A-eDP-1
[249.218379] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.459s)
[249.220693] Subtest universal-setplane-primary: SUCCESS (7.460s)
[250.053352] [064/131] (766s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[250.111619] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[250.184369] [065/131] (766s left) kms_pipe_crc_basic (read-crc)
[250.281210] Starting subtest: read-crc
[250.283480] Starting dynamic subtest: pipe-A-eDP-1
[250.985109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[250.993756] Starting dynamic subtest: pipe-B-eDP-1
[252.319216] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.333s)
[252.327795] Starting dynamic subtest: pipe-C-eDP-1
[253.582017] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.259s)
[253.590146] Starting dynamic subtest: pipe-D-eDP-1
[254.942639] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s)
[254.945015] Subtest read-crc: SUCCESS (4.659s)
[255.752284] [066/131] (760s left) gem_userptr_blits (set-cache-level)
[255.824821] Starting subtest: set-cache-level
[255.829416] Subtest set-cache-level: SKIP (0.000s)
[255.953755] [067/131] (760s left) gem_reg_read (timestamp-monotonic)
[256.013593] Starting subtest: timestamp-monotonic
[260.081755] Subtest timestamp-monotonic: SUCCESS (4.068s)
[260.155725] [068/131] (756s left) gem_exec_whisper (basic-fds-all)
[260.213160] Starting subtest: basic-fds-all
[272.003730] Subtest basic-fds-all: SUCCESS (11.790s)
[272.188041] [069/131] (744s left) kms_dsc (dsc-basic)
[272.295358] Starting subtest: dsc-basic
[272.309550] Subtest dsc-basic: SKIP (0.001s)
[272.367740] [070/131] (744s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[272.458121] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[272.460424] Starting dynamic subtest: pipe-A-eDP-1
[272.485437] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.493663] Starting dynamic subtest: pipe-B-eDP-1
[272.517043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.525239] Starting dynamic subtest: pipe-C-eDP-1
[272.548344] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.556136] Starting dynamic subtest: pipe-D-eDP-1
[272.581811] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.586457] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[274.704220] [071/131] (742s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[274.812168] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[274.816658] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[274.910296] [072/131] (741s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[279.957177] Starting subtest: pr-plane-move-sf-dmg-area
[279.961476] Subtest pr-plane-move-sf-dmg-area: SKIP (0.003s)
[280.815196] [073/131] (736s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[280.901070] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[280.903331] Starting dynamic subtest: pipe-A-eDP-1
[280.925189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.934358] Starting dynamic subtest: pipe-B-eDP-1
[280.954903] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.961793] Starting dynamic subtest: pipe-C-eDP-1
[280.982272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.989596] Starting dynamic subtest: pipe-D-eDP-1
[281.011309] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.015693] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[283.146951] [074/131] (733s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[283.243162] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[283.245387] Starting dynamic subtest: pipe-A-eDP-1
[283.297756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.053s)
[283.306211] Starting dynamic subtest: pipe-B-eDP-1
[283.347141] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.049s)
[283.355377] Starting dynamic subtest: pipe-C-eDP-1
[283.397735] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.050s)
[283.406224] Starting dynamic subtest: pipe-D-eDP-1
[283.446367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.047s)
[283.448734] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.203s)
[285.707534] [075/131] (731s left) kms_invalid_mode (bad-vsync-end)
[285.805335] Starting subtest: bad-vsync-end
[285.807670] Starting dynamic subtest: pipe-A-eDP-1
[286.085202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.279s)
[286.094213] Starting dynamic subtest: pipe-B-eDP-1
[286.096461] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[286.104457] Starting dynamic subtest: pipe-C-eDP-1
[286.106793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[286.114226] Starting dynamic subtest: pipe-D-eDP-1
[286.116142] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[286.118062] Subtest bad-vsync-end: SUCCESS (0.284s)
[286.911208] [076/131] (730s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[287.017726] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[293.626343] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (6.610s)
[293.773854] [077/131] (723s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[293.892967] Starting subtest: 2x-cursor-vs-flip-atomic
[293.897591] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[294.036132] [078/131] (723s left) gem_exec_params (sol-reset-not-gen7)
[294.085104] Starting subtest: sol-reset-not-gen7
[294.090931] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[294.228716] [079/131] (722s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[294.331582] Starting subtest: 4-tiled-64bpp-rotate-0
[296.616141] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (2.284s)
[296.892060] [080/131] (720s left) gem_exec_suspend (basic-s3)
[296.947896] Starting subtest: basic-S3
[296.950376] Starting dynamic subtest: smem
[317.502338] Dynamic subtest smem: SUCCESS (6.989s)
[317.504958] Subtest basic-S3: SUCCESS (6.991s)
[317.682028] [081/131] (699s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[317.817003] Starting subtest: flip-vs-cursor-busy-crc-legacy
[318.618250] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s)
[319.406920] [082/131] (697s left) gem_exec_fence (basic-wait-all)
[319.460996] Starting subtest: basic-wait-all
[319.553381] Subtest basic-wait-all: SUCCESS (0.095s)
[321.621395] [083/131] (695s left) gem_exec_basic (basic)
[321.673367] Starting subtest: basic
[321.675462] Starting dynamic subtest: rcs0-smem
[321.680061] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[321.689767] Starting dynamic subtest: bcs0-smem
[321.692112] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[321.700269] Starting dynamic subtest: vcs0-smem
[321.702440] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[321.710730] Starting dynamic subtest: vcs1-smem
[321.712907] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[321.720889] Starting dynamic subtest: vecs0-smem
[321.723046] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[321.731190] Starting dynamic subtest: ccs0-smem
[321.733420] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[321.735641] Subtest basic: SUCCESS (0.018s)
[323.562963] [084/131] (693s left) kms_chamelium_edid (dp-mode-timings)
[323.965167] Subtest dp-mode-timings: SKIP (0.000s)
[324.724911] [085/131] (692s left) gem_lmem_swapping (verify-random)
[324.767755] Subtest verify-random: SKIP (0.000s)
[324.808062] [086/131] (692s left) gem_mmap_gtt (coherency)
[324.870946] Subtest coherency: SKIP (0.000s)
[324.929088] [087/131] (692s left) kms_psr (psr2-cursor-mmap-cpu)
[325.020986] Starting subtest: psr2-cursor-mmap-cpu
[325.023262] Starting dynamic subtest: eDP-1
[327.301675] Dynamic subtest eDP-1: FAIL (1.733s)
[327.303578] Subtest psr2-cursor-mmap-cpu: FAIL (1.734s)
[327.340640] [088/131] (690s left) gen9_exec_parse (secure-batches)
[327.394767] Subtest secure-batches: SKIP (0.000s)
[327.481388] [089/131] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[327.577226] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[327.581662] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[327.683583] [090/131] (689s left) gem_flink_basic (basic)
[327.746610] Starting subtest: basic
[327.748378] Subtest basic: SUCCESS (0.000s)
[327.869104] [091/131] (689s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[327.961428] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[329.071206] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.118s)
[329.243803] [092/131] (688s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[329.355830] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[336.258268] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.937s)
[336.368769] [093/131] (681s left) kms_flip (2x-flip-vs-wf_vblank)
[336.473850] Starting subtest: 2x-flip-vs-wf_vblank
[336.484672] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[336.559928] [094/131] (681s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[336.648060] Starting subtest: fbc-pr-sprite-mmap-cpu
[336.652524] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[336.719981] [095/131] (681s left) gem_eio (in-flight-internal-1us)
[336.953041] Starting subtest: in-flight-internal-1us
[338.571368] Subtest in-flight-internal-1us: SUCCESS (1.620s)
[338.735117] [096/131] (679s left) kms_plane_scaling (2x-scaler-multi-pipe)
[338.836133] Starting subtest: 2x-scaler-multi-pipe
[338.840684] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[338.935950] [097/131] (678s left) gem_exec_gttfill (multigpu-basic)
[339.107383] Starting subtest: multigpu-basic
[358.804767] Subtest multigpu-basic: SUCCESS (19.703s)
[358.861319] [098/131] (659s left) vgem_basic (dmabuf-fence)
[358.934597] Starting subtest: dmabuf-fence
[358.936645] Subtest dmabuf-fence: SUCCESS (0.000s)
[358.996646] [099/131] (658s left) perf_pmu (busy-double-start)
[359.035375] Starting subtest: busy-double-start
[359.037551] Starting dynamic subtest: rcs0
[362.679526] Dynamic subtest rcs0: FAIL (3.588s)
[362.691391] Starting dynamic subtest: bcs0
[366.236623] Dynamic subtest bcs0: SUCCESS (3.613s)
[366.247932] Starting dynamic subtest: vcs0
[370.083581] Dynamic subtest vcs0: SUCCESS (3.845s)
[370.096577] Starting dynamic subtest: vcs1
[374.045491] Dynamic subtest vcs1: SUCCESS (3.961s)
[374.056340] Starting dynamic subtest: vecs0
[378.081446] Dynamic subtest vecs0: SUCCESS (4.035s)
[378.094313] Starting dynamic subtest: ccs0
[381.719060] Dynamic subtest ccs0: FAIL (3.567s)
[381.721413] Subtest busy-double-start: FAIL (22.619s)
[381.775642] [100/131] (636s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[381.872436] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[381.876830] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[383.002830] [101/131] (635s left) kms_vblank (wait-forked-hang)
[383.106120] Starting subtest: wait-forked-hang
[383.108610] Starting dynamic subtest: pipe-A-eDP-1
[409.269758] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.170s)
[409.285729] Starting dynamic subtest: pipe-D-eDP-1
[434.304029] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[434.306469] Subtest wait-forked-hang: SUCCESS (51.198s)
[435.146650] [102/131] (582s left) kms_cursor_crc (cursor-onscreen-256x256)
[435.409679] Starting subtest: cursor-onscreen-256x256
[435.415141] Starting dynamic subtest: pipe-A-eDP-1
[437.758127] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.345s)
[437.793396] Starting dynamic subtest: pipe-D-eDP-1
[440.696965] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.918s)
[440.699170] Subtest cursor-onscreen-256x256: SUCCESS (5.286s)
[441.482699] [103/131] (576s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[441.602128] Starting subtest: cursorB-vs-flipA-legacy
[441.606644] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[441.753049] [104/131] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[441.852422] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[441.856518] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[441.953940] [105/131] (576s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[446.938641] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[446.943414] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[447.784374] [106/131] (570s left) kms_psr (fbc-psr-primary-mmap-gtt)
[447.878065] Starting subtest: fbc-psr-primary-mmap-gtt
[447.880313] Starting dynamic subtest: eDP-1
[447.884795] Dynamic subtest eDP-1: SKIP (0.000s)
[447.889304] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[447.947903] [107/131] (570s left) kms_cursor_crc (cursor-offscreen-32x10)
[448.103325] Starting subtest: cursor-offscreen-32x10
[448.145611] Subtest cursor-offscreen-32x10: SKIP (0.037s)
[448.432877] [108/131] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[448.533063] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[448.535366] Starting dynamic subtest: pipe-A-default-mode
[448.818027] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[448.822774] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.285s)
[449.610043] [109/131] (568s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[449.719404] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[450.620642] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.903s)
[450.803733] [110/131] (567s left) kms_debugfs (display-on-read-all)
[450.890959] Starting subtest: display-on-read-all
[450.957459] Subtest display-on-read-all: SUCCESS (0.066s)
[451.108345] [111/131] (567s left) drm_read (fault-buffer)
[451.277131] Starting subtest: fault-buffer
[451.279601] Subtest fault-buffer: SUCCESS (0.002s)
[451.399112] [112/131] (567s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[451.497940] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[451.502313] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[451.589227] [113/131] (566s left) gen3_render_tiledy_blits
[451.706595] [114/131] (566s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[451.798553] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[451.800587] Starting dynamic subtest: pipe-A
[451.808755] Dynamic subtest pipe-A: SKIP (0.005s)
[451.818211] Starting dynamic subtest: pipe-B
[451.828569] Dynamic subtest pipe-B: SKIP (0.018s)
[451.837660] Starting dynamic subtest: pipe-C
[451.845573] Dynamic subtest pipe-C: SKIP (0.018s)
[451.854730] Starting dynamic subtest: pipe-D
[451.862839] Dynamic subtest pipe-D: SKIP (0.018s)
[451.866516] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.060s)
[451.976163] [115/131] (566s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[452.087020] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[452.090383] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[452.171802] [116/131] (566s left) gem_exec_params (rel-constants-invalid)
[452.231886] Starting subtest: rel-constants-invalid
[452.233798] Subtest rel-constants-invalid: SUCCESS (0.000s)
[452.364443] [117/131] (566s left) gem_mmap_wc (invalid-flags)
[452.415866] Subtest invalid-flags: SKIP (0.000s)
[452.483786] [118/131] (566s left) gem_mmap (bad-object)
[452.528592] Subtest bad-object: SKIP (0.000s)
[452.586341] [119/131] (566s left) gem_unref_active_buffers
[452.798624] [120/131] (565s left) gem_exec_balancer (bonded-pair)
[452.848048] Starting subtest: bonded-pair
[452.852011] Subtest bonded-pair: SKIP (0.000s)
[453.179905] [121/131] (565s left) core_getversion (all-cards)
[453.217218] Starting subtest: all-cards
[453.231894] Subtest all-cards: SUCCESS (0.020s)
[453.277530] [122/131] (565s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[453.329084] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[453.433546] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[453.516766] [123/131] (565s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[453.621528] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[453.623874] Starting dynamic subtest: pipe-A-eDP-1
[453.647318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[453.658999] Starting dynamic subtest: pipe-B-eDP-1
[453.681349] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[453.690436] Starting dynamic subtest: pipe-C-eDP-1
[453.711284] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[453.719984] Starting dynamic subtest: pipe-D-eDP-1
[453.740846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[453.745016] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[455.756016] [124/131] (563s left) kms_legacy_colorkey (basic)
[455.861776] Starting subtest: basic
[455.863915] Starting dynamic subtest: pipe-A
[455.907742] Dynamic subtest pipe-A: SUCCESS (0.045s)
[455.920363] Starting dynamic subtest: pipe-B
[455.922380] Dynamic subtest pipe-B: SUCCESS (0.001s)
[455.931709] Starting dynamic subtest: pipe-C
[455.934189] Dynamic subtest pipe-C: SUCCESS (0.000s)
[455.943332] Starting dynamic subtest: pipe-D
[455.945558] Dynamic subtest pipe-D: SUCCESS (0.000s)
[455.947828] Subtest basic: SUCCESS (0.050s)
[455.983516] [125/131] (563s left) kms_flip (wf_vblank-ts-check-interruptible)
[456.076038] Starting subtest: wf_vblank-ts-check-interruptible
[456.078329] Starting dynamic subtest: A-eDP1
[464.988368] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[464.998242] Starting dynamic subtest: B-eDP1
[473.914932] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[473.927915] Starting dynamic subtest: C-eDP1
[482.827656] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[482.837937] Starting dynamic subtest: D-eDP1
[491.752399] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[491.757629] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.686s)
[492.974639] [126/131] (526s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[493.029236] Starting subtest: invalid-bsd1-flag-on-vebox
[493.031194] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[493.126869] [127/131] (525s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[493.188307] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[493.192916] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[493.371080] [128/131] (525s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[493.477961] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[500.125313] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.653s)
[500.258330] [129/131] (518s left) gem_pxp (create-regular-buffer)
[500.389215] Starting subtest: create-regular-buffer
[500.391683] Subtest create-regular-buffer: SUCCESS (0.000s)
[500.508385] [130/131] (518s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[505.496900] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[505.499697] Starting dynamic subtest: pipe-A-eDP-1
[506.303052] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[506.312979] Starting dynamic subtest: pipe-B-eDP-1
[507.421128] Dynamic subtest pipe-B-eDP-1: SKIP (1.119s)
[507.426924] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.925s)
[508.599634] [131/131] (510s left) kms_selftest (drm_format)
[508.638631] Starting subtest: drm_format
[508.687695] Starting dynamic subtest: drm_test_format_block_width_invalid
[508.819555] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.131s)
[508.829485] Starting dynamic subtest: drm_test_format_block_width_one_plane
[508.949409] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.128s)
[508.960312] Starting dynamic subtest: drm_test_format_block_width_two_plane
[509.073095] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.124s)
[509.084374] Starting dynamic subtest: drm_test_format_block_width_three_plane
[509.206998] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.132s)
[509.218175] Starting dynamic subtest: drm_test_format_block_width_tiled
[509.339394] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.131s)
[509.356016] Starting dynamic subtest: drm_test_format_block_height_invalid
[509.467777] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.129s)
[509.476846] Starting dynamic subtest: drm_test_format_block_height_one_plane
[509.607425] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.139s)
[509.618408] Starting dynamic subtest: drm_test_format_block_height_two_plane
[509.753864] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.146s)
[509.764562] Starting dynamic subtest: drm_test_format_block_height_three_plane
[509.884105] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.129s)
[509.895809] Starting dynamic subtest: drm_test_format_block_height_tiled
[510.013321] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.129s)
[510.022353] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[510.160053] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.146s)
[510.169504] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[510.283507] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.120s)
[510.299258] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[510.368685] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.086s)
[510.379475] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[510.479539] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.107s)
[510.490681] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[510.624869] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.144s)
[510.636385] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[510.736133] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.112s)
[510.747460] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[510.882086] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.144s)
[510.911487] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[510.981959] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.099s)
[510.984231] Subtest drm_format: SUCCESS (2.341s)
[511.183106] Closing watchdogs
results: parsing output: 0/ for test: gem_blits
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_chamelium_hpd
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_vm_create
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_plane_lowres
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_chamelium_hpd
results: parsing output: 16/ for test: gem_pread
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_fence_thrash
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_feature_discovery
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_pm_rpm
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: sysfs_timeslice_duration
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: fbdev
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: kms_tv_load_detect
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: i915_selftest
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_pm_dc
results: parsing output: 58/ for test: gem_tiled_fence_blits
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic_interruptible
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: gem_reg_read
results: parsing output: 67/ for test: gem_exec_whisper
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_exec_suspend
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_basic
results: parsing output: 83/ for test: kms_chamelium_edid
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_exec_gttfill
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_debugfs
results: parsing output: 110/ for test: drm_read
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gen3_render_tiledy_blits
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_wc
results: parsing output: 117/ for test: gem_mmap
results: parsing output: 118/ for test: gem_unref_active_buffers
results: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: core_getversion
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_legacy_colorkey
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_pxp
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_selftest
Done.