[57.116075] Initializing watchdogs
[57.116120]   /dev/watchdog0
[57.129868] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.134293] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.137074] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.140446] [001/156] (960s left) syncobj_timeline (wait-delayed-signal)
[57.209639] Starting subtest: wait-delayed-signal
[57.313839] Subtest wait-delayed-signal: SUCCESS (0.103s)
[57.392374] [002/156] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[57.500258] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[58.538993] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.039s)
[58.658152] [003/156] (959s left) kms_pm_rpm (fences-dpms)
[60.482935] Starting subtest: fences-dpms
[60.488055] Subtest fences-dpms: SKIP (0.000s)
[60.908993] [004/156] (956s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[61.011208] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[68.376902] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.373s)
[68.496134] [005/156] (949s left) gen7_exec_parse (basic-allowed)
[68.562436] Subtest basic-allowed: SKIP (0.000s)
[68.633511] [006/156] (949s left) kms_cursor_legacy (single-bo)
[68.752189] Starting subtest: single-bo
[68.754576] Starting dynamic subtest: pipe-A
[74.133565] Dynamic subtest pipe-A: SUCCESS (5.378s)
[74.141757] Starting dynamic subtest: pipe-B
[79.518772] Dynamic subtest pipe-B: SUCCESS (5.383s)
[79.528884] Starting dynamic subtest: pipe-C
[84.898489] Dynamic subtest pipe-C: SUCCESS (5.380s)
[84.907530] Starting dynamic subtest: pipe-D
[90.277115] Dynamic subtest pipe-D: SUCCESS (5.380s)
[90.286697] Starting dynamic subtest: all-pipes
[95.662890] Dynamic subtest all-pipes: SUCCESS (5.387s)
[95.665641] Subtest single-bo: SUCCESS (26.914s)
[95.804430] [007/156] (922s left) api_intel_bb (object-reloc-keep-cache)
[95.869078] Starting subtest: object-reloc-keep-cache
[95.873730] Subtest object-reloc-keep-cache: SKIP (0.002s)
[95.994667] [008/156] (921s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[96.258950] Starting subtest: cursor-rapid-movement-512x512
[96.263523] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[96.435710] [009/156] (921s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[96.523818] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[96.526160] Starting dynamic subtest: pipe-A-default-mode
[99.283545] Dynamic subtest pipe-A-default-mode: SUCCESS (2.760s)
[99.286081] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.761s)
[100.101853] [010/156] (917s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[100.189836] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[100.194287] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[101.347571] [011/156] (916s left) kms_psr (psr-suspend)
[101.438247] Starting subtest: psr-suspend
[101.440653] Starting dynamic subtest: eDP-1
[119.340018] Dynamic subtest eDP-1: SUCCESS (3.023s)
[119.342377] Subtest psr-suspend: SUCCESS (3.023s)
[120.199790] [012/156] (897s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[120.307481] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[120.311995] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[120.397495] [013/156] (897s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[120.502445] Starting subtest: x-tiled-8bpp-rotate-90
[120.523583] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[120.635876] [014/156] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[120.740294] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[120.744458] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[120.829393] [015/156] (897s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[120.921016] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[120.925339] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[121.003573] [016/156] (897s left) syncobj_wait (wait-all-for-submit-snapshot)
[121.055716] Starting subtest: wait-all-for-submit-snapshot
[121.135450] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[121.205022] [017/156] (897s left) gem_pread (display)
[121.264026] Subtest display: SKIP (0.000s)
[121.322002] [018/156] (896s left) vgem_basic (dmabuf-fence)
[121.402584] Starting subtest: dmabuf-fence
[121.404306] Subtest dmabuf-fence: SUCCESS (0.001s)
[121.458278] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[121.461149] [019/156] (896s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[121.554481] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[121.558102] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[121.651210] [020/156] (896s left) gem_ctx_sseu (engines)
[121.703633] Subtest engines: SKIP (0.000s)
[121.762911] [021/156] (896s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[121.842854] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[121.846483] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[121.910800] [022/156] (896s left) syncobj_wait (signal)
[121.966735] Starting subtest: signal
[121.968377] Subtest signal: SUCCESS (0.000s)
[122.079640] [023/156] (896s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[122.195775] Starting subtest: cursorA-vs-flipB-legacy
[122.199571] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[122.364461] [024/156] (896s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[122.461867] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[122.463557] Starting dynamic subtest: pipe-A-eDP-1
[122.928684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[122.939141] Starting dynamic subtest: pipe-B-eDP-1
[124.353632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[124.363413] Starting dynamic subtest: pipe-C-eDP-1
[125.706064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s)
[125.716946] Starting dynamic subtest: pipe-D-eDP-1
[127.031526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[127.033448] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.542s)
[128.230767] [025/156] (890s left) gem_create (create-size-update)
[128.289142] Starting subtest: create-size-update
[128.291213] Subtest create-size-update: SUCCESS (0.000s)
[128.486996] [026/156] (890s left) gem_mmap_gtt (close-race)
[128.543470] Subtest close-race: SKIP (0.000s)
[128.598961] [027/156] (890s left) gem_set_tiling_vs_pwrite
[128.704629] [028/156] (889s left) gem_render_copy_redux (normal)
[128.766405] Starting subtest: normal
[129.037357] Subtest normal: SUCCESS (0.271s)
[129.165004] [029/156] (889s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[129.277206] Starting subtest: short-flip-before-cursor-toggle
[130.192322] Subtest short-flip-before-cursor-toggle: SUCCESS (0.916s)
[131.057240] [030/156] (887s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[131.162983] Starting subtest: yf-tiled-8bpp-rotate-90
[131.167447] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[131.251670] [031/156] (887s left) gem_exec_parallel (engines)
[131.312935] Starting subtest: engines
[131.315403] Starting dynamic subtest: basic
[133.155685] Dynamic subtest basic: SUCCESS (1.841s)
[133.167419] Starting dynamic subtest: contexts
[137.422765] Dynamic subtest contexts: SUCCESS (4.266s)
[137.434062] Starting dynamic subtest: fds
[141.287543] Dynamic subtest fds: SUCCESS (3.864s)
[141.298555] Starting dynamic subtest: userptr
[143.140050] Dynamic subtest userptr: SUCCESS (1.851s)
[143.142555] Subtest engines: SUCCESS (11.827s)
[143.330462] [032/156] (875s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[143.432292] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[143.436776] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[143.519944] [033/156] (875s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[143.625713] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[143.629980] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[143.728928] [034/156] (875s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[143.791124] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[143.848237] [035/156] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[143.944664] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[147.665724] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.727s)
[148.851386] [036/156] (870s left) gem_mmap_gtt (basic-wc)
[148.914325] Subtest basic-wc: SKIP (0.000s)
[148.978386] [037/156] (870s left) gem_request_retire (retire-vma-not-inactive)
[149.049348] Starting subtest: retire-vma-not-inactive
[149.105842] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[149.237950] [038/156] (869s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[149.335318] Starting subtest: fbchdr-tiling-4
[149.339413] Subtest fbchdr-tiling-4: SKIP (0.000s)
[149.418853] [039/156] (869s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[149.517336] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[149.521568] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[149.584535] [040/156] (869s left) drm_buddy (drm_buddy)
[149.617061] Starting subtest: drm_buddy
[149.621684] Subtest drm_buddy: SKIP (0.000s)
[149.673137] [041/156] (869s left) kms_frontbuffer_tracking (hdr-suspend)
[149.780189] Starting subtest: hdr-suspend
[149.783731] Subtest hdr-suspend: SKIP (0.000s)
[149.873636] [042/156] (869s left) syncobj_wait (wait-for-submit-snapshot)
[149.928349] Starting subtest: wait-for-submit-snapshot
[150.009970] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[150.097431] [043/156] (869s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[150.191474] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[150.193200] Starting dynamic subtest: pipe-A-eDP-1
[150.919143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[150.928320] Starting dynamic subtest: pipe-B-eDP-1
[152.761171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.840s)
[152.770150] Starting dynamic subtest: pipe-C-eDP-1
[154.512686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.752s)
[154.521810] Starting dynamic subtest: pipe-D-eDP-1
[156.328914] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.815s)
[156.330907] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.131s)
[157.484445] [044/156] (861s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[157.585525] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[157.589995] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[157.696615] [045/156] (861s left) kms_psr (pr-no-drrs)
[157.790340] Starting subtest: pr-no-drrs
[157.794769] Subtest pr-no-drrs: SKIP (0.000s)
[157.874051] [046/156] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[157.973827] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[157.978176] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[158.070221] [047/156] (861s left) kms_vblank (ts-continuation-idle)
[158.158836] Starting subtest: ts-continuation-idle
[158.161044] Starting dynamic subtest: pipe-A-eDP-1
[158.556712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[158.572836] Starting dynamic subtest: pipe-D-eDP-1
[159.684464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[159.686783] Subtest ts-continuation-idle: SUCCESS (1.526s)
[160.559150] [048/156] (858s left) i915_pm_rps (min-max-config-loaded)
[160.623043] Starting subtest: min-max-config-loaded
[160.627524] Subtest min-max-config-loaded: SKIP (0.001s)
[160.719905] [049/156] (858s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[160.815257] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[160.819306] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[160.920155] [050/156] (858s left) gem_exec_whisper (basic-contexts-all)
[160.981886] Starting subtest: basic-contexts-all
[172.209151] Subtest basic-contexts-all: SUCCESS (11.224s)
[172.420411] [051/156] (847s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[172.522234] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[175.058839] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.542s)
[176.176837] [052/156] (843s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[176.236494] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[176.289054] [053/156] (843s left) prime_mmap (test_errors)
[176.344099] Starting subtest: test_errors
[176.346125] Starting dynamic subtest: test_errors-smem
[176.441375] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[176.444033] Subtest test_errors: SUCCESS (0.100s)
[176.528343] [054/156] (843s left) kms_cursor_crc (cursor-sliding-32x10)
[176.703369] Starting subtest: cursor-sliding-32x10
[176.748496] Subtest cursor-sliding-32x10: SKIP (0.042s)
[177.021743] [055/156] (842s left) kms_async_flips (async-flip-suspend-resume)
[177.113289] Starting subtest: async-flip-suspend-resume
[177.503267] Starting dynamic subtest: pipe-A-eDP-1
[194.902620] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.890s)
[195.279317] Starting dynamic subtest: pipe-B-eDP-1
[212.901627] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.887s)
[213.260405] Starting dynamic subtest: pipe-C-eDP-1
[230.931183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.960s)
[231.298302] Starting dynamic subtest: pipe-D-eDP-1
[248.897256] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.856s)
[248.899554] Subtest async-flip-suspend-resume: SUCCESS (13.066s)
[250.104591] [056/156] (769s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[250.210499] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[250.215956] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[250.305103] [057/156] (769s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[250.405247] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[250.409640] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[250.504865] [058/156] (769s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[250.612349] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[250.617161] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.718010] [059/156] (769s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[250.814415] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[250.819292] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[250.911803] [060/156] (769s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[251.015949] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[251.020633] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[251.113198] [061/156] (768s left) kms_lease (lease-invalid-connector)
[251.198310] Starting subtest: lease-invalid-connector
[251.200355] Starting dynamic subtest: pipe-A-eDP-1
[251.202781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[251.212266] Starting dynamic subtest: pipe-B-eDP-1
[251.214407] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[251.223645] Starting dynamic subtest: pipe-C-eDP-1
[251.226171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[251.235198] Starting dynamic subtest: pipe-D-eDP-1
[251.237306] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[251.239395] Subtest lease-invalid-connector: SUCCESS (0.003s)
[251.277327] [062/156] (768s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[251.366526] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[251.370915] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[251.433963] [063/156] (768s left) gem_close_race (basic-threads)
[251.494238] Starting subtest: basic-threads
[252.868837] Subtest basic-threads: SUCCESS (1.372s)
[253.053020] [064/156] (767s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[253.151562] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[253.154324] Starting dynamic subtest: pipe-A-eDP-1
[253.175417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[253.187160] Starting dynamic subtest: pipe-B-eDP-1
[253.209385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[253.218223] Starting dynamic subtest: pipe-C-eDP-1
[253.241462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[253.250197] Starting dynamic subtest: pipe-D-eDP-1
[253.273107] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[253.275300] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[255.461321] [065/156] (764s left) kms_psr (fbc-psr-primary-mmap-gtt)
[255.547423] Starting subtest: fbc-psr-primary-mmap-gtt
[255.550072] Starting dynamic subtest: eDP-1
[255.554754] Dynamic subtest eDP-1: SKIP (0.000s)
[255.559462] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[255.619261] [066/156] (764s left) kms_chamelium_edid (vga-edid-read)
[256.000748] Subtest vga-edid-read: SKIP (0.000s)
[256.788992] [067/156] (763s left) kms_flip (flip-vs-absolute-wf_vblank)
[256.886866] Starting subtest: flip-vs-absolute-wf_vblank
[256.889503] Starting dynamic subtest: A-eDP1
[265.862097] Dynamic subtest A-eDP1: SUCCESS (8.975s)
[265.871192] Starting dynamic subtest: B-eDP1
[274.795022] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[274.804521] Starting dynamic subtest: C-eDP1
[283.718541] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[283.729569] Starting dynamic subtest: D-eDP1
[292.654505] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[292.657559] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.769s)
[293.873135] [068/156] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[293.971115] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[293.976452] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[294.053683] [069/156] (726s left) kms_content_protection (uevent)
[294.202428] Starting subtest: uevent
[294.207343] Subtest uevent: SKIP (0.000s)
[294.319487] [070/156] (726s left) api_intel_allocator (two-level-inception)
[294.368650] Starting subtest: two-level-inception
[299.764876] Subtest two-level-inception: SUCCESS (5.396s)
[299.886450] [071/156] (720s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[300.024031] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[300.028898] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[300.127076] [072/156] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[300.243327] Starting subtest: fbcpsr-rgb565-draw-blt
[307.373392] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.136s)
[307.510019] [073/156] (713s left) gen9_exec_parse (basic-rejected)
[307.568483] Subtest basic-rejected: SKIP (0.000s)
[307.644383] [074/156] (712s left) kms_cursor_crc (cursor-offscreen-128x42)
[307.881473] Starting subtest: cursor-offscreen-128x42
[307.929035] Subtest cursor-offscreen-128x42: SKIP (0.040s)
[308.127329] [075/156] (712s left) gem_exec_fence (basic-wait)
[308.302331] Starting subtest: basic-wait
[308.305017] Starting dynamic subtest: rcs0
[308.383640] Dynamic subtest rcs0: SUCCESS (0.081s)
[308.396315] Starting dynamic subtest: bcs0
[308.442355] Dynamic subtest bcs0: SUCCESS (0.056s)
[308.453270] Starting dynamic subtest: vcs0
[308.500157] Dynamic subtest vcs0: SUCCESS (0.055s)
[308.512194] Starting dynamic subtest: vcs1
[308.563231] Dynamic subtest vcs1: SUCCESS (0.061s)
[308.573638] Starting dynamic subtest: vecs0
[308.623090] Dynamic subtest vecs0: SUCCESS (0.057s)
[308.635631] Starting dynamic subtest: ccs0
[308.677765] Dynamic subtest ccs0: SUCCESS (0.052s)
[308.680649] Subtest basic-wait: SUCCESS (0.377s)
[310.965926] [076/156] (709s left) perf (unprivileged-single-ctx-counters)
[311.094747] Starting subtest: unprivileged-single-ctx-counters
[311.099759] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[311.142047] [077/156] (709s left) kms_color (invalid-ctm-matrix-sizes)
[311.234297] Starting subtest: invalid-ctm-matrix-sizes
[311.236752] Starting dynamic subtest: pipe-A
[311.239558] Dynamic subtest pipe-A: SUCCESS (0.002s)
[311.250010] Starting dynamic subtest: pipe-B
[311.252440] Dynamic subtest pipe-B: SUCCESS (0.003s)
[311.262427] Starting dynamic subtest: pipe-C
[311.265196] Dynamic subtest pipe-C: SUCCESS (0.004s)
[311.275655] Starting dynamic subtest: pipe-D
[311.278050] Dynamic subtest pipe-D: SUCCESS (0.004s)
[311.280266] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[311.322814] [078/156] (709s left) kms_big_fb (linear-16bpp-rotate-180)
[311.417269] Starting subtest: linear-16bpp-rotate-180
[312.752227] Subtest linear-16bpp-rotate-180: SUCCESS (1.335s)
[312.865050] [079/156] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[312.965652] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[312.970654] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[313.055800] [080/156] (707s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[313.158074] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[313.162498] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[313.254494] [081/156] (707s left) gem_exec_schedule (semaphore-resolve)
[313.327120] Starting subtest: semaphore-resolve
[313.361848] Subtest semaphore-resolve: SUCCESS (0.040s)
[313.694346] [082/156] (707s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[313.792416] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[313.797451] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[313.901420] [083/156] (707s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[313.957140] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[313.962444] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[314.141708] [084/156] (706s left) gem_basic (bad-close)
[314.191662] Starting subtest: bad-close
[314.196642] Subtest bad-close: SUCCESS (0.000s)
[314.273513] [085/156] (706s left) kms_atomic (plane-overlay-legacy)
[314.353574] Starting subtest: plane-overlay-legacy
[314.356314] Starting dynamic subtest: pipe-A-eDP-1
[314.770752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[314.773522] Subtest plane-overlay-legacy: SUCCESS (0.416s)
[315.637788] [086/156] (705s left) kms_flip (flip-vs-panning-interruptible)
[315.737408] Starting subtest: flip-vs-panning-interruptible
[315.740211] Starting dynamic subtest: A-eDP1
[324.463177] Dynamic subtest A-eDP1: SUCCESS (8.724s)
[324.479469] Starting dynamic subtest: B-eDP1
[333.177048] Dynamic subtest B-eDP1: SUCCESS (8.710s)
[333.189919] Starting dynamic subtest: C-eDP1
[341.898398] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[341.910384] Starting dynamic subtest: D-eDP1
[350.634933] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[350.639985] Subtest flip-vs-panning-interruptible: SUCCESS (34.900s)
[351.818618] [087/156] (669s left) fbdev (write)
[351.856298] Starting subtest: write
[352.215619] Subtest write: SUCCESS (0.358s)
[352.280228] [088/156] (668s left) gem_ctx_persistence (engines-hang)
[352.336530] Starting subtest: engines-hang
[352.339439] Starting dynamic subtest: rcs0
[352.400808] Dynamic subtest rcs0: SUCCESS (0.064s)
[352.411627] Starting dynamic subtest: bcs0
[352.504028] Dynamic subtest bcs0: SUCCESS (0.101s)
[352.516677] Starting dynamic subtest: vcs0
[352.599833] Dynamic subtest vcs0: SUCCESS (0.094s)
[352.610496] Starting dynamic subtest: vcs1
[352.693917] Dynamic subtest vcs1: SUCCESS (0.092s)
[352.706915] Starting dynamic subtest: vecs0
[352.785991] Dynamic subtest vecs0: SUCCESS (0.090s)
[352.798039] Starting dynamic subtest: ccs0
[352.879056] Dynamic subtest ccs0: SUCCESS (0.091s)
[352.882148] Subtest engines-hang: SUCCESS (0.544s)
[352.960361] [089/156] (668s left) kms_psr (fbc-pr-primary-blt)
[353.062981] Starting subtest: fbc-pr-primary-blt
[353.067655] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[353.175548] [090/156] (668s left) sw_sync (alloc_merge_fence)
[353.210876] Starting subtest: alloc_merge_fence
[353.213039] Subtest alloc_merge_fence: SUCCESS (0.000s)
[353.268081] [091/156] (668s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[353.360147] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[353.372024] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[353.448051] [092/156] (667s left) gem_exec_reloc (basic-gtt-active)
[353.506494] Subtest basic-gtt-active: SKIP (0.000s)
[353.566191] [093/156] (667s left) kms_psr (fbc-pr-sprite-plane-onoff)
[353.657432] Starting subtest: fbc-pr-sprite-plane-onoff
[353.662200] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[353.744405] [094/156] (667s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[353.830854] Starting subtest: 2x-flip-vs-modeset-vs-hang
[353.834365] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.002s)
[353.939011] [095/156] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[354.038024] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[360.556164] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.522s)
[360.681414] [096/156] (660s left) kms_psr (psr2-suspend)
[360.771162] Starting subtest: psr2-suspend
[360.773512] Starting dynamic subtest: eDP-1
[378.289261] Dynamic subtest eDP-1: SUCCESS (2.879s)
[378.291504] Subtest psr2-suspend: SUCCESS (2.880s)
[379.096782] [097/156] (642s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[380.624928] Starting subtest: modeset-non-lpsp-stress-no-wait
[380.674017] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[381.409770] [098/156] (640s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[381.468710] Starting subtest: legacy-engines-hostile-preempt
[381.471072] Starting dynamic subtest: render
[381.565515] Dynamic subtest render: SUCCESS (0.096s)
[381.578586] Starting dynamic subtest: bsd1
[383.528260] Dynamic subtest bsd1: SUCCESS (1.959s)
[383.538916] Starting dynamic subtest: bsd2
[385.511286] Dynamic subtest bsd2: SUCCESS (1.978s)
[385.524486] Starting dynamic subtest: blt
[385.565549] Dynamic subtest blt: SUCCESS (0.055s)
[385.577019] Starting dynamic subtest: vebox
[387.471305] Dynamic subtest vebox: SUCCESS (1.902s)
[387.474010] Subtest legacy-engines-hostile-preempt: SUCCESS (6.003s)
[387.611813] [099/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[387.716120] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[387.720139] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[387.801124] [100/156] (633s left) gem_exec_fence (parallel)
[387.977400] Starting subtest: parallel
[387.979941] Starting dynamic subtest: rcs0
[390.126275] Dynamic subtest rcs0: SUCCESS (2.149s)
[390.136745] Starting dynamic subtest: bcs0
[392.275612] Dynamic subtest bcs0: SUCCESS (2.149s)
[392.286030] Starting dynamic subtest: vcs0
[394.427239] Dynamic subtest vcs0: SUCCESS (2.151s)
[394.437405] Starting dynamic subtest: vcs1
[396.582551] Dynamic subtest vcs1: SUCCESS (2.155s)
[396.592947] Starting dynamic subtest: vecs0
[398.734463] Dynamic subtest vecs0: SUCCESS (2.151s)
[398.745232] Starting dynamic subtest: ccs0
[400.888635] Dynamic subtest ccs0: SUCCESS (2.153s)
[400.890418] Subtest parallel: SUCCESS (12.911s)
[402.645188] [101/156] (619s left) sriov_basic (enable-vfs-autoprobe-on)
[402.695229] Starting subtest: enable-vfs-autoprobe-on
[402.697563] Starting dynamic subtest: numvfs-1
[402.702340] Dynamic subtest numvfs-1: SKIP (0.001s)
[402.714516] Starting dynamic subtest: numvfs-2
[402.719294] Dynamic subtest numvfs-2: SKIP (0.000s)
[402.728690] Starting dynamic subtest: numvfs-3
[402.732554] Dynamic subtest numvfs-3: SKIP (0.000s)
[402.741292] Starting dynamic subtest: numvfs-4
[402.745452] Dynamic subtest numvfs-4: SKIP (0.000s)
[402.755236] Starting dynamic subtest: numvfs-5
[402.760082] Dynamic subtest numvfs-5: SKIP (0.000s)
[402.769772] Starting dynamic subtest: numvfs-6
[402.774205] Dynamic subtest numvfs-6: SKIP (0.000s)
[402.784257] Starting dynamic subtest: numvfs-7
[402.789156] Dynamic subtest numvfs-7: SKIP (0.000s)
[402.798552] Starting dynamic subtest: numvfs-random
[402.803350] Dynamic subtest numvfs-random: SKIP (0.000s)
[402.812606] Starting dynamic subtest: numvfs-all
[402.816888] Dynamic subtest numvfs-all: SKIP (0.001s)
[402.820759] Subtest enable-vfs-autoprobe-on: SKIP (0.010s)
[402.864867] [102/156] (618s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[402.963951] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[402.968010] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[403.059821] [103/156] (618s left) gem_workarounds (reset-fd)
[403.130727] Starting subtest: reset-fd
[403.311424] Subtest reset-fd: SUCCESS (0.179s)
[403.424913] [104/156] (618s left) gem_mmap_gtt (coherency)
[403.484679] Subtest coherency: SKIP (0.000s)
[403.550557] [105/156] (618s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[403.648216] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[403.652629] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[403.717447] [106/156] (618s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[403.770996] Starting subtest: wait-all-for-submit-delayed-submit
[403.874759] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[403.950388] [107/156] (618s left) gem_tiled_swapping (non-threaded)
[404.013190] Subtest non-threaded: SKIP (0.000s)
[404.072756] [108/156] (617s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[404.170568] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[404.174755] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[404.271307] [109/156] (617s left) kms_universal_plane (universal-plane-pageflip-windowed)
[404.372034] Starting subtest: universal-plane-pageflip-windowed
[404.374338] Starting dynamic subtest: pipe-A-eDP-1
[404.932935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s)
[404.944380] Starting dynamic subtest: pipe-B-eDP-1
[406.096948] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[406.108052] Starting dynamic subtest: pipe-C-eDP-1
[407.315700] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[407.326252] Starting dynamic subtest: pipe-D-eDP-1
[408.541544] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[408.543940] Subtest universal-plane-pageflip-windowed: SUCCESS (4.171s)
[409.431040] [110/156] (612s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[409.495477] Starting subtest: etime-multi-wait-all-submitted-signaled
[409.602113] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[409.679379] [111/156] (612s left) core_auth (basic-auth)
[409.735659] Starting subtest: basic-auth
[409.738000] Subtest basic-auth: SUCCESS (0.001s)
[409.858839] [112/156] (612s left) gem_spin_batch (resubmit-new)
[409.914644] Starting subtest: resubmit-new
[409.916994] Starting dynamic subtest: rcs0
[409.924945] Dynamic subtest rcs0: SUCCESS (0.010s)
[409.935478] Starting dynamic subtest: bcs0
[409.937592] Dynamic subtest bcs0: SUCCESS (0.005s)
[409.947193] Starting dynamic subtest: vcs0
[409.949581] Dynamic subtest vcs0: SUCCESS (0.005s)
[409.959808] Starting dynamic subtest: vcs1
[409.961995] Dynamic subtest vcs1: SUCCESS (0.005s)
[409.971309] Starting dynamic subtest: vecs0
[409.973442] Dynamic subtest vecs0: SUCCESS (0.005s)
[409.982996] Starting dynamic subtest: ccs0
[409.985148] Dynamic subtest ccs0: SUCCESS (0.004s)
[409.987342] Subtest resubmit-new: SUCCESS (0.038s)
[411.611740] [113/156] (610s left) kms_plane_cursor (viewport)
[411.694553] Starting subtest: viewport
[411.699013] Starting dynamic subtest: pipe-A-eDP-1-size-64
[414.146017] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.451s)
[414.207975] Starting dynamic subtest: pipe-A-eDP-1-size-128
[416.648367] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[416.710357] Starting dynamic subtest: pipe-A-eDP-1-size-256
[419.117788] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.415s)
[419.466504] Starting dynamic subtest: pipe-B-eDP-1-size-64
[422.688171] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.232s)
[422.749119] Starting dynamic subtest: pipe-B-eDP-1-size-128
[425.212783] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.473s)
[425.272689] Starting dynamic subtest: pipe-B-eDP-1-size-256
[427.726314] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s)
[428.082723] Starting dynamic subtest: pipe-C-eDP-1-size-64
[430.851182] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.779s)
[430.889717] Starting dynamic subtest: pipe-C-eDP-1-size-128
[432.996548] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[433.036769] Starting dynamic subtest: pipe-C-eDP-1-size-256
[435.152090] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[435.480479] Starting dynamic subtest: pipe-D-eDP-1-size-64
[438.330861] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.860s)
[438.369990] Starting dynamic subtest: pipe-D-eDP-1-size-128
[440.420441] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.058s)
[440.457446] Starting dynamic subtest: pipe-D-eDP-1-size-256
[442.565557] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[442.889857] Subtest viewport: SUCCESS (31.185s)
[443.777084] [114/156] (578s left) syncobj_basic (test-valid-cycle)
[443.826731] Starting subtest: test-valid-cycle
[443.829020] Subtest test-valid-cycle: SUCCESS (0.000s)
[443.949404] [115/156] (578s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[444.043780] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[444.047737] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[444.135590] [116/156] (578s left) gem_render_copy (linear-to-vebox-yf-tiled)
[444.192537] Starting subtest: linear-to-vebox-yf-tiled
[444.196951] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[444.388952] [117/156] (578s left) gem_exec_schedule (preempt-other-chain)
[444.446048] Starting subtest: preempt-other-chain
[444.448451] Starting dynamic subtest: rcs0
[444.515917] Dynamic subtest rcs0: SUCCESS (0.079s)
[444.529809] Starting dynamic subtest: bcs0
[444.597310] Dynamic subtest bcs0: SUCCESS (0.080s)
[444.612378] Starting dynamic subtest: vcs0
[444.683386] Dynamic subtest vcs0: SUCCESS (0.087s)
[444.695584] Starting dynamic subtest: vcs1
[444.764415] Dynamic subtest vcs1: SUCCESS (0.080s)
[444.777059] Starting dynamic subtest: vecs0
[444.842000] Dynamic subtest vecs0: SUCCESS (0.076s)
[444.858480] Starting dynamic subtest: ccs0
[444.917747] Dynamic subtest ccs0: SUCCESS (0.075s)
[444.920344] Subtest preempt-other-chain: SUCCESS (0.482s)
[445.625444] [118/156] (576s left) syncobj_wait (invalid-signal-zero-handles)
[445.675396] Starting subtest: invalid-signal-zero-handles
[445.677613] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[445.786282] [119/156] (576s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[445.876756] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[445.879744] Starting dynamic subtest: pipe-A-eDP-1
[446.297529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[446.310768] Starting dynamic subtest: pipe-B-eDP-1
[446.330209] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[446.340414] Starting dynamic subtest: pipe-C-eDP-1
[446.359471] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[446.368465] Starting dynamic subtest: pipe-D-eDP-1
[446.386792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[446.388630] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.438s)
[448.667230] [120/156] (573s left) gem_softpin (invalid)
[448.732746] Starting subtest: invalid
[448.738119] Subtest invalid: SUCCESS (0.005s)
[448.858646] [121/156] (573s left) perf (gen12-group-concurrent-oa-buffer-read)
[448.946443] Starting subtest: gen12-group-concurrent-oa-buffer-read
[458.974347] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.025s)
[459.023627] [122/156] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[459.117289] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[465.938951] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.826s)
[466.062395] [123/156] (556s left) kms_joiner (basic-ultra-joiner)
[466.161248] Starting subtest: basic-ultra-joiner
[466.165294] Subtest basic-ultra-joiner: SKIP (0.000s)
[466.224646] [124/156] (556s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-onoff)
[466.314140] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-onoff
[466.318297] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[466.414516] [125/156] (556s left) kms_flip (flip-vs-suspend)
[466.506735] Starting subtest: flip-vs-suspend
[466.508948] Starting dynamic subtest: A-eDP1
[627.891861] Dynamic subtest A-eDP1: SUCCESS (12.171s)
[627.893866] Subtest flip-vs-suspend: SUCCESS (12.173s)
[628.030809] [126/156] (394s left) i915_drm_fdinfo (virtual-busy)
[628.072592] Starting subtest: virtual-busy
[628.076855] Subtest virtual-busy: SKIP (0.000s)
[628.151558] [127/156] (394s left) perf_pmu (init-sema)
[628.189323] Starting subtest: init-sema
[628.191617] Starting dynamic subtest: rcs0
[628.193915] Dynamic subtest rcs0: SUCCESS (0.002s)
[628.206334] Starting dynamic subtest: bcs0
[628.208160] Dynamic subtest bcs0: SUCCESS (0.000s)
[628.217372] Starting dynamic subtest: vcs0
[628.219248] Dynamic subtest vcs0: SUCCESS (0.001s)
[628.228930] Starting dynamic subtest: vcs1
[628.231125] Dynamic subtest vcs1: SUCCESS (0.001s)
[628.240598] Starting dynamic subtest: vecs0
[628.242957] Dynamic subtest vecs0: SUCCESS (0.001s)
[628.252550] Starting dynamic subtest: ccs0
[628.254809] Dynamic subtest ccs0: SUCCESS (0.000s)
[628.257073] Subtest init-sema: SUCCESS (0.008s)
[628.303594] [128/156] (394s left) syncobj_timeline (reset-unsignaled)
[628.363680] Starting subtest: reset-unsignaled
[628.366021] Subtest reset-unsignaled: SUCCESS (0.000s)
[628.466027] [129/156] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[628.566273] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[628.570376] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[628.674992] [130/156] (394s left) kms_plane_scaling (invalid-num-scalers)
[628.759155] Starting subtest: invalid-num-scalers
[628.761442] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[628.778019] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[628.790236] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[628.809062] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[628.819720] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[628.838920] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[628.849270] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[628.868346] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[628.870643] Subtest invalid-num-scalers: SUCCESS (0.112s)
[628.977765] [131/156] (394s left) gem_pread (bench)
[629.035473] Subtest bench: SKIP (0.000s)
[629.101137] [132/156] (393s left) syncobj_basic (illegal-fd-to-handle)
[629.159439] Starting subtest: illegal-fd-to-handle
[629.161351] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[629.261422] [133/156] (393s left) kms_pm_backlight (fade-with-dpms)
[629.349594] Starting subtest: fade-with-dpms
[631.432708] Starting dynamic subtest: eDP-1
[634.432946] Dynamic subtest eDP-1: SUCCESS (2.998s)
[634.434940] Subtest fade-with-dpms: SUCCESS (5.083s)
[635.317638] [134/156] (387s left) gem_exec_flush (basic-wb-rw-default)
[635.375917] Starting subtest: basic-wb-rw-default
[640.828564] Subtest basic-wb-rw-default: SUCCESS (5.452s)
[641.019613] [135/156] (382s left) gem_exec_params (no-bsd)
[641.081110] Starting subtest: no-bsd
[641.087163] Subtest no-bsd: SUCCESS (0.005s)
[642.817606] [136/156] (380s left) i915_hangman (hangcheck-unterminated)
[642.881110] Starting subtest: hangcheck-unterminated
[653.731876] Subtest hangcheck-unterminated: SUCCESS (10.847s)
[653.858631] [137/156] (369s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[653.978987] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[655.069957] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.090s)
[655.204733] [138/156] (368s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[655.315031] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[655.318511] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[655.412211] [139/156] (367s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[655.458114] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[655.560916] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[655.641889] [140/156] (367s left) gem_eio (suspend)
[655.846285] Starting subtest: suspend
[668.026366] Subtest suspend: SUCCESS (12.179s)
[668.152759] [141/156] (355s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[668.246349] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[668.250414] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[668.320462] [142/156] (355s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[668.409921] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[668.412399] Starting dynamic subtest: pipe-A-eDP-1
[668.470091] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[668.764401] Starting dynamic subtest: pipe-B-eDP-1
[669.532815] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[669.820987] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.411s)
[670.694884] [143/156] (352s left) gem_lmem_swapping (parallel-random-verify)
[670.735386] Subtest parallel-random-verify: SKIP (0.000s)
[670.784691] [144/156] (352s left) kms_chamelium_hpd (vga-hpd)
[671.161704] Subtest vga-hpd: SKIP (0.000s)
[672.015113] [145/156] (351s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[672.114123] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[672.118728] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[672.234018] [146/156] (351s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[672.331592] Starting subtest: fbcpsrhdr-rgb565-draw-render
[672.335629] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[672.430014] [147/156] (351s left) gem_exec_balancer (bonded-dual)
[672.497387] Starting subtest: bonded-dual
[672.501666] Subtest bonded-dual: SKIP (0.000s)
[672.796501] [148/156] (350s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[672.916825] Starting subtest: cursorA-vs-flipB-toggle
[672.921516] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[673.063114] [149/156] (350s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[673.166255] Starting subtest: y-tiled-8bpp-rotate-180
[673.170811] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[673.260523] [150/156] (350s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[673.320914] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[673.323355] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[673.414153] [151/156] (350s left) syncobj_wait (invalid-signal-bad-pad)
[673.468586] Starting subtest: invalid-signal-bad-pad
[673.471007] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[673.556258] [152/156] (350s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[673.663018] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[673.667299] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[673.763616] [153/156] (350s left) gem_mmap_offset (clear-via-pagefault)
[673.807505] Starting subtest: clear-via-pagefault
[673.809111] Starting dynamic subtest: smem0
[705.077215] Dynamic subtest smem0: SUCCESS (31.256s)
[705.079728] Subtest clear-via-pagefault: SUCCESS (31.258s)
[705.198460] [154/156] (318s left) kms_feature_discovery (display-2x)
[705.299546] Starting subtest: display-2x
[705.303866] Subtest display-2x: SKIP (0.000s)
[705.375023] [155/156] (318s left) i915_query (hwconfig_table)
[705.427039] Starting subtest: hwconfig_table
[705.722381] Subtest hwconfig_table: SUCCESS (0.001s)
[705.763480] [156/156] (318s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[705.863618] Starting subtest: psrhdr-shrfb-scaledprimary
[705.867762] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[705.951924] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gen7_exec_parse
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_pread
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_ctx_sseu
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_create
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 27/ for test: gem_render_copy_redux
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_exec_parallel
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_wc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_request_retire
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_plane
results: parsing output: 39/ for test: drm_buddy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: i915_pm_rps
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_pipe_b_c_ivb
results: parsing output: 52/ for test: prime_mmap
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: gem_close_race
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_content_protection
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_color
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: gem_basic
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: fbdev
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: sriov_basic
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_workarounds
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_tiled_swapping
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_universal_plane
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: core_auth
results: parsing output: 111/ for test: gem_spin_batch
results: parsing output: 112/ for test: kms_plane_cursor
results: parsing output: 113/ for test: syncobj_basic
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: gem_pread
results: parsing output: 131/ for test: syncobj_basic
results: parsing output: 132/ for test: kms_pm_backlight
results: parsing output: 133/ for test: gem_exec_flush
results: parsing output: 134/ for test: gem_exec_params
results: parsing output: 135/ for test: i915_hangman
results: parsing output: 136/ for test: kms_big_fb
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: gem_eio
results: parsing output: 140/ for test: kms_flip_scaled_crc
results: parsing output: 141/ for test: kms_atomic_transition
results: parsing output: 142/ for test: gem_lmem_swapping
results: parsing output: 143/ for test: kms_chamelium_hpd
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_exec_balancer
results: parsing output: 147/ for test: kms_cursor_legacy
results: parsing output: 148/ for test: kms_big_fb
results: parsing output: 149/ for test: syncobj_timeline
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_mmap_offset
results: parsing output: 153/ for test: kms_feature_discovery
results: parsing output: 154/ for test: i915_query
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.