[57.529268] Initializing watchdogs [57.529316] /dev/watchdog0 [57.544347] [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] [57.548689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.550993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.554332] [001/133] (960s left) syncobj_wait (wait-all-interrupted) [57.632235] Starting subtest: wait-all-interrupted [57.737647] Subtest wait-all-interrupted: SUCCESS (0.103s) [57.821820] [002/133] (960s left) syncobj_wait (single-wait-all-for-submit-submitted) [57.870673] Starting subtest: single-wait-all-for-submit-submitted [57.977718] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s) [58.058111] [003/133] (960s left) i915_suspend (forcewake) [58.111042] Starting subtest: forcewake [90.144860] Subtest forcewake: SUCCESS (2.370s) [90.217473] [004/133] (927s left) sw_sync (sync_random_merge) [90.258476] Starting subtest: sync_random_merge [90.299390] Subtest sync_random_merge: SUCCESS (0.043s) [90.360210] [005/133] (927s left) gem_mmap_gtt (medium-copy) [90.409269] Subtest medium-copy: SKIP (0.000s) [90.481616] [006/133] (927s left) gem_ctx_shared (q-independent) [90.545128] Starting subtest: Q-independent [90.547473] Starting dynamic subtest: rcs0 [90.628222] Dynamic subtest rcs0: SUCCESS (0.082s) [90.637987] Starting dynamic subtest: vcs0 [90.670140] Dynamic subtest vcs0: SUCCESS (0.041s) [90.678244] Starting dynamic subtest: vcs1 [90.722160] Dynamic subtest vcs1: SUCCESS (0.050s) [90.735104] Starting dynamic subtest: vecs0 [90.763505] Dynamic subtest vecs0: SUCCESS (0.041s) [90.774456] Starting dynamic subtest: ccs0 [90.811401] Dynamic subtest ccs0: SUCCESS (0.047s) [90.814445] Subtest Q-independent: SUCCESS (0.262s) [91.998030] [007/133] (926s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [92.083444] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [92.087724] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [92.168366] [008/133] (926s left) kms_flip (2x-flip-vs-wf_vblank) [92.257856] Starting subtest: 2x-flip-vs-wf_vblank [92.268467] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s) [92.347696] [009/133] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [92.401206] Starting subtest: etime-multi-wait-all-for-submit-submitted [92.510186] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s) [92.585546] [010/133] (925s left) kms_async_flips (alternate-sync-async-flip) [92.670237] Starting subtest: alternate-sync-async-flip [93.061686] Starting dynamic subtest: pipe-A-eDP-1 [95.820647] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.730s) [96.209245] Starting dynamic subtest: pipe-B-eDP-1 [98.970753] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s) [99.344235] Starting dynamic subtest: pipe-C-eDP-1 [102.111157] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s) [102.517786] Starting dynamic subtest: pipe-D-eDP-1 [105.251566] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.733s) [105.255286] Subtest alternate-sync-async-flip: SUCCESS (12.502s) [106.462199] [011/133] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [106.568633] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [106.572978] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [106.659701] [012/133] (911s left) syncobj_wait (multi-wait-signaled) [106.713787] Starting subtest: multi-wait-signaled [106.716094] Subtest multi-wait-signaled: SUCCESS (0.000s) [106.826326] [013/133] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [106.937764] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [114.575228] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.628s) [114.696147] [014/133] (903s left) syncobj_timeline (invalid-wait-illegal-handle) [114.761984] Starting subtest: invalid-wait-illegal-handle [114.764009] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [114.865757] [015/133] (903s left) kms_cursor_crc (cursor-sliding-64x21) [115.070146] Starting subtest: cursor-sliding-64x21 [115.114498] Subtest cursor-sliding-64x21: SKIP (0.039s) [115.346397] [016/133] (903s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [115.405156] Starting subtest: yf-tiled-to-vebox-x-tiled [115.409753] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [115.597724] [017/133] (903s left) gem_busy (extended) [115.784138] Starting subtest: extended [115.786796] Starting dynamic subtest: rcs0 [115.861657] Dynamic subtest rcs0: SUCCESS (0.078s) [115.872667] Starting dynamic subtest: bcs0 [115.903387] Dynamic subtest bcs0: SUCCESS (0.040s) [115.914518] Starting dynamic subtest: vcs0 [117.954656] Dynamic subtest vcs0: SUCCESS (2.046s) [117.966045] Starting dynamic subtest: vcs1 [119.939408] Dynamic subtest vcs1: SUCCESS (1.981s) [119.950722] Starting dynamic subtest: vecs0 [121.922837] Dynamic subtest vecs0: SUCCESS (1.981s) [121.934706] Starting dynamic subtest: ccs0 [121.969072] Dynamic subtest ccs0: SUCCESS (0.047s) [121.971662] Subtest extended: SUCCESS (6.183s) [122.222037] [018/133] (896s left) kms_lease (empty-lease) [122.321641] Starting subtest: empty-lease [122.324266] Starting dynamic subtest: pipe-A-eDP-1 [122.326640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [122.337062] Starting dynamic subtest: pipe-B-eDP-1 [122.339278] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [122.347695] Starting dynamic subtest: pipe-C-eDP-1 [122.349817] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [122.357755] Starting dynamic subtest: pipe-D-eDP-1 [122.359852] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [122.362048] Subtest empty-lease: SUCCESS (0.008s) [122.430592] [019/133] (896s left) kms_chamelium_edid (hdmi-edid-read) [122.806148] Subtest hdmi-edid-read: SKIP (0.000s) [123.580945] [020/133] (895s left) kms_psr (psr2-cursor-mmap-cpu) [123.671010] Starting subtest: psr2-cursor-mmap-cpu [123.673542] Starting dynamic subtest: eDP-1 [125.376631] Dynamic subtest eDP-1: SUCCESS (1.707s) [125.379023] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.708s) [126.258488] [021/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [126.356264] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [126.360480] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [126.441248] [022/133] (892s left) kms_psr (pr-primary-mmap-gtt) [126.542065] Starting subtest: pr-primary-mmap-gtt [126.545875] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [126.625634] [023/133] (892s left) perf_pmu (rc6) [126.670192] Starting subtest: rc6 [126.672438] Starting dynamic subtest: gt0 [133.033409] Dynamic subtest gt0: SUCCESS (6.362s) [133.044529] Starting dynamic subtest: runtime-pm-gt0 [140.811518] Dynamic subtest runtime-pm-gt0: SUCCESS (7.777s) [140.821433] Starting dynamic subtest: runtime-pm-long-gt0 [153.335042] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.519s) [153.346704] Starting dynamic subtest: other-idle-gt0 [159.679229] Dynamic subtest other-idle-gt0: SUCCESS (6.341s) [159.690708] Starting dynamic subtest: gt1 [166.024466] Dynamic subtest gt1: SUCCESS (6.340s) [166.035807] Starting dynamic subtest: runtime-pm-gt1 [173.550678] Dynamic subtest runtime-pm-gt1: SUCCESS (7.523s) [173.562190] Starting dynamic subtest: runtime-pm-long-gt1 [186.068966] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.512s) [186.080663] Starting dynamic subtest: other-idle-gt1 [192.411663] Dynamic subtest other-idle-gt1: SUCCESS (6.343s) [192.414668] Subtest rc6: SUCCESS (65.730s) [193.555884] [024/133] (825s left) kms_plane_lowres (tiling-x) [193.652494] Starting subtest: tiling-x [193.654629] Starting dynamic subtest: pipe-A-eDP-1 [193.658984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [193.945505] Starting dynamic subtest: pipe-B-eDP-1 [193.949902] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [193.957844] Starting dynamic subtest: pipe-C-eDP-1 [193.962374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [193.973355] Starting dynamic subtest: pipe-D-eDP-1 [193.977756] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [193.982073] Subtest tiling-x: SKIP (0.293s) [194.761669] [025/133] (824s left) kms_rotation_crc (multiplane-rotation) [194.864814] Starting subtest: multiplane-rotation [212.330451] Subtest multiplane-rotation: SUCCESS (17.471s) [212.410668] [026/133] (806s left) gem_mmap_offset (partial-remap) [212.473907] Starting subtest: partial-remap [212.476010] Starting dynamic subtest: smem0 [212.483773] Dynamic subtest smem0: SUCCESS (0.003s) [212.485740] Subtest partial-remap: SUCCESS (0.004s) [212.570555] [027/133] (806s left) kms_busy (extended-pageflip-hang-newfb) [212.675119] Starting subtest: extended-pageflip-hang-newfb [212.677181] Starting dynamic subtest: pipe-A [238.687373] Dynamic subtest pipe-A: SUCCESS (26.009s) [238.697300] Starting dynamic subtest: pipe-D [263.705363] Dynamic subtest pipe-D: SUCCESS (25.011s) [263.707626] Subtest extended-pageflip-hang-newfb: SUCCESS (51.025s) [264.517850] [028/133] (754s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [264.613888] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [264.617943] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [264.666423] [029/133] (754s left) gem_ctx_isolation (preservation-reset) [264.842584] Starting subtest: preservation-reset [264.845475] Starting dynamic subtest: rcs0 [265.111980] Dynamic subtest rcs0: SUCCESS (0.269s) [265.126258] Starting dynamic subtest: bcs0 [265.410204] Dynamic subtest bcs0: SUCCESS (0.297s) [265.420199] Starting dynamic subtest: vcs0 [265.703418] Dynamic subtest vcs0: SUCCESS (0.292s) [265.712866] Starting dynamic subtest: vcs1 [267.193831] Dynamic subtest vcs1: SUCCESS (1.489s) [267.204485] Starting dynamic subtest: vecs0 [269.172857] Dynamic subtest vecs0: SUCCESS (1.977s) [269.184939] Starting dynamic subtest: ccs0 [271.199941] Dynamic subtest ccs0: SUCCESS (2.026s) [271.202564] Subtest preservation-reset: SUCCESS (6.358s) [271.317384] [030/133] (747s left) gem_fenced_exec_thrash (no-spare-fences) [271.374458] Subtest no-spare-fences: SKIP (0.000s) [271.450291] [031/133] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [271.548781] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [278.858146] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.310s) [278.946748] [032/133] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [279.040085] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [279.044179] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [279.100299] [033/133] (740s left) kms_cursor_legacy (forked-move) [279.229840] Starting subtest: forked-move [279.232045] Starting dynamic subtest: pipe-A [284.683036] Dynamic subtest pipe-A: SUCCESS (5.448s) [284.696854] Starting dynamic subtest: pipe-B [290.159375] Dynamic subtest pipe-B: SUCCESS (5.471s) [290.172459] Starting dynamic subtest: pipe-C [295.632389] Dynamic subtest pipe-C: SUCCESS (5.470s) [295.647587] Starting dynamic subtest: pipe-D [301.104383] Dynamic subtest pipe-D: SUCCESS (5.468s) [301.116482] Starting dynamic subtest: all-pipes [306.612369] Dynamic subtest all-pipes: SUCCESS (5.505s) [306.614799] Subtest forked-move: SUCCESS (27.373s) [306.737339] [034/133] (712s left) api_intel_allocator (gem-pool) [306.801740] Starting subtest: gem-pool [306.808134] Subtest gem-pool: SUCCESS (0.008s) [306.895341] [035/133] (712s left) api_intel_bb (object-reloc-purge-cache) [306.948844] Starting subtest: object-reloc-purge-cache [306.953445] Subtest object-reloc-purge-cache: SKIP (0.003s) [307.031349] [036/133] (712s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [307.126234] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [307.130313] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [307.192031] [037/133] (712s left) prime_mmap (test_reprime) [307.248214] Starting subtest: test_reprime [307.250229] Starting dynamic subtest: test_reprime-smem [307.279676] Dynamic subtest test_reprime-smem: SUCCESS (0.033s) [307.282093] Subtest test_reprime: SUCCESS (0.033s) [307.366406] [038/133] (712s left) gem_render_copy (yf-tiled) [307.440797] Starting subtest: yf-tiled [307.445395] Subtest yf-tiled: SKIP (0.000s) [307.596537] [039/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [307.689896] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [307.693300] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [307.761344] [040/133] (711s left) i915_drm_fdinfo (most-busy-idle-check-all) [307.801381] Starting subtest: most-busy-idle-check-all [307.803192] Starting dynamic subtest: rcs0 [307.806669] Dynamic subtest rcs0: SKIP (0.003s) [307.815354] Starting dynamic subtest: bcs0 [307.818887] Dynamic subtest bcs0: SKIP (0.000s) [307.827087] Starting dynamic subtest: vcs0 [307.830732] Dynamic subtest vcs0: SKIP (0.000s) [307.840922] Starting dynamic subtest: vcs1 [307.844332] Dynamic subtest vcs1: SKIP (0.000s) [307.852773] Starting dynamic subtest: vecs0 [307.856075] Dynamic subtest vecs0: SKIP (0.000s) [307.864685] Starting dynamic subtest: ccs0 [307.868018] Dynamic subtest ccs0: SKIP (0.000s) [307.871519] Subtest most-busy-idle-check-all: SKIP (0.008s) [307.908308] [041/133] (711s left) kms_big_fb (linear-64bpp-rotate-0) [308.001512] Starting subtest: linear-64bpp-rotate-0 [309.636069] Subtest linear-64bpp-rotate-0: SUCCESS (1.634s) [309.808235] [042/133] (709s left) gem_exec_whisper (basic-queues-forked-all) [309.870413] Starting subtest: basic-queues-forked-all [332.197846] Subtest basic-queues-forked-all: SUCCESS (22.326s) [332.356839] [043/133] (687s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [332.448570] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [332.450866] Starting dynamic subtest: pipe-A-eDP-1 [332.473323] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [332.484740] Starting dynamic subtest: pipe-B-eDP-1 [332.506161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [332.516043] Starting dynamic subtest: pipe-C-eDP-1 [332.537399] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [332.546796] Starting dynamic subtest: pipe-D-eDP-1 [332.568712] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [332.572799] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [334.697630] [044/133] (685s left) gem_unref_active_buffers [334.847263] [045/133] (684s left) kms_pm_rpm (system-suspend-modeset) [337.071118] Starting subtest: system-suspend-modeset [356.699101] Subtest system-suspend-modeset: SUCCESS (4.608s) [357.054703] [046/133] (662s left) gem_userptr_blits (mmap-offset-banned) [357.121350] Starting subtest: mmap-offset-banned [357.124320] Starting dynamic subtest: wb [357.126914] Dynamic subtest wb: SUCCESS (0.000s) [357.139342] Starting dynamic subtest: wc [357.142216] Dynamic subtest wc: SUCCESS (0.000s) [357.152100] Starting dynamic subtest: uc [357.155059] Dynamic subtest uc: SUCCESS (0.000s) [357.157828] Subtest mmap-offset-banned: SUCCESS (0.003s) [357.219574] [047/133] (662s left) kms_pm_backlight (brightness-with-dpms) [357.314018] Starting subtest: brightness-with-dpms [357.363219] Starting dynamic subtest: eDP-1 [359.793594] Dynamic subtest eDP-1: SUCCESS (2.400s) [359.796236] Subtest brightness-with-dpms: SUCCESS (2.452s) [360.665870] [048/133] (659s left) gem_exec_balancer (parallel-balancer) [360.924624] Starting subtest: parallel-balancer [361.792288] Subtest parallel-balancer: SUCCESS (0.860s) [361.865091] [049/133] (658s left) gem_exec_alignment (single) [361.929146] Starting subtest: single [361.931947] Subtest single: SUCCESS (0.002s) [362.027723] [050/133] (657s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [362.141228] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [362.143323] Starting dynamic subtest: pipe-A-eDP-1 [362.863082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [362.873125] Starting dynamic subtest: pipe-B-eDP-1 [364.645962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.770s) [364.656568] Starting dynamic subtest: pipe-C-eDP-1 [366.485553] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.828s) [366.495107] Starting dynamic subtest: pipe-D-eDP-1 [368.322016] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.828s) [368.324475] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.140s) [369.454187] [051/133] (650s left) kms_psr (fbc-psr2-sprite-render) [369.549961] Starting subtest: fbc-psr2-sprite-render [369.552476] Starting dynamic subtest: eDP-1 [369.557351] Dynamic subtest eDP-1: SKIP (0.000s) [369.562930] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [369.600847] [052/133] (650s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [369.694353] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [369.697072] Starting dynamic subtest: pipe-A-eDP-1 [369.725949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [369.736947] Starting dynamic subtest: pipe-B-eDP-1 [369.762379] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [369.772916] Starting dynamic subtest: pipe-C-eDP-1 [369.798277] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [369.810921] Starting dynamic subtest: pipe-D-eDP-1 [369.837279] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [369.843053] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [371.842286] [053/133] (648s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [371.929183] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [371.933954] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [371.975889] [054/133] (648s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [372.078315] Starting subtest: fbc-rgb101010-draw-mmap-wc [376.668189] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.586s) [377.752876] [055/133] (642s left) kms_psr (fbc-psr2-primary-mmap-cpu) [377.836972] Starting subtest: fbc-psr2-primary-mmap-cpu [377.839294] Starting dynamic subtest: eDP-1 [377.844103] Dynamic subtest eDP-1: SKIP (0.000s) [377.848905] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [377.887147] [056/133] (642s left) kms_frontbuffer_tracking (fbc-suspend) [377.982488] Starting subtest: fbc-suspend [415.661855] Subtest fbc-suspend: SUCCESS (7.482s) [416.844662] [057/133] (603s left) gem_exec_params (rsvd2-dirt) [416.910784] Starting subtest: rsvd2-dirt [416.915918] Subtest rsvd2-dirt: SKIP (0.000s) [416.981341] [058/133] (603s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [417.075823] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [417.081031] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [417.150508] [059/133] (603s left) kms_flip (busy-flip) [417.236121] Starting subtest: busy-flip [417.238551] Starting dynamic subtest: A-eDP1 [418.890726] Dynamic subtest A-eDP1: SUCCESS (1.640s) [418.903234] Starting dynamic subtest: B-eDP1 [420.543287] Dynamic subtest B-eDP1: SUCCESS (1.639s) [420.554438] Starting dynamic subtest: C-eDP1 [422.274909] Dynamic subtest C-eDP1: SUCCESS (1.718s) [422.289009] Starting dynamic subtest: D-eDP1 [423.908891] Dynamic subtest D-eDP1: SUCCESS (1.624s) [423.914315] Subtest busy-flip: SUCCESS (6.633s) [425.053362] [060/133] (595s left) kms_addfb_basic (bad-pitch-256) [425.112074] Starting subtest: bad-pitch-256 [425.114793] Subtest bad-pitch-256: SUCCESS (0.000s) [425.227141] [061/133] (595s left) kms_flip (2x-flip-vs-expired-vblank) [425.310863] Starting subtest: 2x-flip-vs-expired-vblank [425.318845] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s) [425.373938] [062/133] (595s left) gem_sync (basic-store-all) [425.443455] Starting subtest: basic-store-all [428.309835] Subtest basic-store-all: SUCCESS (2.870s) [428.472092] [063/133] (592s left) kms_plane (plane-panning-bottom-right-suspend) [428.567101] Starting subtest: plane-panning-bottom-right-suspend [428.570077] Starting dynamic subtest: pipe-A [446.537890] Dynamic subtest pipe-A: SUCCESS (2.855s) [446.557856] Starting dynamic subtest: pipe-B [464.511564] Dynamic subtest pipe-B: SUCCESS (3.435s) [464.513919] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.292s) [465.321794] [064/133] (555s left) gem_exec_store (dword) [465.405810] Starting subtest: dword [465.408210] Starting dynamic subtest: rcs0 [465.470246] Dynamic subtest rcs0: SUCCESS (0.064s) [465.482238] Starting dynamic subtest: bcs0 [465.513537] Dynamic subtest bcs0: SUCCESS (0.040s) [465.523823] Starting dynamic subtest: vcs0 [465.555278] Dynamic subtest vcs0: SUCCESS (0.039s) [465.566028] Starting dynamic subtest: vcs1 [465.597194] Dynamic subtest vcs1: SUCCESS (0.039s) [465.607919] Starting dynamic subtest: vecs0 [465.638123] Dynamic subtest vecs0: SUCCESS (0.038s) [465.648631] Starting dynamic subtest: ccs0 [465.680826] Dynamic subtest ccs0: SUCCESS (0.040s) [465.683293] Subtest dword: SUCCESS (0.272s) [465.844099] [065/133] (554s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [466.225090] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [467.093475] [066/133] (553s left) syncobj_wait (invalid-multi-wait-unsubmitted) [467.146742] Starting subtest: invalid-multi-wait-unsubmitted [467.149001] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [467.232269] [067/133] (553s left) sysfs_heartbeat_interval (precise) [467.302116] Starting subtest: precise [467.304520] Starting dynamic subtest: vecs0 [474.653665] Dynamic subtest vecs0: SUCCESS (7.289s) [474.666694] Starting dynamic subtest: ccs0 [475.789835] Dynamic subtest ccs0: SUCCESS (1.132s) [475.800314] Starting dynamic subtest: vcs0 [483.676079] Dynamic subtest vcs0: SUCCESS (7.865s) [483.688471] Starting dynamic subtest: bcs0 [484.784966] Dynamic subtest bcs0: SUCCESS (1.101s) [484.796671] Starting dynamic subtest: rcs0 [485.842584] Dynamic subtest rcs0: SUCCESS (1.057s) [485.854963] Starting dynamic subtest: vcs1 [493.667147] Dynamic subtest vcs1: SUCCESS (7.812s) [493.669655] Subtest precise: SUCCESS (26.267s) [493.720839] [068/133] (527s left) kms_big_fb (y-tiled-16bpp-rotate-270) [493.853698] Starting subtest: y-tiled-16bpp-rotate-270 [493.858114] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [493.926305] [069/133] (526s left) gem_exec_capture (capture-invisible) [493.989218] Starting subtest: capture-invisible [493.991415] Starting dynamic subtest: smem0 [493.995655] Dynamic subtest smem0: SKIP (0.000s) [494.000045] Subtest capture-invisible: SKIP (0.001s) [494.053916] [070/133] (526s left) perf (blocking-parameterized) [494.138832] Starting subtest: blocking-parameterized [514.160843] Subtest blocking-parameterized: SUCCESS (20.010s) [514.208403] [071/133] (506s left) gem_exec_reloc (basic-write-read-active) [514.269674] Subtest basic-write-read-active: SKIP (0.000s) [514.343722] [072/133] (506s left) kms_vblank (ts-continuation-dpms-suspend) [514.441179] Starting subtest: ts-continuation-dpms-suspend [514.443393] Starting dynamic subtest: pipe-A-eDP-1 [531.684359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s) [531.704091] Starting dynamic subtest: pipe-D-eDP-1 [549.693537] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.486s) [549.695526] Subtest ts-continuation-dpms-suspend: SUCCESS (4.313s) [550.489266] [073/133] (470s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [550.588721] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [550.591024] Starting dynamic subtest: pipe-A-eDP-1 [550.600038] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [550.611910] Starting dynamic subtest: pipe-B-eDP-1 [550.621087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [550.631063] Starting dynamic subtest: pipe-C-eDP-1 [550.639819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [550.649604] Starting dynamic subtest: pipe-D-eDP-1 [550.658551] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [550.662891] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [552.779902] [074/133] (468s left) gem_exec_schedule (preempt) [552.845516] Starting subtest: preempt [552.847747] Starting dynamic subtest: rcs0 [552.865255] Dynamic subtest rcs0: SUCCESS (0.027s) [552.877989] Starting dynamic subtest: bcs0 [552.886073] Dynamic subtest bcs0: SUCCESS (0.020s) [552.895612] Starting dynamic subtest: vcs0 [552.906521] Dynamic subtest vcs0: SUCCESS (0.019s) [552.916798] Starting dynamic subtest: vcs1 [552.929065] Dynamic subtest vcs1: SUCCESS (0.022s) [552.939175] Starting dynamic subtest: vecs0 [552.949154] Dynamic subtest vecs0: SUCCESS (0.019s) [552.959187] Starting dynamic subtest: ccs0 [552.969643] Dynamic subtest ccs0: SUCCESS (0.019s) [552.971800] Subtest preempt: SUCCESS (0.131s) [554.670736] [075/133] (466s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [555.247572] Starting subtest: syncobj-timeline-multiple-ext-nodes [555.250031] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [556.667527] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true [556.670929] [076/133] (464s left) gen9_exec_parse (batch-without-end) [556.739343] Subtest batch-without-end: SKIP (0.000s) [556.810415] [077/133] (464s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180) [556.902777] Starting subtest: primary-yf-tiled-reflect-x-180 [556.965277] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s) [557.045101] [078/133] (464s left) gem_exec_flush (basic-wb-rw-before-default) [557.111709] Starting subtest: basic-wb-rw-before-default [562.616130] Subtest basic-wb-rw-before-default: SUCCESS (5.475s) [562.783518] [079/133] (458s left) prime_busy (after-wait) [562.849339] Starting subtest: after-wait [562.854669] Starting dynamic subtest: rcs0 [562.897877] Dynamic subtest rcs0: SUCCESS (0.044s) [562.911230] Starting dynamic subtest: bcs0 [562.942008] Dynamic subtest bcs0: SUCCESS (0.043s) [562.952697] Starting dynamic subtest: vcs0 [562.985500] Dynamic subtest vcs0: SUCCESS (0.043s) [562.995916] Starting dynamic subtest: vcs1 [563.027381] Dynamic subtest vcs1: SUCCESS (0.041s) [563.037828] Starting dynamic subtest: vecs0 [563.071330] Dynamic subtest vecs0: SUCCESS (0.043s) [563.081915] Starting dynamic subtest: ccs0 [563.114140] Dynamic subtest ccs0: SUCCESS (0.042s) [563.223960] Subtest after-wait: SUCCESS (0.371s) [563.280212] [080/133] (457s left) kms_concurrent (multi-plane-atomic-lowres) [563.380212] Starting subtest: multi-plane-atomic-lowres [563.382379] Starting dynamic subtest: pipe-A-eDP-1 [563.871514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s) [563.882613] Starting dynamic subtest: pipe-B-eDP-1 [565.134622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s) [565.148317] Starting dynamic subtest: pipe-C-eDP-1 [566.355365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s) [566.366511] Starting dynamic subtest: pipe-D-eDP-1 [567.548076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.192s) [567.550480] Subtest multi-plane-atomic-lowres: SUCCESS (4.157s) [568.386462] [081/133] (452s left) kms_flip_tiling (flip-change-tiling) [568.478914] Starting subtest: flip-change-tiling [568.481183] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [568.652416] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.174s) [568.665883] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [568.786808] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [568.799885] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [568.920446] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [568.932121] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [569.064181] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [569.077347] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [569.208834] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [569.220919] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [569.342102] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.131s) [569.355143] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [569.475529] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [569.488546] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [569.587142] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [569.599992] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [569.721715] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [569.734794] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [569.865508] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [569.878745] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [570.011278] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [570.024940] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [570.154971] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [570.171067] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [570.288511] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [570.301509] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [570.423189] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [570.435798] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [570.533256] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [570.546208] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [570.678437] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s) [570.691502] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [570.822359] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [570.836076] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [570.966922] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [570.980270] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [571.111853] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [571.124177] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [571.245321] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s) [571.258762] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [571.390419] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [571.402665] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [571.512124] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [571.524980] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [571.656766] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [571.669665] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [571.801239] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [571.814242] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [571.946119] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [571.958591] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [572.090566] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [572.103278] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [572.234883] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [572.250551] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [572.380019] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [572.392945] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [572.502469] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [572.514048] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [572.647341] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [572.659874] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [572.791203] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [572.806238] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [572.935826] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [572.950924] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [573.081244] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [573.097156] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [573.226158] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [573.238936] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [573.370505] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [573.381824] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [573.493194] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [573.545527] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [574.776179] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.236s) [574.789518] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [574.910710] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [574.923997] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [575.044041] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [575.056254] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [575.187315] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [575.199907] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [575.353878] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.164s) [575.369504] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [575.498130] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [575.513593] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [575.632236] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [575.644435] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [575.743306] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [575.755145] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [575.878438] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [575.891649] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [576.021788] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [576.035079] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [576.165646] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [576.178700] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [576.310551] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [576.326106] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [576.454943] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.141s) [576.468326] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [576.589941] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [576.602084] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [576.700160] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [576.711799] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [576.844619] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [576.860832] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [576.989230] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [577.006660] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [577.144867] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.152s) [577.156651] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [577.289552] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [577.305236] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [577.434290] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [577.446588] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [577.579017] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [577.592183] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [577.700798] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [577.713153] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [577.844836] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [577.859223] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [577.989367] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [578.004009] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [578.134197] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.141s) [578.149470] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [578.278524] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.141s) [578.293551] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [578.423528] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [578.438757] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [578.578703] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s) [578.593437] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [578.701616] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [578.714852] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [578.846237] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [578.860392] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [578.990765] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.141s) [579.006277] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [579.135151] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [579.148669] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [579.279383] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [579.293308] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [579.435172] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s) [579.450224] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [579.580398] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [579.593889] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [579.702482] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [579.755361] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [581.021201] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.274s) [581.034361] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [581.120912] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [581.133232] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [581.232748] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [581.245684] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [581.343670] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [581.356662] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [581.453714] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [581.464831] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [581.564718] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [581.575787] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [581.665176] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [581.676639] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [581.765322] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [581.778397] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [581.865388] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [581.878318] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [581.976229] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [581.991773] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [582.086663] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [582.098985] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [582.197965] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [582.210912] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [582.298141] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [582.311224] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [582.398325] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [582.412591] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [582.498129] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [582.510240] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [582.609187] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [582.622299] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [582.730716] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.119s) [582.743375] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [582.830842] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.099s) [582.843206] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [582.930731] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [582.942430] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [583.031325] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s) [583.045270] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [583.131197] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s) [583.143552] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [583.242205] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s) [583.257802] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [583.352566] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [583.364758] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [583.463765] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s) [583.475435] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [583.563725] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s) [583.576506] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [583.663586] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s) [583.675488] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [583.763920] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s) [583.775662] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [583.874573] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [583.886467] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [583.986348] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [583.998782] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [584.097322] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [584.109186] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [584.208026] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [584.220098] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [584.308051] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s) [584.320438] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [584.408022] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s) [584.419791] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [584.519129] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [584.531974] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [584.641934] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.120s) [584.654133] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [584.752664] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [584.794025] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [586.039492] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.252s) [586.051794] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [586.139188] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [586.151151] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [586.239165] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [586.250961] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [586.350512] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [586.363129] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [586.460937] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [586.473314] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [586.561002] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.098s) [586.571933] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [586.661525] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s) [586.672958] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [586.761313] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [586.774387] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [586.861135] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [586.873368] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [586.960846] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s) [586.972300] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [587.071582] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [587.083197] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [587.171313] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s) [587.183725] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [587.271845] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [587.284914] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [587.372233] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [587.384674] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [587.472322] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [587.484661] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [587.571926] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s) [587.583938] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [587.682297] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [587.696156] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [587.793818] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [587.807390] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [587.893619] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [587.914304] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [588.005405] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s) [588.017992] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [588.105543] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s) [588.118670] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [588.216369] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [588.229211] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [588.327005] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [588.338475] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [588.438274] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [588.449340] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [588.549340] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [588.560046] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [588.660357] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [588.673789] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [588.771988] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.107s) [588.784059] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [588.904737] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.131s) [588.916845] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [589.016012] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s) [589.028676] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [589.127287] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [589.139747] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [589.226519] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s) [589.237672] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [589.337919] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [589.350029] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [589.448811] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [589.460318] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [589.559841] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s) [589.572322] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [589.671408] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s) [589.683531] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [589.782754] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [589.816487] Subtest flip-change-tiling: SUCCESS (21.328s) [591.009640] [082/133] (430s left) kms_hdmi_inject (inject-audio) [591.354135] Starting subtest: inject-audio [591.631405] Subtest inject-audio: SUCCESS (0.276s) [592.174278] [083/133] (429s left) kms_dsc (dsc-fractional-bpp) [592.269701] Starting subtest: dsc-fractional-bpp [592.282924] Subtest dsc-fractional-bpp: SKIP (0.000s) [592.322223] [084/133] (429s left) gem_ctx_param (get-priority-new-ctx) [592.372495] Starting subtest: get-priority-new-ctx [592.374932] Subtest get-priority-new-ctx: SUCCESS (0.001s) [592.455899] [085/133] (428s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [592.554911] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip [592.559447] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [592.617903] [086/133] (428s left) kms_invalid_mode (bad-htotal) [592.716627] Starting subtest: bad-htotal [592.718878] Starting dynamic subtest: pipe-A-eDP-1 [593.001632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [593.012104] Starting dynamic subtest: pipe-B-eDP-1 [593.014112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [593.023768] Starting dynamic subtest: pipe-C-eDP-1 [593.026119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [593.035557] Starting dynamic subtest: pipe-D-eDP-1 [593.037724] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [593.039950] Subtest bad-htotal: SUCCESS (0.293s) [593.835415] [087/133] (427s left) kms_plane_alpha_blend (constant-alpha-min) [593.924913] Starting subtest: constant-alpha-min [594.220351] Starting dynamic subtest: pipe-A-eDP-1 [594.950367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s) [594.960399] Starting dynamic subtest: pipe-D-eDP-1 [596.400674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s) [596.402977] Subtest constant-alpha-min: SUCCESS (2.479s) [597.237416] [088/133] (424s left) kms_addfb_basic (addfb25-bad-modifier) [597.327654] Starting subtest: addfb25-bad-modifier [597.329927] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [597.404411] [089/133] (424s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [597.492079] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [597.496110] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [597.568120] [090/133] (424s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [597.666815] Starting subtest: planes-downscale-factor-0-75-unity-scaling [597.669145] Starting dynamic subtest: pipe-A [597.729356] Dynamic subtest pipe-A: SUCCESS (0.065s) [597.739149] Starting dynamic subtest: pipe-B [598.845679] Dynamic subtest pipe-B: SUCCESS (1.115s) [598.858933] Starting dynamic subtest: pipe-C [599.922808] Dynamic subtest pipe-C: SUCCESS (1.076s) [599.932679] Starting dynamic subtest: pipe-D [601.042262] Dynamic subtest pipe-D: SUCCESS (1.118s) [601.045105] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.377s) [602.147895] [091/133] (419s left) gem_pread (bench) [602.220176] Subtest bench: SKIP (0.000s) [602.284151] [092/133] (419s left) gem_mmap (short-mmap) [602.347412] Subtest short-mmap: SKIP (0.000s) [602.422034] [093/133] (419s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [602.468917] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [602.470826] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [602.535323] [094/133] (419s left) perf_pmu (busy-idle-check-all) [602.581564] Starting subtest: busy-idle-check-all [602.583502] Starting dynamic subtest: rcs0 [603.245279] Dynamic subtest rcs0: SUCCESS (0.666s) [603.257880] Starting dynamic subtest: bcs0 [603.898562] Dynamic subtest bcs0: SUCCESS (0.651s) [603.911259] Starting dynamic subtest: vcs0 [605.628815] Dynamic subtest vcs0: SUCCESS (1.726s) [605.641848] Starting dynamic subtest: vcs1 [607.548967] Dynamic subtest vcs1: SUCCESS (1.916s) [607.562139] Starting dynamic subtest: vecs0 [609.595844] Dynamic subtest vecs0: SUCCESS (2.043s) [609.609231] Starting dynamic subtest: ccs0 [610.253953] Dynamic subtest ccs0: SUCCESS (0.657s) [610.256530] Subtest busy-idle-check-all: SUCCESS (7.675s) [610.350368] [095/133] (411s left) gem_ctx_persistence (heartbeat-hang) [610.418200] Starting subtest: heartbeat-hang [610.423034] Subtest heartbeat-hang: SKIP (0.000s) [610.508738] [096/133] (411s left) syncobj_timeline (etime-single-wait-submitted) [610.572858] Starting subtest: etime-single-wait-submitted [610.680928] Subtest etime-single-wait-submitted: SUCCESS (0.107s) [610.735838] [097/133] (411s left) kms_color (invalid-ctm-matrix-sizes) [610.835583] Starting subtest: invalid-ctm-matrix-sizes [610.837904] Starting dynamic subtest: pipe-A [610.840208] Dynamic subtest pipe-A: SUCCESS (0.002s) [610.850790] Starting dynamic subtest: pipe-B [610.853017] Dynamic subtest pipe-B: SUCCESS (0.003s) [610.862618] Starting dynamic subtest: pipe-C [610.864527] Dynamic subtest pipe-C: SUCCESS (0.004s) [610.873522] Starting dynamic subtest: pipe-D [610.875528] Dynamic subtest pipe-D: SUCCESS (0.004s) [610.877392] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s) [610.916134] [098/133] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [611.019174] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [618.254012] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.236s) [618.345521] [099/133] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [618.459103] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [625.041334] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.583s) [625.147793] [100/133] (396s left) i915_hangman (engine-error-state-capture) [625.210087] Starting subtest: engine-error-state-capture [625.212526] Starting dynamic subtest: rcs0 [630.555128] Dynamic subtest rcs0: SUCCESS (5.341s) [630.569180] Starting dynamic subtest: bcs0 [636.571173] Dynamic subtest bcs0: SUCCESS (6.011s) [636.585978] Starting dynamic subtest: vcs0 [642.522531] Dynamic subtest vcs0: SUCCESS (5.946s) [642.535318] Starting dynamic subtest: vcs1 [648.476811] Dynamic subtest vcs1: SUCCESS (5.952s) [648.491046] Starting dynamic subtest: vecs0 [653.531033] Dynamic subtest vecs0: SUCCESS (5.053s) [653.544412] Starting dynamic subtest: ccs0 [659.546488] Dynamic subtest ccs0: SUCCESS (6.013s) [659.549356] Subtest engine-error-state-capture: SUCCESS (34.334s) [659.605329] [101/133] (362s left) kms_getfb (getfb-repeated-different-handles) [659.706601] Starting subtest: getfb-repeated-different-handles [659.708898] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [659.809419] [102/133] (362s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [659.920862] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [666.454924] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.538s) [666.573036] [103/133] (355s left) dumb_buffer (create-valid-dumb) [666.630961] Starting subtest: create-valid-dumb [666.632946] Subtest create-valid-dumb: SUCCESS (0.000s) [666.706230] [104/133] (355s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [666.807102] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [666.811192] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [666.853493] [105/133] (355s left) gem_create (create-ext-set-pat) [667.016150] Starting subtest: create-ext-set-pat [667.018529] Subtest create-ext-set-pat: SUCCESS (0.001s) [667.082211] [106/133] (355s left) gem_linear_blits (interruptible) [667.561825] Starting subtest: interruptible [671.988545] Subtest interruptible: SUCCESS (4.426s) [672.082577] [107/133] (350s left) gem_workarounds (reset) [672.193933] Starting subtest: reset [672.365839] Subtest reset: SUCCESS (0.172s) [672.457741] [108/133] (349s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [672.575433] Starting subtest: fbc-pr-cursor-plane-update-sf [672.579614] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [672.627970] [109/133] (349s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [672.713702] Starting subtest: plane-use-after-nonblocking-unbind [672.715799] Starting dynamic subtest: pipe-A-eDP-1 [672.776085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s) [673.076160] Starting dynamic subtest: pipe-B-eDP-1 [673.838351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.773s) [674.145412] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.434s) [674.928737] [110/133] (347s left) kms_big_fb (4-tiled-32bpp-rotate-270) [675.047142] Starting subtest: 4-tiled-32bpp-rotate-270 [675.070006] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.024s) [675.169051] [111/133] (347s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [675.272460] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [675.276657] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [675.343053] [112/133] (347s left) gem_mmap (bad-offset) [675.409135] Subtest bad-offset: SKIP (0.000s) [675.473051] [113/133] (347s left) kms_getfb (getfb2-handle-protection) [675.572928] Starting subtest: getfb2-handle-protection [675.599777] Subtest getfb2-handle-protection: SUCCESS (0.029s) [675.703535] [114/133] (346s left) kms_cursor_crc (cursor-random-256x256) [675.983572] Starting subtest: cursor-random-256x256 [675.988035] Starting dynamic subtest: pipe-A-eDP-1 [679.324841] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.336s) [679.359364] Starting dynamic subtest: pipe-D-eDP-1 [683.343602] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s) [683.345867] Subtest cursor-random-256x256: SUCCESS (7.359s) [684.134183] [115/133] (338s left) gem_exec_gttfill (engines) [684.207471] Starting subtest: engines [684.209763] Starting dynamic subtest: rcs0 [706.971684] Dynamic subtest rcs0: SUCCESS (22.759s) [706.982720] Starting dynamic subtest: bcs0 [730.319003] Dynamic subtest bcs0: SUCCESS (23.341s) [730.341393] Starting dynamic subtest: vcs0 [753.652482] Dynamic subtest vcs0: SUCCESS (23.324s) [753.665939] Starting dynamic subtest: vcs1 [776.954967] Dynamic subtest vcs1: SUCCESS (23.297s) [776.968295] Starting dynamic subtest: vecs0 [800.262403] Dynamic subtest vecs0: SUCCESS (23.309s) [800.276255] Starting dynamic subtest: ccs0 [823.669687] Dynamic subtest ccs0: SUCCESS (23.407s) [823.672494] Subtest engines: SUCCESS (139.449s) [823.839188] [116/133] (198s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [823.993191] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [823.997398] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [824.067899] [117/133] (198s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [824.167085] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [824.171231] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [824.241301] [118/133] (198s left) kms_async_flips (test-time-stamp-atomic) [824.332465] Starting subtest: test-time-stamp-atomic [824.715906] Starting dynamic subtest: pipe-A-eDP-1 [825.525505] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s) [825.898142] Starting dynamic subtest: pipe-B-eDP-1 [826.726240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.837s) [827.098648] Starting dynamic subtest: pipe-C-eDP-1 [827.923542] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.832s) [828.294553] Starting dynamic subtest: pipe-D-eDP-1 [829.124078] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.837s) [829.126231] Subtest test-time-stamp-atomic: SUCCESS (4.793s) [830.373247] [119/133] (192s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [830.612145] Starting subtest: psr2-overlay-plane-move-continuous-sf [830.614730] Starting dynamic subtest: pipe-A-eDP-1 [836.603356] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.993s) [836.615024] Starting dynamic subtest: pipe-B-eDP-1 [843.296768] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.692s) [843.299222] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.688s) [844.132886] [120/133] (178s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [844.232081] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [844.236472] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [844.307081] [121/133] (178s left) gem_exec_schedule (u-fairslice) [844.389558] Starting subtest: u-fairslice [844.391439] Starting dynamic subtest: rcs0 [846.407653] Dynamic subtest rcs0: SUCCESS (2.021s) [846.419580] Starting dynamic subtest: bcs0 [848.425812] Dynamic subtest bcs0: SUCCESS (2.019s) [848.436645] Starting dynamic subtest: vcs0 [850.448172] Dynamic subtest vcs0: SUCCESS (2.020s) [850.460033] Starting dynamic subtest: vcs1 [852.467842] Dynamic subtest vcs1: SUCCESS (2.020s) [852.478824] Starting dynamic subtest: vecs0 [854.489772] Dynamic subtest vecs0: SUCCESS (2.019s) [854.500980] Starting dynamic subtest: ccs0 [856.510763] Dynamic subtest ccs0: SUCCESS (2.022s) [856.512637] Subtest u-fairslice: SUCCESS (12.126s) [856.787159] [122/133] (166s left) i915_pm_rc6_residency (rc6-accuracy) [856.843620] Starting subtest: rc6-accuracy [856.846026] Starting dynamic subtest: gt0 [860.017160] Dynamic subtest gt0: SUCCESS (3.169s) [860.029643] Starting dynamic subtest: gt1 [863.188209] Dynamic subtest gt1: SUCCESS (3.168s) [863.190713] Subtest rc6-accuracy: SUCCESS (6.343s) [863.241817] [123/133] (159s left) syncobj_wait (wait-all-for-submit-snapshot) [863.297563] Starting subtest: wait-all-for-submit-snapshot [863.377510] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [863.435941] [124/133] (159s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [863.539231] Starting subtest: fbcpsr-shrfb-scaledprimary [869.226003] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.688s) [869.331602] [125/133] (153s left) kms_selftest (drm_framebuffer) [869.374044] Starting subtest: drm_framebuffer [869.427366] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [869.542418] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.114s) [869.554700] Starting dynamic subtest: drm_test_framebuffer_cleanup [869.648321] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.104s) [869.659681] Starting dynamic subtest: drm_test_framebuffer_create [869.846582] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.198s) [869.857378] Starting dynamic subtest: drm_test_framebuffer_free [870.063678] Dynamic subtest drm_test_framebuffer_free: FAIL (0.172s) [870.067625] Subtest drm_framebuffer: FAIL (0.645s) [870.163483] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [870.180322] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [870.181176] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: i915_suspend results: parsing output: 3/ for test: sw_sync results: parsing output: 4/ for test: gem_mmap_gtt results: parsing output: 5/ for test: gem_ctx_shared results: parsing output: 6/ for test: kms_flip_scaled_crc results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_async_flips results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: syncobj_timeline results: parsing output: 14/ for test: kms_cursor_crc results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: gem_busy results: parsing output: 17/ for test: kms_lease results: parsing output: 18/ for test: kms_chamelium_edid results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: kms_plane_lowres results: parsing output: 24/ for test: kms_rotation_crc results: parsing output: 25/ for test: gem_mmap_offset results: parsing output: 26/ for test: kms_busy results: parsing output: 27/ for test: kms_plane results: parsing output: 28/ for test: gem_ctx_isolation results: parsing output: 29/ for test: gem_fenced_exec_thrash results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: api_intel_allocator results: parsing output: 34/ for test: api_intel_bb results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: prime_mmap results: parsing output: 37/ for test: gem_render_copy results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: i915_drm_fdinfo results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: gem_unref_active_buffers results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: kms_pm_backlight results: parsing output: 47/ for test: gem_exec_balancer results: parsing output: 48/ for test: gem_exec_alignment results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: kms_ccs results: parsing output: 52/ for test: kms_flip_scaled_crc results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_psr results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_exec_params results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_flip results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: gem_sync results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: gem_exec_store results: parsing output: 64/ for test: kms_chamelium_hpd results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: sysfs_heartbeat_interval results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_exec_capture results: parsing output: 69/ for test: perf results: parsing output: 70/ for test: gem_exec_reloc results: parsing output: 71/ for test: kms_vblank results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: gen9_exec_parse results: parsing output: 76/ for test: kms_rotation_crc results: parsing output: 77/ for test: gem_exec_flush results: parsing output: 78/ for test: prime_busy results: parsing output: 79/ for test: kms_concurrent results: parsing output: 80/ for test: kms_flip_tiling results: parsing output: 81/ for test: kms_hdmi_inject results: parsing output: 82/ for test: kms_dsc results: parsing output: 83/ for test: gem_ctx_param results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_invalid_mode results: parsing output: 86/ for test: kms_plane_alpha_blend results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_plane_scaling results: parsing output: 90/ for test: gem_pread results: parsing output: 91/ for test: gem_mmap results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: gem_ctx_persistence results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: kms_color results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: i915_hangman results: parsing output: 100/ for test: kms_getfb results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: dumb_buffer results: parsing output: 103/ for test: kms_psr2_sf results: parsing output: 104/ for test: gem_create results: parsing output: 105/ for test: gem_linear_blits results: parsing output: 106/ for test: gem_workarounds results: parsing output: 107/ for test: kms_psr2_sf results: parsing output: 108/ for test: kms_atomic_transition results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_mmap results: parsing output: 112/ for test: kms_getfb results: parsing output: 113/ for test: kms_cursor_crc results: parsing output: 114/ for test: gem_exec_gttfill results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_async_flips results: parsing output: 118/ for test: kms_psr2_sf results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: i915_pm_rc6_residency results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_selftest results: parsing output: 125/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 126/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 127/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 128/ for test: gem_render_copy results: no output, setting notrun results: parsing output: 129/ for test: kms_ccs results: no output, setting notrun results: parsing output: 130/ for test: gem_spin_batch results: no output, setting notrun results: parsing output: 131/ for test: syncobj_timeline results: no output, setting notrun results: parsing output: 132/ for test: kms_big_fb results: no output, setting notrun Done.