[61.910225] Initializing watchdogs
[61.910271]   /dev/watchdog0
[61.925021] [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]
[61.929497] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.931892] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.933925] [001/132] (960s left) gem_render_copy_redux (flink)
[61.993455] Starting subtest: flink
[63.106696] Subtest flink: SUCCESS (1.114s)
[63.233369] [002/132] (959s left) syncobj_basic (bad-handle-to-fd)
[63.292086] Starting subtest: bad-handle-to-fd
[63.293092] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[63.395689] [003/132] (959s left) kms_content_protection (srm)
[63.544422] Starting subtest: srm
[63.547937] Subtest srm: SKIP (0.002s)
[63.649142] [004/132] (958s left) gem_exec_await (wide-all)
[63.860054] Starting subtest: wide-all
[86.793405] Subtest wide-all: SUCCESS (22.932s)
[86.967851] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[86.970309] [005/132] (935s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[87.082281] Starting subtest: etime-single-wait-all-for-submit-submitted
[87.187365] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[87.271811] [006/132] (935s left) kms_flip (2x-flip-vs-fences)
[87.374450] Starting subtest: 2x-flip-vs-fences
[87.376256] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[87.465038] [007/132] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[87.561340] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[87.563087] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[87.656634] [008/132] (935s left) gem_ringfill (engines-basic)
[92.901998] Starting subtest: engines-basic
[92.903051] Starting dynamic subtest: rcs0
[92.947286] Dynamic subtest rcs0: SUCCESS (0.046s)
[92.956689] Starting dynamic subtest: bcs0
[92.988502] Dynamic subtest bcs0: SUCCESS (0.041s)
[92.998582] Starting dynamic subtest: vcs0
[93.030863] Dynamic subtest vcs0: SUCCESS (0.041s)
[93.039288] Starting dynamic subtest: vcs1
[93.074876] Dynamic subtest vcs1: SUCCESS (0.043s)
[93.084315] Starting dynamic subtest: vecs0
[93.116897] Dynamic subtest vecs0: SUCCESS (0.041s)
[93.124567] Starting dynamic subtest: ccs0
[93.165306] Dynamic subtest ccs0: SUCCESS (0.047s)
[93.166759] Subtest engines-basic: SUCCESS (0.265s)
[93.251189] [009/132] (929s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[93.347059] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[93.348037] Starting dynamic subtest: pipe-A-eDP-1
[93.802476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.445s)
[93.809150] Starting dynamic subtest: pipe-B-eDP-1
[95.312401] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[95.322382] Starting dynamic subtest: pipe-C-eDP-1
[96.653807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s)
[96.660432] Starting dynamic subtest: pipe-D-eDP-1
[98.009623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.357s)
[98.010396] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.654s)
[99.194763] [010/132] (923s left) kms_cursor_crc (cursor-onscreen-256x256)
[99.436323] Starting subtest: cursor-onscreen-256x256
[99.439710] Starting dynamic subtest: pipe-A-eDP-1
[101.560073] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[101.587037] Starting dynamic subtest: pipe-D-eDP-1
[104.389773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.808s)
[104.390667] Subtest cursor-onscreen-256x256: SUCCESS (4.953s)
[105.258717] [011/132] (917s left) gem_exec_nop (basic-parallel)
[105.314553] Starting subtest: basic-parallel
[121.887958] Subtest basic-parallel: SUCCESS (16.566s)
[122.098750] [012/132] (900s left) api_intel_bb (crc32)
[122.147042] Starting subtest: crc32
[122.148015] Starting dynamic subtest: rcs0-smem0
[122.490440] Dynamic subtest rcs0-smem0: SUCCESS (0.335s)
[122.498617] Starting dynamic subtest: bcs0-smem0
[122.846751] Dynamic subtest bcs0-smem0: SUCCESS (0.355s)
[122.856312] Starting dynamic subtest: vcs0-smem0
[123.265472] Dynamic subtest vcs0-smem0: SUCCESS (0.417s)
[123.276179] Starting dynamic subtest: vcs1-smem0
[123.613420] Dynamic subtest vcs1-smem0: SUCCESS (0.346s)
[123.621293] Starting dynamic subtest: vecs0-smem0
[123.957747] Dynamic subtest vecs0-smem0: SUCCESS (0.343s)
[123.967825] Starting dynamic subtest: ccs0-smem0
[124.363284] Dynamic subtest ccs0-smem0: SUCCESS (0.404s)
[124.364303] Subtest crc32: SUCCESS (2.209s)
[124.463026] [013/132] (898s left) perf_pmu (busy-check-all)
[124.504506] Starting subtest: busy-check-all
[124.505443] Starting dynamic subtest: rcs0
[125.054879] Dynamic subtest rcs0: SUCCESS (0.549s)
[125.066347] Starting dynamic subtest: bcs0
[125.608373] Dynamic subtest bcs0: SUCCESS (0.552s)
[125.620439] Starting dynamic subtest: vcs0
[126.878186] Dynamic subtest vcs0: SUCCESS (1.260s)
[126.885344] Starting dynamic subtest: vcs1
[128.927937] Dynamic subtest vcs1: SUCCESS (2.048s)
[128.934931] Starting dynamic subtest: vecs0
[130.910312] Dynamic subtest vecs0: SUCCESS (1.981s)
[130.917646] Starting dynamic subtest: ccs0
[131.458334] Dynamic subtest ccs0: SUCCESS (0.556s)
[131.459618] Subtest busy-check-all: SUCCESS (6.954s)
[131.544785] [014/132] (891s left) kms_psr (fbc-psr2-basic)
[131.659978] Starting subtest: fbc-psr2-basic
[131.660998] Starting dynamic subtest: eDP-1
[131.662763] Dynamic subtest eDP-1: SKIP (0.000s)
[131.664501] Subtest fbc-psr2-basic: SKIP (0.000s)
[131.731403] [015/132] (891s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[131.821866] Starting subtest: y-tiled-16bpp-rotate-90
[131.823857] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[131.914931] [016/132] (891s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[132.008675] Starting subtest: yf-tiled-32bpp-rotate-270
[132.010438] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[132.099405] [017/132] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[132.206303] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[132.207909] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[132.329737] [018/132] (890s left) gem_ctx_param (root-set)
[132.377199] Starting subtest: root-set
[132.377964] Subtest root-set: SUCCESS (0.001s)
[132.463024] [019/132] (890s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[132.537899] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[132.538887] Starting dynamic subtest: pipe-A-default-mode
[135.349665] Dynamic subtest pipe-A-default-mode: SUCCESS (2.810s)
[135.350550] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.812s)
[136.181501] [020/132] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[136.267850] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[136.269712] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[136.362193] [021/132] (886s left) syncobj_wait (wait-any-snapshot)
[136.425538] Starting subtest: wait-any-snapshot
[136.508872] Subtest wait-any-snapshot: SUCCESS (0.082s)
[136.594126] [022/132] (886s left) gem_exec_reloc (basic-write-read-active)
[136.655782] Subtest basic-write-read-active: SKIP (0.000s)
[136.717451] [023/132] (886s left) kms_feature_discovery (display)
[136.812627] Starting subtest: display
[136.813591] Subtest display: SUCCESS (0.000s)
[136.882609] [024/132] (886s left) gem_lmem_swapping (heavy-random)
[136.927912] Subtest heavy-random: SKIP (0.000s)
[136.964217] [025/132] (886s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[137.052414] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[137.054262] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[137.149176] [026/132] (886s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[137.264226] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[137.266041] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[137.405569] [027/132] (885s left) perf_pmu (busy-start)
[137.438088] Starting subtest: busy-start
[137.438965] Starting dynamic subtest: rcs0
[139.989693] Dynamic subtest rcs0: SUCCESS (2.551s)
[140.000869] Starting dynamic subtest: bcs0
[142.550635] Dynamic subtest bcs0: SUCCESS (2.549s)
[142.559587] Starting dynamic subtest: vcs0
[145.951100] Dynamic subtest vcs0: SUCCESS (3.402s)
[145.961720] Starting dynamic subtest: vcs1
[149.918448] Dynamic subtest vcs1: SUCCESS (3.966s)
[149.928499] Starting dynamic subtest: vecs0
[153.950464] Dynamic subtest vecs0: SUCCESS (4.030s)
[153.960676] Starting dynamic subtest: ccs0
[156.500576] Dynamic subtest ccs0: SUCCESS (2.547s)
[156.501589] Subtest busy-start: SUCCESS (19.051s)
[156.576282] [028/132] (866s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[156.714903] Starting subtest: short-flip-after-cursor-atomic-transitions
[157.664539] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.949s)
[158.511928] [029/132] (864s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[158.604928] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[158.606743] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[158.684074] [030/132] (864s left) prime_busy (before)
[158.731055] Starting subtest: before
[158.733252] Starting dynamic subtest: rcs0
[158.761709] Dynamic subtest rcs0: SUCCESS (0.028s)
[158.771242] Starting dynamic subtest: bcs0
[158.812567] Dynamic subtest bcs0: SUCCESS (0.050s)
[158.821203] Starting dynamic subtest: vcs0
[158.852481] Dynamic subtest vcs0: SUCCESS (0.040s)
[158.859982] Starting dynamic subtest: vcs1
[158.893252] Dynamic subtest vcs1: SUCCESS (0.040s)
[158.901236] Starting dynamic subtest: vecs0
[158.934367] Dynamic subtest vecs0: SUCCESS (0.041s)
[158.942148] Starting dynamic subtest: ccs0
[158.974825] Dynamic subtest ccs0: SUCCESS (0.040s)
[159.082380] Subtest before: SUCCESS (0.351s)
[159.151616] [031/132] (864s left) gem_exec_fence (syncobj-unused-fence)
[159.591745] Starting subtest: syncobj-unused-fence
[159.595058] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[160.996700] [032/132] (862s left) gem_mmap (bad-size)
[161.049102] Subtest bad-size: SKIP (0.000s)
[161.100688] [033/132] (862s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[161.162105] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[161.163051] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[161.264109] [034/132] (862s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[161.357258] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[161.358932] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[161.422338] [035/132] (862s left) gem_exec_schedule (submit-golden-slice)
[161.479461] Starting subtest: submit-golden-slice
[161.480558] Starting dynamic subtest: rcs0
[161.518533] Dynamic subtest rcs0: SUCCESS (0.039s)
[161.529110] Starting dynamic subtest: bcs0
[161.546113] Dynamic subtest bcs0: SUCCESS (0.027s)
[161.553716] Starting dynamic subtest: vcs0
[161.582532] Dynamic subtest vcs0: SUCCESS (0.036s)
[161.590658] Starting dynamic subtest: vcs1
[161.624517] Dynamic subtest vcs1: SUCCESS (0.041s)
[161.634147] Starting dynamic subtest: vecs0
[161.657652] Dynamic subtest vecs0: SUCCESS (0.033s)
[161.666074] Starting dynamic subtest: ccs0
[161.695809] Dynamic subtest ccs0: SUCCESS (0.037s)
[161.697049] Subtest submit-golden-slice: SUCCESS (0.216s)
[162.979269] [036/132] (860s left) gem_exec_store (pages)
[163.033356] Starting subtest: pages
[163.034301] Starting dynamic subtest: rcs0
[163.112437] Dynamic subtest rcs0: SUCCESS (0.079s)
[163.119857] Starting dynamic subtest: bcs0
[163.180985] Dynamic subtest bcs0: SUCCESS (0.068s)
[163.189912] Starting dynamic subtest: vcs0
[163.255742] Dynamic subtest vcs0: SUCCESS (0.073s)
[163.264451] Starting dynamic subtest: vcs1
[163.322753] Dynamic subtest vcs1: SUCCESS (0.067s)
[163.331520] Starting dynamic subtest: vecs0
[163.386630] Dynamic subtest vecs0: SUCCESS (0.063s)
[163.394899] Starting dynamic subtest: ccs0
[163.452323] Dynamic subtest ccs0: SUCCESS (0.065s)
[163.453458] Subtest pages: SUCCESS (0.419s)
[163.628849] [037/132] (859s left) kms_psr (pr-sprite-mmap-cpu)
[163.712981] Starting subtest: pr-sprite-mmap-cpu
[163.714571] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[163.795727] [038/132] (859s left) gem_exec_balancer (full-late)
[163.849541] Starting subtest: full-late
[168.804210] Subtest full-late: SUCCESS (4.954s)
[169.124456] [039/132] (854s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[169.217916] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[169.219609] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[169.295268] [040/132] (854s left) kms_display_modes (extended-mode-basic)
[169.392626] Starting subtest: extended-mode-basic
[169.394374] Subtest extended-mode-basic: SKIP (0.000s)
[169.432683] [041/132] (854s left) kms_color (invalid-gamma-lut-sizes)
[169.526230] Starting subtest: invalid-gamma-lut-sizes
[169.527092] Starting dynamic subtest: pipe-A
[169.811073] Dynamic subtest pipe-A: SUCCESS (0.285s)
[169.818663] Starting dynamic subtest: pipe-B
[169.819467] Dynamic subtest pipe-B: SUCCESS (0.000s)
[169.826700] Starting dynamic subtest: pipe-C
[169.827724] Dynamic subtest pipe-C: SUCCESS (0.000s)
[169.836704] Starting dynamic subtest: pipe-D
[169.837533] Dynamic subtest pipe-D: SUCCESS (0.000s)
[169.838347] Subtest invalid-gamma-lut-sizes: SUCCESS (0.287s)
[170.644647] [042/132] (853s left) kms_invalid_mode (clock-too-high)
[170.730604] Starting subtest: clock-too-high
[170.731529] Starting dynamic subtest: pipe-A-eDP-1
[170.733321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.741449] Starting dynamic subtest: pipe-B-eDP-1
[170.743345] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.750849] Starting dynamic subtest: pipe-C-eDP-1
[170.752638] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.760712] Starting dynamic subtest: pipe-D-eDP-1
[170.762446] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.764285] Subtest clock-too-high: SKIP (0.003s)
[170.801981] [043/132] (853s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[170.849213] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[170.850217] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[170.958044] [044/132] (852s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[171.052585] Starting subtest: 4-tiled-32bpp-rotate-0
[172.431836] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.379s)
[172.576271] [045/132] (851s left) gem_mmap_wc (bad-offset)
[172.627915] Subtest bad-offset: SKIP (0.000s)
[172.736939] [046/132] (851s left) gen7_exec_parse (basic-rejected)
[172.792188] Subtest basic-rejected: SKIP (0.000s)
[172.861385] [047/132] (851s left) kms_psr (fbc-psr2-sprite-plane-move)
[172.943360] Starting subtest: fbc-psr2-sprite-plane-move
[172.944287] Starting dynamic subtest: eDP-1
[172.946188] Dynamic subtest eDP-1: SKIP (0.000s)
[172.947887] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[173.014390] [048/132] (851s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[173.103168] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[173.105080] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[173.194026] [049/132] (850s left) kms_selftest (drm_dp_mst_helper)
[173.227070] Starting subtest: drm_dp_mst_helper
[173.248251] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[173.343481] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.095s)
[173.350371] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[173.453359] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s)
[173.460374] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[173.568597] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.115s)
[173.569458] Subtest drm_dp_mst_helper: SUCCESS (0.342s)
[173.714455] [050/132] (850s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[173.784256] Starting subtest: map-fixed-invalidate-overlap
[173.786171] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[173.910014] [051/132] (850s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[173.973301] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[173.975198] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[174.152340] [052/132] (850s left) i915_hangman (detector)
[174.210811] Starting subtest: detector
[174.211685] Starting dynamic subtest: rcs0
[184.893217] Dynamic subtest rcs0: SUCCESS (10.672s)
[184.902112] Starting dynamic subtest: bcs0
[195.838055] Dynamic subtest bcs0: SUCCESS (10.943s)
[195.852463] Starting dynamic subtest: vcs0
[206.846474] Dynamic subtest vcs0: SUCCESS (11.006s)
[206.856576] Starting dynamic subtest: vcs1
[217.853675] Dynamic subtest vcs1: SUCCESS (11.005s)
[217.864047] Starting dynamic subtest: vecs0
[229.822909] Dynamic subtest vecs0: SUCCESS (11.968s)
[229.833183] Starting dynamic subtest: ccs0
[241.918309] Dynamic subtest ccs0: SUCCESS (12.093s)
[241.919765] Subtest detector: SUCCESS (67.697s)
[241.986135] [053/132] (782s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[242.079240] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[242.080132] Starting dynamic subtest: pipe-A-eDP-1
[242.083657] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.092093] Starting dynamic subtest: pipe-B-eDP-1
[242.095712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.102984] Starting dynamic subtest: pipe-C-eDP-1
[242.106591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.114137] Starting dynamic subtest: pipe-D-eDP-1
[242.117479] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.119067] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[244.304114] [054/132] (779s left) kms_flip (flip-vs-expired-vblank)
[244.386693] Starting subtest: flip-vs-expired-vblank
[244.390422] Starting dynamic subtest: A-eDP1
[253.142872] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[253.152295] Starting dynamic subtest: B-eDP1
[261.749709] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[261.763993] Starting dynamic subtest: C-eDP1
[270.408744] Dynamic subtest C-eDP1: SUCCESS (8.620s)
[270.417307] Starting dynamic subtest: D-eDP1
[279.036520] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[279.037805] Subtest flip-vs-expired-vblank: SUCCESS (34.615s)
[280.164463] [055/132] (744s left) gem_ctx_create (basic)
[280.218345] Starting subtest: basic
[280.219583] Subtest basic: SUCCESS (0.000s)
[280.409433] [056/132] (743s left) i915_drm_fdinfo (busy-hang)
[280.445698] Starting subtest: busy-hang
[280.446790] Starting dynamic subtest: rcs0
[280.465140] Dynamic subtest rcs0: SKIP (0.018s)
[280.475047] Starting dynamic subtest: bcs0
[280.476848] Dynamic subtest bcs0: SKIP (0.001s)
[280.484260] Starting dynamic subtest: vcs0
[280.485858] Dynamic subtest vcs0: SKIP (0.000s)
[280.493270] Starting dynamic subtest: vcs1
[280.494835] Dynamic subtest vcs1: SKIP (0.000s)
[280.502154] Starting dynamic subtest: vecs0
[280.503913] Dynamic subtest vecs0: SKIP (0.000s)
[280.511151] Starting dynamic subtest: ccs0
[280.512767] Dynamic subtest ccs0: SKIP (0.000s)
[280.514436] Subtest busy-hang: SKIP (0.022s)
[280.542712] [057/132] (743s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[280.923145] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[281.729489] [058/132] (742s left) gem_exec_fence (syncobj-timeline-repeat)
[282.267042] Starting subtest: syncobj-timeline-repeat
[282.515070] Subtest syncobj-timeline-repeat: SUCCESS (0.248s)
[283.991739] [059/132] (740s left) kms_flip (flip-vs-absolute-wf_vblank)
[284.076351] Starting subtest: flip-vs-absolute-wf_vblank
[284.077274] Starting dynamic subtest: A-eDP1
[292.974935] Dynamic subtest A-eDP1: SUCCESS (8.897s)
[292.983667] Starting dynamic subtest: B-eDP1
[301.900402] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[301.909197] Starting dynamic subtest: C-eDP1
[310.863737] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[310.873131] Starting dynamic subtest: D-eDP1
[319.785062] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[319.785954] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.675s)
[320.973193] [060/132] (703s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[321.070989] Starting subtest: flip-vs-dpms-off-vs-modeset
[321.072870] Starting dynamic subtest: A-eDP1
[324.697547] Dynamic subtest A-eDP1: SUCCESS (3.625s)
[324.705577] Starting dynamic subtest: B-eDP1
[327.901164] Dynamic subtest B-eDP1: SUCCESS (3.201s)
[327.909598] Starting dynamic subtest: C-eDP1
[330.996875] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[331.004674] Starting dynamic subtest: D-eDP1
[334.091602] Dynamic subtest D-eDP1: SUCCESS (3.093s)
[334.093642] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.022s)
[334.886509] [061/132] (689s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[334.989163] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[334.989933] Starting dynamic subtest: pipe-A-eDP-1
[345.675721] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.685s)
[345.683956] Starting dynamic subtest: pipe-B-eDP-1
[357.094435] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.417s)
[357.095355] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.105s)
[357.947079] [062/132] (666s left) gem_userptr_blits (sd-probe)
[357.999541] Starting subtest: sd-probe
[358.000601] Subtest sd-probe: SUCCESS (0.000s)
[358.131790] [063/132] (666s left) kms_addfb_basic (invalid-get-prop-any)
[358.180053] Starting subtest: invalid-get-prop-any
[358.181079] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[358.307067] [064/132] (666s left) gem_exec_schedule (noreorder)
[358.481642] Starting subtest: noreorder
[358.482915] Starting dynamic subtest: rcs0
[358.529928] Dynamic subtest rcs0: SUCCESS (0.056s)
[358.540845] Starting dynamic subtest: vcs0
[359.905593] Dynamic subtest vcs0: SUCCESS (1.365s)
[359.916376] Starting dynamic subtest: vcs1
[361.881273] Dynamic subtest vcs1: SUCCESS (1.974s)
[361.891430] Starting dynamic subtest: vecs0
[363.910642] Dynamic subtest vecs0: SUCCESS (2.027s)
[363.920607] Starting dynamic subtest: ccs0
[363.974476] Dynamic subtest ccs0: SUCCESS (0.070s)
[363.975745] Subtest noreorder: SUCCESS (5.502s)
[364.163128] [065/132] (660s left) i915_pm_rps (fence-order)
[364.228538] Starting subtest: fence-order
[367.692763] Subtest fence-order: SUCCESS (3.456s)
[367.808035] [066/132] (656s left) kms_plane_scaling (planes-upscale-20x20)
[367.917059] Starting subtest: planes-upscale-20x20
[367.917915] Starting dynamic subtest: pipe-A
[367.980377] Dynamic subtest pipe-A: SUCCESS (0.064s)
[367.993390] Starting dynamic subtest: pipe-B
[369.167400] Dynamic subtest pipe-B: SUCCESS (1.186s)
[369.178058] Starting dynamic subtest: pipe-C
[370.279872] Dynamic subtest pipe-C: SUCCESS (1.111s)
[370.287846] Starting dynamic subtest: pipe-D
[371.414943] Dynamic subtest pipe-D: SUCCESS (1.134s)
[371.415978] Subtest planes-upscale-20x20: SUCCESS (3.499s)
[372.555997] [067/132] (652s left) kms_chamelium_edid (dp-edid-resolution-list)
[372.946301] Subtest dp-edid-resolution-list: SKIP (0.000s)
[373.760481] [068/132] (651s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[373.855174] Starting subtest: crc-primary-basic-y-tiled-ccs
[373.855996] Starting dynamic subtest: pipe-A-eDP-1
[373.864559] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[373.873088] Starting dynamic subtest: pipe-B-eDP-1
[373.881812] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[373.889799] Starting dynamic subtest: pipe-C-eDP-1
[373.897966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[373.905243] Starting dynamic subtest: pipe-D-eDP-1
[373.913389] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[373.914948] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[376.161426] [069/132] (648s left) i915_query (query-topology-unsupported)
[376.205431] Starting subtest: query-topology-unsupported
[376.207241] Subtest query-topology-unsupported: SKIP (0.000s)
[376.302677] [070/132] (648s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[376.379394] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[376.380341] Starting dynamic subtest: pipe-A-default-mode
[377.533958] Dynamic subtest pipe-A-default-mode: SKIP (1.153s)
[377.535734] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.155s)
[377.661222] [071/132] (647s left) kms_pm_backlight (basic-brightness)
[377.740573] Starting subtest: basic-brightness
[377.789345] Starting dynamic subtest: eDP-1
[378.097694] Dynamic subtest eDP-1: SUCCESS (0.307s)
[378.098923] Subtest basic-brightness: SUCCESS (0.356s)
[378.909900] [072/132] (646s left) fbdev (info)
[378.942870] Starting subtest: info
[378.943814] Subtest info: SUCCESS (0.000s)
[379.022437] [073/132] (645s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[379.111446] Starting subtest: primary-x-tiled-reflect-x-180
[386.104449] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.994s)
[387.280134] [074/132] (637s left) kms_vblank (ts-continuation-dpms-rpm)
[387.383548] Starting subtest: ts-continuation-dpms-rpm
[387.384501] Starting dynamic subtest: pipe-A-eDP-1
[389.881215] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[389.892231] Starting dynamic subtest: pipe-D-eDP-1
[392.137088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.252s)
[392.137982] Subtest ts-continuation-dpms-rpm: SUCCESS (4.754s)
[393.022878] [075/132] (632s left) api_intel_bb (object-reloc-keep-cache)
[393.072116] Starting subtest: object-reloc-keep-cache
[393.074084] Subtest object-reloc-keep-cache: SKIP (0.002s)
[393.176379] [076/132] (631s left) gem_ccs (suspend-resume)
[393.222583] Starting subtest: suspend-resume
[393.224380] Subtest suspend-resume: SKIP (0.000s)
[393.323274] [077/132] (631s left) gem_userptr_blits (coherency-unsync)
[393.389423] Subtest coherency-unsync: SKIP (0.000s)
[393.518744] [078/132] (631s left) kms_atomic (plane-primary-legacy)
[393.615381] Starting subtest: plane-primary-legacy
[393.616246] Starting dynamic subtest: pipe-A-eDP-1
[394.061857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[394.062784] Subtest plane-primary-legacy: SUCCESS (0.447s)
[394.845968] [079/132] (630s left) kms_big_fb (linear-8bpp-rotate-180)
[394.942243] Starting subtest: linear-8bpp-rotate-180
[396.189058] Subtest linear-8bpp-rotate-180: SUCCESS (1.247s)
[396.299981] [080/132] (628s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[396.356298] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[396.357308] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[396.444788] [081/132] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[396.542342] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[403.627607] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.086s)
[403.752096] [082/132] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[403.852262] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[410.755954] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.903s)
[410.912276] [083/132] (614s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[411.025043] Starting subtest: x-tiled-8bpp-rotate-90
[411.047170] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[411.164792] [084/132] (614s left) syncobj_timeline (single-wait-all-available-submitted)
[411.213934] Starting subtest: single-wait-all-available-submitted
[411.214977] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[411.314530] [085/132] (614s left) kms_atomic_transition (plane-all-transition)
[411.399362] Starting subtest: plane-all-transition
[411.400288] Starting dynamic subtest: pipe-A-eDP-1
[413.894700] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[414.198942] Starting dynamic subtest: pipe-B-eDP-1
[417.431893] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.240s)
[417.743887] Subtest plane-all-transition: SUCCESS (6.345s)
[418.569750] [086/132] (606s left) sysfs_heartbeat_interval (nopreempt)
[418.623501] Starting subtest: nopreempt
[418.624520] Starting dynamic subtest: vecs0
[427.919825] Dynamic subtest vecs0: SUCCESS (9.295s)
[427.936521] Starting dynamic subtest: ccs0
[431.921100] Dynamic subtest ccs0: SUCCESS (3.999s)
[431.931585] Starting dynamic subtest: vcs0
[441.881660] Dynamic subtest vcs0: SUCCESS (9.950s)
[441.891977] Starting dynamic subtest: bcs0
[445.827605] Dynamic subtest bcs0: SUCCESS (3.951s)
[445.837516] Starting dynamic subtest: rcs0
[449.874408] Dynamic subtest rcs0: SUCCESS (4.047s)
[449.887834] Starting dynamic subtest: vcs1
[458.906364] Dynamic subtest vcs1: SUCCESS (9.020s)
[458.907594] Subtest nopreempt: SUCCESS (40.273s)
[459.013023] [087/132] (566s left) kms_addfb_basic (too-high)
[459.100415] Starting subtest: too-high
[459.101382] Subtest too-high: SUCCESS (0.001s)
[459.191750] [088/132] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[459.279732] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[466.760591] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.482s)
[466.892483] [089/132] (558s left) kms_lease (page-flip-implicit-plane)
[466.987386] Starting subtest: page-flip-implicit-plane
[466.988207] Starting dynamic subtest: pipe-A-eDP-1
[467.474970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[467.485581] Starting dynamic subtest: pipe-B-eDP-1
[468.636572] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[468.646107] Starting dynamic subtest: pipe-C-eDP-1
[469.753463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[469.763153] Starting dynamic subtest: pipe-D-eDP-1
[470.893710] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[470.894594] Subtest page-flip-implicit-plane: SUCCESS (3.907s)
[471.731168] [090/132] (553s left) gem_exec_big (single)
[471.789143] Starting subtest: single
[476.638443] Subtest single: SUCCESS (4.802s)
[476.880050] [091/132] (548s left) gem_spin_batch (legacy-resubmit)
[476.983487] Starting subtest: legacy-resubmit
[476.984588] Starting dynamic subtest: default
[476.992402] Dynamic subtest default: SUCCESS (0.008s)
[477.001394] Starting dynamic subtest: render
[477.002342] Dynamic subtest render: SUCCESS (0.002s)
[477.010123] Starting dynamic subtest: bsd
[477.010971] Dynamic subtest bsd: SUCCESS (0.003s)
[477.018866] Starting dynamic subtest: bsd1
[477.019818] Dynamic subtest bsd1: SUCCESS (0.003s)
[477.027575] Starting dynamic subtest: bsd2
[477.028681] Dynamic subtest bsd2: SUCCESS (0.001s)
[477.036549] Starting dynamic subtest: blt
[477.037610] Dynamic subtest blt: SUCCESS (0.004s)
[477.045362] Starting dynamic subtest: vebox
[477.046465] Dynamic subtest vebox: SUCCESS (0.003s)
[477.047422] Subtest legacy-resubmit: SUCCESS (0.031s)
[477.233955] [092/132] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[477.326650] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[477.328347] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[477.412611] [093/132] (548s left) kms_psr (psr-primary-mmap-cpu)
[477.505729] Starting subtest: psr-primary-mmap-cpu
[477.506592] Starting dynamic subtest: eDP-1
[479.218547] Dynamic subtest eDP-1: SUCCESS (1.712s)
[479.219458] Subtest psr-primary-mmap-cpu: SUCCESS (1.713s)
[480.075084] [094/132] (545s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[480.158722] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[480.159583] Starting dynamic subtest: pipe-A-eDP-1
[486.086099] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.926s)
[486.094479] Starting dynamic subtest: pipe-B-eDP-1
[492.774325] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.687s)
[492.775238] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.616s)
[493.650816] [095/132] (532s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[493.749871] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[493.751442] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[493.840372] [096/132] (531s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[493.921377] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[493.923356] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[494.005415] [097/132] (531s left) gem_mmap_gtt (coherency)
[494.063270] Subtest coherency: SKIP (0.000s)
[494.123718] [098/132] (531s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[494.179597] Starting subtest: etime-multi-wait-all-available-unsubmitted
[494.282899] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s)
[494.368344] [099/132] (531s left) perf (polling)
[494.499573] Starting subtest: polling
[494.506827] Starting dynamic subtest: 0-rcs0
[504.571647] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[504.582284] Starting dynamic subtest: 1-vcs0
[514.591995] Dynamic subtest 1-vcs0: SUCCESS (10.018s)
[514.593592] Subtest polling: SUCCESS (20.048s)
[514.624849] [100/132] (511s left) i915_query (query-topology-coherent-slice-mask)
[514.672524] Starting subtest: query-topology-coherent-slice-mask
[514.674356] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[514.781544] [101/132] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[514.880254] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[514.881824] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[514.993252] [102/132] (511s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[515.144959] Starting subtest: cursor-rapid-movement-32x10
[515.189564] Subtest cursor-rapid-movement-32x10: SKIP (0.044s)
[515.453451] [103/132] (510s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[515.535414] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[515.536399] Starting dynamic subtest: pipe-A-eDP-1
[515.545469] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[515.553925] Starting dynamic subtest: pipe-B-eDP-1
[515.562179] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[515.569943] Starting dynamic subtest: pipe-C-eDP-1
[515.577314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[515.584962] Starting dynamic subtest: pipe-D-eDP-1
[515.594193] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[515.595835] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[517.710639] [104/132] (508s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[517.830218] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[517.833011] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[517.970191] [105/132] (508s left) gem_userptr_blits (relocations)
[518.031162] Starting subtest: relocations
[518.032918] Subtest relocations: SKIP (0.001s)
[518.169569] [106/132] (508s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[518.259607] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[525.183960] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.924s)
[525.299166] [107/132] (500s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[525.400137] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[525.401929] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[525.524471] [108/132] (500s left) gem_flink_basic (flink-lifetime)
[525.591937] Starting subtest: flink-lifetime
[525.592969] Subtest flink-lifetime: SUCCESS (0.002s)
[525.705918] [109/132] (500s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[525.809476] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[525.811205] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[525.889964] [110/132] (500s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[525.987717] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[533.446282] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.459s)
[533.562832] [111/132] (492s left) gem_exec_reloc (basic-gtt-read-active)
[533.614932] Subtest basic-gtt-read-active: SKIP (0.000s)
[533.669626] [112/132] (492s left) gem_ctx_persistence (engines-mixed)
[533.730650] Starting subtest: engines-mixed
[533.731623] Starting dynamic subtest: rcs0
[533.817493] Dynamic subtest rcs0: SUCCESS (0.086s)
[533.830251] Starting dynamic subtest: bcs0
[533.864400] Dynamic subtest bcs0: SUCCESS (0.045s)
[533.875779] Starting dynamic subtest: vcs0
[533.902445] Dynamic subtest vcs0: SUCCESS (0.036s)
[533.911046] Starting dynamic subtest: vcs1
[533.944467] Dynamic subtest vcs1: SUCCESS (0.041s)
[533.955317] Starting dynamic subtest: vecs0
[533.991475] Dynamic subtest vecs0: SUCCESS (0.045s)
[534.002817] Starting dynamic subtest: ccs0
[534.031098] Dynamic subtest ccs0: SUCCESS (0.038s)
[534.032091] Subtest engines-mixed: SUCCESS (0.301s)
[534.164016] [113/132] (492s left) gem_mmap_offset (mmap-unmap)
[534.209675] Starting subtest: mmap-unmap
[534.210580] Starting dynamic subtest: smem0
[559.027735] Dynamic subtest smem0: SUCCESS (24.807s)
[559.028885] Subtest mmap-unmap: SUCCESS (24.808s)
[559.140318] [114/132] (467s left) i915_selftest (live)
[562.502564] Starting subtest: live
[562.503959] Starting dynamic subtest: sanitycheck
[566.907619] Dynamic subtest sanitycheck: SUCCESS (4.397s)
[566.915176] Starting dynamic subtest: uncore
[571.235480] Dynamic subtest uncore: SUCCESS (4.325s)
[571.244942] Starting dynamic subtest: workarounds
[575.820581] Dynamic subtest workarounds: SUCCESS (4.583s)
[575.828075] Starting dynamic subtest: gt_engines
[580.376314] Dynamic subtest gt_engines: SUCCESS (4.554s)
[580.386050] Starting dynamic subtest: gt_timelines
[594.701810] Dynamic subtest gt_timelines: SUCCESS (14.323s)
[594.711792] Starting dynamic subtest: gt_contexts
[599.019683] Dynamic subtest gt_contexts: SUCCESS (4.316s)
[599.029647] Starting dynamic subtest: gt_lrc
[605.159232] Dynamic subtest gt_lrc: SUCCESS (6.137s)
[605.167137] Starting dynamic subtest: gt_mocs
[608.165683] Dynamic subtest gt_mocs: SUCCESS (3.004s)
[608.175112] Starting dynamic subtest: gt_pm
[612.891513] Dynamic subtest gt_pm: SUCCESS (4.723s)
[612.899391] Starting dynamic subtest: gt_heartbeat
[617.261054] Dynamic subtest gt_heartbeat: SUCCESS (4.367s)
[617.269949] Starting dynamic subtest: gt_tlb
[627.254779] Dynamic subtest gt_tlb: SUCCESS (9.991s)
[627.264128] Starting dynamic subtest: requests
[640.606308] Dynamic subtest requests: SUCCESS (13.349s)
[640.615376] Starting dynamic subtest: migrate
[646.340818] Dynamic subtest migrate: SUCCESS (5.731s)
[646.348680] Starting dynamic subtest: active
[650.673453] Dynamic subtest active: SUCCESS (4.330s)
[650.682598] Starting dynamic subtest: objects
[655.675503] Dynamic subtest objects: SUCCESS (5.001s)
[655.684533] Starting dynamic subtest: mman
[660.469854] Dynamic subtest mman: SUCCESS (4.793s)
[660.479120] Starting dynamic subtest: dmabuf
[664.847230] Dynamic subtest dmabuf: SUCCESS (4.374s)
[664.856548] Starting dynamic subtest: vma
[669.211675] Dynamic subtest vma: SUCCESS (4.363s)
[669.220467] Starting dynamic subtest: coherency
[672.712751] Dynamic subtest coherency: SUCCESS (3.500s)
[672.722642] Starting dynamic subtest: gtt
[682.978245] Dynamic subtest gtt: SUCCESS (10.263s)
[682.987401] Starting dynamic subtest: gem
[688.585801] Dynamic subtest gem: SUCCESS (5.606s)
[688.594859] Starting dynamic subtest: evict
[694.490238] Dynamic subtest evict: SUCCESS (5.902s)
[694.500039] Starting dynamic subtest: hugepages
[705.844553] Dynamic subtest hugepages: SUCCESS (11.351s)
[705.854058] Starting dynamic subtest: gem_contexts
[726.229590] Dynamic subtest gem_contexts: FAIL (20.177s)
[726.236766] Starting dynamic subtest: client
[730.369661] Dynamic subtest client: SUCCESS (4.345s)
[730.378786] Starting dynamic subtest: gem_migrate
[734.716559] Dynamic subtest gem_migrate: SUCCESS (4.345s)
[734.727531] Starting dynamic subtest: reset
[737.442608] Dynamic subtest reset: SUCCESS (2.724s)
[737.451591] Starting dynamic subtest: memory_region
[741.771640] Dynamic subtest memory_region: SUCCESS (4.327s)
[741.780835] Starting dynamic subtest: hangcheck
[755.799613] Dynamic subtest hangcheck: SUCCESS (14.026s)
[755.809429] Starting dynamic subtest: execlists
[758.511961] Dynamic subtest execlists: SUCCESS (2.711s)
[758.519317] Starting dynamic subtest: ring_submission
[762.900993] Dynamic subtest ring_submission: SUCCESS (4.386s)
[762.910282] Starting dynamic subtest: perf
[767.211836] Dynamic subtest perf: SUCCESS (4.308s)
[767.221116] Starting dynamic subtest: slpc
[779.994970] Dynamic subtest slpc: SUCCESS (12.782s)
[780.004091] Starting dynamic subtest: guc
[783.950778] Dynamic subtest guc: SUCCESS (3.955s)
[783.960198] Starting dynamic subtest: guc_multi_lrc
[788.304932] Dynamic subtest guc_multi_lrc: SUCCESS (4.353s)
[788.314602] Starting dynamic subtest: guc_hang
[793.196930] Dynamic subtest guc_hang: SUCCESS (4.890s)
[793.206635] Starting dynamic subtest: late_gt_pm
[797.552215] Dynamic subtest late_gt_pm: SUCCESS (4.353s)
[797.553390] Subtest live: FAIL (235.032s)
[797.574775] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[797.575636] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[797.577273] [115/132] (228s left) kms_flip (dpms-vs-vblank-race-interruptible)
[799.174136] Starting subtest: dpms-vs-vblank-race-interruptible
[799.176509] Starting dynamic subtest: A-eDP1
[803.094173] Dynamic subtest A-eDP1: SUCCESS (3.917s)
[803.101507] Starting dynamic subtest: B-eDP1
[806.705269] Dynamic subtest B-eDP1: SUCCESS (3.609s)
[806.714604] Starting dynamic subtest: C-eDP1
[810.650386] Dynamic subtest C-eDP1: SUCCESS (3.943s)
[810.660819] Starting dynamic subtest: D-eDP1
[814.386024] Dynamic subtest D-eDP1: SUCCESS (3.732s)
[814.388460] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.215s)
[815.432561] [FACT kms_flip (dpms-vs-vblank-race-interruptible)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[815.433873] [FACT kms_flip (dpms-vs-vblank-race-interruptible)] new: kernel.kmod_is_loaded.i915: true
[815.436317] [116/132] (211s left) gem_mmap_wc (set-cache-level)
[815.485634] Subtest set-cache-level: SKIP (0.000s)
[815.555807] [117/132] (211s left) syncobj_timeline (multi-wait-available-submitted)
[815.604170] Starting subtest: multi-wait-available-submitted
[815.605420] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[815.713145] [118/132] (210s left) dmabuf_sync_file (export-before-signal)
[815.756080] Starting subtest: export-before-signal
[815.756954] Subtest export-before-signal: SUCCESS (0.001s)
[815.811600] [119/132] (210s left) kms_async_flips (async-flip-hang)
[815.901508] Starting subtest: async-flip-hang
[816.364045] Starting dynamic subtest: pipe-A-eDP-1
[831.350550] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.986s)
[831.735808] Starting dynamic subtest: pipe-B-eDP-1
[847.409339] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.678s)
[847.815011] Starting dynamic subtest: pipe-C-eDP-1
[863.409437] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.601s)
[863.782942] Starting dynamic subtest: pipe-D-eDP-1
[879.343990] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.568s)
[879.345361] Subtest async-flip-hang: SUCCESS (63.442s)
[880.611632] [120/132] (146s left) gem_ctx_param (invalid-param-set)
[880.662942] Starting subtest: invalid-param-set
[880.663999] Subtest invalid-param-set: SUCCESS (0.000s)
[880.743935] [121/132] (145s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[880.849688] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[880.851399] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[880.943991] [122/132] (145s left) kms_fbcon_fbt (psr-suspend)
[881.003957] Starting subtest: psr-suspend
[931.590649] Subtest psr-suspend: SUCCESS (20.559s)
[933.689430] [123/132] ( 95s left) perf (non-system-wide-paranoid)
[933.821576] Starting subtest: non-system-wide-paranoid
[933.849454] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[933.894152] [124/132] ( 94s left) kms_prop_blob (basic)
[933.939425] Starting subtest: basic
[933.940369] Subtest basic: SUCCESS (0.000s)
[934.029158] [125/132] ( 94s left) gem_ctx_persistence (heartbeat-hang)
[934.085770] Starting subtest: heartbeat-hang
[934.087608] Subtest heartbeat-hang: SKIP (0.000s)
[934.180670] [126/132] ( 94s left) gem_readwrite (write-bad-handle)
[934.233397] Subtest write-bad-handle: SKIP (0.000s)
[934.285207] [127/132] ( 94s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[934.377382] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[938.869721] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.487s)
[940.260116] [128/132] ( 88s left) kms_cursor_edge_walk (64x64-right-edge)
[940.345536] Starting subtest: 64x64-right-edge
[940.346526] Starting dynamic subtest: pipe-A-eDP-1
[944.932685] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.573s)
[944.942690] Starting dynamic subtest: pipe-D-eDP-1
[947.731390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.805s)
[947.732209] Subtest 64x64-right-edge: SUCCESS (7.382s)
[948.764866] [129/132] ( 80s left) kms_chamelium_color (ctm-0-50)
[948.863088] Subtest ctm-0-50: SKIP (0.000s)
[948.905918] [130/132] ( 80s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[949.001400] Starting subtest: stress-xrgb8888-ytiled
[949.003217] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[949.072970] [131/132] ( 80s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[949.171762] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[949.173587] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[949.263364] [132/132] ( 79s left) kms_psr (psr2-sprite-mmap-gtt)
[949.362532] Starting subtest: psr2-sprite-mmap-gtt
[949.363592] Starting dynamic subtest: eDP-1
[951.154668] Dynamic subtest eDP-1: SKIP (1.781s)
[951.156759] Subtest psr2-sprite-mmap-gtt: SKIP (1.784s)
[951.270900] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy_redux
results: parsing output: 1/ for test: syncobj_basic
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_exec_await
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ringfill
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_exec_nop
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_feature_discovery
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: prime_busy
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: gem_mmap
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_exec_store
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_display_modes
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: kms_invalid_mode
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_mmap_wc
results: parsing output: 45/ for test: gen7_exec_parse
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_selftest
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_render_copy
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_ctx_create
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_chamelium_edid
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_pm_backlight
results: parsing output: 71/ for test: fbdev
results: parsing output: 72/ for test: kms_rotation_crc
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: api_intel_bb
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: sysfs_heartbeat_interval
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_lease
results: parsing output: 89/ for test: gem_exec_big
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_flink_basic
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: gem_mmap_offset
results: parsing output: 113/ for test: i915_selftest
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_mmap_wc
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: dmabuf_sync_file
results: parsing output: 118/ for test: kms_async_flips
results: parsing output: 119/ for test: gem_ctx_param
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_fbcon_fbt
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_prop_blob
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: gem_readwrite
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: kms_pipe_stress
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_psr
Done.