[149.139601] Initializing watchdogs [149.139717] /dev/watchdog0 [149.194516] [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] [149.198813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [149.201265] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [149.204805] [001/156] (960s left) kms_plane_scaling (invalid-parameters) [149.330708] Starting subtest: invalid-parameters [149.333052] Starting dynamic subtest: less-than-1-height-src [149.345588] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s) [149.354292] Starting dynamic subtest: less-than-1-width-src [149.359324] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s) [149.361491] Subtest invalid-parameters: SUCCESS (0.030s) [149.460795] [002/156] (960s left) kms_lease (lease-unleased-connector) [149.543258] Starting subtest: lease-unleased-connector [149.545638] Starting dynamic subtest: pipe-A-eDP-1 [149.551078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s) [149.559257] Starting dynamic subtest: pipe-B-eDP-1 [149.561501] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s) [149.569773] Starting dynamic subtest: pipe-C-eDP-1 [149.572231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s) [149.579938] Starting dynamic subtest: pipe-D-eDP-1 [149.582190] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [149.584301] Subtest lease-unleased-connector: SUCCESS (0.033s) [149.692565] [003/156] (960s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [150.074356] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [150.931785] [004/156] (958s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary) [151.033147] Starting subtest: fbchdr-indfb-scaledprimary [151.037431] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s) [151.113651] [005/156] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [151.229602] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [158.148460] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.924s) [158.269565] [006/156] (951s left) kms_big_fb (linear-64bpp-rotate-180) [158.368060] Starting subtest: linear-64bpp-rotate-180 [159.912222] Subtest linear-64bpp-rotate-180: SUCCESS (1.545s) [160.066603] [007/156] (949s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [160.168515] Starting subtest: fbcpsr-farfromfence-mmap-gtt [160.172604] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [160.262172] [008/156] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [160.359746] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [160.363403] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [160.449202] [009/156] (949s left) gem_softpin (evict-single-offset) [160.515500] Starting subtest: evict-single-offset [188.287586] Subtest evict-single-offset: SUCCESS (27.769s) [188.368887] [010/156] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [188.501818] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [195.412805] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.915s) [195.561043] [011/156] (914s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [195.659566] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [196.727259] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s) [196.859682] [012/156] (913s left) gem_caching (writes) [196.922057] Subtest writes: SKIP (0.000s) [196.993019] [013/156] (913s left) gem_ctx_shared (q-independent) [197.048340] Starting subtest: Q-independent [197.050409] Starting dynamic subtest: rcs0 [197.126032] Dynamic subtest rcs0: SUCCESS (0.077s) [197.138814] Starting dynamic subtest: vcs0 [197.170527] Dynamic subtest vcs0: SUCCESS (0.044s) [197.178566] Starting dynamic subtest: vcs1 [197.217877] Dynamic subtest vcs1: SUCCESS (0.048s) [197.226519] Starting dynamic subtest: vecs0 [197.259827] Dynamic subtest vecs0: SUCCESS (0.041s) [197.269847] Starting dynamic subtest: ccs0 [197.309829] Dynamic subtest ccs0: SUCCESS (0.049s) [197.312280] Subtest Q-independent: SUCCESS (0.261s) [198.349859] [014/156] (911s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [198.443824] Starting subtest: fbc-rgb565-draw-blt [202.589821] Subtest fbc-rgb565-draw-blt: SUCCESS (4.153s) [203.828115] [015/156] (906s left) gem_mmap_gtt (big-bo-tiledx) [203.894400] Subtest big-bo-tiledX: SKIP (0.000s) [203.950954] [016/156] (906s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt) [204.049602] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt [204.053747] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [204.140205] [017/156] (906s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [204.183827] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [204.186189] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [204.261747] [018/156] (906s left) kms_psr (pr-sprite-plane-move) [204.353148] Starting subtest: pr-sprite-plane-move [204.357257] Subtest pr-sprite-plane-move: SKIP (0.000s) [204.421729] [019/156] (905s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render) [204.526267] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render [204.530453] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [204.638052] [020/156] (905s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [204.719655] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [204.724115] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [204.787646] [021/156] (905s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc) [204.877340] Starting subtest: psrhdr-rgb101010-draw-mmap-wc [204.881078] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [204.966177] [022/156] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [205.066751] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [211.858062] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.795s) [211.980489] [023/156] (898s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [212.094306] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [212.098274] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [212.187092] [024/156] (898s left) gem_eio (in-flight-external) [212.419868] Starting subtest: in-flight-external [214.342873] Subtest in-flight-external: SUCCESS (1.924s) [214.467406] [025/156] (896s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [214.566239] Starting subtest: yf-tiled-64bpp-rotate-270 [214.570106] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [214.674256] [026/156] (895s left) gem_mmap_gtt (basic-short) [214.736464] Subtest basic-short: SKIP (0.000s) [214.800132] [027/156] (895s left) kms_dsc (dsc-with-output-formats) [214.894434] Starting subtest: dsc-with-output-formats [214.898983] Subtest dsc-with-output-formats: SKIP (0.000s) [214.973704] [028/156] (895s left) kms_psr (fbc-pr-sprite-mmap-cpu) [215.086596] Starting subtest: fbc-pr-sprite-mmap-cpu [215.091370] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [215.153733] [029/156] (895s left) syncobj_timeline (multi-wait-all-available-signaled) [215.215039] Starting subtest: multi-wait-all-available-signaled [215.217460] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [215.302652] [030/156] (895s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [215.398950] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [215.402526] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [215.489111] [031/156] (895s left) gem_exec_balancer (parallel-bb-first) [215.750196] Starting subtest: parallel-bb-first [216.680728] Subtest parallel-bb-first: SUCCESS (0.931s) [217.336958] [032/156] (893s left) kms_lease (lease-get) [217.434205] Starting subtest: lease-get [217.436658] Starting dynamic subtest: pipe-A-eDP-1 [217.439152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [217.449516] Starting dynamic subtest: pipe-B-eDP-1 [217.451422] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [217.460088] Starting dynamic subtest: pipe-C-eDP-1 [217.462021] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [217.470233] Starting dynamic subtest: pipe-D-eDP-1 [217.472148] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [217.474076] Subtest lease-get: SUCCESS (0.007s) [217.544206] [033/156] (893s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [217.650088] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt [217.654278] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [217.747277] [034/156] (893s left) gen7_exec_parse (chained-batch) [217.802569] Subtest chained-batch: SKIP (0.000s) [217.877225] [035/156] (893s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move) [217.974598] Starting subtest: hdr-2p-primscrn-cur-indfb-move [217.978905] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [218.078618] [036/156] (892s left) gem_exec_reloc (basic-wc-cpu-noreloc) [218.148078] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [218.234872] [037/156] (892s left) kms_feature_discovery (display-4x) [218.333189] Starting subtest: display-4x [218.336928] Subtest display-4x: SKIP (0.000s) [218.403770] [038/156] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [218.496430] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [218.499801] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [218.580402] [039/156] (892s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [218.644546] Starting subtest: y-tiled-ccs-to-yf-tiled [218.648442] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [218.837894] [040/156] (892s left) i915_pm_rpm (debugfs-forcewake-user) [220.473954] Starting subtest: debugfs-forcewake-user [231.861647] Subtest debugfs-forcewake-user: SUCCESS (11.389s) [232.256968] [041/156] (878s left) kms_content_protection (dp-mst-lic-type-0) [232.403262] Starting subtest: dp-mst-lic-type-0 [232.407984] Subtest dp-mst-lic-type-0: SKIP (0.000s) [232.526623] [042/156] (878s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [232.623868] Starting subtest: fbc-psr2-cursor-plane-update-sf [232.626122] Starting dynamic subtest: pipe-A-eDP-1 [232.696312] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s) [232.706074] Starting dynamic subtest: pipe-B-eDP-1 [233.826101] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [233.830424] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.207s) [235.042957] [043/156] (876s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [235.138024] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [235.140449] Starting dynamic subtest: pipe-A-default-mode [236.300150] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [236.304667] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.160s) [236.430101] [044/156] (874s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [236.550236] Starting subtest: cursorB-vs-flipB-toggle [236.554737] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [236.716210] [045/156] (874s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt) [236.806226] Starting subtest: fbc-rgb101010-draw-mmap-gtt [236.810167] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s) [236.884065] [046/156] (874s left) gem_pxp (verify-pxp-stale-buf-optout-execution) [237.003119] Starting subtest: verify-pxp-stale-buf-optout-execution [238.062581] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s) [238.174861] [047/156] (873s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt) [238.273825] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt [238.277992] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [238.375766] [048/156] (873s left) gem_ccs (block-multicopy-inplace) [238.425077] Starting subtest: block-multicopy-inplace [238.429787] Subtest block-multicopy-inplace: SKIP (0.000s) [238.545542] [049/156] (873s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [238.647799] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [238.649706] Starting dynamic subtest: pipe-A-eDP-1 [254.917680] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.287s) [254.931592] Starting dynamic subtest: pipe-B-eDP-1 [271.932503] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.470s) [271.943719] Starting dynamic subtest: pipe-C-eDP-1 [288.866508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.391s) [288.877548] Starting dynamic subtest: pipe-D-eDP-1 [305.845324] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.335s) [305.847875] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.487s) [307.075719] [050/156] (804s left) gem_ppgtt (blt-vs-render-ctxn) [307.138308] Starting subtest: blt-vs-render-ctxN [340.081208] Subtest blt-vs-render-ctxN: SUCCESS (32.737s) [340.223375] [051/156] (771s left) gem_exec_fence (syncobj-timeline-chain-engines) [340.869718] Starting subtest: syncobj-timeline-chain-engines [341.055167] Subtest syncobj-timeline-chain-engines: SUCCESS (0.185s) [341.877907] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [341.881179] [052/156] (769s left) kms_vblank (query-busy-hang) [341.975221] Starting subtest: query-busy-hang [341.977076] Starting dynamic subtest: pipe-A-eDP-1 [368.560323] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.582s) [368.579807] Starting dynamic subtest: pipe-D-eDP-1 [383.602586] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s) [383.604889] Subtest query-busy-hang: SUCCESS (41.620s) [384.434754] [053/156] (727s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [384.483441] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [384.592859] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s) [384.671425] [054/156] (727s left) gem_userptr_blits (create-destroy-sync) [384.726683] Starting subtest: create-destroy-sync [389.747142] Subtest create-destroy-sync: SUCCESS (5.015s) [389.877845] [055/156] (721s left) gem_ctx_engines (execute-oneforall) [389.947223] Starting subtest: execute-oneforall [390.923186] Subtest execute-oneforall: SUCCESS (0.974s) [391.898732] [056/156] (719s left) syncobj_basic (test-valid-cycle) [391.943664] Starting subtest: test-valid-cycle [391.945676] Subtest test-valid-cycle: SUCCESS (0.000s) [392.065440] [057/156] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [392.183026] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [399.588824] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.407s) [399.728234] [058/156] (712s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [399.827319] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [399.829689] Starting dynamic subtest: pipe-A-eDP-1 [405.769161] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.945s) [405.780232] Starting dynamic subtest: pipe-B-eDP-1 [412.435641] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.670s) [412.438031] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.618s) [413.297608] [059/156] (698s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [413.400292] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [420.555758] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.161s) [420.695696] [060/156] (691s left) api_intel_bb (simple-bb) [420.752889] Starting subtest: simple-bb [420.758063] Subtest simple-bb: SUCCESS (0.007s) [420.887033] [061/156] (691s left) gem_ctx_persistence (legacy-engines-hostile) [420.939840] Starting subtest: legacy-engines-hostile [420.942192] Starting dynamic subtest: render [421.069437] Dynamic subtest render: SUCCESS (0.128s) [421.082443] Starting dynamic subtest: bsd1 [421.171739] Dynamic subtest bsd1: SUCCESS (0.100s) [421.188336] Starting dynamic subtest: bsd2 [421.278357] Dynamic subtest bsd2: SUCCESS (0.102s) [421.292302] Starting dynamic subtest: blt [421.351554] Dynamic subtest blt: SUCCESS (0.070s) [421.364734] Starting dynamic subtest: vebox [421.505951] Dynamic subtest vebox: SUCCESS (0.152s) [421.508357] Subtest legacy-engines-hostile: SUCCESS (0.567s) [421.589278] [062/156] (690s left) gem_create (create-invalid-size) [421.647350] Starting subtest: create-invalid-size [421.649183] Subtest create-invalid-size: SUCCESS (0.000s) [421.838505] [063/156] (690s left) kms_big_fb (x-tiled-64bpp-rotate-270) [421.940133] Starting subtest: x-tiled-64bpp-rotate-270 [421.960034] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [422.085591] [064/156] (690s left) gem_mmap_offset (close-race) [422.134543] Starting subtest: close-race [442.235671] Subtest close-race: SUCCESS (20.101s) [442.372229] [065/156] (669s left) gem_exec_reloc (basic-write-cpu-active) [442.448815] Subtest basic-write-cpu-active: SKIP (0.000s) [442.525448] [066/156] (669s left) kms_plane_multiple (tiling-none) [442.628259] Starting subtest: tiling-none [442.630151] Starting dynamic subtest: pipe-A-eDP-1 [446.566783] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.938s) [446.578721] Starting dynamic subtest: pipe-B-eDP-1 [451.225855] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.658s) [451.239283] Starting dynamic subtest: pipe-C-eDP-1 [455.748818] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.521s) [455.759912] Starting dynamic subtest: pipe-D-eDP-1 [460.390725] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.639s) [460.393035] Subtest tiling-none: SUCCESS (17.761s) [461.202778] [067/156] (651s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [461.311954] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [461.316279] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [461.434431] [068/156] (650s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt) [461.539756] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt [461.543802] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [461.650660] [069/156] (650s left) kms_flip (nonblocking-read) [461.744998] Starting subtest: nonblocking-read [461.747834] Subtest nonblocking-read: SUCCESS (0.000s) [461.848842] [070/156] (650s left) gem_exec_schedule (u-submit-early-slice) [461.924120] Starting subtest: u-submit-early-slice [461.926232] Starting dynamic subtest: rcs0 [461.953629] Dynamic subtest rcs0: SUCCESS (0.039s) [461.966283] Starting dynamic subtest: bcs0 [461.987754] Dynamic subtest bcs0: SUCCESS (0.033s) [461.998603] Starting dynamic subtest: vcs0 [462.028359] Dynamic subtest vcs0: SUCCESS (0.040s) [462.039998] Starting dynamic subtest: vcs1 [462.067899] Dynamic subtest vcs1: SUCCESS (0.039s) [462.078881] Starting dynamic subtest: vecs0 [462.107981] Dynamic subtest vecs0: SUCCESS (0.039s) [462.119891] Starting dynamic subtest: ccs0 [462.148687] Dynamic subtest ccs0: SUCCESS (0.040s) [462.150545] Subtest u-submit-early-slice: SUCCESS (0.235s) [463.899065] [071/156] (648s left) kms_psr (fbc-psr-cursor-plane-move) [463.992500] Starting subtest: fbc-psr-cursor-plane-move [463.994817] Starting dynamic subtest: eDP-1 [463.999223] Dynamic subtest eDP-1: SKIP (0.000s) [464.003556] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s) [464.088338] [072/156] (648s left) gem_mmap_gtt (basic-write-gtt) [464.137693] Subtest basic-write-gtt: SKIP (0.000s) [464.195336] [073/156] (648s left) sysfs_timeslice_duration (duration) [464.250019] Starting subtest: duration [464.252443] Starting dynamic subtest: vecs0 [478.796226] Dynamic subtest vecs0: SUCCESS (14.540s) [478.812268] Starting dynamic subtest: ccs0 [491.957722] Dynamic subtest ccs0: SUCCESS (13.157s) [491.971981] Starting dynamic subtest: vcs0 [505.739863] Dynamic subtest vcs0: SUCCESS (13.774s) [505.753104] Starting dynamic subtest: bcs0 [518.880237] Dynamic subtest bcs0: SUCCESS (13.136s) [518.894440] Starting dynamic subtest: rcs0 [532.021566] Dynamic subtest rcs0: SUCCESS (13.137s) [532.035137] Starting dynamic subtest: vcs1 [546.702447] Dynamic subtest vcs1: SUCCESS (14.677s) [546.705421] Subtest duration: SUCCESS (82.436s) [546.794654] [074/156] (565s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt) [546.899053] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt [546.903512] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [546.995623] [075/156] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [547.103993] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [550.839150] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.742s) [552.016109] [076/156] (560s left) kms_async_flips (crc-atomic) [552.106242] Starting subtest: crc-atomic [552.483478] Starting dynamic subtest: pipe-A-eDP-1 [555.415516] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.932s) [555.794713] Starting dynamic subtest: pipe-B-eDP-1 [558.726441] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.942s) [559.109907] Starting dynamic subtest: pipe-C-eDP-1 [562.089641] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.992s) [562.469068] Starting dynamic subtest: pipe-D-eDP-1 [565.389404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.935s) [565.391816] Subtest crc-atomic: SUCCESS (13.287s) [566.547619] [077/156] (546s left) perf (invalid-oa-format-id) [566.693988] Starting subtest: invalid-oa-format-id [566.703430] Subtest invalid-oa-format-id: SUCCESS (0.010s) [566.748535] [078/156] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [566.801569] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [566.905164] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s) [566.994289] [079/156] (545s left) gem_exec_reloc (basic-cpu-gtt) [567.047494] Subtest basic-cpu-gtt: SKIP (0.000s) [567.138128] [080/156] (545s left) api_intel_allocator (alloc-simple) [567.192427] Starting subtest: alloc-simple [567.195152] Subtest alloc-simple: SUCCESS (0.003s) [567.314296] [081/156] (545s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [567.416642] Starting subtest: primary-yf-tiled-reflect-x-90 [567.420902] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [567.502652] [082/156] (545s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [567.594589] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [567.596996] Starting dynamic subtest: pipe-A-eDP-1 [567.656233] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [567.666983] Starting dynamic subtest: pipe-B-eDP-1 [567.723978] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [567.736131] Starting dynamic subtest: pipe-C-eDP-1 [567.795527] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [567.807162] Starting dynamic subtest: pipe-D-eDP-1 [567.863725] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [567.868001] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s) [569.895994] [083/156] (543s left) syncobj_wait (wait-zero-handles) [569.946477] Starting subtest: wait-zero-handles [569.948410] Subtest wait-zero-handles: SUCCESS (0.000s) [570.062133] [084/156] (543s left) kms_cursor_crc (cursor-offscreen-256x256) [570.302155] Starting subtest: cursor-offscreen-256x256 [570.304431] Starting dynamic subtest: pipe-A-eDP-1 [572.250607] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s) [572.281305] Starting dynamic subtest: pipe-D-eDP-1 [574.909414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.638s) [574.912020] Subtest cursor-offscreen-256x256: SUCCESS (4.610s) [575.754527] [085/156] (537s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [575.850493] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [575.862954] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s) [575.941464] [086/156] (537s left) gem_ctx_param (invalid-size-set) [575.990197] Starting subtest: invalid-size-set [575.992491] Subtest invalid-size-set: SUCCESS (0.001s) [576.088515] [087/156] (537s left) kms_big_fb (y-tiled-8bpp-rotate-180) [576.186479] Starting subtest: y-tiled-8bpp-rotate-180 [576.190933] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [576.291612] [088/156] (536s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [576.397412] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [576.401711] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [576.484999] [089/156] (536s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [576.578737] Starting subtest: bad-pixel-format-y-tiled-ccs [576.581103] Starting dynamic subtest: pipe-A-eDP-1 [576.603950] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [576.617220] Starting dynamic subtest: pipe-B-eDP-1 [576.639177] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [576.652401] Starting dynamic subtest: pipe-C-eDP-1 [576.672859] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [576.683599] Starting dynamic subtest: pipe-D-eDP-1 [576.701292] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [576.704810] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [578.834736] [090/156] (534s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [578.928713] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [585.566570] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.643s) [585.696466] [091/156] (527s left) syncobj_wait (reset-during-wait-for-submit) [585.747173] Starting subtest: reset-during-wait-for-submit [585.850993] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [585.942146] [092/156] (527s left) i915_hangman (error-state-basic) [586.000201] Starting subtest: error-state-basic [586.131136] Subtest error-state-basic: SUCCESS (0.133s) [586.208260] [093/156] (527s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [586.341259] Starting subtest: basic-busy-flip-before-cursor-varying-size [586.345596] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [586.486260] [094/156] (527s left) gem_exec_schedule (pi-ringfull) [586.660421] Starting subtest: pi-ringfull [586.662710] Starting dynamic subtest: rcs0 [586.698076] Dynamic subtest rcs0: SUCCESS (0.042s) [586.709812] Starting dynamic subtest: bcs0 [586.740294] Dynamic subtest bcs0: SUCCESS (0.041s) [586.751365] Starting dynamic subtest: vcs0 [586.776170] Dynamic subtest vcs0: SUCCESS (0.035s) [586.791825] Starting dynamic subtest: vcs1 [586.811592] Dynamic subtest vcs1: SUCCESS (0.035s) [586.826289] Starting dynamic subtest: vecs0 [586.842605] Dynamic subtest vecs0: SUCCESS (0.030s) [586.858152] Starting dynamic subtest: ccs0 [586.872163] Dynamic subtest ccs0: SUCCESS (0.029s) [586.874445] Subtest pi-ringfull: SUCCESS (0.217s) [587.109161] [095/156] (526s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [587.210677] Starting subtest: plane-scaler-with-clipping-clamping-rotation [587.212818] Starting dynamic subtest: pipe-A [587.447737] Dynamic subtest pipe-A: SUCCESS (0.241s) [587.461442] Starting dynamic subtest: pipe-B [588.738234] Dynamic subtest pipe-B: SUCCESS (1.290s) [588.750252] Starting dynamic subtest: pipe-C [590.054761] Dynamic subtest pipe-C: SUCCESS (1.316s) [590.066453] Starting dynamic subtest: pipe-D [591.402365] Dynamic subtest pipe-D: SUCCESS (1.347s) [591.404750] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.196s) [592.565439] [096/156] (521s left) kms_flip (2x-modeset-vs-vblank-race) [592.658852] Starting subtest: 2x-modeset-vs-vblank-race [592.669961] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s) [592.748680] [097/156] (520s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt) [592.858022] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt [592.862473] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [592.968740] [098/156] (520s left) kms_setmode (clone-exclusive-crtc) [593.019836] Starting subtest: clone-exclusive-crtc [593.026562] Subtest clone-exclusive-crtc: SKIP (0.000s) [593.140089] [099/156] (520s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [593.222891] Starting subtest: primary-4-tiled-reflect-x-0 [600.283330] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.060s) [601.545764] [100/156] (512s left) gem_mmap_wc (read-write) [601.605778] Subtest read-write: SKIP (0.000s) [601.674999] [101/156] (512s left) kms_psr (pr-cursor-render) [601.768666] Starting subtest: pr-cursor-render [601.773012] Subtest pr-cursor-render: SKIP (0.000s) [601.842763] [102/156] (512s left) gem_exec_flush (basic-batch-kernel-default-cmd) [601.901785] Starting subtest: basic-batch-kernel-default-cmd [601.906093] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [602.090817] [103/156] (511s left) kms_vrr (flipline) [602.179630] Starting subtest: flipline [602.185955] Subtest flipline: SKIP (0.000s) [602.252951] [104/156] (511s left) kms_prop_blob (blob-multiple) [602.301505] Starting subtest: blob-multiple [602.303816] Subtest blob-multiple: SUCCESS (0.003s) [602.430949] [105/156] (511s left) sw_sync (sync_multi_consumer_producer) [602.465647] Starting subtest: sync_multi_consumer_producer [602.747250] Subtest sync_multi_consumer_producer: SUCCESS (0.281s) [602.810292] [106/156] (511s left) perf (global-sseu-config-invalid) [602.911265] Starting subtest: global-sseu-config-invalid [602.916121] Subtest global-sseu-config-invalid: SKIP (0.000s) [602.957064] [107/156] (511s left) gem_exec_params (rel-constants-invalid-rel-gen5) [603.028957] Starting subtest: rel-constants-invalid-rel-gen5 [603.031323] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [603.156442] [108/156] (510s left) gem_render_copy_redux (normal) [603.204137] Starting subtest: normal [603.497826] Subtest normal: SUCCESS (0.297s) [603.627339] [109/156] (510s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [603.730151] Starting subtest: psr-rgb565-draw-blt [610.887728] Subtest psr-rgb565-draw-blt: SUCCESS (7.162s) [611.026919] [110/156] (503s left) kms_dp_linktrain_fallback (dp-fallback) [611.126535] Starting subtest: dp-fallback [611.133588] Subtest dp-fallback: SKIP (0.000s) [611.203578] [111/156] (503s left) gem_mmap_wc (coherency) [611.264088] Subtest coherency: SKIP (0.000s) [611.330525] [112/156] (502s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt) [611.429411] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt [611.433568] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [611.541203] [113/156] (502s left) i915_drm_fdinfo (memory-info-shared) [611.582996] Starting subtest: memory-info-shared [611.584957] Starting dynamic subtest: smem0 [611.651451] Dynamic subtest smem0: SUCCESS (0.070s) [611.654388] Subtest memory-info-shared: SUCCESS (0.071s) [611.726301] [114/156] (502s left) core_getversion (basic) [611.766678] Starting subtest: basic [611.770869] Subtest basic: SUCCESS (0.000s) [611.825417] [115/156] (502s left) kms_ccs (random-ccs-data-yf-tiled-ccs) [611.912557] Starting subtest: random-ccs-data-yf-tiled-ccs [611.914459] Starting dynamic subtest: pipe-A-eDP-1 [611.937740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [611.949457] Starting dynamic subtest: pipe-B-eDP-1 [611.968094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [611.978224] Starting dynamic subtest: pipe-C-eDP-1 [611.997285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [612.007298] Starting dynamic subtest: pipe-D-eDP-1 [612.027089] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [612.030652] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s) [614.221382] [116/156] (500s left) kms_frontbuffer_tracking (fbc-tiling-4) [614.320761] Starting subtest: fbc-tiling-4 [618.547486] Subtest fbc-tiling-4: SUCCESS (4.231s) [619.737173] [117/156] (494s left) kms_rotation_crc (primary-rotation-270) [619.825577] Starting subtest: primary-rotation-270 [619.829769] Subtest primary-rotation-270: SKIP (0.001s) [619.900282] [118/156] (494s left) sriov_basic (enable-vfs-autoprobe-off) [619.964465] Starting subtest: enable-vfs-autoprobe-off [619.966813] Starting dynamic subtest: numvfs-1 [619.971415] Dynamic subtest numvfs-1: SKIP (0.001s) [619.984547] Starting dynamic subtest: numvfs-2 [619.988602] Dynamic subtest numvfs-2: SKIP (0.001s) [619.999202] Starting dynamic subtest: numvfs-3 [620.003346] Dynamic subtest numvfs-3: SKIP (0.001s) [620.015581] Starting dynamic subtest: numvfs-4 [620.019770] Dynamic subtest numvfs-4: SKIP (0.000s) [620.033657] Starting dynamic subtest: numvfs-5 [620.038166] Dynamic subtest numvfs-5: SKIP (0.000s) [620.048364] Starting dynamic subtest: numvfs-6 [620.052509] Dynamic subtest numvfs-6: SKIP (0.000s) [620.062555] Starting dynamic subtest: numvfs-7 [620.066575] Dynamic subtest numvfs-7: SKIP (0.000s) [620.076712] Starting dynamic subtest: numvfs-random [620.080771] Dynamic subtest numvfs-random: SKIP (0.000s) [620.091041] Starting dynamic subtest: numvfs-all [620.095162] Dynamic subtest numvfs-all: SKIP (0.000s) [620.099253] Subtest enable-vfs-autoprobe-off: SKIP (0.011s) [620.139548] [119/156] (494s left) kms_cursor_crc (cursor-rapid-movement-64x21) [620.340496] Starting subtest: cursor-rapid-movement-64x21 [620.388867] Subtest cursor-rapid-movement-64x21: SKIP (0.043s) [620.638640] [120/156] (494s left) perf_pmu (render-node-busy-idle) [620.716006] Starting subtest: render-node-busy-idle [620.718048] Starting dynamic subtest: rcs0 [621.386693] Dynamic subtest rcs0: SUCCESS (0.669s) [621.401603] Starting dynamic subtest: bcs0 [622.053380] Dynamic subtest bcs0: SUCCESS (0.664s) [622.067970] Starting dynamic subtest: vcs0 [623.788648] Dynamic subtest vcs0: SUCCESS (1.731s) [623.803333] Starting dynamic subtest: vcs1 [625.837697] Dynamic subtest vcs1: SUCCESS (2.046s) [625.854422] Starting dynamic subtest: vecs0 [627.822916] Dynamic subtest vecs0: SUCCESS (1.980s) [627.849555] Starting dynamic subtest: ccs0 [628.493005] Dynamic subtest ccs0: SUCCESS (0.668s) [628.495496] Subtest render-node-busy-idle: SUCCESS (7.776s) [628.570944] [121/156] (486s left) kms_async_flips (invalid-async-flip) [628.678126] Starting subtest: invalid-async-flip [629.051654] Starting dynamic subtest: pipe-A-eDP-1 [629.859958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.810s) [630.228834] Starting dynamic subtest: pipe-B-eDP-1 [631.074546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.862s) [631.451032] Starting dynamic subtest: pipe-C-eDP-1 [632.295496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.855s) [632.651955] Starting dynamic subtest: pipe-D-eDP-1 [633.430443] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.788s) [633.432952] Subtest invalid-async-flip: SUCCESS (4.754s) [634.604256] [122/156] (480s left) kms_getfb (getfb2-handle-protection) [634.702216] Starting subtest: getfb2-handle-protection [634.726741] Subtest getfb2-handle-protection: SUCCESS (0.025s) [634.844449] [123/156] (479s left) kms_flip (plain-flip-interruptible) [634.946711] Starting subtest: plain-flip-interruptible [634.948941] Starting dynamic subtest: A-eDP1 [636.583191] Dynamic subtest A-eDP1: SUCCESS (1.634s) [636.598532] Starting dynamic subtest: B-eDP1 [638.214537] Dynamic subtest B-eDP1: SUCCESS (1.630s) [638.229045] Starting dynamic subtest: C-eDP1 [639.833577] Dynamic subtest C-eDP1: SUCCESS (1.617s) [639.846752] Starting dynamic subtest: D-eDP1 [641.459995] Dynamic subtest D-eDP1: SUCCESS (1.625s) [641.465225] Subtest plain-flip-interruptible: SUCCESS (6.517s) [642.644776] [124/156] (472s left) gem_lmem_swapping (heavy-multi) [642.683651] Subtest heavy-multi: SKIP (0.000s) [642.731350] [125/156] (472s left) gem_ctx_param (invalid-set-ringsize) [642.775390] Starting subtest: invalid-set-ringsize [642.777723] Subtest invalid-set-ringsize: SUCCESS (0.000s) [642.849486] [126/156] (472s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [642.952055] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [642.956273] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [643.077096] [127/156] (471s left) gem_exec_reloc (basic-gtt-wc-noreloc) [643.134906] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [643.230562] [128/156] (471s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [643.277293] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [643.338793] [129/156] (471s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [643.446311] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [650.398917] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.955s) [650.536727] [130/156] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [650.647184] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [650.651078] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [650.738738] [131/156] (464s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [651.123883] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [651.979535] [132/156] (463s left) kms_flip (flip-vs-rmfb-interruptible) [652.067681] Starting subtest: flip-vs-rmfb-interruptible [652.069985] Starting dynamic subtest: A-eDP1 [660.696584] Dynamic subtest A-eDP1: SUCCESS (8.626s) [660.711465] Starting dynamic subtest: B-eDP1 [669.328260] Dynamic subtest B-eDP1: SUCCESS (8.626s) [669.343954] Starting dynamic subtest: C-eDP1 [677.948817] Dynamic subtest C-eDP1: SUCCESS (8.616s) [677.962153] Starting dynamic subtest: D-eDP1 [686.576848] Dynamic subtest D-eDP1: SUCCESS (8.624s) [686.581508] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.507s) [687.767334] [133/156] (427s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [687.863451] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt [687.867475] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [687.992894] [134/156] (427s left) gem_exec_fence (syncobj-wait) [688.420417] Starting subtest: syncobj-wait [689.836646] Subtest syncobj-wait: SUCCESS (1.413s) [690.181166] [135/156] (425s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [690.281921] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [690.286481] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [690.383042] [136/156] (424s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite) [690.490092] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite [690.494132] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [690.598194] [137/156] (424s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [690.649547] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [690.710095] [138/156] (424s left) kms_psr (psr-sprite-blt) [690.810089] Starting subtest: psr-sprite-blt [690.812632] Starting dynamic subtest: eDP-1 [692.576788] Dynamic subtest eDP-1: SUCCESS (1.767s) [692.579066] Subtest psr-sprite-blt: SUCCESS (1.768s) [693.433531] [139/156] (422s left) gem_exec_store (dword) [693.499439] Starting subtest: dword [693.501724] Starting dynamic subtest: rcs0 [693.553649] Dynamic subtest rcs0: SUCCESS (0.057s) [693.569589] Starting dynamic subtest: bcs0 [693.596152] Dynamic subtest bcs0: SUCCESS (0.041s) [693.608244] Starting dynamic subtest: vcs0 [693.637652] Dynamic subtest vcs0: SUCCESS (0.040s) [693.651705] Starting dynamic subtest: vcs1 [693.679441] Dynamic subtest vcs1: SUCCESS (0.040s) [693.691740] Starting dynamic subtest: vecs0 [693.721632] Dynamic subtest vecs0: SUCCESS (0.040s) [693.733525] Starting dynamic subtest: ccs0 [693.764819] Dynamic subtest ccs0: SUCCESS (0.041s) [693.767164] Subtest dword: SUCCESS (0.271s) [693.951216] [140/156] (421s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt) [694.057672] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt [694.061809] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [694.163216] [141/156] (421s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [694.280737] Starting subtest: basic-flip-after-cursor-legacy [695.196147] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.915s) [696.063720] [142/156] (419s left) kms_addfb_basic (unused-handle) [696.109489] Starting subtest: unused-handle [696.111785] Subtest unused-handle: SUCCESS (0.000s) [696.247463] [143/156] (419s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [696.341731] Starting subtest: ccs-on-another-bo-y-tiled-ccs [696.344691] Starting dynamic subtest: pipe-A-eDP-1 [696.370454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [696.384119] Starting dynamic subtest: pipe-B-eDP-1 [696.404469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [696.415900] Starting dynamic subtest: pipe-C-eDP-1 [696.436477] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [696.447658] Starting dynamic subtest: pipe-D-eDP-1 [696.468444] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [696.472404] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [698.614876] [144/156] (417s left) gem_watchdog (default-virtual) [698.685716] Starting subtest: default-virtual [704.957080] Subtest default-virtual: SUCCESS (6.279s) [705.053395] [145/156] (410s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear) [705.162624] Starting subtest: fbcpsrhdr-tiling-linear [705.166684] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s) [705.273010] [146/156] (410s left) kms_plane_lowres (tiling-yf) [705.356451] Starting subtest: tiling-yf [705.360449] Subtest tiling-yf: SKIP (0.000s) [705.430002] [147/156] (410s left) gem_exec_balancer (semaphore) [705.501162] Starting subtest: semaphore [706.793814] Subtest semaphore: SUCCESS (1.290s) [707.117355] [148/156] (408s left) kms_color (ctm-signed) [707.210800] Starting subtest: ctm-signed [707.212957] Starting dynamic subtest: pipe-A-eDP-1 [709.289412] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.081s) [709.301040] Starting dynamic subtest: pipe-B-eDP-1 [712.166384] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.873s) [712.177684] Starting dynamic subtest: pipe-C-eDP-1 [714.987627] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.820s) [715.000634] Starting dynamic subtest: pipe-D-eDP-1 [717.650470] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.661s) [717.653033] Subtest ctm-signed: SUCCESS (10.438s) [718.499414] [149/156] (397s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [718.601805] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [722.581627] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.985s) [723.770207] [150/156] (392s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [723.868940] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [723.873021] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [723.986764] [151/156] (392s left) gem_pxp (create-regular-context-1) [724.088501] Starting subtest: create-regular-context-1 [724.090923] Subtest create-regular-context-1: SUCCESS (0.002s) [724.209139] [152/156] (391s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [724.306344] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [724.310810] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [724.403647] [153/156] (391s left) kms_big_fb (4-tiled-addfb-size-overflow) [724.504908] Starting subtest: 4-tiled-addfb-size-overflow [724.507233] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [724.597128] [154/156] (391s left) kms_flip (flip-vs-expired-vblank-interruptible) [724.690534] Starting subtest: flip-vs-expired-vblank-interruptible [724.692422] Starting dynamic subtest: A-eDP1 [733.355196] Dynamic subtest A-eDP1: SUCCESS (8.661s) [733.368561] Starting dynamic subtest: B-eDP1 [741.980020] Dynamic subtest B-eDP1: SUCCESS (8.622s) [741.993887] Starting dynamic subtest: C-eDP1 [750.598480] Dynamic subtest C-eDP1: SUCCESS (8.615s) [750.611787] Starting dynamic subtest: D-eDP1 [759.226416] Dynamic subtest D-eDP1: SUCCESS (8.625s) [759.231822] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.532s) [760.407359] [155/156] (355s left) kms_pm_dc (dc3co-vpb-simulation) [761.505809] Starting subtest: dc3co-vpb-simulation [761.508181] Starting dynamic subtest: psr2 [761.512783] Dynamic subtest psr2: SKIP (0.000s) [761.525649] Starting dynamic subtest: pr [761.529765] Dynamic subtest pr: SKIP (0.000s) [761.534292] Subtest dc3co-vpb-simulation: SKIP (0.001s) [761.579642] [156/156] (354s left) i915_suspend (fence-restore-tiled2untiled) [761.639951] Starting subtest: fence-restore-tiled2untiled [761.644423] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [761.756906] Closing watchdogs results: parsing output: 0/ for test: kms_plane_scaling results: parsing output: 1/ for test: kms_lease results: parsing output: 2/ for test: kms_chamelium_hpd results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_big_fb results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_softpin results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: gem_caching results: parsing output: 12/ for test: gem_ctx_shared results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_mmap_gtt results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_flip_scaled_crc 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: gem_eio results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_mmap_gtt results: parsing output: 26/ for test: kms_dsc results: parsing output: 27/ for test: kms_psr results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: kms_lease results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gen7_exec_parse results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: kms_feature_discovery results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: gem_render_copy results: parsing output: 39/ for test: i915_pm_rpm results: parsing output: 40/ for test: kms_content_protection results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_ccs results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: gem_ppgtt results: parsing output: 50/ for test: gem_exec_fence results: parsing output: 51/ for test: kms_vblank results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: gem_ctx_engines results: parsing output: 55/ for test: syncobj_basic results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_psr2_sf results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: gem_ctx_persistence results: parsing output: 61/ for test: gem_create results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: gem_mmap_offset results: parsing output: 64/ for test: gem_exec_reloc results: parsing output: 65/ for test: kms_plane_multiple results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_flip results: parsing output: 69/ for test: gem_exec_schedule results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_mmap_gtt results: parsing output: 72/ for test: sysfs_timeslice_duration results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: perf results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: gem_exec_reloc results: parsing output: 79/ for test: api_intel_allocator results: parsing output: 80/ for test: kms_rotation_crc results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: kms_flip results: parsing output: 85/ for test: gem_ctx_param results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_wait results: parsing output: 91/ for test: i915_hangman results: parsing output: 92/ for test: kms_cursor_legacy results: parsing output: 93/ for test: gem_exec_schedule results: parsing output: 94/ for test: kms_plane_scaling results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_setmode results: parsing output: 98/ for test: kms_rotation_crc results: parsing output: 99/ for test: gem_mmap_wc results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: gem_exec_flush results: parsing output: 102/ for test: kms_vrr results: parsing output: 103/ for test: kms_prop_blob results: parsing output: 104/ for test: sw_sync results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: gem_exec_params results: parsing output: 107/ for test: gem_render_copy_redux results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_dp_linktrain_fallback results: parsing output: 110/ for test: gem_mmap_wc results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: core_getversion results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: sriov_basic results: parsing output: 118/ for test: kms_cursor_crc results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: kms_async_flips results: parsing output: 121/ for test: kms_getfb results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: gem_lmem_swapping results: parsing output: 124/ for test: gem_ctx_param results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_reloc results: parsing output: 127/ for test: gem_mmap_gtt results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_chamelium_edid results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: gem_exec_fence results: parsing output: 134/ for test: kms_big_fb results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: gem_mmap_gtt results: parsing output: 137/ for test: kms_psr results: parsing output: 138/ for test: gem_exec_store results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_cursor_legacy results: parsing output: 141/ for test: kms_addfb_basic results: parsing output: 142/ for test: kms_ccs results: parsing output: 143/ for test: gem_watchdog results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_plane_lowres results: parsing output: 146/ for test: gem_exec_balancer results: parsing output: 147/ for test: kms_color results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: gem_pxp results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_big_fb results: parsing output: 153/ for test: kms_flip results: parsing output: 154/ for test: kms_pm_dc results: parsing output: 155/ for test: i915_suspend Done.