[56.652060] Initializing watchdogs
[56.652109]   /dev/watchdog0
[56.665856] [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]
[56.670288] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.672480] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.675900] [001/132] (960s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[56.793989] Starting subtest: sprite-rotation-90-pos-100-0
[56.798211] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[56.870989] [002/132] (960s left) gem_mmap_offset (pf-nonblock)
[56.926909] Starting subtest: pf-nonblock
[56.932142] Subtest pf-nonblock: SUCCESS (0.008s)
[57.022471] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[57.127650] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[57.131880] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[57.230863] [004/132] (960s left) kms_hdr (brightness-with-hdr)
[57.325064] Starting subtest: brightness-with-hdr
[57.331863] Subtest brightness-with-hdr: SKIP (0.000s)
[57.392913] [005/132] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[57.491140] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[57.495551] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[57.591583] [006/132] (959s left) api_intel_bb (full-batch)
[57.652432] Starting subtest: full-batch
[57.656388] Subtest full-batch: SUCCESS (0.005s)
[57.764190] [007/132] (959s left) prime_mmap (test_userptr)
[57.823947] Starting subtest: test_userptr
[57.825986] Starting dynamic subtest: test_userptr-smem
[57.827880] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[57.829758] Subtest test_userptr: SUCCESS (0.001s)
[57.920087] [008/132] (959s left) gem_ctx_exec (basic-norecovery)
[57.978372] Starting subtest: basic-norecovery
[58.145215] Subtest basic-norecovery: SUCCESS (0.167s)
[58.276316] [009/132] (959s left) i915_drm_fdinfo (virtual-busy)
[58.321067] Starting subtest: virtual-busy
[58.325111] Subtest virtual-busy: SKIP (0.000s)
[58.401717] [010/132] (959s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[58.446665] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[58.448774] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[58.550432] [011/132] (958s left) gem_exec_fence (basic-busy-all)
[58.619439] Starting subtest: basic-busy-all
[58.712248] Subtest basic-busy-all: SUCCESS (0.095s)
[60.344921] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[60.348063] [012/132] (957s left) gem_spin_batch (engines)
[60.412561] Starting subtest: engines
[60.414950] Starting dynamic subtest: rcs0
[63.661534] Dynamic subtest rcs0: SUCCESS (3.244s)
[63.671458] Starting dynamic subtest: bcs0
[66.898961] Dynamic subtest bcs0: SUCCESS (3.237s)
[66.908991] Starting dynamic subtest: vcs0
[70.137958] Dynamic subtest vcs0: SUCCESS (3.237s)
[70.147724] Starting dynamic subtest: vcs1
[73.368906] Dynamic subtest vcs1: SUCCESS (3.230s)
[73.376988] Starting dynamic subtest: vecs0
[76.607512] Dynamic subtest vecs0: SUCCESS (3.237s)
[76.615647] Starting dynamic subtest: ccs0
[79.842029] Dynamic subtest ccs0: SUCCESS (3.235s)
[79.844124] Subtest engines: SUCCESS (19.426s)
[80.060855] [013/132] (937s left) kms_plane (plane-position-covered)
[80.149619] Starting subtest: plane-position-covered
[80.666138] Starting dynamic subtest: pipe-A-plane-1
[81.940832] Dynamic subtest pipe-A-plane-1: SUCCESS (1.276s)
[81.950923] Starting dynamic subtest: pipe-A-plane-2
[83.254373] Dynamic subtest pipe-A-plane-2: SUCCESS (1.311s)
[83.263782] Starting dynamic subtest: pipe-A-plane-3
[84.496262] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s)
[84.505175] Starting dynamic subtest: pipe-A-plane-4
[85.737242] Dynamic subtest pipe-A-plane-4: SUCCESS (1.241s)
[85.746778] Starting dynamic subtest: pipe-A-plane-5
[85.761459] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[86.886153] Starting dynamic subtest: pipe-B-plane-1
[88.136401] Dynamic subtest pipe-B-plane-1: SUCCESS (1.257s)
[88.146791] Starting dynamic subtest: pipe-B-plane-2
[89.474365] Dynamic subtest pipe-B-plane-2: SUCCESS (1.337s)
[89.482703] Starting dynamic subtest: pipe-B-plane-3
[90.805690] Dynamic subtest pipe-B-plane-3: SUCCESS (1.333s)
[90.817015] Starting dynamic subtest: pipe-B-plane-4
[92.111827] Dynamic subtest pipe-B-plane-4: SUCCESS (1.306s)
[92.121024] Starting dynamic subtest: pipe-B-plane-5
[92.140661] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s)
[92.142690] Subtest plane-position-covered: SUCCESS (11.989s)
[92.917236] [014/132] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[93.022236] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[93.026806] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[93.120773] [015/132] (924s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[93.211117] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[93.213378] Starting dynamic subtest: pipe-A-eDP-1
[93.951555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[93.961065] Starting dynamic subtest: pipe-B-eDP-1
[95.736573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s)
[95.745780] Starting dynamic subtest: pipe-C-eDP-1
[97.570740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.833s)
[97.580417] Starting dynamic subtest: pipe-D-eDP-1
[99.375591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.804s)
[99.377479] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.158s)
[100.548904] [016/132] (917s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[100.640254] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[100.644731] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[100.746148] [017/132] (917s left) kms_chamelium_hpd (dp-hpd-storm)
[101.123385] Subtest dp-hpd-storm: SKIP (0.000s)
[101.938987] [018/132] (915s left) kms_feature_discovery (psr1)
[102.027041] Starting subtest: psr1
[102.029416] Subtest psr1: SUCCESS (0.000s)
[102.107400] [019/132] (915s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[102.198129] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[102.202582] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[102.268156] [020/132] (915s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[102.360673] Starting subtest: modeset-transition-nonblocking-fencing
[102.362620] Starting dynamic subtest: 1x-outputs
[113.431793] Dynamic subtest 1x-outputs: SUCCESS (11.070s)
[113.434658] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.071s)
[114.297528] [021/132] (903s left) gem_exec_flush (basic-uc-pro-default)
[114.357153] Starting subtest: basic-uc-pro-default
[119.809829] Subtest basic-uc-pro-default: SUCCESS (5.454s)
[120.003394] [022/132] (897s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[120.121505] Starting subtest: x-tiled-64bpp-rotate-180
[121.755096] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.635s)
[121.921986] [023/132] (896s left) gem_exec_schedule (noreorder-priority)
[122.102404] Starting subtest: noreorder-priority
[122.104798] Starting dynamic subtest: rcs0
[123.247826] Dynamic subtest rcs0: SUCCESS (1.147s)
[123.259419] Starting dynamic subtest: vcs0
[125.311557] Dynamic subtest vcs0: SUCCESS (2.061s)
[125.320564] Starting dynamic subtest: vcs1
[127.291032] Dynamic subtest vcs1: SUCCESS (1.977s)
[127.301831] Starting dynamic subtest: vecs0
[129.257044] Dynamic subtest vecs0: SUCCESS (1.965s)
[129.268182] Starting dynamic subtest: ccs0
[130.437065] Dynamic subtest ccs0: SUCCESS (1.180s)
[130.439877] Subtest noreorder-priority: SUCCESS (8.337s)
[130.620464] [024/132] (887s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[130.712379] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[130.714668] Starting dynamic subtest: pipe-A-eDP-1
[130.735377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[130.743705] Starting dynamic subtest: pipe-B-eDP-1
[130.763096] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[130.770574] Starting dynamic subtest: pipe-C-eDP-1
[130.790063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[130.797715] Starting dynamic subtest: pipe-D-eDP-1
[130.816948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[130.818880] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[132.877397] [025/132] (885s left) syncobj_wait (reset-during-wait-for-submit)
[132.936090] Starting subtest: reset-during-wait-for-submit
[133.039350] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[133.112417] [026/132] (885s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[133.219550] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[133.223647] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[133.316501] [027/132] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[133.412219] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[133.416639] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[133.508289] [028/132] (884s left) drm_read (fault-buffer)
[133.643187] Starting subtest: fault-buffer
[133.645634] Subtest fault-buffer: SUCCESS (0.000s)
[133.756359] [029/132] (884s left) kms_pipe_crc_basic (suspend-read-crc)
[133.844054] Starting subtest: suspend-read-crc
[133.846384] Starting dynamic subtest: pipe-A-eDP-1
[151.441985] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.642s)
[151.459025] Starting dynamic subtest: pipe-B-eDP-1
[169.448879] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.241s)
[169.458738] Starting dynamic subtest: pipe-C-eDP-1
[187.361050] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.103s)
[187.374385] Starting dynamic subtest: pipe-D-eDP-1
[205.394505] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.058s)
[205.396496] Subtest suspend-read-crc: SUCCESS (12.050s)
[206.255837] [030/132] (812s left) gem_userptr_blits (stress-mm-invalidate-close)
[206.334596] Starting subtest: stress-mm-invalidate-close
[208.484486] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[208.615911] [031/132] (809s left) sysfs_preempt_timeout (timeout)
[208.676124] Starting subtest: timeout
[208.678416] Starting dynamic subtest: vecs0
[218.793330] Dynamic subtest vecs0: SUCCESS (10.106s)
[218.805418] Starting dynamic subtest: ccs0
[220.051974] Dynamic subtest ccs0: SUCCESS (1.256s)
[220.063790] Starting dynamic subtest: vcs0
[229.792758] Dynamic subtest vcs0: SUCCESS (9.733s)
[229.805470] Starting dynamic subtest: bcs0
[230.979137] Dynamic subtest bcs0: SUCCESS (1.188s)
[230.991138] Starting dynamic subtest: rcs0
[232.190185] Dynamic subtest rcs0: SUCCESS (1.206s)
[232.202176] Starting dynamic subtest: vcs1
[241.764116] Dynamic subtest vcs1: SUCCESS (9.568s)
[241.766676] Subtest timeout: SUCCESS (33.067s)
[241.838248] [032/132] (776s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[241.935327] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[241.946447] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[242.051920] [033/132] (776s left) gem_exec_reloc (basic-scanout)
[242.111211] Subtest basic-scanout: SKIP (0.000s)
[242.188358] [034/132] (776s left) syncobj_timeline (invalid-transfer-non-existent-point)
[242.243681] Starting subtest: invalid-transfer-non-existent-point
[242.246063] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[242.340574] [035/132] (776s left) gem_softpin (32b-excludes-last-page)
[242.404340] Starting subtest: 32b-excludes-last-page
[242.409623] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[242.543520] [036/132] (775s left) perf_pmu (pmu-read)
[242.586728] Starting subtest: pmu-read
[242.588685] Subtest pmu-read: SUCCESS (0.002s)
[242.712831] [037/132] (775s left) gem_mmap (bad-object)
[242.762108] Subtest bad-object: SKIP (0.000s)
[242.844713] [038/132] (775s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[242.950813] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[243.731676] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[243.884987] [039/132] (774s left) kms_cursor_edge_walk (128x128-right-edge)
[243.987665] Starting subtest: 128x128-right-edge
[243.989967] Starting dynamic subtest: pipe-A-eDP-1
[247.429879] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[247.439458] Starting dynamic subtest: pipe-D-eDP-1
[250.540072] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s)
[250.541975] Subtest 128x128-right-edge: SUCCESS (6.550s)
[251.356024] [040/132] (767s left) vgem_basic (mmap)
[251.408526] Starting subtest: mmap
[251.427503] Subtest mmap: SUCCESS (0.021s)
[251.500145] [041/132] (767s left) kms_flip (flip-vs-wf_vblank-interruptible)
[251.589168] Starting subtest: flip-vs-wf_vblank-interruptible
[251.593623] Starting dynamic subtest: A-eDP1
[253.510772] Dynamic subtest A-eDP1: SUCCESS (1.918s)
[253.521284] Starting dynamic subtest: B-eDP1
[255.453030] Dynamic subtest B-eDP1: SUCCESS (1.940s)
[255.462974] Starting dynamic subtest: C-eDP1
[257.370135] Dynamic subtest C-eDP1: SUCCESS (1.914s)
[257.380036] Starting dynamic subtest: D-eDP1
[259.206192] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[259.211224] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.617s)
[260.439224] [042/132] (758s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[260.559405] Starting subtest: basic-flip-before-cursor-varying-size
[261.481404] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.920s)
[262.288449] [043/132] (756s left) gem_exec_reloc (basic-wc-read)
[262.345968] Subtest basic-wc-read: SKIP (0.000s)
[262.418408] [044/132] (756s left) dmabuf_sync_file (export-multiwait)
[262.468467] Starting subtest: export-multiwait
[262.470691] Subtest export-multiwait: SUCCESS (0.002s)
[262.531914] [045/132] (756s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[262.630075] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[262.634279] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[262.716825] [046/132] (756s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[262.785639] Subtest tiled-to-tiled: SKIP (0.000s)
[262.870994] [047/132] (756s left) kms_vblank (wait-busy)
[262.953186] Starting subtest: wait-busy
[262.955015] Starting dynamic subtest: pipe-A-eDP-1
[264.835518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[264.850025] Starting dynamic subtest: pipe-D-eDP-1
[267.447725] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.609s)
[267.449692] Subtest wait-busy: SUCCESS (4.493s)
[268.258874] [048/132] (750s left) i915_hangman (detector)
[268.320040] Starting subtest: detector
[268.321956] Starting dynamic subtest: rcs0
[279.748456] Dynamic subtest rcs0: SUCCESS (11.423s)
[279.760692] Starting dynamic subtest: bcs0
[291.782303] Dynamic subtest bcs0: SUCCESS (12.026s)
[291.793930] Starting dynamic subtest: vcs0
[303.685920] Dynamic subtest vcs0: SUCCESS (11.896s)
[303.697314] Starting dynamic subtest: vcs1
[314.692750] Dynamic subtest vcs1: SUCCESS (11.000s)
[314.704406] Starting dynamic subtest: vecs0
[324.740773] Dynamic subtest vecs0: SUCCESS (10.041s)
[324.753116] Starting dynamic subtest: ccs0
[335.748958] Dynamic subtest ccs0: SUCCESS (11.001s)
[335.751818] Subtest detector: SUCCESS (67.402s)
[335.870156] [049/132] (683s left) gem_close_race (basic-process)
[335.942367] Starting subtest: basic-process
[335.983642] Subtest basic-process: SUCCESS (0.041s)
[336.167273] [050/132] (682s left) gem_mmap_gtt (big-bo-tiledy)
[336.223123] Subtest big-bo-tiledY: SKIP (0.000s)
[336.282663] [051/132] (682s left) kms_psr (fbc-psr2-cursor-render)
[336.378858] Starting subtest: fbc-psr2-cursor-render
[336.380961] Starting dynamic subtest: eDP-1
[336.385042] Dynamic subtest eDP-1: SKIP (0.000s)
[336.389154] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[336.466303] [052/132] (682s left) kms_psr (fbc-pr-basic)
[336.554093] Starting subtest: fbc-pr-basic
[336.558607] Subtest fbc-pr-basic: SKIP (0.000s)
[336.640692] [053/132] (682s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[336.741501] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[336.745523] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[336.812995] [054/132] (682s left) kms_hdmi_inject (inject-4k)
[337.155673] Starting subtest: inject-4k
[337.474750] Subtest inject-4k: SUCCESS (0.320s)
[338.025751] [055/132] (681s left) kms_frontbuffer_tracking (psr-slowdraw)
[338.129093] Starting subtest: psr-slowdraw
[363.175004] Subtest psr-slowdraw: SUCCESS (25.039s)
[363.300276] [056/132] (656s left) gem_mmap_gtt (zero-extend)
[363.364802] Subtest zero-extend: SKIP (0.000s)
[363.432649] [057/132] (656s left) kms_prop_blob (blob-prop-core)
[363.484944] Starting subtest: blob-prop-core
[363.487242] Subtest blob-prop-core: SUCCESS (0.000s)
[363.585288] [058/132] (655s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[363.678086] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[363.680326] Starting dynamic subtest: pipe-A-default-mode
[364.861700] Dynamic subtest pipe-A-default-mode: SKIP (1.181s)
[364.865639] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.183s)
[365.005755] [059/132] (654s left) gem_ctx_persistence (hang)
[365.058024] Starting subtest: hang
[365.062773] Subtest hang: SKIP (0.000s)
[365.182180] [060/132] (654s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[365.289427] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[365.293601] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[365.379884] [061/132] (654s left) syncobj_eventfd (invalid-bad-flags)
[365.430490] Starting subtest: invalid-bad-flags
[365.432871] Subtest invalid-bad-flags: SUCCESS (0.000s)
[365.521292] [062/132] (654s left) gem_ccs (ctrl-surf-copy-new-ctx)
[365.581125] Starting subtest: ctrl-surf-copy-new-ctx
[365.585328] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[365.677692] [063/132] (654s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[365.773144] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[365.777081] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[366.862952] [064/132] (652s left) kms_universal_plane (cursor-fb-leak)
[366.949842] Starting subtest: cursor-fb-leak
[366.951860] Starting dynamic subtest: pipe-A-eDP-1
[367.316490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[367.328764] Starting dynamic subtest: pipe-B-eDP-1
[368.693013] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[368.706595] Starting dynamic subtest: pipe-C-eDP-1
[370.037068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[370.053165] Starting dynamic subtest: pipe-D-eDP-1
[371.449867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s)
[371.452635] Subtest cursor-fb-leak: SUCCESS (4.501s)
[372.600274] [065/132] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[372.714551] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[379.877482] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.163s)
[380.014089] [066/132] (639s left) kms_addfb_basic (addfb25-4-tiled)
[380.109633] Starting subtest: addfb25-4-tiled
[380.111709] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[380.209118] [067/132] (639s left) kms_atomic_transition (plane-all-transition-fencing)
[380.297509] Starting subtest: plane-all-transition-fencing
[380.299588] Starting dynamic subtest: pipe-A-eDP-1
[382.791916] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[383.113329] Starting dynamic subtest: pipe-B-eDP-1
[386.392254] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.288s)
[386.704969] Subtest plane-all-transition-fencing: SUCCESS (6.406s)
[387.519143] [068/132] (632s left) gen7_exec_parse (load-register-reg)
[387.573614] Subtest load-register-reg: SKIP (0.000s)
[387.638828] [069/132] (632s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[387.747670] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[387.752172] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[387.840563] [070/132] (632s left) gem_exec_params (sol-reset-invalid)
[387.897090] Starting subtest: sol-reset-invalid
[387.902443] Subtest sol-reset-invalid: SUCCESS (0.003s)
[389.889210] [071/132] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[389.991867] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[389.995978] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[390.082201] [072/132] (629s left) gem_reg_read (bad-register)
[390.135437] Starting subtest: bad-register
[390.137832] Subtest bad-register: SUCCESS (0.000s)
[390.261894] [073/132] (629s left) perf (gen12-group-exclusive-stream-ctx-handle)
[390.381823] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[390.406443] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.025s)
[390.456010] [074/132] (629s left) gem_exec_fence (syncobj-invalid-wait)
[392.131473] Starting subtest: syncobj-invalid-wait
[392.133874] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[393.845153] [075/132] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[393.960784] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[400.960762] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.000s)
[401.068372] [076/132] (619s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[401.452414] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[402.265780] [077/132] (617s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[402.367651] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[402.394029] Starting dynamic subtest: pipe-A-plane-0
[403.071540] Dynamic subtest pipe-A-plane-0: SUCCESS (0.678s)
[403.084448] Starting dynamic subtest: pipe-A-plane-3
[403.483123] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s)
[404.576775] Starting dynamic subtest: pipe-B-plane-0
[405.234254] Dynamic subtest pipe-B-plane-0: SUCCESS (0.666s)
[405.243460] Starting dynamic subtest: pipe-B-plane-3
[405.689578] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[406.002981] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.634s)
[406.843860] [078/132] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[406.943054] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[406.947485] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.034897] [079/132] (613s left) gem_lmem_swapping (verify)
[407.082095] Subtest verify: SKIP (0.000s)
[407.127035] [080/132] (613s left) kms_joiner (invalid-modeset-big-joiner)
[407.217159] Starting subtest: invalid-modeset-big-joiner
[407.221537] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[407.306099] [081/132] (613s left) api_intel_allocator (simple-allocator)
[407.368746] Starting subtest: simple-allocator
[407.371101] Starting dynamic subtest: basic
[407.373310] Dynamic subtest basic: SUCCESS (0.003s)
[407.387062] Starting dynamic subtest: parallel-one
[407.559045] Dynamic subtest parallel-one: SUCCESS (0.187s)
[407.572191] Starting dynamic subtest: print
[407.574418] Dynamic subtest print: SUCCESS (0.000s)
[407.583156] Starting dynamic subtest: reuse
[407.585063] Dynamic subtest reuse: SUCCESS (0.000s)
[407.593877] Starting dynamic subtest: reserve
[407.595783] Dynamic subtest reserve: SUCCESS (0.000s)
[407.604187] Starting dynamic subtest: fork-reopen-allocator
[407.606071] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[407.607950] Subtest simple-allocator: SUCCESS (0.206s)
[407.681792] [082/132] (612s left) syncobj_timeline (wait-all-snapshot)
[407.740992] Starting subtest: wait-all-snapshot
[407.820367] Subtest wait-all-snapshot: SUCCESS (0.081s)
[407.897767] [083/132] (612s left) gem_exec_whisper (basic-fds-priority-all)
[407.960483] Starting subtest: basic-fds-priority-all
[431.854007] Subtest basic-fds-priority-all: SUCCESS (23.886s)
[432.052681] [084/132] (588s left) kms_flip (2x-plain-flip-ts-check)
[432.155779] Starting subtest: 2x-plain-flip-ts-check
[432.166679] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[432.249146] [085/132] (588s left) gem_lmem_swapping (massive-random)
[432.290973] Subtest massive-random: SKIP (0.000s)
[432.335569] [086/132] (588s left) gem_userptr_blits (unsync-overlap)
[432.390043] Subtest unsync-overlap: SKIP (0.000s)
[432.506534] [087/132] (588s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[432.596990] Starting subtest: pr-plane-move-sf-dmg-area
[432.601330] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[432.674573] [088/132] (588s left) i915_pm_rc6_residency (rc6-idle)
[432.732352] Starting subtest: rc6-idle
[432.747472] Starting dynamic subtest: gt0-rcs0
[457.189904] Dynamic subtest gt0-rcs0: SUCCESS (24.432s)
[457.199975] Starting dynamic subtest: gt0-bcs0
[481.546822] Dynamic subtest gt0-bcs0: SUCCESS (24.344s)
[481.558693] Starting dynamic subtest: gt0-ccs0
[505.756866] Dynamic subtest gt0-ccs0: SUCCESS (24.272s)
[505.768472] Starting dynamic subtest: gt1-vcs0
[511.931567] Dynamic subtest gt1-vcs0: SUCCESS (6.188s)
[511.943968] Starting dynamic subtest: gt1-vecs0
[518.102641] Dynamic subtest gt1-vecs0: SUCCESS (6.181s)
[518.105182] Subtest rc6-idle: SUCCESS (85.448s)
[518.180890] [089/132] (502s left) kms_psr (psr2-cursor-plane-onoff)
[518.269071] Starting subtest: psr2-cursor-plane-onoff
[518.271331] Starting dynamic subtest: eDP-1
[519.950056] Dynamic subtest eDP-1: SUCCESS (1.681s)
[519.952373] Subtest psr2-cursor-plane-onoff: SUCCESS (1.682s)
[520.761625] [090/132] (500s left) kms_lease (lease-invalid-connector)
[520.857679] Starting subtest: lease-invalid-connector
[520.860084] Starting dynamic subtest: pipe-A-eDP-1
[520.862583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[520.876044] Starting dynamic subtest: pipe-B-eDP-1
[520.878001] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[520.887450] Starting dynamic subtest: pipe-C-eDP-1
[520.889618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[520.898697] Starting dynamic subtest: pipe-D-eDP-1
[520.900937] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[520.903146] Subtest lease-invalid-connector: SUCCESS (0.005s)
[520.943869] [091/132] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[521.044716] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[521.049158] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[521.147118] [092/132] (499s left) kms_plane_scaling (planes-upscale-factor-0-25)
[521.249600] Starting subtest: planes-upscale-factor-0-25
[521.251823] Starting dynamic subtest: pipe-A
[521.310216] Dynamic subtest pipe-A: SUCCESS (0.062s)
[521.328199] Starting dynamic subtest: pipe-B
[522.477337] Dynamic subtest pipe-B: SUCCESS (1.166s)
[522.490130] Starting dynamic subtest: pipe-C
[523.584654] Dynamic subtest pipe-C: SUCCESS (1.109s)
[523.594607] Starting dynamic subtest: pipe-D
[524.712044] Dynamic subtest pipe-D: SUCCESS (1.128s)
[524.714468] Subtest planes-upscale-factor-0-25: SUCCESS (3.470s)
[525.877843] [093/132] (495s left) gem_ctx_shared (single-timeline)
[525.963882] Starting subtest: single-timeline
[525.982143] Subtest single-timeline: SUCCESS (0.016s)
[526.200008] [094/132] (494s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[526.306772] Starting subtest: y-tiled-64bpp-rotate-180
[526.311062] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[526.409658] [095/132] (494s left) prime_busy (hang)
[526.462340] Starting subtest: hang
[526.465111] Starting dynamic subtest: rcs0
[552.314019] Dynamic subtest rcs0: SUCCESS (25.870s)
[552.323715] Starting dynamic subtest: bcs0
[559.472490] Dynamic subtest bcs0: SUCCESS (7.157s)
[559.484463] Starting dynamic subtest: vcs0
[566.444721] Dynamic subtest vcs0: SUCCESS (6.971s)
[566.458067] Starting dynamic subtest: vcs1
[573.421410] Dynamic subtest vcs1: SUCCESS (6.973s)
[573.434198] Starting dynamic subtest: vecs0
[580.464030] Dynamic subtest vecs0: SUCCESS (7.037s)
[580.473464] Starting dynamic subtest: ccs0
[594.308472] Dynamic subtest ccs0: SUCCESS (13.843s)
[594.310732] Subtest hang: SUCCESS (67.859s)
[594.420303] [096/132] (426s left) gem_create (busy-create)
[594.475549] Starting subtest: busy-create
[594.477852] Starting dynamic subtest: smem0
[627.753839] Dynamic subtest smem0: SUCCESS (33.281s)
[627.756590] Subtest busy-create: SUCCESS (33.283s)
[627.940142] [097/132] (393s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[628.048910] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[634.795699] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.751s)
[634.919846] [098/132] (386s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[635.024491] Starting subtest: plane-lut1d-ctm3x4
[635.205896] Starting dynamic subtest: pipe-A-plane-0
[635.361988] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[635.377406] Starting dynamic subtest: pipe-A-plane-1
[635.494704] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[635.505193] Starting dynamic subtest: pipe-A-plane-2
[635.628563] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[636.846612] Starting dynamic subtest: pipe-B-plane-0
[636.981795] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[636.992431] Starting dynamic subtest: pipe-B-plane-1
[637.115254] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[637.125868] Starting dynamic subtest: pipe-B-plane-2
[637.248811] Dynamic subtest pipe-B-plane-2: SUCCESS (0.132s)
[638.477760] Starting dynamic subtest: pipe-C-plane-0
[638.602318] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[638.612929] Starting dynamic subtest: pipe-C-plane-1
[638.735578] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[638.745642] Starting dynamic subtest: pipe-C-plane-2
[638.868702] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[640.105494] Starting dynamic subtest: pipe-D-plane-0
[640.230217] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[640.240659] Starting dynamic subtest: pipe-D-plane-1
[640.364353] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[640.374564] Starting dynamic subtest: pipe-D-plane-2
[640.496866] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[640.789873] Subtest plane-lut1d-ctm3x4: SUCCESS (5.764s)
[641.602777] [099/132] (379s left) kms_cursor_crc (cursor-onscreen-32x32)
[641.747129] Starting subtest: cursor-onscreen-32x32
[641.793341] Subtest cursor-onscreen-32x32: SKIP (0.039s)
[642.093871] [100/132] (379s left) gem_pxp (reject-modify-context-protection-off-2)
[642.213505] Starting subtest: reject-modify-context-protection-off-2
[642.215885] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[642.320258] [101/132] (378s left) gem_userptr_blits (sd-probe)
[642.377672] Starting subtest: sd-probe
[642.379663] Subtest sd-probe: SUCCESS (0.000s)
[642.493114] [102/132] (378s left) kms_psr (psr-sprite-mmap-cpu)
[642.586803] Starting subtest: psr-sprite-mmap-cpu
[642.588872] Starting dynamic subtest: eDP-1
[644.322027] Dynamic subtest eDP-1: SUCCESS (1.735s)
[644.324441] Subtest psr-sprite-mmap-cpu: SUCCESS (1.736s)
[645.149937] [103/132] (376s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[645.251780] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[645.254191] Starting dynamic subtest: pipe-A-eDP-1
[645.311552] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[645.321217] Starting dynamic subtest: pipe-B-eDP-1
[645.383960] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[645.395424] Starting dynamic subtest: pipe-C-eDP-1
[645.453259] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[645.464117] Starting dynamic subtest: pipe-D-eDP-1
[645.522279] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[645.526586] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.017s)
[647.431143] [104/132] (373s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[647.532651] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[647.537249] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[647.620699] [105/132] (373s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[647.730339] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[651.420062] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.694s)
[652.549963] [106/132] (368s left) kms_psr (fbc-psr-primary-mmap-cpu)
[652.637572] Starting subtest: fbc-psr-primary-mmap-cpu
[652.639950] Starting dynamic subtest: eDP-1
[652.644324] Dynamic subtest eDP-1: SKIP (0.000s)
[652.648765] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[652.711525] [107/132] (368s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[652.813799] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[656.935718] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.126s)
[658.145297] [108/132] (363s left) i915_query (engine-info)
[658.202687] Starting subtest: engine-info
[658.205211] Subtest engine-info: SUCCESS (0.004s)
[658.320903] [109/132] (363s left) kms_cursor_legacy (single-move)
[658.439110] Starting subtest: single-move
[658.441477] Starting dynamic subtest: pipe-A
[663.821637] Dynamic subtest pipe-A: SUCCESS (5.380s)
[663.833448] Starting dynamic subtest: pipe-B
[669.203416] Dynamic subtest pipe-B: SUCCESS (5.380s)
[669.215562] Starting dynamic subtest: pipe-C
[674.583450] Dynamic subtest pipe-C: SUCCESS (5.379s)
[674.597646] Starting dynamic subtest: pipe-D
[679.963668] Dynamic subtest pipe-D: SUCCESS (5.379s)
[679.975611] Starting dynamic subtest: all-pipes
[685.350926] Dynamic subtest all-pipes: SUCCESS (5.385s)
[685.353512] Subtest single-move: SUCCESS (26.917s)
[685.495642] [110/132] (336s left) prime_self_import (basic-with_two_bos)
[685.550316] Starting subtest: basic-with_two_bos
[685.577429] Subtest basic-with_two_bos: SUCCESS (0.027s)
[685.672955] [111/132] (335s left) gem_render_copy_redux (flink)
[685.726246] Starting subtest: flink
[686.546989] Subtest flink: SUCCESS (0.821s)
[686.709815] [112/132] (335s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[686.841638] Starting subtest: flip-vs-cursor-atomic-transitions
[694.674878] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.827s)
[695.467210] [113/132] (326s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[695.567136] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[696.224791] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[696.384923] [114/132] (325s left) kms_pm_dc (dc5-dpms-negative)
[697.490582] Starting subtest: dc5-dpms-negative
[697.495143] Subtest dc5-dpms-negative: SKIP (0.000s)
[697.563885] [115/132] (324s left) gem_exec_capture (capture)
[697.623508] Starting subtest: capture
[697.625791] Starting dynamic subtest: rcs0-smem
[698.454622] Dynamic subtest rcs0-smem: SUCCESS (0.831s)
[698.464862] Starting dynamic subtest: bcs0-smem
[699.779995] Dynamic subtest bcs0-smem: SUCCESS (1.322s)
[699.791093] Starting dynamic subtest: vcs0-smem
[700.597467] Dynamic subtest vcs0-smem: SUCCESS (0.817s)
[700.606862] Starting dynamic subtest: vcs1-smem
[701.419450] Dynamic subtest vcs1-smem: SUCCESS (0.820s)
[701.431545] Starting dynamic subtest: vecs0-smem
[702.803621] Dynamic subtest vecs0-smem: FAIL (1.325s)
[702.815330] Starting dynamic subtest: ccs0-smem
[704.059439] Dynamic subtest ccs0-smem: SUCCESS (1.314s)
[704.061864] Subtest capture: FAIL (6.434s)
[704.172631] [116/132] (317s left) kms_setmode (clone-exclusive-crtc)
[704.230784] Starting subtest: clone-exclusive-crtc
[704.237655] Subtest clone-exclusive-crtc: SKIP (0.000s)
[704.329640] [117/132] (317s left) gem_exec_params (rel-constants-invalid)
[704.395854] Starting subtest: rel-constants-invalid
[704.398295] Subtest rel-constants-invalid: SUCCESS (0.000s)
[704.501801] [118/132] (317s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[704.602059] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[705.591715] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.990s)
[705.721292] [119/132] (316s left) gem_exec_flush (basic-batch-kernel-default-wb)
[705.779338] Starting subtest: basic-batch-kernel-default-wb
[713.121666] Subtest basic-batch-kernel-default-wb: SUCCESS (7.340s)
[713.306820] [120/132] (308s left) prime_mmap (test_reprime)
[713.367088] Starting subtest: test_reprime
[713.369521] Starting dynamic subtest: test_reprime-smem
[713.396652] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[713.399104] Subtest test_reprime: SUCCESS (0.032s)
[713.510578] [121/132] (308s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[713.565004] Starting subtest: rel-constants-invalid-rel-gen5
[713.567312] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[713.681917] [122/132] (308s left) gem_exec_schedule (submit-late-slice)
[713.746289] Starting subtest: submit-late-slice
[713.748695] Starting dynamic subtest: rcs0
[713.805609] Dynamic subtest rcs0: SUCCESS (0.065s)
[713.817121] Starting dynamic subtest: bcs0
[713.867466] Dynamic subtest bcs0: SUCCESS (0.061s)
[713.878571] Starting dynamic subtest: vcs0
[713.917232] Dynamic subtest vcs0: SUCCESS (0.049s)
[713.931673] Starting dynamic subtest: vcs1
[713.969057] Dynamic subtest vcs1: SUCCESS (0.051s)
[713.983834] Starting dynamic subtest: vecs0
[714.017060] Dynamic subtest vecs0: SUCCESS (0.047s)
[714.030302] Starting dynamic subtest: ccs0
[714.075243] Dynamic subtest ccs0: SUCCESS (0.057s)
[714.077721] Subtest submit-late-slice: SUCCESS (0.336s)
[715.910185] [123/132] (306s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[716.166753] Starting subtest: cursor-rapid-movement-256x85
[716.210192] Subtest cursor-rapid-movement-256x85: SKIP (0.039s)
[716.392409] [124/132] (305s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[716.489940] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[716.492147] Starting dynamic subtest: pipe-A-eDP-1
[716.514666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[716.527989] Starting dynamic subtest: pipe-B-eDP-1
[716.549456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[716.559884] Starting dynamic subtest: pipe-C-eDP-1
[716.581359] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[716.591696] Starting dynamic subtest: pipe-D-eDP-1
[716.614654] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[716.618859] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[718.742173] [125/132] (303s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[718.900690] Starting subtest: dp-mst-lic-type-0-hdcp14
[718.905149] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[719.010484] [126/132] (303s left) kms_psr (pr-cursor-plane-move)
[719.109330] Starting subtest: pr-cursor-plane-move
[719.113575] Subtest pr-cursor-plane-move: SKIP (0.000s)
[719.181306] [127/132] (303s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[719.276353] Starting subtest: fbcpsr-rgb101010-draw-render
[726.020537] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.741s)
[726.147124] [128/132] (296s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[726.208835] Starting subtest: multi-wait-for-submit-available-signaled
[726.211266] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[726.306796] [129/132] (296s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[726.415949] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[730.971312] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.558s)
[732.083085] [130/132] (290s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[732.137468] Starting subtest: etime-single-wait-available-unsubmitted
[732.243330] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[732.317874] [131/132] (290s left) gem_userptr_blits (unsync-unmap-cycles)
[732.389229] Subtest unsync-unmap-cycles: SKIP (0.000s)
[732.548128] [132/132] (290s left) gem_exec_balancer (hog)
[732.608081] Starting subtest: hog
[732.612826] Subtest hog: SKIP (0.000s)
[732.913677] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_hdr
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: gem_ctx_exec
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_chamelium_hpd
results: parsing output: 17/ for test: kms_feature_discovery
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_atomic_transition
results: parsing output: 20/ for test: gem_exec_flush
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: drm_read
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: sysfs_preempt_timeout
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_mmap
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: dmabuf_sync_file
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_set_tiling_vs_blt
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: i915_hangman
results: parsing output: 48/ for test: gem_close_race
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_hdmi_inject
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_mmap_gtt
results: parsing output: 56/ for test: kms_prop_blob
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_ctx_persistence
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_eventfd
results: parsing output: 61/ for test: gem_ccs
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_universal_plane
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_atomic_transition
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_reg_read
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_chamelium_edid
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: kms_joiner
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: i915_pm_rc6_residency
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: gem_ctx_shared
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: prime_busy
results: parsing output: 95/ for test: gem_create
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_color_pipeline
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_pxp
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_query
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: prime_self_import
results: parsing output: 110/ for test: gem_render_copy_redux
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_pm_dc
results: parsing output: 114/ for test: gem_exec_capture
results: parsing output: 115/ for test: kms_setmode
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: prime_mmap
results: parsing output: 120/ for test: gem_exec_params
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_exec_balancer
Done.