[59.157770] Initializing watchdogs
[59.157814]   /dev/watchdog0
[59.171144] [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]
[59.175197] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.177353] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.180406] [001/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[59.302381] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[59.306920] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[59.421838] [002/130] (960s left) gem_exec_schedule (out-order)
[59.496228] Starting subtest: out-order
[59.498496] Starting dynamic subtest: rcs0
[59.599368] Dynamic subtest rcs0: SUCCESS (0.108s)
[59.610043] Starting dynamic subtest: vcs0
[59.681651] Dynamic subtest vcs0: SUCCESS (0.083s)
[59.690766] Starting dynamic subtest: vcs1
[59.759716] Dynamic subtest vcs1: SUCCESS (0.078s)
[59.766709] Starting dynamic subtest: vecs0
[59.838888] Dynamic subtest vecs0: SUCCESS (0.078s)
[59.849834] Starting dynamic subtest: ccs0
[59.918990] Dynamic subtest ccs0: SUCCESS (0.080s)
[59.921648] Subtest out-order: SUCCESS (0.428s)
[61.019136] [003/130] (958s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[61.115441] Starting subtest: fbc-psr2-cursor-mmap-gtt
[61.117912] Starting dynamic subtest: eDP-1
[61.122622] Dynamic subtest eDP-1: SKIP (0.000s)
[61.127323] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[61.212476] [004/130] (958s left) kms_pipe_crc_basic (suspend-read-crc)
[61.307780] Starting subtest: suspend-read-crc
[61.309786] Starting dynamic subtest: pipe-A-eDP-1
[79.228566] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.275s)
[79.239463] Starting dynamic subtest: pipe-B-eDP-1
[97.175369] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.184s)
[97.185606] Starting dynamic subtest: pipe-C-eDP-1
[115.127887] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.001s)
[115.137907] Starting dynamic subtest: pipe-D-eDP-1
[133.130557] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.076s)
[133.133180] Subtest suspend-read-crc: SUCCESS (15.540s)
[133.985541] [005/130] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[134.098256] Starting subtest: fbcpsr-2p-rte
[134.103250] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[134.223993] [006/130] (885s left) kms_hdr (static-toggle)
[134.323226] Starting subtest: static-toggle
[134.331218] Subtest static-toggle: SKIP (0.000s)
[134.417825] [007/130] (885s left) gem_userptr_blits (sync-unmap-after-close)
[134.486098] Starting subtest: sync-unmap-after-close
[134.501180] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[134.644185] [008/130] (885s left) kms_selftest (drm_cmdline_parser)
[134.679151] Starting subtest: drm_cmdline_parser
[134.698912] Starting dynamic subtest: drm_test_cmdline_force_d_only
[134.842053] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.144s)
[134.852618] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[134.986046] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.143s)
[134.995371] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[135.125933] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.139s)
[135.135876] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[135.277042] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.150s)
[135.287433] Starting dynamic subtest: drm_test_cmdline_force_e_only
[135.403734] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.128s)
[135.412438] Starting dynamic subtest: drm_test_cmdline_res
[135.514721] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.110s)
[135.525020] Starting dynamic subtest: drm_test_cmdline_res_vesa
[135.653052] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.138s)
[135.663041] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[135.785284] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.131s)
[135.794029] Starting dynamic subtest: drm_test_cmdline_res_rblank
[135.905296] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.119s)
[135.916254] Starting dynamic subtest: drm_test_cmdline_res_bpp
[136.031678] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.126s)
[136.040405] Starting dynamic subtest: drm_test_cmdline_res_refresh
[136.155314] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.124s)
[136.166240] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[136.288402] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.133s)
[136.299038] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[136.425709] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.137s)
[136.436119] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[136.553411] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.126s)
[136.563880] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[136.678973] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.125s)
[136.689038] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[136.790389] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.111s)
[136.800930] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[136.918380] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.126s)
[136.928305] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[137.030995] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.114s)
[137.047029] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[137.158100] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.127s)
[137.174002] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[137.267231] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.109s)
[137.277797] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[137.408391] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.140s)
[137.418585] Starting dynamic subtest: drm_test_cmdline_name
[137.532541] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.124s)
[137.543069] Starting dynamic subtest: drm_test_cmdline_name_bpp
[137.656435] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.123s)
[137.666196] Starting dynamic subtest: drm_test_cmdline_name_option
[137.782015] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.125s)
[137.792408] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[137.862450] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.079s)
[137.872948] Starting dynamic subtest: drm_test_cmdline_rotate_0
[137.965371] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.105s)
[137.975866] Starting dynamic subtest: drm_test_cmdline_rotate_90
[138.071425] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.106s)
[138.082192] Starting dynamic subtest: drm_test_cmdline_rotate_180
[138.186554] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.115s)
[138.197405] Starting dynamic subtest: drm_test_cmdline_rotate_270
[138.326000] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.138s)
[138.336029] Starting dynamic subtest: drm_test_cmdline_hmirror
[138.490685] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.166s)
[138.499357] Starting dynamic subtest: drm_test_cmdline_vmirror
[138.646104] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.154s)
[138.654642] Starting dynamic subtest: drm_test_cmdline_margin_options
[138.791134] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.145s)
[138.800376] Starting dynamic subtest: drm_test_cmdline_multiple_options
[138.938146] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.146s)
[138.949418] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[139.074382] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.136s)
[139.085045] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[139.215204] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.140s)
[139.225439] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[139.373682] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.159s)
[139.384293] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[139.523256] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.147s)
[139.533410] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[139.647408] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.126s)
[139.658169] Starting dynamic subtest: drm_test_cmdline_invalid
[139.775661] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.127s)
[139.784539] Starting dynamic subtest: drm_test_cmdline_tv_options
[139.915909] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.139s)
[139.918358] Subtest drm_cmdline_parser: SUCCESS (5.234s)
[140.141518] [009/130] (879s left) gem_exec_gttfill (engines)
[140.208296] Starting subtest: engines
[140.211175] Starting dynamic subtest: rcs0
[163.380576] Dynamic subtest rcs0: SUCCESS (23.173s)
[163.389731] Starting dynamic subtest: bcs0
[186.688654] Dynamic subtest bcs0: SUCCESS (23.301s)
[186.700746] Starting dynamic subtest: vcs0
[209.937831] Dynamic subtest vcs0: SUCCESS (23.244s)
[209.950452] Starting dynamic subtest: vcs1
[233.210104] Dynamic subtest vcs1: SUCCESS (23.271s)
[233.222325] Starting dynamic subtest: vecs0
[256.475926] Dynamic subtest vecs0: SUCCESS (23.263s)
[256.487413] Starting dynamic subtest: ccs0
[279.801073] Dynamic subtest ccs0: SUCCESS (23.322s)
[279.803578] Subtest engines: SUCCESS (139.580s)
[280.008545] [010/130] (740s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[280.176124] Starting subtest: fbc-rgb101010-draw-blt
[284.802920] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.630s)
[285.995453] [011/130] (734s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[286.111240] Starting subtest: yf-tiled-8bpp-rotate-270
[286.116220] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[286.230862] [012/130] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[286.342389] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[286.347877] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[286.467825] [013/130] (733s left) i915_getparams_basic (basic-eu-total)
[286.525369] Starting subtest: basic-eu-total
[286.530395] Subtest basic-eu-total: SUCCESS (0.000s)
[286.639814] [014/130] (733s left) prime_vgem (fence-wait)
[286.815560] Starting subtest: fence-wait
[286.818209] Starting dynamic subtest: rcs0
[287.866715] Dynamic subtest rcs0: SUCCESS (1.051s)
[287.877305] Starting dynamic subtest: bcs0
[288.931022] Dynamic subtest bcs0: SUCCESS (1.065s)
[288.942397] Starting dynamic subtest: vcs0
[289.977024] Dynamic subtest vcs0: SUCCESS (1.043s)
[289.989275] Starting dynamic subtest: vcs1
[291.019244] Dynamic subtest vcs1: SUCCESS (1.041s)
[291.031613] Starting dynamic subtest: vecs0
[292.061054] Dynamic subtest vecs0: SUCCESS (1.040s)
[292.076072] Starting dynamic subtest: ccs0
[293.108735] Dynamic subtest ccs0: SUCCESS (1.046s)
[293.111542] Subtest fence-wait: SUCCESS (6.293s)
[293.285510] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[293.289170] [015/130] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[293.399199] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[293.404634] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[293.529372] [016/130] (726s left) gem_ctx_shared (exec-shared-gtt)
[293.602364] Starting subtest: exec-shared-gtt
[293.605229] Starting dynamic subtest: rcs0
[293.611465] Dynamic subtest rcs0: SUCCESS (0.011s)
[293.623417] Starting dynamic subtest: bcs0
[293.626464] Dynamic subtest bcs0: SUCCESS (0.007s)
[293.635938] Starting dynamic subtest: vcs0
[293.638375] Dynamic subtest vcs0: SUCCESS (0.006s)
[293.647948] Starting dynamic subtest: vcs1
[293.650162] Dynamic subtest vcs1: SUCCESS (0.005s)
[293.659517] Starting dynamic subtest: vecs0
[293.661847] Dynamic subtest vecs0: SUCCESS (0.005s)
[293.670663] Starting dynamic subtest: ccs0
[293.672985] Dynamic subtest ccs0: SUCCESS (0.005s)
[293.675228] Subtest exec-shared-gtt: SUCCESS (0.039s)
[293.848296] [017/130] (726s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[293.980122] Starting subtest: modeset-atomic-cursor-hotspot
[293.984969] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[294.148268] [018/130] (726s left) kms_plane_cursor (viewport)
[294.246656] Starting subtest: viewport
[294.250805] Starting dynamic subtest: pipe-A-eDP-1-size-64
[296.683297] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.436s)
[296.742327] Starting dynamic subtest: pipe-A-eDP-1-size-128
[299.185952] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.450s)
[299.250869] Starting dynamic subtest: pipe-A-eDP-1-size-256
[301.661427] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.427s)
[302.013957] Starting dynamic subtest: pipe-B-eDP-1-size-64
[305.138087] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.136s)
[305.201054] Starting dynamic subtest: pipe-B-eDP-1-size-128
[307.605619] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.415s)
[307.665804] Starting dynamic subtest: pipe-B-eDP-1-size-256
[310.107563] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.449s)
[310.463606] Starting dynamic subtest: pipe-C-eDP-1-size-64
[313.287383] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.836s)
[313.326231] Starting dynamic subtest: pipe-C-eDP-1-size-128
[315.400248] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[315.442049] Starting dynamic subtest: pipe-C-eDP-1-size-256
[317.454177] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.024s)
[317.783400] Starting dynamic subtest: pipe-D-eDP-1-size-64
[320.597098] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.826s)
[320.635233] Starting dynamic subtest: pipe-D-eDP-1-size-128
[322.665228] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.036s)
[322.702377] Starting dynamic subtest: pipe-D-eDP-1-size-256
[324.766247] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.068s)
[325.109298] Subtest viewport: SUCCESS (30.860s)
[325.929619] [019/130] (694s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[326.050407] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[326.054864] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[326.189006] [020/130] (694s left) kms_psr2_su (page_flip-xrgb8888)
[326.253158] Subtest page_flip-XRGB8888: SKIP (0.000s)
[326.321133] [021/130] (694s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[326.425297] Starting subtest: 4-tiled-32bpp-rotate-90
[326.445265] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[326.609075] [022/130] (693s left) kms_vblank (ts-continuation-dpms-rpm)
[326.714200] Starting subtest: ts-continuation-dpms-rpm
[326.716397] Starting dynamic subtest: pipe-A-eDP-1
[329.192396] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.478s)
[329.208398] Starting dynamic subtest: pipe-D-eDP-1
[331.456353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.262s)
[331.459257] Subtest ts-continuation-dpms-rpm: SUCCESS (4.743s)
[332.270683] [023/130] (688s left) template (a)
[332.332291] Starting subtest: A
[332.335204] Subtest A: SUCCESS (0.000s)
[332.451184] [024/130] (688s left) i915_pm_rc6_residency (rc6-accuracy)
[332.512260] Starting subtest: rc6-accuracy
[332.514628] Starting dynamic subtest: gt0
[335.683663] Dynamic subtest gt0: SUCCESS (3.169s)
[335.695512] Starting dynamic subtest: gt1
[338.855262] Dynamic subtest gt1: SUCCESS (3.168s)
[338.858186] Subtest rc6-accuracy: SUCCESS (6.343s)
[338.955721] [025/130] (681s left) gem_exec_balancer (parallel)
[339.207383] Starting subtest: parallel
[340.117734] Subtest parallel: SUCCESS (0.910s)
[341.233119] [026/130] (679s left) kms_content_protection (atomic)
[341.380601] Starting subtest: atomic
[341.386185] Subtest atomic: SKIP (0.000s)
[341.572225] [027/130] (679s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[341.701942] Starting subtest: cursor-vs-flip-atomic
[371.008166] Subtest cursor-vs-flip-atomic: SUCCESS (29.303s)
[371.891788] [028/130] (648s left) perf_pmu (enable-race)
[371.937142] Starting subtest: enable-race
[371.939644] Starting dynamic subtest: rcs0
[384.713089] Dynamic subtest rcs0: SUCCESS (12.778s)
[384.723450] Starting dynamic subtest: bcs0
[397.456185] Dynamic subtest bcs0: SUCCESS (12.741s)
[397.468211] Starting dynamic subtest: vcs0
[413.166784] Dynamic subtest vcs0: SUCCESS (15.709s)
[413.177978] Starting dynamic subtest: vcs1
[429.167032] Dynamic subtest vcs1: SUCCESS (15.997s)
[429.179452] Starting dynamic subtest: vecs0
[445.169054] Dynamic subtest vecs0: SUCCESS (15.997s)
[445.179410] Starting dynamic subtest: ccs0
[457.911166] Dynamic subtest ccs0: SUCCESS (12.743s)
[457.914115] Subtest enable-race: SUCCESS (85.976s)
[458.040108] [029/130] (562s left) vgem_basic (create)
[458.079425] Starting subtest: create
[458.081923] Subtest create: SUCCESS (0.000s)
[458.164784] [030/130] (562s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[458.253375] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[458.256132] Starting dynamic subtest: pipe-A-eDP-1
[458.320074] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[458.330322] Starting dynamic subtest: pipe-B-eDP-1
[458.399397] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[458.410298] Starting dynamic subtest: pipe-C-eDP-1
[458.476553] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[458.486393] Starting dynamic subtest: pipe-D-eDP-1
[458.553082] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[458.557945] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[460.455639] [031/130] (560s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[460.561128] Starting subtest: psr-rgb101010-draw-mmap-gtt
[460.566177] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[460.691577] [032/130] (560s left) i915_query (query-regions-unallocated)
[460.753409] Starting subtest: query-regions-unallocated
[460.756013] Subtest query-regions-unallocated: SUCCESS (0.000s)
[460.871974] [033/130] (560s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[461.196074] Starting subtest: cursor-rapid-movement-max-size
[461.204234] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[461.364438] [034/130] (559s left) api_intel_bb (intel-bb-blit-x)
[461.431238] Starting subtest: intel-bb-blit-x
[465.037693] Subtest intel-bb-blit-x: SUCCESS (3.606s)
[465.203362] [035/130] (555s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[465.311276] Starting subtest: bo-too-small-due-to-tiling
[465.316797] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[465.448858] [036/130] (555s left) kms_hdr (bpc-switch-dpms)
[465.549492] Starting subtest: bpc-switch-dpms
[466.608888] Starting dynamic subtest: pipe-A-eDP-1
[471.140381] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.532s)
[471.143316] Subtest bpc-switch-dpms: SUCCESS (5.593s)
[471.301894] [037/130] (549s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[471.410955] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[471.421606] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[471.523828] [038/130] (549s left) syncobj_wait (invalid-signal-illegal-handle)
[471.587407] Starting subtest: invalid-signal-illegal-handle
[471.590113] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[471.728064] [039/130] (549s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[471.791974] Starting subtest: legacy-engines-hostile-preempt
[471.794440] Starting dynamic subtest: render
[471.914059] Dynamic subtest render: SUCCESS (0.122s)
[471.929073] Starting dynamic subtest: bsd1
[473.202965] Dynamic subtest bsd1: SUCCESS (1.284s)
[473.214007] Starting dynamic subtest: bsd2
[475.206994] Dynamic subtest bsd2: SUCCESS (2.001s)
[475.219073] Starting dynamic subtest: blt
[475.285586] Dynamic subtest blt: SUCCESS (0.077s)
[475.297021] Starting dynamic subtest: vebox
[477.195412] Dynamic subtest vebox: SUCCESS (1.905s)
[477.198217] Subtest legacy-engines-hostile-preempt: SUCCESS (5.403s)
[477.302737] [040/130] (544s left) kms_pm_rpm (pc8-residency)
[479.326819] Starting subtest: pc8-residency
[479.331985] Subtest pc8-residency: SKIP (0.000s)
[479.719549] [041/130] (541s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[479.825164] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[479.829422] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.961778] [042/130] (541s left) kms_sequence (get-busy)
[480.061903] Starting subtest: get-busy
[480.064242] Starting dynamic subtest: pipe-A-eDP-1
[481.987006] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[481.998400] Starting dynamic subtest: pipe-B-eDP-1
[484.585860] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.595s)
[484.598490] Starting dynamic subtest: pipe-C-eDP-1
[487.214018] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.626s)
[487.225124] Starting dynamic subtest: pipe-D-eDP-1
[489.744295] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[489.747210] Subtest get-busy: SUCCESS (9.682s)
[490.570972] [043/130] (530s left) gen9_exec_parse (batch-without-end)
[490.639231] Subtest batch-without-end: SKIP (0.000s)
[490.702126] [044/130] (530s left) gem_exec_whisper (basic-queues-forked-all)
[490.781982] Starting subtest: basic-queues-forked-all
[512.332386] Subtest basic-queues-forked-all: SUCCESS (21.547s)
[512.540569] [045/130] (508s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[512.646118] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[512.648914] Starting dynamic subtest: pipe-A
[512.981793] Dynamic subtest pipe-A: SUCCESS (0.338s)
[512.993442] Starting dynamic subtest: pipe-B
[514.444399] Dynamic subtest pipe-B: SUCCESS (1.461s)
[514.460888] Starting dynamic subtest: pipe-C
[515.875126] Dynamic subtest pipe-C: SUCCESS (1.428s)
[515.884987] Starting dynamic subtest: pipe-D
[517.300917] Dynamic subtest pipe-D: SUCCESS (1.425s)
[517.303277] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.658s)
[518.498846] [046/130] (503s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[518.597393] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[518.600186] Starting dynamic subtest: pipe-A-eDP-1
[518.626742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[518.637963] Starting dynamic subtest: pipe-B-eDP-1
[518.663162] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[518.672425] Starting dynamic subtest: pipe-C-eDP-1
[518.698124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[518.707810] Starting dynamic subtest: pipe-D-eDP-1
[518.733000] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[518.738200] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[520.863437] [047/130] (500s left) kms_psr (pr-cursor-plane-onoff)
[520.963427] Starting subtest: pr-cursor-plane-onoff
[520.968405] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[521.057774] [048/130] (500s left) kms_cursor_crc (cursor-alpha-transparent)
[521.147810] Starting subtest: cursor-alpha-transparent
[521.149896] Starting dynamic subtest: pipe-A-eDP-1
[521.790920] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[521.801162] Starting dynamic subtest: pipe-D-eDP-1
[523.100914] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[523.103305] Subtest cursor-alpha-transparent: SUCCESS (1.953s)
[523.927790] [049/130] (497s left) gem_exec_suspend (basic-s3)
[523.986787] Starting subtest: basic-S3
[523.989176] Starting dynamic subtest: smem
[544.166352] Dynamic subtest smem: SUCCESS (6.168s)
[544.169107] Subtest basic-S3: SUCCESS (6.170s)
[544.382019] [050/130] (477s left) kms_properties (colorop-properties-atomic)
[544.508941] Starting subtest: colorop-properties-atomic
[544.511268] Starting dynamic subtest: pipe-A-eDP-1
[544.875493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[544.892217] Starting dynamic subtest: pipe-B-eDP-1
[545.918903] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.039s)
[545.929755] Starting dynamic subtest: pipe-C-eDP-1
[546.946154] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.024s)
[546.960674] Starting dynamic subtest: pipe-D-eDP-1
[547.987433] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.041s)
[547.989789] Subtest colorop-properties-atomic: SUCCESS (3.476s)
[548.808716] [051/130] (472s left) gem_ctx_isolation (clean)
[548.874888] Starting subtest: clean
[548.877300] Starting dynamic subtest: rcs0
[548.940107] Dynamic subtest rcs0: SUCCESS (0.065s)
[548.952363] Starting dynamic subtest: bcs0
[549.017781] Dynamic subtest bcs0: SUCCESS (0.077s)
[549.028553] Starting dynamic subtest: vcs0
[549.085749] Dynamic subtest vcs0: SUCCESS (0.067s)
[549.097801] Starting dynamic subtest: vcs1
[550.194005] Dynamic subtest vcs1: SUCCESS (1.106s)
[550.205726] Starting dynamic subtest: vecs0
[552.215072] Dynamic subtest vecs0: SUCCESS (2.018s)
[552.226643] Starting dynamic subtest: ccs0
[554.222234] Dynamic subtest ccs0: SUCCESS (2.005s)
[554.224698] Subtest clean: SUCCESS (5.344s)
[554.493868] [052/130] (467s left) kms_flip (plain-flip-ts-check)
[554.600128] Starting subtest: plain-flip-ts-check
[554.602460] Starting dynamic subtest: A-eDP1
[563.490695] Dynamic subtest A-eDP1: SUCCESS (8.885s)
[563.513657] Starting dynamic subtest: B-eDP1
[572.318772] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[572.331343] Starting dynamic subtest: C-eDP1
[581.142996] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[581.154512] Starting dynamic subtest: D-eDP1
[589.982657] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[589.984811] Subtest plain-flip-ts-check: SUCCESS (35.377s)
[591.192424] [053/130] (430s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[591.302277] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[591.306746] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[591.440517] [054/130] (430s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[591.537585] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[591.541675] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[591.674676] [055/130] (430s left) gem_wait (write-wait)
[591.747441] Starting subtest: write-wait
[591.749627] Starting dynamic subtest: all-engines
[592.864907] Dynamic subtest all-engines: SUCCESS (1.120s)
[592.886304] Starting dynamic subtest: rcs0
[593.927102] Dynamic subtest rcs0: SUCCESS (1.059s)
[593.945826] Starting dynamic subtest: bcs0
[594.986302] Dynamic subtest bcs0: SUCCESS (1.057s)
[595.004923] Starting dynamic subtest: vcs0
[596.039126] Dynamic subtest vcs0: SUCCESS (1.051s)
[596.055842] Starting dynamic subtest: vcs1
[597.091168] Dynamic subtest vcs1: SUCCESS (1.050s)
[597.107790] Starting dynamic subtest: vecs0
[598.144805] Dynamic subtest vecs0: SUCCESS (1.051s)
[598.161586] Starting dynamic subtest: ccs0
[599.201106] Dynamic subtest ccs0: SUCCESS (1.054s)
[599.203885] Subtest write-wait: SUCCESS (7.457s)
[599.427323] [056/130] (422s left) perf (short-reads)
[599.597413] Starting subtest: short-reads
[599.613301] Subtest short-reads: SUCCESS (0.016s)
[599.661451] [057/130] (422s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[599.776247] Starting subtest: addfb25-y-tiled-small-legacy
[599.780428] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[599.907130] [058/130] (422s left) syncobj_timeline (wait-all-for-submit-complex)
[599.980556] Starting subtest: wait-all-for-submit-complex
[600.195245] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[600.295996] [059/130] (421s left) gem_exec_capture (userptr)
[600.358079] Starting subtest: userptr
[601.181340] Subtest userptr: SUCCESS (0.822s)
[601.347435] [060/130] (420s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[601.412808] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[601.512485] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s)
[601.614167] [061/130] (420s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[601.710372] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[601.712618] Starting dynamic subtest: pipe-A-default-mode
[601.997709] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[602.002359] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.286s)
[602.818902] [062/130] (419s left) drm_read (empty-nonblock)
[602.959204] Starting subtest: empty-nonblock
[602.961637] Subtest empty-nonblock: SUCCESS (0.000s)
[603.129653] [063/130] (419s left) kms_big_fb (y-tiled-addfb-size-overflow)
[603.226850] Starting subtest: y-tiled-addfb-size-overflow
[603.231011] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[603.361428] [064/130] (418s left) api_intel_allocator (reopen-fork)
[603.417168] Starting subtest: reopen-fork
[606.932865] Subtest reopen-fork: SUCCESS (3.516s)
[607.035758] [065/130] (415s left) gem_exec_store (pages)
[607.108382] Starting subtest: pages
[607.110812] Starting dynamic subtest: rcs0
[607.215983] Dynamic subtest rcs0: SUCCESS (0.108s)
[607.227093] Starting dynamic subtest: bcs0
[607.315584] Dynamic subtest bcs0: SUCCESS (0.097s)
[607.328190] Starting dynamic subtest: vcs0
[607.400148] Dynamic subtest vcs0: SUCCESS (0.082s)
[607.412408] Starting dynamic subtest: vcs1
[607.473900] Dynamic subtest vcs1: SUCCESS (0.073s)
[607.486178] Starting dynamic subtest: vecs0
[607.537246] Dynamic subtest vecs0: SUCCESS (0.062s)
[607.549841] Starting dynamic subtest: ccs0
[607.626950] Dynamic subtest ccs0: SUCCESS (0.089s)
[607.629550] Subtest pages: SUCCESS (0.520s)
[607.841589] [066/130] (414s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[607.905230] Starting subtest: multi-wait-all-for-submit-signaled
[607.907527] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[608.045004] [067/130] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[608.140054] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[614.689246] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.550s)
[614.876928] [068/130] (407s left) kms_addfb_basic (unused-offsets)
[614.937155] Starting subtest: unused-offsets
[614.939555] Subtest unused-offsets: SUCCESS (0.000s)
[615.114961] [069/130] (407s left) syncobj_timeline (single-wait-all-available-signaled)
[615.180899] Starting subtest: single-wait-all-available-signaled
[615.183155] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[615.308460] [070/130] (407s left) gem_eio (in-flight-internal-10ms)
[615.490065] Starting subtest: in-flight-internal-10ms
[617.250272] Subtest in-flight-internal-10ms: SUCCESS (1.758s)
[617.428607] [071/130] (405s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[617.541689] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[618.484226] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.944s)
[618.655704] [072/130] (404s left) syncobj_basic (bad-destroy-pad)
[618.721787] Starting subtest: bad-destroy-pad
[618.723710] Subtest bad-destroy-pad: SUCCESS (0.000s)
[618.863932] [073/130] (403s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[618.971599] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[618.973543] Starting dynamic subtest: pipe-A-default-mode
[621.682894] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[621.685192] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.712s)
[622.553874] [074/130] (400s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[622.670775] Starting subtest: psr-2p-primscrn-cur-indfb-move
[622.674862] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[622.808686] [075/130] (399s left) kms_psr (psr2-sprite-mmap-cpu)
[622.903766] Starting subtest: psr2-sprite-mmap-cpu
[622.905891] Starting dynamic subtest: eDP-1
[624.629617] Dynamic subtest eDP-1: SUCCESS (1.724s)
[624.632018] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.725s)
[625.511565] [076/130] (397s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[625.615668] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[629.952659] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.340s)
[631.098386] [077/130] (391s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[636.172896] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[636.177589] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[637.028655] [078/130] (385s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[637.141985] Starting subtest: x-tiled-8bpp-rotate-0
[638.344698] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.202s)
[638.507465] [079/130] (384s left) perf (gen12-mi-rpc)
[638.621021] Starting subtest: gen12-mi-rpc
[638.623199] Starting dynamic subtest: rcs0
[638.640515] Dynamic subtest rcs0: SUCCESS (0.017s)
[638.642155] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[638.689531] [080/130] (384s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[638.786357] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[638.788277] Starting dynamic subtest: pipe-A-eDP-1
[638.807062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.819237] Starting dynamic subtest: pipe-B-eDP-1
[638.836915] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.847318] Starting dynamic subtest: pipe-C-eDP-1
[638.865213] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.877736] Starting dynamic subtest: pipe-D-eDP-1
[638.895883] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.899254] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[641.089812] [081/130] (381s left) kms_joiner (invalid-modeset-big-joiner)
[641.192132] Starting subtest: invalid-modeset-big-joiner
[641.196435] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[641.278191] [082/130] (381s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[641.382098] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[641.384353] Starting dynamic subtest: pipe-A-default-mode
[644.118900] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[644.121091] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.737s)
[644.973578] [083/130] (378s left) gem_exec_fence (invalid-timeline-fence-array)
[645.513120] Starting subtest: invalid-timeline-fence-array
[645.519751] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[647.329177] [084/130] (375s left) kms_chamelium_color (ctm-negative)
[647.410724] Subtest ctm-negative: SKIP (0.000s)
[647.460150] [085/130] (375s left) gem_exec_flush (basic-wb-prw-default)
[647.530816] Starting subtest: basic-wb-prw-default
[652.983517] Subtest basic-wb-prw-default: SUCCESS (5.456s)
[653.204908] [086/130] (370s left) gem_exec_reloc (basic-softpin)
[653.271491] Subtest basic-softpin: SKIP (0.000s)
[653.370056] [087/130] (369s left) gem_mmap_wc (bad-object)
[653.438701] Subtest bad-object: SKIP (0.000s)
[653.505921] [088/130] (369s left) gem_mmap_gtt (pf-nonblock)
[653.570707] Subtest pf-nonblock: SKIP (0.000s)
[653.631421] [089/130] (369s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[654.039447] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[654.854876] [090/130] (368s left) gem_eio (wait-wedge-immediate)
[655.073591] Starting subtest: wait-wedge-immediate
[656.230555] Subtest wait-wedge-immediate: SUCCESS (1.156s)
[656.400108] [091/130] (367s left) prime_mmap (test_forked_cpu_write)
[656.456471] Starting subtest: test_forked_cpu_write
[656.458476] Starting dynamic subtest: test_forked_cpu_write-smem
[656.461684] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[656.464020] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[656.603176] [092/130] (366s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[656.695729] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[656.700023] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[656.851789] [093/130] (366s left) kms_hdmi_inject (inject-4k)
[657.183841] Starting subtest: inject-4k
[657.495622] Subtest inject-4k: SUCCESS (0.314s)
[658.058446] [094/130] (365s left) perf_pmu (frequency)
[658.103475] Starting subtest: frequency
[658.105872] Starting dynamic subtest: gt0
[660.250919] Dynamic subtest gt0: SUCCESS (2.141s)
[660.263538] Starting dynamic subtest: idle-gt0
[660.756630] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[660.769920] Starting dynamic subtest: gt1
[665.220103] Dynamic subtest gt1: SUCCESS (4.458s)
[665.233241] Starting dynamic subtest: idle-gt1
[665.725264] Dynamic subtest idle-gt1: SUCCESS (0.505s)
[665.727871] Subtest frequency: SUCCESS (7.626s)
[665.862234] [095/130] (357s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[665.961993] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[665.964377] Starting dynamic subtest: pipe-A
[666.214798] Dynamic subtest pipe-A: SUCCESS (0.254s)
[666.225849] Starting dynamic subtest: pipe-B
[667.547293] Dynamic subtest pipe-B: SUCCESS (1.332s)
[667.557724] Starting dynamic subtest: pipe-C
[668.849551] Dynamic subtest pipe-C: SUCCESS (1.300s)
[668.867346] Starting dynamic subtest: pipe-D
[670.142210] Dynamic subtest pipe-D: SUCCESS (1.291s)
[670.144556] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.183s)
[671.326840] [096/130] (352s left) gem_mmap_gtt (basic-write-read)
[671.390870] Subtest basic-write-read: SKIP (0.000s)
[671.461577] [097/130] (352s left) gem_softpin (evict-snoop)
[671.513081] Starting subtest: evict-snoop
[671.517606] Subtest evict-snoop: SKIP (0.000s)
[671.653267] [098/130] (352s left) gem_exec_schedule (preempt-user)
[671.736830] Starting subtest: preempt-user
[671.738751] Starting dynamic subtest: rcs0
[671.753598] Dynamic subtest rcs0: SUCCESS (0.024s)
[671.766267] Starting dynamic subtest: bcs0
[671.772884] Dynamic subtest bcs0: SUCCESS (0.019s)
[671.783243] Starting dynamic subtest: vcs0
[671.790998] Dynamic subtest vcs0: SUCCESS (0.017s)
[671.801343] Starting dynamic subtest: vcs1
[671.817861] Dynamic subtest vcs1: SUCCESS (0.025s)
[671.836064] Starting dynamic subtest: vecs0
[671.840778] Dynamic subtest vecs0: SUCCESS (0.021s)
[671.851618] Starting dynamic subtest: ccs0
[671.867422] Dynamic subtest ccs0: SUCCESS (0.028s)
[671.869642] Subtest preempt-user: SUCCESS (0.138s)
[673.280886] [099/130] (350s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[673.410715] Starting subtest: cursor-vs-flip-legacy
[702.657938] Subtest cursor-vs-flip-legacy: SUCCESS (29.245s)
[703.527511] [100/130] (320s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[703.626490] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[703.630510] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[703.753843] [101/130] (320s left) gem_create (create-clear)
[703.817305] Starting subtest: create-clear
[703.819789] Starting dynamic subtest: smem0
[736.618226] Dynamic subtest smem0: SUCCESS (32.794s)
[736.620235] Subtest create-clear: SUCCESS (32.797s)
[736.836520] [102/130] (287s left) kms_flip (absolute-wf_vblank)
[736.938442] Starting subtest: absolute-wf_vblank
[736.940434] Starting dynamic subtest: A-eDP1
[745.627579] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[745.638327] Starting dynamic subtest: B-eDP1
[754.323600] Dynamic subtest B-eDP1: SUCCESS (8.692s)
[754.338454] Starting dynamic subtest: C-eDP1
[763.015889] Dynamic subtest C-eDP1: SUCCESS (8.688s)
[763.026938] Starting dynamic subtest: D-eDP1
[771.714432] Dynamic subtest D-eDP1: SUCCESS (8.697s)
[771.716997] Subtest absolute-wf_vblank: SUCCESS (34.777s)
[772.924073] [103/130] (251s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[773.014175] Starting subtest: plane-use-after-nonblocking-unbind
[773.016355] Starting dynamic subtest: pipe-A-eDP-1
[773.074268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[773.384925] Starting dynamic subtest: pipe-B-eDP-1
[774.164020] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.789s)
[774.456100] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.444s)
[775.317809] [104/130] (248s left) gem_workarounds (suspend-resume-fd)
[775.397999] Starting subtest: suspend-resume-fd
[791.307408] Subtest suspend-resume-fd: SUCCESS (1.230s)
[791.478976] [105/130] (232s left) kms_psr (fbc-psr-primary-mmap-cpu)
[791.589770] Starting subtest: fbc-psr-primary-mmap-cpu
[791.592417] Starting dynamic subtest: eDP-1
[791.597650] Dynamic subtest eDP-1: SKIP (0.000s)
[791.602951] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[791.690968] [106/130] (232s left) gem_exec_capture (capture-recoverable)
[791.752830] Starting subtest: capture-recoverable
[791.755433] Subtest capture-recoverable: SUCCESS (0.003s)
[791.921371] [107/130] (232s left) gem_mmap_gtt (big-bo-tiledy)
[791.985935] Subtest big-bo-tiledY: SKIP (0.000s)
[792.049296] [108/130] (232s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[792.139878] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[792.142548] Starting dynamic subtest: pipe-A-eDP-1
[792.153016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[792.164900] Starting dynamic subtest: pipe-B-eDP-1
[792.175027] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[792.185737] Starting dynamic subtest: pipe-C-eDP-1
[792.195987] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[792.206884] Starting dynamic subtest: pipe-D-eDP-1
[792.217052] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[792.221909] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[794.416774] [109/130] (229s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[794.479919] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[794.482625] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[794.629887] [110/130] (229s left) kms_big_fb (linear-8bpp-rotate-90)
[794.729853] Starting subtest: linear-8bpp-rotate-90
[794.750934] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[794.898431] [111/130] (229s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[794.965908] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[795.034793] [112/130] (229s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[795.147154] Starting subtest: basic-flip-before-cursor-legacy
[796.064132] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[796.906506] [113/130] (227s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[797.006950] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[803.763325] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.760s)
[803.923479] [114/130] (220s left) gem_render_copy (yf-tiled)
[803.989026] Starting subtest: yf-tiled
[803.994783] Subtest yf-tiled: SKIP (0.000s)
[804.199644] [115/130] (220s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[804.254017] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[804.319313] [116/130] (220s left) gem_softpin (safe-alignment)
[804.389034] Starting subtest: safe-alignment
[804.415503] Subtest safe-alignment: SUCCESS (0.028s)
[805.946487] [117/130] (218s left) kms_dp_link_training (uhbr-sst)
[806.062862] Starting subtest: uhbr-sst
[806.073633] Subtest uhbr-sst: SKIP (0.000s)
[806.166273] [118/130] (218s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[806.225376] Starting subtest: y-tiled-to-vebox-yf-tiled
[806.230791] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[806.435695] [119/130] (218s left) perf (polling)
[806.537488] Starting subtest: polling
[806.540314] Starting dynamic subtest: 0-rcs0
[816.567542] Dynamic subtest 0-rcs0: SUCCESS (10.028s)
[816.578311] Starting dynamic subtest: 1-vecs0
[826.590160] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[826.593020] Subtest polling: SUCCESS (20.052s)
[826.641614] [120/130] (198s left) syncobj_wait (wait-all-complex)
[826.708011] Starting subtest: wait-all-complex
[826.922162] Subtest wait-all-complex: SUCCESS (0.215s)
[827.030641] [121/130] (197s left) dmabuf (all-tests)
[827.072057] Starting subtest: all-tests
[827.074577] Starting dynamic subtest: sanitycheck
[827.256013] Dynamic subtest sanitycheck: SUCCESS (0.186s)
[827.271405] Starting dynamic subtest: dma_fence
[827.561535] Dynamic subtest dma_fence: SUCCESS (0.303s)
[827.576131] Starting dynamic subtest: dma_fence_chain
[836.118712] Dynamic subtest dma_fence_chain: SUCCESS (8.556s)
[836.133867] Starting dynamic subtest: dma_fence_unwrap
[836.247765] Dynamic subtest dma_fence_unwrap: SUCCESS (0.127s)
[836.262050] Starting dynamic subtest: dma_resv
[836.370835] Dynamic subtest dma_resv: SUCCESS (0.121s)
[836.373740] Subtest all-tests: SUCCESS (9.303s)
[836.464548] [122/130] (188s left) dumb_buffer (map-invalid-size)
[836.527706] Starting subtest: map-invalid-size
[836.530173] Subtest map-invalid-size: SUCCESS (0.000s)
[836.649434] [123/130] (188s left) kms_chamelium_hpd (vga-hpd)
[837.046014] Subtest vga-hpd: SKIP (0.000s)
[837.859401] [124/130] (187s left) kms_busy (basic)
[837.961947] Starting subtest: basic
[837.964772] Starting dynamic subtest: flip
[838.544367] Dynamic subtest flip: SUCCESS (0.583s)
[838.555851] Starting dynamic subtest: modeset
[842.128158] Dynamic subtest modeset: SUCCESS (3.585s)
[842.130719] Subtest basic: SUCCESS (4.170s)
[842.999234] [125/130] (181s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[843.102439] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[850.411770] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.313s)
[850.570812] [126/130] (174s left) i915_drm_fdinfo (busy)
[850.613178] Starting subtest: busy
[850.615931] Starting dynamic subtest: rcs0
[850.638543] Dynamic subtest rcs0: SKIP (0.025s)
[850.650541] Starting dynamic subtest: bcs0
[850.655001] Dynamic subtest bcs0: SKIP (0.000s)
[850.666138] Starting dynamic subtest: vcs0
[850.671551] Dynamic subtest vcs0: SKIP (0.000s)
[850.682255] Starting dynamic subtest: vcs1
[850.687896] Dynamic subtest vcs1: SKIP (0.000s)
[850.698938] Starting dynamic subtest: vecs0
[850.704126] Dynamic subtest vecs0: SKIP (0.000s)
[850.714947] Starting dynamic subtest: ccs0
[850.720044] Dynamic subtest ccs0: SKIP (0.000s)
[850.725620] Subtest busy: SKIP (0.029s)
[850.769293] [127/130] (174s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[850.828137] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[850.830690] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[850.960737] [128/130] (174s left) kms_pm_lpsp (screens-disabled)
[852.066877] Starting subtest: screens-disabled
[852.072054] Subtest screens-disabled: SKIP (0.000s)
[852.164760] [129/130] (172s left) kms_async_flips (invalid-async-flip-atomic)
[852.263152] Starting subtest: invalid-async-flip-atomic
[852.634380] Starting dynamic subtest: pipe-A-eDP-1
[853.465341] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[853.829372] Starting dynamic subtest: pipe-B-eDP-1
[854.660041] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.841s)
[855.018804] Starting dynamic subtest: pipe-C-eDP-1
[855.842861] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.833s)
[856.196795] Starting dynamic subtest: pipe-D-eDP-1
[856.942930] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.754s)
[856.945534] Subtest invalid-async-flip-atomic: SUCCESS (4.682s)
[858.108417] [130/130] (167s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[858.358975] Starting subtest: cursor-rapid-movement-256x256
[858.361468] Starting dynamic subtest: pipe-A-eDP-1
[858.902956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[858.938891] Starting dynamic subtest: pipe-D-eDP-1
[860.153321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[860.155800] Subtest cursor-rapid-movement-256x256: SUCCESS (1.795s)
[860.990993] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_selftest
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: i915_getparams_basic
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_plane_cursor
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr2_su
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: template
results: parsing output: 23/ for test: i915_pm_rc6_residency
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: api_intel_bb
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: kms_hdr
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_sequence
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: gem_exec_whisper
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_exec_suspend
results: parsing output: 49/ for test: kms_properties
results: parsing output: 50/ for test: gem_ctx_isolation
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_wait
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_flip_scaled_crc
results: parsing output: 61/ for test: drm_read
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: api_intel_allocator
results: parsing output: 64/ for test: gem_exec_store
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: gem_eio
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: syncobj_basic
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_joiner
results: parsing output: 81/ for test: kms_flip_scaled_crc
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_chamelium_color
results: parsing output: 84/ for test: gem_exec_flush
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_hdmi_inject
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: gem_exec_capture
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_pipe_b_c_ivb
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: kms_dp_link_training
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: dmabuf
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: kms_busy
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_pm_lpsp
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: kms_cursor_crc
Done.