[62.484500] Initializing watchdogs [62.484550] /dev/watchdog0 [62.498783] [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] [62.503579] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [62.505568] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [62.507435] [001/134] (960s left) gem_exec_schedule (preempt-other-chain) [62.590825] Starting subtest: preempt-other-chain [62.591835] Starting dynamic subtest: rcs0 [62.740037] Dynamic subtest rcs0: SUCCESS (0.145s) [62.749950] Starting dynamic subtest: bcs0 [62.873029] Dynamic subtest bcs0: SUCCESS (0.132s) [62.881778] Starting dynamic subtest: vcs0 [63.006069] Dynamic subtest vcs0: SUCCESS (0.132s) [63.015164] Starting dynamic subtest: vcs1 [63.139063] Dynamic subtest vcs1: SUCCESS (0.132s) [63.151868] Starting dynamic subtest: vecs0 [63.274764] Dynamic subtest vecs0: SUCCESS (0.135s) [63.284237] Starting dynamic subtest: ccs0 [63.406615] Dynamic subtest ccs0: SUCCESS (0.131s) [63.407973] Subtest preempt-other-chain: SUCCESS (0.809s) [63.979757] [002/134] (959s left) gem_eio (reset-stress) [64.235823] Starting subtest: reset-stress [64.236852] Starting dynamic subtest: render [70.112438] Dynamic subtest render: SUCCESS (5.856s) [70.126301] Starting dynamic subtest: bsd1 [88.445228] Dynamic subtest bsd1: SUCCESS (18.312s) [88.457384] Starting dynamic subtest: bsd2 [106.423597] Dynamic subtest bsd2: SUCCESS (17.971s) [106.436902] Starting dynamic subtest: blt [106.438526] Dynamic subtest blt: SKIP (0.000s) [106.444368] Starting dynamic subtest: vebox [124.463420] Dynamic subtest vebox: SUCCESS (18.035s) [124.464411] Subtest reset-stress: SUCCESS (60.177s) [125.969901] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true [125.971683] [003/134] (897s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [126.358931] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [127.162324] [004/134] (895s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling) [127.260424] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling [127.261452] Starting dynamic subtest: pipe-A-default-mode [128.461351] Dynamic subtest pipe-A-default-mode: SKIP (1.199s) [128.463528] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.200s) [128.632969] [005/134] (894s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [133.604556] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [133.608264] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [134.473089] [006/134] (888s left) kms_plane_multiple (tiling-4) [134.563383] Starting subtest: tiling-4 [134.564421] Starting dynamic subtest: pipe-A-eDP-1 [138.370790] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.807s) [138.377857] Starting dynamic subtest: pipe-B-eDP-1 [142.736704] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.364s) [142.743097] Starting dynamic subtest: pipe-C-eDP-1 [147.065530] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s) [147.075803] Starting dynamic subtest: pipe-D-eDP-1 [151.408744] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.343s) [151.409744] Subtest tiling-4: SUCCESS (16.845s) [152.229730] [007/134] (870s left) i915_query (test-query-geometry-subslices) [152.289865] Starting subtest: test-query-geometry-subslices [152.290839] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [152.415447] [008/134] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [152.508768] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [159.249467] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.741s) [159.391266] [009/134] (863s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [159.488049] Starting subtest: yf-tiled-8bpp-rotate-90 [159.489846] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [159.614914] [010/134] (863s left) kms_selftest (drm_format_helper) [159.646425] Starting subtest: drm_format_helper [159.660787] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [159.784544] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.123s) [159.792863] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [159.875079] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.089s) [159.885388] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [160.026208] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.151s) [160.032861] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [160.164814] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.138s) [160.172624] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [160.289069] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.124s) [160.296798] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [160.424778] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.135s) [160.432752] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [160.549940] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.125s) [160.556379] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [160.687993] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.137s) [160.694403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [160.818246] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.129s) [160.825904] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [160.942878] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.125s) [160.950674] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [161.072704] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.130s) [161.080604] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [161.204674] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.132s) [161.212276] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [161.325741] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.120s) [161.333605] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [161.408646] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.083s) [161.416846] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [161.532793] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.124s) [161.540277] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [161.670519] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.137s) [161.678852] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [161.773788] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.103s) [161.774662] Subtest drm_format_helper: SUCCESS (2.129s) [161.991054] [011/134] (861s left) kms_joiner (basic-max-non-joiner) [162.083514] Starting subtest: basic-max-non-joiner [162.085245] Subtest basic-max-non-joiner: SKIP (0.000s) [162.173327] [012/134] (861s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [162.264453] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [162.265491] Starting dynamic subtest: pipe-A-eDP-1 [164.305696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.041s) [164.313541] Starting dynamic subtest: pipe-B-eDP-1 [166.429956] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.123s) [166.437829] Starting dynamic subtest: pipe-C-eDP-1 [168.471222] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.040s) [168.478632] Starting dynamic subtest: pipe-D-eDP-1 [170.632287] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s) [170.633188] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.369s) [171.846770] [013/134] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [171.945780] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [178.860321] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.915s) [178.993707] [014/134] (844s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [179.385424] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [180.190974] [015/134] (843s left) syncobj_wait (reset-signaled) [180.250509] Starting subtest: reset-signaled [180.251436] Subtest reset-signaled: SUCCESS (0.000s) [180.362860] [016/134] (843s left) kms_frontbuffer_tracking (fbc-argb161616f-draw-pwrite) [180.463400] Starting subtest: fbc-argb161616f-draw-pwrite [180.465177] Subtest fbc-argb161616f-draw-pwrite: SKIP (0.000s) [180.586896] [017/134] (842s left) gem_exec_flush (basic-uc-rw-default) [180.649152] Starting subtest: basic-uc-rw-default [186.111279] Subtest basic-uc-rw-default: SUCCESS (5.462s) [186.312165] [018/134] (837s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [186.421273] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [193.258197] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.835s) [193.431847] [019/134] (830s left) gem_ctx_shared (q-out-order) [193.493222] Starting subtest: Q-out-order [193.494264] Starting dynamic subtest: rcs0 [193.593519] Dynamic subtest rcs0: SUCCESS (0.099s) [193.607610] Starting dynamic subtest: vcs0 [193.672474] Dynamic subtest vcs0: SUCCESS (0.079s) [193.686569] Starting dynamic subtest: vcs1 [193.753661] Dynamic subtest vcs1: SUCCESS (0.080s) [193.767357] Starting dynamic subtest: vecs0 [193.827911] Dynamic subtest vecs0: SUCCESS (0.074s) [193.841748] Starting dynamic subtest: ccs0 [193.918460] Dynamic subtest ccs0: SUCCESS (0.090s) [193.919611] Subtest Q-out-order: SUCCESS (0.425s) [195.031378] [020/134] (828s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [195.137813] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [195.138761] Starting dynamic subtest: pipe-A [195.155868] Dynamic subtest pipe-A: SKIP (0.017s) [195.162583] Starting dynamic subtest: pipe-B [195.185150] Dynamic subtest pipe-B: SKIP (0.030s) [195.191608] Starting dynamic subtest: pipe-C [195.215284] Dynamic subtest pipe-C: SKIP (0.029s) [195.221603] Starting dynamic subtest: pipe-D [195.243813] Dynamic subtest pipe-D: SKIP (0.028s) [195.245629] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.106s) [195.354608] [021/134] (828s left) kms_prop_blob (invalid-get-prop-any) [195.409056] Starting subtest: invalid-get-prop-any [195.410181] Subtest invalid-get-prop-any: SUCCESS (0.000s) [195.526948] [022/134] (828s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [195.621329] Starting subtest: fbc-dirtyfb-ioctl [195.622228] Starting dynamic subtest: A-eDP-1 [198.217373] Dynamic subtest A-eDP-1: SUCCESS (2.595s) [198.218212] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.596s) [199.032366] [023/134] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [199.125382] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [199.127051] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [199.277829] [024/134] (824s left) i915_drm_fdinfo (memory-info-idle) [199.316905] Starting subtest: memory-info-idle [199.317808] Starting dynamic subtest: smem0 [199.396321] Dynamic subtest smem0: SUCCESS (0.078s) [199.397875] Subtest memory-info-idle: SUCCESS (0.079s) [199.486088] [025/134] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [199.588074] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [199.589803] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [199.704739] [026/134] (824s left) syncobj_basic (bad-pad-handle-to-fd) [199.768106] Starting subtest: bad-pad-handle-to-fd [199.768961] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [199.884198] [027/134] (823s left) gem_eio (in-flight-10ms) [200.097921] Starting subtest: in-flight-10ms [208.959097] Subtest in-flight-10ms: SUCCESS (8.860s) [209.152212] [028/134] (814s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [209.266690] Starting subtest: 2x-long-cursor-vs-flip-atomic [209.269900] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s) [209.446809] [029/134] (814s left) gem_eio (in-flight-external) [209.661801] Starting subtest: in-flight-external [210.976039] Subtest in-flight-external: SUCCESS (1.315s) [211.133843] [030/134] (812s left) sw_sync (sync_merge_same) [211.168762] Starting subtest: sync_merge_same [211.170221] Subtest sync_merge_same: SUCCESS (0.000s) [211.242175] [031/134] (812s left) gem_exec_reloc (basic-write-read-noreloc) [211.292518] Subtest basic-write-read-noreloc: SKIP (0.000s) [211.366517] [032/134] (812s left) syncobj_timeline (multi-wait-available-submitted) [211.416346] Starting subtest: multi-wait-available-submitted [211.417304] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [211.545202] [033/134] (812s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [211.663396] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [211.665117] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [211.825578] [034/134] (812s left) syncobj_wait (invalid-multi-wait-unsubmitted) [211.879923] Starting subtest: invalid-multi-wait-unsubmitted [211.881251] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [212.004243] [035/134] (812s left) kms_psr (psr2-cursor-mmap-gtt) [212.094601] Starting subtest: psr2-cursor-mmap-gtt [212.095580] Starting dynamic subtest: eDP-1 [213.789199] Dynamic subtest eDP-1: SUCCESS (1.695s) [213.790152] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.696s) [214.610451] [036/134] (809s left) kms_flip (flip-vs-dpms-on-nop) [214.696390] Starting subtest: flip-vs-dpms-on-nop [214.697323] Starting dynamic subtest: A-eDP1 [216.593329] Dynamic subtest A-eDP1: SUCCESS (1.895s) [216.603743] Starting dynamic subtest: B-eDP1 [218.440281] Dynamic subtest B-eDP1: SUCCESS (1.843s) [218.460795] Starting dynamic subtest: C-eDP1 [220.356961] Dynamic subtest C-eDP1: SUCCESS (1.914s) [220.364705] Starting dynamic subtest: D-eDP1 [222.208842] Dynamic subtest D-eDP1: SUCCESS (1.850s) [222.214224] Subtest flip-vs-dpms-on-nop: SUCCESS (7.518s) [223.400387] [037/134] (800s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [223.499923] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [223.501720] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [223.627389] [038/134] (800s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [223.721263] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [223.722810] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [223.845999] [039/134] (800s left) syncobj_wait (single-wait-all-for-submit-submitted) [223.904715] Starting subtest: single-wait-all-for-submit-submitted [224.011314] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s) [224.102529] [040/134] (800s left) kms_cursor_edge_walk (64x64-top-edge) [224.199611] Starting subtest: 64x64-top-edge [224.200508] Starting dynamic subtest: pipe-A-eDP-1 [227.651918] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s) [227.659740] Starting dynamic subtest: pipe-D-eDP-1 [230.780690] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s) [230.781595] Subtest 64x64-top-edge: SUCCESS (6.582s) [231.589608] [041/134] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [231.680958] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [231.682739] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [231.814459] [042/134] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence) [231.897249] Starting subtest: read-crc-frame-sequence [231.898144] Starting dynamic subtest: pipe-A-eDP-1 [232.599707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s) [232.606731] Starting dynamic subtest: pipe-B-eDP-1 [233.942290] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.341s) [233.949458] Starting dynamic subtest: pipe-C-eDP-1 [235.261977] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s) [235.268814] Starting dynamic subtest: pipe-D-eDP-1 [236.602230] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s) [236.603090] Subtest read-crc-frame-sequence: SUCCESS (4.705s) [237.424514] [043/134] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [237.522752] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [237.524633] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [237.636845] [044/134] (786s left) gem_ctx_isolation (preservation) [237.704317] Starting subtest: preservation [237.705328] Starting dynamic subtest: rcs0 [237.854118] Dynamic subtest rcs0: SUCCESS (0.149s) [237.863685] Starting dynamic subtest: bcs0 [238.015467] Dynamic subtest bcs0: SUCCESS (0.160s) [238.025251] Starting dynamic subtest: vcs0 [238.199612] Dynamic subtest vcs0: SUCCESS (0.184s) [238.207071] Starting dynamic subtest: vcs1 [240.036539] Dynamic subtest vcs1: SUCCESS (1.835s) [240.045150] Starting dynamic subtest: vecs0 [242.074112] Dynamic subtest vecs0: SUCCESS (2.036s) [242.081696] Starting dynamic subtest: ccs0 [244.061527] Dynamic subtest ccs0: SUCCESS (1.985s) [244.063504] Subtest preservation: SUCCESS (6.355s) [244.311551] [045/134] (780s left) api_intel_bb (reset-bb) [244.374204] Starting subtest: reset-bb [244.378909] Subtest reset-bb: SUCCESS (0.006s) [244.520139] [046/134] (779s left) gem_exec_balancer (nohangcheck) [244.784390] Starting subtest: nohangcheck [245.652275] Subtest nohangcheck: SUCCESS (0.867s) [245.805892] [047/134] (778s left) kms_flip (2x-flip-vs-modeset) [245.896135] Starting subtest: 2x-flip-vs-modeset [245.907398] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [246.002289] [048/134] (778s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [246.099058] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [250.750431] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.651s) [251.939909] [049/134] (772s left) gem_ccs (block-multicopy-compressed) [252.000923] Starting subtest: block-multicopy-compressed [252.002739] Subtest block-multicopy-compressed: SKIP (0.000s) [252.142394] [050/134] (772s left) kms_content_protection (dp-mst-type-0-hdcp14) [252.284430] Starting subtest: dp-mst-type-0-hdcp14 [252.286277] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [252.440295] [051/134] (772s left) perf_pmu (semaphore-busy) [252.471169] Starting subtest: semaphore-busy [252.472083] Starting dynamic subtest: rcs0 [254.133384] Dynamic subtest rcs0: SUCCESS (1.658s) [254.143276] Starting dynamic subtest: bcs0 [255.765069] Dynamic subtest bcs0: SUCCESS (1.628s) [255.775164] Starting dynamic subtest: vcs0 [259.407897] Dynamic subtest vcs0: SUCCESS (3.639s) [259.417397] Starting dynamic subtest: vcs1 [265.423541] Dynamic subtest vcs1: SUCCESS (6.013s) [265.434762] Starting dynamic subtest: vecs0 [271.439793] Dynamic subtest vecs0: SUCCESS (6.012s) [271.449743] Starting dynamic subtest: ccs0 [274.512266] Dynamic subtest ccs0: SUCCESS (3.068s) [274.513663] Subtest semaphore-busy: SUCCESS (22.037s) [274.644479] [052/134] (750s left) kms_vblank (wait-idle) [274.731185] Starting subtest: wait-idle [274.732094] Starting dynamic subtest: pipe-A-eDP-1 [276.485755] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s) [276.494700] Starting dynamic subtest: pipe-D-eDP-1 [278.947757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.456s) [278.948622] Subtest wait-idle: SUCCESS (4.213s) [279.784581] [053/134] (744s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [279.878320] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [279.879272] Starting dynamic subtest: pipe-A-eDP-1 [279.902502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.024s) [279.911050] Starting dynamic subtest: pipe-B-eDP-1 [279.925755] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [279.934101] Starting dynamic subtest: pipe-C-eDP-1 [279.948345] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [279.956593] Starting dynamic subtest: pipe-D-eDP-1 [279.971164] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [279.971981] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s) [282.251088] [054/134] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc) [282.349127] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc [282.350868] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [282.466827] [055/134] (742s left) kms_psr (fbc-pr-suspend) [282.557795] Starting subtest: fbc-pr-suspend [282.559705] Subtest fbc-pr-suspend: SKIP (0.000s) [282.647289] [056/134] (742s left) gem_tiled_pread_basic [282.761548] [057/134] (742s left) kms_big_fb (linear-8bpp-rotate-90) [282.861927] Starting subtest: linear-8bpp-rotate-90 [282.882253] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [283.024910] [058/134] (741s left) gem_exec_whisper (basic-contexts-priority-all) [283.082215] Starting subtest: basic-contexts-priority-all [307.562981] Subtest basic-contexts-priority-all: SUCCESS (24.479s) [307.770628] [059/134] (717s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [307.834612] Starting subtest: invalid-bsd2-flag-on-vebox [307.836204] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [307.968424] [060/134] (716s left) gem_vm_create (create-ext) [308.032356] Starting subtest: create-ext [308.043556] Subtest create-ext: SUCCESS (0.011s) [308.190606] [061/134] (716s left) syncobj_wait (single-wait-signaled) [308.249949] Starting subtest: single-wait-signaled [308.250963] Subtest single-wait-signaled: SUCCESS (0.000s) [308.383837] [062/134] (716s left) prime_mmap (test_reprime) [308.441838] Starting subtest: test_reprime [308.442825] Starting dynamic subtest: test_reprime-smem [308.476373] Dynamic subtest test_reprime-smem: SUCCESS (0.034s) [308.477447] Subtest test_reprime: SUCCESS (0.035s) [308.626461] [063/134] (716s left) gem_mmap_wc (close) [308.677543] Subtest close: SKIP (0.000s) [308.739578] [064/134] (716s left) gem_exec_gttfill (engines) [308.801420] Starting subtest: engines [308.802480] Starting dynamic subtest: rcs0 [332.514707] Dynamic subtest rcs0: SUCCESS (23.712s) [332.526624] Starting dynamic subtest: bcs0 [355.905840] Dynamic subtest bcs0: SUCCESS (23.386s) [355.920526] Starting dynamic subtest: vcs0 [379.414899] Dynamic subtest vcs0: SUCCESS (23.503s) [379.423584] Starting dynamic subtest: vcs1 [402.779714] Dynamic subtest vcs1: SUCCESS (23.361s) [402.793647] Starting dynamic subtest: vecs0 [426.176458] Dynamic subtest vecs0: SUCCESS (23.392s) [426.187547] Starting dynamic subtest: ccs0 [449.562309] Dynamic subtest ccs0: SUCCESS (23.383s) [449.563817] Subtest engines: SUCCESS (140.755s) [449.773096] [065/134] (575s left) vgem_basic (sysfs) [449.843208] Starting subtest: sysfs [449.844203] Subtest sysfs: SUCCESS (0.000s) [449.922116] [066/134] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [450.022040] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [450.023987] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [450.159482] [067/134] (574s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [450.257296] Starting subtest: yf-tiled-32bpp-rotate-180 [450.259063] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [450.395985] [068/134] (574s left) syncobj_timeline (invalid-signal-illegal-handle) [450.460392] Starting subtest: invalid-signal-illegal-handle [450.461403] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [450.582405] [069/134] (574s left) gem_mmap (bad-offset) [450.642527] Subtest bad-offset: SKIP (0.000s) [450.698390] [070/134] (574s left) i915_pm_rpm (debugfs-read) [452.247739] Starting subtest: debugfs-read [453.399769] Subtest debugfs-read: SUCCESS (1.153s) [453.784072] [071/134] (571s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [453.875753] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [458.227940] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.351s) [459.380212] [072/134] (565s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [459.432378] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [459.539337] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [459.631433] [073/134] (565s left) kms_addfb_basic (legacy-format) [459.684357] Starting subtest: legacy-format [459.709863] Subtest legacy-format: SUCCESS (0.026s) [459.878978] [074/134] (565s left) gem_exec_fence (basic-await) [460.052622] Starting subtest: basic-await [460.053769] Starting dynamic subtest: rcs0 [460.131608] Dynamic subtest rcs0: SUCCESS (0.079s) [460.140220] Starting dynamic subtest: bcs0 [460.204401] Dynamic subtest bcs0: SUCCESS (0.072s) [460.215383] Starting dynamic subtest: vcs0 [460.278583] Dynamic subtest vcs0: SUCCESS (0.072s) [460.290401] Starting dynamic subtest: vcs1 [460.354040] Dynamic subtest vcs1: SUCCESS (0.073s) [460.365298] Starting dynamic subtest: vecs0 [460.429214] Dynamic subtest vecs0: SUCCESS (0.074s) [460.440118] Starting dynamic subtest: ccs0 [460.504840] Dynamic subtest ccs0: SUCCESS (0.073s) [460.505987] Subtest basic-await: SUCCESS (0.453s) [462.002876] [075/134] (563s left) kms_big_fb (4-tiled-8bpp-rotate-0) [462.104703] Starting subtest: 4-tiled-8bpp-rotate-0 [463.206941] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.103s) [463.390107] [076/134] (562s left) kms_psr (fbc-psr2-primary-render) [463.489462] Starting subtest: fbc-psr2-primary-render [463.490478] Starting dynamic subtest: eDP-1 [463.492249] Dynamic subtest eDP-1: SKIP (0.000s) [463.493849] Subtest fbc-psr2-primary-render: SKIP (0.001s) [463.581256] [077/134] (561s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [468.522417] Starting subtest: psr2-primary-plane-update-sf-dmg-area [468.523419] Starting dynamic subtest: pipe-A-eDP-1 [474.978136] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.454s) [474.986356] Starting dynamic subtest: pipe-B-eDP-1 [481.626048] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s) [481.627171] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.104s) [482.520606] [078/134] (543s left) kms_cursor_crc (cursor-offscreen-512x512) [482.806200] Starting subtest: cursor-offscreen-512x512 [482.807949] Subtest cursor-offscreen-512x512: SKIP (0.001s) [482.995779] [079/134] (542s left) gem_softpin (softpin) [483.054830] Starting subtest: softpin [515.384206] Subtest softpin: SUCCESS (32.323s) [515.592500] [080/134] (510s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [515.709568] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [516.664918] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.956s) [516.840977] [081/134] (508s left) gen9_exec_parse (basic-rejected) [516.911793] Subtest basic-rejected: SKIP (0.000s) [516.995869] [082/134] (508s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [517.058963] Starting subtest: etime-single-wait-for-submit-submitted [517.163729] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s) [517.256030] [083/134] (508s left) kms_atomic (plane-overlay-legacy) [517.360775] Starting subtest: plane-overlay-legacy [517.361717] Starting dynamic subtest: pipe-A-eDP-1 [517.771920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s) [517.772829] Subtest plane-overlay-legacy: SUCCESS (0.411s) [518.647805] [084/134] (507s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [518.749048] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [522.363634] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.614s) [523.563111] [085/134] (502s left) core_getstats (basic) [523.619148] Starting subtest: basic [523.619995] Subtest basic: SUCCESS (0.000s) [523.751221] [086/134] (502s left) api_intel_allocator (open-vm) [523.813410] Starting subtest: open-vm [523.816622] Subtest open-vm: SUCCESS (0.004s) [523.978188] [087/134] (501s left) kms_hdr (bpc-switch-dpms) [524.082959] Starting subtest: bpc-switch-dpms [525.110076] Starting dynamic subtest: pipe-A-eDP-1 [529.643902] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.535s) [529.644851] Subtest bpc-switch-dpms: SUCCESS (5.561s) [529.786964] [088/134] (496s left) kms_psr (psr-sprite-plane-move) [529.874367] Starting subtest: psr-sprite-plane-move [529.875267] Starting dynamic subtest: eDP-1 [531.652088] Dynamic subtest eDP-1: SUCCESS (1.777s) [531.652972] Subtest psr-sprite-plane-move: SUCCESS (1.778s) [532.487054] [089/134] (493s left) gem_ctx_persistence (legacy-engines-persistence) [532.532290] Starting subtest: legacy-engines-persistence [532.533150] Starting dynamic subtest: render [533.346875] Dynamic subtest render: SUCCESS (0.813s) [533.359782] Starting dynamic subtest: bsd1 [534.122811] Dynamic subtest bsd1: SUCCESS (0.773s) [534.134976] Starting dynamic subtest: bsd2 [534.909615] Dynamic subtest bsd2: SUCCESS (0.784s) [534.920576] Starting dynamic subtest: blt [535.692757] Dynamic subtest blt: SUCCESS (0.780s) [535.704479] Starting dynamic subtest: vebox [536.554960] Dynamic subtest vebox: SUCCESS (0.859s) [536.556829] Subtest legacy-engines-persistence: SUCCESS (4.023s) [536.651627] [090/134] (489s left) syncobj_timeline (32bits-limit) [536.702906] Starting subtest: 32bits-limit [536.703861] Subtest 32bits-limit: SUCCESS (0.001s) [536.844202] [091/134] (489s left) syncobj_basic (create-signaled) [536.903446] Starting subtest: create-signaled [536.904368] Subtest create-signaled: SUCCESS (0.000s) [537.013343] [092/134] (489s left) gem_mmap_offset (pf-nonblock) [537.075077] Starting subtest: pf-nonblock [537.086179] Subtest pf-nonblock: SUCCESS (0.012s) [537.201638] [093/134] (488s left) gem_ccs (large-ctrl-surf-copy) [537.254508] Starting subtest: large-ctrl-surf-copy [537.256268] Subtest large-ctrl-surf-copy: SKIP (0.000s) [537.378153] [094/134] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [537.475597] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [537.477268] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [537.584125] [095/134] (488s left) kms_pm_rpm (dpms-lpsp) [539.106985] Starting subtest: dpms-lpsp [539.732868] Subtest dpms-lpsp: SUCCESS (0.627s) [539.840287] [096/134] (486s left) gem_userptr_blits (process-exit-busy) [539.904255] Starting subtest: process-exit-busy [539.915563] Subtest process-exit-busy: SUCCESS (0.011s) [540.061857] [097/134] (486s left) kms_atomic_interruptible (legacy-dpms) [540.162396] Starting subtest: legacy-dpms [540.163372] Starting dynamic subtest: pipe-A-eDP-1 [547.619325] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.454s) [547.620229] Subtest legacy-dpms: SUCCESS (7.456s) [548.463620] [098/134] (477s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc) [548.554131] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc [548.555094] Starting dynamic subtest: pipe-A-eDP-1 [549.297611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [549.306065] Starting dynamic subtest: pipe-B-eDP-1 [551.084312] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s) [551.092893] Starting dynamic subtest: pipe-C-eDP-1 [552.914303] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.829s) [552.922553] Starting dynamic subtest: pipe-D-eDP-1 [554.755638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.840s) [554.756530] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.199s) [555.910867] [099/134] (470s left) kms_pm_rpm (dpms-mode-unset-lpsp) [558.038245] Starting subtest: dpms-mode-unset-lpsp [562.097384] Subtest dpms-mode-unset-lpsp: SUCCESS (4.060s) [562.494958] [100/134] (463s left) kms_dsc (dsc-fractional-bpp) [562.591454] Starting subtest: dsc-fractional-bpp [562.596563] Subtest dsc-fractional-bpp: SKIP (0.000s) [562.682399] [101/134] (463s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [562.782321] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [562.783185] Starting dynamic subtest: pipe-A-eDP-1 [562.791819] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [562.800662] Starting dynamic subtest: pipe-B-eDP-1 [562.808603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [562.816928] Starting dynamic subtest: pipe-C-eDP-1 [562.825251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [562.833354] Starting dynamic subtest: pipe-D-eDP-1 [562.841449] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [562.843070] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s) [564.972765] [102/134] (461s left) kms_vblank (accuracy-idle) [565.074943] Starting subtest: accuracy-idle [565.077411] Starting dynamic subtest: pipe-A-eDP-1 [566.832268] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s) [566.842369] Starting dynamic subtest: pipe-D-eDP-1 [569.294786] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.460s) [569.295754] Subtest accuracy-idle: SUCCESS (4.220s) [570.134601] [103/134] (456s left) syncobj_timeline (wait-all-complex) [570.197711] Starting subtest: wait-all-complex [570.411442] Subtest wait-all-complex: SUCCESS (0.212s) [570.505944] [104/134] (455s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [570.614546] Starting subtest: cursorA-vs-flipA-legacy [581.749207] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.134s) [582.570277] [105/134] (443s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [582.655261] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [582.656117] Starting dynamic subtest: pipe-A-eDP-1 [582.664534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [582.672832] Starting dynamic subtest: pipe-B-eDP-1 [582.681359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [582.689778] Starting dynamic subtest: pipe-C-eDP-1 [582.698026] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [582.705988] Starting dynamic subtest: pipe-D-eDP-1 [582.715631] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [582.717402] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s) [584.858499] [106/134] (441s left) kms_atomic_transition (plane-toggle-modeset-transition) [584.971248] Starting subtest: plane-toggle-modeset-transition [584.972452] Starting dynamic subtest: pipe-A-eDP-1 [597.693288] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.720s) [597.704901] Starting dynamic subtest: pipe-B-eDP-1 [610.155027] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.458s) [610.158577] Subtest plane-toggle-modeset-transition: SUCCESS (25.185s) [610.992139] [107/134] (415s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [611.098585] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [611.099594] Starting dynamic subtest: pipe-A-eDP-1 [611.166128] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s) [611.179535] Starting dynamic subtest: pipe-B-eDP-1 [611.229912] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s) [611.239489] Starting dynamic subtest: pipe-C-eDP-1 [611.298618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.067s) [611.310726] Starting dynamic subtest: pipe-D-eDP-1 [611.360064] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s) [611.360932] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.263s) [613.575378] [108/134] (413s left) gem_exec_schedule (u-semaphore-user) [613.641285] Starting subtest: u-semaphore-user [613.698100] Subtest u-semaphore-user: SUCCESS (0.056s) [614.989664] [109/134] (411s left) i915_pciid [615.172510] [110/134] (411s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [615.237980] Starting subtest: y-tiled-to-vebox-x-tiled [615.239953] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [615.437924] [111/134] (411s left) perf_pmu (multi-client) [615.477475] Starting subtest: multi-client [615.478669] Starting dynamic subtest: rcs0 [616.561791] Dynamic subtest rcs0: SUCCESS (1.083s) [616.573651] Starting dynamic subtest: bcs0 [617.617819] Dynamic subtest bcs0: SUCCESS (1.051s) [617.626608] Starting dynamic subtest: vcs0 [618.669612] Dynamic subtest vcs0: SUCCESS (1.049s) [618.678249] Starting dynamic subtest: vcs1 [619.918333] Dynamic subtest vcs1: SUCCESS (1.246s) [619.926970] Starting dynamic subtest: vecs0 [621.901039] Dynamic subtest vecs0: SUCCESS (1.982s) [621.912206] Starting dynamic subtest: ccs0 [623.949609] Dynamic subtest ccs0: SUCCESS (2.045s) [623.950436] Subtest multi-client: SUCCESS (8.472s) [624.086504] [112/134] (402s left) gem_pxp (verify-pxp-stale-buf-execution) [624.214659] Starting subtest: verify-pxp-stale-buf-execution [625.284493] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.071s) [625.445652] [113/134] (401s left) sysfs_timeslice_duration (duration) [625.515181] Starting subtest: duration [625.516295] Starting dynamic subtest: vecs0 [638.901365] Dynamic subtest vecs0: SUCCESS (13.382s) [638.912777] Starting dynamic subtest: ccs0 [652.074359] Dynamic subtest ccs0: SUCCESS (13.171s) [652.086099] Starting dynamic subtest: vcs0 [665.845312] Dynamic subtest vcs0: SUCCESS (13.765s) [665.856049] Starting dynamic subtest: bcs0 [679.030091] Dynamic subtest bcs0: SUCCESS (13.183s) [679.042278] Starting dynamic subtest: rcs0 [692.216199] Dynamic subtest rcs0: SUCCESS (13.182s) [692.230652] Starting dynamic subtest: vcs1 [706.805628] Dynamic subtest vcs1: SUCCESS (14.584s) [706.807101] Subtest duration: SUCCESS (81.286s) [706.899458] [114/134] (319s left) kms_cursor_crc (cursor-random-max-size) [707.201358] Starting subtest: cursor-random-max-size [707.203901] Subtest cursor-random-max-size: SKIP (0.000s) [707.372162] [115/134] (319s left) kms_color_pipeline (plane-ctm3x4) [707.468490] Starting subtest: plane-ctm3x4 [707.482894] Starting dynamic subtest: pipe-A-eDP-1 [707.908548] Dynamic subtest pipe-A-eDP-1: FAIL (0.280s) [708.811133] Starting dynamic subtest: pipe-B-eDP-1 [709.251826] Dynamic subtest pipe-B-eDP-1: FAIL (0.257s) [710.140693] Starting dynamic subtest: pipe-C-eDP-1 [710.551106] Dynamic subtest pipe-C-eDP-1: FAIL (0.202s) [711.374444] Starting dynamic subtest: pipe-D-eDP-1 [711.804202] Dynamic subtest pipe-D-eDP-1: FAIL (0.213s) [711.859559] Subtest plane-ctm3x4: FAIL (4.391s) [712.675599] [116/134] (314s left) kms_panel_fitting (atomic-fastset) [712.786563] Starting subtest: atomic-fastset [712.787497] Starting dynamic subtest: pipe-A-eDP-1 [712.922260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s) [712.932888] Starting dynamic subtest: pipe-B-eDP-1 [714.119693] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s) [714.130315] Starting dynamic subtest: pipe-C-eDP-1 [715.304621] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s) [715.313807] Starting dynamic subtest: pipe-D-eDP-1 [716.435940] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [716.436989] Subtest atomic-fastset: SUCCESS (3.651s) [717.731869] [117/134] (309s left) gem_tiled_wc [717.848554] [118/134] (309s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [717.952744] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [717.963960] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s) [718.066041] [119/134] (308s left) gem_eio (throttle) [718.260089] Starting subtest: throttle [718.556663] Subtest throttle: SUCCESS (0.295s) [718.730329] [120/134] (308s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [718.831018] Starting subtest: fbcpsr-1p-rte [725.762480] Subtest fbcpsr-1p-rte: SUCCESS (6.933s) [725.941383] [121/134] (301s left) gem_render_copy (x-tiled) [726.000172] Starting subtest: x-tiled [726.001277] Starting dynamic subtest: smem [726.043902] Dynamic subtest smem: SUCCESS (0.043s) [726.044948] Subtest x-tiled: SUCCESS (0.044s) [726.280424] [122/134] (300s left) gem_exec_whisper (basic-queues-forked) [726.333056] Starting subtest: basic-queues-forked [750.845415] Subtest basic-queues-forked: SUCCESS (24.506s) [751.046907] [123/134] (276s left) kms_big_fb (y-tiled-64bpp-rotate-0) [751.150377] Starting subtest: y-tiled-64bpp-rotate-0 [751.152311] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [751.276460] [124/134] (275s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [751.360241] Starting subtest: psr-2p-pri-indfb-multidraw [751.362138] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [751.504111] [125/134] (275s left) vgem_basic (bad-handle) [751.546085] Starting subtest: bad-handle [751.546901] Subtest bad-handle: SUCCESS (0.000s) [751.621280] [126/134] (275s left) prime_vgem (basic-fence-read) [751.700611] Starting subtest: basic-fence-read [751.717475] Subtest basic-fence-read: SKIP (0.016s) [751.870789] [127/134] (275s left) gem_exec_fence (syncobj-invalid-flags) [752.296401] Starting subtest: syncobj-invalid-flags [752.297418] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [753.966554] [128/134] (273s left) gem_spin_batch (resubmit-new-all) [754.035506] Starting subtest: resubmit-new-all [754.036557] Starting dynamic subtest: rcs0 [754.059965] Dynamic subtest rcs0: SUCCESS (0.024s) [754.069623] Starting dynamic subtest: bcs0 [754.077634] Dynamic subtest bcs0: SUCCESS (0.017s) [754.085915] Starting dynamic subtest: vcs0 [754.091975] Dynamic subtest vcs0: SUCCESS (0.014s) [754.100945] Starting dynamic subtest: vcs1 [754.109200] Dynamic subtest vcs1: SUCCESS (0.017s) [754.116774] Starting dynamic subtest: vecs0 [754.126895] Dynamic subtest vecs0: SUCCESS (0.017s) [754.134660] Starting dynamic subtest: ccs0 [754.145527] Dynamic subtest ccs0: SUCCESS (0.018s) [754.146418] Subtest resubmit-new-all: SUCCESS (0.111s) [755.987268] [129/134] (271s left) gem_mmap_offset (bad-flags) [756.051432] Starting subtest: bad-flags [756.052413] Subtest bad-flags: SUCCESS (0.000s) [756.191383] [130/134] (271s left) kms_flip (plain-flip-ts-check) [756.300803] Starting subtest: plain-flip-ts-check [756.302755] Starting dynamic subtest: A-eDP1 [765.198135] Dynamic subtest A-eDP1: SUCCESS (8.895s) [765.208177] Starting dynamic subtest: B-eDP1 [774.030874] Dynamic subtest B-eDP1: SUCCESS (8.831s) [774.041496] Starting dynamic subtest: C-eDP1 [782.850521] Dynamic subtest C-eDP1: SUCCESS (8.816s) [782.859726] Starting dynamic subtest: D-eDP1 [791.675781] Dynamic subtest D-eDP1: SUCCESS (8.824s) [791.678095] Subtest plain-flip-ts-check: SUCCESS (35.375s) [792.874489] [131/134] (234s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [792.977416] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [792.979123] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [793.118400] [132/134] (234s left) kms_plane_alpha_blend (constant-alpha-mid) [793.219921] Starting subtest: constant-alpha-mid [793.504668] Starting dynamic subtest: pipe-A-eDP-1 [794.241911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s) [794.251357] Starting dynamic subtest: pipe-D-eDP-1 [795.739434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s) [795.740272] Subtest constant-alpha-mid: SUCCESS (2.521s) [796.646107] [133/134] (230s left) kms_psr (pr-sprite-plane-move) [796.741327] Starting subtest: pr-sprite-plane-move [796.743069] Subtest pr-sprite-plane-move: SKIP (0.000s) [796.831872] [134/134] (230s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [796.927968] Starting subtest: fbc-1p-pri-indfb-multidraw [810.011053] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.083s) [811.373487] Closing watchdogs results: parsing output: 0/ for test: gem_exec_schedule results: parsing output: 1/ for test: gem_eio results: parsing output: 2/ for test: kms_chamelium_frames results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: kms_psr2_sf results: parsing output: 5/ for test: kms_plane_multiple results: parsing output: 6/ for test: i915_query results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_selftest results: parsing output: 10/ for test: kms_joiner results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_chamelium_hpd results: parsing output: 14/ for test: syncobj_wait results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_exec_flush results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_shared results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: kms_prop_blob results: parsing output: 21/ for test: kms_dirtyfb results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: i915_drm_fdinfo results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: syncobj_basic results: parsing output: 26/ for test: gem_eio results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: gem_eio results: parsing output: 29/ for test: sw_sync results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: kms_cursor_edge_walk results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_pipe_crc_basic results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_ctx_isolation results: parsing output: 44/ for test: api_intel_bb results: parsing output: 45/ for test: gem_exec_balancer results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_ccs results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: perf_pmu results: parsing output: 51/ for test: kms_vblank results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: gem_tiled_pread_basic results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: gem_exec_whisper results: parsing output: 58/ for test: gem_exec_params results: parsing output: 59/ for test: gem_vm_create results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: prime_mmap results: parsing output: 62/ for test: gem_mmap_wc results: parsing output: 63/ for test: gem_exec_gttfill results: parsing output: 64/ for test: vgem_basic results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: gem_mmap results: parsing output: 69/ for test: i915_pm_rpm results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: syncobj_wait results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_psr results: parsing output: 76/ for test: kms_psr2_sf results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: gen9_exec_parse results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_atomic results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: core_getstats results: parsing output: 85/ for test: api_intel_allocator results: parsing output: 86/ for test: kms_hdr results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: gem_ctx_persistence results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: syncobj_basic results: parsing output: 91/ for test: gem_mmap_offset results: parsing output: 92/ for test: gem_ccs results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_pm_rpm results: parsing output: 95/ for test: gem_userptr_blits results: parsing output: 96/ for test: kms_atomic_interruptible results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: kms_pm_rpm results: parsing output: 99/ for test: kms_dsc results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_vblank results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_atomic_transition results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: i915_pciid results: parsing output: 109/ for test: gem_render_copy results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: gem_pxp results: parsing output: 112/ for test: sysfs_timeslice_duration results: parsing output: 113/ for test: kms_cursor_crc results: parsing output: 114/ for test: kms_color_pipeline results: parsing output: 115/ for test: kms_panel_fitting results: parsing output: 116/ for test: gem_tiled_wc results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: gem_eio results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: gem_exec_whisper results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: vgem_basic results: parsing output: 125/ for test: prime_vgem results: parsing output: 126/ for test: gem_exec_fence results: parsing output: 127/ for test: gem_spin_batch results: parsing output: 128/ for test: gem_mmap_offset results: parsing output: 129/ for test: kms_flip results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_plane_alpha_blend results: parsing output: 132/ for test: kms_psr results: parsing output: 133/ for test: kms_frontbuffer_tracking Done.