[56.405369] Initializing watchdogs
[56.405446]   /dev/watchdog0
[56.441430] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.445702] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.448324] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.451405] [001/130] (960s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[56.563714] Starting subtest: coverage-vs-premult-vs-constant
[56.855797] Starting dynamic subtest: pipe-A-eDP-1
[57.470435] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[57.480988] Starting dynamic subtest: pipe-D-eDP-1
[58.833033] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s)
[58.835342] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.265s)
[59.695207] [002/130] (957s left) kms_fbcon_fbt (fbc)
[59.755327] Starting subtest: fbc
[66.149802] Subtest fbc: SUCCESS (6.385s)
[67.233422] [003/130] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[67.330464] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[74.931959] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.603s)
[75.064986] [004/130] (942s left) kms_atomic (plane-cursor-legacy)
[75.173065] Starting subtest: plane-cursor-legacy
[75.175446] Starting dynamic subtest: pipe-A-eDP-1
[75.596237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[75.598754] Subtest plane-cursor-legacy: SUCCESS (0.422s)
[76.419918] [005/130] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[76.515802] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[76.520076] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.595428] [006/130] (940s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[76.689397] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[83.719076] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.034s)
[83.852355] [007/130] (933s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[83.949971] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[83.952228] Starting dynamic subtest: pipe-A-eDP-1
[99.887867] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.537s)
[99.901796] Starting dynamic subtest: pipe-B-eDP-1
[116.868093] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.422s)
[116.877127] Starting dynamic subtest: pipe-C-eDP-1
[133.832447] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.435s)
[133.841573] Starting dynamic subtest: pipe-D-eDP-1
[150.855653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.367s)
[150.858060] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.764s)
[152.075575] [008/130] (865s left) kms_selftest (drm_plane_helper)
[152.124091] Starting subtest: drm_plane_helper
[152.131941] Starting dynamic subtest: drm_test_check_plane_state
[152.236764] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.103s)
[152.246309] Starting dynamic subtest: drm_test_check_invalid_plane_state
[152.344255] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.105s)
[152.346424] Subtest drm_plane_helper: SUCCESS (0.220s)
[152.508222] [009/130] (864s left) gem_exec_create (basic)
[152.575295] Starting subtest: basic
[152.577714] Starting dynamic subtest: smem
[156.410930] Dynamic subtest smem: SUCCESS (3.818s)
[156.413869] Subtest basic: SUCCESS (3.819s)
[156.624740] [010/130] (860s left) gem_ccs (block-multicopy-compressed)
[156.694601] Starting subtest: block-multicopy-compressed
[156.699102] Subtest block-multicopy-compressed: SKIP (0.000s)
[156.807442] [011/130] (860s left) gem_exec_fence (syncobj-timeline-export)
[157.419826] Starting subtest: syncobj-timeline-export
[157.429694] Subtest syncobj-timeline-export: SUCCESS (0.012s)
[158.471275] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[158.474444] [012/130] (858s left) gem_mmap_gtt (hang-user)
[158.530903] Subtest hang-user: SKIP (0.000s)
[158.589432] [013/130] (858s left) prime_self_import (basic-with_fd_dup)
[158.620086] Starting subtest: basic-with_fd_dup
[158.635553] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[158.743617] [014/130] (858s left) gem_exec_whisper (basic-sync)
[158.816588] Starting subtest: basic-sync
[167.813531] Subtest basic-sync: SUCCESS (8.980s)
[167.999911] [015/130] (849s left) kms_psr (fbc-pr-cursor-blt)
[168.092884] Starting subtest: fbc-pr-cursor-blt
[168.097323] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[168.166047] [016/130] (849s left) gem_spin_batch (resubmit-new)
[168.234790] Starting subtest: resubmit-new
[168.237090] Starting dynamic subtest: rcs0
[168.242760] Dynamic subtest rcs0: SUCCESS (0.008s)
[168.253968] Starting dynamic subtest: bcs0
[168.256176] Dynamic subtest bcs0: SUCCESS (0.004s)
[168.265263] Starting dynamic subtest: vcs0
[168.267479] Dynamic subtest vcs0: SUCCESS (0.006s)
[168.279638] Starting dynamic subtest: vcs1
[168.281567] Dynamic subtest vcs1: SUCCESS (0.009s)
[168.290296] Starting dynamic subtest: vecs0
[168.292162] Dynamic subtest vecs0: SUCCESS (0.006s)
[168.300623] Starting dynamic subtest: ccs0
[168.302530] Dynamic subtest ccs0: SUCCESS (0.006s)
[168.304467] Subtest resubmit-new: SUCCESS (0.043s)
[169.457336] [017/130] (848s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[169.511626] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[169.513971] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[169.606259] [018/130] (848s left) gem_exec_schedule (submit-late-slice)
[169.670943] Starting subtest: submit-late-slice
[169.673146] Starting dynamic subtest: rcs0
[169.701937] Dynamic subtest rcs0: SUCCESS (0.039s)
[169.714087] Starting dynamic subtest: bcs0
[169.736363] Dynamic subtest bcs0: SUCCESS (0.034s)
[169.746401] Starting dynamic subtest: vcs0
[169.771853] Dynamic subtest vcs0: SUCCESS (0.035s)
[169.781089] Starting dynamic subtest: vcs1
[169.803429] Dynamic subtest vcs1: SUCCESS (0.031s)
[169.812555] Starting dynamic subtest: vecs0
[169.835114] Dynamic subtest vecs0: SUCCESS (0.031s)
[169.843776] Starting dynamic subtest: ccs0
[169.872335] Dynamic subtest ccs0: SUCCESS (0.037s)
[169.874544] Subtest submit-late-slice: SUCCESS (0.210s)
[171.482775] [019/130] (846s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[171.600462] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[171.602717] Starting dynamic subtest: pipe-A-eDP-1
[171.696616] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[171.713017] Starting dynamic subtest: pipe-B-eDP-1
[172.789733] Dynamic subtest pipe-B-eDP-1: SKIP (1.090s)
[172.794430] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.192s)
[173.970676] [020/130] (843s left) sysfs_defaults (readonly)
[174.037207] Starting subtest: readonly
[174.039555] Starting dynamic subtest: vecs0
[174.041802] Dynamic subtest vecs0: SUCCESS (0.000s)
[174.051587] Starting dynamic subtest: ccs0
[174.053696] Dynamic subtest ccs0: SUCCESS (0.000s)
[174.062448] Starting dynamic subtest: vcs0
[174.064527] Dynamic subtest vcs0: SUCCESS (0.000s)
[174.073279] Starting dynamic subtest: bcs0
[174.075429] Dynamic subtest bcs0: SUCCESS (0.000s)
[174.083966] Starting dynamic subtest: rcs0
[174.085822] Dynamic subtest rcs0: SUCCESS (0.000s)
[174.094911] Starting dynamic subtest: vcs1
[174.096999] Dynamic subtest vcs1: SUCCESS (0.000s)
[174.099107] Subtest readonly: SUCCESS (0.004s)
[174.137768] [021/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[174.237633] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[174.239897] Starting dynamic subtest: pipe-A-eDP-1
[174.259645] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[174.269943] Starting dynamic subtest: pipe-B-eDP-1
[174.288303] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[174.296887] Starting dynamic subtest: pipe-C-eDP-1
[174.315581] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[174.324145] Starting dynamic subtest: pipe-D-eDP-1
[174.342754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[174.344866] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[176.528939] [022/130] (841s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[176.631419] Starting subtest: fbc-psr2-cursor-plane-update-sf
[176.633755] Starting dynamic subtest: pipe-A-eDP-1
[176.721541] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[176.732904] Starting dynamic subtest: pipe-B-eDP-1
[177.806872] Dynamic subtest pipe-B-eDP-1: SKIP (1.083s)
[177.811081] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.179s)
[179.089569] [023/130] (838s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[179.202643] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[179.206908] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[179.294942] [024/130] (838s left) kms_cursor_crc (cursor-random-256x85)
[179.551679] Starting subtest: cursor-random-256x85
[179.599662] Subtest cursor-random-256x85: SKIP (0.043s)
[179.818799] [025/130] (838s left) kms_psr (fbc-psr-dpms)
[179.909820] Starting subtest: fbc-psr-dpms
[179.912136] Starting dynamic subtest: eDP-1
[179.916419] Dynamic subtest eDP-1: SKIP (0.000s)
[179.920777] Subtest fbc-psr-dpms: SKIP (0.001s)
[179.981029] [026/130] (838s left) kms_dsc (dsc-with-bpc)
[180.075089] Starting subtest: dsc-with-bpc
[180.100545] Subtest dsc-with-bpc: SKIP (0.001s)
[180.156251] [027/130] (837s left) gem_ctx_shared (create-shared-gtt)
[180.220117] Starting subtest: create-shared-gtt
[182.380623] Subtest create-shared-gtt: SUCCESS (2.151s)
[182.740975] [028/130] (835s left) kms_hdr (invalid-hdr)
[182.844018] Starting subtest: invalid-hdr
[184.897643] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[187.903154] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (3.005s)
[189.004189] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[191.980468] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (2.982s)
[191.982747] Subtest invalid-hdr: SUCCESS (9.138s)
[192.085468] [029/130] (826s left) kms_flip (absolute-wf_vblank)
[192.189851] Starting subtest: absolute-wf_vblank
[192.192309] Starting dynamic subtest: A-eDP1
[200.891686] Dynamic subtest A-eDP1: SUCCESS (8.698s)
[200.903243] Starting dynamic subtest: B-eDP1
[209.631922] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[209.641227] Starting dynamic subtest: C-eDP1
[218.360863] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[218.370014] Starting dynamic subtest: D-eDP1
[227.096080] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[227.098287] Subtest absolute-wf_vblank: SUCCESS (34.898s)
[228.309035] [030/130] (789s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[228.416135] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[232.147670] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.733s)
[233.321205] [031/130] (784s left) perf_pmu (busy-accuracy-98)
[233.370388] Starting subtest: busy-accuracy-98
[233.372311] Starting dynamic subtest: rcs0
[236.410570] Dynamic subtest rcs0: SUCCESS (3.036s)
[236.421774] Starting dynamic subtest: bcs0
[239.460605] Dynamic subtest bcs0: SUCCESS (3.049s)
[239.470334] Starting dynamic subtest: vcs0
[242.501138] Dynamic subtest vcs0: SUCCESS (3.037s)
[242.512911] Starting dynamic subtest: vcs1
[245.546182] Dynamic subtest vcs1: SUCCESS (3.042s)
[245.557099] Starting dynamic subtest: vecs0
[248.589453] Dynamic subtest vecs0: SUCCESS (3.043s)
[248.600211] Starting dynamic subtest: ccs0
[251.642408] Dynamic subtest ccs0: SUCCESS (3.050s)
[251.644651] Subtest busy-accuracy-98: SUCCESS (18.265s)
[251.757155] [032/130] (766s left) gem_mmap_wc (coherency)
[251.821030] Subtest coherency: SKIP (0.000s)
[251.884821] [033/130] (766s left) gem_vm_create (execbuf)
[251.948966] Starting subtest: execbuf
[251.961575] Subtest execbuf: SUCCESS (0.013s)
[252.097182] [034/130] (766s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[252.195228] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[252.199315] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[252.305462] [035/130] (766s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[252.435627] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[252.440068] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[252.577999] [036/130] (765s left) syncobj_wait (invalid-reset-illegal-handle)
[252.634878] Starting subtest: invalid-reset-illegal-handle
[252.637115] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[252.748184] [037/130] (765s left) syncobj_timeline (invalid-signal-zero-handles)
[252.802101] Starting subtest: invalid-signal-zero-handles
[252.803968] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[252.904366] [038/130] (765s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[252.970718] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[253.077655] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[253.168066] [039/130] (765s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[253.266131] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[253.276893] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[253.354462] [040/130] (765s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[253.410850] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[253.471663] [041/130] (765s left) gem_pxp (reject-modify-context-protection-off-3)
[253.594375] Starting subtest: reject-modify-context-protection-off-3
[253.596902] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[253.711201] [042/130] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[253.807621] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[253.812258] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[253.916112] [043/130] (764s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[254.023240] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[254.049886] Starting dynamic subtest: pipe-A-plane-0
[254.505004] Dynamic subtest pipe-A-plane-0: SUCCESS (0.456s)
[254.516623] Starting dynamic subtest: pipe-A-plane-3
[254.782773] Dynamic subtest pipe-A-plane-3: SUCCESS (0.275s)
[255.897533] Starting dynamic subtest: pipe-B-plane-0
[256.331296] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[256.343497] Starting dynamic subtest: pipe-B-plane-3
[256.608961] Dynamic subtest pipe-B-plane-3: SUCCESS (0.276s)
[256.931604] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.910s)
[257.785199] [044/130] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[257.881487] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[257.885924] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[257.981605] [045/130] (760s left) gen7_exec_parse (basic-rejected)
[258.043039] Subtest basic-rejected: SKIP (0.000s)
[258.103696] [046/130] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[258.208369] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[264.890797] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.684s)
[265.039466] [047/130] (753s left) kms_chamelium_frames (dp-crc-single)
[265.419417] Subtest dp-crc-single: SKIP (0.000s)
[266.240446] [048/130] (752s left) kms_cdclk (mode-transition-all-outputs)
[266.330988] Starting subtest: mode-transition-all-outputs
[266.619402] Subtest mode-transition-all-outputs: SKIP (0.287s)
[267.483137] [049/130] (751s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[267.583241] Starting subtest: x-tiled-16bpp-rotate-0
[268.831837] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.246s)
[268.952140] [050/130] (750s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[269.053442] Starting subtest: y-tiled-16bpp-rotate-90
[269.057243] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[269.146237] [051/130] (749s left) kms_addfb_basic (bad-pitch-128)
[269.206214] Starting subtest: bad-pitch-128
[269.207907] Subtest bad-pitch-128: SUCCESS (0.000s)
[269.351221] [052/130] (749s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[269.456966] Starting subtest: yf-tiled-64bpp-rotate-0
[269.460560] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[269.567953] [053/130] (749s left) gem_exec_fence (syncobj-unused-fence)
[270.013313] Starting subtest: syncobj-unused-fence
[270.019080] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[271.493187] [054/130] (747s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[271.579674] Starting subtest: fbc-psr2-primary-mmap-gtt
[271.582048] Starting dynamic subtest: eDP-1
[271.586034] Dynamic subtest eDP-1: SKIP (0.000s)
[271.590086] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[271.662899] [055/130] (747s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[271.754340] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[271.758670] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[271.860227] [056/130] (747s left) kms_cursor_crc (cursor-sliding-256x85)
[272.113501] Starting subtest: cursor-sliding-256x85
[272.161372] Subtest cursor-sliding-256x85: SKIP (0.043s)
[272.341900] [057/130] (747s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[272.437496] Starting subtest: blocking-absolute-wf_vblank-interruptible
[272.439990] Starting dynamic subtest: A-eDP1
[281.128754] Dynamic subtest A-eDP1: SUCCESS (8.689s)
[281.140131] Starting dynamic subtest: B-eDP1
[289.853622] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[289.865937] Starting dynamic subtest: C-eDP1
[298.577339] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[298.587703] Starting dynamic subtest: D-eDP1
[307.302595] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[307.307335] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.864s)
[308.525494] [058/130] (710s left) kms_cursor_crc (cursor-offscreen-64x64)
[308.711452] Starting subtest: cursor-offscreen-64x64
[308.713875] Starting dynamic subtest: pipe-A-eDP-1
[310.653589] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[310.687036] Starting dynamic subtest: pipe-D-eDP-1
[313.241463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[313.243577] Subtest cursor-offscreen-64x64: SUCCESS (4.530s)
[314.105043] [059/130] (705s left) kms_flip (2x-busy-flip)
[314.194274] Starting subtest: 2x-busy-flip
[314.217452] Subtest 2x-busy-flip: SKIP (0.023s)
[314.305429] [060/130] (705s left) perf_pmu (module-unload)