[58.753910] Initializing watchdogs [58.753958] /dev/watchdog0 [58.768017] [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] [58.772716] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.775201] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.778553] [001/153] (960s left) kms_psr (fbc-psr-primary-page-flip) [58.900884] Starting subtest: fbc-psr-primary-page-flip [58.903163] Starting dynamic subtest: eDP-1 [58.907572] Dynamic subtest eDP-1: SKIP (0.000s) [58.911692] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [58.984082] [002/153] (960s left) kms_psr (psr2-sprite-plane-onoff) [59.075675] Starting subtest: psr2-sprite-plane-onoff [59.077948] Starting dynamic subtest: eDP-1 [60.794876] Dynamic subtest eDP-1: SUCCESS (1.722s) [60.797180] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s) [61.658449] [003/153] (957s left) kms_addfb_basic (invalid-get-prop) [61.707879] Starting subtest: invalid-get-prop [61.709898] Subtest invalid-get-prop: SUCCESS (0.000s) [61.835687] [004/153] (957s left) gem_fence_thrash (bo-write-verify-y) [61.869799] Starting subtest: bo-write-verify-y [61.887685] Subtest bo-write-verify-y: SKIP (0.014s) [61.938770] [005/153] (957s left) gem_exec_schedule (u-independent) [62.004565] Starting subtest: u-independent [62.006536] Starting dynamic subtest: rcs0 [63.299367] Dynamic subtest rcs0: SUCCESS (1.302s) [63.311071] Starting dynamic subtest: vcs0 [65.290199] Dynamic subtest vcs0: SUCCESS (1.992s) [65.300463] Starting dynamic subtest: vcs1 [67.274761] Dynamic subtest vcs1: SUCCESS (1.985s) [67.285393] Starting dynamic subtest: vecs0 [69.320856] Dynamic subtest vecs0: SUCCESS (2.047s) [69.331958] Starting dynamic subtest: ccs0 [71.298025] Dynamic subtest ccs0: SUCCESS (1.977s) [71.301033] Subtest u-independent: SUCCESS (9.308s) [71.600293] [006/153] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen) [71.700338] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen [71.704456] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [71.775560] [007/153] (947s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [71.870484] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [71.874569] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [71.966553] [008/153] (947s left) kms_getfb (getfb-addfb-different-handles) [72.062934] Starting subtest: getfb-addfb-different-handles [72.065305] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [72.164952] [009/153] (947s left) gen9_exec_parse (bb-start-far) [72.270685] Subtest bb-start-far: SKIP (0.000s) [72.335844] [010/153] (947s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [72.395304] Starting subtest: multi-wait-for-submit-submitted-signaled [72.397213] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [72.764075] [011/153] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt) [72.992941] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt [72.997505] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [73.189402] [012/153] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [73.303470] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [73.307678] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [73.472582] [013/153] (946s left) kms_content_protection (dp-mst-type-0-hdcp14) [73.638092] Starting subtest: dp-mst-type-0-hdcp14 [73.642496] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [73.754604] [014/153] (946s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [73.854764] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [73.858727] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [73.945673] [015/153] (945s left) kms_feature_discovery (display-3x) [74.033886] Starting subtest: display-3x [74.038952] Subtest display-3x: SKIP (0.000s) [74.103603] [016/153] (945s left) kms_fence_pin_leak [74.260815] [017/153] (945s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [74.342207] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [74.344260] Starting dynamic subtest: pipe-A-eDP-1 [74.364037] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [74.373225] Starting dynamic subtest: pipe-B-eDP-1 [74.391138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [74.397847] Starting dynamic subtest: pipe-C-eDP-1 [74.415675] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [74.422427] Starting dynamic subtest: pipe-D-eDP-1 [74.440418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [74.443891] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s) [76.620636] [018/153] (943s left) kms_cursor_crc (cursor-rapid-movement-64x21) [76.836523] Starting subtest: cursor-rapid-movement-64x21 [76.881813] Subtest cursor-rapid-movement-64x21: SKIP (0.042s) [77.112414] [019/153] (942s left) kms_plane_alpha_blend (alpha-basic) [77.197368] Starting subtest: alpha-basic [77.499315] Starting dynamic subtest: pipe-A-eDP-1 [79.434389] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [79.459058] Starting dynamic subtest: pipe-D-eDP-1 [82.057025] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.604s) [82.059461] Subtest alpha-basic: SUCCESS (4.861s) [82.865888] [020/153] (937s left) i915_fb_tiling (basic-x-tiling) [82.917815] Subtest basic-x-tiling: SKIP (0.000s) [82.968570] [021/153] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [83.068247] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [83.072263] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [83.146901] [022/153] (936s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [83.254873] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite [83.259062] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [83.371953] [023/153] (936s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt) [83.478088] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt [83.482236] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [83.585755] [024/153] (936s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [83.648941] Starting subtest: invalid-multi-wait-unsubmitted-submitted [83.651395] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [83.742316] [025/153] (936s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt) [83.832427] Starting subtest: psrhdr-rgb565-draw-mmap-gtt [83.835952] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s) [83.935480] [026/153] (936s left) kms_psr (pr-primary-page-flip) [84.020244] Starting subtest: pr-primary-page-flip [84.023892] Subtest pr-primary-page-flip: SKIP (0.000s) [84.104795] [027/153] (936s left) kms_chamelium_hpd (hdmi-hpd-fast) [84.477790] Subtest hdmi-hpd-fast: SKIP (0.000s) [85.307349] [028/153] (935s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [85.424401] Starting subtest: plane-downscale-factor-0-5-with-modifiers [85.426835] Starting dynamic subtest: pipe-A [85.444445] Dynamic subtest pipe-A: SKIP (0.017s) [85.452651] Starting dynamic subtest: pipe-B [85.479318] Dynamic subtest pipe-B: SKIP (0.035s) [85.487117] Starting dynamic subtest: pipe-C [85.513957] Dynamic subtest pipe-C: SKIP (0.034s) [85.521672] Starting dynamic subtest: pipe-D [85.543957] Dynamic subtest pipe-D: SKIP (0.031s) [85.548092] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.118s) [85.667008] [029/153] (934s left) perf_pmu (busy-idle-check-all) [85.705623] Starting subtest: busy-idle-check-all [85.707636] Starting dynamic subtest: rcs0 [86.359213] Dynamic subtest rcs0: SUCCESS (0.655s) [86.370074] Starting dynamic subtest: bcs0 [87.011977] Dynamic subtest bcs0: SUCCESS (0.651s) [87.021175] Starting dynamic subtest: vcs0 [88.259113] Dynamic subtest vcs0: SUCCESS (1.246s) [88.271330] Starting dynamic subtest: vcs1 [90.307073] Dynamic subtest vcs1: SUCCESS (2.047s) [90.318829] Starting dynamic subtest: vecs0 [92.290301] Dynamic subtest vecs0: SUCCESS (1.983s) [92.301448] Starting dynamic subtest: ccs0 [92.948446] Dynamic subtest ccs0: SUCCESS (0.658s) [92.950961] Subtest busy-idle-check-all: SUCCESS (7.246s) [93.075280] [030/153] (927s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [93.132716] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [93.238858] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s) [93.314114] [031/153] (927s left) kms_lease (invalid-create-leases) [93.419130] Starting subtest: invalid-create-leases [93.425667] Subtest invalid-create-leases: SUCCESS (0.005s) [93.550617] [032/153] (927s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [93.650386] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [93.652758] Starting dynamic subtest: pipe-A-default-mode [96.354961] Dynamic subtest pipe-A-default-mode: SUCCESS (2.701s) [96.357373] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.702s) [97.231656] [033/153] (923s left) gem_softpin (allocator-basic) [97.299303] Starting subtest: allocator-basic [97.369213] Subtest allocator-basic: SUCCESS (0.070s) [97.480398] [034/153] (923s left) gem_pxp (create-regular-buffer) [97.599921] Starting subtest: create-regular-buffer [97.602793] Subtest create-regular-buffer: SUCCESS (0.000s) [97.706357] [035/153] (923s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [97.816181] Starting subtest: cursorA-vs-flipB-legacy [97.820729] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [97.957956] [036/153] (922s left) template (a) [98.013152] Starting subtest: A [98.015597] Subtest A: SUCCESS (0.000s) [98.094041] [037/153] (922s left) gem_flink_basic (bad-open) [98.154068] Starting subtest: bad-open [98.156086] Subtest bad-open: SUCCESS (0.000s) [98.241313] [038/153] (922s left) kms_dither (fb-8bpc-vs-panel-6bpc) [98.326910] Starting subtest: fb-8bpc-vs-panel-6bpc [98.328912] Starting dynamic subtest: pipe-A-eDP-1 [99.706173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.378s) [99.708580] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.379s) [100.507283] [039/153] (920s left) gem_exec_flush (basic-uc-rw-default) [100.577055] Starting subtest: basic-uc-rw-default [106.032929] Subtest basic-uc-rw-default: SUCCESS (5.456s) [106.228703] [040/153] (914s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [106.340369] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [106.344488] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [106.452506] [041/153] (914s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [106.557686] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [106.561721] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [106.651647] [042/153] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [106.759698] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [114.674225] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.919s) [114.819990] [043/153] (906s left) sriov_basic (bind-unbind-vf) [114.884517] Starting subtest: bind-unbind-vf [114.887074] Starting dynamic subtest: vf-1 [114.962245] Dynamic subtest vf-1: FAIL (0.017s) [114.972134] Starting dynamic subtest: vf-2 [115.044339] Dynamic subtest vf-2: FAIL (0.004s) [115.054093] Starting dynamic subtest: vf-3 [115.127127] Dynamic subtest vf-3: FAIL (0.003s) [115.136999] Starting dynamic subtest: vf-4 [115.210336] Dynamic subtest vf-4: FAIL (0.003s) [115.219536] Starting dynamic subtest: vf-5 [115.291258] Dynamic subtest vf-5: FAIL (0.004s) [115.300819] Starting dynamic subtest: vf-6 [115.373884] Dynamic subtest vf-6: FAIL (0.004s) [115.382778] Starting dynamic subtest: vf-7 [115.456114] Dynamic subtest vf-7: FAIL (0.003s) [115.465532] Starting dynamic subtest: vf-random [115.536894] Dynamic subtest vf-random: FAIL (0.004s) [115.546232] Starting dynamic subtest: vf-last [115.618484] Dynamic subtest vf-last: FAIL (0.508s) [115.620616] Subtest bind-unbind-vf: FAIL (0.555s) [115.656068] [044/153] (905s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [116.039076] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [116.892168] [045/153] (904s left) i915_pm_rps (min-max-config-idle) [116.959114] Starting subtest: min-max-config-idle [116.963361] Subtest min-max-config-idle: SKIP (0.000s) [117.059487] [046/153] (904s left) kms_big_fb (y-tiled-64bpp-rotate-0) [117.151841] Starting subtest: y-tiled-64bpp-rotate-0 [117.155819] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [117.255953] [047/153] (903s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [117.369337] Starting subtest: pr-overlay-primary-update-sf-dmg-area [117.373549] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [117.431336] [048/153] (903s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [118.009833] Starting subtest: syncobj-stationary-timeline-chain-engines [118.124402] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.118s) [119.393702] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [119.397131] [049/153] (901s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [119.487792] Starting subtest: async-flip-with-page-flip-events-tiled [119.860418] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [122.588784] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.728s) [122.600904] Starting dynamic subtest: pipe-A-eDP-1-4 [124.774633] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s) [124.785321] Starting dynamic subtest: pipe-A-eDP-1-4 [126.784708] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [126.796632] Starting dynamic subtest: pipe-A-eDP-1-x [128.963657] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [129.352991] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [132.126290] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.779s) [132.138196] Starting dynamic subtest: pipe-B-eDP-1-4 [134.301375] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s) [134.312817] Starting dynamic subtest: pipe-B-eDP-1-4 [136.311480] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s) [136.320259] Starting dynamic subtest: pipe-B-eDP-1-x [138.502336] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [138.877316] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [141.661993] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.791s) [141.674295] Starting dynamic subtest: pipe-C-eDP-1-4 [143.836881] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [143.848754] Starting dynamic subtest: pipe-C-eDP-1-4 [145.847490] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [145.858369] Starting dynamic subtest: pipe-C-eDP-1-x [148.025543] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [148.411447] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [151.188386] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.785s) [151.199897] Starting dynamic subtest: pipe-D-eDP-1-4 [153.374121] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.185s) [153.385501] Starting dynamic subtest: pipe-D-eDP-1-4 [155.384588] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [155.396058] Starting dynamic subtest: pipe-D-eDP-1-x [157.562965] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [157.565549] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.074s) [158.779941] [050/153] (862s left) gem_exec_balancer (parallel-balancer) [159.031927] Starting subtest: parallel-balancer [159.926648] Subtest parallel-balancer: SUCCESS (0.895s) [160.026666] [051/153] (861s left) gen9_exec_parse (valid-registers) [160.083667] Subtest valid-registers: SKIP (0.000s) [160.137516] [052/153] (861s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt) [160.241834] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt [160.246078] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [160.345064] [053/153] (861s left) kms_frontbuffer_tracking (hdr-suspend) [160.444175] Starting subtest: hdr-suspend [160.448183] Subtest hdr-suspend: SKIP (0.000s) [160.524986] [054/153] (860s left) gem_mmap_gtt (basic) [160.581660] Subtest basic: SKIP (0.000s) [160.638428] [055/153] (860s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [160.722693] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [160.724844] Starting dynamic subtest: pipe-A-default-mode [161.840877] Dynamic subtest pipe-A-default-mode: SKIP (1.115s) [161.844849] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.116s) [161.993643] [056/153] (859s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [162.048072] Starting subtest: y-tiled-to-vebox-y-tiled [162.052288] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [162.231890] [057/153] (859s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [162.281690] Starting subtest: multi-wait-all-for-submit-submitted-signaled [162.389702] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s) [162.466981] [058/153] (859s left) gem_exec_reloc (basic-cpu-read-noreloc) [162.536730] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [162.610365] [059/153] (859s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt) [162.709282] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt [162.713514] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [162.803976] [060/153] (858s left) kms_cursor_crc (cursor-tearing-position-change) [162.906643] Starting subtest: cursor-tearing-position-change [162.908855] Starting dynamic subtest: pipe-A-eDP-1 [163.497213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s) [163.505755] Starting dynamic subtest: pipe-D-eDP-1 [164.737573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s) [164.739749] Subtest cursor-tearing-position-change: SUCCESS (1.829s) [165.579421] [061/153] (856s left) gem_exec_params (rel-constants-invalid-rel-gen5) [165.640567] Starting subtest: rel-constants-invalid-rel-gen5 [165.642878] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [165.741089] [062/153] (856s left) kms_flip (2x-plain-flip-ts-check-interruptible) [165.837705] Starting subtest: 2x-plain-flip-ts-check-interruptible [165.849616] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s) [165.924902] [063/153] (855s left) gem_basic (bad-close) [165.975430] Starting subtest: bad-close [165.979683] Subtest bad-close: SUCCESS (0.000s) [166.075829] [064/153] (855s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [166.179507] Starting subtest: fbc-2p-pri-indfb-multidraw [166.184052] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [166.283060] [065/153] (855s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render) [166.381658] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render [166.385853] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [166.467986] [066/153] (855s left) gem_eio (in-flight-contexts-immediate) [166.691450] Starting subtest: in-flight-contexts-immediate [180.311693] Subtest in-flight-contexts-immediate: SUCCESS (13.619s) [180.430227] [067/153] (841s left) perf_pmu (semaphore-wait) [180.470101] Starting subtest: semaphore-wait [180.471944] Starting dynamic subtest: rcs0 [180.984753] Dynamic subtest rcs0: SUCCESS (0.515s) [180.997037] Starting dynamic subtest: bcs0 [181.497498] Dynamic subtest bcs0: SUCCESS (0.511s) [181.509037] Starting dynamic subtest: vcs0 [182.011434] Dynamic subtest vcs0: SUCCESS (0.511s) [182.022543] Starting dynamic subtest: vcs1 [182.525827] Dynamic subtest vcs1: SUCCESS (0.511s) [182.539331] Starting dynamic subtest: vecs0 [183.037860] Dynamic subtest vecs0: SUCCESS (0.510s) [183.049158] Starting dynamic subtest: ccs0 [183.553046] Dynamic subtest ccs0: SUCCESS (0.513s) [183.555921] Subtest semaphore-wait: SUCCESS (3.086s) [184.343845] [068/153] (837s left) gem_partial_pwrite_pread (writes-after-reads-snoop) [184.406487] Subtest writes-after-reads-snoop: SKIP (0.000s) [184.481895] [069/153] (837s left) gem_userptr_blits (map-fixed-invalidate) [184.552624] Starting subtest: map-fixed-invalidate [184.556864] Subtest map-fixed-invalidate: SKIP (0.000s) [184.686064] [070/153] (837s left) gem_ctx_persistence (engines-persistence) [184.752897] Starting subtest: engines-persistence [184.754779] Starting dynamic subtest: rcs0 [185.539028] Dynamic subtest rcs0: SUCCESS (0.788s) [185.550942] Starting dynamic subtest: bcs0 [186.281936] Dynamic subtest bcs0: SUCCESS (0.741s) [186.291384] Starting dynamic subtest: vcs0 [187.070816] Dynamic subtest vcs0: SUCCESS (0.787s) [187.080908] Starting dynamic subtest: vcs1 [187.837786] Dynamic subtest vcs1: SUCCESS (0.765s) [187.848290] Starting dynamic subtest: vecs0 [188.585087] Dynamic subtest vecs0: SUCCESS (0.745s) [188.595988] Starting dynamic subtest: ccs0 [189.373977] Dynamic subtest ccs0: SUCCESS (0.788s) [189.376499] Subtest engines-persistence: SUCCESS (4.624s) [189.468599] [071/153] (832s left) kms_flip (nonexisting-fb) [189.568373] Starting subtest: nonexisting-fb [189.570800] Starting dynamic subtest: A-eDP1 [190.752893] Dynamic subtest A-eDP1: SUCCESS (1.186s) [190.764594] Starting dynamic subtest: B-eDP1 [191.874073] Dynamic subtest B-eDP1: SUCCESS (1.121s) [191.886904] Starting dynamic subtest: C-eDP1 [193.011702] Dynamic subtest C-eDP1: SUCCESS (1.135s) [193.020577] Starting dynamic subtest: D-eDP1 [194.141244] Dynamic subtest D-eDP1: SUCCESS (1.127s) [194.145999] Subtest nonexisting-fb: SUCCESS (4.582s) [195.405732] [072/153] (826s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [195.519471] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [195.523786] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [195.612914] [073/153] (826s left) gem_mmap_gtt (basic-write) [195.673078] Subtest basic-write: SKIP (0.000s) [195.727740] [074/153] (826s left) kms_frontbuffer_tracking (psrhdr-2p-rte) [195.834725] Starting subtest: psrhdr-2p-rte [195.838939] Subtest psrhdr-2p-rte: SKIP (0.000s) [195.931637] [075/153] (826s left) kms_vblank (wait-busy-hang) [196.024507] Starting subtest: wait-busy-hang [196.026740] Starting dynamic subtest: pipe-A-eDP-1 [222.089886] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.063s) [222.103670] Starting dynamic subtest: pipe-D-eDP-1 [237.130738] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s) [237.133478] Subtest wait-busy-hang: SUCCESS (41.106s) [237.985823] [076/153] (784s left) kms_plane (pixel-format-linear-modifier-source-clamping) [238.091113] Starting subtest: pixel-format-linear-modifier-source-clamping [238.117435] Starting dynamic subtest: pipe-A-plane-0 [241.805791] Dynamic subtest pipe-A-plane-0: SUCCESS (3.689s) [241.814952] Starting dynamic subtest: pipe-A-plane-3 [243.528057] Dynamic subtest pipe-A-plane-3: SUCCESS (1.720s) [244.671574] Starting dynamic subtest: pipe-B-plane-0 [248.272153] Dynamic subtest pipe-B-plane-0: SUCCESS (3.611s) [248.281465] Starting dynamic subtest: pipe-B-plane-3 [249.949901] Dynamic subtest pipe-B-plane-3: SUCCESS (1.676s) [250.261829] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.169s) [251.147758] [077/153] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [251.257076] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [258.579248] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.327s) [258.725983] [078/153] (763s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [258.846515] Starting subtest: psr-rgb101010-draw-mmap-gtt [258.850884] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [258.942237] [079/153] (763s left) kms_flip (2x-blocking-absolute-wf_vblank) [259.028183] Starting subtest: 2x-blocking-absolute-wf_vblank [259.036410] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [259.115686] [080/153] (763s left) kms_addfb_basic (size-max) [259.220941] Starting subtest: size-max [259.222903] Subtest size-max: SUCCESS (0.000s) [259.322058] [081/153] (763s left) gem_ctx_shared (q-smoketest) [259.390019] Starting subtest: Q-smoketest [259.392384] Starting dynamic subtest: rcs0 [264.938467] Dynamic subtest rcs0: SUCCESS (5.495s) [264.948449] Starting dynamic subtest: bcs0 [270.456778] Dynamic subtest bcs0: SUCCESS (5.518s) [270.468058] Starting dynamic subtest: vcs0 [275.960877] Dynamic subtest vcs0: SUCCESS (5.476s) [275.972427] Starting dynamic subtest: vcs1 [281.406069] Dynamic subtest vcs1: SUCCESS (5.473s) [281.417705] Starting dynamic subtest: vecs0 [286.892399] Dynamic subtest vecs0: SUCCESS (5.484s) [286.905141] Starting dynamic subtest: ccs0 [292.383553] Dynamic subtest ccs0: SUCCESS (5.489s) [292.386065] Subtest Q-smoketest: SUCCESS (32.942s) [292.526016] [082/153] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [292.629165] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [292.633046] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [292.707985] [083/153] (729s left) api_intel_bb (intel-bb-blit-x) [292.761800] Starting subtest: intel-bb-blit-x [296.425131] Subtest intel-bb-blit-x: SUCCESS (3.663s) [296.526909] [084/153] (726s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite) [296.623638] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite [296.627705] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [296.713064] [085/153] (725s left) kms_prime (basic-modeset-hybrid) [296.794166] Subtest basic-modeset-hybrid: SKIP (0.000s) [296.904523] [086/153] (725s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [297.001016] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [297.005199] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [297.109236] [087/153] (725s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [297.164201] Starting subtest: multi-wait-all-for-submit-available-signaled [297.166467] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [297.257096] [088/153] (725s left) gem_exec_schedule (preempt-queue-contexts) [297.336767] Subtest preempt-queue-contexts: SKIP (0.000s) [297.624680] [089/153] (725s left) gem_exec_basic (basic) [297.676635] Starting subtest: basic [297.678846] Starting dynamic subtest: rcs0-smem [297.681013] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [297.691550] Starting dynamic subtest: bcs0-smem [297.693947] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [297.703199] Starting dynamic subtest: vcs0-smem [297.705107] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [297.713797] Starting dynamic subtest: vcs1-smem [297.715811] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [297.724338] Starting dynamic subtest: vecs0-smem [297.726268] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [297.735173] Starting dynamic subtest: ccs0-smem [297.737039] Dynamic subtest ccs0-smem: SUCCESS (0.002s) [297.738869] Subtest basic: SUCCESS (0.017s) [299.306441] [090/153] (723s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render) [299.402496] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render [299.406962] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [299.520027] [091/153] (723s left) kms_cdclk (plane-scaling) [299.599948] Starting subtest: plane-scaling [299.602253] Starting dynamic subtest: pipe-A-eDP-1 [299.905226] Dynamic subtest pipe-A-eDP-1: SKIP (0.302s) [299.914096] Starting dynamic subtest: pipe-B-eDP-1 [299.918701] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [299.927467] Starting dynamic subtest: pipe-C-eDP-1 [299.932092] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [299.940810] Starting dynamic subtest: pipe-D-eDP-1 [299.944965] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [299.949152] Subtest plane-scaling: SKIP (0.309s) [300.719916] [092/153] (722s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc) [300.822873] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc [300.827220] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [300.945689] [093/153] (722s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [301.001981] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [301.069829] [094/153] (722s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [301.179158] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [301.183263] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [301.271235] [095/153] (721s left) kms_properties (crtc-properties-atomic) [301.362045] Starting subtest: crtc-properties-atomic [301.364320] Starting dynamic subtest: pipe-A-eDP-1 [301.820122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [301.829377] Starting dynamic subtest: pipe-B-eDP-1 [302.989081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s) [303.008879] Starting dynamic subtest: pipe-C-eDP-1 [304.122855] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s) [304.134785] Starting dynamic subtest: pipe-D-eDP-1 [305.256113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [305.258426] Subtest crtc-properties-atomic: SUCCESS (3.893s) [306.098143] [096/153] (717s left) gem_exec_fence (syncobj-timeline-wait) [306.697049] Starting subtest: syncobj-timeline-wait [308.247665] Subtest syncobj-timeline-wait: SUCCESS (1.552s) [310.365015] [097/153] (712s left) i915_suspend (basic-s2idle-without-i915) [310.404782] Starting subtest: basic-s2idle-without-i915 [329.717795] Subtest basic-s2idle-without-i915: SUCCESS (4.235s) [329.868135] [098/153] (693s left) kms_psr (fbc-pr-no-drrs) [329.983992] Starting subtest: fbc-pr-no-drrs [329.988260] Subtest fbc-pr-no-drrs: SKIP (0.000s) [330.054759] [099/153] (693s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [330.143209] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [330.147523] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [330.235523] [100/153] (693s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [330.286455] Subtest no-spare-fences-interruptible: SKIP (0.000s) [330.356453] [101/153] (693s left) syncobj_basic (illegal-fd-to-handle) [330.405364] Starting subtest: illegal-fd-to-handle [330.407561] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [330.499828] [102/153] (692s left) fbdev (pan) [330.542628] Starting subtest: pan [330.570948] Subtest pan: SUCCESS (0.031s) [330.639402] [103/153] (692s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [330.725856] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [330.727772] Starting dynamic subtest: pipe-A [330.746692] Dynamic subtest pipe-A: SKIP (0.018s) [330.755577] Starting dynamic subtest: pipe-B [330.781861] Dynamic subtest pipe-B: SKIP (0.035s) [330.790366] Starting dynamic subtest: pipe-C [330.824875] Dynamic subtest pipe-C: SKIP (0.034s) [330.833507] Starting dynamic subtest: pipe-D [330.852283] Dynamic subtest pipe-D: SKIP (0.035s) [330.855303] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.124s) [330.958220] [104/153] (692s left) kms_psr (fbc-psr2-no-drrs) [331.049604] Starting subtest: fbc-psr2-no-drrs [331.051424] Starting dynamic subtest: eDP-1 [331.054726] Dynamic subtest eDP-1: SKIP (0.000s) [331.057955] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [331.118720] [105/153] (692s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [331.203398] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [331.207064] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [332.346364] [106/153] (691s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [332.453935] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [333.490738] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.040s) [333.603871] [107/153] (690s left) kms_cursor_crc (cursor-offscreen-32x10) [333.768421] Starting subtest: cursor-offscreen-32x10 [333.818061] Subtest cursor-offscreen-32x10: SKIP (0.048s) [334.141674] [108/153] (689s left) syncobj_timeline (wait-for-submit-complex) [334.184811] Starting subtest: wait-for-submit-complex [334.245692] Subtest wait-for-submit-complex: SUCCESS (0.062s) [334.335661] [109/153] (689s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [334.428406] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [341.173537] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.755s) [341.300668] [110/153] (682s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [341.417992] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [341.420145] Starting dynamic subtest: pipe-A-eDP-1 [341.441963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [341.452635] Starting dynamic subtest: pipe-B-eDP-1 [341.474034] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [341.482975] Starting dynamic subtest: pipe-C-eDP-1 [341.504524] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [341.513245] Starting dynamic subtest: pipe-D-eDP-1 [341.535009] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [341.539059] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s) [343.730771] [111/153] (680s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [343.834966] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [343.837054] Starting dynamic subtest: pipe-A-eDP-1 [345.857124] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.025s) [345.866130] Starting dynamic subtest: pipe-B-eDP-1 [348.019577] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.162s) [348.028281] Starting dynamic subtest: pipe-C-eDP-1 [350.085713] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.066s) [350.094913] Starting dynamic subtest: pipe-D-eDP-1 [352.091673] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.001s) [352.093985] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.259s) [353.336262] [112/153] (670s left) kms_selftest (drm_dp_mst_helper) [353.393702] Starting subtest: drm_dp_mst_helper [353.404762] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode [353.502860] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s) [353.513044] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div [353.598130] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.095s) [353.607498] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode [353.694658] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s) [353.696864] Subtest drm_dp_mst_helper: SUCCESS (0.303s) [353.873976] [113/153] (670s left) gem_exec_suspend (basic-s0) [353.935270] Starting subtest: basic-S0 [353.937606] Starting dynamic subtest: smem [373.376501] Dynamic subtest smem: SUCCESS (6.426s) [373.379519] Subtest basic-S0: SUCCESS (6.429s) [373.581544] [114/153] (650s left) gem_ctx_persistence (heartbeat-stop) [373.643057] Starting subtest: heartbeat-stop [373.647713] Subtest heartbeat-stop: SKIP (0.000s) [373.742845] [115/153] (650s left) gem_pxp (protected-encrypted-src-copy-not-readible) [373.872234] Starting subtest: protected-encrypted-src-copy-not-readible [373.982841] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s) [374.104906] [116/153] (649s left) api_intel_allocator (reopen) [374.160401] Starting subtest: reopen [374.164963] Subtest reopen: SUCCESS (0.004s) [374.285535] [117/153] (649s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [374.339598] Starting subtest: etime-single-wait-available-unsubmitted [374.443242] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s) [374.523136] [118/153] (649s left) kms_pm_rpm (basic-rte) [374.566708] Starting subtest: basic-rte [378.039535] Subtest basic-rte: SUCCESS (3.477s) [379.860964] [119/153] (644s left) gem_mmap_gtt (cpuset-medium-copy-xy) [379.909163] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [379.973646] [120/153] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [380.073028] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt [380.077153] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [380.226546] [121/153] (644s left) gem_mmap_gtt (hang-busy) [380.286007] Subtest hang-busy: SKIP (0.000s) [380.352829] [122/153] (643s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [380.452269] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [387.207717] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.763s) [387.322951] [123/153] (637s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt) [387.422673] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt [387.426727] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [387.517520] [124/153] (636s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [387.605653] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [387.610269] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [387.686774] [125/153] (636s left) gem_exec_params (invalid-bsd2-flag-on-blt) [387.738851] Starting subtest: invalid-bsd2-flag-on-blt [387.741168] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [387.844401] [126/153] (636s left) dumb_buffer (create-clear) [387.903411] Starting subtest: create-clear [422.342121] Subtest create-clear: SUCCESS (34.461s) [422.451934] [127/153] (602s left) kms_big_fb (linear-16bpp-rotate-270) [422.565189] Starting subtest: linear-16bpp-rotate-270 [422.584283] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [422.701628] [128/153] (601s left) gem_exec_params (invalid-ring) [422.764960] Starting subtest: invalid-ring [422.767263] Subtest invalid-ring: SUCCESS (0.000s) [422.878251] [129/153] (601s left) sw_sync (sync_multi_consumer_producer) [422.914417] Starting subtest: sync_multi_consumer_producer [423.208440] Subtest sync_multi_consumer_producer: SUCCESS (0.293s) [423.268892] [130/153] (601s left) kms_universal_plane (universal-plane-functional) [423.353115] Starting subtest: universal-plane-functional [423.355389] Starting dynamic subtest: pipe-A-eDP-1 [427.200102] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.849s) [427.210954] Starting dynamic subtest: pipe-B-eDP-1 [431.671502] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.472s) [431.682334] Starting dynamic subtest: pipe-C-eDP-1 [436.027484] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.355s) [436.037616] Starting dynamic subtest: pipe-D-eDP-1 [440.333482] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.301s) [440.335571] Subtest universal-plane-functional: SUCCESS (16.984s) [441.214777] [131/153] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4) [441.328645] Starting subtest: fbcpsrhdr-tiling-4 [441.332576] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s) [441.427273] [132/153] (583s left) kms_color_pipeline (plane-lut1d-ctm3x4) [441.515941] Starting subtest: plane-lut1d-ctm3x4 [441.685280] Starting dynamic subtest: pipe-A-plane-0 [441.828281] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [441.838356] Starting dynamic subtest: pipe-A-plane-1 [441.962979] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [441.972772] Starting dynamic subtest: pipe-A-plane-2 [442.150717] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s) [443.304151] Starting dynamic subtest: pipe-B-plane-0 [443.440065] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [443.450491] Starting dynamic subtest: pipe-B-plane-1 [443.573698] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s) [443.583559] Starting dynamic subtest: pipe-B-plane-2 [443.707069] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [444.860701] Starting dynamic subtest: pipe-C-plane-0 [444.983846] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s) [444.993719] Starting dynamic subtest: pipe-C-plane-1 [445.128421] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [445.138503] Starting dynamic subtest: pipe-C-plane-2 [445.274286] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s) [446.485553] Starting dynamic subtest: pipe-D-plane-0 [446.610586] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [446.622117] Starting dynamic subtest: pipe-D-plane-1 [446.743919] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s) [446.753394] Starting dynamic subtest: pipe-D-plane-2 [446.888414] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s) [447.172945] Subtest plane-lut1d-ctm3x4: SUCCESS (5.656s) [448.064789] [133/153] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [448.171709] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [448.175683] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [448.265885] [134/153] (576s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [448.362118] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [448.366470] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [448.451311] [135/153] (576s left) kms_async_flips (crc-atomic) [448.546311] Starting subtest: crc-atomic [448.923486] Starting dynamic subtest: pipe-A-eDP-1 [451.856331] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s) [452.233855] Starting dynamic subtest: pipe-B-eDP-1 [455.088392] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s) [455.462633] Starting dynamic subtest: pipe-C-eDP-1 [458.315558] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.862s) [458.689731] Starting dynamic subtest: pipe-D-eDP-1 [461.550186] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s) [461.552537] Subtest crc-atomic: SUCCESS (13.005s) [462.729619] [136/153] (562s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [462.843730] Starting subtest: hdr-rgb565-draw-mmap-cpu [462.847769] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [462.952063] [137/153] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [463.046682] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [463.051285] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [463.147933] [138/153] (561s left) kms_getfb (getfb-reject-nv12) [463.228293] Starting subtest: getfb-reject-nv12 [463.230499] Subtest getfb-reject-nv12: SUCCESS (0.001s) [463.339754] [139/153] (561s left) kms_invalid_mode (zero-clock) [463.435042] Starting subtest: zero-clock [463.437222] Starting dynamic subtest: pipe-A-eDP-1 [463.718361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [463.727738] Starting dynamic subtest: pipe-B-eDP-1 [463.729630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [463.738082] Starting dynamic subtest: pipe-C-eDP-1 [463.739963] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [463.748828] Starting dynamic subtest: pipe-D-eDP-1 [463.750989] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [463.753155] Subtest zero-clock: SUCCESS (0.291s) [464.541113] [140/153] (560s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc) [464.652950] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc [464.657483] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [464.751692] [141/153] (560s left) kms_flip (2x-flip-vs-dpms) [464.851955] Starting subtest: 2x-flip-vs-dpms [464.861308] Subtest 2x-flip-vs-dpms: SKIP (0.010s) [464.939288] [142/153] (560s left) gem_compute (compute-square) [464.996542] Starting subtest: compute-square [464.999882] Subtest compute-square: SUCCESS (0.006s) [465.100363] [143/153] (560s left) kms_frontbuffer_tracking (fbchdr-tiling-linear) [465.195673] Starting subtest: fbchdr-tiling-linear [465.199821] Subtest fbchdr-tiling-linear: SKIP (0.000s) [465.296032] [144/153] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [465.386571] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [465.390802] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [465.477321] [145/153] (559s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [465.584112] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [465.587402] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [465.691953] [146/153] (559s left) gem_ctx_param (basic) [465.743713] Starting subtest: basic [465.745738] Subtest basic: SUCCESS (0.001s) [465.849093] [147/153] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [465.948013] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [473.203543] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.261s) [473.319863] [148/153] (552s left) gem_wait (busy) [473.391240] Starting subtest: busy [473.393498] Starting dynamic subtest: all-engines [475.391306] Dynamic subtest all-engines: SUCCESS (1.998s) [475.401397] Starting dynamic subtest: rcs0 [475.933770] Dynamic subtest rcs0: SUCCESS (0.542s) [475.944489] Starting dynamic subtest: bcs0 [476.474350] Dynamic subtest bcs0: SUCCESS (0.539s) [476.486368] Starting dynamic subtest: vcs0 [478.399751] Dynamic subtest vcs0: SUCCESS (1.923s) [478.411465] Starting dynamic subtest: vcs1 [480.382892] Dynamic subtest vcs1: SUCCESS (1.981s) [480.394866] Starting dynamic subtest: vecs0 [482.367423] Dynamic subtest vecs0: SUCCESS (1.983s) [482.379393] Starting dynamic subtest: ccs0 [482.910146] Dynamic subtest ccs0: SUCCESS (0.541s) [482.913092] Subtest busy: SUCCESS (9.521s) [483.106850] [149/153] (542s left) gem_exec_whisper (basic-queues-forked) [483.173252] Starting subtest: basic-queues-forked [507.548335] Subtest basic-queues-forked: SUCCESS (24.372s) [507.742017] [150/153] (517s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [507.859863] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area [507.864386] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [507.943749] [151/153] (517s left) gen3_render_linear_blits [508.068315] [152/153] (517s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [508.118862] Starting subtest: multi-wait-for-submit-available-submitted-signaled [508.121042] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [508.227921] [153/153] (517s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [508.312491] Starting subtest: x-tiled-addfb-size-offset-overflow [508.314837] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [508.405021] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_addfb_basic results: parsing output: 3/ for test: gem_fence_thrash results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_getfb results: parsing output: 8/ for test: gen9_exec_parse results: parsing output: 9/ for test: syncobj_wait results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_content_protection results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_feature_discovery results: parsing output: 15/ for test: kms_fence_pin_leak results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_plane_alpha_blend results: parsing output: 19/ for test: i915_fb_tiling results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_psr results: parsing output: 26/ for test: kms_chamelium_hpd results: parsing output: 27/ for test: kms_plane_scaling results: parsing output: 28/ for test: perf_pmu results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_lease results: parsing output: 31/ for test: kms_flip_scaled_crc results: parsing output: 32/ for test: gem_softpin results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: template results: parsing output: 36/ for test: gem_flink_basic results: parsing output: 37/ for test: kms_dither results: parsing output: 38/ for test: gem_exec_flush results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: sriov_basic results: parsing output: 43/ for test: kms_chamelium_edid results: parsing output: 44/ for test: i915_pm_rps results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_psr2_sf results: parsing output: 47/ for test: gem_exec_fence results: parsing output: 48/ for test: kms_async_flips results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: gen9_exec_parse results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: gem_render_copy results: parsing output: 56/ for test: syncobj_wait results: parsing output: 57/ for test: gem_exec_reloc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: gem_exec_params results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: gem_basic results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_eio results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: gem_partial_pwrite_pread results: parsing output: 68/ for test: gem_userptr_blits results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_flip results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_vblank results: parsing output: 75/ for test: kms_plane results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: api_intel_bb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_prime results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: gem_exec_schedule results: parsing output: 88/ for test: gem_exec_basic results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_cdclk results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_pipe_b_c_ivb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_properties results: parsing output: 95/ for test: gem_exec_fence results: parsing output: 96/ for test: i915_suspend results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_fenced_exec_thrash results: parsing output: 100/ for test: syncobj_basic results: parsing output: 101/ for test: fbdev results: parsing output: 102/ for test: kms_plane_scaling results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_cursor_crc results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: kms_selftest results: parsing output: 112/ for test: gem_exec_suspend results: parsing output: 113/ for test: gem_ctx_persistence results: parsing output: 114/ for test: gem_pxp results: parsing output: 115/ for test: api_intel_allocator results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: kms_pm_rpm results: parsing output: 118/ for test: gem_mmap_gtt results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_mmap_gtt results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_plane results: parsing output: 124/ for test: gem_exec_params results: parsing output: 125/ for test: dumb_buffer results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: gem_exec_params results: parsing output: 128/ for test: sw_sync results: parsing output: 129/ for test: kms_universal_plane results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_color_pipeline results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: kms_async_flips results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_getfb results: parsing output: 138/ for test: kms_invalid_mode results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_flip results: parsing output: 141/ for test: gem_compute results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: gem_ctx_param results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gem_wait results: parsing output: 148/ for test: gem_exec_whisper results: parsing output: 149/ for test: kms_psr2_sf results: parsing output: 150/ for test: gen3_render_linear_blits results: parsing output: 151/ for test: syncobj_timeline results: parsing output: 152/ for test: kms_big_fb Done.