[56.772712] Initializing watchdogs
[56.772793]   /dev/watchdog0
[56.788475] [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]
[56.792970] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.795361] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.799049] [001/133] (960s left) kms_cursor_crc (cursor-sliding-512x512)
[57.102670] Starting subtest: cursor-sliding-512x512
[57.107266] Subtest cursor-sliding-512x512: SKIP (0.001s)
[57.257132] [002/133] (960s left) kms_vblank (wait-idle-hang)
[57.351398] Starting subtest: wait-idle-hang
[57.353360] Starting dynamic subtest: pipe-A-eDP-1
[85.071908] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.695s)
[85.086169] Starting dynamic subtest: pipe-D-eDP-1
[110.096649] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[110.098978] Subtest wait-idle-hang: SUCCESS (52.719s)
[110.973113] [003/133] (906s left) gem_exec_params (mmapped)
[111.041607] Starting subtest: mmapped
[111.047139] Subtest mmapped: SUCCESS (0.003s)
[111.179050] [004/133] (906s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[111.282837] Starting subtest: x-tiled-32bpp-rotate-180
[112.737987] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.456s)
[112.870662] [005/133] (904s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[112.969954] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[112.973577] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[113.036732] [006/133] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[113.134073] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[113.137397] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[113.230360] [007/133] (904s left) i915_suspend (debugfs-reader)
[113.279256] Starting subtest: debugfs-reader
[131.391427] Subtest debugfs-reader: SUCCESS (3.953s)
[131.554535] [008/133] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[131.664713] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[131.669509] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[131.754926] [009/133] (885s left) fbdev (read)
[131.800117] Starting subtest: read
[132.330814] Subtest read: SUCCESS (0.528s)
[132.394606] [010/133] (885s left) gem_mmap (short-mmap)
[132.449457] Subtest short-mmap: SKIP (0.000s)
[132.504453] [011/133] (885s left) syncobj_timeline (wait-all-delayed-signal)
[132.552078] Starting subtest: wait-all-delayed-signal
[132.655532] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[132.740756] [012/133] (885s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[132.832232] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[132.837292] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[132.925130] [013/133] (884s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[132.993454] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[132.996257] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[133.080275] [014/133] (884s left) gem_render_copy (linear-to-vebox-y-tiled)
[133.128386] Starting subtest: linear-to-vebox-y-tiled
[133.133890] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[133.326005] [015/133] (884s left) gem_create (create-size-update)
[133.371485] Starting subtest: create-size-update
[133.374486] Subtest create-size-update: SUCCESS (0.000s)
[133.575985] [016/133] (884s left) syncobj_wait (single-wait-all-submitted)
[133.628346] Starting subtest: single-wait-all-submitted
[133.735741] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[133.810500] [017/133] (884s left) kms_selftest (drm_format_helper)
[133.859133] Starting subtest: drm_format_helper
[133.874252] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[133.962496] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.089s)
[133.971147] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[134.050385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.086s)
[134.058445] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[134.137339] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.088s)
[134.148212] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[134.225471] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.086s)
[134.233482] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[134.310104] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.085s)
[134.320449] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[134.395434] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.082s)
[134.403963] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[134.485818] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.090s)
[134.494651] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[134.572744] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.086s)
[134.580928] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[134.658026] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.084s)
[134.667030] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[134.760228] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.102s)
[134.769349] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[134.858498] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.097s)
[134.868663] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[134.968793] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.110s)
[134.977644] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[135.077986] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.108s)
[135.087796] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[135.168875] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.090s)
[135.178368] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[135.254044] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.086s)
[135.263202] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[135.365305] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.111s)
[135.373818] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[135.478120] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.110s)
[135.480223] Subtest drm_format_helper: SUCCESS (1.614s)
[135.618909] [018/133] (882s left) kms_psr (psr-primary-mmap-cpu)
[135.719745] Starting subtest: psr-primary-mmap-cpu
[135.721970] Starting dynamic subtest: eDP-1
[137.472133] Dynamic subtest eDP-1: SUCCESS (1.746s)
[137.475184] Subtest psr-primary-mmap-cpu: SUCCESS (1.747s)
[138.348475] [019/133] (879s left) kms_force_connector_basic (force-connector-state)
[138.420442] Starting subtest: force-connector-state
[139.043356] Subtest force-connector-state: SUCCESS (0.621s)
[140.015200] [020/133] (878s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[140.073847] Starting subtest: invalid-smem-bo-on-discrete
[140.079194] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[140.193698] [021/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[140.296355] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[147.459605] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.155s)
[147.592230] [022/133] (870s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[147.692173] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[147.694973] Starting dynamic subtest: pipe-A-eDP-1
[147.722999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.736295] Starting dynamic subtest: pipe-B-eDP-1
[147.762055] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.773838] Starting dynamic subtest: pipe-C-eDP-1
[147.800198] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.811171] Starting dynamic subtest: pipe-D-eDP-1
[147.838944] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.844175] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[149.932034] [023/133] (868s left) kms_content_protection (dp-mst-lic-type-1)
[150.077954] Starting subtest: dp-mst-lic-type-1
[150.083423] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[150.210488] [024/133] (868s left) kms_addfb_basic (basic)
[150.266133] Starting subtest: basic
[150.268825] Subtest basic: SUCCESS (0.000s)
[150.393220] [025/133] (867s left) kms_pm_rpm (system-suspend-modeset)
[152.634434] Starting subtest: system-suspend-modeset
[171.639623] Subtest system-suspend-modeset: SUCCESS (4.304s)
[172.043992] [026/133] (846s left) gem_eio (wait-immediate)
[172.246397] Starting subtest: wait-immediate
[172.580218] Subtest wait-immediate: SUCCESS (0.333s)
[172.693631] [027/133] (845s left) kms_dsc (dsc-with-output-formats)
[172.784568] Starting subtest: dsc-with-output-formats
[172.805771] Subtest dsc-with-output-formats: SKIP (0.000s)
[172.869282] [028/133] (845s left) i915_pm_rpm (sysfs-read)
[174.410277] Starting subtest: sysfs-read
[175.560420] Subtest sysfs-read: SUCCESS (1.145s)
[175.930803] [029/133] (842s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[176.018265] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[176.020547] Starting dynamic subtest: pipe-A-default-mode
[178.761797] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[178.764277] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.743s)
[179.560586] [030/133] (839s left) kms_flip (2x-flip-vs-fences-interruptible)
[179.651745] Starting subtest: 2x-flip-vs-fences-interruptible
[179.656113] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[179.754457] [031/133] (838s left) kms_psr (fbc-psr-dpms)
[179.850323] Starting subtest: fbc-psr-dpms
[179.852638] Starting dynamic subtest: eDP-1
[179.857036] Dynamic subtest eDP-1: SKIP (0.000s)
[179.861500] Subtest fbc-psr-dpms: SKIP (0.001s)
[179.923094] [032/133] (838s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[180.004889] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[180.009319] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[180.088818] [033/133] (838s left) gem_mmap_gtt (basic-write-read-distinct)
[180.146323] Subtest basic-write-read-distinct: SKIP (0.000s)
[180.205400] [034/133] (838s left) gem_userptr_blits (invalid-null-pointer)
[180.257771] Starting subtest: invalid-null-pointer
[180.259676] Subtest invalid-null-pointer: SUCCESS (0.001s)
[180.373015] [035/133] (838s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[180.480089] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[180.482258] Starting dynamic subtest: pipe-A
[180.543767] Dynamic subtest pipe-A: SUCCESS (0.065s)
[180.552399] Starting dynamic subtest: pipe-B
[181.655378] Dynamic subtest pipe-B: SUCCESS (1.110s)
[181.665944] Starting dynamic subtest: pipe-C
[182.827532] Dynamic subtest pipe-C: SUCCESS (1.171s)
[182.837110] Starting dynamic subtest: pipe-D
[183.924952] Dynamic subtest pipe-D: SUCCESS (1.096s)
[183.927752] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.444s)
[185.067881] [036/133] (833s left) perf_pmu (init-wait)
[185.119333] Starting subtest: init-wait
[185.121787] Starting dynamic subtest: rcs0
[185.124271] Dynamic subtest rcs0: SUCCESS (0.002s)
[185.134498] Starting dynamic subtest: bcs0
[185.136494] Dynamic subtest bcs0: SUCCESS (0.000s)
[185.144914] Starting dynamic subtest: vcs0
[185.146923] Dynamic subtest vcs0: SUCCESS (0.000s)
[185.156764] Starting dynamic subtest: vcs1
[185.159084] Dynamic subtest vcs1: SUCCESS (0.001s)
[185.169256] Starting dynamic subtest: vecs0
[185.171238] Dynamic subtest vecs0: SUCCESS (0.001s)
[185.180072] Starting dynamic subtest: ccs0
[185.182039] Dynamic subtest ccs0: SUCCESS (0.000s)
[185.184005] Subtest init-wait: SUCCESS (0.006s)
[185.223384] [037/133] (833s left) kms_cursor_crc (cursor-offscreen-32x32)
[185.375301] Starting subtest: cursor-offscreen-32x32
[185.423192] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[185.711975] [038/133] (833s left) gem_madvise (dontneed-before-mmap)
[185.754695] Starting subtest: dontneed-before-mmap
[185.780040] Subtest dontneed-before-mmap: SUCCESS (0.026s)
[185.870693] [039/133] (833s left) kms_psr (pr-sprite-plane-move)
[185.956014] Starting subtest: pr-sprite-plane-move
[185.959907] Subtest pr-sprite-plane-move: SKIP (0.000s)
[186.027892] [040/133] (832s left) gem_exec_parallel (basic)
[186.083786] Starting subtest: basic
[186.085799] Starting dynamic subtest: rcs0
[187.506123] Dynamic subtest rcs0: SUCCESS (1.421s)
[187.515510] Starting dynamic subtest: bcs0
[188.971412] Dynamic subtest bcs0: SUCCESS (1.464s)
[188.980774] Starting dynamic subtest: vcs0
[192.193921] Dynamic subtest vcs0: SUCCESS (3.217s)
[192.205106] Starting dynamic subtest: vcs1
[194.110152] Dynamic subtest vcs1: SUCCESS (1.915s)
[194.119256] Starting dynamic subtest: vecs0
[196.159044] Dynamic subtest vecs0: SUCCESS (2.046s)
[196.170993] Starting dynamic subtest: ccs0
[197.653241] Dynamic subtest ccs0: SUCCESS (1.493s)
[197.655618] Subtest basic: SUCCESS (11.564s)
[197.836920] [041/133] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[197.948807] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[197.953247] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[198.064054] [042/133] (820s left) perf_pmu (all-busy-idle-check-all)
[198.107257] Starting subtest: all-busy-idle-check-all
[200.128095] Subtest all-busy-idle-check-all: SUCCESS (2.018s)
[200.232804] [043/133] (818s left) sw_sync (sync_merge_same)
[200.274834] Starting subtest: sync_merge_same
[200.277151] Subtest sync_merge_same: SUCCESS (0.000s)
[200.332064] [044/133] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[200.417797] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[207.456424] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.022s)
[207.606584] [045/133] (811s left) gem_mmap_gtt (cpuset-big-copy-xy)
[207.659579] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[207.715606] [046/133] (811s left) sysfs_heartbeat_interval (idempotent)
[207.775902] Starting subtest: idempotent
[207.778298] Starting dynamic subtest: vecs0
[207.780819] Dynamic subtest vecs0: SUCCESS (0.001s)
[207.791237] Starting dynamic subtest: ccs0
[207.793462] Dynamic subtest ccs0: SUCCESS (0.001s)
[207.802756] Starting dynamic subtest: vcs0
[207.804963] Dynamic subtest vcs0: SUCCESS (0.000s)
[207.816254] Starting dynamic subtest: bcs0
[207.818456] Dynamic subtest bcs0: SUCCESS (0.001s)
[207.827775] Starting dynamic subtest: rcs0
[207.829971] Dynamic subtest rcs0: SUCCESS (0.001s)
[207.839749] Starting dynamic subtest: vcs1
[207.841538] Dynamic subtest vcs1: SUCCESS (0.000s)
[207.843424] Subtest idempotent: SUCCESS (0.008s)
[207.894835] [047/133] (811s left) gem_ctx_persistence (heartbeat-hostile)
[207.960513] Starting subtest: heartbeat-hostile
[207.964973] Subtest heartbeat-hostile: SKIP (0.000s)
[208.081229] [048/133] (811s left) kms_pm_backlight (fade-with-dpms)
[208.166793] Starting subtest: fade-with-dpms
[210.616979] Starting dynamic subtest: eDP-1
[213.323689] Dynamic subtest eDP-1: SUCCESS (2.702s)
[213.326040] Subtest fade-with-dpms: SUCCESS (5.149s)
[214.200185] [049/133] (805s left) gem_vm_create (invalid-destroy)
[214.265949] Starting subtest: invalid-destroy
[214.268690] Subtest invalid-destroy: SUCCESS (0.001s)
[214.385770] [050/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[214.499888] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[214.503981] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[214.607247] [051/133] (804s left) gem_exec_params (batch-first)
[214.670848] Starting subtest: batch-first
[214.677368] Subtest batch-first: SUCCESS (0.006s)
[214.812402] [052/133] (804s left) kms_lease (lessee-list)
[214.918256] Starting subtest: lessee-list
[214.920442] Starting dynamic subtest: pipe-A-eDP-1
[214.922712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[214.932463] Starting dynamic subtest: pipe-B-eDP-1
[214.934268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[214.943409] Starting dynamic subtest: pipe-C-eDP-1
[214.945261] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[214.954250] Starting dynamic subtest: pipe-D-eDP-1
[214.956133] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[214.958190] Subtest lessee-list: SUCCESS (0.008s)
[215.039977] [053/133] (804s left) gem_mmap_gtt (flink-race)
[215.098563] Subtest flink-race: SKIP (0.000s)
[215.165468] [054/133] (804s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[215.218154] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[215.324631] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[215.409497] [055/133] (804s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[215.523063] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[215.525341] Starting dynamic subtest: pipe-A-eDP-1
[215.597182] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[215.612190] Starting dynamic subtest: pipe-B-eDP-1
[216.737393] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[216.741654] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.218s)
[218.003378] [056/133] (801s left) kms_plane_multiple (2x-tiling-4)
[218.087493] Starting subtest: 2x-tiling-4
[218.091980] Subtest 2x-tiling-4: SKIP (0.000s)
[218.168120] [057/133] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[218.261795] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[222.805167] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.541s)
[224.014398] [058/133] (795s left) kms_rotation_crc (sprite-rotation-90)
[224.109257] Starting subtest: sprite-rotation-90
[224.113840] Subtest sprite-rotation-90: SKIP (0.001s)
[224.196566] [059/133] (795s left) gem_ringfill (legacy-basic)
[230.147904] Starting subtest: legacy-basic
[230.150515] Starting dynamic subtest: default
[230.216751] Dynamic subtest default: SUCCESS (0.068s)
[230.232116] Starting dynamic subtest: render
[230.259355] Dynamic subtest render: SUCCESS (0.041s)
[230.271169] Starting dynamic subtest: bsd
[230.302376] Dynamic subtest bsd: SUCCESS (0.041s)
[230.313295] Starting dynamic subtest: bsd1
[230.342372] Dynamic subtest bsd1: SUCCESS (0.038s)
[230.352751] Starting dynamic subtest: bsd2
[230.384348] Dynamic subtest bsd2: SUCCESS (0.040s)
[230.395218] Starting dynamic subtest: blt
[230.430345] Dynamic subtest blt: SUCCESS (0.044s)
[230.441625] Starting dynamic subtest: vebox
[230.474484] Dynamic subtest vebox: SUCCESS (0.042s)
[230.476898] Subtest legacy-basic: SUCCESS (0.328s)
[230.552031] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[230.555779] [060/133] (789s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[230.661638] Starting subtest: psr-rgb565-draw-blt
[237.705210] Subtest psr-rgb565-draw-blt: SUCCESS (7.047s)
[237.829627] [061/133] (781s left) gem_exec_fence (basic-await)
[238.010731] Starting subtest: basic-await
[238.013099] Starting dynamic subtest: rcs0
[238.087569] Dynamic subtest rcs0: SUCCESS (0.077s)
[238.100025] Starting dynamic subtest: bcs0
[238.163283] Dynamic subtest bcs0: SUCCESS (0.074s)
[238.176783] Starting dynamic subtest: vcs0
[238.236683] Dynamic subtest vcs0: SUCCESS (0.072s)
[238.249302] Starting dynamic subtest: vcs1
[238.310151] Dynamic subtest vcs1: SUCCESS (0.073s)
[238.322530] Starting dynamic subtest: vecs0
[238.384807] Dynamic subtest vecs0: SUCCESS (0.073s)
[238.396443] Starting dynamic subtest: ccs0
[238.457821] Dynamic subtest ccs0: SUCCESS (0.071s)
[238.460753] Subtest basic-await: SUCCESS (0.448s)
[240.276393] [062/133] (779s left) perf_pmu (busy-check-all)
[240.316236] Starting subtest: busy-check-all
[240.318539] Starting dynamic subtest: rcs0
[240.872081] Dynamic subtest rcs0: SUCCESS (0.555s)
[240.883759] Starting dynamic subtest: bcs0
[241.425090] Dynamic subtest bcs0: SUCCESS (0.552s)
[241.438004] Starting dynamic subtest: vcs0
[243.137110] Dynamic subtest vcs0: SUCCESS (1.708s)
[243.152234] Starting dynamic subtest: vcs1
[245.120817] Dynamic subtest vcs1: SUCCESS (1.981s)
[245.134108] Starting dynamic subtest: vecs0
[247.104580] Dynamic subtest vecs0: SUCCESS (1.981s)
[247.118235] Starting dynamic subtest: ccs0
[247.659469] Dynamic subtest ccs0: SUCCESS (0.554s)
[247.662178] Subtest busy-check-all: SUCCESS (7.346s)
[247.790142] [063/133] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[247.898325] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[247.902471] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[248.015489] [064/133] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[248.113776] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[254.796992] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.684s)
[254.948033] [065/133] (765s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[255.017188] Starting subtest: stress-mm-invalidate-close-overlap
[257.167153] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[257.318021] [066/133] (762s left) gen9_exec_parse (bb-start-cmd)
[257.383560] Subtest bb-start-cmd: SKIP (0.000s)
[257.457742] [067/133] (762s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[257.522778] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[257.590414] [068/133] (762s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[257.646899] Starting subtest: invalid-single-wait-unsubmitted
[257.649340] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[257.755468] [069/133] (762s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[257.849148] Starting subtest: bad-pixel-format-yf-tiled-ccs
[257.851441] Starting dynamic subtest: pipe-A-eDP-1
[257.874239] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[257.886427] Starting dynamic subtest: pipe-B-eDP-1
[257.908021] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[257.917710] Starting dynamic subtest: pipe-C-eDP-1
[257.939246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[257.948865] Starting dynamic subtest: pipe-D-eDP-1
[257.971729] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[257.975932] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[260.106874] [070/133] (760s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[260.202241] Starting subtest: primary-yf-tiled-reflect-x-270
[260.206488] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[260.277267] [071/133] (759s left) kms_flip (wf_vblank-ts-check-interruptible)
[260.374132] Starting subtest: wf_vblank-ts-check-interruptible
[260.376511] Starting dynamic subtest: A-eDP1
[269.318843] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[269.331173] Starting dynamic subtest: B-eDP1
[278.215135] Dynamic subtest B-eDP1: SUCCESS (8.891s)
[278.229012] Starting dynamic subtest: C-eDP1
[287.106730] Dynamic subtest C-eDP1: SUCCESS (8.885s)
[287.119269] Starting dynamic subtest: D-eDP1
[296.011630] Dynamic subtest D-eDP1: SUCCESS (8.901s)
[296.016501] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.633s)
[297.225222] [072/133] (723s left) kms_flip (2x-flip-vs-modeset)
[297.326047] Starting subtest: 2x-flip-vs-modeset
[297.335261] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[297.416504] [073/133] (722s left) gem_workarounds (basic-read-context)
[297.486614] Starting subtest: basic-read-context
[297.502121] Subtest basic-read-context: SUCCESS (0.016s)
[297.624159] [074/133] (722s left) gem_pxp (create-regular-context-1)
[297.744249] Starting subtest: create-regular-context-1
[297.747020] Subtest create-regular-context-1: SUCCESS (0.002s)
[297.863721] [075/133] (722s left) kms_chamelium_color (ctm-0-25)
[297.949408] Subtest ctm-0-25: SKIP (0.000s)
[298.001542] [076/133] (722s left) i915_drm_fdinfo (busy-idle-check-all)
[298.042779] Starting subtest: busy-idle-check-all
[298.045050] Starting dynamic subtest: rcs0
[298.049281] Dynamic subtest rcs0: SKIP (0.004s)
[298.060190] Starting dynamic subtest: bcs0
[298.064282] Dynamic subtest bcs0: SKIP (0.000s)
[298.074059] Starting dynamic subtest: vcs0
[298.078444] Dynamic subtest vcs0: SKIP (0.000s)
[298.087593] Starting dynamic subtest: vcs1
[298.091530] Dynamic subtest vcs1: SKIP (0.000s)
[298.100841] Starting dynamic subtest: vecs0
[298.104880] Dynamic subtest vecs0: SKIP (0.000s)
[298.113818] Starting dynamic subtest: ccs0
[298.117878] Dynamic subtest ccs0: SKIP (0.000s)
[298.121896] Subtest busy-idle-check-all: SKIP (0.009s)
[298.161079] [077/133] (722s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[298.302757] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[298.306470] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[298.391882] [078/133] (722s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[298.485371] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[298.489017] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[298.560792] [079/133] (722s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[298.666543] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[305.388495] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.726s)
[305.510922] [080/133] (715s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[305.610104] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[305.612277] Starting dynamic subtest: pipe-A
[305.719743] Dynamic subtest pipe-A: SKIP (0.107s)
[305.729420] Starting dynamic subtest: pipe-B
[306.960747] Dynamic subtest pipe-B: SKIP (1.241s)
[306.972164] Starting dynamic subtest: pipe-C
[308.141655] Dynamic subtest pipe-C: SUCCESS (1.182s)
[308.167035] Starting dynamic subtest: pipe-D
[309.343781] Dynamic subtest pipe-D: SUCCESS (1.203s)
[309.346056] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.737s)
[310.495858] [081/133] (710s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[310.598010] Starting subtest: fbcpsr-stridechange
[316.751337] Subtest fbcpsr-stridechange: SUCCESS (6.156s)
[316.916536] [082/133] (703s left) kms_atomic_transition (plane-toggle-modeset-transition)
[317.006621] Starting subtest: plane-toggle-modeset-transition
[317.008477] Starting dynamic subtest: pipe-A-eDP-1
[330.107104] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.101s)
[330.120766] Starting dynamic subtest: pipe-B-eDP-1
[343.000215] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.887s)
[343.002818] Subtest plane-toggle-modeset-transition: SUCCESS (25.994s)
[343.815816] [083/133] (676s left) syncobj_wait (wait-delayed-signal)
[343.885853] Starting subtest: wait-delayed-signal
[343.988532] Subtest wait-delayed-signal: SUCCESS (0.103s)
[344.077123] [084/133] (676s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[344.176554] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[344.178491] Starting dynamic subtest: pipe-A-eDP-1
[345.005176] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[345.016528] Starting dynamic subtest: pipe-B-eDP-1
[346.773117] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.766s)
[346.783474] Starting dynamic subtest: pipe-C-eDP-1
[348.284373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s)
[348.295855] Starting dynamic subtest: pipe-D-eDP-1
[349.781612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.496s)
[349.783982] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.598s)
[350.998556] [085/133] (669s left) api_intel_allocator (execbuf-with-allocator)
[351.065871] Starting subtest: execbuf-with-allocator
[351.069357] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[351.198796] [086/133] (669s left) gem_eio (in-flight-contexts-1us)
[351.397096] Starting subtest: in-flight-contexts-1us
[365.214801] Subtest in-flight-contexts-1us: SUCCESS (13.813s)
[365.386261] [087/133] (655s left) kms_psr (psr2-sprite-mmap-cpu)
[365.495248] Starting subtest: psr2-sprite-mmap-cpu
[365.497458] Starting dynamic subtest: eDP-1
[367.265255] Dynamic subtest eDP-1: SUCCESS (1.768s)
[367.267416] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.769s)
[368.106268] [088/133] (652s left) sw_sync (timeline_closed_signaled)
[368.154608] Starting subtest: timeline_closed_signaled
[368.156885] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[368.218818] [089/133] (652s left) gem_ppgtt (blt-vs-render-ctx0)
[368.286424] Starting subtest: blt-vs-render-ctx0
[401.356236] Subtest blt-vs-render-ctx0: SUCCESS (33.062s)
[401.493902] [090/133] (619s left) gem_eio (in-flight-internal-immediate)
[401.799172] Starting subtest: in-flight-internal-immediate
[403.226370] Subtest in-flight-internal-immediate: SUCCESS (1.426s)
[403.384853] [091/133] (617s left) kms_psr (fbc-psr2-primary-render)
[403.480072] Starting subtest: fbc-psr2-primary-render
[403.482390] Starting dynamic subtest: eDP-1
[403.486424] Dynamic subtest eDP-1: SKIP (0.000s)
[403.490416] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[403.554520] [092/133] (617s left) api_intel_bb (intel-bb-blit-x)
[403.610284] Starting subtest: intel-bb-blit-x
[407.295169] Subtest intel-bb-blit-x: SUCCESS (3.684s)
[407.416751] [093/133] (613s left) gem_spin_batch (engines)
[407.481259] Starting subtest: engines
[407.483948] Starting dynamic subtest: rcs0
[410.728419] Dynamic subtest rcs0: SUCCESS (3.241s)
[410.747735] Starting dynamic subtest: bcs0
[413.967281] Dynamic subtest bcs0: SUCCESS (3.235s)
[413.978718] Starting dynamic subtest: vcs0
[417.207392] Dynamic subtest vcs0: SUCCESS (3.236s)
[417.218295] Starting dynamic subtest: vcs1
[420.444798] Dynamic subtest vcs1: SUCCESS (3.234s)
[420.457387] Starting dynamic subtest: vecs0
[423.684285] Dynamic subtest vecs0: SUCCESS (3.236s)
[423.696999] Starting dynamic subtest: ccs0
[426.920925] Dynamic subtest ccs0: SUCCESS (3.233s)
[426.923091] Subtest engines: SUCCESS (19.432s)
[427.151147] [094/133] (594s left) kms_big_fb (linear-32bpp-rotate-270)
[427.252895] Starting subtest: linear-32bpp-rotate-270
[427.271638] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[427.387818] [095/133] (593s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[427.476559] Starting subtest: fbcpsr-rgb565-draw-pwrite
[434.488094] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.015s)
[434.605571] [096/133] (586s left) perf (whitelisted-registers-userspace-config)
[434.754486] Starting subtest: whitelisted-registers-userspace-config
[434.756241] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[434.798782] [097/133] (586s left) perf (polling-small-buf)
[434.878580] Starting subtest: polling-small-buf
[434.971263] Subtest polling-small-buf: SUCCESS (0.090s)
[435.023718] [098/133] (586s left) kms_getfb (getfb2-handle-protection)
[435.110276] Starting subtest: getfb2-handle-protection
[435.126509] Subtest getfb2-handle-protection: SUCCESS (0.018s)
[435.226403] [099/133] (586s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[435.605111] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[436.384774] [100/133] (585s left) gem_exec_schedule (u-submit-early-slice)
[436.456410] Starting subtest: u-submit-early-slice
[436.458279] Starting dynamic subtest: rcs0
[436.490394] Dynamic subtest rcs0: SUCCESS (0.042s)
[436.503267] Starting dynamic subtest: bcs0
[436.532408] Dynamic subtest bcs0: SUCCESS (0.041s)
[436.543620] Starting dynamic subtest: vcs0
[436.574238] Dynamic subtest vcs0: SUCCESS (0.041s)
[436.586522] Starting dynamic subtest: vcs1
[436.616892] Dynamic subtest vcs1: SUCCESS (0.042s)
[436.628373] Starting dynamic subtest: vecs0
[436.656870] Dynamic subtest vecs0: SUCCESS (0.039s)
[436.668671] Starting dynamic subtest: ccs0
[436.702522] Dynamic subtest ccs0: SUCCESS (0.045s)
[436.704947] Subtest u-submit-early-slice: SUCCESS (0.255s)
[438.251622] [101/133] (583s left) dumb_buffer (map-invalid-size)
[438.303387] Starting subtest: map-invalid-size
[438.305263] Subtest map-invalid-size: SUCCESS (0.000s)
[438.400831] [102/133] (583s left) gem_unfence_active_buffers
[438.571029] [103/133] (583s left) gem_exec_balancer (invalid-balancer)
[438.635567] Starting subtest: invalid-balancer
[439.555280] Subtest invalid-balancer: SUCCESS (0.918s)
[439.855786] [104/133] (581s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[439.911261] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[440.020027] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[440.099419] [105/133] (581s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[440.197165] Starting subtest: 4-tiled-16bpp-rotate-90
[440.217475] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[440.332102] [106/133] (581s left) kms_async_flips (test-cursor-atomic)
[440.427357] Starting subtest: test-cursor-atomic
[440.805130] Starting dynamic subtest: pipe-A-eDP-1
[441.557543] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[441.940416] Starting dynamic subtest: pipe-B-eDP-1
[442.758329] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.827s)
[443.129489] Starting dynamic subtest: pipe-C-eDP-1
[443.863275] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.742s)
[444.246383] Starting dynamic subtest: pipe-D-eDP-1
[445.050571] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.824s)
[445.052890] Subtest test-cursor-atomic: SUCCESS (4.626s)
[446.309848] [107/133] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[446.412591] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[446.416983] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[446.503885] [108/133] (575s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[446.886509] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[447.679777] [109/133] (574s left) kms_cursor_legacy (torture-bo)
[447.789947] Starting subtest: torture-bo
[447.792306] Starting dynamic subtest: pipe-A
[453.507496] Dynamic subtest pipe-A: SUCCESS (5.714s)
[453.519387] Starting dynamic subtest: pipe-B
[460.648689] Dynamic subtest pipe-B: SUCCESS (7.140s)
[460.662454] Starting dynamic subtest: pipe-C
[467.553878] Dynamic subtest pipe-C: SUCCESS (6.903s)
[467.566014] Starting dynamic subtest: pipe-D
[475.501929] Dynamic subtest pipe-D: SUCCESS (7.944s)
[475.515758] Starting dynamic subtest: all-pipes
[483.084842] Dynamic subtest all-pipes: SUCCESS (7.579s)
[483.087382] Subtest torture-bo: SUCCESS (35.292s)
[483.257365] [110/133] (538s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[483.352009] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[483.354144] Starting dynamic subtest: pipe-A-eDP-1
[484.243957] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s)
[484.259748] Starting dynamic subtest: pipe-B-eDP-1
[485.847255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.597s)
[485.859362] Starting dynamic subtest: pipe-C-eDP-1
[487.390181] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.544s)
[487.407505] Starting dynamic subtest: pipe-D-eDP-1
[488.866443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.474s)
[488.868526] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.507s)
[490.018414] [111/133] (531s left) gem_exec_fence (syncobj-invalid-flags)
[490.494321] Starting subtest: syncobj-invalid-flags
[490.496796] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[492.252809] [112/133] (529s left) gem_exec_reloc (basic-write-read-active)
[492.309302] Subtest basic-write-read-active: SKIP (0.000s)
[492.389049] [113/133] (529s left) kms_psr (fbc-pr-cursor-render)
[492.472325] Starting subtest: fbc-pr-cursor-render
[492.476657] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[492.568286] [114/133] (529s left) gem_eio (kms)
[492.832055] Starting subtest: kms
[512.444757] Subtest kms: SUCCESS (19.611s)
[513.610013] [115/133] (508s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[513.718329] Starting subtest: plane-lut1d-post-ctm3x4
[513.864270] Starting dynamic subtest: pipe-A-plane-0
[514.031251] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[514.042770] Starting dynamic subtest: pipe-A-plane-1
[514.186712] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[514.197694] Starting dynamic subtest: pipe-A-plane-2
[514.376882] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[515.603468] Starting dynamic subtest: pipe-B-plane-0
[515.793958] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[515.804906] Starting dynamic subtest: pipe-B-plane-1
[515.982763] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[515.994148] Starting dynamic subtest: pipe-B-plane-2
[516.149457] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[517.343652] Starting dynamic subtest: pipe-C-plane-0
[517.467444] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[517.478270] Starting dynamic subtest: pipe-C-plane-1
[517.611547] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[517.622813] Starting dynamic subtest: pipe-C-plane-2
[517.756566] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[518.960003] Starting dynamic subtest: pipe-D-plane-0
[519.117251] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[519.137908] Starting dynamic subtest: pipe-D-plane-1
[519.282820] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[519.293956] Starting dynamic subtest: pipe-D-plane-2
[519.450266] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[519.736891] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.019s)
[520.594169] [116/133] (501s left) gem_userptr_blits (create-destroy-unsync)
[520.657335] Subtest create-destroy-unsync: SKIP (0.000s)
[520.790415] [117/133] (501s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[520.888163] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[520.892328] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[520.961662] [118/133] (501s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[521.047827] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[521.051848] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[521.141229] [119/133] (501s left) core_auth (basic-auth)
[521.201171] Starting subtest: basic-auth
[521.203486] Subtest basic-auth: SUCCESS (0.001s)
[521.318025] [120/133] (501s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[521.528782] Starting subtest: cursor-rapid-movement-64x21
[521.582443] Subtest cursor-rapid-movement-64x21: SKIP (0.050s)
[521.830964] [121/133] (500s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[521.931300] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[522.778565] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[522.944232] [122/133] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[523.033624] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[523.037718] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[523.154507] [123/133] (499s left) kms_plane_alpha_blend (alpha-opaque-fb)
[523.251567] Starting subtest: alpha-opaque-fb
[523.546806] Starting dynamic subtest: pipe-A-eDP-1
[524.191588] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[524.203235] Starting dynamic subtest: pipe-D-eDP-1
[525.535753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[525.538027] Subtest alpha-opaque-fb: SUCCESS (2.285s)
[526.384850] [124/133] (496s left) gem_exec_whisper (basic-fds-priority)
[526.453873] Starting subtest: basic-fds-priority
[550.746855] Subtest basic-fds-priority: SUCCESS (24.289s)
[550.935329] [125/133] (471s left) gem_exec_schedule (pi-distinct-iova)
[551.125028] Starting subtest: pi-distinct-iova
[551.127420] Starting dynamic subtest: rcs0
[551.250790] Dynamic subtest rcs0: SUCCESS (0.127s)
[551.264115] Starting dynamic subtest: vcs0
[551.342664] Dynamic subtest vcs0: SUCCESS (0.093s)
[551.357622] Starting dynamic subtest: vcs1
[551.433081] Dynamic subtest vcs1: SUCCESS (0.089s)
[551.448429] Starting dynamic subtest: vecs0
[551.525971] Dynamic subtest vecs0: SUCCESS (0.092s)
[551.540778] Starting dynamic subtest: ccs0
[551.645048] Dynamic subtest ccs0: SUCCESS (0.117s)
[551.647512] Subtest pi-distinct-iova: SUCCESS (0.523s)
[553.247240] [126/133] (469s left) kms_joiner (basic-big-joiner)
[553.350633] Starting subtest: basic-big-joiner
[553.354644] Subtest basic-big-joiner: SKIP (0.000s)
[553.434540] [127/133] (469s left) drm_read (empty-block)
[553.580278] Starting subtest: empty-block
[554.581743] Subtest empty-block: SUCCESS (1.000s)
[554.728583] [128/133] (468s left) i915_hangman (engine-error-state-capture)
[554.790312] Starting subtest: engine-error-state-capture
[554.792762] Starting dynamic subtest: rcs0
[558.110827] Dynamic subtest rcs0: SUCCESS (3.320s)
[558.129022] Starting dynamic subtest: bcs0
[564.126446] Dynamic subtest bcs0: SUCCESS (6.012s)
[564.141311] Starting dynamic subtest: vcs0
[570.086500] Dynamic subtest vcs0: SUCCESS (5.946s)
[570.100134] Starting dynamic subtest: vcs1
[575.070563] Dynamic subtest vcs1: SUCCESS (4.990s)
[575.084895] Starting dynamic subtest: vecs0
[580.062281] Dynamic subtest vecs0: SUCCESS (4.988s)
[580.076575] Starting dynamic subtest: ccs0
[585.116612] Dynamic subtest ccs0: SUCCESS (5.051s)
[585.119504] Subtest engine-error-state-capture: SUCCESS (30.323s)
[585.252481] [129/133] (437s left) gem_exec_whisper (basic-sync-all)
[585.330259] Starting subtest: basic-sync-all
[593.490845] Subtest basic-sync-all: SUCCESS (8.157s)
[593.681486] [130/133] (429s left) gem_mmap_gtt (medium-copy-odd)
[593.737381] Subtest medium-copy-odd: SKIP (0.000s)
[593.802263] [131/133] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[593.894544] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[593.898605] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[593.989499] [132/133] (428s left) gem_mmap_gtt (big-bo-tiledy)
[594.044270] Subtest big-bo-tiledY: SKIP (0.000s)
[594.115145] [133/133] (428s left) gem_ctx_param (invalid-get-no-zeromap)
[594.182626] Starting subtest: invalid-get-no-zeromap
[594.184973] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[594.307205] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: i915_suspend
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: gem_mmap
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_selftest
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_dsc
results: parsing output: 27/ for test: i915_pm_rpm
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: gem_madvise
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: sysfs_heartbeat_interval
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: kms_pm_backlight
results: parsing output: 48/ for test: gem_vm_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_plane_multiple
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: gem_ringfill
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_fence
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_rotation_crc
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: gem_ppgtt
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: gem_unfence_active_buffers
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_async_flips
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_chamelium_edid
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: core_auth
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_alpha_blend
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: kms_joiner
results: parsing output: 126/ for test: drm_read
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: gem_ctx_param
Done.