[58.094693] Initializing watchdogs
[58.094736]   /dev/watchdog0
[58.108355] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.112433] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.114539] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.117812] [001/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[58.246954] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[58.251164] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[58.356408] [002/130] (960s left) gem_exec_schedule (out-order)
[58.423090] Starting subtest: out-order
[58.425369] Starting dynamic subtest: rcs0
[58.522053] Dynamic subtest rcs0: SUCCESS (0.101s)
[58.530853] Starting dynamic subtest: vcs0
[58.601329] Dynamic subtest vcs0: SUCCESS (0.079s)
[58.612562] Starting dynamic subtest: vcs1
[58.677469] Dynamic subtest vcs1: SUCCESS (0.076s)
[58.688245] Starting dynamic subtest: vecs0
[58.760703] Dynamic subtest vecs0: SUCCESS (0.083s)
[58.771034] Starting dynamic subtest: ccs0
[58.841332] Dynamic subtest ccs0: SUCCESS (0.081s)
[58.844033] Subtest out-order: SUCCESS (0.422s)
[60.044281] [003/130] (958s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[60.153262] Starting subtest: fbc-psr2-cursor-mmap-gtt
[60.155260] Starting dynamic subtest: eDP-1
[60.159455] Dynamic subtest eDP-1: SKIP (0.000s)
[60.163662] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[60.245112] [004/130] (958s left) kms_pipe_crc_basic (suspend-read-crc)
[60.341692] Starting subtest: suspend-read-crc
[60.343683] Starting dynamic subtest: pipe-A-eDP-1
[77.923953] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.233s)
[77.933768] Starting dynamic subtest: pipe-B-eDP-1
[95.910890] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.215s)
[95.924339] Starting dynamic subtest: pipe-C-eDP-1
[113.885552] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.121s)
[113.896339] Starting dynamic subtest: pipe-D-eDP-1
[131.872237] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.040s)
[131.874577] Subtest suspend-read-crc: SUCCESS (15.613s)
[132.706236] [005/130] (886s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[132.818951] Starting subtest: fbcpsr-2p-rte
[132.823455] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[132.937253] [006/130] (885s left) kms_hdr (static-toggle)
[133.025729] Starting subtest: static-toggle
[133.032221] Subtest static-toggle: SKIP (0.000s)
[133.117999] [007/130] (885s left) gem_userptr_blits (sync-unmap-after-close)
[133.196002] Starting subtest: sync-unmap-after-close
[133.204834] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[133.379526] [008/130] (885s left) kms_selftest (drm_cmdline_parser)
[133.413220] Starting subtest: drm_cmdline_parser
[133.428889] Starting dynamic subtest: drm_test_cmdline_force_d_only
[133.561134] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.133s)
[133.570081] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[133.713087] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.152s)
[133.721512] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[133.831709] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.119s)
[133.841264] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[133.921279] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.091s)
[133.930817] Starting dynamic subtest: drm_test_cmdline_force_e_only
[134.066242] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.146s)
[134.076107] Starting dynamic subtest: drm_test_cmdline_res
[134.215834] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.150s)
[134.222926] Starting dynamic subtest: drm_test_cmdline_res_vesa
[134.332251] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.117s)
[134.339891] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[134.462814] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.132s)
[134.470012] Starting dynamic subtest: drm_test_cmdline_res_rblank
[134.607399] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.145s)
[134.615708] Starting dynamic subtest: drm_test_cmdline_res_bpp
[134.732962] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.127s)
[134.740472] Starting dynamic subtest: drm_test_cmdline_res_refresh
[134.827675] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.095s)
[134.837106] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[134.957238] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.130s)
[134.967081] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[135.094013] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.138s)
[135.103415] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[135.244444] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.151s)
[135.253694] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[135.366189] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.123s)
[135.375661] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[135.491402] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.126s)
[135.501232] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[135.594313] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.103s)
[135.603829] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[135.730269] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.136s)
[135.739981] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[135.820311] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.091s)
[135.829785] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[135.944248] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.123s)
[135.953692] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[136.097307] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.154s)
[136.106704] Starting dynamic subtest: drm_test_cmdline_name
[136.229413] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.133s)
[136.238772] Starting dynamic subtest: drm_test_cmdline_name_bpp
[136.387873] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.160s)
[136.395149] Starting dynamic subtest: drm_test_cmdline_name_option
[136.502291] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.115s)
[136.510451] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[136.636132] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.134s)
[136.644445] Starting dynamic subtest: drm_test_cmdline_rotate_0
[136.799961] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.164s)
[136.807229] Starting dynamic subtest: drm_test_cmdline_rotate_90
[136.929481] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.129s)
[136.938450] Starting dynamic subtest: drm_test_cmdline_rotate_180
[137.072071] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.144s)
[137.079600] Starting dynamic subtest: drm_test_cmdline_rotate_270
[137.215439] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.143s)
[137.223475] Starting dynamic subtest: drm_test_cmdline_hmirror
[137.346075] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.131s)
[137.353698] Starting dynamic subtest: drm_test_cmdline_vmirror
[137.485582] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.140s)
[137.494582] Starting dynamic subtest: drm_test_cmdline_margin_options
[137.641560] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.156s)
[137.649154] Starting dynamic subtest: drm_test_cmdline_multiple_options
[137.785945] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.146s)
[137.793225] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[137.934995] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.149s)
[137.942250] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[138.099330] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.164s)
[138.108827] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[138.255057] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.158s)
[138.262683] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[138.377440] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.120s)
[138.386727] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[138.486109] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.111s)
[138.493654] Starting dynamic subtest: drm_test_cmdline_invalid
[138.606984] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.120s)
[138.615923] Starting dynamic subtest: drm_test_cmdline_tv_options
[138.746850] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.141s)
[138.749112] Subtest drm_cmdline_parser: SUCCESS (5.369s)
[138.969386] [009/130] (879s left) gem_exec_gttfill (engines)
[139.042163] Starting subtest: engines
[139.044467] Starting dynamic subtest: rcs0
[162.577764] Dynamic subtest rcs0: SUCCESS (23.574s)
[162.589771] Starting dynamic subtest: bcs0
[185.864721] Dynamic subtest bcs0: SUCCESS (23.281s)
[185.875894] Starting dynamic subtest: vcs0
[209.175603] Dynamic subtest vcs0: SUCCESS (23.315s)
[209.184260] Starting dynamic subtest: vcs1
[232.416275] Dynamic subtest vcs1: SUCCESS (23.242s)
[232.427930] Starting dynamic subtest: vecs0
[255.708903] Dynamic subtest vecs0: SUCCESS (23.286s)
[255.720323] Starting dynamic subtest: ccs0
[278.987063] Dynamic subtest ccs0: SUCCESS (23.279s)
[278.990051] Subtest engines: SUCCESS (139.984s)
[279.204290] [010/130] (739s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[279.336367] Starting subtest: fbc-rgb101010-draw-blt
[283.947716] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.615s)
[285.114837] [011/130] (733s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[285.227440] Starting subtest: yf-tiled-8bpp-rotate-270
[285.231458] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[285.370604] [012/130] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[285.470369] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[285.474641] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[285.588077] [013/130] (733s left) i915_getparams_basic (basic-eu-total)
[285.657167] Starting subtest: basic-eu-total
[285.661912] Subtest basic-eu-total: SUCCESS (0.000s)
[285.775676] [014/130] (733s left) prime_vgem (fence-wait)
[285.935170] Starting subtest: fence-wait
[285.937535] Starting dynamic subtest: rcs0
[286.984243] Dynamic subtest rcs0: SUCCESS (1.048s)
[286.996051] Starting dynamic subtest: bcs0
[288.067262] Dynamic subtest bcs0: SUCCESS (1.084s)
[288.079068] Starting dynamic subtest: vcs0
[289.111900] Dynamic subtest vcs0: SUCCESS (1.043s)
[289.123933] Starting dynamic subtest: vcs1
[290.154390] Dynamic subtest vcs1: SUCCESS (1.041s)
[290.166167] Starting dynamic subtest: vecs0
[291.197375] Dynamic subtest vecs0: SUCCESS (1.042s)
[291.209816] Starting dynamic subtest: ccs0
[292.241845] Dynamic subtest ccs0: SUCCESS (1.043s)
[292.244950] Subtest fence-wait: SUCCESS (6.307s)
[292.395339] [FACT prime_vgem (fence-wait)] new: kernel.kmod_is_loaded.vgem: true
[292.398403] [015/130] (726s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[292.504471] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[292.508869] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[292.646053] [016/130] (726s left) gem_ctx_shared (exec-shared-gtt)
[292.708543] Starting subtest: exec-shared-gtt
[292.710852] Starting dynamic subtest: rcs0
[292.715916] Dynamic subtest rcs0: SUCCESS (0.007s)
[292.726333] Starting dynamic subtest: bcs0
[292.728162] Dynamic subtest bcs0: SUCCESS (0.009s)
[292.736689] Starting dynamic subtest: vcs0
[292.738918] Dynamic subtest vcs0: SUCCESS (0.006s)
[292.747983] Starting dynamic subtest: vcs1
[292.750293] Dynamic subtest vcs1: SUCCESS (0.007s)
[292.758745] Starting dynamic subtest: vecs0
[292.760994] Dynamic subtest vecs0: SUCCESS (0.005s)
[292.769632] Starting dynamic subtest: ccs0
[292.771880] Dynamic subtest ccs0: SUCCESS (0.005s)
[292.774142] Subtest exec-shared-gtt: SUCCESS (0.041s)
[292.954674] [017/130] (726s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[293.093136] Starting subtest: modeset-atomic-cursor-hotspot
[293.097714] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[293.261622] [018/130] (726s left) kms_plane_cursor (viewport)
[293.359117] Starting subtest: viewport
[293.363261] Starting dynamic subtest: pipe-A-eDP-1-size-64
[295.869782] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.509s)
[295.929765] Starting dynamic subtest: pipe-A-eDP-1-size-128
[298.358670] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[298.418280] Starting dynamic subtest: pipe-A-eDP-1-size-256
[300.860213] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[301.211085] Starting dynamic subtest: pipe-B-eDP-1-size-64
[304.328572] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.130s)
[304.388910] Starting dynamic subtest: pipe-B-eDP-1-size-128
[306.851239] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.472s)
[306.911972] Starting dynamic subtest: pipe-B-eDP-1-size-256
[309.420762] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.517s)
[309.767181] Starting dynamic subtest: pipe-C-eDP-1-size-64
[312.725398] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.970s)
[312.763512] Starting dynamic subtest: pipe-C-eDP-1-size-128
[314.903580] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[314.940269] Starting dynamic subtest: pipe-C-eDP-1-size-256
[317.035721] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.102s)
[317.370675] Starting dynamic subtest: pipe-D-eDP-1-size-64
[320.080895] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.725s)
[320.120504] Starting dynamic subtest: pipe-D-eDP-1-size-128
[322.259418] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s)
[322.296293] Starting dynamic subtest: pipe-D-eDP-1-size-256
[324.380101] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.091s)
[324.698182] Subtest viewport: SUCCESS (31.344s)
[325.520572] [019/130] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[325.636780] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[325.641065] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[325.783014] [020/130] (693s left) kms_psr2_su (page_flip-xrgb8888)
[325.845348] Subtest page_flip-XRGB8888: SKIP (0.000s)
[325.919549] [021/130] (693s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[326.014023] Starting subtest: 4-tiled-32bpp-rotate-90
[326.033404] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[326.210433] [022/130] (693s left) kms_vblank (ts-continuation-dpms-rpm)
[326.307338] Starting subtest: ts-continuation-dpms-rpm
[326.309532] Starting dynamic subtest: pipe-A-eDP-1
[328.787084] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.480s)
[328.801697] Starting dynamic subtest: pipe-D-eDP-1
[331.035902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s)
[331.038261] Subtest ts-continuation-dpms-rpm: SUCCESS (4.731s)
[331.853239] [023/130] (687s left) template (a)
[331.915756] Starting subtest: A
[331.918000] Subtest A: SUCCESS (0.000s)
[332.045492] [024/130] (687s left) i915_pm_rc6_residency (rc6-accuracy)
[332.094749] Starting subtest: rc6-accuracy
[332.096606] Starting dynamic subtest: gt0
[335.266415] Dynamic subtest gt0: SUCCESS (3.170s)
[335.277655] Starting dynamic subtest: gt1
[338.438096] Dynamic subtest gt1: SUCCESS (3.169s)
[338.440628] Subtest rc6-accuracy: SUCCESS (6.345s)
[338.538203] [025/130] (681s left) gem_exec_balancer (parallel)
[338.789953] Starting subtest: parallel
[339.697389] Subtest parallel: SUCCESS (0.908s)
[340.977366] [026/130] (678s left) kms_content_protection (atomic)
[341.123822] Starting subtest: atomic
[341.128464] Subtest atomic: SKIP (0.000s)
[341.287945] [027/130] (678s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[341.413464] Starting subtest: cursor-vs-flip-atomic
[370.610932] Subtest cursor-vs-flip-atomic: SUCCESS (29.195s)
[371.490047] [028/130] (648s left) perf_pmu (enable-race)
[371.541140] Starting subtest: enable-race
[371.543379] Starting dynamic subtest: rcs0
[384.304122] Dynamic subtest rcs0: SUCCESS (12.762s)
[384.315800] Starting dynamic subtest: bcs0
[397.044706] Dynamic subtest bcs0: SUCCESS (12.736s)
[397.056622] Starting dynamic subtest: vcs0
[412.910602] Dynamic subtest vcs0: SUCCESS (15.861s)
[412.923097] Starting dynamic subtest: vcs1
[428.909309] Dynamic subtest vcs1: SUCCESS (15.995s)
[428.920347] Starting dynamic subtest: vecs0
[444.910238] Dynamic subtest vecs0: SUCCESS (15.999s)
[444.923126] Starting dynamic subtest: ccs0
[457.688280] Dynamic subtest ccs0: SUCCESS (12.777s)
[457.690972] Subtest enable-race: SUCCESS (86.144s)
[457.822526] [029/130] (561s left) vgem_basic (create)
[457.871222] Starting subtest: create
[457.873392] Subtest create: SUCCESS (0.000s)
[457.952960] [030/130] (561s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[458.063015] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[458.065197] Starting dynamic subtest: pipe-A-eDP-1
[458.123075] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[458.134018] Starting dynamic subtest: pipe-B-eDP-1
[458.189746] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[458.200897] Starting dynamic subtest: pipe-C-eDP-1
[458.258268] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[458.268608] Starting dynamic subtest: pipe-D-eDP-1
[458.324463] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[458.328536] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[460.255656] [031/130] (559s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[460.365948] Starting subtest: psr-rgb101010-draw-mmap-gtt
[460.370295] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[460.490407] [032/130] (559s left) i915_query (query-regions-unallocated)
[460.556459] Starting subtest: query-regions-unallocated
[460.558742] Subtest query-regions-unallocated: SUCCESS (0.000s)
[460.682779] [033/130] (559s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[460.991097] Starting subtest: cursor-rapid-movement-max-size
[460.997608] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[461.147554] [034/130] (558s left) api_intel_bb (intel-bb-blit-x)
[461.204324] Starting subtest: intel-bb-blit-x
[464.577517] Subtest intel-bb-blit-x: SUCCESS (3.372s)
[464.736570] [035/130] (555s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[464.834732] Starting subtest: bo-too-small-due-to-tiling
[464.838894] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[464.974552] [036/130] (555s left) kms_hdr (bpc-switch-dpms)
[465.072686] Starting subtest: bpc-switch-dpms
[466.116207] Starting dynamic subtest: pipe-A-eDP-1
[470.635056] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.519s)
[470.637676] Subtest bpc-switch-dpms: SUCCESS (5.565s)
[470.785818] [037/130] (549s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[470.890009] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[470.901098] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[471.033802] [038/130] (549s left) syncobj_wait (invalid-signal-illegal-handle)
[471.091513] Starting subtest: invalid-signal-illegal-handle
[471.093651] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[471.235491] [039/130] (548s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[471.295800] Starting subtest: legacy-engines-hostile-preempt
[471.298153] Starting dynamic subtest: render
[471.375799] Dynamic subtest render: SUCCESS (0.079s)
[471.389475] Starting dynamic subtest: bsd1
[472.938826] Dynamic subtest bsd1: SUCCESS (1.559s)
[472.950852] Starting dynamic subtest: bsd2
[474.899949] Dynamic subtest bsd2: SUCCESS (1.957s)
[474.912428] Starting dynamic subtest: blt
[475.032883] Dynamic subtest blt: SUCCESS (0.132s)
[475.048239] Starting dynamic subtest: vebox
[476.948134] Dynamic subtest vebox: SUCCESS (1.910s)
[476.950847] Subtest legacy-engines-hostile-preempt: SUCCESS (5.653s)
[477.062594] [040/130] (543s left) kms_pm_rpm (pc8-residency)
[479.084536] Starting subtest: pc8-residency
[479.089403] Subtest pc8-residency: SKIP (0.000s)
[479.497793] [041/130] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[479.603626] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[479.607712] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.741416] [042/130] (540s left) kms_sequence (get-busy)
[479.840150] Starting subtest: get-busy
[479.842242] Starting dynamic subtest: pipe-A-eDP-1
[481.766788] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[481.777320] Starting dynamic subtest: pipe-B-eDP-1
[484.337617] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s)
[484.348648] Starting dynamic subtest: pipe-C-eDP-1
[486.964176] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[486.974165] Starting dynamic subtest: pipe-D-eDP-1
[489.582268] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.617s)
[489.584595] Subtest get-busy: SUCCESS (9.745s)
[490.399133] [043/130] (529s left) gen9_exec_parse (batch-without-end)
[490.468171] Subtest batch-without-end: SKIP (0.000s)
[490.545938] [044/130] (529s left) gem_exec_whisper (basic-queues-forked-all)
[490.611103] Starting subtest: basic-queues-forked-all
[510.223656] Subtest basic-queues-forked-all: SUCCESS (19.611s)
[510.430330] [045/130] (510s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[510.532649] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[510.534731] Starting dynamic subtest: pipe-A
[510.879491] Dynamic subtest pipe-A: SUCCESS (0.349s)
[510.891587] Starting dynamic subtest: pipe-B
[512.261505] Dynamic subtest pipe-B: SUCCESS (1.381s)
[512.274410] Starting dynamic subtest: pipe-C
[513.700729] Dynamic subtest pipe-C: SUCCESS (1.438s)
[513.715292] Starting dynamic subtest: pipe-D
[515.141881] Dynamic subtest pipe-D: SUCCESS (1.439s)
[515.144282] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.613s)
[516.332980] [046/130] (504s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[516.426152] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[516.428407] Starting dynamic subtest: pipe-A-eDP-1
[516.451088] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[516.463165] Starting dynamic subtest: pipe-B-eDP-1
[516.484301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[516.493495] Starting dynamic subtest: pipe-C-eDP-1
[516.515299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[516.524107] Starting dynamic subtest: pipe-D-eDP-1
[516.546277] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[516.550652] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[518.690012] [047/130] (501s left) kms_psr (pr-cursor-plane-onoff)
[518.783356] Starting subtest: pr-cursor-plane-onoff
[518.787442] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[518.880087] [048/130] (501s left) kms_cursor_crc (cursor-alpha-transparent)
[518.978584] Starting subtest: cursor-alpha-transparent
[518.980817] Starting dynamic subtest: pipe-A-eDP-1
[519.589334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[519.599958] Starting dynamic subtest: pipe-D-eDP-1
[520.838377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[520.840269] Subtest cursor-alpha-transparent: SUCCESS (1.862s)
[521.668179] [049/130] (498s left) gem_exec_suspend (basic-s3)
[521.729451] Starting subtest: basic-S3
[521.731835] Starting dynamic subtest: smem
[541.979597] Dynamic subtest smem: SUCCESS (6.203s)
[541.982630] Subtest basic-S3: SUCCESS (6.205s)
[542.191826] [050/130] (478s left) kms_properties (colorop-properties-atomic)
[542.290980] Starting subtest: colorop-properties-atomic
[542.293193] Starting dynamic subtest: pipe-A-eDP-1
[542.625636] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.339s)
[542.635461] Starting dynamic subtest: pipe-B-eDP-1
[543.700385] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.082s)
[543.710104] Starting dynamic subtest: pipe-C-eDP-1
[544.738429] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s)
[544.748545] Starting dynamic subtest: pipe-D-eDP-1
[545.769438] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.036s)
[545.771689] Subtest colorop-properties-atomic: SUCCESS (3.505s)
[546.590966] [051/130] (474s left) gem_ctx_isolation (clean)
[546.670596] Starting subtest: clean
[546.672600] Starting dynamic subtest: rcs0
[546.744413] Dynamic subtest rcs0: SUCCESS (0.077s)
[546.756744] Starting dynamic subtest: bcs0
[546.843948] Dynamic subtest bcs0: SUCCESS (0.099s)
[546.853547] Starting dynamic subtest: vcs0
[546.933036] Dynamic subtest vcs0: SUCCESS (0.089s)
[546.942415] Starting dynamic subtest: vcs1
[547.990869] Dynamic subtest vcs1: SUCCESS (1.062s)
[548.000311] Starting dynamic subtest: vecs0
[549.986696] Dynamic subtest vecs0: SUCCESS (2.003s)
[549.999234] Starting dynamic subtest: ccs0
[552.082394] Dynamic subtest ccs0: SUCCESS (2.102s)
[552.084802] Subtest clean: SUCCESS (5.438s)
[552.359485] [052/130] (468s left) kms_flip (plain-flip-ts-check)
[552.458867] Starting subtest: plain-flip-ts-check
[552.460714] Starting dynamic subtest: A-eDP1
[561.331079] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[561.342819] Starting dynamic subtest: B-eDP1
[570.147389] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[570.159123] Starting dynamic subtest: C-eDP1
[578.952356] Dynamic subtest C-eDP1: SUCCESS (8.803s)
[578.963631] Starting dynamic subtest: D-eDP1
[587.779532] Dynamic subtest D-eDP1: SUCCESS (8.825s)
[587.784858] Subtest plain-flip-ts-check: SUCCESS (35.350s)
[588.989039] [053/130] (431s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[589.098452] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[589.102429] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[589.239643] [054/130] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[589.332620] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[589.337009] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[589.466131] [055/130] (431s left) gem_wait (write-wait)
[589.534351] Starting subtest: write-wait
[589.536763] Starting dynamic subtest: all-engines
[590.685384] Dynamic subtest all-engines: SUCCESS (1.150s)
[590.703349] Starting dynamic subtest: rcs0
[591.746559] Dynamic subtest rcs0: SUCCESS (1.060s)
[591.762294] Starting dynamic subtest: bcs0
[592.806746] Dynamic subtest bcs0: SUCCESS (1.058s)
[592.824003] Starting dynamic subtest: vcs0
[593.863615] Dynamic subtest vcs0: SUCCESS (1.054s)
[593.879415] Starting dynamic subtest: vcs1
[594.917515] Dynamic subtest vcs1: SUCCESS (1.052s)
[594.933694] Starting dynamic subtest: vecs0
[595.972227] Dynamic subtest vecs0: SUCCESS (1.053s)
[595.989136] Starting dynamic subtest: ccs0
[597.028529] Dynamic subtest ccs0: SUCCESS (1.054s)
[597.031136] Subtest write-wait: SUCCESS (7.496s)
[597.251168] [056/130] (423s left) perf (short-reads)
[597.408821] Starting subtest: short-reads
[597.422201] Subtest short-reads: SUCCESS (0.015s)
[597.499357] [057/130] (423s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[597.596272] Starting subtest: addfb25-y-tiled-small-legacy
[597.600605] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[597.721899] [058/130] (423s left) syncobj_timeline (wait-all-for-submit-complex)
[597.781676] Starting subtest: wait-all-for-submit-complex
[597.994863] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[598.094324] [059/130] (422s left) gem_exec_capture (userptr)
[598.161238] Starting subtest: userptr
[598.977890] Subtest userptr: SUCCESS (0.817s)
[599.154315] [060/130] (421s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[599.213102] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[599.320304] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[599.423250] [061/130] (421s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[599.525979] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[599.528318] Starting dynamic subtest: pipe-A-default-mode
[599.814858] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[599.819837] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.287s)
[600.714736] [062/130] (420s left) drm_read (empty-nonblock)
[600.866507] Starting subtest: empty-nonblock
[600.869046] Subtest empty-nonblock: SUCCESS (0.000s)
[601.027394] [063/130] (420s left) kms_big_fb (y-tiled-addfb-size-overflow)
[601.124100] Starting subtest: y-tiled-addfb-size-overflow
[601.128412] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[601.254339] [064/130] (419s left) api_intel_allocator (reopen-fork)
[601.313522] Starting subtest: reopen-fork
[604.758744] Subtest reopen-fork: SUCCESS (3.447s)
[604.861711] [065/130] (416s left) gem_exec_store (pages)
[604.943445] Starting subtest: pages
[604.945951] Starting dynamic subtest: rcs0
[605.066235] Dynamic subtest rcs0: SUCCESS (0.122s)
[605.078612] Starting dynamic subtest: bcs0
[605.149650] Dynamic subtest bcs0: SUCCESS (0.082s)
[605.161917] Starting dynamic subtest: vcs0
[605.219057] Dynamic subtest vcs0: SUCCESS (0.068s)
[605.231175] Starting dynamic subtest: vcs1
[605.284181] Dynamic subtest vcs1: SUCCESS (0.064s)
[605.293729] Starting dynamic subtest: vecs0
[605.350390] Dynamic subtest vecs0: SUCCESS (0.065s)
[605.359949] Starting dynamic subtest: ccs0
[605.421624] Dynamic subtest ccs0: SUCCESS (0.071s)
[605.424150] Subtest pages: SUCCESS (0.479s)
[605.631943] [066/130] (415s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[605.696327] Starting subtest: multi-wait-all-for-submit-signaled
[605.699214] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[605.837707] [067/130] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[605.952375] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[612.692619] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.744s)
[612.858855] [068/130] (408s left) kms_addfb_basic (unused-offsets)
[612.920243] Starting subtest: unused-offsets
[612.922139] Subtest unused-offsets: SUCCESS (0.000s)
[613.083913] [069/130] (408s left) syncobj_timeline (single-wait-all-available-signaled)
[613.140610] Starting subtest: single-wait-all-available-signaled
[613.142535] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[613.266094] [070/130] (408s left) gem_eio (in-flight-internal-10ms)
[613.467095] Starting subtest: in-flight-internal-10ms
[615.070053] Subtest in-flight-internal-10ms: SUCCESS (1.602s)
[615.247141] [071/130] (406s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[615.346397] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[616.334251] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.989s)
[616.518717] [072/130] (405s left) syncobj_basic (bad-destroy-pad)
[616.580248] Starting subtest: bad-destroy-pad
[616.582755] Subtest bad-destroy-pad: SUCCESS (0.000s)
[616.703863] [073/130] (404s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[616.795372] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[616.797265] Starting dynamic subtest: pipe-A-default-mode
[619.567109] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[619.569390] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.774s)
[620.429762] [074/130] (401s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[620.546541] Starting subtest: psr-2p-primscrn-cur-indfb-move
[620.550609] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[620.680609] [075/130] (401s left) kms_psr (psr2-sprite-mmap-cpu)
[620.778058] Starting subtest: psr2-sprite-mmap-cpu
[620.780347] Starting dynamic subtest: eDP-1
[622.490694] Dynamic subtest eDP-1: SUCCESS (1.713s)
[622.493101] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.714s)
[623.382395] [076/130] (398s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[623.483868] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[627.854457] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.376s)
[628.991564] [077/130] (392s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[634.019347] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[634.023876] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[634.891121] [078/130] (386s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[634.985740] Starting subtest: x-tiled-8bpp-rotate-0
[636.177029] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.191s)
[636.325153] [079/130] (385s left) perf (gen12-mi-rpc)
[636.433330] Starting subtest: gen12-mi-rpc
[636.435510] Starting dynamic subtest: rcs0
[636.450638] Dynamic subtest rcs0: SUCCESS (0.015s)
[636.452244] Subtest gen12-mi-rpc: SUCCESS (0.016s)
[636.494184] [080/130] (385s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[636.641489] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[636.643338] Starting dynamic subtest: pipe-A-eDP-1
[636.662415] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[636.673974] Starting dynamic subtest: pipe-B-eDP-1
[636.691463] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[636.700986] Starting dynamic subtest: pipe-C-eDP-1
[636.718533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[636.728067] Starting dynamic subtest: pipe-D-eDP-1
[636.746046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[636.749400] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[638.958114] [081/130] (382s left) kms_joiner (invalid-modeset-big-joiner)
[639.063168] Starting subtest: invalid-modeset-big-joiner
[639.067369] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[639.153634] [082/130] (382s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[639.241789] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[639.244003] Starting dynamic subtest: pipe-A-default-mode
[641.995957] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[641.997990] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.752s)
[642.855043] [083/130] (379s left) gem_exec_fence (invalid-timeline-fence-array)
[643.396353] Starting subtest: invalid-timeline-fence-array
[643.402929] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[645.156771] [084/130] (376s left) kms_chamelium_color (ctm-negative)
[645.263876] Subtest ctm-negative: SKIP (0.000s)
[645.308898] [085/130] (376s left) gem_exec_flush (basic-wb-prw-default)
[645.370247] Starting subtest: basic-wb-prw-default
[650.831201] Subtest basic-wb-prw-default: SUCCESS (5.461s)
[651.042008] [086/130] (371s left) gem_exec_reloc (basic-softpin)
[651.095193] Subtest basic-softpin: SKIP (0.000s)
[651.162145] [087/130] (371s left) gem_mmap_wc (bad-object)
[651.214101] Subtest bad-object: SKIP (0.000s)
[651.282966] [088/130] (370s left) gem_mmap_gtt (pf-nonblock)
[651.338081] Subtest pf-nonblock: SKIP (0.000s)
[651.404471] [089/130] (370s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[651.797565] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[652.649261] [090/130] (369s left) gem_eio (wait-wedge-immediate)
[652.868930] Starting subtest: wait-wedge-immediate
[654.044545] Subtest wait-wedge-immediate: SUCCESS (1.176s)
[654.211899] [091/130] (368s left) prime_mmap (test_forked_cpu_write)
[654.262409] Starting subtest: test_forked_cpu_write
[654.264774] Starting dynamic subtest: test_forked_cpu_write-smem
[654.269993] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[654.272212] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[654.399610] [092/130] (367s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[654.491687] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[654.495747] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[654.613626] [093/130] (367s left) kms_hdmi_inject (inject-4k)
[654.966870] Starting subtest: inject-4k
[655.280643] Subtest inject-4k: SUCCESS (0.316s)
[655.852693] [094/130] (366s left) perf_pmu (frequency)
[655.885693] Starting subtest: frequency
[655.890432] Starting dynamic subtest: gt0
[658.099789] Dynamic subtest gt0: SUCCESS (2.205s)
[658.112856] Starting dynamic subtest: idle-gt0
[658.604997] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[658.615807] Starting dynamic subtest: gt1
[663.016926] Dynamic subtest gt1: SUCCESS (4.406s)
[663.030044] Starting dynamic subtest: idle-gt1
[663.521792] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[663.524370] Subtest frequency: SUCCESS (7.638s)
[663.654327] [095/130] (358s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[663.752439] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[663.754833] Starting dynamic subtest: pipe-A
[664.000908] Dynamic subtest pipe-A: SUCCESS (0.251s)
[664.015967] Starting dynamic subtest: pipe-B
[665.251103] Dynamic subtest pipe-B: SUCCESS (1.249s)
[665.262901] Starting dynamic subtest: pipe-C
[666.548324] Dynamic subtest pipe-C: SUCCESS (1.297s)
[666.558364] Starting dynamic subtest: pipe-D
[667.851541] Dynamic subtest pipe-D: SUCCESS (1.302s)
[667.853867] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.102s)
[669.020396] [096/130] (353s left) gem_mmap_gtt (basic-write-read)
[669.078814] Subtest basic-write-read: SKIP (0.000s)
[669.129471] [097/130] (353s left) gem_softpin (evict-snoop)
[669.180667] Starting subtest: evict-snoop
[669.185108] Subtest evict-snoop: SKIP (0.000s)
[669.335284] [098/130] (353s left) gem_exec_schedule (preempt-user)
[669.406468] Starting subtest: preempt-user
[669.408638] Starting dynamic subtest: rcs0
[669.421750] Dynamic subtest rcs0: SUCCESS (0.023s)
[669.432685] Starting dynamic subtest: bcs0
[669.439516] Dynamic subtest bcs0: SUCCESS (0.017s)
[669.449767] Starting dynamic subtest: vcs0
[669.458082] Dynamic subtest vcs0: SUCCESS (0.018s)
[669.470694] Starting dynamic subtest: vcs1
[669.479744] Dynamic subtest vcs1: SUCCESS (0.021s)
[669.490099] Starting dynamic subtest: vecs0
[669.498458] Dynamic subtest vecs0: SUCCESS (0.018s)
[669.508522] Starting dynamic subtest: ccs0
[669.518840] Dynamic subtest ccs0: SUCCESS (0.020s)
[669.520966] Subtest preempt-user: SUCCESS (0.121s)
[671.108559] [099/130] (351s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[671.220089] Starting subtest: cursor-vs-flip-legacy
[700.438951] Subtest cursor-vs-flip-legacy: SUCCESS (29.221s)
[701.321856] [100/130] (321s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[701.421733] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[701.425992] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[701.541458] [101/130] (321s left) gem_create (create-clear)
[701.594917] Starting subtest: create-clear
[701.597178] Starting dynamic subtest: smem0
[734.283908] Dynamic subtest smem0: SUCCESS (32.696s)
[734.286328] Subtest create-clear: SUCCESS (32.697s)
[734.500669] [102/130] (288s left) kms_flip (absolute-wf_vblank)
[734.595292] Starting subtest: absolute-wf_vblank
[734.597660] Starting dynamic subtest: A-eDP1
[743.302876] Dynamic subtest A-eDP1: SUCCESS (8.709s)
[743.316949] Starting dynamic subtest: B-eDP1
[752.005556] Dynamic subtest B-eDP1: SUCCESS (8.704s)
[752.016202] Starting dynamic subtest: C-eDP1
[760.689763] Dynamic subtest C-eDP1: SUCCESS (8.685s)
[760.700163] Starting dynamic subtest: D-eDP1
[769.389903] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[769.392350] Subtest absolute-wf_vblank: SUCCESS (34.805s)
[770.593212] [103/130] (252s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[770.699126] Starting subtest: plane-use-after-nonblocking-unbind
[770.701401] Starting dynamic subtest: pipe-A-eDP-1
[770.760335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[771.074817] Starting dynamic subtest: pipe-B-eDP-1
[771.845607] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.780s)
[772.152177] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.455s)
[772.997465] [104/130] (249s left) gem_workarounds (suspend-resume-fd)
[773.070901] Starting subtest: suspend-resume-fd
[789.013720] Subtest suspend-resume-fd: SUCCESS (1.186s)
[790.179116] [105/130] (233s left) kms_psr (fbc-psr-primary-mmap-cpu)
[790.294038] Starting subtest: fbc-psr-primary-mmap-cpu
[790.296852] Starting dynamic subtest: eDP-1
[790.302267] Dynamic subtest eDP-1: SKIP (0.000s)
[790.307638] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[790.390016] [106/130] (233s left) gem_exec_capture (capture-recoverable)
[790.452254] Starting subtest: capture-recoverable
[790.454873] Subtest capture-recoverable: SUCCESS (0.003s)
[790.592151] [107/130] (233s left) gem_mmap_gtt (big-bo-tiledy)
[790.656781] Subtest big-bo-tiledY: SKIP (0.000s)
[790.725651] [108/130] (233s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[790.821693] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[790.824249] Starting dynamic subtest: pipe-A-eDP-1
[790.834774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[790.846467] Starting dynamic subtest: pipe-B-eDP-1
[790.856505] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[790.866764] Starting dynamic subtest: pipe-C-eDP-1
[790.876865] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[790.887009] Starting dynamic subtest: pipe-D-eDP-1
[790.897594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[790.902763] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[793.116026] [109/130] (230s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[793.176021] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[793.178609] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[793.311067] [110/130] (230s left) kms_big_fb (linear-8bpp-rotate-90)
[793.425893] Starting subtest: linear-8bpp-rotate-90
[793.447224] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[793.597097] [111/130] (230s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[793.648836] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[793.711011] [112/130] (230s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[793.835813] Starting subtest: basic-flip-before-cursor-legacy
[794.756945] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.920s)
[795.619655] [113/130] (228s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[795.729231] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[802.600847] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.867s)
[802.748675] [114/130] (221s left) gem_render_copy (yf-tiled)
[802.820734] Starting subtest: yf-tiled
[802.825881] Subtest yf-tiled: SKIP (0.000s)
[803.031183] [115/130] (221s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[803.087929] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[803.145928] [116/130] (221s left) gem_softpin (safe-alignment)
[803.204013] Starting subtest: safe-alignment
[803.226565] Subtest safe-alignment: SUCCESS (0.023s)
[804.802899] [117/130] (219s left) kms_dp_link_training (uhbr-sst)
[804.906705] Starting subtest: uhbr-sst
[804.915799] Subtest uhbr-sst: SKIP (0.000s)
[805.005689] [118/130] (219s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[805.070840] Starting subtest: y-tiled-to-vebox-yf-tiled
[805.075755] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[805.281797] [119/130] (219s left) perf (polling)
[805.385480] Starting subtest: polling
[805.387935] Starting dynamic subtest: 0-rcs0
[815.409806] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[815.420647] Starting dynamic subtest: 1-vcs1
[825.428504] Dynamic subtest 1-vcs1: SUCCESS (10.017s)
[825.431083] Subtest polling: SUCCESS (20.042s)
[825.480178] [120/130] (199s left) syncobj_wait (wait-all-complex)
[825.542894] Starting subtest: wait-all-complex
[825.758845] Subtest wait-all-complex: SUCCESS (0.217s)
[825.863520] [121/130] (198s left) dmabuf (all-tests)
[825.904781] Starting subtest: all-tests
[825.907398] Starting dynamic subtest: sanitycheck
[826.059245] Dynamic subtest sanitycheck: SUCCESS (0.156s)
[826.073853] Starting dynamic subtest: dma_fence
[826.366556] Dynamic subtest dma_fence: SUCCESS (0.306s)
[826.380646] Starting dynamic subtest: dma_fence_chain
[834.440504] Dynamic subtest dma_fence_chain: SUCCESS (8.075s)
[834.456632] Starting dynamic subtest: dma_fence_unwrap
[834.582697] Dynamic subtest dma_fence_unwrap: SUCCESS (0.140s)
[834.597442] Starting dynamic subtest: dma_resv
[834.716816] Dynamic subtest dma_resv: SUCCESS (0.132s)
[834.719894] Subtest all-tests: SUCCESS (8.819s)
[834.810104] [122/130] (189s left) dumb_buffer (map-invalid-size)
[834.868928] Starting subtest: map-invalid-size
[834.871858] Subtest map-invalid-size: SUCCESS (0.000s)
[835.007328] [123/130] (189s left) kms_chamelium_hpd (vga-hpd)
[835.397555] Subtest vga-hpd: SKIP (0.000s)
[836.195864] [124/130] (188s left) kms_busy (basic)
[836.290442] Starting subtest: basic
[836.292732] Starting dynamic subtest: flip
[836.867698] Dynamic subtest flip: SUCCESS (0.578s)
[836.882041] Starting dynamic subtest: modeset
[840.231145] Dynamic subtest modeset: SUCCESS (3.362s)
[840.234202] Subtest basic: SUCCESS (3.943s)
[841.138352] [125/130] (183s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[841.239878] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[848.470002] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.233s)
[848.665324] [126/130] (176s left) i915_drm_fdinfo (busy)
[848.708448] Starting subtest: busy
[848.710893] Starting dynamic subtest: rcs0
[848.732805] Dynamic subtest rcs0: SKIP (0.021s)
[848.743219] Starting dynamic subtest: bcs0
[848.748606] Dynamic subtest bcs0: SKIP (0.014s)
[848.759004] Starting dynamic subtest: vcs0
[848.764627] Dynamic subtest vcs0: SKIP (0.000s)
[848.775319] Starting dynamic subtest: vcs1
[848.780895] Dynamic subtest vcs1: SKIP (0.000s)
[848.791783] Starting dynamic subtest: vecs0
[848.797019] Dynamic subtest vecs0: SKIP (0.000s)
[848.807566] Starting dynamic subtest: ccs0
[848.812631] Dynamic subtest ccs0: SKIP (0.000s)
[848.817027] Subtest busy: SKIP (0.040s)
[848.854638] [127/130] (176s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[848.908333] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[848.910906] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[849.071673] [128/130] (175s left) kms_pm_lpsp (screens-disabled)
[850.189869] Starting subtest: screens-disabled
[850.194878] Subtest screens-disabled: SKIP (0.000s)
[850.286777] [129/130] (174s left) kms_async_flips (invalid-async-flip-atomic)
[850.381842] Starting subtest: invalid-async-flip-atomic
[850.757589] Starting dynamic subtest: pipe-A-eDP-1
[851.596014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[851.961825] Starting dynamic subtest: pipe-B-eDP-1
[852.798892] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.851s)
[853.156816] Starting dynamic subtest: pipe-C-eDP-1
[853.970815] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.823s)
[854.330507] Starting dynamic subtest: pipe-D-eDP-1
[855.074994] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.756s)
[855.077702] Subtest invalid-async-flip-atomic: SUCCESS (4.694s)
[856.319205] [130/130] (168s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[856.568988] Starting subtest: cursor-rapid-movement-256x256
[856.572093] Starting dynamic subtest: pipe-A-eDP-1
[857.112597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[857.144625] Starting dynamic subtest: pipe-D-eDP-1
[858.274825] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[858.277679] Subtest cursor-rapid-movement-256x256: SUCCESS (1.707s)
[859.111755] 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.