[56.928839] Initializing watchdogs
[56.928885]   /dev/watchdog0
[56.945358] [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.950115] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.952330] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.955616] [001/132] (960s left) syncobj_wait (single-wait-all-for-submit-signaled)
[57.026089] Starting subtest: single-wait-all-for-submit-signaled
[57.028361] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[57.130334] [002/132] (960s left) perf_pmu (busy-idle)
[57.171687] Starting subtest: busy-idle
[57.174037] Starting dynamic subtest: rcs0
[57.874574] Dynamic subtest rcs0: SUCCESS (0.717s)
[57.884746] Starting dynamic subtest: bcs0
[58.540851] Dynamic subtest bcs0: SUCCESS (0.677s)
[58.549437] Starting dynamic subtest: vcs0
[60.295501] Dynamic subtest vcs0: SUCCESS (1.780s)
[60.304565] Starting dynamic subtest: vcs1
[62.281093] Dynamic subtest vcs1: SUCCESS (2.009s)
[62.291396] Starting dynamic subtest: vecs0
[64.327391] Dynamic subtest vecs0: SUCCESS (2.064s)
[64.338322] Starting dynamic subtest: ccs0
[65.000504] Dynamic subtest ccs0: SUCCESS (0.679s)
[65.003483] Subtest busy-idle: SUCCESS (7.932s)
[65.104727] [003/132] (952s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[65.218194] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[65.222789] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[65.318455] [004/132] (952s left) gem_exec_schedule (preempt-hang)
[65.497341] Starting subtest: preempt-hang
[65.500173] Starting dynamic subtest: rcs0
[65.717359] Dynamic subtest rcs0: SUCCESS (0.223s)
[65.726197] Starting dynamic subtest: bcs0
[65.933587] Dynamic subtest bcs0: SUCCESS (0.216s)
[65.944580] Starting dynamic subtest: vcs0
[66.150698] Dynamic subtest vcs0: SUCCESS (0.218s)
[66.164101] Starting dynamic subtest: vcs1
[66.357981] Dynamic subtest vcs1: SUCCESS (0.209s)
[66.366614] Starting dynamic subtest: vecs0
[66.575264] Dynamic subtest vecs0: SUCCESS (0.218s)
[66.585805] Starting dynamic subtest: ccs0
[66.791620] Dynamic subtest ccs0: SUCCESS (0.218s)
[66.793603] Subtest preempt-hang: SUCCESS (1.303s)
[67.366980] [005/132] (950s left) kms_scaling_modes (scaling-mode-none)
[67.463632] Starting subtest: scaling-mode-none
[67.465778] Starting dynamic subtest: pipe-A-eDP-1
[67.557586] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[67.568105] Starting dynamic subtest: pipe-B-eDP-1
[67.590092] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s)
[67.598270] Starting dynamic subtest: pipe-C-eDP-1
[67.623523] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[67.633554] Starting dynamic subtest: pipe-D-eDP-1
[67.655195] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[67.659589] Subtest scaling-mode-none: SKIP (0.192s)
[67.772039] [006/132] (949s left) kms_cursor_crc (cursor-sliding-max-size)
[68.060604] Starting subtest: cursor-sliding-max-size
[68.067299] Subtest cursor-sliding-max-size: SKIP (0.000s)
[68.175869] [007/132] (949s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[68.263336] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[68.265711] Starting dynamic subtest: pipe-A-eDP-1
[68.288827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.300886] Starting dynamic subtest: pipe-B-eDP-1
[68.322612] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.330632] Starting dynamic subtest: pipe-C-eDP-1
[68.348415] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.355333] Starting dynamic subtest: pipe-D-eDP-1
[68.373536] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.377094] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[70.508600] [008/132] (947s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[70.605982] Starting subtest: 4-tiled-16bpp-rotate-0
[71.969546] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[72.077968] [009/132] (945s left) gem_exec_fence (syncobj-export)
[72.682938] Starting subtest: syncobj-export
[72.691500] Subtest syncobj-export: SUCCESS (0.011s)
[74.386955] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[74.390082] [010/132] (943s left) gem_ccs (block-copy-compressed)
[74.440842] Starting subtest: block-copy-compressed
[74.445041] Subtest block-copy-compressed: SKIP (0.000s)
[74.537068] [011/132] (943s left) kms_content_protection (uevent)
[74.677739] Starting subtest: uevent
[74.682243] Subtest uevent: SKIP (0.000s)
[74.804318] [012/132] (943s left) kms_pipe_crc_basic (suspend-read-crc)
[74.885866] Starting subtest: suspend-read-crc
[74.888047] Starting dynamic subtest: pipe-A-eDP-1
[93.119800] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.709s)
[93.129891] Starting dynamic subtest: pipe-B-eDP-1
[111.070589] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.224s)
[111.081210] Starting dynamic subtest: pipe-C-eDP-1
[129.035960] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.085s)
[129.046831] Starting dynamic subtest: pipe-D-eDP-1
[147.039494] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.080s)
[147.041363] Subtest suspend-read-crc: SUCCESS (12.101s)
[147.845523] [013/132] (870s left) dumb_buffer (invalid-bpp)
[147.900921] Starting subtest: invalid-bpp
[147.903054] Subtest invalid-bpp: SUCCESS (0.000s)
[147.994475] [014/132] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[148.098940] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[148.103798] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[148.195851] [015/132] (869s left) gem_exec_flush (basic-wb-ro-default)
[148.260125] Starting subtest: basic-wb-ro-default
[153.583005] Subtest basic-wb-ro-default: SUCCESS (5.460s)
[153.782039] [016/132] (864s left) gem_ctx_persistence (engines-mixed)
[153.841710] Starting subtest: engines-mixed
[153.843589] Starting dynamic subtest: rcs0
[153.917791] Dynamic subtest rcs0: SUCCESS (0.078s)
[153.929785] Starting dynamic subtest: bcs0
[153.948656] Dynamic subtest bcs0: SUCCESS (0.032s)
[153.957344] Starting dynamic subtest: vcs0
[154.027882] Dynamic subtest vcs0: SUCCESS (0.080s)
[154.039074] Starting dynamic subtest: vcs1
[154.087997] Dynamic subtest vcs1: SUCCESS (0.060s)
[154.098092] Starting dynamic subtest: vecs0
[154.149898] Dynamic subtest vecs0: SUCCESS (0.062s)
[154.160990] Starting dynamic subtest: ccs0
[154.212113] Dynamic subtest ccs0: SUCCESS (0.062s)
[154.214492] Subtest engines-mixed: SUCCESS (0.379s)
[154.305154] [017/132] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[154.400607] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[154.404538] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[154.482861] [018/132] (863s left) vgem_basic (bad-fence)
[154.526657] Starting subtest: bad-fence
[154.528473] Subtest bad-fence: SUCCESS (0.000s)
[154.583598] [019/132] (863s left) gem_mmap_gtt (basic-small-copy-xy)
[154.645535] Subtest basic-small-copy-XY: SKIP (0.000s)
[154.709596] [020/132] (863s left) perf_pmu (busy)
[154.747495] Starting subtest: busy
[154.749287] Starting dynamic subtest: rcs0
[155.343696] Dynamic subtest rcs0: SUCCESS (0.605s)
[155.357303] Starting dynamic subtest: bcs0
[155.909179] Dynamic subtest bcs0: SUCCESS (0.572s)
[155.921344] Starting dynamic subtest: vcs0
[157.704848] Dynamic subtest vcs0: SUCCESS (1.813s)
[157.717271] Starting dynamic subtest: vcs1
[159.688684] Dynamic subtest vcs1: SUCCESS (2.000s)
[159.701151] Starting dynamic subtest: vecs0
[161.736794] Dynamic subtest vecs0: SUCCESS (2.061s)
[161.748472] Starting dynamic subtest: ccs0
[162.301288] Dynamic subtest ccs0: SUCCESS (0.567s)
[162.303997] Subtest busy: SUCCESS (7.626s)
[162.399192] [021/132] (855s left) gem_exec_suspend (basic)
[162.460211] Starting subtest: basic
[162.462979] Starting dynamic subtest: smem
[163.721146] Dynamic subtest smem: SUCCESS (1.265s)
[163.724099] Subtest basic: SUCCESS (1.267s)
[163.903965] [022/132] (854s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[163.957040] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[164.061095] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[164.138584] [023/132] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[164.235853] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[164.240366] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[164.335387] [024/132] (854s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[164.425930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[164.430253] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[164.529367] [025/132] (853s left) gem_exec_flush (basic-uc-ro-default)
[164.597950] Starting subtest: basic-uc-ro-default
[170.031513] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[170.215184] [026/132] (848s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[170.277312] Subtest writes-after-reads-snoop: SKIP (0.000s)
[170.339685] [027/132] (848s left) core_debugfs (read-all-entries)
[170.391126] Starting subtest: read-all-entries
[170.474386] Subtest read-all-entries: SUCCESS (0.084s)
[170.538497] [028/132] (847s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[170.588202] Starting subtest: y-tiled-to-vebox-yf-tiled
[170.592860] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[170.769557] [029/132] (847s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[170.820673] Starting subtest: wait-all-for-submit-delayed-submit
[170.924993] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[171.013959] [030/132] (847s left) kms_flip (dpms-vs-vblank-race)
[171.112307] Starting subtest: dpms-vs-vblank-race
[171.114766] Starting dynamic subtest: A-eDP1
[176.153306] Dynamic subtest A-eDP1: SUCCESS (5.045s)
[176.163227] Starting dynamic subtest: B-eDP1
[180.794273] Dynamic subtest B-eDP1: SUCCESS (4.635s)
[180.803929] Starting dynamic subtest: C-eDP1
[185.424492] Dynamic subtest C-eDP1: SUCCESS (4.625s)
[185.433577] Starting dynamic subtest: D-eDP1
[190.060909] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[190.062960] Subtest dpms-vs-vblank-race: SUCCESS (18.946s)
[190.933268] [031/132] (827s left) gem_mmap_offset (partial-mmap)
[190.993236] Starting subtest: partial-mmap
[190.995463] Starting dynamic subtest: smem0
[190.997655] Dynamic subtest smem0: SUCCESS (0.004s)
[190.999496] Subtest partial-mmap: SUCCESS (0.005s)
[191.111151] [032/132] (827s left) gem_exec_schedule (u-lateslice)
[191.179500] Starting subtest: u-lateslice
[191.181360] Starting dynamic subtest: rcs0
[191.193622] Dynamic subtest rcs0: SUCCESS (0.025s)
[191.202704] Starting dynamic subtest: bcs0
[191.211510] Dynamic subtest bcs0: SUCCESS (0.017s)
[191.220804] Starting dynamic subtest: vcs0
[191.228553] Dynamic subtest vcs0: SUCCESS (0.017s)
[191.237689] Starting dynamic subtest: vcs1
[191.246846] Dynamic subtest vcs1: SUCCESS (0.017s)
[191.255937] Starting dynamic subtest: vecs0
[191.263885] Dynamic subtest vecs0: SUCCESS (0.017s)
[191.273043] Starting dynamic subtest: ccs0
[191.280277] Dynamic subtest ccs0: SUCCESS (0.016s)
[191.282546] Subtest u-lateslice: SUCCESS (0.111s)
[192.799589] [033/132] (825s left) gem_mmap_wc (bad-object)
[192.871373] Subtest bad-object: SKIP (0.000s)
[192.938701] [034/132] (825s left) gem_basic (create-close)
[193.005746] Starting subtest: create-close
[193.009781] Subtest create-close: SUCCESS (0.000s)
[193.106351] [035/132] (825s left) gem_lmem_swapping (heavy-verify-random)
[193.149702] Subtest heavy-verify-random: SKIP (0.000s)
[193.192331] [036/132] (825s left) api_intel_allocator (two-level-inception)
[193.253754] Starting subtest: two-level-inception
[198.653892] Subtest two-level-inception: SUCCESS (5.401s)
[198.795576] [037/132] (820s left) i915_pm_rpm (system-suspend-devices)
[200.920840] Starting subtest: system-suspend-devices
[208.626129] Subtest system-suspend-devices: SUCCESS (7.706s)
[209.008155] [038/132] (809s left) prime_vgem (basic-blt)
[209.077490] Starting subtest: basic-blt
[209.114405] Subtest basic-blt: SUCCESS (0.039s)
[209.244604] [039/132] (809s left) kms_plane_multiple (tiling-y)
[209.331413] Starting subtest: tiling-y
[209.335520] Subtest tiling-y: SKIP (0.000s)
[209.403829] [040/132] (809s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[209.473942] Starting subtest: yf-tiled-ccs-to-x-tiled
[209.478466] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[209.656743] [041/132] (809s left) kms_pm_dc (dc5-dpms)
[210.764469] Starting subtest: dc5-dpms
[212.884318] Subtest dc5-dpms: SUCCESS (2.111s)
[212.951985] [042/132] (806s left) gem_eio (in-flight-contexts-1us)
[213.191580] Starting subtest: in-flight-contexts-1us
[226.725051] Subtest in-flight-contexts-1us: SUCCESS (13.533s)
[226.859724] [043/132] (792s left) prime_self_import (basic-with_fd_dup)
[226.893703] Starting subtest: basic-with_fd_dup
[226.916057] Subtest basic-with_fd_dup: SUCCESS (0.025s)
[227.014927] [044/132] (792s left) gem_exec_reloc (basic-gtt)
[227.082080] Subtest basic-gtt: SKIP (0.000s)
[227.167986] [045/132] (792s left) gem_eio (in-flight-suspend)
[227.397081] Starting subtest: in-flight-suspend
[270.502280] Subtest in-flight-suspend: SUCCESS (13.357s)
[270.647375] [046/132] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[270.753387] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[270.757265] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[270.858777] [047/132] (748s left) gem_ctx_persistence (legacy-engines-cleanup)
[270.911156] Starting subtest: legacy-engines-cleanup
[270.913417] Starting dynamic subtest: render
[270.983631] Dynamic subtest render: SUCCESS (0.075s)
[270.997951] Starting dynamic subtest: bsd1
[271.022482] Dynamic subtest bsd1: SUCCESS (0.039s)
[271.032284] Starting dynamic subtest: bsd2
[271.045596] Dynamic subtest bsd2: SUCCESS (0.022s)
[271.057173] Starting dynamic subtest: blt
[271.087371] Dynamic subtest blt: SUCCESS (0.043s)
[271.097444] Starting dynamic subtest: vebox
[271.152855] Dynamic subtest vebox: SUCCESS (0.067s)
[271.155249] Subtest legacy-engines-cleanup: SUCCESS (0.254s)
[271.236356] [048/132] (748s left) gem_exec_schedule (deep)
[271.418115] Starting subtest: deep
[271.420297] Starting dynamic subtest: rcs0
[277.229444] Dynamic subtest rcs0: SKIP (5.985s)
[277.239400] Starting dynamic subtest: vcs0
[288.361423] Dynamic subtest vcs0: SUCCESS (11.248s)
[288.376411] Starting dynamic subtest: vcs1
[299.960647] Dynamic subtest vcs1: SUCCESS (11.630s)
[299.977145] Starting dynamic subtest: vecs0
[311.629259] Dynamic subtest vecs0: SUCCESS (11.654s)
[311.641024] Starting dynamic subtest: ccs0
[324.423693] Dynamic subtest ccs0: SUCCESS (12.797s)
[324.426191] Subtest deep: SUCCESS (53.320s)
[325.690591] [049/132] (693s left) gem_mmap_wc (copy)
[325.741822] Subtest copy: SKIP (0.000s)
[325.811845] [050/132] (693s left) syncobj_wait (invalid-reset-illegal-handle)
[325.858425] Starting subtest: invalid-reset-illegal-handle
[325.860716] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[325.960894] [051/132] (693s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[326.050899] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[326.053088] Starting dynamic subtest: pipe-A-default-mode
[328.776297] Dynamic subtest pipe-A-default-mode: SUCCESS (2.725s)
[328.778763] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.726s)
[329.609730] [052/132] (689s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[329.716221] Starting subtest: x-tiled-64bpp-rotate-180
[331.361670] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.646s)
[331.548620] [053/132] (688s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[331.612635] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[331.614282] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[331.720785] [054/132] (687s left) kms_flip (flip-vs-panning-vs-hang)
[331.813059] Starting subtest: flip-vs-panning-vs-hang
[331.815026] Starting dynamic subtest: A-eDP1
[382.957825] Dynamic subtest A-eDP1: SUCCESS (51.148s)
[382.969512] Starting dynamic subtest: D-eDP1
[422.957719] Dynamic subtest D-eDP1: SUCCESS (39.998s)
[422.963408] Subtest flip-vs-panning-vs-hang: SUCCESS (91.152s)
[424.218381] [055/132] (595s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[424.290065] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[424.292395] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[424.409347] [056/132] (595s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[424.509148] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[424.511573] Starting dynamic subtest: pipe-A-default-mode
[427.264928] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[427.266883] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.756s)
[428.110752] [057/132] (591s left) kms_hdr (static-toggle-dpms)
[428.204550] Starting subtest: static-toggle-dpms
[428.211308] Subtest static-toggle-dpms: SKIP (0.000s)
[428.280693] [058/132] (591s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[428.373947] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[428.376259] Starting dynamic subtest: pipe-A-eDP-1
[434.292520] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.924s)
[434.304021] Starting dynamic subtest: pipe-B-eDP-1
[440.931999] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.639s)
[440.934330] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.566s)
[441.807516] [059/132] (578s left) prime_mmap (test_map_unmap)
[441.865424] Starting subtest: test_map_unmap
[441.867300] Starting dynamic subtest: test_map_unmap-smem
[441.895869] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[441.898287] Subtest test_map_unmap: SUCCESS (0.033s)
[441.995726] [060/132] (577s left) gem_exec_reloc (basic-range-active)
[442.059988] Subtest basic-range-active: SKIP (0.000s)
[442.136121] [061/132] (577s left) gem_mmap_gtt (basic-small-bo)
[442.192919] Subtest basic-small-bo: SKIP (0.000s)
[442.258435] [062/132] (577s left) kms_psr (fbc-psr-basic)
[442.359859] Starting subtest: fbc-psr-basic
[442.361995] Starting dynamic subtest: eDP-1
[442.365922] Dynamic subtest eDP-1: SKIP (0.000s)
[442.369913] Subtest fbc-psr-basic: SKIP (0.001s)
[442.437108] [063/132] (577s left) gem_softpin (full)
[442.485992] Starting subtest: full
[442.492606] Subtest full: SUCCESS (0.007s)
[442.627329] [064/132] (577s left) kms_big_fb (linear-8bpp-rotate-90)
[442.733089] Starting subtest: linear-8bpp-rotate-90
[442.753186] Subtest linear-8bpp-rotate-90: SKIP (0.019s)
[442.857911] [065/132] (577s left) kms_color_pipeline (plane-lut1d-lut1d)
[442.950582] Starting subtest: plane-lut1d-lut1d
[443.120426] Starting dynamic subtest: pipe-A-plane-0
[443.297113] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[443.310666] Starting dynamic subtest: pipe-A-plane-1
[443.453318] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[443.463071] Starting dynamic subtest: pipe-A-plane-2
[443.641683] Dynamic subtest pipe-A-plane-2: SUCCESS (0.187s)
[444.796446] Starting dynamic subtest: pipe-B-plane-0
[444.954613] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[444.965250] Starting dynamic subtest: pipe-B-plane-1
[445.121634] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[445.132121] Starting dynamic subtest: pipe-B-plane-2
[445.265817] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[446.430155] Starting dynamic subtest: pipe-C-plane-0
[446.565468] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[446.575527] Starting dynamic subtest: pipe-C-plane-1
[446.698879] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[446.709323] Starting dynamic subtest: pipe-C-plane-2
[446.843277] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s)
[448.053090] Starting dynamic subtest: pipe-D-plane-0
[448.177466] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[448.188265] Starting dynamic subtest: pipe-D-plane-1
[448.321874] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[448.332319] Starting dynamic subtest: pipe-D-plane-2
[448.488359] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[448.778733] Subtest plane-lut1d-lut1d: SUCCESS (5.828s)
[449.623033] [066/132] (570s left) gem_userptr_blits (vma-merge)
[449.702369] Starting subtest: vma-merge
[449.743807] Subtest vma-merge: SUCCESS (0.041s)
[449.869655] [067/132] (570s left) gem_ctx_param (basic-default)
[449.925291] Starting subtest: basic-default
[449.927785] Subtest basic-default: SUCCESS (0.000s)
[450.007131] [068/132] (570s left) kms_plane (pixel-format-linear-modifier)
[450.109890] Starting subtest: pixel-format-linear-modifier
[450.137266] Starting dynamic subtest: pipe-A-plane-0
[453.780178] Dynamic subtest pipe-A-plane-0: SUCCESS (3.644s)
[453.789904] Starting dynamic subtest: pipe-A-plane-3
[455.479919] Dynamic subtest pipe-A-plane-3: SUCCESS (1.699s)
[455.492777] Starting dynamic subtest: pipe-A-plane-5
[455.691257] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[456.808565] Starting dynamic subtest: pipe-B-plane-0
[460.454011] Dynamic subtest pipe-B-plane-0: SUCCESS (3.655s)
[460.463950] Starting dynamic subtest: pipe-B-plane-3
[462.132430] Dynamic subtest pipe-B-plane-3: SUCCESS (1.677s)
[462.144539] Starting dynamic subtest: pipe-B-plane-5
[462.343079] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[462.664769] Subtest pixel-format-linear-modifier: SUCCESS (12.557s)
[463.533644] [069/132] (556s left) gem_ctx_create (basic-files)
[463.600798] Starting subtest: basic-files
[466.095875] Subtest basic-files: SUCCESS (2.495s)
[467.498379] [070/132] (552s left) gem_exec_whisper (basic-fds-forked)
[467.563564] Starting subtest: basic-fds-forked
[491.315254] Subtest basic-fds-forked: SUCCESS (23.756s)
[491.500965] [071/132] (528s left) kms_psr (pr-cursor-mmap-cpu)
[491.608799] Starting subtest: pr-cursor-mmap-cpu
[491.613305] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[491.682637] [072/132] (528s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[491.792689] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[492.838847] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.047s)
[492.970604] [073/132] (527s left) kms_dp_link_training (uhbr-sst)
[493.071940] Starting subtest: uhbr-sst
[493.079538] Subtest uhbr-sst: SKIP (0.000s)
[493.173770] [074/132] (527s left) kms_chamelium_hpd (vga-hpd)
[493.559409] Subtest vga-hpd: SKIP (0.000s)
[494.376388] [075/132] (526s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[494.472200] Starting subtest: addfb25-y-tiled-small-legacy
[494.476763] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[494.573756] [076/132] (526s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[494.666023] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[494.668314] Starting dynamic subtest: pipe-A-eDP-1
[494.937214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.239s)
[494.952084] Starting dynamic subtest: pipe-B-eDP-1
[496.166650] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.226s)
[496.178971] Starting dynamic subtest: pipe-C-eDP-1
[497.384128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[497.395484] Starting dynamic subtest: pipe-D-eDP-1
[498.594638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[498.596889] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.900s)
[499.738502] [077/132] (520s left) i915_drm_fdinfo (memory-info-idle)
[499.784517] Starting subtest: memory-info-idle
[499.786910] Starting dynamic subtest: smem0
[499.829908] Dynamic subtest smem0: SUCCESS (0.049s)
[499.832142] Subtest memory-info-idle: SUCCESS (0.050s)
[499.908492] [078/132] (520s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[500.011807] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[500.014073] Starting dynamic subtest: pipe-A-eDP-1
[500.034284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[500.048251] Starting dynamic subtest: pipe-B-eDP-1
[500.066503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[500.076299] Starting dynamic subtest: pipe-C-eDP-1
[500.095038] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[500.104779] Starting dynamic subtest: pipe-D-eDP-1
[500.123312] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[500.125406] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[502.282899] [079/132] (518s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[502.339043] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[502.406242] [080/132] (518s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[502.510639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[509.243577] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.736s)
[509.381952] [081/132] (511s left) gem_exec_balancer (parallel-keep-in-fence)
[509.642026] Starting subtest: parallel-keep-in-fence
[510.891183] Subtest parallel-keep-in-fence: SUCCESS (1.248s)
[511.016363] [082/132] (509s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[511.068411] Starting subtest: multi-wait-all-for-submit-signaled
[511.070720] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[511.185543] [083/132] (509s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[511.289799] Starting subtest: fbc-indfb-scaledprimary
[514.267839] Subtest fbc-indfb-scaledprimary: SUCCESS (2.980s)
[515.402503] [084/132] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[515.504781] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[515.509324] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[515.607025] [085/132] (505s left) kms_cursor_crc (cursor-random-512x512)
[515.903147] Starting subtest: cursor-random-512x512
[515.907740] Subtest cursor-random-512x512: SKIP (0.001s)
[516.079124] [086/132] (504s left) gem_mmap_gtt (basic-short)
[516.146538] Subtest basic-short: SKIP (0.000s)
[516.208642] [087/132] (504s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[516.297956] Starting subtest: fbc-psr2-cursor-mmap-gtt
[516.300226] Starting dynamic subtest: eDP-1
[516.304420] Dynamic subtest eDP-1: SKIP (0.000s)
[516.311519] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[516.372912] [088/132] (504s left) kms_psr (psr-cursor-render)
[516.485293] Starting subtest: psr-cursor-render
[516.487136] Starting dynamic subtest: eDP-1
[518.189864] Dynamic subtest eDP-1: SUCCESS (1.702s)
[518.192177] Subtest psr-cursor-render: SUCCESS (1.704s)
[519.070248] [089/132] (502s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[519.174040] Starting subtest: y-tiled-64bpp-rotate-0
[519.178376] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[519.277958] [090/132] (501s left) kms_flip (basic-flip-vs-wf_vblank)
[519.369544] Starting subtest: basic-flip-vs-wf_vblank
[519.371740] Starting dynamic subtest: A-eDP1
[521.300097] Dynamic subtest A-eDP1: SUCCESS (1.931s)
[521.311405] Starting dynamic subtest: B-eDP1
[523.231585] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[523.243023] Starting dynamic subtest: C-eDP1
[525.153137] Dynamic subtest C-eDP1: SUCCESS (1.919s)
[525.166627] Starting dynamic subtest: D-eDP1
[527.071303] Dynamic subtest D-eDP1: SUCCESS (1.915s)
[527.073738] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.706s)
[528.296924] [091/132] (492s left) kms_hdr (bpc-switch-dpms)
[528.379756] Starting subtest: bpc-switch-dpms
[529.474114] Starting dynamic subtest: pipe-A-eDP-1
[534.003773] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.531s)
[534.006445] Subtest bpc-switch-dpms: SUCCESS (5.625s)
[534.120805] [092/132] (487s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[534.213970] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[534.218096] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[534.320704] [093/132] (487s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[534.410656] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[534.412957] Starting dynamic subtest: pipe-A
[534.433426] Dynamic subtest pipe-A: SKIP (0.018s)
[534.444202] Starting dynamic subtest: pipe-B
[534.468447] Dynamic subtest pipe-B: SKIP (0.034s)
[534.479497] Starting dynamic subtest: pipe-C
[534.499903] Dynamic subtest pipe-C: SKIP (0.033s)
[534.510967] Starting dynamic subtest: pipe-D
[534.532943] Dynamic subtest pipe-D: SKIP (0.032s)
[534.537283] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.120s)
[534.642458] [094/132] (486s left) syncobj_timeline (32bits-limit)
[534.694130] Starting subtest: 32bits-limit
[534.696382] Subtest 32bits-limit: SUCCESS (0.001s)
[534.811343] [095/132] (486s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[534.910617] Starting subtest: fbc-2p-pri-indfb-multidraw
[534.915167] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[535.011600] [096/132] (486s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[535.106404] Starting subtest: 4-tiled-8bpp-rotate-0
[536.364842] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.258s)
[536.535218] [097/132] (485s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[536.620732] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[536.622710] Starting dynamic subtest: pipe-A-eDP-1
[536.642866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.656531] Starting dynamic subtest: pipe-B-eDP-1
[536.675513] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.685285] Starting dynamic subtest: pipe-C-eDP-1
[536.704285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.714006] Starting dynamic subtest: pipe-D-eDP-1
[536.734742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.738276] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[538.918481] [098/132] (482s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[539.013589] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[546.087310] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.076s)
[546.198702] [099/132] (475s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[546.335786] Starting subtest: short-flip-before-cursor-atomic-transitions
[547.321127] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.986s)
[548.190483] [100/132] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[548.286394] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[548.290377] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[548.384671] [101/132] (473s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[548.466065] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[548.468307] Starting dynamic subtest: pipe-A-eDP-1
[549.318660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.847s)
[549.329913] Starting dynamic subtest: pipe-B-eDP-1
[550.868965] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.546s)
[550.880618] Starting dynamic subtest: pipe-C-eDP-1
[552.439704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.570s)
[552.451316] Starting dynamic subtest: pipe-D-eDP-1
[553.990246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.548s)
[553.992149] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.516s)
[555.221405] [102/132] (466s left) kms_cursor_crc (cursor-offscreen-512x512)
[555.517317] Starting subtest: cursor-offscreen-512x512
[555.521757] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[555.683124] [103/132] (466s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[555.777179] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[555.781364] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[555.871807] [104/132] (466s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[555.973626] Starting subtest: yf-tiled-addfb-size-overflow
[555.977893] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[556.077111] [105/132] (465s left) sw_sync (sync_expired_merge)
[556.115790] Starting subtest: sync_expired_merge
[557.188908] Subtest sync_expired_merge: SUCCESS (1.074s)
[557.253550] [106/132] (464s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[557.632119] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[558.418226] [107/132] (463s left) i915_selftest (perf)
[560.218261] Starting subtest: perf
[560.220598] Starting dynamic subtest: engine_cs
[564.584486] Dynamic subtest engine_cs: SUCCESS (4.366s)
[564.595042] Starting dynamic subtest: request
[571.894806] Dynamic subtest request: SUCCESS (7.309s)
[571.905974] Starting dynamic subtest: migrate
[576.609561] Dynamic subtest migrate: SUCCESS (4.713s)
[576.625975] Starting dynamic subtest: region
[582.354326] Dynamic subtest region: SUCCESS (5.743s)
[582.356867] Subtest perf: SUCCESS (22.138s)
[582.388196] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[582.388924] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[582.392109] [108/132] (439s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[584.023854] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[584.026049] Starting dynamic subtest: pipe-A-eDP-1
[584.173300] Dynamic subtest pipe-A-eDP-1: SKIP (0.145s)
[584.182559] Starting dynamic subtest: pipe-B-eDP-1
[585.313567] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[585.318195] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.288s)
[586.521426] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[586.522957] [FACT kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)] new: kernel.kmod_is_loaded.i915: true
[586.526636] [109/132] (435s left) gem_create (create-size-update)
[586.595720] Starting subtest: create-size-update
[586.598017] Subtest create-size-update: SUCCESS (0.000s)
[586.825255] [110/132] (435s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[586.918932] Starting subtest: plane-upscale-20x20-with-modifiers
[586.921088] Starting dynamic subtest: pipe-A
[587.254881] Dynamic subtest pipe-A: SUCCESS (0.338s)
[587.264633] Starting dynamic subtest: pipe-B
[588.687013] Dynamic subtest pipe-B: SUCCESS (1.431s)
[588.696762] Starting dynamic subtest: pipe-C
[590.120589] Dynamic subtest pipe-C: SUCCESS (1.432s)
[590.132095] Starting dynamic subtest: pipe-D
[591.565618] Dynamic subtest pipe-D: SUCCESS (1.443s)
[591.568037] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.649s)
[592.734638] [111/132] (429s left) perf (invalid-oa-metric-set-id)
[592.870262] Starting subtest: invalid-oa-metric-set-id
[592.881349] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[592.924176] [112/132] (429s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[593.039015] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[597.456890] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.421s)
[598.660590] [113/132] (423s left) kms_psr (psr2-suspend)
[598.744016] Starting subtest: psr2-suspend
[598.746291] Starting dynamic subtest: eDP-1
[616.617913] Dynamic subtest eDP-1: SUCCESS (2.859s)
[616.620277] Subtest psr2-suspend: SUCCESS (2.860s)
[617.407680] [114/132] (404s left) gem_exec_balancer (noheartbeat)
[617.671942] Starting subtest: noheartbeat
[617.676680] Subtest noheartbeat: SKIP (0.000s)
[617.767703] [115/132] (404s left) gem_exec_reloc (basic-gtt-cpu)
[617.834188] Subtest basic-gtt-cpu: SKIP (0.000s)
[617.914217] [116/132] (404s left) syncobj_timeline (signal-point-0)
[617.965904] Starting subtest: signal-point-0
[617.967777] Subtest signal-point-0: SUCCESS (0.000s)
[618.062288] [117/132] (404s left) kms_lease (lease-invalid-plane)
[618.147329] Starting subtest: lease-invalid-plane
[618.149550] Starting dynamic subtest: pipe-A-eDP-1
[618.151714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[618.161128] Starting dynamic subtest: pipe-B-eDP-1
[618.163249] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[618.171815] Starting dynamic subtest: pipe-C-eDP-1
[618.173652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[618.182500] Starting dynamic subtest: pipe-D-eDP-1
[618.184603] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[618.186755] Subtest lease-invalid-plane: SUCCESS (0.004s)
[618.223604] [118/132] (404s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[618.277529] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[618.335311] [119/132] (404s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[618.423121] Starting subtest: drrs-dirtyfb-ioctl
[618.435476] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[618.512885] [120/132] (404s left) gem_exec_async (concurrent-writes)
[618.575386] Starting subtest: concurrent-writes
[618.577590] Starting dynamic subtest: rcs0
[618.587908] Dynamic subtest rcs0: SUCCESS (0.016s)
[618.601197] Starting dynamic subtest: bcs0
[618.603444] Dynamic subtest bcs0: SUCCESS (0.006s)
[618.612365] Starting dynamic subtest: vcs0
[618.614164] Dynamic subtest vcs0: SUCCESS (0.005s)
[618.623863] Starting dynamic subtest: vcs1
[618.625998] Dynamic subtest vcs1: SUCCESS (0.006s)
[618.635116] Starting dynamic subtest: vecs0
[618.637283] Dynamic subtest vecs0: SUCCESS (0.005s)
[618.645917] Starting dynamic subtest: ccs0
[618.647731] Dynamic subtest ccs0: SUCCESS (0.005s)
[618.649788] Subtest concurrent-writes: SUCCESS (0.046s)
[618.871980] [121/132] (403s left) syncobj_timeline (multi-wait-for-submit-signaled)
[618.924976] Starting subtest: multi-wait-for-submit-signaled
[618.926870] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[619.037197] [122/132] (403s left) syncobj_wait (single-wait-for-submit-submitted)
[619.087410] Starting subtest: single-wait-for-submit-submitted
[619.194725] Subtest single-wait-for-submit-submitted: SUCCESS (0.111s)
[619.270321] [123/132] (403s left) syncobj_wait (invalid-reset-one-illegal-handle)
[619.329514] Starting subtest: invalid-reset-one-illegal-handle
[619.331445] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[619.436849] [124/132] (403s left) i915_drm_fdinfo (virtual-busy-hang-all)
[619.477877] Starting subtest: virtual-busy-hang-all
[619.482257] Subtest virtual-busy-hang-all: SKIP (0.000s)
[619.550383] [125/132] (403s left) kms_vblank (wait-forked-busy)
[619.638708] Starting subtest: wait-forked-busy
[619.640838] Starting dynamic subtest: pipe-A-eDP-1
[621.491228] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.903s)
[621.505371] Starting dynamic subtest: pipe-D-eDP-1
[623.985370] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s)
[623.987232] Subtest wait-forked-busy: SUCCESS (4.450s)
[624.783870] [126/132] (397s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[624.873277] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[624.877474] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[624.966840] [127/132] (397s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[625.061880] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[625.066171] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[625.152732] [128/132] (397s left) gem_userptr_blits (access-control)
[625.225488] Starting subtest: access-control
[625.229925] Subtest access-control: SKIP (0.000s)
[625.337008] [129/132] (397s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[625.431016] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[625.434876] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[625.497045] [130/132] (397s left) gem_partial_pwrite_pread (writes-after-reads)
[625.555305] Subtest writes-after-reads: SKIP (0.000s)
[625.622123] [131/132] (397s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[625.721183] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[625.724623] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[625.826007] [132/132] (397s left) gen9_exec_parse (basic-rejected)
[625.880697] Subtest basic-rejected: SKIP (0.000s)
[625.945155] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_scaling_modes
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: gem_ccs
results: parsing output: 10/ for test: kms_content_protection
results: parsing output: 11/ for test: kms_pipe_crc_basic
results: parsing output: 12/ for test: dumb_buffer
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: gem_exec_suspend
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: core_debugfs
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_mmap_offset
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_basic
results: parsing output: 34/ for test: gem_lmem_swapping
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: i915_pm_rpm
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: kms_plane_multiple
results: parsing output: 39/ for test: gem_render_copy
results: parsing output: 40/ for test: kms_pm_dc
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_hdr
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: prime_mmap
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_softpin
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_color_pipeline
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: gem_ctx_create
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_dp_link_training
results: parsing output: 73/ for test: kms_chamelium_hpd
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_mmap_gtt
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_hdr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_plane_scaling
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: sw_sync
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: i915_selftest
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_create
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: kms_pipe_b_c_ivb
results: parsing output: 118/ for test: kms_dirtyfb
results: parsing output: 119/ for test: gem_exec_async
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_partial_pwrite_pread
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gen9_exec_parse
Done.