[56.171718] Initializing watchdogs
[56.171863]   /dev/watchdog0
[56.190133] [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.194632] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.197247] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.200810] [001/133] (960s left) kms_rotation_crc (bad-pixel-format)
[56.321290] Starting subtest: bad-pixel-format
[56.325911] Subtest bad-pixel-format: SKIP (0.001s)
[56.417534] [002/133] (960s left) vgem_basic (debugfs)
[56.493495] Starting subtest: debugfs
[56.495320] Subtest debugfs: SUCCESS (0.000s)
[56.570851] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[56.573809] [003/133] (960s left) gem_pxp (create-valid-protected-context)
[56.707540] Starting subtest: create-valid-protected-context
[56.710051] Subtest create-valid-protected-context: SUCCESS (0.004s)
[56.850969] [004/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[56.971220] Starting subtest: psr-1p-rte
[62.731970] Subtest psr-1p-rte: SUCCESS (5.750s)
[62.909058] [005/133] (953s left) syncobj_basic (bad-flags-handle-to-fd)
[62.978155] Starting subtest: bad-flags-handle-to-fd
[62.980115] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[63.113243] [006/133] (953s left) gen9_exec_parse (bb-secure)
[63.171226] Subtest bb-secure: SKIP (0.000s)
[63.246911] [007/133] (953s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[63.343100] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[63.345491] Starting dynamic subtest: A-eDP1
[72.280947] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[72.290090] Starting dynamic subtest: B-eDP1
[81.206519] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[81.216285] Starting dynamic subtest: C-eDP1
[90.133023] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[90.143024] Starting dynamic subtest: D-eDP1
[98.974370] Dynamic subtest D-eDP1: SUCCESS (8.840s)
[98.979226] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.617s)
[100.213655] [008/133] (916s left) kms_psr (psr-primary-render)
[100.312977] Starting subtest: psr-primary-render
[100.315422] Starting dynamic subtest: eDP-1
[102.089401] Dynamic subtest eDP-1: SUCCESS (1.777s)
[102.091758] Subtest psr-primary-render: SUCCESS (1.777s)
[102.974364] [009/133] (914s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[103.077854] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[103.082277] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[104.210332] [010/133] (912s left) kms_content_protection (lic-type-0)
[104.348378] Starting subtest: lic-type-0
[104.353104] Subtest lic-type-0: SKIP (0.000s)
[104.527679] [011/133] (912s left) kms_psr (psr2-cursor-plane-onoff)
[104.640925] Starting subtest: psr2-cursor-plane-onoff
[104.651869] Starting dynamic subtest: eDP-1
[106.364685] Dynamic subtest eDP-1: SUCCESS (1.722s)
[106.367083] Subtest psr2-cursor-plane-onoff: SUCCESS (1.723s)
[107.179941] [012/133] (909s left) syncobj_wait (reset-multiple-signaled)
[107.243053] Starting subtest: reset-multiple-signaled
[107.245433] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[107.357672] [013/133] (909s left) gem_mmap_gtt (hang-busy)
[107.416662] Subtest hang-busy: SKIP (0.000s)
[107.472237] [014/133] (909s left) syncobj_timeline (invalid-transfer-non-existent-point)
[107.524060] Starting subtest: invalid-transfer-non-existent-point
[107.526426] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[107.639324] [015/133] (909s left) kms_pm_rpm (modeset-pc8-residency-stress)
[109.160898] Starting subtest: modeset-pc8-residency-stress
[109.166054] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[109.911950] [016/133] (907s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[110.039688] Starting subtest: short-busy-flip-before-cursor-toggle
[110.044329] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[110.210349] [017/133] (907s left) gem_spin_batch (resubmit)
[110.290860] Starting subtest: resubmit
[110.293330] Starting dynamic subtest: rcs0
[110.298189] Dynamic subtest rcs0: SUCCESS (0.006s)
[110.308012] Starting dynamic subtest: bcs0
[110.310239] Dynamic subtest bcs0: SUCCESS (0.004s)
[110.318024] Starting dynamic subtest: vcs0
[110.319923] Dynamic subtest vcs0: SUCCESS (0.003s)
[110.326721] Starting dynamic subtest: vcs1
[110.328602] Dynamic subtest vcs1: SUCCESS (0.002s)
[110.335572] Starting dynamic subtest: vecs0
[110.337459] Dynamic subtest vecs0: SUCCESS (0.002s)
[110.344353] Starting dynamic subtest: ccs0
[110.346273] Dynamic subtest ccs0: SUCCESS (0.002s)
[110.348140] Subtest resubmit: SUCCESS (0.021s)
[110.566622] [018/133] (906s left) vgem_slow (nohang)
[110.604904] Starting subtest: nohang
[120.947858] Subtest nohang: SUCCESS (10.341s)
[121.038251] [019/133] (896s left) kms_getfb (getfb-reject-nv12)
[121.137900] Starting subtest: getfb-reject-nv12
[121.140266] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[121.257598] [020/133] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[121.358626] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[121.363073] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[121.489398] [021/133] (895s left) gem_exec_fence (basic-wait-all)
[121.563983] Starting subtest: basic-wait-all
[121.676589] Subtest basic-wait-all: SUCCESS (0.115s)
[124.054300] [022/133] (893s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[124.163044] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[124.165336] Starting dynamic subtest: pipe-A-eDP-1
[156.352563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.841s)
[156.362685] Starting dynamic subtest: pipe-B-eDP-1
[189.272311] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.727s)
[189.284605] Starting dynamic subtest: pipe-C-eDP-1
[222.252554] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.730s)
[222.262183] Starting dynamic subtest: pipe-D-eDP-1
[255.258724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.622s)
[255.261016] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.924s)
[256.492121] [023/133] (761s left) gem_exec_params (invalid-ring)
[256.559299] Starting subtest: invalid-ring
[256.561768] Subtest invalid-ring: SUCCESS (0.000s)
[256.688998] [024/133] (760s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[256.791114] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[260.973430] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.165s)
[262.127805] [025/133] (755s left) kms_feature_discovery (display-1x)
[262.241786] Starting subtest: display-1x
[262.244422] Subtest display-1x: SUCCESS (0.000s)
[262.336490] [026/133] (755s left) gem_request_retire (retire-vma-not-inactive)
[262.403085] Starting subtest: retire-vma-not-inactive
[262.460476] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[262.622340] [027/133] (755s left) sysfs_preempt_timeout (timeout)
[262.692374] Starting subtest: timeout
[262.694886] Starting dynamic subtest: vecs0
[271.967767] Dynamic subtest vecs0: SUCCESS (9.213s)
[271.978652] Starting dynamic subtest: ccs0
[273.396057] Dynamic subtest ccs0: SUCCESS (1.422s)
[273.406361] Starting dynamic subtest: vcs0
[282.974429] Dynamic subtest vcs0: SUCCESS (9.558s)
[282.985301] Starting dynamic subtest: bcs0
[284.241723] Dynamic subtest bcs0: SUCCESS (1.265s)
[284.253516] Starting dynamic subtest: rcs0
[285.570924] Dynamic subtest rcs0: SUCCESS (1.326s)
[285.582466] Starting dynamic subtest: vcs1
[294.934464] Dynamic subtest vcs1: SUCCESS (9.355s)
[294.936858] Subtest timeout: SUCCESS (32.150s)
[295.032899] [028/133] (722s left) i915_drm_fdinfo (idle)
[295.075198] Starting subtest: idle
[295.077637] Starting dynamic subtest: rcs0
[295.664909] Dynamic subtest rcs0: SUCCESS (0.590s)
[295.675797] Starting dynamic subtest: bcs0
[296.171601] Dynamic subtest bcs0: SUCCESS (0.504s)
[296.182757] Starting dynamic subtest: vcs0
[296.676256] Dynamic subtest vcs0: SUCCESS (0.503s)
[296.687136] Starting dynamic subtest: vcs1
[297.181347] Dynamic subtest vcs1: SUCCESS (0.503s)
[297.193482] Starting dynamic subtest: vecs0
[297.686110] Dynamic subtest vecs0: SUCCESS (0.503s)
[297.698332] Starting dynamic subtest: ccs0
[298.192514] Dynamic subtest ccs0: SUCCESS (0.504s)
[298.195454] Subtest idle: SUCCESS (3.118s)
[298.291905] [029/133] (719s left) kms_big_fb (4-tiled-addfb-size-overflow)
[298.408678] Starting subtest: 4-tiled-addfb-size-overflow
[298.411068] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[298.546654] [030/133] (719s left) kms_plane_alpha_blend (constant-alpha-min)
[298.646129] Starting subtest: constant-alpha-min
[298.927824] Starting dynamic subtest: pipe-A-eDP-1
[299.670779] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[299.679802] Starting dynamic subtest: pipe-D-eDP-1
[301.176646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.505s)
[301.179052] Subtest constant-alpha-min: SUCCESS (2.534s)
[302.061442] [031/133] (715s left) gem_exec_alignment (many)
[302.127109] Starting subtest: many
[324.174505] Subtest many: SUCCESS (22.047s)
[325.948041] [032/133] (691s left) sw_sync (sync_busy)
[326.030728] Starting subtest: sync_busy
[326.033264] Subtest sync_busy: SUCCESS (0.002s)
[326.120752] [033/133] (691s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[326.244698] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[326.247033] Starting dynamic subtest: pipe-A-default-mode
[328.957627] Dynamic subtest pipe-A-default-mode: SUCCESS (2.711s)
[328.959911] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.713s)
[329.858373] [034/133] (688s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[329.954880] Starting subtest: plane-lut1d-pre-ctm3x4
[329.967730] Starting dynamic subtest: pipe-A-eDP-1
[330.700287] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[331.419500] Starting dynamic subtest: pipe-B-eDP-1
[332.315022] Dynamic subtest pipe-B-eDP-1: FAIL (0.380s)
[332.851996] Starting dynamic subtest: pipe-C-eDP-1
[333.685617] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s)
[334.186684] Starting dynamic subtest: pipe-D-eDP-1
[335.030926] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[335.033315] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.764s)
[335.587150] [035/133] (682s left) i915_query (test-query-geometry-subslices)
[335.657199] Starting subtest: test-query-geometry-subslices
[335.659434] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[335.792785] [036/133] (682s left) kms_addfb_basic (bad-pitch-128)
[335.857823] Starting subtest: bad-pitch-128
[335.859986] Subtest bad-pitch-128: SUCCESS (0.000s)
[336.036123] [037/133] (682s left) kms_psr (pr-cursor-blt)
[336.130771] Starting subtest: pr-cursor-blt
[336.134946] Subtest pr-cursor-blt: SKIP (0.000s)
[336.228479] [038/133] (681s left) syncobj_basic (bad-pad-fd-to-handle)
[336.280473] Starting subtest: bad-pad-fd-to-handle
[336.282570] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[336.411945] [039/133] (681s left) gem_ctx_persistence (legacy-engines-hang)
[336.479911] Starting subtest: legacy-engines-hang
[336.481821] Starting dynamic subtest: render
[336.607143] Dynamic subtest render: SUCCESS (0.130s)
[336.620788] Starting dynamic subtest: bsd1
[336.709819] Dynamic subtest bsd1: SUCCESS (0.100s)
[336.723271] Starting dynamic subtest: bsd2
[336.812292] Dynamic subtest bsd2: SUCCESS (0.100s)
[336.825609] Starting dynamic subtest: blt
[336.890936] Dynamic subtest blt: SUCCESS (0.076s)
[336.901905] Starting dynamic subtest: vebox
[337.033352] Dynamic subtest vebox: SUCCESS (0.139s)
[337.035557] Subtest legacy-engines-hang: SUCCESS (0.557s)
[337.134627] [040/133] (681s left) kms_pipe_crc_basic (read-crc)
[337.234423] Starting subtest: read-crc
[337.236114] Starting dynamic subtest: pipe-A-eDP-1
[337.949649] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[337.958572] Starting dynamic subtest: pipe-B-eDP-1
[339.327679] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[339.340887] Starting dynamic subtest: pipe-C-eDP-1
[340.631273] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s)
[340.640720] Starting dynamic subtest: pipe-D-eDP-1
[341.960240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[341.962697] Subtest read-crc: SUCCESS (4.726s)
[342.819629] [041/133] (675s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[342.953506] Starting subtest: short-flip-before-cursor-toggle
[343.905228] Subtest short-flip-before-cursor-toggle: SUCCESS (0.950s)
[344.739161] [042/133] (673s left) gem_partial_pwrite_pread (writes-after-reads)
[344.816122] Subtest writes-after-reads: SKIP (0.000s)
[344.894692] [043/133] (673s left) gem_mmap_gtt (big-bo-tiledy)
[344.946692] Subtest big-bo-tiledY: SKIP (0.000s)
[345.007359] [044/133] (673s left) gem_exec_reloc (basic-gtt-wc)
[345.070422] Subtest basic-gtt-wc: SKIP (0.000s)
[345.158026] [045/133] (673s left) gem_pread (display)
[345.224635] Subtest display: SKIP (0.000s)
[345.289181] [046/133] (673s left) kms_chamelium_hpd (hdmi-hpd-storm)
[345.673525] Subtest hdmi-hpd-storm: SKIP (0.000s)
[346.533567] [047/133] (672s left) gem_exec_schedule (fairslice)
[346.613745] Starting subtest: fairslice
[346.615785] Starting dynamic subtest: rcs0
[348.626172] Dynamic subtest rcs0: SUCCESS (2.019s)
[348.637170] Starting dynamic subtest: bcs0
[350.642700] Dynamic subtest bcs0: SUCCESS (2.016s)
[350.652983] Starting dynamic subtest: vcs0
[352.662152] Dynamic subtest vcs0: SUCCESS (2.017s)
[352.672493] Starting dynamic subtest: vcs1
[354.684994] Dynamic subtest vcs1: SUCCESS (2.020s)
[354.695289] Starting dynamic subtest: vecs0
[356.703332] Dynamic subtest vecs0: SUCCESS (2.018s)
[356.719252] Starting dynamic subtest: ccs0
[358.723734] Dynamic subtest ccs0: SUCCESS (2.020s)
[358.725777] Subtest fairslice: SUCCESS (12.115s)
[359.044986] [048/133] (659s left) kms_vrr (flip-basic)
[359.147636] Starting subtest: flip-basic
[359.154023] Subtest flip-basic: SKIP (0.000s)
[359.244061] [049/133] (659s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[359.337076] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[359.339276] Starting dynamic subtest: pipe-A-eDP-1
[359.361193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[359.372816] Starting dynamic subtest: pipe-B-eDP-1
[359.393620] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[359.402811] Starting dynamic subtest: pipe-C-eDP-1
[359.423532] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[359.432153] Starting dynamic subtest: pipe-D-eDP-1
[359.454059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[359.458078] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[361.629251] [050/133] (657s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[361.742346] Starting subtest: protected-encrypted-src-copy-not-readible
[361.851898] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[361.992682] [051/133] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[362.098690] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[362.103035] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[362.237183] [052/133] (656s left) gem_exec_whisper (basic-contexts-forked)
[362.309307] Starting subtest: basic-contexts-forked
[387.313050] Subtest basic-contexts-forked: SUCCESS (25.005s)
[387.524759] [053/133] (631s left) gem_exec_fence (syncobj-timeline-chain-engines)
[388.135777] Starting subtest: syncobj-timeline-chain-engines
[388.296925] Subtest syncobj-timeline-chain-engines: SUCCESS (0.161s)
[390.076230] [054/133] (628s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[390.178678] Starting subtest: primary-yf-tiled-reflect-x-0
[390.237568] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[390.364538] [055/133] (628s left) syncobj_timeline (wait-all-for-submit-complex)
[390.412152] Starting subtest: wait-all-for-submit-complex
[390.625501] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[390.726267] [056/133] (628s left) gem_exec_flush (basic-uc-prw-default)
[390.799895] Starting subtest: basic-uc-prw-default
[396.271510] Subtest basic-uc-prw-default: SUCCESS (5.472s)
[396.482118] [057/133] (622s left) kms_psr (fbc-psr2-primary-page-flip)
[396.585120] Starting subtest: fbc-psr2-primary-page-flip
[396.587425] Starting dynamic subtest: eDP-1
[396.591613] Dynamic subtest eDP-1: SKIP (0.000s)
[396.596033] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[396.680479] [058/133] (622s left) kms_vblank (ts-continuation-idle-hang)
[396.784236] Starting subtest: ts-continuation-idle-hang
[396.786093] Starting dynamic subtest: pipe-A-eDP-1
[423.711352] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.922s)
[423.726998] Starting dynamic subtest: pipe-D-eDP-1
[448.722682] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.003s)
[448.724912] Subtest ts-continuation-idle-hang: SUCCESS (51.929s)
[449.581313] [059/133] (569s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[449.692098] Starting subtest: x-tiled-16bpp-rotate-180
[451.028012] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.337s)
[451.183418] [060/133] (567s left) kms_psr (fbc-pr-cursor-plane-onoff)
[451.283188] Starting subtest: fbc-pr-cursor-plane-onoff
[451.287042] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[451.387560] [061/133] (567s left) kms_async_flips (crc-atomic)
[451.479393] Starting subtest: crc-atomic
[451.862021] Starting dynamic subtest: pipe-A-eDP-1
[454.785613] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.921s)
[455.161217] Starting dynamic subtest: pipe-B-eDP-1
[458.114420] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.960s)
[458.488261] Starting dynamic subtest: pipe-C-eDP-1
[461.410891] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.930s)
[461.782255] Starting dynamic subtest: pipe-D-eDP-1
[464.643360] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.868s)
[464.645799] Subtest crc-atomic: SUCCESS (13.161s)
[465.834158] [062/133] (553s left) syncobj_wait (invalid-signal-illegal-handle)
[465.901811] Starting subtest: invalid-signal-illegal-handle
[465.904102] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[466.040914] [063/133] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[466.133807] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[466.137748] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[466.255165] [064/133] (552s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[466.361206] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[467.130224] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[467.348427] [065/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[467.448145] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[474.008859] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.561s)
[474.162418] [066/133] (545s left) dmabuf (all-tests)
[474.209858] Starting subtest: all-tests
[474.212085] Starting dynamic subtest: sanitycheck
[474.358010] Dynamic subtest sanitycheck: SUCCESS (0.146s)
[474.370959] Starting dynamic subtest: dma_fence
[474.613509] Dynamic subtest dma_fence: SUCCESS (0.253s)
[474.625685] Starting dynamic subtest: dma_fence_chain
[486.082240] Dynamic subtest dma_fence_chain: SUCCESS (11.464s)
[486.094662] Starting dynamic subtest: dma_fence_unwrap
[486.229065] Dynamic subtest dma_fence_unwrap: SUCCESS (0.145s)
[486.240348] Starting dynamic subtest: dma_resv
[486.375288] Dynamic subtest dma_resv: SUCCESS (0.144s)
[486.377879] Subtest all-tests: SUCCESS (12.163s)
[486.472013] [067/133] (532s left) perf_pmu (rc6-all-gts)
[486.521835] Starting subtest: rc6-all-gts
[492.903039] Subtest rc6-all-gts: SUCCESS (6.382s)
[493.791442] [068/133] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[493.908706] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[493.913105] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[494.048421] [069/133] (525s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[499.118148] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[499.122655] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.004s)
[499.982117] [070/133] (519s left) kms_cursor_crc (cursor-sliding-64x64)
[500.167654] Starting subtest: cursor-sliding-64x64
[500.172964] Starting dynamic subtest: pipe-A-eDP-1
[503.432828] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.263s)
[503.464006] Starting dynamic subtest: pipe-D-eDP-1
[507.334041] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.876s)
[507.336206] Subtest cursor-sliding-64x64: SUCCESS (7.165s)
[508.232053] [071/133] (511s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[508.290395] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[508.395670] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[508.501138] [072/133] (511s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[513.501127] Starting subtest: psr2-plane-move-sf-dmg-area
[513.503430] Starting dynamic subtest: pipe-A-eDP-1
[518.787470] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.286s)
[518.799303] Starting dynamic subtest: pipe-B-eDP-1
[524.096741] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.310s)
[524.099154] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.600s)
[525.001919] [073/133] (494s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[525.110098] Starting subtest: plane-all-transition-nonblocking-fencing
[525.112388] Starting dynamic subtest: pipe-A-eDP-1
[527.604082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[527.911139] Starting dynamic subtest: pipe-B-eDP-1
[531.113232] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.212s)
[531.423189] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.312s)
[532.275717] [074/133] (487s left) kms_busy (basic-hang)
[532.389098] Starting subtest: basic-hang
[532.391477] Starting dynamic subtest: flip-pipe-A
[532.987594] Dynamic subtest flip-pipe-A: SUCCESS (0.599s)
[532.998527] Starting dynamic subtest: modeset-pipe-A
[536.385089] Dynamic subtest modeset-pipe-A: SUCCESS (3.396s)
[536.397788] Starting dynamic subtest: flip-pipe-D
[537.564798] Dynamic subtest flip-pipe-D: SUCCESS (1.177s)
[537.575717] Starting dynamic subtest: modeset-pipe-D
[540.999402] Dynamic subtest modeset-pipe-D: SUCCESS (3.433s)
[541.001779] Subtest basic-hang: SUCCESS (8.612s)
[541.834461] [075/133] (477s left) kms_plane_scaling (2x-scaler-multi-pipe)
[541.930050] Starting subtest: 2x-scaler-multi-pipe
[541.934492] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[542.055692] [076/133] (477s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[542.161532] Starting subtest: psr-rgb565-draw-mmap-gtt
[542.165791] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[542.308033] [077/133] (477s left) i915_pm_rpm (system-suspend-devices)
[544.128880] Starting subtest: system-suspend-devices
[551.797174] Subtest system-suspend-devices: SUCCESS (7.672s)
[552.200653] [078/133] (467s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[552.313982] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[552.318395] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[552.454782] [079/133] (467s left) dumb_buffer (map-invalid-size)
[552.511936] Starting subtest: map-invalid-size
[552.514161] Subtest map-invalid-size: SUCCESS (0.000s)
[552.634602] [080/133] (467s left) kms_rotation_crc (primary-rotation-270)
[552.735250] Starting subtest: primary-rotation-270
[552.739622] Subtest primary-rotation-270: SKIP (0.001s)
[552.834363] [081/133] (467s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[552.939613] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[552.944043] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[553.059673] [082/133] (466s left) i915_pm_freq_api (freq-reset)
[553.127645] Starting subtest: freq-reset
[553.129617] Starting dynamic subtest: gt0
[553.328197] Dynamic subtest gt0: SUCCESS (0.198s)
[553.339266] Starting dynamic subtest: gt1
[553.496903] Dynamic subtest gt1: SUCCESS (0.168s)
[553.499542] Subtest freq-reset: SUCCESS (0.368s)
[553.597101] [083/133] (466s left) syncobj_wait (wait-all-complex)
[553.654413] Starting subtest: wait-all-complex
[553.866466] Subtest wait-all-complex: SUCCESS (0.212s)
[553.969130] [084/133] (466s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[554.062666] Starting subtest: basic-modeset-with-all-modifiers-formats
[554.444610] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[555.260688] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.816s)
[555.271393] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[555.282919] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[555.292989] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[555.305094] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[555.315077] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[555.472060] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[555.482921] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[555.494148] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[555.504730] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[555.516456] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[555.526336] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[555.538504] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[555.548031] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[555.560791] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[555.570278] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[555.583024] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[555.592337] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[555.605254] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[555.614809] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[555.627437] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[555.637042] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[555.649340] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[555.658993] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[555.805260] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[555.820890] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[555.827475] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[555.842273] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[555.849808] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[555.864914] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[555.872458] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[555.886312] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[555.894178] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[555.906437] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[555.916428] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[555.926763] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[555.938634] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[555.949355] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[555.960796] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[555.970461] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[555.982984] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[555.992927] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[556.139088] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[556.151945] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[556.161370] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[556.171591] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[556.183321] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[556.193161] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[556.205762] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[556.215721] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[556.227995] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.020s)
[556.237938] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[556.249957] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.020s)
[556.261681] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[556.271818] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.020s)
[556.280914] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[556.294136] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[556.304045] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[556.316451] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[556.716703] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.655s)
[557.576128] [085/133] (462s left) api_intel_bb (intel-bb-blit-y)
[557.639816] Starting subtest: intel-bb-blit-y
[561.447511] Subtest intel-bb-blit-y: SUCCESS (3.809s)
[561.609426] [086/133] (458s left) gem_basic (create-close)
[561.666662] Starting subtest: create-close
[561.671358] Subtest create-close: SUCCESS (0.000s)
[561.790349] [087/133] (458s left) api_intel_allocator (reopen)
[561.848217] Starting subtest: reopen
[561.853043] Subtest reopen: SUCCESS (0.006s)
[562.027489] [088/133] (458s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[562.166396] Starting subtest: basic-flip-before-cursor-legacy
[563.087935] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.921s)
[563.905862] [089/133] (456s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[563.964904] Starting subtest: y-tiled-to-vebox-yf-tiled
[563.969426] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[564.175733] [090/133] (456s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[564.265244] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[571.699400] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.437s)
[571.860793] [091/133] (448s left) gem_exec_flush (basic-wb-ro-before-default)
[571.931296] Starting subtest: basic-wb-ro-before-default
[577.380980] Subtest basic-wb-ro-before-default: SUCCESS (5.451s)
[577.592377] [092/133] (442s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[577.702600] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[577.707012] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[577.823526] [093/133] (442s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[577.917227] Starting subtest: yf-tiled-16bpp-rotate-270
[577.921640] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[578.063192] [094/133] (442s left) gem_exec_schedule (preempt-other)
[578.148432] Starting subtest: preempt-other
[578.150421] Starting dynamic subtest: rcs0
[578.217458] Dynamic subtest rcs0: SUCCESS (0.074s)
[578.231925] Starting dynamic subtest: bcs0
[578.281533] Dynamic subtest bcs0: SUCCESS (0.065s)
[578.294210] Starting dynamic subtest: vcs0
[578.346035] Dynamic subtest vcs0: SUCCESS (0.063s)
[578.358953] Starting dynamic subtest: vcs1
[578.414069] Dynamic subtest vcs1: SUCCESS (0.067s)
[578.428171] Starting dynamic subtest: vecs0
[578.477713] Dynamic subtest vecs0: SUCCESS (0.063s)
[578.487965] Starting dynamic subtest: ccs0
[578.551906] Dynamic subtest ccs0: SUCCESS (0.074s)
[578.554192] Subtest preempt-other: SUCCESS (0.410s)
[580.071047] [095/133] (440s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[580.121908] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[580.124296] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[580.252515] [096/133] (440s left) gem_exec_schedule (u-fairslice-all)
[580.317060] Starting subtest: u-fairslice-all
[582.370258] Subtest u-fairslice-all: SUCCESS (2.059s)
[583.967630] [097/133] (436s left) kms_invalid_mode (int-max-clock)
[584.076525] Starting subtest: int-max-clock
[584.078860] Starting dynamic subtest: pipe-A-eDP-1
[584.358884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[584.369665] Starting dynamic subtest: pipe-B-eDP-1
[584.371937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[584.384563] Starting dynamic subtest: pipe-C-eDP-1
[584.386959] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[584.399357] Starting dynamic subtest: pipe-D-eDP-1
[584.401544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[584.403891] Subtest int-max-clock: SUCCESS (0.291s)
[585.174216] [098/133] (435s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[585.221833] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[585.292619] [099/133] (435s left) gem_mmap_wc (write-read-distinct)
[585.353261] Subtest write-read-distinct: SKIP (0.000s)
[585.422722] [100/133] (435s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[585.658774] Starting subtest: cursor-rapid-movement-128x42
[585.709393] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[585.944388] [101/133] (434s left) kms_scaling_modes (scaling-mode-center)
[586.037030] Starting subtest: scaling-mode-center
[586.039416] Starting dynamic subtest: pipe-A-eDP-1
[586.126369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.091s)
[586.137578] Starting dynamic subtest: pipe-B-eDP-1
[587.281043] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.152s)
[587.291546] Starting dynamic subtest: pipe-C-eDP-1
[588.394231] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[588.405061] Starting dynamic subtest: pipe-D-eDP-1
[589.530304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[589.532562] Subtest scaling-mode-center: SUCCESS (3.493s)
[590.708832] [102/133] (430s left) gem_eio (in-flight-contexts-immediate)
[590.939143] Starting subtest: in-flight-contexts-immediate
[604.964074] Subtest in-flight-contexts-immediate: SUCCESS (14.021s)
[605.176868] [103/133] (415s left) gem_partial_pwrite_pread (write-snoop)
[605.245981] Subtest write-snoop: SKIP (0.000s)
[605.332539] [104/133] (415s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[605.387903] Starting subtest: single-wait-for-submit-unsubmitted
[605.491906] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[605.591124] [105/133] (415s left) gem_mmap_wc (fault-concurrent)
[605.643160] Subtest fault-concurrent: SKIP (0.000s)
[605.713910] [106/133] (415s left) kms_pm_dc (dc9-dpms)
[606.816237] Starting subtest: dc9-dpms
[608.253109] Subtest dc9-dpms: SUCCESS (1.437s)
[608.346328] [107/133] (412s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[608.457445] Starting subtest: fbc-rgb565-draw-pwrite
[613.032315] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.577s)
[614.244570] [108/133] (406s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[614.369048] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[615.341173] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.970s)
[616.171464] [109/133] (404s left) gem_flink_basic (double-flink)
[616.229502] Starting subtest: double-flink
[616.231904] Subtest double-flink: SUCCESS (0.000s)
[616.364224] [110/133] (404s left) gem_ctx_exec (basic-close-race)
[616.426763] Starting subtest: basic-close-race
[622.051154] Subtest basic-close-race: SUCCESS (5.623s)
[622.233664] [111/133] (398s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[622.335029] Starting subtest: bad-pixel-format-yf-tiled-ccs
[622.337233] Starting dynamic subtest: pipe-A-eDP-1
[622.358760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[622.369928] Starting dynamic subtest: pipe-B-eDP-1
[622.390224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[622.400277] Starting dynamic subtest: pipe-C-eDP-1
[622.421310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[622.431138] Starting dynamic subtest: pipe-D-eDP-1
[622.453038] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[622.457382] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[624.553486] [112/133] (396s left) kms_cursor_crc (cursor-onscreen-64x64)
[624.745557] Starting subtest: cursor-onscreen-64x64
[624.750897] Starting dynamic subtest: pipe-A-eDP-1
[626.857788] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[626.898802] Starting dynamic subtest: pipe-D-eDP-1
[629.604305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.713s)
[629.606365] Subtest cursor-onscreen-64x64: SUCCESS (4.856s)
[630.424952] [113/133] (390s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[630.529137] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[630.531418] Starting dynamic subtest: pipe-A-default-mode
[631.662233] Dynamic subtest pipe-A-default-mode: SKIP (1.131s)
[631.666113] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.132s)
[631.843460] [114/133] (389s left) gem_wait (wait)
[631.906549] Starting subtest: wait
[631.908807] Starting dynamic subtest: all-engines
[633.935738] Dynamic subtest all-engines: SUCCESS (2.026s)
[633.949616] Starting dynamic subtest: rcs0
[634.981975] Dynamic subtest rcs0: SUCCESS (1.045s)
[634.994814] Starting dynamic subtest: bcs0
[636.028952] Dynamic subtest bcs0: SUCCESS (1.044s)
[636.041509] Starting dynamic subtest: vcs0
[637.073299] Dynamic subtest vcs0: SUCCESS (1.042s)
[637.086063] Starting dynamic subtest: vcs1
[638.116984] Dynamic subtest vcs1: SUCCESS (1.042s)
[638.128535] Starting dynamic subtest: vecs0
[639.162379] Dynamic subtest vecs0: SUCCESS (1.043s)
[639.175470] Starting dynamic subtest: ccs0
[640.208790] Dynamic subtest ccs0: SUCCESS (1.044s)
[640.211332] Subtest wait: SUCCESS (8.302s)
[640.433276] [115/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[640.541622] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[640.545628] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[640.659418] [116/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[640.761671] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[640.765993] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[640.906014] [117/133] (380s left) sriov_basic (enable-vfs-autoprobe-off)
[640.967966] Starting subtest: enable-vfs-autoprobe-off
[640.970216] Starting dynamic subtest: numvfs-1
[641.043060] Dynamic subtest numvfs-1: FAIL (0.006s)
[641.053461] Starting dynamic subtest: numvfs-2
[641.126367] Dynamic subtest numvfs-2: FAIL (0.004s)
[641.138073] Starting dynamic subtest: numvfs-3
[641.211694] Dynamic subtest numvfs-3: FAIL (0.004s)
[641.223017] Starting dynamic subtest: numvfs-4
[641.296609] Dynamic subtest numvfs-4: FAIL (0.004s)
[641.308600] Starting dynamic subtest: numvfs-5
[641.375927] Dynamic subtest numvfs-5: FAIL (0.004s)
[641.386570] Starting dynamic subtest: numvfs-6
[641.445772] Dynamic subtest numvfs-6: FAIL (0.004s)
[641.457212] Starting dynamic subtest: numvfs-7
[641.517032] Dynamic subtest numvfs-7: FAIL (0.004s)
[641.526625] Starting dynamic subtest: numvfs-random
[641.585267] Dynamic subtest numvfs-random: FAIL (0.004s)
[641.595156] Starting dynamic subtest: numvfs-all
[641.652417] Dynamic subtest numvfs-all: FAIL (0.491s)
[641.654222] Subtest enable-vfs-autoprobe-off: FAIL (0.529s)
[641.707128] [118/133] (379s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[646.728120] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[646.730537] Starting dynamic subtest: pipe-A-eDP-1
[647.508366] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s)
[647.520247] Starting dynamic subtest: pipe-B-eDP-1
[648.739246] Dynamic subtest pipe-B-eDP-1: SKIP (1.231s)
[648.744059] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (2.010s)
[649.952364] [119/133] (371s left) kms_plane (pixel-format-source-clamping)
[650.051262] Starting subtest: pixel-format-source-clamping
[650.080052] Starting dynamic subtest: pipe-A-plane-0
[654.968833] Dynamic subtest pipe-A-plane-0: SUCCESS (4.889s)
[654.981000] Starting dynamic subtest: pipe-A-plane-3
[657.291685] Dynamic subtest pipe-A-plane-3: SUCCESS (2.320s)
[657.306892] Starting dynamic subtest: pipe-A-plane-5
[657.308776] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[658.402024] Starting dynamic subtest: pipe-B-plane-0
[663.304407] Dynamic subtest pipe-B-plane-0: SUCCESS (4.911s)
[663.316932] Starting dynamic subtest: pipe-B-plane-3
[665.638204] Dynamic subtest pipe-B-plane-3: SUCCESS (2.333s)
[665.648981] Starting dynamic subtest: pipe-B-plane-5
[665.650891] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[665.960165] Subtest pixel-format-source-clamping: SUCCESS (15.907s)
[666.811794] [120/133] (354s left) gem_ctx_exec (basic-nohangcheck)
[666.866405] Starting subtest: basic-nohangcheck
[667.108688] Subtest basic-nohangcheck: SUCCESS (0.244s)
[667.265268] [121/133] (354s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[667.366199] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[667.370600] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[667.504895] [122/133] (354s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[667.607433] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[674.903244] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.298s)
[675.064457] [123/133] (346s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[675.165423] Starting subtest: y-tiled-16bpp-rotate-270
[675.169655] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[675.309662] [124/133] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[675.410993] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[682.398051] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.987s)
[682.569019] [125/133] (339s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[682.659426] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[682.663511] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[682.784668] [126/133] (339s left) gem_mmap_gtt (basic-write-read)
[682.835089] Subtest basic-write-read: SKIP (0.000s)
[682.896417] [127/133] (339s left) kms_chamelium_frames (dp-crc-single)
[683.280371] Subtest dp-crc-single: SKIP (0.000s)
[684.077086] [128/133] (337s left) gem_exec_balancer (full-late)
[684.155795] Starting subtest: full-late
[688.852178] Subtest full-late: SUCCESS (4.695s)
[689.196558] [129/133] (332s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[689.282880] Starting subtest: plane-upscale-20x20-with-modifiers
[689.285102] Starting dynamic subtest: pipe-A
[689.619161] Dynamic subtest pipe-A: SUCCESS (0.338s)
[689.630029] Starting dynamic subtest: pipe-B
[690.983777] Dynamic subtest pipe-B: SUCCESS (1.363s)
[690.998939] Starting dynamic subtest: pipe-C
[692.415981] Dynamic subtest pipe-C: SUCCESS (1.431s)
[692.426365] Starting dynamic subtest: pipe-D
[693.846450] Dynamic subtest pipe-D: SUCCESS (1.429s)
[693.848734] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.565s)
[695.074115] [130/133] (327s left) gem_lmem_swapping (heavy-multi)
[695.114105] Subtest heavy-multi: SKIP (0.000s)
[695.160744] [131/133] (326s left) perf_pmu (enable-race)
[695.210230] Starting subtest: enable-race
[695.212143] Starting dynamic subtest: rcs0
[707.989084] Dynamic subtest rcs0: SUCCESS (12.779s)
[708.000355] Starting dynamic subtest: bcs0
[720.732774] Dynamic subtest bcs0: SUCCESS (12.739s)
[720.744703] Starting dynamic subtest: vcs0
[735.950973] Dynamic subtest vcs0: SUCCESS (15.213s)
[735.963052] Starting dynamic subtest: vcs1
[751.951182] Dynamic subtest vcs1: SUCCESS (15.994s)
[751.963201] Starting dynamic subtest: vecs0
[767.951647] Dynamic subtest vecs0: SUCCESS (15.996s)
[767.965515] Starting dynamic subtest: ccs0
[780.700385] Dynamic subtest ccs0: SUCCESS (12.744s)
[780.703120] Subtest enable-race: SUCCESS (85.477s)
[780.821364] [132/133] (241s left) kms_chamelium_audio (hdmi-audio-edid)
[781.217055] Subtest hdmi-audio-edid: SKIP (0.000s)
[782.029505] [133/133] (240s left) gem_exec_basic (basic)
[782.090432] Starting subtest: basic
[782.092654] Starting dynamic subtest: rcs0-smem
[782.095046] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[782.109969] Starting dynamic subtest: bcs0-smem
[782.112291] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[782.122980] Starting dynamic subtest: vcs0-smem
[782.125207] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[782.135782] Starting dynamic subtest: vcs1-smem
[782.138251] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[782.150492] Starting dynamic subtest: vecs0-smem
[782.152790] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[782.163160] Starting dynamic subtest: ccs0-smem
[782.165455] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[782.167717] Subtest basic: SUCCESS (0.017s)
[784.012694] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_pxp
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_content_protection
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: vgem_slow
results: parsing output: 18/ for test: kms_getfb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: gem_request_retire
results: parsing output: 26/ for test: sysfs_preempt_timeout
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_plane_alpha_blend
results: parsing output: 30/ for test: gem_exec_alignment
results: parsing output: 31/ for test: sw_sync
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_color_pipeline
results: parsing output: 34/ for test: i915_query
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: syncobj_basic
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_pread
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: dmabuf
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_busy
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_pm_rpm
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: dumb_buffer
results: parsing output: 79/ for test: kms_rotation_crc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_pm_freq_api
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: gem_basic
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_flush
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_invalid_mode
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: gem_eio
results: parsing output: 102/ for test: gem_partial_pwrite_pread
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_mmap_wc
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_flink_basic
results: parsing output: 109/ for test: gem_ctx_exec
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_cursor_crc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
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_mmap_gtt
results: parsing output: 126/ for test: kms_chamelium_frames
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_chamelium_audio
results: parsing output: 132/ for test: gem_exec_basic
Done.