[57.138923] Initializing watchdogs
[57.139021]   /dev/watchdog0
[57.153378] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.157821] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.159996] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.163438] [001/133] (960s left) kms_psr (fbc-psr2-sprite-blt)
[57.277854] Starting subtest: fbc-psr2-sprite-blt
[57.280155] Starting dynamic subtest: eDP-1
[57.284579] Dynamic subtest eDP-1: SKIP (0.000s)
[57.289070] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[57.345568] [002/133] (960s left) kms_big_fb (linear-8bpp-rotate-90)
[57.453350] Starting subtest: linear-8bpp-rotate-90
[57.488962] Subtest linear-8bpp-rotate-90: SKIP (0.035s)
[57.594079] [003/133] (960s left) kms_pm_rpm (universal-planes-dpms)
[59.152936] Starting subtest: universal-planes-dpms
[59.155022] Starting dynamic subtest: plane-34
[67.444877] Dynamic subtest plane-34: SUCCESS (8.293s)
[67.457065] Starting dynamic subtest: plane-64
[75.773499] Dynamic subtest plane-64: SUCCESS (8.324s)
[75.783788] Starting dynamic subtest: plane-94
[84.097141] Dynamic subtest plane-94: SUCCESS (8.322s)
[84.107771] Starting dynamic subtest: plane-124
[92.385701] Dynamic subtest plane-124: SUCCESS (8.287s)
[92.395171] Starting dynamic subtest: plane-134
[100.694066] Dynamic subtest plane-134: SUCCESS (8.307s)
[100.703759] Starting dynamic subtest: plane-144
[109.012069] Dynamic subtest plane-144: SUCCESS (8.317s)
[109.014506] Subtest universal-planes-dpms: SUCCESS (49.861s)
[109.393842] [004/133] (908s left) tools_test (tools_test)
[109.442874] Starting subtest: tools_test
[109.494324] Subtest tools_test: SUCCESS (0.067s)
[109.573677] [005/133] (908s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[109.670821] Starting subtest: plane-upscale-20x20-with-modifiers
[109.673135] Starting dynamic subtest: pipe-A
[110.006173] Dynamic subtest pipe-A: SUCCESS (0.337s)
[110.013052] Starting dynamic subtest: pipe-B
[111.391710] Dynamic subtest pipe-B: SUCCESS (1.385s)
[111.400186] Starting dynamic subtest: pipe-C
[112.818235] Dynamic subtest pipe-C: SUCCESS (1.426s)
[112.827875] Starting dynamic subtest: pipe-D
[114.256091] Dynamic subtest pipe-D: SUCCESS (1.438s)
[114.258402] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.587s)
[115.429347] [006/133] (902s left) kms_color (invalid-ctm-matrix-sizes)
[115.529207] Starting subtest: invalid-ctm-matrix-sizes
[115.531610] Starting dynamic subtest: pipe-A
[115.534064] Dynamic subtest pipe-A: SUCCESS (0.002s)
[115.542829] Starting dynamic subtest: pipe-B
[115.544797] Dynamic subtest pipe-B: SUCCESS (0.003s)
[115.551361] Starting dynamic subtest: pipe-C
[115.553736] Dynamic subtest pipe-C: SUCCESS (0.003s)
[115.560327] Starting dynamic subtest: pipe-D
[115.562665] Dynamic subtest pipe-D: SUCCESS (0.004s)
[115.565143] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[115.608929] [007/133] (902s left) gem_softpin (noreloc-s3)
[115.668095] Starting subtest: noreloc-S3
[135.621318] Subtest noreloc-S3: SUCCESS (5.386s)
[135.756224] [008/133] (882s left) kms_cursor_crc (cursor-size-change)
[135.865496] Starting subtest: cursor-size-change
[135.867411] Starting dynamic subtest: pipe-A-eDP-1
[136.701915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[136.715252] Starting dynamic subtest: pipe-D-eDP-1
[138.150547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s)
[138.152822] Subtest cursor-size-change: SUCCESS (2.285s)
[138.960808] [009/133] (879s left) gem_ctx_exec (basic-nohangcheck)
[139.018278] Starting subtest: basic-nohangcheck
[139.271271] Subtest basic-nohangcheck: SUCCESS (0.254s)
[139.381573] [010/133] (878s left) gem_softpin (allocator-nopin-reserve)
[139.455495] Starting subtest: allocator-nopin-reserve
[139.542728] Subtest allocator-nopin-reserve: SUCCESS (0.086s)
[139.652803] [011/133] (878s left) kms_draw_crc (fill-fb)
[139.747977] Starting subtest: fill-fb
[140.231800] Subtest fill-fb: SUCCESS (0.486s)
[140.321864] [012/133] (877s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[140.425254] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[144.913479] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.489s)
[146.083418] [013/133] (872s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[146.173278] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[146.175429] Starting dynamic subtest: pipe-A-eDP-1
[146.184410] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.193717] Starting dynamic subtest: pipe-B-eDP-1
[146.203504] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.211599] Starting dynamic subtest: pipe-C-eDP-1
[146.220496] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.228426] Starting dynamic subtest: pipe-D-eDP-1
[146.238021] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.242467] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[148.340047] [014/133] (869s left) gem_ctx_shared (q-smoketest-all)
[148.424485] Starting subtest: Q-smoketest-all
[180.810026] Subtest Q-smoketest-all: SUCCESS (32.329s)
[182.569469] [015/133] (835s left) kms_psr (pr-primary-mmap-gtt)
[182.681735] Starting subtest: pr-primary-mmap-gtt
[182.686089] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[182.749690] [016/133] (835s left) api_intel_allocator (fork-simple-once)
[182.800886] Starting subtest: fork-simple-once
[182.814502] Subtest fork-simple-once: SUCCESS (0.016s)
[182.923570] [017/133] (835s left) kms_psr (fbc-psr-primary-render)
[183.013581] Starting subtest: fbc-psr-primary-render
[183.015864] Starting dynamic subtest: eDP-1
[183.019896] Dynamic subtest eDP-1: SKIP (0.000s)
[183.023955] Subtest fbc-psr-primary-render: SKIP (0.001s)
[183.085973] [018/133] (835s left) gem_ccs (block-multicopy-compressed)
[183.145472] Starting subtest: block-multicopy-compressed
[183.149721] Subtest block-multicopy-compressed: SKIP (0.000s)
[183.244719] [019/133] (835s left) gem_ctx_create (basic-files)
[183.310745] Starting subtest: basic-files
[185.316993] Subtest basic-files: SUCCESS (2.009s)
[185.608036] [020/133] (832s left) gem_lmem_swapping (heavy-verify-multi)
[185.655523] Subtest heavy-verify-multi: SKIP (0.000s)
[185.695068] [021/133] (832s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[185.788644] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[185.792744] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[185.857504] [022/133] (832s left) gem_mmap_wc (pf-nonblock)
[185.915110] Subtest pf-nonblock: SKIP (0.000s)
[185.976215] [023/133] (832s left) kms_vrr (flip-suspend)
[186.081522] Starting subtest: flip-suspend
[186.088049] Subtest flip-suspend: SKIP (0.000s)
[186.171024] [024/133] (832s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[186.229605] Starting subtest: y-tiled-to-vebox-y-tiled
[186.233891] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[186.422873] [025/133] (832s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[186.485832] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[186.589036] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[186.664951] [026/133] (831s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[186.760068] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[186.764461] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[186.845600] [027/133] (831s left) drm_read (invalid-buffer)
[186.994614] Starting subtest: invalid-buffer
[186.997035] Subtest invalid-buffer: SUCCESS (0.000s)
[187.108838] [028/133] (831s left) gem_wait (write-wait)
[187.170732] Starting subtest: write-wait
[187.173033] Starting dynamic subtest: all-engines
[188.312543] Dynamic subtest all-engines: SUCCESS (1.141s)
[188.329647] Starting dynamic subtest: rcs0
[189.369450] Dynamic subtest rcs0: SUCCESS (1.054s)
[189.384981] Starting dynamic subtest: bcs0
[190.426518] Dynamic subtest bcs0: SUCCESS (1.056s)
[190.442301] Starting dynamic subtest: vcs0
[191.480268] Dynamic subtest vcs0: SUCCESS (1.052s)
[191.495616] Starting dynamic subtest: vcs1
[192.533037] Dynamic subtest vcs1: SUCCESS (1.052s)
[192.547619] Starting dynamic subtest: vecs0
[193.595610] Dynamic subtest vecs0: SUCCESS (1.061s)
[193.614450] Starting dynamic subtest: ccs0
[194.658428] Dynamic subtest ccs0: SUCCESS (1.061s)
[194.661081] Subtest write-wait: SUCCESS (7.488s)
[194.855108] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[194.858516] [029/133] (823s left) gem_ctx_persistence (legacy-engines-queued)
[194.916915] Starting subtest: legacy-engines-queued
[194.919214] Starting dynamic subtest: render
[194.997117] Dynamic subtest render: SUCCESS (0.082s)
[195.009224] Starting dynamic subtest: bsd1
[196.441546] Dynamic subtest bsd1: SUCCESS (1.441s)
[196.452650] Starting dynamic subtest: bsd2
[198.478595] Dynamic subtest bsd2: SUCCESS (1.978s)
[198.489641] Starting dynamic subtest: blt
[198.491840] Dynamic subtest blt: SUCCESS (0.054s)
[198.499059] Starting dynamic subtest: vebox
[200.407470] Dynamic subtest vebox: SUCCESS (1.925s)
[200.410432] Subtest legacy-engines-queued: SUCCESS (5.492s)
[200.486756] [030/133] (818s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[200.881590] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[201.657819] [031/133] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[201.763539] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[210.616904] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.854s)
[210.728082] [032/133] (808s left) gem_exec_schedule (noreorder)
[210.909462] Starting subtest: noreorder
[210.912088] Starting dynamic subtest: rcs0
[210.974471] Dynamic subtest rcs0: SUCCESS (0.066s)
[210.985105] Starting dynamic subtest: vcs0
[212.446663] Dynamic subtest vcs0: SUCCESS (1.469s)
[212.457556] Starting dynamic subtest: vcs1
[214.430964] Dynamic subtest vcs1: SUCCESS (1.982s)
[214.442268] Starting dynamic subtest: vecs0
[216.494366] Dynamic subtest vecs0: SUCCESS (2.007s)
[216.505960] Starting dynamic subtest: ccs0
[216.508260] Dynamic subtest ccs0: SUCCESS (0.061s)
[216.510352] Subtest noreorder: SUCCESS (5.593s)
[216.682535] [033/133] (802s left) gem_basic (create-close)
[216.747676] Starting subtest: create-close
[216.752258] Subtest create-close: SUCCESS (0.000s)
[216.855493] [034/133] (802s left) perf (buffer-fill)
[216.976335] Starting subtest: buffer-fill
[216.978552] Starting dynamic subtest: 0-rcs0
[219.246883] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[219.255881] Starting dynamic subtest: 1-vcs0
[223.677368] Dynamic subtest 1-vcs0: SUCCESS (4.429s)
[223.680070] Subtest buffer-fill: SUCCESS (6.701s)
[223.725180] [035/133] (795s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[223.836485] Starting subtest: psr-shrfb-scaledprimary
[229.618109] Subtest psr-shrfb-scaledprimary: SUCCESS (5.786s)
[229.748404] [036/133] (789s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[229.855076] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[230.844175] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[230.969051] [037/133] (788s left) kms_async_flips (alternate-sync-async-flip)
[231.063528] Starting subtest: alternate-sync-async-flip
[231.457357] Starting dynamic subtest: pipe-A-eDP-1
[234.264335] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.810s)
[234.660144] Starting dynamic subtest: pipe-B-eDP-1
[237.402502] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[237.780522] Starting dynamic subtest: pipe-C-eDP-1
[240.535271] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[240.901440] Starting dynamic subtest: pipe-D-eDP-1
[243.664012] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[243.666092] Subtest alternate-sync-async-flip: SUCCESS (12.605s)
[244.846749] [038/133] (774s left) perf_pmu (busy-idle-no-semaphores)
[244.888625] Starting subtest: busy-idle-no-semaphores
[244.890947] Starting dynamic subtest: rcs0
[245.545327] Dynamic subtest rcs0: SUCCESS (0.655s)
[245.556803] Starting dynamic subtest: bcs0
[246.200794] Dynamic subtest bcs0: SUCCESS (0.654s)
[246.216062] Starting dynamic subtest: vcs0
[246.852271] Dynamic subtest vcs0: SUCCESS (0.650s)
[246.863825] Starting dynamic subtest: vcs1
[248.097206] Dynamic subtest vcs1: SUCCESS (1.242s)
[248.108738] Starting dynamic subtest: vecs0
[250.083301] Dynamic subtest vecs0: SUCCESS (1.983s)
[250.094866] Starting dynamic subtest: ccs0
[252.066589] Dynamic subtest ccs0: SUCCESS (1.981s)
[252.069662] Subtest busy-idle-no-semaphores: SUCCESS (7.179s)
[252.208648] [039/133] (766s left) sw_sync (alloc_merge_fence)
[252.252155] Starting subtest: alloc_merge_fence
[252.254324] Subtest alloc_merge_fence: SUCCESS (0.000s)
[252.305734] [040/133] (766s left) gem_render_linear_blits (basic)
[252.382776] Starting subtest: basic
[252.413643] Subtest basic: SUCCESS (0.034s)
[252.514522] [041/133] (766s left) kms_dsc (dsc-fractional-bpp)
[252.616847] Starting subtest: dsc-fractional-bpp
[252.630162] Subtest dsc-fractional-bpp: SKIP (0.000s)
[252.701589] [042/133] (766s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[252.789445] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[252.793533] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[252.855216] [043/133] (766s left) kms_atomic (atomic-plane-damage)
[252.950099] Starting subtest: atomic-plane-damage
[252.998933] Starting dynamic subtest: pipe-A-eDP-1
[253.527786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[253.530193] Subtest atomic-plane-damage: SUCCESS (0.578s)
[254.383656] [044/133] (764s left) gem_softpin (invalid)
[254.457837] Starting subtest: invalid
[254.465703] Subtest invalid: SUCCESS (0.006s)
[254.602650] [045/133] (764s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[254.725262] Starting subtest: cursor-vs-flip-varying-size
[285.567597] Subtest cursor-vs-flip-varying-size: SUCCESS (30.843s)
[286.391953] [046/133] (733s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[286.450368] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[286.452637] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[286.545381] [047/133] (732s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[286.613496] Starting subtest: multi-wait-available-submitted-signaled
[286.615757] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[286.732101] [048/133] (732s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[286.829633] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[293.567188] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.741s)
[293.682257] [049/133] (725s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[293.778488] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[293.780688] Starting dynamic subtest: pipe-A
[294.127672] Dynamic subtest pipe-A: SUCCESS (0.350s)
[294.137403] Starting dynamic subtest: pipe-B
[295.519246] Dynamic subtest pipe-B: SUCCESS (1.390s)
[295.528117] Starting dynamic subtest: pipe-C
[296.951902] Dynamic subtest pipe-C: SUCCESS (1.432s)
[296.960238] Starting dynamic subtest: pipe-D
[298.440247] Dynamic subtest pipe-D: SUCCESS (1.487s)
[298.442448] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.663s)
[299.671147] [050/133] (719s left) i915_drm_fdinfo (memory-info-purgeable)
[299.726188] Starting subtest: memory-info-purgeable
[299.728457] Starting dynamic subtest: smem0
[302.313539] Dynamic subtest smem0: SUCCESS (2.589s)
[302.315978] Subtest memory-info-purgeable: SUCCESS (2.591s)
[302.390778] [051/133] (717s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[302.491946] Starting subtest: psr2-cursor-plane-update-sf
[302.493809] Starting dynamic subtest: pipe-A-eDP-1
[303.080372] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[303.089963] Starting dynamic subtest: pipe-B-eDP-1
[304.372317] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.293s)
[304.374821] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.885s)
[305.241138] [052/133] (714s left) gem_request_retire (retire-vma-not-inactive)
[305.298995] Starting subtest: retire-vma-not-inactive
[305.359574] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[305.480753] [053/133] (714s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[305.546367] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[305.652838] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[305.727227] [054/133] (714s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[305.833920] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[305.836235] Starting dynamic subtest: pipe-A-eDP-1
[305.859079] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[305.868979] Starting dynamic subtest: pipe-B-eDP-1
[305.890627] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[305.898527] Starting dynamic subtest: pipe-C-eDP-1
[305.919753] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[305.927693] Starting dynamic subtest: pipe-D-eDP-1
[305.949296] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[305.953605] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[308.100879] [055/133] (711s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[308.496000] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[309.308580] [056/133] (710s left) perf (invalid-remove-userspace-config)
[309.396373] Starting subtest: invalid-remove-userspace-config
[309.405373] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[309.448895] [057/133] (710s left) kms_vblank (query-idle)
[309.540678] Starting subtest: query-idle
[309.542943] Starting dynamic subtest: pipe-A-eDP-1
[311.300106] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.758s)
[311.313905] Starting dynamic subtest: pipe-D-eDP-1
[313.777278] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.473s)
[313.779185] Subtest query-idle: SUCCESS (4.235s)
[314.595829] [058/133] (705s left) i915_pm_rpm (gem-idle)
[316.627184] Starting subtest: gem-idle
[322.828293] Subtest gem-idle: SUCCESS (6.204s)
[323.170712] [059/133] (696s left) gem_exec_fence (syncobj-timeline-signal)
[324.936253] Starting subtest: syncobj-timeline-signal
[324.942496] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[326.557619] [060/133] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[326.661218] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[333.963558] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.306s)
[334.080714] [061/133] (685s left) gen7_exec_parse (chained-batch)
[334.154782] Subtest chained-batch: SKIP (0.000s)
[334.228530] [062/133] (685s left) kms_psr (psr2-no-drrs)
[334.325710] Starting subtest: psr2-no-drrs
[334.327951] Starting dynamic subtest: eDP-1
[335.978040] Dynamic subtest eDP-1: SUCCESS (1.651s)
[335.980219] Subtest psr2-no-drrs: SUCCESS (1.652s)
[336.777704] [063/133] (683s left) kms_lease (lease-invalid-connector)
[336.869574] Starting subtest: lease-invalid-connector
[336.871866] Starting dynamic subtest: pipe-A-eDP-1
[336.874157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[336.883592] Starting dynamic subtest: pipe-B-eDP-1
[336.885835] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[336.894172] Starting dynamic subtest: pipe-C-eDP-1
[336.896490] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[336.905283] Starting dynamic subtest: pipe-D-eDP-1
[336.907423] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[336.909542] Subtest lease-invalid-connector: SUCCESS (0.004s)
[336.945571] [064/133] (683s left) kms_psr (psr-sprite-render)
[337.032401] Starting subtest: psr-sprite-render
[337.034531] Starting dynamic subtest: eDP-1
[338.799565] Dynamic subtest eDP-1: SUCCESS (1.768s)
[338.801799] Subtest psr-sprite-render: SUCCESS (1.769s)
[339.635124] [065/133] (680s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[339.733962] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[339.738041] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[339.840999] [066/133] (680s left) syncobj_wait (wait-all-for-submit-snapshot)
[339.894662] Starting subtest: wait-all-for-submit-snapshot
[339.975421] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[340.051444] [067/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[340.154416] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[340.158560] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[340.265617] [068/133] (680s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[340.363213] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[344.335867] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.976s)
[345.534893] [069/133] (674s left) gem_exec_balancer (busy)
[345.593489] Starting subtest: busy
[347.452009] Subtest busy: SUCCESS (1.856s)
[347.776282] [070/133] (672s left) gem_exec_schedule (timeslicing)
[347.843638] Starting subtest: timeslicing
[347.846861] Starting dynamic subtest: rcs0
[347.855664] Dynamic subtest rcs0: SUCCESS (0.022s)
[347.865955] Starting dynamic subtest: bcs0
[347.881194] Dynamic subtest bcs0: SUCCESS (0.023s)
[347.889457] Starting dynamic subtest: vcs0
[347.902372] Dynamic subtest vcs0: SUCCESS (0.020s)
[347.911097] Starting dynamic subtest: vcs1
[347.923418] Dynamic subtest vcs1: SUCCESS (0.020s)
[347.932089] Starting dynamic subtest: vecs0
[347.943183] Dynamic subtest vecs0: SUCCESS (0.019s)
[347.951474] Starting dynamic subtest: ccs0
[347.962370] Dynamic subtest ccs0: SUCCESS (0.018s)
[347.964732] Subtest timeslicing: SUCCESS (0.130s)
[349.485516] [071/133] (670s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[349.598225] Starting subtest: 4-tiled-64bpp-rotate-90
[349.625481] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.025s)
[349.727023] [072/133] (670s left) gem_ctx_param (invalid-param-set)
[349.785834] Starting subtest: invalid-param-set
[349.788171] Subtest invalid-param-set: SUCCESS (0.000s)
[349.863407] [073/133] (670s left) gem_render_copy_redux (normal)
[349.918431] Starting subtest: normal
[350.178476] Subtest normal: SUCCESS (0.263s)
[350.292860] [074/133] (670s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[350.364812] Starting subtest: invalid-bsd2-flag-on-blt
[350.367004] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[350.476314] [075/133] (670s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[350.564299] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[350.580449] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.013s)
[350.653797] [076/133] (669s left) kms_setmode (basic)
[350.718582] Starting subtest: basic
[351.049379] Starting dynamic subtest: pipe-A-eDP-1
[353.147740] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s)
[353.487348] Starting dynamic subtest: pipe-B-eDP-1
[355.576836] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.093s)
[355.887728] Subtest basic: SUCCESS (5.167s)
[356.715919] [077/133] (663s left) kms_selftest (drm_cmdline_parser)
[356.762937] Starting subtest: drm_cmdline_parser
[356.780404] Starting dynamic subtest: drm_test_cmdline_force_d_only
[356.868106] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.087s)
[356.878643] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[356.964672] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.094s)
[356.975250] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[357.061397] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.094s)
[357.071960] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[357.151000] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.088s)
[357.159209] Starting dynamic subtest: drm_test_cmdline_force_e_only
[357.247200] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.095s)
[357.256245] Starting dynamic subtest: drm_test_cmdline_res
[357.348841] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.100s)
[357.357718] Starting dynamic subtest: drm_test_cmdline_res_vesa
[357.443043] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.095s)
[357.453398] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[357.542068] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.098s)
[357.551931] Starting dynamic subtest: drm_test_cmdline_res_rblank
[357.638133] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[357.648151] Starting dynamic subtest: drm_test_cmdline_res_bpp
[357.739282] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.099s)
[357.749265] Starting dynamic subtest: drm_test_cmdline_res_refresh
[357.844884] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.105s)
[357.854776] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[357.925329] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.080s)
[357.934815] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[358.031336] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.104s)
[358.040944] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[358.133527] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.102s)
[358.143072] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[358.223422] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.091s)
[358.231350] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[358.332499] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.107s)
[358.341139] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[358.419551] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.087s)
[358.427210] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[358.516330] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.096s)
[358.524397] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[358.606374] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.089s)
[358.614189] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[358.696623] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.091s)
[358.704546] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[358.803460] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.106s)
[358.811319] Starting dynamic subtest: drm_test_cmdline_name
[358.896299] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.089s)
[358.904241] Starting dynamic subtest: drm_test_cmdline_name_bpp
[358.981346] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.086s)
[358.989344] Starting dynamic subtest: drm_test_cmdline_name_option
[359.069846] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.085s)
[359.077525] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[359.160519] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.090s)
[359.168396] Starting dynamic subtest: drm_test_cmdline_rotate_0
[359.260540] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.101s)
[359.268588] Starting dynamic subtest: drm_test_cmdline_rotate_90
[359.353538] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.092s)
[359.361624] Starting dynamic subtest: drm_test_cmdline_rotate_180
[359.453692] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.098s)
[359.461538] Starting dynamic subtest: drm_test_cmdline_rotate_270
[359.556670] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.103s)
[359.564993] Starting dynamic subtest: drm_test_cmdline_hmirror
[359.654037] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.095s)
[359.662147] Starting dynamic subtest: drm_test_cmdline_vmirror
[359.746095] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.093s)
[359.754291] Starting dynamic subtest: drm_test_cmdline_margin_options
[359.842897] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.097s)
[359.850455] Starting dynamic subtest: drm_test_cmdline_multiple_options
[359.966603] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.120s)
[359.975082] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[360.069881] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.104s)
[360.078576] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[360.157309] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.088s)
[360.165887] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[360.238571] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.080s)
[360.246484] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[360.348993] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.110s)
[360.357587] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[360.454816] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.106s)
[360.465620] Starting dynamic subtest: drm_test_cmdline_invalid
[360.581293] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.127s)
[360.589734] Starting dynamic subtest: drm_test_cmdline_tv_options
[360.694087] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.110s)
[360.696111] Subtest drm_cmdline_parser: SUCCESS (3.930s)
[360.841945] [078/133] (659s left) kms_content_protection (dp-mst-lic-type-0)
[360.990049] Starting subtest: dp-mst-lic-type-0
[360.994457] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[361.093813] [079/133] (659s left) kms_flip (2x-flip-vs-suspend)
[361.185420] Starting subtest: 2x-flip-vs-suspend
[361.197370] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[361.275649] [080/133] (659s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[361.390927] Starting subtest: cursorB-vs-flipB-atomic-transitions
[361.395228] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[361.536017] [081/133] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[361.616883] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[361.620209] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[361.721675] [082/133] (659s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[361.776789] Starting subtest: invalid-multi-wait-all-unsubmitted
[361.778474] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[361.867323] [083/133] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[361.962445] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[361.965993] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[362.071030] [084/133] (658s left) syncobj_timeline (signal-point-0)
[362.121028] Starting subtest: signal-point-0
[362.122966] Subtest signal-point-0: SUCCESS (0.000s)
[362.215412] [085/133] (658s left) sysfs_defaults (readonly)
[362.268093] Starting subtest: readonly
[362.270008] Starting dynamic subtest: vecs0
[362.272108] Dynamic subtest vecs0: SUCCESS (0.000s)
[362.281807] Starting dynamic subtest: ccs0
[362.283408] Dynamic subtest ccs0: SUCCESS (0.000s)
[362.291168] Starting dynamic subtest: vcs0
[362.293081] Dynamic subtest vcs0: SUCCESS (0.000s)
[362.302862] Starting dynamic subtest: bcs0
[362.304379] Dynamic subtest bcs0: SUCCESS (0.000s)
[362.311625] Starting dynamic subtest: rcs0
[362.313166] Dynamic subtest rcs0: SUCCESS (0.000s)
[362.320651] Starting dynamic subtest: vcs1
[362.322202] Dynamic subtest vcs1: SUCCESS (0.000s)
[362.323754] Subtest readonly: SUCCESS (0.008s)
[362.359008] [086/133] (658s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[362.465197] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[362.468778] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[362.567937] [087/133] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[362.653501] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[367.085685] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.434s)
[368.222129] [088/133] (652s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[368.317248] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[375.238932] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.923s)
[375.364233] [089/133] (645s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[375.427419] Starting subtest: invalid-signal-one-illegal-handle
[375.429415] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[375.537967] [090/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[375.651069] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[375.655401] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[375.746286] [091/133] (645s left) kms_pm_backlight (fade-with-dpms)
[375.841659] Starting subtest: fade-with-dpms
[377.996821] Starting dynamic subtest: eDP-1
[380.480020] Dynamic subtest eDP-1: SUCCESS (2.483s)
[380.482441] Subtest fade-with-dpms: SUCCESS (4.641s)
[381.295462] [092/133] (639s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[381.390361] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[381.392489] Starting dynamic subtest: pipe-A-eDP-1
[397.855795] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.464s)
[397.864981] Starting dynamic subtest: pipe-B-eDP-1
[414.839828] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.453s)
[414.849408] Starting dynamic subtest: pipe-C-eDP-1
[431.773820] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[431.783529] Starting dynamic subtest: pipe-D-eDP-1
[448.771700] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.352s)
[448.773641] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.697s)
[449.924264] [093/133] (571s left) i915_power (sanity)
[449.978034] Starting subtest: sanity
[454.018119] Subtest sanity: SUCCESS (4.027s)
[455.155026] [094/133] (566s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[455.222832] Starting subtest: x-tiled-to-vebox-yf-tiled
[455.227555] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[455.411209] [095/133] (565s left) dumb_buffer (invalid-bpp)
[455.466091] Starting subtest: invalid-bpp
[455.468402] Subtest invalid-bpp: SUCCESS (0.000s)
[455.575651] [096/133] (565s left) gem_exec_fence (basic-wait)
[455.746823] Starting subtest: basic-wait
[455.749340] Starting dynamic subtest: rcs0
[455.816387] Dynamic subtest rcs0: SUCCESS (0.070s)
[455.827793] Starting dynamic subtest: bcs0
[455.883168] Dynamic subtest bcs0: SUCCESS (0.065s)
[455.893445] Starting dynamic subtest: vcs0
[455.941183] Dynamic subtest vcs0: SUCCESS (0.055s)
[455.952041] Starting dynamic subtest: vcs1
[456.001908] Dynamic subtest vcs1: SUCCESS (0.059s)
[456.012919] Starting dynamic subtest: vecs0
[456.055890] Dynamic subtest vecs0: SUCCESS (0.052s)
[456.068377] Starting dynamic subtest: ccs0
[456.117803] Dynamic subtest ccs0: SUCCESS (0.060s)
[456.120313] Subtest basic-wait: SUCCESS (0.372s)
[458.255434] [097/133] (563s left) i915_module_load (resize-bar)
[458.293544] Starting subtest: resize-bar
[458.300074] Subtest resize-bar: SKIP (0.007s)
[458.342407] [098/133] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[458.443404] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[465.773375] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.326s)
[465.899050] [099/133] (555s left) gem_partial_pwrite_pread (write-snoop)
[465.964619] Subtest write-snoop: SKIP (0.000s)
[466.050147] [100/133] (555s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[466.103245] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[466.180099] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.029s)
[466.220687] [101/133] (555s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[466.305090] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[466.331390] Starting dynamic subtest: pipe-A-plane-0
[466.620139] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[466.628752] Starting dynamic subtest: pipe-A-plane-3
[466.854050] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[466.862184] Starting dynamic subtest: pipe-A-plane-5
[466.865843] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[467.928761] Starting dynamic subtest: pipe-B-plane-0
[468.222069] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[468.233145] Starting dynamic subtest: pipe-B-plane-3
[468.455615] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[468.465431] Starting dynamic subtest: pipe-B-plane-5
[468.470895] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[468.771132] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.464s)
[469.604259] [102/133] (552s left) gem_exec_flush (basic-uc-prw-default)
[469.676793] Starting subtest: basic-uc-prw-default
[475.167620] Subtest basic-uc-prw-default: SUCCESS (5.490s)
[475.362473] [103/133] (546s left) kms_cursor_crc (cursor-onscreen-256x256)
[475.608357] Starting subtest: cursor-onscreen-256x256
[475.610646] Starting dynamic subtest: pipe-A-eDP-1
[477.705105] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.094s)
[477.735111] Starting dynamic subtest: pipe-D-eDP-1
[480.470203] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s)
[480.473041] Subtest cursor-onscreen-256x256: SUCCESS (4.860s)
[481.262233] [104/133] (540s left) gem_exec_reloc (basic-gtt-read)
[481.317321] Subtest basic-gtt-read: SKIP (0.000s)
[481.373896] [105/133] (540s left) kms_plane_lowres (tiling-none)
[481.462193] Starting subtest: tiling-none
[481.464483] Starting dynamic subtest: pipe-A-eDP-1
[481.468877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[481.758916] Starting dynamic subtest: pipe-B-eDP-1
[481.763686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[481.772542] Starting dynamic subtest: pipe-C-eDP-1
[481.777278] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[481.786065] Starting dynamic subtest: pipe-D-eDP-1
[481.790657] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[481.795160] Subtest tiling-none: SKIP (0.294s)
[482.585583] [106/133] (539s left) gem_exec_reloc (basic-gtt)
[482.639570] Subtest basic-gtt: SKIP (0.000s)
[482.722684] [107/133] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[482.819996] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[482.824447] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.921602] [108/133] (539s left) kms_cursor_crc (cursor-sliding-64x21)
[483.108218] Starting subtest: cursor-sliding-64x21
[483.153637] Subtest cursor-sliding-64x21: SKIP (0.042s)
[483.384993] [109/133] (538s left) gem_cs_tlb (engines)
[483.449069] Starting subtest: engines
[483.451444] Starting dynamic subtest: rcs0
[485.604093] Dynamic subtest rcs0: SUCCESS (2.153s)
[485.615481] Starting dynamic subtest: bcs0
[487.812068] Dynamic subtest bcs0: SUCCESS (2.152s)
[487.821894] Starting dynamic subtest: vcs0
[489.962729] Dynamic subtest vcs0: SUCCESS (2.152s)
[489.974779] Starting dynamic subtest: vcs1
[492.116711] Dynamic subtest vcs1: SUCCESS (2.153s)
[492.127929] Starting dynamic subtest: vecs0
[494.270755] Dynamic subtest vecs0: SUCCESS (2.153s)
[494.282004] Starting dynamic subtest: ccs0
[496.425976] Dynamic subtest ccs0: SUCCESS (2.153s)
[496.428324] Subtest engines: SUCCESS (12.923s)
[496.517256] [110/133] (525s left) gem_mmap_wc (close)
[496.572066] Subtest close: SKIP (0.000s)
[496.628144] [111/133] (525s left) template (b)
[496.683389] Starting subtest: B
[496.685525] Subtest B: SUCCESS (0.000s)
[496.779826] [112/133] (525s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[496.887628] Starting subtest: x-tiled-16bpp-rotate-0
[498.201285] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.313s)
[498.335623] [113/133] (523s left) prime_mmap (test_dup)
[498.387939] Starting subtest: test_dup
[498.389818] Starting dynamic subtest: test_dup-smem
[498.418014] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[498.420126] Subtest test_dup: SUCCESS (0.032s)
[498.493311] [114/133] (523s left) gem_pread (display)
[498.554978] Subtest display: SKIP (0.000s)
[498.609291] [115/133] (523s left) kms_invalid_mode (bad-hsync-start)
[498.711742] Starting subtest: bad-hsync-start
[498.713599] Starting dynamic subtest: pipe-A-eDP-1
[498.996071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[499.005708] Starting dynamic subtest: pipe-B-eDP-1
[499.007715] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[499.016247] Starting dynamic subtest: pipe-C-eDP-1
[499.018762] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[499.027559] Starting dynamic subtest: pipe-D-eDP-1
[499.030039] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[499.032345] Subtest bad-hsync-start: SUCCESS (0.290s)
[499.811943] [116/133] (522s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[499.911850] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[499.916454] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[500.009850] [117/133] (522s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[500.105307] Starting subtest: compare-crc-sanitycheck-nv12
[500.107606] Starting dynamic subtest: pipe-A-eDP-1
[500.764175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.658s)
[500.776518] Starting dynamic subtest: pipe-B-eDP-1
[502.071488] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.304s)
[502.080980] Starting dynamic subtest: pipe-C-eDP-1
[503.272990] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[503.287426] Starting dynamic subtest: pipe-D-eDP-1
[504.523827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[504.526089] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.417s)
[505.369592] [118/133] (517s left) gem_mmap_gtt (fault-concurrent-y)
[505.419232] Subtest fault-concurrent-Y: SKIP (0.000s)
[505.484620] [119/133] (516s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[505.541462] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[505.611736] [120/133] (516s left) api_intel_bb (render-ccs)
[505.661391] Starting subtest: render-ccs
[506.022579] Subtest render-ccs: SUCCESS (0.361s)
[506.149665] [121/133] (516s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[506.252642] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[506.255070] Starting dynamic subtest: pipe-A-eDP-1
[506.281222] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[506.291931] Starting dynamic subtest: pipe-B-eDP-1
[506.315560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[506.324295] Starting dynamic subtest: pipe-C-eDP-1
[506.347815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[506.356548] Starting dynamic subtest: pipe-D-eDP-1
[506.380546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[506.384557] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[508.428185] [122/133] (514s left) gem_exec_whisper (basic-contexts-all)
[508.485107] Starting subtest: basic-contexts-all
[520.136009] Subtest basic-contexts-all: SUCCESS (11.642s)
[520.333629] [123/133] (502s left) kms_flip (busy-flip)
[520.429584] Starting subtest: busy-flip
[520.431918] Starting dynamic subtest: A-eDP1
[522.122763] Dynamic subtest A-eDP1: SUCCESS (1.692s)
[522.134467] Starting dynamic subtest: B-eDP1
[523.858433] Dynamic subtest B-eDP1: SUCCESS (1.733s)
[523.872477] Starting dynamic subtest: C-eDP1
[525.597036] Dynamic subtest C-eDP1: SUCCESS (1.719s)
[525.617696] Starting dynamic subtest: D-eDP1
[527.221939] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[527.227421] Subtest busy-flip: SUCCESS (6.795s)
[528.381687] [124/133] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[528.483180] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[532.835288] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.354s)
[533.991042] [125/133] (488s left) kms_dp_linktrain_fallback (dsc-fallback)
[534.071272] Starting subtest: dsc-fallback
[534.078055] Subtest dsc-fallback: SKIP (0.000s)
[534.147175] [126/133] (488s left) gem_exec_alignment (single)
[534.217660] Starting subtest: single
[534.220020] Subtest single: SUCCESS (0.002s)
[534.332235] [127/133] (488s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[534.429170] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[534.433649] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[534.530716] [128/133] (488s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[534.617202] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[534.619415] Starting dynamic subtest: pipe-A-eDP-1
[534.641318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[534.652059] Starting dynamic subtest: pipe-B-eDP-1
[534.672480] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[534.680931] Starting dynamic subtest: pipe-C-eDP-1
[534.701573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[534.709976] Starting dynamic subtest: pipe-D-eDP-1
[534.731013] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[534.734867] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[536.864297] [129/133] (485s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[536.976257] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[536.979270] Starting dynamic subtest: pipe-A-eDP-1
[537.070278] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[537.081105] Starting dynamic subtest: pipe-B-eDP-1
[538.251014] Dynamic subtest pipe-B-eDP-1: SKIP (1.178s)
[538.255188] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.280s)
[539.434781] [130/133] (483s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[539.493204] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[539.578246] [131/133] (483s left) gem_exec_fence (syncobj-channel)
[540.053390] Starting subtest: syncobj-channel
[541.072203] Subtest syncobj-channel: SUCCESS (1.014s)
[541.372758] [132/133] (481s left) kms_cursor_crc (cursor-random-256x256)
[541.604021] Starting subtest: cursor-random-256x256
[541.612349] Starting dynamic subtest: pipe-A-eDP-1
[544.957610] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[544.983727] Starting dynamic subtest: pipe-D-eDP-1
[548.956309] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.982s)
[548.958897] Subtest cursor-random-256x256: SUCCESS (7.353s)
[549.801810] [133/133] (473s left) syncobj_wait (reset-signaled)
[549.865862] Starting subtest: reset-signaled
[549.867808] Subtest reset-signaled: SUCCESS (0.000s)
[549.965706] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: tools_test
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: gem_softpin
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_ctx_exec
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_draw_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_ctx_shared
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: api_intel_allocator
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_ccs
results: parsing output: 18/ for test: gem_ctx_create
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_vrr
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: drm_read
results: parsing output: 27/ for test: gem_wait
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_chamelium_edid
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_basic
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: gem_render_linear_blits
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_request_retire
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen7_exec_parse
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_render_copy_redux
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_setmode
results: parsing output: 76/ for test: kms_selftest
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: sysfs_defaults
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pm_backlight
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: i915_power
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: i915_module_load
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: sriov_basic
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_plane_lowres
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_cs_tlb
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: template
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: gem_pread
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_dp_linktrain_fallback
results: parsing output: 125/ for test: gem_exec_alignment
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: syncobj_wait
Done.