[57.420740] Initializing watchdogs
[57.420786]   /dev/watchdog0
[57.434728] [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]
[57.439029] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.441333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.444557] [001/133] (960s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[57.561860] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[57.566238] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[57.629444] [002/133] (960s left) syncobj_eventfd (timeline-wait)
[57.691224] Starting subtest: timeline-wait
[57.702371] Subtest timeline-wait: SUCCESS (0.011s)
[57.784908] [003/133] (960s left) kms_lease (empty-lease)
[57.878390] Starting subtest: empty-lease
[57.880722] Starting dynamic subtest: pipe-A-eDP-1
[57.882913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[57.891062] Starting dynamic subtest: pipe-B-eDP-1
[57.893095] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[57.899772] Starting dynamic subtest: pipe-C-eDP-1
[57.901902] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[57.909175] Starting dynamic subtest: pipe-D-eDP-1
[57.911260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[57.913339] Subtest empty-lease: SUCCESS (0.007s)
[58.002570] [004/133] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[58.107855] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[58.110273] Starting dynamic subtest: pipe-A-eDP-1
[58.131213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[58.139756] Starting dynamic subtest: pipe-B-eDP-1
[58.159562] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[58.166647] Starting dynamic subtest: pipe-C-eDP-1
[58.186355] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.193049] Starting dynamic subtest: pipe-D-eDP-1
[58.212792] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.215098] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[60.351202] [005/133] (957s left) gem_userptr_blits (stress-mm-invalidate-close)
[60.422616] Starting subtest: stress-mm-invalidate-close
[62.625843] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[62.701092] [006/133] (955s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[62.801656] Starting subtest: random-ccs-data-yf-tiled-ccs
[62.804220] Starting dynamic subtest: pipe-A-eDP-1
[62.830226] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.838469] Starting dynamic subtest: pipe-B-eDP-1
[62.861827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.868548] Starting dynamic subtest: pipe-C-eDP-1
[62.892578] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.899530] Starting dynamic subtest: pipe-D-eDP-1
[62.923327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.927741] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[65.019065] [007/133] (953s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[65.122852] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[65.127180] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s)
[65.226152] [008/133] (952s left) gem_exec_await (wide-contexts)
[65.425130] Starting subtest: wide-contexts
[89.189028] Subtest wide-contexts: SUCCESS (23.746s)
[89.374064] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[89.379666] [009/133] (928s left) gem_ctx_exec (basic)
[89.476672] Starting subtest: basic
[89.486885] Subtest basic: SUCCESS (0.014s)
[89.630783] [010/133] (928s left) syncobj_basic (bad-flags-fd-to-handle)
[89.684339] Starting subtest: bad-flags-fd-to-handle
[89.686668] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[89.804205] [011/133] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[89.906037] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[89.908279] Starting dynamic subtest: pipe-A-eDP-1
[89.930813] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[89.940065] Starting dynamic subtest: pipe-B-eDP-1
[89.961739] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[89.968967] Starting dynamic subtest: pipe-C-eDP-1
[89.990401] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[89.997697] Starting dynamic subtest: pipe-D-eDP-1
[90.019672] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[90.023751] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[92.088916] [012/133] (926s left) vgem_basic (setversion)
[92.135296] Starting subtest: setversion
[92.139409] Subtest setversion: SUCCESS (0.000s)
[92.191154] [013/133] (926s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[92.295291] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[92.299242] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[92.391421] [014/133] (926s left) gem_mmap_gtt (big-bo)
[92.459084] Subtest big-bo: SKIP (0.000s)
[92.525208] [015/133] (925s left) perf (gen12-group-concurrent-oa-buffer-read)
[92.690444] Starting subtest: gen12-group-concurrent-oa-buffer-read
[102.735609] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.044s)
[102.780190] [016/133] (915s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[102.903067] Starting subtest: pr-cursor-plane-update-sf
[102.907210] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[102.968853] [017/133] (915s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[103.086066] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[114.311910] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.224s)
[115.120772] [018/133] (903s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[115.185012] Starting subtest: multi-wait-all-for-submit-available-signaled
[115.187300] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[115.276330] [019/133] (903s left) kms_joiner (basic-ultra-joiner)
[115.374813] Starting subtest: basic-ultra-joiner
[115.378677] Subtest basic-ultra-joiner: SKIP (0.000s)
[115.450829] [020/133] (903s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[115.556748] Starting subtest: x-tiled-32bpp-rotate-90
[115.576962] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[115.688480] [021/133] (903s left) gem_mmap_offset (partial-mmap)
[115.741794] Starting subtest: partial-mmap
[115.743614] Starting dynamic subtest: smem0
[115.745935] Dynamic subtest smem0: SUCCESS (0.004s)
[115.748034] Subtest partial-mmap: SUCCESS (0.004s)
[115.865284] [022/133] (902s left) i915_pm_rpm (gem-mmap-type)
[118.090047] Starting subtest: gem-mmap-type
[118.092950] Starting dynamic subtest: wb-smem0
[121.873039] Dynamic subtest wb-smem0: SUCCESS (3.785s)
[121.882068] Starting dynamic subtest: wc-smem0
[124.723842] Dynamic subtest wc-smem0: SUCCESS (2.850s)
[124.731617] Starting dynamic subtest: uc-smem0
[127.907513] Dynamic subtest uc-smem0: SUCCESS (3.183s)
[127.909894] Subtest gem-mmap-type: SUCCESS (9.822s)
[127.992252] [023/133] (890s left) sysfs_timeslice_duration (timeout)
[128.062796] Starting subtest: timeout
[128.065119] Starting dynamic subtest: vecs0
[137.930265] Dynamic subtest vecs0: SUCCESS (9.864s)
[137.940837] Starting dynamic subtest: ccs0
[139.216741] Dynamic subtest ccs0: SUCCESS (1.285s)
[139.227248] Starting dynamic subtest: vcs0
[148.877781] Dynamic subtest vcs0: SUCCESS (9.657s)
[148.887584] Starting dynamic subtest: bcs0
[149.457790] Dynamic subtest bcs0: SUCCESS (0.580s)
[149.465475] Starting dynamic subtest: rcs0
[150.688210] Dynamic subtest rcs0: SUCCESS (1.228s)
[150.698031] Starting dynamic subtest: vcs1
[159.889185] Dynamic subtest vcs1: SUCCESS (9.196s)
[159.891838] Subtest timeout: SUCCESS (31.823s)
[159.962790] [024/133] (858s left) kms_cursor_crc (cursor-random-128x128)
[160.180263] Starting subtest: cursor-random-128x128
[160.185137] Starting dynamic subtest: pipe-A-eDP-1
[162.368801] Dynamic subtest pipe-A-eDP-1: FAIL (1.593s)
[162.379314] Starting dynamic subtest: pipe-D-eDP-1
[170.241326] Dynamic subtest pipe-D-eDP-1: SUCCESS (8.436s)
[170.243440] Subtest cursor-random-128x128: FAIL (10.060s)
[171.247813] [025/133] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[171.345617] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[171.349991] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[171.438114] [026/133] (847s left) gem_exec_endless (dispatch)
[171.494265] Starting subtest: dispatch
[171.496717] Starting dynamic subtest: rcs0
[171.503903] Dynamic subtest rcs0: SUCCESS (0.005s)
[171.515050] Starting dynamic subtest: bcs0
[171.519575] Dynamic subtest bcs0: SUCCESS (0.004s)
[171.527935] Starting dynamic subtest: vcs0
[171.532331] Dynamic subtest vcs0: SUCCESS (0.006s)
[171.541101] Starting dynamic subtest: vcs1
[171.545503] Dynamic subtest vcs1: SUCCESS (0.009s)
[171.553055] Starting dynamic subtest: vecs0
[171.557243] Dynamic subtest vecs0: SUCCESS (0.008s)
[171.564849] Starting dynamic subtest: ccs0
[171.569294] Dynamic subtest ccs0: SUCCESS (0.007s)
[171.571521] Subtest dispatch: SUCCESS (0.045s)
[172.934178] [027/133] (846s left) gem_ctx_param (set-priority-not-supported)
[172.986848] Starting subtest: set-priority-not-supported
[172.991461] Subtest set-priority-not-supported: SKIP (0.000s)
[173.050924] [028/133] (845s left) gem_flink_race (flink_close)
[173.099248] Starting subtest: flink_close
[178.199841] Subtest flink_close: SUCCESS (5.098s)
[178.277246] [029/133] (840s left) kms_feature_discovery (display-4x)
[178.400954] Starting subtest: display-4x
[178.405466] Subtest display-4x: SKIP (0.000s)
[178.505624] [030/133] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[178.639054] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[185.390070] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.753s)
[185.532079] [031/133] (833s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[185.585696] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[185.589899] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[185.769729] [032/133] (833s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[185.870091] Starting subtest: basic-modeset-with-all-modifiers-formats
[186.258628] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[187.048702] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.790s)
[187.056596] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[187.070361] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[187.078340] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[187.092706] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[187.100921] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[187.259433] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[187.268107] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[187.281584] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[187.289528] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[187.303899] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[187.311719] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[187.326063] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[187.333966] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[187.348295] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[187.356114] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[187.370446] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[187.378302] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[187.392703] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[187.400269] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[187.414659] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[187.422605] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[187.437199] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[187.444818] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[187.592851] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[187.600868] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[187.615066] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[187.622891] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[187.637444] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[187.645281] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[187.659775] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.020s)
[187.667491] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[187.681716] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[187.689370] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[187.703960] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[187.711543] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[187.726179] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[187.733973] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[187.748326] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[187.755982] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[187.770206] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[187.777595] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[187.925978] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[187.933834] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[187.948358] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[187.956608] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[187.970673] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[187.978440] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[187.992873] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[188.000063] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[188.014995] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[188.022345] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[188.037361] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[188.044606] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[188.059714] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[188.066946] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[188.081504] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[188.089440] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[188.104295] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[188.501706] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.633s)
[189.326699] [033/133] (829s left) gem_eio (wait-wedge-1us)
[189.565682] Starting subtest: wait-wedge-1us
[191.000212] Subtest wait-wedge-1us: SUCCESS (1.432s)
[191.153891] [034/133] (828s left) gem_spin_batch (resubmit-new-all)
[191.238582] Starting subtest: resubmit-new-all
[191.241058] Starting dynamic subtest: rcs0
[191.253458] Dynamic subtest rcs0: SUCCESS (0.015s)
[191.262871] Starting dynamic subtest: bcs0
[191.265048] Dynamic subtest bcs0: SUCCESS (0.009s)
[191.273076] Starting dynamic subtest: vcs0
[191.275931] Dynamic subtest vcs0: SUCCESS (0.010s)
[191.284421] Starting dynamic subtest: vcs1
[191.290907] Dynamic subtest vcs1: SUCCESS (0.013s)
[191.303232] Starting dynamic subtest: vecs0
[191.305314] Dynamic subtest vecs0: SUCCESS (0.008s)
[191.313732] Starting dynamic subtest: ccs0
[191.315609] Dynamic subtest ccs0: SUCCESS (0.009s)
[191.317482] Subtest resubmit-new-all: SUCCESS (0.068s)
[192.891222] [035/133] (826s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[192.999403] Starting subtest: short-flip-after-cursor-atomic-transitions
[193.957550] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.958s)
[194.767173] [036/133] (824s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[194.869264] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[194.873193] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[194.979827] [037/133] (824s left) kms_psr (psr2-cursor-plane-onoff)
[195.075799] Starting subtest: psr2-cursor-plane-onoff
[195.078069] Starting dynamic subtest: eDP-1
[196.734452] Dynamic subtest eDP-1: SUCCESS (1.658s)
[196.736467] Subtest psr2-cursor-plane-onoff: SUCCESS (1.659s)
[197.535554] [038/133] (821s left) kms_getfb (getfb-handle-closed)
[197.633323] Starting subtest: getfb-handle-closed
[197.635608] Subtest getfb-handle-closed: SUCCESS (0.000s)
[197.739937] [039/133] (821s left) gem_exec_fence (invalid-timeline-fence-array)
[198.302689] Starting subtest: invalid-timeline-fence-array
[198.308773] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[199.976132] [040/133] (819s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[200.065089] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[200.067339] Starting dynamic subtest: pipe-A-default-mode
[201.196627] Dynamic subtest pipe-A-default-mode: SKIP (1.130s)
[201.201015] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.131s)
[201.342581] [041/133] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[201.452472] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[201.457012] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[201.557924] [042/133] (818s left) kms_atomic (crtc-invalid-params-fence)
[201.673148] Starting subtest: crtc-invalid-params-fence
[201.675527] Starting dynamic subtest: pipe-A-eDP-1
[202.108620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.432s)
[202.110623] Subtest crtc-invalid-params-fence: SUCCESS (0.435s)
[202.901300] [043/133] (816s left) kms_properties (crtc-properties-atomic)
[203.008538] Starting subtest: crtc-properties-atomic
[203.010836] Starting dynamic subtest: pipe-A-eDP-1
[203.467299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[203.477204] Starting dynamic subtest: pipe-B-eDP-1
[204.655824] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.187s)
[204.664945] Starting dynamic subtest: pipe-C-eDP-1
[205.793644] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[205.802944] Starting dynamic subtest: pipe-D-eDP-1
[206.915411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[206.917929] Subtest crtc-properties-atomic: SUCCESS (3.908s)
[207.733284] [044/133] (811s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[207.858540] Starting subtest: cursor-vs-flip-atomic
[237.485066] Subtest cursor-vs-flip-atomic: SUCCESS (29.624s)
[238.357106] [045/133] (781s left) syncobj_wait (multi-wait-all-signaled)
[238.420056] Starting subtest: multi-wait-all-signaled
[238.422250] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[238.514212] [046/133] (781s left) gem_create (create-ext-placement-each)
[238.691455] Starting subtest: create-ext-placement-each
[238.693492] Subtest create-ext-placement-each: SUCCESS (0.000s)
[238.812353] [047/133] (781s left) kms_chamelium_edid (hdmi-edid-read)
[239.202362] Subtest hdmi-edid-read: SKIP (0.000s)
[239.970911] [048/133] (779s left) kms_cursor_edge_walk (64x64-top-bottom)
[240.059376] Starting subtest: 64x64-top-bottom
[240.061764] Starting dynamic subtest: pipe-A-eDP-1
[243.567758] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[243.576312] Starting dynamic subtest: pipe-D-eDP-1
[246.692762] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[246.694863] Subtest 64x64-top-bottom: SUCCESS (6.636s)
[247.515113] [049/133] (772s left) kms_cursor_crc (cursor-offscreen-256x85)
[247.775894] Starting subtest: cursor-offscreen-256x85
[247.829077] Subtest cursor-offscreen-256x85: SKIP (0.047s)
[248.014118] [050/133] (771s left) kms_color (ctm-negative)
[248.112312] Starting subtest: ctm-negative
[248.114596] Starting dynamic subtest: pipe-A-eDP-1
[248.825777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[248.835663] Starting dynamic subtest: pipe-B-eDP-1
[250.230812] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[250.239281] Starting dynamic subtest: pipe-C-eDP-1
[251.604208] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[251.612531] Starting dynamic subtest: pipe-D-eDP-1
[252.945673] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[252.948104] Subtest ctm-negative: SUCCESS (4.836s)
[253.760445] [051/133] (766s left) kms_chamelium_hpd (common-hpd-after-suspend)
[254.159654] Subtest common-hpd-after-suspend: SKIP (0.000s)
[254.971654] [052/133] (765s left) gem_exec_whisper (basic-contexts-priority-all)
[255.033093] Starting subtest: basic-contexts-priority-all
[278.039207] Subtest basic-contexts-priority-all: SUCCESS (23.001s)
[278.219225] [053/133] (741s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[278.335070] Starting subtest: flip-vs-cursor-busy-crc-legacy
[279.126887] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.792s)
[279.958263] [054/133] (740s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[280.050458] Starting subtest: 2x-flip-vs-modeset-vs-hang
[280.061220] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[280.140504] [055/133] (740s left) kms_pipe_crc_basic (suspend-read-crc)
[280.234429] Starting subtest: suspend-read-crc
[280.236563] Starting dynamic subtest: pipe-A-eDP-1
[297.898474] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.693s)
[297.909966] Starting dynamic subtest: pipe-B-eDP-1
[315.906798] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.111s)
[315.917398] Starting dynamic subtest: pipe-C-eDP-1
[333.867757] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.050s)
[333.877971] Starting dynamic subtest: pipe-D-eDP-1
[351.930356] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.147s)
[351.932791] Subtest suspend-read-crc: SUCCESS (12.008s)
[352.821329] [056/133] (667s left) sriov_basic (enable-vfs-bind-unbind-each)
[352.879354] Starting subtest: enable-vfs-bind-unbind-each
[352.881749] Starting dynamic subtest: numvfs-1
[352.957384] Dynamic subtest numvfs-1: FAIL (0.005s)
[352.969348] Starting dynamic subtest: numvfs-2
[353.042783] Dynamic subtest numvfs-2: FAIL (0.004s)
[353.054430] Starting dynamic subtest: numvfs-3
[353.127943] Dynamic subtest numvfs-3: FAIL (0.003s)
[353.138961] Starting dynamic subtest: numvfs-4
[353.213859] Dynamic subtest numvfs-4: FAIL (0.003s)
[353.225099] Starting dynamic subtest: numvfs-5
[353.300281] Dynamic subtest numvfs-5: FAIL (0.004s)
[353.312364] Starting dynamic subtest: numvfs-6
[353.388290] Dynamic subtest numvfs-6: FAIL (0.003s)
[353.400437] Starting dynamic subtest: numvfs-7
[353.472460] Dynamic subtest numvfs-7: FAIL (0.004s)
[353.483909] Starting dynamic subtest: numvfs-random
[353.555834] Dynamic subtest numvfs-random: FAIL (0.004s)
[353.557855] Subtest enable-vfs-bind-unbind-each: FAIL (0.034s)
[353.596621] [057/133] (666s left) kms_addfb_basic (unused-modifier)
[353.651188] Starting subtest: unused-modifier
[353.653396] Subtest unused-modifier: SUCCESS (0.000s)
[353.785257] [058/133] (666s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[353.836514] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[353.896153] [059/133] (666s left) gem_exec_async (forked-writes)
[353.945083] Starting subtest: forked-writes
[353.946882] Starting dynamic subtest: rcs0
[353.973102] Dynamic subtest rcs0: SUCCESS (0.028s)
[353.983680] Starting dynamic subtest: bcs0
[353.996794] Dynamic subtest bcs0: SUCCESS (0.023s)
[354.007719] Starting dynamic subtest: vcs0
[354.019511] Dynamic subtest vcs0: SUCCESS (0.022s)
[354.030559] Starting dynamic subtest: vcs1
[354.041446] Dynamic subtest vcs1: SUCCESS (0.021s)
[354.052151] Starting dynamic subtest: vecs0
[354.064764] Dynamic subtest vecs0: SUCCESS (0.023s)
[354.075229] Starting dynamic subtest: ccs0
[354.087405] Dynamic subtest ccs0: SUCCESS (0.022s)
[354.089182] Subtest forked-writes: SUCCESS (0.143s)
[354.302901] [060/133] (666s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[354.389184] Starting subtest: yf-tiled-16bpp-rotate-270
[354.393341] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[354.494190] [061/133] (665s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[354.543407] Starting subtest: multi-wait-all-for-submit-submitted
[354.644993] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[354.723237] [062/133] (665s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[354.817787] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[354.822277] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[354.899057] [063/133] (665s left) kms_addfb_basic (bad-pitch-0)
[354.964026] Starting subtest: bad-pitch-0
[354.966242] Subtest bad-pitch-0: SUCCESS (0.000s)
[355.105140] [064/133] (665s left) kms_flip (flip-vs-absolute-wf_vblank)
[355.199189] Starting subtest: flip-vs-absolute-wf_vblank
[355.201132] Starting dynamic subtest: A-eDP1
[364.160993] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[364.172805] Starting dynamic subtest: B-eDP1
[373.097014] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[373.110641] Starting dynamic subtest: C-eDP1
[382.031479] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[382.043362] Starting dynamic subtest: D-eDP1
[391.008163] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[391.010102] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.744s)
[392.176218] [065/133] (628s left) gen9_exec_parse (bb-oversize)
[392.230121] Subtest bb-oversize: SKIP (0.000s)
[392.298900] [066/133] (628s left) sw_sync (sync_busy_fork)
[392.341322] Starting subtest: sync_busy_fork
[393.348036] Subtest sync_busy_fork: SUCCESS (1.010s)
[393.412346] [067/133] (627s left) gem_mmap_wc (write-gtt-read-wc)
[393.469142] Subtest write-gtt-read-wc: SKIP (0.000s)
[393.531554] [068/133] (627s left) kms_psr (fbc-psr2-dpms)
[393.623267] Starting subtest: fbc-psr2-dpms
[393.625510] Starting dynamic subtest: eDP-1
[393.629445] Dynamic subtest eDP-1: SKIP (0.000s)
[393.633350] Subtest fbc-psr2-dpms: SKIP (0.001s)
[393.711202] [069/133] (627s left) gem_ctx_shared (q-smoketest-all)
[393.786435] Starting subtest: Q-smoketest-all
[426.179291] Subtest Q-smoketest-all: SUCCESS (32.332s)
[427.617269] [070/133] (593s left) i915_drm_fdinfo (virtual-busy-idle-all)
[427.674591] Starting subtest: virtual-busy-idle-all
[427.679084] Subtest virtual-busy-idle-all: SKIP (0.000s)
[427.762865] [071/133] (593s left) kms_psr (psr-suspend)
[427.865415] Starting subtest: psr-suspend
[427.867524] Starting dynamic subtest: eDP-1
[445.433871] Dynamic subtest eDP-1: SUCCESS (2.932s)
[445.436204] Subtest psr-suspend: SUCCESS (2.933s)
[446.298346] [072/133] (574s left) gem_exec_schedule (preempt-queue-chain)
[446.382523] Subtest preempt-queue-chain: SKIP (0.000s)
[446.668789] [073/133] (574s left) syncobj_wait (multi-wait-for-submit-signaled)
[446.718377] Starting subtest: multi-wait-for-submit-signaled
[446.720753] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[446.813873] [074/133] (574s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[446.922167] Starting subtest: 2x-long-flip-vs-cursor-legacy
[446.926472] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[447.068359] [075/133] (573s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[447.159879] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[447.164001] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[447.268642] [076/133] (573s left) kms_pm_backlight (brightness-with-dpms)
[447.362263] Starting subtest: brightness-with-dpms
[447.413595] Starting dynamic subtest: eDP-1
[450.028586] Dynamic subtest eDP-1: SUCCESS (2.613s)
[450.031021] Subtest brightness-with-dpms: SUCCESS (2.664s)
[450.907924] [077/133] (570s left) gem_bad_reloc (negative-reloc-lut)
[450.962018] Subtest negative-reloc-lut: SKIP (0.000s)
[451.039412] [078/133] (570s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[451.145910] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[455.497998] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.353s)
[456.707473] [079/133] (564s left) kms_psr (pr-primary-mmap-cpu)
[456.806213] Starting subtest: pr-primary-mmap-cpu
[456.810711] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[456.904198] [080/133] (564s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[456.955920] Starting subtest: multi-wait-available-unsubmitted-signaled
[456.958310] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[457.054205] [081/133] (564s left) core_getstats (basic)
[457.105225] Starting subtest: basic
[457.107518] Subtest basic: SUCCESS (0.000s)
[457.191551] [082/133] (564s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[457.292093] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[464.640001] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.348s)
[464.779290] [083/133] (556s left) kms_psr2_su (page_flip-xrgb8888)
[464.838993] Subtest page_flip-XRGB8888: SKIP (0.000s)
[464.905210] [084/133] (556s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[465.002924] Starting subtest: 4-tiled-8bpp-rotate-180
[466.184766] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.183s)
[466.315162] [085/133] (555s left) kms_dirtyfb (default-dirtyfb-ioctl)
[466.408519] Starting subtest: default-dirtyfb-ioctl
[466.410425] Starting dynamic subtest: A-eDP-1
[468.030668] Dynamic subtest A-eDP-1: SUCCESS (1.622s)
[468.033212] Subtest default-dirtyfb-ioctl: SUCCESS (1.623s)
[468.866442] [086/133] (552s left) gem_userptr_blits (huge-split)
[468.949292] Starting subtest: huge-split
[468.953974] Subtest huge-split: SUCCESS (0.008s)
[469.068791] [087/133] (552s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[469.161665] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[469.165793] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[469.258855] [088/133] (552s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[469.352491] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[469.354660] Starting dynamic subtest: pipe-A
[470.400745] Dynamic subtest pipe-A: SUCCESS (1.050s)
[470.410445] Starting dynamic subtest: pipe-B
[472.505011] Dynamic subtest pipe-B: SUCCESS (2.102s)
[472.515424] Starting dynamic subtest: pipe-C
[473.686598] Dynamic subtest pipe-C: SUCCESS (1.179s)
[473.697422] Starting dynamic subtest: pipe-D
[474.836363] Dynamic subtest pipe-D: SUCCESS (1.148s)
[474.838698] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.485s)
[476.050300] [089/133] (545s left) core_getclient (basic)
[476.098228] Starting subtest: basic
[476.100578] Subtest basic: SUCCESS (0.000s)
[476.205160] [090/133] (545s left) kms_big_fb (linear-64bpp-rotate-180)
[476.298192] Starting subtest: linear-64bpp-rotate-180
[477.787554] Subtest linear-64bpp-rotate-180: SUCCESS (1.489s)
[477.954162] [091/133] (543s left) kms_content_protection (content-type-change)
[478.096381] Starting subtest: content-type-change
[478.101174] Subtest content-type-change: SKIP (0.000s)
[478.215176] [092/133] (543s left) gem_exec_whisper (basic-queues-priority)
[478.279510] Starting subtest: basic-queues-priority
[501.486095] Subtest basic-queues-priority: SUCCESS (23.153s)
[501.617920] [093/133] (520s left) kms_pm_rpm (system-suspend-modeset)
[503.379287] Starting subtest: system-suspend-modeset
[523.236606] Subtest system-suspend-modeset: SUCCESS (4.309s)
[523.630107] [094/133] (498s left) gem_exec_schedule (semaphore-noskip)
[523.709904] Starting subtest: semaphore-noskip
[524.119082] Subtest semaphore-noskip: SUCCESS (0.415s)
[524.466203] [095/133] (497s left) kms_vblank (wait-forked-busy)
[524.573655] Starting subtest: wait-forked-busy
[524.575871] Starting dynamic subtest: pipe-A-eDP-1
[526.472134] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.894s)
[526.487446] Starting dynamic subtest: pipe-D-eDP-1
[529.079333] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s)
[529.081754] Subtest wait-forked-busy: SUCCESS (4.501s)
[529.884038] [096/133] (492s left) gem_ppgtt (shrink-vs-evict-any)
[529.949623] Starting subtest: shrink-vs-evict-any
[535.779778] Subtest shrink-vs-evict-any: SUCCESS (5.772s)
[535.822145] [097/133] (486s left) syncobj_wait (invalid-reset-bad-pad)
[535.880050] Starting subtest: invalid-reset-bad-pad
[535.882436] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[535.993519] [098/133] (486s left) i915_query (query-regions-garbage-items)
[536.047713] Starting subtest: query-regions-garbage-items
[536.050030] Subtest query-regions-garbage-items: SUCCESS (0.001s)
[536.161236] [099/133] (485s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[536.253876] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[536.256089] Starting dynamic subtest: pipe-A-eDP-1
[536.278737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.292208] Starting dynamic subtest: pipe-B-eDP-1
[536.313135] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.322475] Starting dynamic subtest: pipe-C-eDP-1
[536.344456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.356221] Starting dynamic subtest: pipe-D-eDP-1
[536.379743] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.384268] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[538.556092] [100/133] (483s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[538.678988] Starting subtest: cursorB-vs-flipB-atomic
[538.683543] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[538.821455] [101/133] (483s left) prime_vgem (fence-flip-hang)
[538.896508] Subtest fence-flip-hang: SKIP (0.000s)
[539.012642] [102/133] (483s left) syncobj_wait (reset-signaled)
[539.060099] Starting subtest: reset-signaled
[539.062391] Subtest reset-signaled: SUCCESS (0.000s)
[539.142325] [103/133] (483s left) kms_psr (fbc-psr-primary-mmap-cpu)
[539.233983] Starting subtest: fbc-psr-primary-mmap-cpu
[539.236191] Starting dynamic subtest: eDP-1
[539.240325] Dynamic subtest eDP-1: SKIP (0.000s)
[539.244486] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[539.318680] [104/133] (482s left) api_intel_allocator (execbuf-with-allocator)
[539.378144] Starting subtest: execbuf-with-allocator
[539.382828] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[539.509267] [105/133] (482s left) gem_exec_suspend (basic-s4-devices)
[539.567459] Starting subtest: basic-S4-devices
[539.569503] Starting dynamic subtest: smem
[550.746250] Dynamic subtest smem: SUCCESS (11.169s)
[550.750470] Subtest basic-S4-devices: SUCCESS (11.171s)
[556.963076] [106/133] (471s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[557.063643] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[557.065872] Starting dynamic subtest: pipe-A-eDP-1
[557.085520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[557.099997] Starting dynamic subtest: pipe-B-eDP-1
[557.119382] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[557.129612] Starting dynamic subtest: pipe-C-eDP-1
[557.149113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[557.159366] Starting dynamic subtest: pipe-D-eDP-1
[557.178782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[557.180979] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[559.290500] [107/133] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[559.397078] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[562.981623] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.586s)
[564.193916] [108/133] (464s left) kms_plane_multiple (2x-tiling-y)
[564.288925] Starting subtest: 2x-tiling-y
[564.293186] Subtest 2x-tiling-y: SKIP (0.000s)
[564.361762] [109/133] (464s left) gem_exec_fence (syncobj-unused-fence)
[564.808350] Starting subtest: syncobj-unused-fence
[564.814493] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[565.843467] [110/133] (462s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[565.947355] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[565.951485] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[566.040446] [111/133] (462s left) gem_ctx_persistence (engines-hostile-preempt)
[566.104180] Starting subtest: engines-hostile-preempt
[566.106594] Starting dynamic subtest: rcs0
[566.178148] Dynamic subtest rcs0: SUCCESS (0.073s)
[566.192249] Starting dynamic subtest: bcs0
[566.219287] Dynamic subtest bcs0: SUCCESS (0.040s)
[566.230716] Starting dynamic subtest: vcs0
[567.762160] Dynamic subtest vcs0: SUCCESS (1.539s)
[567.778530] Starting dynamic subtest: vcs1
[569.746087] Dynamic subtest vcs1: SUCCESS (1.980s)
[569.760387] Starting dynamic subtest: vecs0
[571.730031] Dynamic subtest vecs0: SUCCESS (1.981s)
[571.743752] Starting dynamic subtest: ccs0
[571.786642] Dynamic subtest ccs0: SUCCESS (0.055s)
[571.789192] Subtest engines-hostile-preempt: SUCCESS (5.681s)
[571.882531] [112/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[571.989575] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[571.993820] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[572.098955] [113/133] (456s left) kms_flip_event_leak (basic)
[572.211066] Starting subtest: basic
[572.213311] Starting dynamic subtest: pipe-A-eDP-1
[572.629677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[572.643407] Starting dynamic subtest: pipe-B-eDP-1
[573.721608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[573.732517] Starting dynamic subtest: pipe-C-eDP-1
[574.823461] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s)
[574.834745] Starting dynamic subtest: pipe-D-eDP-1
[575.956251] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[575.958686] Subtest basic: SUCCESS (3.746s)
[576.828016] [114/133] (451s left) kms_busy (extended-modeset-hang-oldfb)
[576.927886] Starting subtest: extended-modeset-hang-oldfb
[576.930194] Starting dynamic subtest: pipe-A
[588.503844] Dynamic subtest pipe-A: SUCCESS (11.571s)
[588.519290] Starting dynamic subtest: pipe-D
[600.767236] Dynamic subtest pipe-D: SUCCESS (12.260s)
[600.769606] Subtest extended-modeset-hang-oldfb: SUCCESS (23.835s)
[601.564641] [115/133] (427s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[601.625080] Starting subtest: etime-multi-wait-available-unsubmitted
[601.733320] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[601.823992] [116/133] (426s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[601.915578] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[601.919716] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[602.010173] [117/133] (426s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[602.118446] Starting subtest: fbc-2p-pri-indfb-multidraw
[602.122416] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[602.214228] [118/133] (426s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[602.310091] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[605.979373] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.672s)
[607.186466] [119/133] (421s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[607.251154] Starting subtest: x-tiled-to-vebox-y-tiled
[607.255862] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[607.434455] [120/133] (421s left) gem_madvise (dontneed-before-mmap)
[607.478576] Starting subtest: dontneed-before-mmap
[607.495854] Subtest dontneed-before-mmap: SUCCESS (0.017s)
[607.588844] [121/133] (421s left) perf_pmu (rc6-all-gts)
[607.628323] Starting subtest: rc6-all-gts
[614.062224] Subtest rc6-all-gts: SUCCESS (6.381s)
[614.922207] [122/133] (414s left) gem_ctx_persistence (legacy-engines-hang)
[614.980573] Starting subtest: legacy-engines-hang
[614.982876] Starting dynamic subtest: render
[615.134204] Dynamic subtest render: SUCCESS (0.153s)
[615.152518] Starting dynamic subtest: bsd1
[615.236950] Dynamic subtest bsd1: SUCCESS (0.100s)
[615.251926] Starting dynamic subtest: bsd2
[615.343170] Dynamic subtest bsd2: SUCCESS (0.103s)
[615.357891] Starting dynamic subtest: blt
[615.447857] Dynamic subtest blt: SUCCESS (0.102s)
[615.463287] Starting dynamic subtest: vebox
[615.537102] Dynamic subtest vebox: SUCCESS (0.086s)
[615.539223] Subtest legacy-engines-hang: SUCCESS (0.558s)
[615.618130] [123/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[615.712888] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[615.716318] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.815423] [124/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[615.904088] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[615.907478] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.012756] [125/133] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[616.104458] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[616.108632] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[616.199785] [126/133] (413s left) gem_exec_flush (basic-wb-rw-before-default)
[616.264864] Starting subtest: basic-wb-rw-before-default
[621.723229] Subtest basic-wb-rw-before-default: SUCCESS (5.457s)
[621.922530] [127/133] (407s left) syncobj_timeline (single-wait-available-submitted)
[621.980475] Starting subtest: single-wait-available-submitted
[621.982698] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[622.087561] [128/133] (407s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[622.183112] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[622.187147] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[622.282634] [129/133] (407s left) kms_tiled_display (basic-test-pattern)
[622.396004] Subtest basic-test-pattern: SKIP (0.000s)
[622.442278] [130/133] (406s left) i915_drm_fdinfo (most-busy-idle-check-all)
[622.483608] Starting subtest: most-busy-idle-check-all
[622.486082] Starting dynamic subtest: rcs0
[622.494250] Dynamic subtest rcs0: SKIP (0.005s)
[622.506463] Starting dynamic subtest: bcs0
[622.511291] Dynamic subtest bcs0: SKIP (0.000s)
[622.521773] Starting dynamic subtest: vcs0
[622.526090] Dynamic subtest vcs0: SKIP (0.000s)
[622.536506] Starting dynamic subtest: vcs1
[622.540720] Dynamic subtest vcs1: SKIP (0.000s)
[622.551125] Starting dynamic subtest: vecs0
[622.555405] Dynamic subtest vecs0: SKIP (0.000s)
[622.566384] Starting dynamic subtest: ccs0
[622.570744] Dynamic subtest ccs0: SKIP (0.000s)
[622.575417] Subtest most-busy-idle-check-all: SKIP (0.010s)
[622.616681] [131/133] (406s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[622.749018] Starting subtest: psr-rgb101010-draw-render
[630.074002] Subtest psr-rgb101010-draw-render: SUCCESS (7.326s)
[630.199092] [132/133] (399s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[630.298474] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[637.538471] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.241s)
[637.673656] [133/133] (391s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[637.790119] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[637.792443] Starting dynamic subtest: pipe-A
[638.150131] Dynamic subtest pipe-A: SUCCESS (0.362s)
[638.161394] Starting dynamic subtest: pipe-B
[639.531855] Dynamic subtest pipe-B: SUCCESS (1.381s)
[639.544659] Starting dynamic subtest: pipe-C
[640.958348] Dynamic subtest pipe-C: SUCCESS (1.425s)
[640.969445] Starting dynamic subtest: pipe-D
[642.418508] Dynamic subtest pipe-D: SUCCESS (1.459s)
[642.420998] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.630s)
[643.570235] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: syncobj_eventfd
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_await
results: parsing output: 8/ for test: gem_ctx_exec
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_joiner
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: i915_pm_rpm
results: parsing output: 22/ for test: sysfs_timeslice_duration
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_endless
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: gem_flink_race
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_async_flips
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: gem_spin_batch
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: kms_properties
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: gem_create
results: parsing output: 46/ for test: kms_chamelium_edid
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_color
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_pipe_crc_basic
results: parsing output: 55/ for test: sriov_basic
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_async
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: gem_mmap_wc
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_ctx_shared
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_pm_backlight
results: parsing output: 76/ for test: gem_bad_reloc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: core_getstats
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_su
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_dirtyfb
results: parsing output: 85/ for test: gem_userptr_blits
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: core_getclient
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: gem_ppgtt
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: i915_query
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: prime_vgem
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: gem_exec_suspend
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane_multiple
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ctx_persistence
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip_event_leak
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_madvise
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_flush
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_tiled_display
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane_scaling
Done.