[60.446265] Initializing watchdogs [60.446310] /dev/watchdog0 [60.461374] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.465817] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.468041] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.469898] [001/133] (960s left) perf (global-sseu-config-invalid) [60.605754] Starting subtest: global-sseu-config-invalid [60.607398] Subtest global-sseu-config-invalid: SKIP (0.000s) [60.635566] [002/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [60.740289] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [68.617069] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.918s) [68.757795] [003/133] (952s left) kms_dither (fb-8bpc-vs-panel-8bpc) [68.849554] Starting subtest: fb-8bpc-vs-panel-8bpc [68.850504] Starting dynamic subtest: pipe-A-eDP-1 [70.193429] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.346s) [70.194289] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.348s) [70.991498] [004/133] (950s left) kms_vblank (query-busy) [71.085154] Starting subtest: query-busy [71.085955] Starting dynamic subtest: pipe-A-eDP-1 [72.964770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s) [72.973447] Starting dynamic subtest: pipe-D-eDP-1 [75.539062] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s) [75.539982] Subtest query-busy: SUCCESS (4.461s) [76.361576] [005/133] (944s left) gem_exec_fence (syncobj-timeline-export) [76.932908] Starting subtest: syncobj-timeline-export [76.934194] Subtest syncobj-timeline-export: SUCCESS (0.007s) [78.014931] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [78.016561] [006/133] (943s left) kms_vblank (wait-forked-hang) [78.118943] Starting subtest: wait-forked-hang [78.119851] Starting dynamic subtest: pipe-A-eDP-1 [104.736021] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.607s) [104.744032] Starting dynamic subtest: pipe-D-eDP-1 [119.698576] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.959s) [119.699637] Subtest wait-forked-hang: SUCCESS (41.569s) [120.513315] [007/133] (900s left) gem_exec_params (invalid-bsd1-flag-on-blt) [120.562448] Starting subtest: invalid-bsd1-flag-on-blt [120.563571] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [120.674538] [008/133] (900s left) gem_media_vme [120.793969] [009/133] (900s left) kms_cursor_crc (cursor-random-64x64) [120.956102] Starting subtest: cursor-random-64x64 [120.958930] Starting dynamic subtest: pipe-A-eDP-1 [124.310383] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.351s) [124.338062] Starting dynamic subtest: pipe-D-eDP-1 [128.301461] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.968s) [128.302405] Subtest cursor-random-64x64: SUCCESS (7.344s) [129.183177] [010/133] (892s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [129.273983] Starting subtest: pixel-format-yf-tiled-ccs-modifier [129.275974] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [129.353107] [011/133] (891s left) kms_psr (psr2-cursor-render) [129.449204] Starting subtest: psr2-cursor-render [129.450025] Starting dynamic subtest: eDP-1 [131.160318] Dynamic subtest eDP-1: SUCCESS (1.711s) [131.161245] Subtest psr2-cursor-render: SUCCESS (1.712s) [131.960121] [012/133] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [132.067457] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [132.069183] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [132.169455] [013/133] (889s left) gem_set_tiling_vs_pwrite [132.316651] [014/133] (889s left) gem_exec_balancer (parallel-keep-in-fence) [132.586041] Starting subtest: parallel-keep-in-fence [133.778779] Subtest parallel-keep-in-fence: SUCCESS (1.193s) [133.895918] [015/133] (887s left) gem_userptr_blits (create-destroy-sync) [133.971913] Starting subtest: create-destroy-sync [139.027101] Subtest create-destroy-sync: SUCCESS (5.009s) [139.137219] [016/133] (882s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [139.201688] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [139.306371] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [139.405226] [017/133] (882s left) gem_mmap_gtt (basic-small-copy-xy) [139.460767] Subtest basic-small-copy-XY: SKIP (0.000s) [139.522325] [018/133] (882s left) gem_caching (read-writes) [139.567275] Subtest read-writes: SKIP (0.000s) [139.638771] [019/133] (881s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [139.696015] Starting subtest: multi-wait-all-for-submit-available-signaled [139.697058] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [139.814685] [020/133] (881s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4) [139.917224] Starting subtest: plane-lut1d-pre-ctm3x4 [139.931339] Starting dynamic subtest: pipe-A-eDP-1 [140.402090] Dynamic subtest pipe-A-eDP-1: FAIL (0.321s) [141.329305] Starting dynamic subtest: pipe-B-eDP-1 [141.799572] Dynamic subtest pipe-B-eDP-1: FAIL (0.292s) [142.667490] Starting dynamic subtest: pipe-C-eDP-1 [143.101614] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s) [144.005212] Starting dynamic subtest: pipe-D-eDP-1 [144.453365] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s) [144.524474] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.607s) [145.410245] [021/133] (876s left) sysfs_heartbeat_interval (idempotent) [145.466296] Starting subtest: idempotent [145.467252] Starting dynamic subtest: vecs0 [145.468322] Dynamic subtest vecs0: SUCCESS (0.001s) [145.476782] Starting dynamic subtest: ccs0 [145.477627] Dynamic subtest ccs0: SUCCESS (0.001s) [145.483426] Starting dynamic subtest: vcs0 [145.484242] Dynamic subtest vcs0: SUCCESS (0.000s) [145.489919] Starting dynamic subtest: bcs0 [145.490705] Dynamic subtest bcs0: SUCCESS (0.001s) [145.496442] Starting dynamic subtest: rcs0 [145.497377] Dynamic subtest rcs0: SUCCESS (0.000s) [145.503157] Starting dynamic subtest: vcs1 [145.503896] Dynamic subtest vcs1: SUCCESS (0.000s) [145.504695] Subtest idempotent: SUCCESS (0.007s) [145.599285] [022/133] (876s left) kms_atomic (atomic-invalid-params) [145.695021] Starting subtest: atomic-invalid-params [145.695970] Starting dynamic subtest: pipe-A-eDP-1 [146.085245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.389s) [146.086118] Subtest atomic-invalid-params: SUCCESS (0.390s) [146.970501] [023/133] (874s left) gem_pxp (hw-rejects-pxp-buffer) [147.104238] Starting subtest: hw-rejects-pxp-buffer [147.106249] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [147.238955] [024/133] (874s left) perf (non-system-wide-paranoid) [147.343216] Starting subtest: non-system-wide-paranoid [147.370203] Subtest non-system-wide-paranoid: SUCCESS (0.027s) [147.414314] [025/133] (874s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [147.511244] Starting subtest: psr-rgb565-draw-mmap-gtt [147.512930] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [147.647220] [026/133] (874s left) i915_query (hwconfig_table) [147.696694] Starting subtest: hwconfig_table [147.804893] Subtest hwconfig_table: SUCCESS (0.001s) [147.832189] [027/133] (874s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [147.937939] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [155.827852] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.890s) [157.249971] [028/133] (864s left) gem_ctx_param (invalid-set-ringsize) [157.297386] Starting subtest: invalid-set-ringsize [157.298364] Subtest invalid-set-ringsize: SUCCESS (0.000s) [157.382692] [029/133] (864s left) kms_big_fb (4-tiled-addfb-size-offset-overflow) [157.489029] Starting subtest: 4-tiled-addfb-size-offset-overflow [157.490023] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [157.605296] [030/133] (864s left) kms_dsc (dsc-fractional-bpp) [157.693492] Starting subtest: dsc-fractional-bpp [157.698904] Subtest dsc-fractional-bpp: SKIP (0.000s) [157.771260] [031/133] (864s left) drm_buddy (drm_buddy) [157.807783] Starting subtest: drm_buddy [157.809845] Subtest drm_buddy: SKIP (0.001s) [157.871247] [032/133] (864s left) kms_chamelium_hpd (common-hpd-after-suspend) [158.258983] Subtest common-hpd-after-suspend: SKIP (0.000s) [159.036665] [033/133] (863s left) gem_exec_schedule (u-submit-golden-slice) [159.105526] Starting subtest: u-submit-golden-slice [159.106511] Starting dynamic subtest: rcs0 [159.136933] Dynamic subtest rcs0: SUCCESS (0.031s) [159.145866] Starting dynamic subtest: bcs0 [159.164248] Dynamic subtest bcs0: SUCCESS (0.027s) [159.173881] Starting dynamic subtest: vcs0 [159.196438] Dynamic subtest vcs0: SUCCESS (0.032s) [159.204341] Starting dynamic subtest: vcs1 [159.225173] Dynamic subtest vcs1: SUCCESS (0.028s) [159.231809] Starting dynamic subtest: vecs0 [159.250674] Dynamic subtest vecs0: SUCCESS (0.025s) [159.256928] Starting dynamic subtest: ccs0 [159.279195] Dynamic subtest ccs0: SUCCESS (0.028s) [159.280042] Subtest u-submit-golden-slice: SUCCESS (0.174s) [161.033691] [034/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [161.124521] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [161.126320] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [161.205023] [035/133] (860s left) syncobj_wait (single-wait-signaled) [161.264166] Starting subtest: single-wait-signaled [161.265095] Subtest single-wait-signaled: SUCCESS (0.000s) [161.369583] [036/133] (860s left) kms_pm_backlight (fade-with-dpms) [161.454589] Starting subtest: fade-with-dpms [163.549599] Starting dynamic subtest: eDP-1 [166.247616] Dynamic subtest eDP-1: SUCCESS (2.697s) [166.248625] Subtest fade-with-dpms: SUCCESS (4.793s) [167.072557] [037/133] (855s left) kms_rmfb (close-fd) [167.157227] Starting subtest: close-fd [167.158249] Starting dynamic subtest: pipe-A-eDP-1 [167.265357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [167.273069] Starting dynamic subtest: pipe-B-eDP-1 [168.413362] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s) [168.421401] Starting dynamic subtest: pipe-C-eDP-1 [169.536036] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s) [169.543050] Starting dynamic subtest: pipe-D-eDP-1 [170.671059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [170.672071] Subtest close-fd: SUCCESS (3.514s) [171.892990] [038/133] (850s left) kms_pipe_crc_basic (read-crc-frame-sequence) [171.978073] Starting subtest: read-crc-frame-sequence [171.978950] Starting dynamic subtest: pipe-A-eDP-1 [172.689551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [172.696425] Starting dynamic subtest: pipe-B-eDP-1 [174.060513] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s) [174.068519] Starting dynamic subtest: pipe-C-eDP-1 [175.374046] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.312s) [175.381998] Starting dynamic subtest: pipe-D-eDP-1 [176.696968] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s) [176.697874] Subtest read-crc-frame-sequence: SUCCESS (4.719s) [177.530721] [039/133] (844s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [177.615258] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [177.617106] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [177.696275] [040/133] (844s left) syncobj_wait (wait-all-interrupted) [177.753486] Starting subtest: wait-all-interrupted [177.855557] Subtest wait-all-interrupted: SUCCESS (0.101s) [177.936623] [041/133] (844s left) kms_fbcon_fbt (psr-suspend) [177.998770] Starting subtest: psr-suspend [228.784452] Subtest psr-suspend: SUCCESS (20.623s) [230.831081] [042/133] (793s left) gem_render_copy (y-tiled) [230.897938] Starting subtest: y-tiled [230.899799] Subtest y-tiled: SKIP (0.000s) [231.082161] [043/133] (793s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [231.205349] Starting subtest: cursorA-vs-flipA-legacy [242.073416] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.148s) [242.915926] [044/133] (781s left) syncobj_wait (single-wait-for-submit-signaled) [242.961511] Starting subtest: single-wait-for-submit-signaled [242.962538] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [243.077168] [045/133] (781s left) kms_psr (fbc-pr-sprite-plane-move) [243.159326] Starting subtest: fbc-pr-sprite-plane-move [243.160945] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [243.234972] [046/133] (781s left) gem_mmap_offset (partial-mmap) [243.282775] Starting subtest: partial-mmap [243.283794] Starting dynamic subtest: smem0 [243.285098] Dynamic subtest smem0: SUCCESS (0.003s) [243.286088] Subtest partial-mmap: SUCCESS (0.004s) [243.441004] [047/133] (781s left) gem_spin_batch (resubmit) [243.505077] Starting subtest: resubmit [243.505881] Starting dynamic subtest: rcs0 [243.509851] Dynamic subtest rcs0: SUCCESS (0.006s) [243.520415] Starting dynamic subtest: bcs0 [243.521239] Dynamic subtest bcs0: SUCCESS (0.002s) [243.528544] Starting dynamic subtest: vcs0 [243.529379] Dynamic subtest vcs0: SUCCESS (0.003s) [243.536375] Starting dynamic subtest: vcs1 [243.537328] Dynamic subtest vcs1: SUCCESS (0.002s) [243.545577] Starting dynamic subtest: vecs0 [243.546390] Dynamic subtest vecs0: SUCCESS (0.003s) [243.553074] Starting dynamic subtest: ccs0 [243.553801] Dynamic subtest ccs0: SUCCESS (0.003s) [243.554708] Subtest resubmit: SUCCESS (0.022s) [243.788001] [048/133] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [243.885264] Starting subtest: fbcpsr-rgb565-draw-render [251.040599] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.199s) [251.205798] [049/133] (773s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [251.300631] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [251.302322] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [251.429558] [050/133] (773s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [251.520090] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [251.520968] Starting dynamic subtest: pipe-A-eDP-1 [251.542366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [251.550515] Starting dynamic subtest: pipe-B-eDP-1 [251.562778] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s) [251.570852] Starting dynamic subtest: pipe-C-eDP-1 [251.595840] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [251.603230] Starting dynamic subtest: pipe-D-eDP-1 [251.611100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [251.611854] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s) [253.859654] [051/133] (770s left) kms_setmode (invalid-clone-single-crtc-stealing) [253.908254] Starting subtest: invalid-clone-single-crtc-stealing [253.911208] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [254.015528] [052/133] (770s left) kms_invalid_mode (bad-vtotal) [254.100993] Starting subtest: bad-vtotal [254.101777] Starting dynamic subtest: pipe-A-eDP-1 [254.384098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [254.391347] Starting dynamic subtest: pipe-B-eDP-1 [254.392156] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [254.398703] Starting dynamic subtest: pipe-C-eDP-1 [254.399540] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [254.406163] Starting dynamic subtest: pipe-D-eDP-1 [254.406912] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [254.407673] Subtest bad-vtotal: SUCCESS (0.289s) [255.199476] [053/133] (769s left) gem_mmap (short-mmap) [255.248965] Subtest short-mmap: SKIP (0.000s) [255.298959] [054/133] (769s left) gem_close (many-handles-one-vma) [255.353978] Starting subtest: many-handles-one-vma [255.378172] Subtest many-handles-one-vma: SUCCESS (0.024s) [255.501909] [055/133] (769s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [255.556596] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [255.557485] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [255.675346] [056/133] (769s left) gem_exec_fence (syncobj-timeline-wait) [256.208743] Starting subtest: syncobj-timeline-wait [258.113005] Subtest syncobj-timeline-wait: SUCCESS (1.906s) [258.383618] [057/133] (766s left) api_intel_allocator (default-alignment) [258.441817] Starting subtest: default-alignment [258.444955] Subtest default-alignment: SUCCESS (0.004s) [258.584425] [058/133] (766s left) kms_psr (fbc-pr-basic) [258.682115] Starting subtest: fbc-pr-basic [258.683951] Subtest fbc-pr-basic: SKIP (0.000s) [258.760699] [059/133] (766s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [258.846403] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [258.847459] Starting dynamic subtest: pipe-A-eDP-1 [258.857080] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [258.865389] Starting dynamic subtest: pipe-B-eDP-1 [258.874530] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [258.882346] Starting dynamic subtest: pipe-C-eDP-1 [258.890486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [258.897324] Starting dynamic subtest: pipe-D-eDP-1 [258.905531] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [258.907164] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s) [261.158400] [060/133] (763s left) kms_content_protection (dp-mst-lic-type-0) [261.315463] Starting subtest: dp-mst-lic-type-0 [261.317067] Subtest dp-mst-lic-type-0: SKIP (0.000s) [261.464126] [061/133] (763s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [261.573612] Starting subtest: cursorA-vs-flipB-legacy [261.575686] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [261.723585] [062/133] (763s left) gem_eio (suspend) [261.954762] Starting subtest: suspend [274.194067] Subtest suspend: SUCCESS (12.243s) [283.421223] [063/133] (750s left) gem_exec_schedule (implicit-write-read) [283.488136] Starting subtest: implicit-write-read [283.489058] Starting dynamic subtest: rcs0 [283.639721] Dynamic subtest rcs0: SUCCESS (0.150s) [283.650525] Starting dynamic subtest: vcs0 [283.749577] Dynamic subtest vcs0: SUCCESS (0.110s) [283.758636] Starting dynamic subtest: vcs1 [283.855683] Dynamic subtest vcs1: SUCCESS (0.104s) [283.867373] Starting dynamic subtest: vecs0 [283.971384] Dynamic subtest vecs0: SUCCESS (0.114s) [283.982093] Starting dynamic subtest: ccs0 [284.102588] Dynamic subtest ccs0: SUCCESS (0.130s) [284.103918] Subtest implicit-write-read: SUCCESS (0.614s) [285.178438] [064/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [285.284400] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [285.286097] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [285.410260] [065/133] (748s left) api_intel_bb (reset-flags) [285.471160] Starting subtest: reset-flags [285.478422] Subtest reset-flags: SUCCESS (0.008s) [285.637241] [066/133] (748s left) i915_drm_fdinfo (virtual-idle) [285.668811] Starting subtest: virtual-idle [288.741373] Subtest virtual-idle: SUCCESS (3.063s) [288.815944] [067/133] (745s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [288.875378] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [288.876315] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [288.987646] [068/133] (745s left) gem_exec_reloc (basic-write-cpu) [289.051897] Subtest basic-write-cpu: SKIP (0.000s) [289.139706] [069/133] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [289.231021] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [293.203536] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.973s) [294.371524] [070/133] (740s left) gem_busy (busy) [294.437540] Starting subtest: busy [294.438630] Starting dynamic subtest: all-engines [294.509877] Dynamic subtest all-engines: SUCCESS (0.072s) [294.522987] Starting dynamic subtest: rcs0 [296.008311] Dynamic subtest rcs0: SUCCESS (1.491s) [296.017603] Starting dynamic subtest: bcs0 [296.067688] Dynamic subtest bcs0: SUCCESS (0.064s) [296.076697] Starting dynamic subtest: vcs0 [296.107518] Dynamic subtest vcs0: SUCCESS (0.039s) [296.116484] Starting dynamic subtest: vcs1 [298.055558] Dynamic subtest vcs1: SUCCESS (1.937s) [298.065497] Starting dynamic subtest: vecs0 [300.040946] Dynamic subtest vecs0: SUCCESS (1.984s) [300.051309] Starting dynamic subtest: ccs0 [302.023322] Dynamic subtest ccs0: SUCCESS (1.983s) [302.024365] Subtest busy: SUCCESS (7.580s) [302.377868] [071/133] (732s left) kms_cursor_legacy (cursor-vs-flip-toggle) [302.501077] Starting subtest: cursor-vs-flip-toggle [333.381423] Subtest cursor-vs-flip-toggle: SUCCESS (30.891s) [334.267851] [072/133] (700s left) gen7_exec_parse (oacontrol-tracking) [334.318081] Subtest oacontrol-tracking: SKIP (0.000s) [334.396343] [073/133] (700s left) kms_chamelium_frames (hdmi-crc-multiple) [334.774738] Subtest hdmi-crc-multiple: SKIP (0.000s) [335.559232] [074/133] (698s left) i915_pm_rps (min-max-config-idle) [335.620300] Starting subtest: min-max-config-idle [335.622086] Subtest min-max-config-idle: SKIP (0.001s) [335.734462] [075/133] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [335.826559] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [335.828512] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [335.974497] [076/133] (698s left) kms_big_fb (linear-32bpp-rotate-270) [336.077945] Starting subtest: linear-32bpp-rotate-270 [336.097564] Subtest linear-32bpp-rotate-270: SKIP (0.019s) [336.253283] [077/133] (698s left) gem_mmap_wc (pf-nonblock) [336.311574] Subtest pf-nonblock: SKIP (0.000s) [336.379225] [078/133] (698s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [336.473250] Starting subtest: crc-primary-suspend-y-tiled-ccs [336.474082] Starting dynamic subtest: pipe-A-eDP-1 [336.477499] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [336.485626] Starting dynamic subtest: pipe-B-eDP-1 [336.489209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [336.497927] Starting dynamic subtest: pipe-C-eDP-1 [336.501267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [336.508557] Starting dynamic subtest: pipe-D-eDP-1 [336.511732] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [336.513372] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [338.763430] [079/133] (695s left) gem_exec_schedule (u-submit-early-slice) [338.838969] Starting subtest: u-submit-early-slice [338.839976] Starting dynamic subtest: rcs0 [338.878467] Dynamic subtest rcs0: SUCCESS (0.041s) [338.887939] Starting dynamic subtest: bcs0 [338.918680] Dynamic subtest bcs0: SUCCESS (0.040s) [338.926935] Starting dynamic subtest: vcs0 [338.962184] Dynamic subtest vcs0: SUCCESS (0.042s) [338.971524] Starting dynamic subtest: vcs1 [339.003696] Dynamic subtest vcs1: SUCCESS (0.041s) [339.012991] Starting dynamic subtest: vecs0 [339.045530] Dynamic subtest vecs0: SUCCESS (0.041s) [339.053641] Starting dynamic subtest: ccs0 [339.088290] Dynamic subtest ccs0: SUCCESS (0.042s) [339.089356] Subtest u-submit-early-slice: SUCCESS (0.252s) [340.140264] [080/133] (694s left) kms_lease (implicit-plane-lease) [340.235807] Starting subtest: implicit-plane-lease [340.238154] Subtest implicit-plane-lease: SUCCESS (0.003s) [340.351724] [081/133] (694s left) perf_pmu (multi-client) [340.383328] Starting subtest: multi-client [340.384230] Starting dynamic subtest: rcs0 [341.465898] Dynamic subtest rcs0: SUCCESS (1.071s) [341.477069] Starting dynamic subtest: bcs0 [342.516586] Dynamic subtest bcs0: SUCCESS (1.048s) [342.525664] Starting dynamic subtest: vcs0 [343.568670] Dynamic subtest vcs0: SUCCESS (1.049s) [343.578490] Starting dynamic subtest: vcs1 [345.020477] Dynamic subtest vcs1: SUCCESS (1.449s) [345.031554] Starting dynamic subtest: vecs0 [347.069345] Dynamic subtest vecs0: SUCCESS (2.046s) [347.080008] Starting dynamic subtest: ccs0 [349.054800] Dynamic subtest ccs0: SUCCESS (1.982s) [349.056139] Subtest multi-client: SUCCESS (8.664s) [349.169649] [082/133] (685s left) gem_wait (wait) [349.232612] Starting subtest: wait [349.233660] Starting dynamic subtest: all-engines [351.045820] Dynamic subtest all-engines: SUCCESS (1.802s) [351.056595] Starting dynamic subtest: rcs0 [352.082072] Dynamic subtest rcs0: SUCCESS (1.044s) [352.093579] Starting dynamic subtest: bcs0 [353.128948] Dynamic subtest bcs0: SUCCESS (1.045s) [353.148376] Starting dynamic subtest: vcs0 [354.174108] Dynamic subtest vcs0: SUCCESS (1.042s) [354.185899] Starting dynamic subtest: vcs1 [355.219093] Dynamic subtest vcs1: SUCCESS (1.042s) [355.230747] Starting dynamic subtest: vecs0 [356.266078] Dynamic subtest vecs0: SUCCESS (1.045s) [356.277917] Starting dynamic subtest: ccs0 [357.314279] Dynamic subtest ccs0: SUCCESS (1.046s) [357.315593] Subtest wait: SUCCESS (8.083s) [357.534800] [083/133] (677s left) kms_busy (extended-pageflip-hang-newfb) [357.641107] Starting subtest: extended-pageflip-hang-newfb [357.642092] Starting dynamic subtest: pipe-A [383.818568] Dynamic subtest pipe-A: SUCCESS (26.179s) [383.829332] Starting dynamic subtest: pipe-D [408.781443] Dynamic subtest pipe-D: SUCCESS (24.966s) [408.782436] Subtest extended-pageflip-hang-newfb: SUCCESS (51.150s) [409.610657] [084/133] (625s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [409.709998] Starting subtest: yf-tiled-8bpp-rotate-90 [409.712023] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [409.815178] [085/133] (625s left) kms_prime (basic-modeset-hybrid) [409.897705] Subtest basic-modeset-hybrid: SKIP (0.000s) [409.985601] [086/133] (624s left) gem_exec_balancer (bonded-dual) [410.051465] Starting subtest: bonded-dual [410.053087] Subtest bonded-dual: SKIP (0.000s) [410.373887] [087/133] (624s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [410.472413] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [410.474218] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [410.602763] [088/133] (624s left) prime_mmap (test_correct_cpu_write) [410.658354] Starting subtest: test_correct_cpu_write [410.659278] Starting dynamic subtest: test_correct_cpu_write-smem [410.660196] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [410.661089] Subtest test_correct_cpu_write: SUCCESS (0.001s) [410.782444] [089/133] (624s left) gem_ctx_persistence (smoketest) [410.849637] Starting subtest: smoketest [450.979965] Subtest smoketest: SUCCESS (40.130s) [451.067292] [090/133] (584s left) syncobj_wait (multi-wait-submitted) [451.125572] Starting subtest: multi-wait-submitted [451.231380] Subtest multi-wait-submitted: SUCCESS (0.105s) [451.329155] [091/133] (583s left) syncobj_timeline (wait-all-complex) [451.390270] Starting subtest: wait-all-complex [451.614990] Subtest wait-all-complex: SUCCESS (0.214s) [451.695478] [092/133] (583s left) kms_big_fb (y-tiled-16bpp-rotate-0) [451.809874] Starting subtest: y-tiled-16bpp-rotate-0 [451.811946] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [451.923861] [093/133] (583s left) sw_sync (sync_busy) [451.962724] Starting subtest: sync_busy [451.963812] Subtest sync_busy: SUCCESS (0.002s) [452.025903] [094/133] (583s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [452.119609] Starting subtest: psr-rgb565-draw-pwrite [459.177284] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.061s) [459.324715] [095/133] (575s left) kms_flip (basic-flip-vs-dpms) [459.414375] Starting subtest: basic-flip-vs-dpms [459.416646] Starting dynamic subtest: A-eDP1 [462.033761] Dynamic subtest A-eDP1: SUCCESS (2.617s) [462.042309] Starting dynamic subtest: B-eDP1 [464.206716] Dynamic subtest B-eDP1: SUCCESS (2.172s) [464.214975] Starting dynamic subtest: C-eDP1 [466.370545] Dynamic subtest C-eDP1: SUCCESS (2.164s) [466.378763] Starting dynamic subtest: D-eDP1 [468.449904] Dynamic subtest D-eDP1: SUCCESS (2.079s) [468.451948] Subtest basic-flip-vs-dpms: SUCCESS (9.040s) [469.243970] [096/133] (566s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [469.344618] Starting subtest: pr-overlay-plane-update-continuous-sf [469.346447] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [469.442234] [097/133] (565s left) gem_create (busy-create) [469.499203] Starting subtest: busy-create [469.500118] Starting dynamic subtest: smem0 [503.073737] Dynamic subtest smem0: SUCCESS (33.577s) [503.075009] Subtest busy-create: SUCCESS (33.579s) [503.267934] [098/133] (532s left) kms_plane_cursor (viewport) [503.353220] Starting subtest: viewport [503.354944] Starting dynamic subtest: pipe-A-eDP-1-size-64 [505.858128] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.506s) [505.919984] Starting dynamic subtest: pipe-A-eDP-1-size-128 [508.415599] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.507s) [508.479358] Starting dynamic subtest: pipe-A-eDP-1-size-256 [510.914059] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s) [511.259716] Starting dynamic subtest: pipe-B-eDP-1-size-64 [514.441886] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.191s) [514.511923] Starting dynamic subtest: pipe-B-eDP-1-size-128 [517.019179] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.527s) [517.081353] Starting dynamic subtest: pipe-B-eDP-1-size-256 [519.575074] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s) [519.924448] Starting dynamic subtest: pipe-C-eDP-1-size-64 [522.785274] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.870s) [522.821525] Starting dynamic subtest: pipe-C-eDP-1-size-128 [524.971739] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s) [525.010920] Starting dynamic subtest: pipe-C-eDP-1-size-256 [527.115641] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.114s) [527.451460] Starting dynamic subtest: pipe-D-eDP-1-size-64 [530.245941] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.814s) [530.285120] Starting dynamic subtest: pipe-D-eDP-1-size-128 [532.445199] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s) [532.485897] Starting dynamic subtest: pipe-D-eDP-1-size-256 [534.622484] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s) [534.939660] Subtest viewport: SUCCESS (31.597s) [535.759592] [099/133] (499s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [535.880717] Starting subtest: short-flip-after-cursor-toggle [536.805390] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s) [537.696900] [100/133] (497s left) gem_tiled_blits (normal) [537.759209] Subtest normal: SKIP (0.000s) [537.823218] [101/133] (497s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [537.917742] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [537.918717] Starting dynamic subtest: pipe-A-eDP-1 [537.928373] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [537.937387] Starting dynamic subtest: pipe-B-eDP-1 [537.946540] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [537.954982] Starting dynamic subtest: pipe-C-eDP-1 [537.963708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [537.971731] Starting dynamic subtest: pipe-D-eDP-1 [537.988919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [537.990601] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [540.066420] [102/133] (495s left) kms_psr (psr-no-drrs) [540.165323] Starting subtest: psr-no-drrs [540.166377] Starting dynamic subtest: eDP-1 [541.734444] Dynamic subtest eDP-1: SUCCESS (1.570s) [541.735227] Subtest psr-no-drrs: SUCCESS (1.571s) [542.536788] [103/133] (493s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [542.631315] Starting subtest: planes-downscale-factor-0-5-unity-scaling [542.632179] Starting dynamic subtest: pipe-A [542.649585] Dynamic subtest pipe-A: SKIP (0.017s) [542.658273] Starting dynamic subtest: pipe-B [542.682197] Dynamic subtest pipe-B: SKIP (0.031s) [542.690506] Starting dynamic subtest: pipe-C [542.713185] Dynamic subtest pipe-C: SKIP (0.030s) [542.721187] Starting dynamic subtest: pipe-D [542.744626] Dynamic subtest pipe-D: SKIP (0.031s) [542.746380] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s) [542.872871] [104/133] (492s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [542.978513] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [542.979426] Starting dynamic subtest: pipe-A-eDP-1 [542.987973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [542.996978] Starting dynamic subtest: pipe-B-eDP-1 [543.005428] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [543.016726] Starting dynamic subtest: pipe-C-eDP-1 [543.025502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [543.035448] Starting dynamic subtest: pipe-D-eDP-1 [543.043818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [543.045456] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [545.220390] [105/133] (490s left) i915_drm_fdinfo (busy) [545.256464] Starting subtest: busy [545.257308] Starting dynamic subtest: rcs0 [545.292382] Dynamic subtest rcs0: SKIP (0.036s) [545.302990] Starting dynamic subtest: bcs0 [545.304540] Dynamic subtest bcs0: SKIP (0.000s) [545.312240] Starting dynamic subtest: vcs0 [545.313699] Dynamic subtest vcs0: SKIP (0.000s) [545.321359] Starting dynamic subtest: vcs1 [545.322872] Dynamic subtest vcs1: SKIP (0.000s) [545.330853] Starting dynamic subtest: vecs0 [545.333675] Dynamic subtest vecs0: SKIP (0.000s) [545.343836] Starting dynamic subtest: ccs0 [545.345382] Dynamic subtest ccs0: SKIP (0.000s) [545.346912] Subtest busy: SKIP (0.043s) [545.376314] [106/133] (490s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [545.471399] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [545.473081] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [545.611853] [107/133] (490s left) kms_cursor_crc (cursor-offscreen-64x21) [545.788733] Starting subtest: cursor-offscreen-64x21 [545.835289] Subtest cursor-offscreen-64x21: SKIP (0.044s) [546.098260] [108/133] (489s left) kms_async_flips (async-flip-with-page-flip-events-linear) [546.191294] Starting subtest: async-flip-with-page-flip-events-linear [546.565132] Starting dynamic subtest: pipe-A-eDP-1 [549.299436] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.725s) [549.675156] Starting dynamic subtest: pipe-B-eDP-1 [552.430727] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s) [552.794264] Starting dynamic subtest: pipe-C-eDP-1 [555.563087] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s) [555.952091] Starting dynamic subtest: pipe-D-eDP-1 [558.704473] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s) [558.705701] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.509s) [559.883501] [109/133] (475s left) gem_readwrite (beyond-eob) [559.939844] Subtest beyond-EOB: SKIP (0.000s) [560.004366] [110/133] (475s left) gem_exec_whisper (basic-queues-all) [560.058516] Starting subtest: basic-queues-all [570.818204] Subtest basic-queues-all: SUCCESS (10.762s) [571.010348] [111/133] (464s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [571.137307] Starting subtest: cursorB-vs-flipB-varying-size [571.138844] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [571.303450] [112/133] (464s left) prime_self_import (basic-with_one_bo) [571.338517] Starting subtest: basic-with_one_bo [571.369488] Subtest basic-with_one_bo: SUCCESS (0.031s) [571.487912] [113/133] (464s left) kms_flip (2x-plain-flip-ts-check-interruptible) [571.582089] Starting subtest: 2x-plain-flip-ts-check-interruptible [571.593844] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [571.678883] [114/133] (464s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [571.734204] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [571.736249] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [571.923667] [115/133] (464s left) kms_big_fb (x-tiled-32bpp-rotate-270) [572.029324] Starting subtest: x-tiled-32bpp-rotate-270 [572.049730] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [572.173339] [116/133] (463s left) gem_ctx_sseu (engines) [572.220073] Subtest engines: SKIP (0.000s) [572.293537] [117/133] (463s left) kms_cursor_edge_walk (64x64-top-bottom) [572.378021] Starting subtest: 64x64-top-bottom [572.378935] Starting dynamic subtest: pipe-A-eDP-1 [575.816769] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s) [575.828736] Starting dynamic subtest: pipe-D-eDP-1 [578.934563] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s) [578.935446] Subtest 64x64-top-bottom: SUCCESS (6.560s) [579.752003] [118/133] (456s left) kms_psr (pr-primary-page-flip) [579.845834] Starting subtest: pr-primary-page-flip [579.847599] Subtest pr-primary-page-flip: SKIP (0.000s) [579.942168] [119/133] (456s left) i915_query (query-topology-matches-eu-total) [579.995812] Starting subtest: query-topology-matches-eu-total [579.996701] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [580.097134] [120/133] (456s left) gem_set_tiling_vs_blt (tiled-to-untiled) [580.146641] Subtest tiled-to-untiled: SKIP (0.000s) [580.210544] [121/133] (455s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [580.257419] Starting subtest: etime-multi-wait-all-submitted-signaled [580.359807] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s) [580.444118] [122/133] (455s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [580.530966] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [580.532982] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [580.640011] [123/133] (455s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [580.734606] Starting subtest: fbc-rgb565-draw-mmap-gtt [580.736408] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [580.846139] [124/133] (455s left) prime_busy (hang) [580.899851] Starting subtest: hang [580.900855] Starting dynamic subtest: rcs0 [606.550022] Dynamic subtest rcs0: SUCCESS (25.658s) [606.558679] Starting dynamic subtest: bcs0 [613.708406] Dynamic subtest bcs0: SUCCESS (7.160s) [613.718515] Starting dynamic subtest: vcs0 [620.680899] Dynamic subtest vcs0: SUCCESS (6.975s) [620.690722] Starting dynamic subtest: vcs1 [627.655067] Dynamic subtest vcs1: SUCCESS (6.978s) [627.666240] Starting dynamic subtest: vecs0 [634.700619] Dynamic subtest vecs0: SUCCESS (7.046s) [634.710682] Starting dynamic subtest: ccs0 [648.528904] Dynamic subtest ccs0: SUCCESS (13.834s) [648.530384] Subtest hang: SUCCESS (67.658s) [648.678720] [125/133] (387s left) kms_setmode (invalid-clone-single-crtc) [648.738663] Starting subtest: invalid-clone-single-crtc [648.741461] Subtest invalid-clone-single-crtc: SKIP (0.000s) [648.870699] [126/133] (387s left) kms_properties (colorop-properties-atomic) [648.967568] Starting subtest: colorop-properties-atomic [648.968552] Starting dynamic subtest: pipe-A-eDP-1 [649.304979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s) [649.313604] Starting dynamic subtest: pipe-B-eDP-1 [650.377588] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s) [650.385985] Starting dynamic subtest: pipe-C-eDP-1 [651.406947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.029s) [651.419673] Starting dynamic subtest: pipe-D-eDP-1 [652.441746] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s) [652.442574] Subtest colorop-properties-atomic: SUCCESS (3.477s) [653.230382] [127/133] (383s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [653.318026] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [653.319860] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [653.451373] [128/133] (382s left) kms_plane_scaling (invalid-num-scalers) [653.550381] Starting subtest: invalid-num-scalers [653.551313] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers [653.570877] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s) [653.579491] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers [653.603415] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [653.612067] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers [653.636074] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [653.644522] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers [653.669647] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s) [653.670501] Subtest invalid-num-scalers: SUCCESS (0.120s) [653.796152] [129/133] (382s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [653.902065] Starting subtest: yf-tiled-16bpp-rotate-0 [653.903784] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [654.021678] [130/133] (382s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [654.114558] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [654.116117] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [654.247369] [131/133] (382s left) kms_psr (fbc-psr-primary-page-flip) [654.332470] Starting subtest: fbc-psr-primary-page-flip [654.333359] Starting dynamic subtest: eDP-1 [654.334886] Dynamic subtest eDP-1: SKIP (0.000s) [654.336608] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [654.426363] [132/133] (382s left) gem_render_copy_redux (normal) [654.484133] Starting subtest: normal [654.758539] Subtest normal: SUCCESS (0.274s) [654.899429] [133/133] (381s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [655.003330] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [655.005102] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [655.135814] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_dither results: parsing output: 3/ for test: kms_vblank results: parsing output: 4/ for test: gem_exec_fence results: parsing output: 5/ for test: kms_vblank results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: gem_media_vme results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: kms_plane results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_set_tiling_vs_pwrite results: parsing output: 13/ for test: gem_exec_balancer results: parsing output: 14/ for test: gem_userptr_blits results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: gem_mmap_gtt results: parsing output: 17/ for test: gem_caching results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: kms_color_pipeline results: parsing output: 20/ for test: sysfs_heartbeat_interval results: parsing output: 21/ for test: kms_atomic results: parsing output: 22/ for test: gem_pxp results: parsing output: 23/ for test: perf results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: i915_query results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_ctx_param results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_dsc results: parsing output: 30/ for test: drm_buddy results: parsing output: 31/ for test: kms_chamelium_hpd results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_flip_scaled_crc results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_pm_backlight results: parsing output: 36/ for test: kms_rmfb results: parsing output: 37/ for test: kms_pipe_crc_basic results: parsing output: 38/ for test: kms_flip_scaled_crc results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_fbcon_fbt results: parsing output: 41/ for test: gem_render_copy results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: kms_psr results: parsing output: 45/ for test: gem_mmap_offset results: parsing output: 46/ for test: gem_spin_batch results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_setmode results: parsing output: 51/ for test: kms_invalid_mode results: parsing output: 52/ for test: gem_mmap results: parsing output: 53/ for test: gem_close results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_exec_fence results: parsing output: 56/ for test: api_intel_allocator results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_content_protection results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: gem_eio results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: api_intel_bb results: parsing output: 65/ for test: i915_drm_fdinfo results: parsing output: 66/ for test: syncobj_wait results: parsing output: 67/ for test: gem_exec_reloc results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_busy results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: gen7_exec_parse results: parsing output: 72/ for test: kms_chamelium_frames results: parsing output: 73/ for test: i915_pm_rps results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_mmap_wc results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_lease results: parsing output: 80/ for test: perf_pmu results: parsing output: 81/ for test: gem_wait results: parsing output: 82/ for test: kms_busy results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_prime results: parsing output: 85/ for test: gem_exec_balancer results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: prime_mmap results: parsing output: 88/ for test: gem_ctx_persistence results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: sw_sync results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: gem_create results: parsing output: 97/ for test: kms_plane_cursor results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: gem_tiled_blits results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_plane_scaling results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: i915_drm_fdinfo results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_cursor_crc results: parsing output: 107/ for test: kms_async_flips results: parsing output: 108/ for test: gem_readwrite results: parsing output: 109/ for test: gem_exec_whisper results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: prime_self_import results: parsing output: 112/ for test: kms_flip results: parsing output: 113/ for test: gem_render_copy results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: gem_ctx_sseu results: parsing output: 116/ for test: kms_cursor_edge_walk results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: i915_query results: parsing output: 119/ for test: gem_set_tiling_vs_blt results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: prime_busy results: parsing output: 124/ for test: kms_setmode results: parsing output: 125/ for test: kms_properties results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_plane_scaling results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_psr results: parsing output: 131/ for test: gem_render_copy_redux results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.