[60.424987] Initializing watchdogs
[60.425079]   /dev/watchdog0
[60.439340] [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]
[60.444140] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.446297] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.449659] [001/133] (960s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[60.570716] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[60.574688] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[60.648580] [002/133] (960s left) kms_psr (fbc-pr-cursor-render)
[60.741607] Starting subtest: fbc-pr-cursor-render
[60.746059] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[60.810448] [003/133] (960s left) gem_ccs (block-copy-compressed)
[60.873028] Starting subtest: block-copy-compressed
[60.877326] Subtest block-copy-compressed: SKIP (0.000s)
[60.967325] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[61.065686] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[61.069891] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[61.160357] [005/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[61.253409] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[62.075924] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.825s)
[62.229484] [006/133] (958s left) kms_joiner (basic-ultra-joiner)
[62.325561] Starting subtest: basic-ultra-joiner
[62.331223] Subtest basic-ultra-joiner: SKIP (0.000s)
[62.384682] [007/133] (958s left) kms_dsc (dsc-with-output-formats-with-bpc)
[62.487129] Starting subtest: dsc-with-output-formats-with-bpc
[62.544397] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[62.576764] [008/133] (958s left) kms_chamelium_frames (dp-crc-single)
[62.955425] Subtest dp-crc-single: SKIP (0.000s)
[63.797644] [009/133] (957s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[63.940751] Starting subtest: dp-mst-type-1-suspend-resume
[63.945415] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[64.049379] [010/133] (957s left) kms_addfb_basic (basic)
[64.103625] Starting subtest: basic
[64.105904] Subtest basic: SUCCESS (0.000s)
[64.235410] [011/133] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[64.326788] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[68.971000] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.647s)
[70.111532] [012/133] (951s left) gem_exec_fence (submit)
[70.282581] Starting subtest: submit
[70.287427] Subtest submit: SKIP (0.000s)
[71.979861] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[71.982944] [013/133] (949s left) gem_unfence_active_buffers
[72.120942] [014/133] (949s left) kms_cursor_edge_walk (256x256-right-edge)
[72.218285] Starting subtest: 256x256-right-edge
[72.220683] Starting dynamic subtest: pipe-A-eDP-1
[75.672564] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.456s)
[75.681799] Starting dynamic subtest: pipe-D-eDP-1
[78.812491] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[78.814870] Subtest 256x256-right-edge: SUCCESS (6.592s)
[79.609182] [015/133] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[79.720731] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[79.724894] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[79.806268] [016/133] (941s left) perf (gen12-invalid-class-instance)
[79.924814] Starting subtest: gen12-invalid-class-instance
[79.936847] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[79.981507] [017/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[80.085701] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[80.089649] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[80.203485] [018/133] (941s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[80.296255] Starting subtest: psr-rgb565-draw-mmap-gtt
[80.300701] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[80.396710] [019/133] (941s left) gem_flink_race (flink_name)
[80.428773] Starting subtest: flink_name
[85.827076] Subtest flink_name: SUCCESS (5.394s)
[85.930668] [020/133] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[86.027822] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[86.032212] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[86.118850] [021/133] (935s left) gem_exec_balancer (parallel)
[86.371284] Starting subtest: parallel
[87.300460] Subtest parallel: SUCCESS (0.932s)
[87.951555] [022/133] (933s left) gem_ctx_param (invalid-size-get)
[88.002678] Starting subtest: invalid-size-get
[88.005065] Subtest invalid-size-get: SUCCESS (0.001s)
[88.088771] [023/133] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[88.184604] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[94.881397] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.698s)
[95.007491] [024/133] (926s left) api_intel_allocator (reopen-fork)
[95.075380] Starting subtest: reopen-fork
[98.573321] Subtest reopen-fork: SUCCESS (3.498s)
[98.648924] [025/133] (923s left) kms_psr (psr-cursor-plane-onoff)
[98.760632] Starting subtest: psr-cursor-plane-onoff
[98.762991] Starting dynamic subtest: eDP-1
[100.505136] Dynamic subtest eDP-1: SUCCESS (1.745s)
[100.507541] Subtest psr-cursor-plane-onoff: SUCCESS (1.746s)
[101.378961] [026/133] (920s left) kms_addfb_basic (size-max)
[101.478288] Starting subtest: size-max
[101.480347] Subtest size-max: SUCCESS (0.000s)
[101.582608] [027/133] (920s left) gem_userptr_blits (dmabuf-sync)
[101.641453] Starting subtest: dmabuf-sync
[101.645554] Subtest dmabuf-sync: SKIP (0.002s)
[101.783534] [028/133] (920s left) syncobj_eventfd (invalid-bad-flags)
[101.858492] Starting subtest: invalid-bad-flags
[101.860893] Subtest invalid-bad-flags: SUCCESS (0.000s)
[101.968458] [029/133] (920s left) kms_plane_scaling (planes-downscale-factor-0-5)
[102.062018] Starting subtest: planes-downscale-factor-0-5
[102.064438] Starting dynamic subtest: pipe-A
[102.082361] Dynamic subtest pipe-A: SKIP (0.017s)
[102.092908] Starting dynamic subtest: pipe-B
[102.117911] Dynamic subtest pipe-B: SKIP (0.035s)
[102.125528] Starting dynamic subtest: pipe-C
[102.152226] Dynamic subtest pipe-C: SKIP (0.034s)
[102.159624] Starting dynamic subtest: pipe-D
[102.181817] Dynamic subtest pipe-D: SKIP (0.030s)
[102.186159] Subtest planes-downscale-factor-0-5: SKIP (0.116s)
[102.285645] [030/133] (919s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[102.375120] Starting subtest: fbc-psr-cursor-mmap-gtt
[102.377084] Starting dynamic subtest: eDP-1
[102.380631] Dynamic subtest eDP-1: SKIP (0.000s)
[102.384240] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[102.450036] [031/133] (919s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[102.511546] Starting subtest: y-tiled-to-vebox-x-tiled
[102.515418] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[102.692847] [032/133] (919s left) gem_exec_schedule (out-order)
[102.759914] Starting subtest: out-order
[102.762522] Starting dynamic subtest: rcs0
[102.857141] Dynamic subtest rcs0: SUCCESS (0.106s)
[102.867754] Starting dynamic subtest: vcs0
[102.943388] Dynamic subtest vcs0: SUCCESS (0.086s)
[102.953756] Starting dynamic subtest: vcs1
[103.024448] Dynamic subtest vcs1: SUCCESS (0.080s)
[103.034898] Starting dynamic subtest: vecs0
[103.104373] Dynamic subtest vecs0: SUCCESS (0.080s)
[103.114409] Starting dynamic subtest: ccs0
[103.191291] Dynamic subtest ccs0: SUCCESS (0.087s)
[103.193710] Subtest out-order: SUCCESS (0.441s)
[105.003009] [033/133] (917s left) vgem_basic (dmabuf-mmap)
[105.044920] Starting subtest: dmabuf-mmap
[105.053102] Subtest dmabuf-mmap: SUCCESS (0.010s)
[105.111487] [034/133] (917s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[105.217204] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[105.221476] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[105.327371] [035/133] (916s left) kms_hdr (static-swap)
[105.416204] Starting subtest: static-swap
[105.422863] Subtest static-swap: SKIP (0.000s)
[105.488087] [036/133] (916s left) gem_create (create-massive)
[105.545705] Starting subtest: create-massive
[105.547890] Subtest create-massive: SUCCESS (0.000s)
[105.736041] [037/133] (916s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[105.832839] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[105.837047] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[105.933851] [038/133] (916s left) kms_psr (fbc-psr2-primary-render)
[106.025738] Starting subtest: fbc-psr2-primary-render
[106.027859] Starting dynamic subtest: eDP-1
[106.031772] Dynamic subtest eDP-1: SKIP (0.000s)
[106.035687] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[106.095829] [039/133] (916s left) kms_chamelium_hpd (hdmi-hpd-fast)
[106.492834] Subtest hdmi-hpd-fast: SKIP (0.000s)
[107.288233] [040/133] (915s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[107.346679] Starting subtest: multi-wait-all-for-submit-signaled
[107.348980] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[107.432944] [041/133] (915s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[107.528264] Starting subtest: pr-overlay-plane-move-continuous-sf
[107.532269] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[107.607805] [042/133] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[107.715171] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[107.719191] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[107.808925] [043/133] (914s left) kms_cursor_crc (cursor-alpha-opaque)
[107.893153] Starting subtest: cursor-alpha-opaque
[107.895284] Starting dynamic subtest: pipe-A-eDP-1
[108.495692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[108.504762] Starting dynamic subtest: pipe-D-eDP-1
[109.786281] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[109.788774] Subtest cursor-alpha-opaque: SUCCESS (1.895s)
[110.582859] [044/133] (912s left) kms_plane_multiple (2x-tiling-y)
[110.674520] Starting subtest: 2x-tiling-y
[110.679113] Subtest 2x-tiling-y: SKIP (0.000s)
[110.741075] [045/133] (911s left) gem_exec_params (invalid-bsd1-flag-on-render)
[110.795192] Starting subtest: invalid-bsd1-flag-on-render
[110.797521] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[110.894393] [046/133] (911s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[110.983823] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[110.988222] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[111.073835] [047/133] (911s left) gem_ctx_persistence (engines-cleanup)
[111.130734] Starting subtest: engines-cleanup
[111.133292] Starting dynamic subtest: rcs0
[111.207350] Dynamic subtest rcs0: SUCCESS (0.075s)
[111.217205] Starting dynamic subtest: bcs0
[111.260672] Dynamic subtest bcs0: SUCCESS (0.053s)
[111.271363] Starting dynamic subtest: vcs0
[111.303740] Dynamic subtest vcs0: SUCCESS (0.042s)
[111.316264] Starting dynamic subtest: vcs1
[111.350827] Dynamic subtest vcs1: SUCCESS (0.046s)
[111.360034] Starting dynamic subtest: vecs0
[111.377719] Dynamic subtest vecs0: SUCCESS (0.026s)
[111.390555] Starting dynamic subtest: ccs0
[111.425805] Dynamic subtest ccs0: SUCCESS (0.047s)
[111.428531] Subtest engines-cleanup: SUCCESS (0.295s)
[111.551729] [048/133] (911s left) drm_read (short-buffer-block)
[111.697478] Starting subtest: short-buffer-block
[111.699573] Subtest short-buffer-block: SUCCESS (0.000s)
[111.807442] [049/133] (910s left) kms_psr (pr-cursor-blt)
[111.899725] Starting subtest: pr-cursor-blt
[111.903436] Subtest pr-cursor-blt: SKIP (0.000s)
[111.969861] [050/133] (910s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[112.060304] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[112.067831] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[112.153854] [051/133] (910s left) kms_vblank (query-busy-hang)
[112.241355] Starting subtest: query-busy-hang
[112.243090] Starting dynamic subtest: pipe-A-eDP-1
[138.653973] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.409s)
[138.666706] Starting dynamic subtest: pipe-D-eDP-1
[163.679693] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s)
[163.681850] Subtest query-busy-hang: SUCCESS (51.436s)
[164.554367] [052/133] (858s left) gem_exec_store (pages)
[164.611671] Starting subtest: pages
[164.613678] Starting dynamic subtest: rcs0
[164.691685] Dynamic subtest rcs0: SUCCESS (0.082s)
[164.702052] Starting dynamic subtest: bcs0
[164.756284] Dynamic subtest bcs0: SUCCESS (0.064s)
[164.764981] Starting dynamic subtest: vcs0
[164.822479] Dynamic subtest vcs0: SUCCESS (0.066s)
[164.832067] Starting dynamic subtest: vcs1
[164.900029] Dynamic subtest vcs1: SUCCESS (0.077s)
[164.909701] Starting dynamic subtest: vecs0
[164.972826] Dynamic subtest vecs0: SUCCESS (0.072s)
[164.982986] Starting dynamic subtest: ccs0
[165.036893] Dynamic subtest ccs0: SUCCESS (0.063s)
[165.039607] Subtest pages: SUCCESS (0.427s)
[165.217126] [053/133] (857s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[165.317223] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[165.319523] Starting dynamic subtest: pipe-A-eDP-1
[165.342892] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.351540] Starting dynamic subtest: pipe-B-eDP-1
[165.373136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.380678] Starting dynamic subtest: pipe-C-eDP-1
[165.402403] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.409644] Starting dynamic subtest: pipe-D-eDP-1
[165.431382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[165.435412] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[167.674286] [054/133] (855s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[167.797369] Starting subtest: compare-crc-sanitycheck-xr24
[167.799321] Starting dynamic subtest: pipe-A-eDP-1
[168.436221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[168.446339] Starting dynamic subtest: pipe-B-eDP-1
[169.693104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s)
[169.701765] Starting dynamic subtest: pipe-C-eDP-1
[170.875144] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.180s)
[170.884079] Starting dynamic subtest: pipe-D-eDP-1
[172.104971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[172.107584] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.309s)
[172.949988] [055/133] (850s left) kms_atomic_transition (plane-toggle-modeset-transition)
[173.050145] Starting subtest: plane-toggle-modeset-transition
[173.052062] Starting dynamic subtest: pipe-A-eDP-1
[185.802956] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.752s)
[185.812985] Starting dynamic subtest: pipe-B-eDP-1
[198.205066] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.396s)
[198.207659] Subtest plane-toggle-modeset-transition: SUCCESS (25.155s)
[199.024140] [056/133] (824s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[199.073632] Starting subtest: single-wait-for-submit-available-signaled
[199.075978] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[199.164305] [057/133] (823s left) gem_spin_batch (resubmit)
[199.223786] Starting subtest: resubmit
[199.226027] Starting dynamic subtest: rcs0
[199.231175] Dynamic subtest rcs0: SUCCESS (0.007s)
[199.239127] Starting dynamic subtest: bcs0
[199.241473] Dynamic subtest bcs0: SUCCESS (0.003s)
[199.248611] Starting dynamic subtest: vcs0
[199.250494] Dynamic subtest vcs0: SUCCESS (0.003s)
[199.262731] Starting dynamic subtest: vcs1
[199.264744] Dynamic subtest vcs1: SUCCESS (0.002s)
[199.276203] Starting dynamic subtest: vecs0
[199.278263] Dynamic subtest vecs0: SUCCESS (0.002s)
[199.289801] Starting dynamic subtest: ccs0
[199.291830] Dynamic subtest ccs0: SUCCESS (0.002s)
[199.293851] Subtest resubmit: SUCCESS (0.022s)
[199.494787] [058/133] (823s left) gem_userptr_blits (map-fixed-invalidate-busy)
[199.568564] Starting subtest: map-fixed-invalidate-busy
[199.572817] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[199.690836] [059/133] (823s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[199.790771] Starting subtest: 4-tiled-32bpp-rotate-90
[199.810316] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[199.914730] [060/133] (823s left) kms_psr (psr-primary-mmap-cpu)
[200.003471] Starting subtest: psr-primary-mmap-cpu
[200.005345] Starting dynamic subtest: eDP-1
[201.716419] Dynamic subtest eDP-1: SUCCESS (1.712s)
[201.718728] Subtest psr-primary-mmap-cpu: SUCCESS (1.713s)
[202.577838] [061/133] (820s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[202.634360] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[202.737246] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[202.811725] [062/133] (820s left) perf_pmu (render-node-busy)
[202.875859] Starting subtest: render-node-busy
[202.878156] Starting dynamic subtest: rcs0
[203.470476] Dynamic subtest rcs0: SUCCESS (0.594s)
[203.481858] Starting dynamic subtest: bcs0
[204.030970] Dynamic subtest bcs0: SUCCESS (0.559s)
[204.042206] Starting dynamic subtest: vcs0
[205.908951] Dynamic subtest vcs0: SUCCESS (1.875s)
[205.917812] Starting dynamic subtest: vcs1
[207.893381] Dynamic subtest vcs1: SUCCESS (1.982s)
[207.904658] Starting dynamic subtest: vecs0
[209.876617] Dynamic subtest vecs0: SUCCESS (1.981s)
[209.887795] Starting dynamic subtest: ccs0
[210.438697] Dynamic subtest ccs0: SUCCESS (0.561s)
[210.441549] Subtest render-node-busy: SUCCESS (7.563s)
[210.515314] [063/133] (812s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[210.613909] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[210.616239] Starting dynamic subtest: pipe-A-eDP-1
[210.674391] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[210.681955] Starting dynamic subtest: pipe-B-eDP-1
[210.738905] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[210.748236] Starting dynamic subtest: pipe-C-eDP-1
[210.805448] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[210.815408] Starting dynamic subtest: pipe-D-eDP-1
[210.873631] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[210.877799] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[212.943679] [064/133] (810s left) kms_async_flips (crc-atomic)
[213.034168] Starting subtest: crc-atomic
[213.414319] Starting dynamic subtest: pipe-A-eDP-1
[216.349673] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.935s)
[216.723878] Starting dynamic subtest: pipe-B-eDP-1
[219.597298] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s)
[219.974689] Starting dynamic subtest: pipe-C-eDP-1
[222.904447] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[223.274989] Starting dynamic subtest: pipe-D-eDP-1
[226.131693] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.866s)
[226.134056] Subtest crc-atomic: SUCCESS (13.100s)
[227.297136] [065/133] (796s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[227.364061] Starting subtest: single-wait-for-submit-unsubmitted
[227.472983] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[227.548113] [066/133] (795s left) syncobj_wait (signal)
[227.613249] Starting subtest: signal
[227.615435] Subtest signal: SUCCESS (0.000s)
[227.707400] [067/133] (795s left) i915_drm_fdinfo (idle)
[227.747990] Starting subtest: idle
[227.750280] Starting dynamic subtest: rcs0
[228.310742] Dynamic subtest rcs0: SUCCESS (0.562s)
[228.321592] Starting dynamic subtest: bcs0
[228.814594] Dynamic subtest bcs0: SUCCESS (0.503s)
[228.846565] Starting dynamic subtest: vcs0
[229.320324] Dynamic subtest vcs0: SUCCESS (0.503s)
[229.330497] Starting dynamic subtest: vcs1
[229.824697] Dynamic subtest vcs1: SUCCESS (0.504s)
[229.842912] Starting dynamic subtest: vecs0
[230.330677] Dynamic subtest vecs0: SUCCESS (0.503s)
[230.347751] Starting dynamic subtest: ccs0
[230.835612] Dynamic subtest ccs0: SUCCESS (0.503s)
[230.838390] Subtest idle: SUCCESS (3.089s)
[230.914531] [068/133] (792s left) kms_chamelium_audio (dp-audio)
[231.303541] Subtest dp-audio: SKIP (0.000s)
[232.110610] [069/133] (791s left) gem_userptr_blits (invalid-null-pointer)
[232.183319] Starting subtest: invalid-null-pointer
[232.185711] Subtest invalid-null-pointer: SUCCESS (0.001s)
[232.293688] [070/133] (791s left) kms_cursor_crc (cursor-random-128x128)
[232.490235] Starting subtest: cursor-random-128x128
[232.495196] Starting dynamic subtest: pipe-A-eDP-1
[235.837200] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.343s)
[235.866925] Starting dynamic subtest: pipe-D-eDP-1
[239.835896] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.975s)
[239.838284] Subtest cursor-random-128x128: SUCCESS (7.344s)
[240.724887] [071/133] (782s left) gem_exec_fence (basic-await)
[240.905132] Starting subtest: basic-await
[240.907422] Starting dynamic subtest: rcs0
[240.978986] Dynamic subtest rcs0: SUCCESS (0.075s)
[240.996383] Starting dynamic subtest: bcs0
[241.051511] Dynamic subtest bcs0: SUCCESS (0.072s)
[241.063208] Starting dynamic subtest: vcs0
[241.124989] Dynamic subtest vcs0: SUCCESS (0.072s)
[241.136202] Starting dynamic subtest: vcs1
[241.196700] Dynamic subtest vcs1: SUCCESS (0.071s)
[241.208123] Starting dynamic subtest: vecs0
[241.269359] Dynamic subtest vecs0: SUCCESS (0.071s)
[241.280890] Starting dynamic subtest: ccs0
[241.341965] Dynamic subtest ccs0: SUCCESS (0.071s)
[241.345259] Subtest basic-await: SUCCESS (0.439s)
[242.955609] [072/133] (780s left) i915_selftest (perf)
[246.238462] Starting subtest: perf
[246.240838] Starting dynamic subtest: engine_cs
[248.903310] Dynamic subtest engine_cs: SUCCESS (2.664s)
[248.914992] Starting dynamic subtest: request
[256.119770] Dynamic subtest request: SUCCESS (7.214s)
[256.128903] Starting dynamic subtest: migrate
[260.396380] Dynamic subtest migrate: SUCCESS (4.276s)
[260.405510] Starting dynamic subtest: region
[266.056031] Dynamic subtest region: SUCCESS (5.657s)
[266.058950] Subtest perf: SUCCESS (19.817s)
[266.088448] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[266.089257] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[266.093213] [073/133] (757s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[267.728511] Starting subtest: x-tiled-8bpp-rotate-270
[267.772182] Subtest x-tiled-8bpp-rotate-270: SKIP (0.040s)
[267.871637] [FACT kms_big_fb (x-tiled-8bpp-rotate-270)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[267.872810] [FACT kms_big_fb (x-tiled-8bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[267.876287] [074/133] (755s left) gem_exec_reloc (basic-write-gtt)
[267.949559] Subtest basic-write-gtt: SKIP (0.000s)
[268.025937] [075/133] (755s left) gem_exec_parallel (userptr)
[268.087067] Starting subtest: userptr
[268.089457] Starting dynamic subtest: rcs0
[269.471191] Dynamic subtest rcs0: SUCCESS (1.384s)
[269.480216] Starting dynamic subtest: bcs0
[270.957758] Dynamic subtest bcs0: SUCCESS (1.486s)
[270.967196] Starting dynamic subtest: vcs0
[272.853603] Dynamic subtest vcs0: SUCCESS (1.893s)
[272.864061] Starting dynamic subtest: vcs1
[274.900724] Dynamic subtest vcs1: SUCCESS (2.044s)
[274.910864] Starting dynamic subtest: vecs0
[276.884602] Dynamic subtest vecs0: SUCCESS (1.982s)
[276.894773] Starting dynamic subtest: ccs0
[278.382250] Dynamic subtest ccs0: SUCCESS (1.497s)
[278.384640] Subtest userptr: SUCCESS (10.296s)
[278.569520] [076/133] (745s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[278.674112] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[278.701127] Starting dynamic subtest: pipe-A-plane-0
[279.001240] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[279.011242] Starting dynamic subtest: pipe-A-plane-3
[279.235985] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[279.244532] Starting dynamic subtest: pipe-A-plane-5
[279.249150] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[280.352295] Starting dynamic subtest: pipe-B-plane-0
[280.646960] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[280.655551] Starting dynamic subtest: pipe-B-plane-3
[280.880244] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[280.888657] Starting dynamic subtest: pipe-B-plane-5
[280.893093] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[281.193562] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.519s)
[282.030893] [077/133] (741s left) kms_flip (plain-flip-interruptible)
[282.118719] Starting subtest: plain-flip-interruptible
[282.121147] Starting dynamic subtest: A-eDP1
[283.744045] Dynamic subtest A-eDP1: SUCCESS (1.624s)
[283.756502] Starting dynamic subtest: B-eDP1
[285.373186] Dynamic subtest B-eDP1: SUCCESS (1.628s)
[285.384212] Starting dynamic subtest: C-eDP1
[286.989084] Dynamic subtest C-eDP1: SUCCESS (1.613s)
[286.998665] Starting dynamic subtest: D-eDP1
[288.620516] Dynamic subtest D-eDP1: SUCCESS (1.629s)
[288.622920] Subtest plain-flip-interruptible: SUCCESS (6.505s)
[289.801638] [078/133] (734s left) gen7_exec_parse (load-register-reg)
[289.868747] Subtest load-register-reg: SKIP (0.000s)
[289.940779] [079/133] (734s left) sw_sync (sync_merge_same)
[289.972529] Starting subtest: sync_merge_same
[289.974964] Subtest sync_merge_same: SUCCESS (0.000s)
[290.031153] [080/133] (734s left) i915_query (query-topology-unsupported)
[290.089764] Starting subtest: query-topology-unsupported
[290.093966] Subtest query-topology-unsupported: SKIP (0.000s)
[290.176424] [081/133] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[290.264702] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[297.395902] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.133s)
[297.530251] [082/133] (726s left) perf (non-system-wide-paranoid)
[297.660892] Starting subtest: non-system-wide-paranoid
[297.688219] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[297.738557] [083/133] (726s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[297.831110] Starting subtest: fbc-rgb565-draw-mmap-gtt
[297.835194] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[297.932500] [084/133] (726s left) gem_pipe_control_store_loop (fresh-buffer)
[297.987690] Starting subtest: fresh-buffer
[300.140045] Subtest fresh-buffer: SUCCESS (2.151s)
[300.258171] [085/133] (724s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[300.358078] Starting subtest: bad-pixel-format-y-tiled-ccs
[300.360276] Starting dynamic subtest: pipe-A-eDP-1
[300.382734] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[300.393751] Starting dynamic subtest: pipe-B-eDP-1
[300.415105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[300.423172] Starting dynamic subtest: pipe-C-eDP-1
[300.444602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[300.452754] Starting dynamic subtest: pipe-D-eDP-1
[300.474709] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[300.478780] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[302.616143] [086/133] (721s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[302.746627] Starting subtest: basic-flip-before-cursor-legacy
[303.661542] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.915s)
[304.461521] [087/133] (719s left) gem_lmem_swapping (basic)
[304.516554] Subtest basic: SKIP (0.000s)
[304.561905] [088/133] (719s left) gem_caching (reads)
[304.622436] Subtest reads: SKIP (0.000s)
[304.698247] [089/133] (719s left) kms_big_fb (y-tiled-addfb-size-overflow)
[304.802683] Starting subtest: y-tiled-addfb-size-overflow
[304.807319] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[304.888652] [090/133] (719s left) gem_flink_basic (bad-flink)
[304.953424] Starting subtest: bad-flink
[304.955694] Subtest bad-flink: SUCCESS (0.000s)
[305.068090] [091/133] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[305.174868] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[312.392268] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.221s)
[312.513865] [092/133] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[312.612487] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[312.617056] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[312.695549] [093/133] (711s left) kms_flip (2x-dpms-vs-vblank-race)
[312.792349] Starting subtest: 2x-dpms-vs-vblank-race
[312.800931] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[312.880456] [094/133] (711s left) gem_mmap_gtt (ptrace)
[312.937228] Subtest ptrace: SKIP (0.000s)
[312.997583] [095/133] (711s left) i915_drm_fdinfo (virtual-busy-idle)
[313.034370] Starting subtest: virtual-busy-idle
[313.038977] Subtest virtual-busy-idle: SKIP (0.000s)
[313.097470] [096/133] (711s left) kms_prop_blob (invalid-set-prop)
[313.145042] Starting subtest: invalid-set-prop
[313.146986] Subtest invalid-set-prop: SUCCESS (0.000s)
[313.240857] [097/133] (711s left) gem_ctx_persistence (userptr)
[313.306754] Starting subtest: userptr
[313.498278] Subtest userptr: SUCCESS (0.192s)
[313.575490] [098/133] (711s left) syncobj_eventfd (binary-wait)
[313.618868] Starting subtest: binary-wait
[313.627663] Subtest binary-wait: SUCCESS (0.010s)
[313.715602] [099/133] (711s left) gem_pxp (create-valid-protected-context)
[313.844686] Starting subtest: create-valid-protected-context
[313.847195] Subtest create-valid-protected-context: SUCCESS (0.002s)
[313.963992] [100/133] (710s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[314.031616] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[314.127197] [101/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[314.232127] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[314.235544] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[314.328988] [102/133] (710s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[314.416691] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[314.418577] Starting dynamic subtest: pipe-A-default-mode
[317.111677] Dynamic subtest pipe-A-default-mode: SUCCESS (2.693s)
[317.113657] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.694s)
[317.973034] [103/133] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[318.074738] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[325.042364] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.970s)
[325.192801] [104/133] (699s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[325.295284] Starting subtest: yf-tiled-32bpp-rotate-0
[325.299344] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[325.387780] [105/133] (699s left) kms_cursor_legacy (single-move)
[325.508051] Starting subtest: single-move
[325.510283] Starting dynamic subtest: pipe-A
[330.894065] Dynamic subtest pipe-A: SUCCESS (5.381s)
[330.908184] Starting dynamic subtest: pipe-B
[336.274585] Dynamic subtest pipe-B: SUCCESS (5.379s)
[336.283067] Starting dynamic subtest: pipe-C
[341.658089] Dynamic subtest pipe-C: SUCCESS (5.380s)
[341.666668] Starting dynamic subtest: pipe-D
[347.042091] Dynamic subtest pipe-D: SUCCESS (5.380s)
[347.051370] Starting dynamic subtest: all-pipes
[352.430943] Dynamic subtest all-pipes: SUCCESS (5.386s)
[352.433255] Subtest single-move: SUCCESS (26.920s)
[352.571275] [106/133] (672s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[352.673023] Starting subtest: addfb25-y-tiled-legacy
[352.675130] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[352.770074] [107/133] (672s left) dmabuf_sync_file (import-multiple-read-write)
[352.818202] Starting subtest: import-multiple-read-write
[352.820473] Subtest import-multiple-read-write: SUCCESS (0.003s)
[352.877451] [108/133] (672s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[352.932118] Starting subtest: multi-wait-all-available-submitted-signaled
[352.934375] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[353.011540] [109/133] (672s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[353.108064] Starting subtest: primary-x-tiled-reflect-x-180
[360.123437] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.017s)
[361.581233] [110/133] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[361.695799] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[361.699990] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.792397] [111/133] (663s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[361.924997] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[366.874833] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.951s)
[367.992147] [112/133] (657s left) kms_lease (lease-unleased-crtc)
[368.105952] Starting subtest: lease-unleased-crtc
[368.108188] Starting dynamic subtest: pipe-A-eDP-1
[368.402997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[368.414660] Starting dynamic subtest: pipe-B-eDP-1
[369.136648] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.727s)
[369.146828] Starting dynamic subtest: pipe-C-eDP-1
[369.149201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[369.157223] Starting dynamic subtest: pipe-D-eDP-1
[369.159441] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[369.161648] Subtest lease-unleased-crtc: SUCCESS (1.042s)
[369.511832] [113/133] (655s left) i915_pm_rpm (reg-read-ioctl)
[371.045481] Starting subtest: reg-read-ioctl
[373.339895] Subtest reg-read-ioctl: SUCCESS (2.296s)
[373.709997] [114/133] (651s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[373.804160] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[373.806295] Starting dynamic subtest: pipe-A-eDP-1
[390.432572] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.514s)
[390.442478] Starting dynamic subtest: pipe-B-eDP-1
[407.381568] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.471s)
[407.391472] Starting dynamic subtest: pipe-C-eDP-1
[424.371547] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.358s)
[424.380420] Starting dynamic subtest: pipe-D-eDP-1
[441.394242] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.387s)
[441.396510] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.735s)
[442.570149] [115/133] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[442.683749] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[449.608675] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.049s)
[449.711274] [116/133] (575s left) kms_pm_dc (dc6-psr)
[450.818854] Starting subtest: dc6-psr
[453.711479] Subtest dc6-psr: SUCCESS (2.913s)
[454.568921] [117/133] (570s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[454.651368] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[454.653594] Starting dynamic subtest: pipe-A-default-mode
[455.807425] Dynamic subtest pipe-A-default-mode: SKIP (1.158s)
[455.811752] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.160s)
[455.965015] [118/133] (569s left) kms_prime (basic-crc-hybrid)
[456.054781] Subtest basic-crc-hybrid: SKIP (0.000s)
[456.152595] [119/133] (569s left) gem_wait (await)
[456.212298] Starting subtest: await
[456.214479] Starting dynamic subtest: all-engines
[457.354586] Dynamic subtest all-engines: SUCCESS (1.147s)
[457.366202] Starting dynamic subtest: rcs0
[458.428469] Dynamic subtest rcs0: SUCCESS (1.075s)
[458.445424] Starting dynamic subtest: bcs0
[459.491451] Dynamic subtest bcs0: SUCCESS (1.064s)
[459.509273] Starting dynamic subtest: vcs0
[460.547919] Dynamic subtest vcs0: SUCCESS (1.057s)
[460.564535] Starting dynamic subtest: vcs1
[461.601639] Dynamic subtest vcs1: SUCCESS (1.055s)
[461.617754] Starting dynamic subtest: vecs0
[462.655214] Dynamic subtest vecs0: SUCCESS (1.053s)
[462.671532] Starting dynamic subtest: ccs0
[463.710941] Dynamic subtest ccs0: SUCCESS (1.056s)
[463.713565] Subtest await: SUCCESS (7.523s)
[463.912838] [120/133] (561s left) gem_exec_alignment (many)
[463.995154] Starting subtest: many
[487.276024] Subtest many: SUCCESS (23.288s)
[488.972621] [121/133] (536s left) sysfs_heartbeat_interval (invalid)
[489.073241] Starting subtest: invalid
[489.075755] Starting dynamic subtest: vecs0
[489.078149] Dynamic subtest vecs0: SUCCESS (0.000s)
[489.089624] Starting dynamic subtest: ccs0
[489.091917] Dynamic subtest ccs0: SUCCESS (0.000s)
[489.101242] Starting dynamic subtest: vcs0
[489.103414] Dynamic subtest vcs0: SUCCESS (0.000s)
[489.112577] Starting dynamic subtest: bcs0
[489.114829] Dynamic subtest bcs0: SUCCESS (0.000s)
[489.123522] Starting dynamic subtest: rcs0
[489.125771] Dynamic subtest rcs0: SUCCESS (0.000s)
[489.133989] Starting dynamic subtest: vcs1
[489.135876] Dynamic subtest vcs1: SUCCESS (0.000s)
[489.138210] Subtest invalid: SUCCESS (0.005s)
[489.199040] [122/133] (536s left) gem_media_fill (media-fill)
[489.255016] Subtest media-fill: SKIP (0.000s)
[489.381936] [123/133] (536s left) gem_exec_fence (basic-wait-all)
[489.455195] Starting subtest: basic-wait-all
[489.566170] Subtest basic-wait-all: SUCCESS (0.114s)
[491.015652] [124/133] (534s left) gem_softpin (softpin)
[491.069428] Starting subtest: softpin
[523.310503] Subtest softpin: SUCCESS (32.245s)
[523.429283] [125/133] (502s left) api_intel_bb (intel-bb-blit-y)
[523.496276] Starting subtest: intel-bb-blit-y
[527.217516] Subtest intel-bb-blit-y: SUCCESS (3.723s)
[527.360583] [126/133] (498s left) kms_color (ctm-0-50)
[527.456406] Starting subtest: ctm-0-50
[527.458509] Starting dynamic subtest: pipe-A-eDP-1
[531.050950] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.595s)
[531.060415] Starting dynamic subtest: pipe-B-eDP-1
[535.313098] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.264s)
[535.323737] Starting dynamic subtest: pipe-C-eDP-1
[539.290052] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.975s)
[539.299588] Starting dynamic subtest: pipe-D-eDP-1
[543.369185] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.076s)
[543.371532] Subtest ctm-0-50: SUCCESS (15.913s)
[544.198962] [127/133] (481s left) gem_render_copy (yf-tiled)
[544.258254] Starting subtest: yf-tiled
[544.262726] Subtest yf-tiled: SKIP (0.000s)
[544.455062] [128/133] (481s left) gem_mmap_gtt (medium-copy-odd)
[544.510334] Subtest medium-copy-odd: SKIP (0.000s)
[544.571580] [129/133] (481s left) gem_ctx_param (set-priority-range)
[544.617206] Starting subtest: set-priority-range
[544.631818] Subtest set-priority-range: SUCCESS (0.014s)
[544.751689] [130/133] (481s left) gem_exec_schedule (u-fairslice-all)
[544.827577] Starting subtest: u-fairslice-all
[546.879623] Subtest u-fairslice-all: SUCCESS (2.058s)
[547.179851] [131/133] (478s left) i915_query (query-topology-coherent-slice-mask)
[547.228561] Starting subtest: query-topology-coherent-slice-mask
[547.232486] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[547.325092] [132/133] (478s left) kms_flip (2x-blocking-absolute-wf_vblank)
[547.431106] Starting subtest: 2x-blocking-absolute-wf_vblank
[547.441819] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[547.517055] [133/133] (478s left) kms_vblank (wait-forked-busy)
[547.617069] Starting subtest: wait-forked-busy
[547.618960] Starting dynamic subtest: pipe-A-eDP-1
[549.491737] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[549.505765] Starting dynamic subtest: pipe-D-eDP-1
[552.063529] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[552.065949] Subtest wait-forked-busy: SUCCESS (4.448s)
[552.860022] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: kms_dsc
results: parsing output: 7/ for test: kms_chamelium_frames
results: parsing output: 8/ for test: kms_content_protection
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_unfence_active_buffers
results: parsing output: 13/ for test: kms_cursor_edge_walk
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: perf
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_flink_race
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: api_intel_allocator
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_hdr
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_chamelium_hpd
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane_multiple
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_exec_store
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_pipe_crc_basic
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: gem_userptr_blits
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: i915_selftest
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: gem_exec_parallel
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gen7_exec_parse
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_pipe_control_store_loop
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_flink_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: syncobj_eventfd
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: i915_pm_rpm
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_prime
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: gem_exec_alignment
results: parsing output: 120/ for test: sysfs_heartbeat_interval
results: parsing output: 121/ for test: gem_media_fill
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_query
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_vblank
Done.