[102.837226] Initializing watchdogs
[102.837274]   /dev/watchdog0
[102.855027] [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]
[102.859943] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.862860] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.864877] [001/133] (960s left) perf_pmu (render-node-busy)
[102.942859] Starting subtest: render-node-busy
[102.944313] Starting dynamic subtest: rcs0
[103.535572] Dynamic subtest rcs0: SUCCESS (0.592s)
[103.544647] Starting dynamic subtest: bcs0
[104.098660] Dynamic subtest bcs0: SUCCESS (0.562s)
[104.107696] Starting dynamic subtest: vcs0
[105.951323] Dynamic subtest vcs0: SUCCESS (1.842s)
[105.960639] Starting dynamic subtest: vcs1
[107.934042] Dynamic subtest vcs1: SUCCESS (1.982s)
[107.940997] Starting dynamic subtest: vecs0
[109.920300] Dynamic subtest vecs0: SUCCESS (1.984s)
[109.927963] Starting dynamic subtest: ccs0
[110.474249] Dynamic subtest ccs0: SUCCESS (0.562s)
[110.475586] Subtest render-node-busy: SUCCESS (7.531s)
[110.541394] [002/133] (952s left) gem_exec_balancer (full)
[110.600999] Starting subtest: full
[115.786468] Subtest full: SUCCESS (5.184s)
[116.090544] [003/133] (947s left) perf_pmu (rc6)
[116.126975] Starting subtest: rc6
[116.127972] Starting dynamic subtest: gt0
[122.504506] Dynamic subtest gt0: SUCCESS (6.368s)
[122.514440] Starting dynamic subtest: runtime-pm-gt0
[130.243824] Dynamic subtest runtime-pm-gt0: SUCCESS (7.737s)
[130.253434] Starting dynamic subtest: runtime-pm-long-gt0
[142.746486] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.502s)
[142.755256] Starting dynamic subtest: other-idle-gt0
[149.089354] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[149.097429] Starting dynamic subtest: gt1
[155.431037] Dynamic subtest gt1: SUCCESS (6.340s)
[155.439913] Starting dynamic subtest: runtime-pm-gt1
[162.872568] Dynamic subtest runtime-pm-gt1: SUCCESS (7.439s)
[162.881850] Starting dynamic subtest: runtime-pm-long-gt1
[175.364062] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.490s)
[175.373344] Starting dynamic subtest: other-idle-gt1
[181.707731] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[181.709115] Subtest rc6: SUCCESS (65.570s)
[182.307792] [004/133] (881s left) kms_selftest (drm_plane_helper)
[182.342524] Starting subtest: drm_plane_helper
[182.348324] Starting dynamic subtest: drm_test_check_plane_state
[182.438889] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.091s)
[182.446952] Starting dynamic subtest: drm_test_check_invalid_plane_state
[182.522929] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.084s)
[182.524039] Subtest drm_plane_helper: SUCCESS (0.180s)
[182.644202] [005/133] (880s left) gem_exec_schedule (pi-userfault)
[182.826137] Starting subtest: pi-userfault
[182.827061] Starting dynamic subtest: rcs0
[182.828269] Dynamic subtest rcs0: SUCCESS (0.010s)
[182.837785] Starting dynamic subtest: bcs0
[182.838741] Dynamic subtest bcs0: SUCCESS (0.008s)
[182.845228] Starting dynamic subtest: vcs0
[182.845964] Dynamic subtest vcs0: SUCCESS (0.009s)
[182.852420] Starting dynamic subtest: vcs1
[182.855823] Dynamic subtest vcs1: SUCCESS (0.009s)
[182.865955] Starting dynamic subtest: vecs0
[182.866864] Dynamic subtest vecs0: SUCCESS (0.010s)
[182.876802] Starting dynamic subtest: ccs0
[182.877952] Dynamic subtest ccs0: SUCCESS (0.008s)
[182.879017] Subtest pi-userfault: SUCCESS (0.058s)
[183.033154] [006/133] (880s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[183.144894] Starting subtest: basic-flip-before-cursor-varying-size
[184.118064] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.973s)
[184.962648] [007/133] (878s left) kms_async_flips (crc-atomic)
[185.047945] Starting subtest: crc-atomic
[185.422958] Starting dynamic subtest: pipe-A-eDP-1
[188.308609] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.885s)
[188.683372] Starting dynamic subtest: pipe-B-eDP-1
[191.651641] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.975s)
[192.036047] Starting dynamic subtest: pipe-C-eDP-1
[194.945197] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.916s)
[195.319078] Starting dynamic subtest: pipe-D-eDP-1
[198.165926] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.852s)
[198.167423] Subtest crc-atomic: SUCCESS (13.118s)
[199.314296] [008/133] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[199.423425] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[199.425383] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[199.492542] [009/133] (864s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[199.581361] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[206.651411] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.069s)
[206.746364] [010/133] (856s left) sysfs_timeslice_duration (idempotent)
[206.812255] Starting subtest: idempotent
[206.813233] Starting dynamic subtest: vecs0
[206.814141] Dynamic subtest vecs0: SUCCESS (0.000s)
[206.821453] Starting dynamic subtest: ccs0
[206.822362] Dynamic subtest ccs0: SUCCESS (0.000s)
[206.828453] Starting dynamic subtest: vcs0
[206.829340] Dynamic subtest vcs0: SUCCESS (0.000s)
[206.835611] Starting dynamic subtest: bcs0
[206.836483] Dynamic subtest bcs0: SUCCESS (0.000s)
[206.842895] Starting dynamic subtest: rcs0
[206.843939] Dynamic subtest rcs0: SUCCESS (0.000s)
[206.850165] Starting dynamic subtest: vcs1
[206.851056] Dynamic subtest vcs1: SUCCESS (0.000s)
[206.851933] Subtest idempotent: SUCCESS (0.004s)
[206.901441] [011/133] (856s left) kms_plane_multiple (2x-tiling-x)
[207.005400] Starting subtest: 2x-tiling-x
[207.007359] Subtest 2x-tiling-x: SKIP (0.000s)
[207.047537] [012/133] (856s left) kms_lease (empty-lease)
[207.139605] Starting subtest: empty-lease
[207.140775] Starting dynamic subtest: pipe-A-eDP-1
[207.141732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[207.150222] Starting dynamic subtest: pipe-B-eDP-1
[207.151060] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[207.157471] Starting dynamic subtest: pipe-C-eDP-1
[207.158381] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[207.164940] Starting dynamic subtest: pipe-D-eDP-1
[207.165869] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[207.166897] Subtest empty-lease: SUCCESS (0.007s)
[207.226766] [013/133] (856s left) gem_exec_schedule (submit-late-slice)
[207.288059] Starting subtest: submit-late-slice
[207.288987] Starting dynamic subtest: rcs0
[207.324116] Dynamic subtest rcs0: SUCCESS (0.036s)
[207.335205] Starting dynamic subtest: bcs0
[207.354019] Dynamic subtest bcs0: SUCCESS (0.030s)
[207.360806] Starting dynamic subtest: vcs0
[207.388110] Dynamic subtest vcs0: SUCCESS (0.034s)
[207.396859] Starting dynamic subtest: vcs1
[207.420097] Dynamic subtest vcs1: SUCCESS (0.032s)
[207.427616] Starting dynamic subtest: vecs0
[207.453778] Dynamic subtest vecs0: SUCCESS (0.033s)
[207.460407] Starting dynamic subtest: ccs0
[207.494277] Dynamic subtest ccs0: SUCCESS (0.040s)
[207.495373] Subtest submit-late-slice: SUCCESS (0.206s)
[208.974539] [014/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[209.057356] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[209.059021] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[209.108017] [015/133] (854s left) syncobj_timeline (multi-wait-submitted-signaled)
[209.155250] Starting subtest: multi-wait-submitted-signaled
[209.156152] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[209.217105] [016/133] (854s left) kms_invalid_mode (bad-htotal)
[209.308283] Starting subtest: bad-htotal
[209.309224] Starting dynamic subtest: pipe-A-eDP-1
[209.597336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[209.604268] Starting dynamic subtest: pipe-B-eDP-1
[209.605200] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[209.611490] Starting dynamic subtest: pipe-C-eDP-1
[209.612366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[209.618713] Starting dynamic subtest: pipe-D-eDP-1
[209.619627] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[209.620514] Subtest bad-htotal: SUCCESS (0.294s)
[210.440478] [017/133] (853s left) kms_addfb_basic (bad-pitch-0)
[210.482330] Starting subtest: bad-pitch-0
[210.483350] Subtest bad-pitch-0: SUCCESS (0.000s)
[210.597619] [018/133] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[210.689086] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[217.519105] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.832s)
[217.642884] [019/133] (846s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[217.735510] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[217.747175] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[217.788876] [020/133] (846s left) i915_drm_fdinfo (busy-check-all)
[217.821721] Starting subtest: busy-check-all
[217.823505] Starting dynamic subtest: rcs0
[217.826275] Dynamic subtest rcs0: SKIP (0.003s)
[217.833041] Starting dynamic subtest: bcs0
[217.834760] Dynamic subtest bcs0: SKIP (0.000s)
[217.841494] Starting dynamic subtest: vcs0
[217.843059] Dynamic subtest vcs0: SKIP (0.000s)
[217.849495] Starting dynamic subtest: vcs1
[217.851200] Dynamic subtest vcs1: SKIP (0.000s)
[217.857491] Starting dynamic subtest: vecs0
[217.859081] Dynamic subtest vecs0: SKIP (0.001s)
[217.865400] Starting dynamic subtest: ccs0
[217.867040] Dynamic subtest ccs0: SKIP (0.000s)
[217.868838] Subtest busy-check-all: SKIP (0.007s)
[217.894569] [021/133] (846s left) syncobj_wait (single-wait-for-submit-signaled)
[217.978811] Starting subtest: single-wait-for-submit-signaled
[217.980259] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[218.058117] [022/133] (845s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[218.149301] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[218.151080] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[218.220854] [023/133] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[218.315301] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[224.885914] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.572s)
[224.969251] [024/133] (839s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[225.018979] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[225.121815] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[225.168240] [025/133] (838s left) gem_exec_alignment (pi)
[225.219661] Starting subtest: pi
[278.419242] Subtest pi: SUCCESS (53.196s)
[279.481251] [026/133] (784s left) syncobj_wait (invalid-signal-bad-pad)
[279.578947] Starting subtest: invalid-signal-bad-pad
[279.579945] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[279.670995] [027/133] (784s left) i915_drm_fdinfo (virtual-idle)
[279.709143] Starting subtest: virtual-idle
[282.782861] Subtest virtual-idle: SUCCESS (3.069s)
[282.818312] [028/133] (781s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[282.941021] Starting subtest: x-tiled-32bpp-rotate-270
[282.960640] Subtest x-tiled-32bpp-rotate-270: SKIP (0.018s)
[283.047592] [029/133] (781s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[283.138384] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[283.140081] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[283.207315] [030/133] (781s left) kms_fence_pin_leak
[283.351504] [031/133] (781s left) gem_create (create-ext-set-pat)
[283.514504] Starting subtest: create-ext-set-pat
[283.515728] Subtest create-ext-set-pat: SUCCESS (0.001s)
[283.577806] [032/133] (780s left) gen9_exec_parse (bb-secure)
[283.622721] Subtest bb-secure: SKIP (0.000s)
[283.684812] [033/133] (780s left) prime_mmap (test_correct_cpu_write)
[283.733606] Starting subtest: test_correct_cpu_write
[283.734681] Starting dynamic subtest: test_correct_cpu_write-smem
[283.735650] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[283.736730] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[283.796504] [034/133] (780s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[283.876667] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[283.877776] Starting dynamic subtest: pipe-A-eDP-1
[283.887899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.898080] Starting dynamic subtest: pipe-B-eDP-1
[283.907047] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.914461] Starting dynamic subtest: pipe-C-eDP-1
[283.922670] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.929604] Starting dynamic subtest: pipe-D-eDP-1
[283.938569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.940248] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[286.060754] [035/133] (778s left) kms_chamelium_edid (dp-edid-resolution-list)
[287.231422] Subtest dp-edid-resolution-list: SKIP (0.000s)
[287.530078] [036/133] (777s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[287.629346] Starting subtest: y-tiled-8bpp-rotate-180
[287.631059] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[287.711278] [037/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[287.798563] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[287.800365] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[287.861413] [038/133] (776s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[287.943796] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[287.955083] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[288.002302] [039/133] (776s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[288.087392] Starting subtest: coverage-vs-premult-vs-constant
[288.382032] Starting dynamic subtest: pipe-A-eDP-1
[288.967675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[288.979067] Starting dynamic subtest: pipe-D-eDP-1
[290.273800] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[290.275014] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.187s)
[291.105310] [040/133] (773s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[291.219449] Starting subtest: yf-tiled-16bpp-rotate-270
[291.221244] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[291.292781] [041/133] (773s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[291.375785] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[291.377610] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[291.427105] [042/133] (773s left) gem_render_copy (linear-to-vebox-y-tiled)
[291.486980] Starting subtest: linear-to-vebox-y-tiled
[291.488935] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[291.648507] [043/133] (773s left) kms_psr (psr2-cursor-render)
[291.742526] Starting subtest: psr2-cursor-render
[291.743441] Starting dynamic subtest: eDP-1
[293.432393] Dynamic subtest eDP-1: SUCCESS (1.690s)
[293.433321] Subtest psr2-cursor-render: SUCCESS (1.691s)
[294.288059] [044/133] (770s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[294.381097] Starting subtest: fbc-psr2-sprite-plane-onoff
[294.381931] Starting dynamic subtest: eDP-1
[294.383687] Dynamic subtest eDP-1: SKIP (0.000s)
[294.385463] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[294.421722] [045/133] (770s left) gem_exercise_blt (fast-copy)
[294.480990] Starting subtest: fast-copy
[294.481976] Starting dynamic subtest: linear-smem-smem
[294.507469] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[294.517278] Starting dynamic subtest: xmajor-smem-smem
[294.527911] Dynamic subtest xmajor-smem-smem: SUCCESS (0.020s)
[294.535345] Starting dynamic subtest: tile4-smem-smem
[294.546538] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[294.553570] Starting dynamic subtest: tile64-smem-smem
[294.564143] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[294.564953] Subtest fast-copy: SUCCESS (0.084s)
[294.637778] [046/133] (770s left) core_getclient (basic)
[294.691403] Starting subtest: basic
[294.692401] Subtest basic: SUCCESS (0.000s)
[294.760057] [047/133] (770s left) kms_addfb_basic (small-bo)
[294.837280] Starting subtest: small-bo
[294.838323] Subtest small-bo: SUCCESS (0.000s)
[294.904131] [048/133] (770s left) gem_spin_batch (spin-all)
[294.968667] Starting subtest: spin-all
[294.982639] Subtest spin-all: SUCCESS (0.014s)
[296.935445] [049/133] (768s left) gem_userptr_blits (unsync-unmap-cycles)
[296.998204] Subtest unsync-unmap-cycles: SKIP (0.000s)
[297.086364] [050/133] (767s left) gem_pread (self)
[297.142270] Subtest self: SKIP (0.000s)
[297.194534] [051/133] (767s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[297.290284] Starting subtest: plane-all-transition-nonblocking-fencing
[297.291287] Starting dynamic subtest: pipe-A-eDP-1
[299.790085] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[300.095473] Starting dynamic subtest: pipe-B-eDP-1
[303.349267] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.261s)
[303.652195] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.362s)
[304.446074] [052/133] (760s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[304.549085] Starting subtest: fbc-rgb101010-draw-mmap-wc
[309.181840] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.633s)
[310.342926] [053/133] (754s left) i915_query (hwconfig_table)
[310.392193] Starting subtest: hwconfig_table
[310.498305] Subtest hwconfig_table: SUCCESS (0.001s)
[310.525072] [054/133] (754s left) syncobj_eventfd (invalid-bad-pad)
[310.574636] Starting subtest: invalid-bad-pad
[310.575548] Subtest invalid-bad-pad: SUCCESS (0.000s)
[310.645749] [055/133] (754s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[310.763568] Starting subtest: basic-busy-flip-before-cursor-varying-size
[310.765352] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[310.876523] [056/133] (754s left) kms_addfb_basic (bad-pitch-32)
[310.924730] Starting subtest: bad-pitch-32
[310.925632] Subtest bad-pitch-32: SUCCESS (0.000s)
[311.014202] [057/133] (754s left) api_intel_bb (blit-reloc-purge-cache)
[311.070058] Starting subtest: blit-reloc-purge-cache
[311.071929] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[311.152847] [058/133] (754s left) kms_chamelium_color (ctm-0-25)
[311.233488] Subtest ctm-0-25: SKIP (0.000s)
[311.274711] [059/133] (753s left) dmabuf_sync_file (export-before-signal)
[311.393854] Starting subtest: export-before-signal
[311.394917] Subtest export-before-signal: SUCCESS (0.001s)
[311.424864] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[311.426884] [060/133] (753s left) kms_fbcon_fbt (psr)
[311.489059] Starting subtest: psr
[318.794377] Subtest psr: SUCCESS (7.294s)
[318.855914] [061/133] (746s left) kms_color (ctm-green-to-red)
[318.948619] Starting subtest: ctm-green-to-red
[318.949610] Starting dynamic subtest: pipe-A-eDP-1
[319.649363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[319.656527] Starting dynamic subtest: pipe-B-eDP-1
[321.116186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.467s)
[321.123624] Starting dynamic subtest: pipe-C-eDP-1
[322.477192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.360s)
[322.484413] Starting dynamic subtest: pipe-D-eDP-1
[323.844827] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.366s)
[323.845744] Subtest ctm-green-to-red: SUCCESS (4.896s)
[324.619704] [062/133] (740s left) syncobj_wait (wait-all-delayed-signal)
[324.665797] Starting subtest: wait-all-delayed-signal
[324.768902] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[324.815861] [063/133] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[324.903678] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[324.905451] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[324.964943] [064/133] (740s left) syncobj_wait (single-wait-all-for-submit-submitted)
[325.020392] Starting subtest: single-wait-all-for-submit-submitted
[325.140218] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[325.177378] [065/133] (740s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[325.226760] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[325.228451] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[325.378054] [066/133] (740s left) kms_dsc (dsc-with-output-formats)
[325.473855] Starting subtest: dsc-with-output-formats
[325.482495] Subtest dsc-with-output-formats: SKIP (0.001s)
[325.526672] [067/133] (740s left) kms_psr (fbc-psr2-primary-render)
[325.614667] Starting subtest: fbc-psr2-primary-render
[325.615755] Starting dynamic subtest: eDP-1
[325.617723] Dynamic subtest eDP-1: SKIP (0.000s)
[325.619465] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[325.658469] [068/133] (739s left) gem_exec_reloc (basic-wc)
[325.724627] Subtest basic-wc: SKIP (0.000s)
[325.787736] [069/133] (739s left) kms_chamelium_hpd (vga-hpd)
[326.170338] Subtest vga-hpd: SKIP (0.000s)
[326.954927] [070/133] (738s left) prime_busy (hang)
[326.999233] Starting subtest: hang
[327.001565] Starting dynamic subtest: rcs0
[353.458632] Dynamic subtest rcs0: SUCCESS (26.455s)
[353.468570] Starting dynamic subtest: bcs0
[360.549219] Dynamic subtest bcs0: SUCCESS (7.087s)
[360.558436] Starting dynamic subtest: vcs0
[367.585695] Dynamic subtest vcs0: SUCCESS (7.037s)
[367.593439] Starting dynamic subtest: vcs1
[374.560297] Dynamic subtest vcs1: SUCCESS (6.974s)
[374.569870] Starting dynamic subtest: vecs0
[381.538233] Dynamic subtest vecs0: SUCCESS (6.975s)
[381.548232] Starting dynamic subtest: ccs0
[395.438762] Dynamic subtest ccs0: SUCCESS (13.900s)
[395.439840] Subtest hang: SUCCESS (68.435s)
[395.540710] [071/133] (670s left) gem_mmap_offset (perf)
[395.587894] Starting subtest: perf
[395.588782] Starting dynamic subtest: smem0
[395.959980] Dynamic subtest smem0: SUCCESS (0.370s)
[395.961402] Subtest perf: SUCCESS (0.371s)
[396.036709] [072/133] (669s left) kms_flip (basic-flip-vs-modeset)
[396.121999] Starting subtest: basic-flip-vs-modeset
[396.123930] Starting dynamic subtest: A-eDP1
[398.682012] Dynamic subtest A-eDP1: SUCCESS (2.557s)
[398.693833] Starting dynamic subtest: B-eDP1
[400.828660] Dynamic subtest B-eDP1: SUCCESS (2.146s)
[400.836127] Starting dynamic subtest: C-eDP1
[402.996905] Dynamic subtest C-eDP1: SUCCESS (2.166s)
[403.004722] Starting dynamic subtest: D-eDP1
[405.161177] Dynamic subtest D-eDP1: SUCCESS (2.164s)
[405.163098] Subtest basic-flip-vs-modeset: SUCCESS (9.041s)
[405.935803] [073/133] (659s left) kms_atomic_interruptible (legacy-setmode)
[406.032596] Starting subtest: legacy-setmode
[406.033554] Starting dynamic subtest: pipe-A-eDP-1
[412.961339] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.928s)
[412.962147] Subtest legacy-setmode: SUCCESS (6.929s)
[413.804672] [074/133] (651s left) gem_vm_create (isolation)
[413.854375] Starting subtest: isolation
[413.862885] Subtest isolation: SUCCESS (0.008s)
[413.953912] [075/133] (651s left) gem_pread (display)
[414.002907] Subtest display: SKIP (0.000s)
[414.072508] [076/133] (651s left) kms_cursor_crc (cursor-random-32x10)
[414.227728] Starting subtest: cursor-random-32x10
[414.271855] Subtest cursor-random-32x10: SKIP (0.042s)
[414.505125] [077/133] (651s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[414.595406] Starting subtest: primary-y-tiled-reflect-x-180
[414.655955] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[414.730605] [078/133] (651s left) kms_big_fb (linear-16bpp-rotate-270)
[414.814600] Starting subtest: linear-16bpp-rotate-270
[414.834171] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[414.907964] [079/133] (651s left) gem_exec_reloc (basic-active)
[414.966443] Subtest basic-active: SKIP (0.000s)
[415.039941] [080/133] (650s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[415.129673] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[415.131337] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[415.194068] [081/133] (650s left) gem_ctx_persistence (engines-persistence)
[415.257425] Starting subtest: engines-persistence
[415.258292] Starting dynamic subtest: rcs0
[416.084490] Dynamic subtest rcs0: SUCCESS (0.828s)
[416.095996] Starting dynamic subtest: bcs0
[416.851513] Dynamic subtest bcs0: SUCCESS (0.765s)
[416.863062] Starting dynamic subtest: vcs0
[417.623793] Dynamic subtest vcs0: SUCCESS (0.770s)
[417.634947] Starting dynamic subtest: vcs1
[418.384545] Dynamic subtest vcs1: SUCCESS (0.759s)
[418.395396] Starting dynamic subtest: vecs0
[419.154763] Dynamic subtest vecs0: SUCCESS (0.768s)
[419.166287] Starting dynamic subtest: ccs0
[419.927505] Dynamic subtest ccs0: SUCCESS (0.771s)
[419.931608] Subtest engines-persistence: SUCCESS (4.673s)
[419.978361] [082/133] (646s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[420.063510] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[420.065241] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[420.146932] [083/133] (645s left) kms_pm_dc (dc9-dpms)
[421.243429] Starting subtest: dc9-dpms
[422.668131] Subtest dc9-dpms: SUCCESS (1.424s)
[422.711077] [084/133] (643s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[422.799182] Starting subtest: async-flip-with-page-flip-events-linear
[423.182693] Starting dynamic subtest: pipe-A-eDP-1
[425.992572] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.801s)
[426.347495] Starting dynamic subtest: pipe-B-eDP-1
[429.114095] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[429.493898] Starting dynamic subtest: pipe-C-eDP-1
[432.239250] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.743s)
[432.591855] Starting dynamic subtest: pipe-D-eDP-1
[435.374856] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[435.375871] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.567s)
[436.522128] [085/133] (629s left) gem_exec_capture (userptr)
[436.588530] Starting subtest: userptr
[437.407714] Subtest userptr: SUCCESS (0.819s)
[437.482553] [086/133] (628s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[437.594027] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[437.595735] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[437.711910] [087/133] (628s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[437.807256] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[444.866743] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.059s)
[444.976276] [088/133] (621s left) kms_vrr (max-min)
[445.060474] Starting subtest: max-min
[445.063063] Subtest max-min: SKIP (0.000s)
[445.107235] [089/133] (621s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[445.194598] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[452.061882] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.868s)
[452.145521] [090/133] (614s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[452.233711] Starting subtest: invalidate-primary-flip-overlay
[462.936568] Subtest invalidate-primary-flip-overlay: SUCCESS (10.703s)
[463.012384] [091/133] (603s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[463.097244] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[463.098045] Starting dynamic subtest: pipe-A-default-mode
[465.815586] Dynamic subtest pipe-A-default-mode: SUCCESS (2.717s)
[465.816691] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.718s)
[466.655285] [092/133] (599s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[466.713031] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[466.769290] [093/133] (599s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[466.892436] Starting subtest: flip-vs-cursor-atomic
[474.166733] Subtest flip-vs-cursor-atomic: SUCCESS (7.274s)
[474.985437] [094/133] (591s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[475.037494] Starting subtest: multi-wait-all-for-submit-signaled
[475.038365] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[475.098875] [095/133] (591s left) gem_close_race (basic-process)
[475.162974] Starting subtest: basic-process
[475.215973] Subtest basic-process: SUCCESS (0.052s)
[475.370451] [096/133] (591s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[475.460700] Starting subtest: plane-upscale-20x20-with-modifiers
[475.461793] Starting dynamic subtest: pipe-A
[475.797524] Dynamic subtest pipe-A: SUCCESS (0.338s)
[475.805225] Starting dynamic subtest: pipe-B
[477.204803] Dynamic subtest pipe-B: SUCCESS (1.406s)
[477.213858] Starting dynamic subtest: pipe-C
[478.643595] Dynamic subtest pipe-C: SUCCESS (1.437s)
[478.653229] Starting dynamic subtest: pipe-D
[480.076072] Dynamic subtest pipe-D: SUCCESS (1.431s)
[480.076979] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.617s)
[481.229069] [097/133] (585s left) gem_userptr_blits (sync-unmap)
[481.290861] Starting subtest: sync-unmap
[481.303674] Subtest sync-unmap: SUCCESS (0.013s)
[481.393199] [098/133] (585s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[481.442674] Starting subtest: invalid-single-wait-all-unsubmitted
[481.443614] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[481.516957] [099/133] (585s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[481.619658] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[481.621578] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[481.685974] [100/133] (584s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[481.780921] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[481.782644] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[481.846484] [101/133] (584s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[481.957940] Starting subtest: cursorA-vs-flipB-atomic
[481.959702] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[482.073111] [102/133] (584s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[482.154500] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[482.155326] Starting dynamic subtest: pipe-A-eDP-1
[482.158505] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.166583] Starting dynamic subtest: pipe-B-eDP-1
[482.170037] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.177578] Starting dynamic subtest: pipe-C-eDP-1
[482.180809] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.188294] Starting dynamic subtest: pipe-D-eDP-1
[482.191515] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.193112] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[484.386564] [103/133] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[484.481743] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[491.826951] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.346s)
[491.913613] [104/133] (574s left) gem_ctx_persistence (file)
[491.969999] Starting subtest: file
[492.093194] Subtest file: SUCCESS (0.123s)
[492.169982] [105/133] (574s left) kms_psr (pr-primary-render)
[492.261236] Starting subtest: pr-primary-render
[492.262777] Subtest pr-primary-render: SKIP (0.000s)
[492.304098] [106/133] (574s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[492.386247] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[492.387030] Starting dynamic subtest: pipe-A-eDP-1
[492.395024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.402616] Starting dynamic subtest: pipe-B-eDP-1
[492.410670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.418144] Starting dynamic subtest: pipe-C-eDP-1
[492.426449] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.433770] Starting dynamic subtest: pipe-D-eDP-1
[492.442618] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.444406] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[494.663344] [107/133] (572s left) kms_content_protection (dp-mst-type-1)
[494.801604] Starting subtest: dp-mst-type-1
[494.803159] Subtest dp-mst-type-1: SKIP (0.000s)
[494.882720] [108/133] (571s left) gem_mmap_gtt (big-copy-odd)
[494.929688] Subtest big-copy-odd: SKIP (0.000s)
[494.989836] [109/133] (571s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[495.067754] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[495.068611] Starting dynamic subtest: pipe-A-eDP-1
[495.076419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.084645] Starting dynamic subtest: pipe-B-eDP-1
[495.092585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.100132] Starting dynamic subtest: pipe-C-eDP-1
[495.107806] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[495.115113] Starting dynamic subtest: pipe-D-eDP-1
[495.122514] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.124129] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[497.332871] [110/133] (569s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[497.457609] Starting subtest: cursor-vs-flip-toggle
[528.651780] Subtest cursor-vs-flip-toggle: SUCCESS (31.192s)
[529.462986] [111/133] (537s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[529.565269] Starting subtest: psr2-overlay-plane-update-continuous-sf
[529.566233] Starting dynamic subtest: pipe-A-eDP-1
[530.682919] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.117s)
[530.691150] Starting dynamic subtest: pipe-B-eDP-1
[532.441407] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.757s)
[532.442324] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.877s)
[533.223153] [112/133] (533s left) kms_cursor_legacy (torture-move)
[533.336455] Starting subtest: torture-move
[533.337447] Starting dynamic subtest: pipe-A
[539.211405] Dynamic subtest pipe-A: SUCCESS (5.864s)
[539.221917] Starting dynamic subtest: pipe-B
[546.944911] Dynamic subtest pipe-B: SUCCESS (7.731s)
[546.955196] Starting dynamic subtest: pipe-C
[553.692433] Dynamic subtest pipe-C: SUCCESS (6.754s)
[553.700992] Starting dynamic subtest: pipe-D
[561.260975] Dynamic subtest pipe-D: SUCCESS (7.566s)
[561.271094] Starting dynamic subtest: all-pipes
[567.695812] Dynamic subtest all-pipes: SUCCESS (6.423s)
[567.697171] Subtest torture-move: SUCCESS (34.348s)
[567.834955] [113/133] (499s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[567.943167] Starting subtest: fbc-psr2-cursor-plane-update-sf
[567.944051] Starting dynamic subtest: pipe-A-eDP-1
[568.037940] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[568.050991] Starting dynamic subtest: pipe-B-eDP-1
[569.130687] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[569.132373] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.188s)
[570.296908] [114/133] (496s left) i915_pm_rps (min-max-config-idle)
[570.355079] Starting subtest: min-max-config-idle
[570.356695] Subtest min-max-config-idle: SKIP (0.001s)
[570.422602] [115/133] (496s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[570.980696] Starting subtest: syncobj-timeline-invalid-flags
[570.981752] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[571.989974] [116/133] (495s left) syncobj_timeline (single-wait-signaled)
[572.053153] Starting subtest: single-wait-signaled
[572.054140] Subtest single-wait-signaled: SUCCESS (0.000s)
[572.120376] [117/133] (495s left) kms_pm_rpm (modeset-lpsp-stress)
[573.950385] Starting subtest: modeset-lpsp-stress
[589.827171] Subtest modeset-lpsp-stress: SUCCESS (15.877s)
[589.887651] [118/133] (477s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[589.975758] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[589.977595] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[590.020646] [119/133] (477s left) gem_busy (semaphore)
[590.205319] Subtest semaphore: SKIP (0.000s)
[590.390620] [120/133] (476s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[590.478193] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[590.506094] Starting dynamic subtest: pipe-A-plane-0
[590.928036] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[590.935853] Starting dynamic subtest: pipe-A-plane-3
[591.194740] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[592.269229] Starting dynamic subtest: pipe-B-plane-0
[592.705131] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[592.713229] Starting dynamic subtest: pipe-B-plane-3
[592.960856] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[593.270352] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.791s)
[595.181709] [121/133] (472s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[595.273938] Starting subtest: flip-vs-dpms-on-nop-interruptible
[595.275312] Starting dynamic subtest: A-eDP1
[597.103288] Dynamic subtest A-eDP1: SUCCESS (1.827s)
[597.113879] Starting dynamic subtest: B-eDP1
[598.929647] Dynamic subtest B-eDP1: SUCCESS (1.824s)
[598.944824] Starting dynamic subtest: C-eDP1
[600.750471] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[600.759906] Starting dynamic subtest: D-eDP1
[602.576980] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[602.577933] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.303s)
[603.738832] [122/133] (463s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[603.829399] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[603.884406] [123/133] (463s left) gem_exec_whisper (basic-fds)
[603.943850] Starting subtest: basic-fds
[609.957077] Subtest basic-fds: SUCCESS (6.011s)
[610.112178] [124/133] (457s left) gem_render_copy (y-tiled-ccs-to-linear)
[610.165132] Starting subtest: y-tiled-ccs-to-linear
[610.166925] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[610.323117] [125/133] (457s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[610.448120] Starting subtest: 2x-flip-vs-cursor-atomic
[610.450785] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[610.565071] [126/133] (456s left) gem_mmap_gtt (coherency)
[610.615322] Subtest coherency: SKIP (0.000s)
[610.676832] [127/133] (456s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[610.726458] Starting subtest: etime-single-wait-all-for-submit-submitted
[610.833970] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[610.890795] [128/133] (456s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[610.999297] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[611.636043] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[611.768533] [129/133] (455s left) kms_vblank (wait-busy-hang)
[611.856357] Starting subtest: wait-busy-hang
[611.857165] Starting dynamic subtest: pipe-A-eDP-1
[639.641457] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.783s)
[639.650993] Starting dynamic subtest: pipe-D-eDP-1
[654.679049] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.034s)
[654.680018] Subtest wait-busy-hang: SUCCESS (42.821s)
[655.490122] [130/133] (412s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[655.577797] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[659.192735] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.614s)
[660.286697] [131/133] (407s left) kms_cursor_crc (cursor-offscreen-512x170)
[660.591107] Starting subtest: cursor-offscreen-512x170
[660.593618] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[660.695800] [132/133] (406s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[660.787059] Starting subtest: psr-rgb101010-draw-blt
[668.255129] Subtest psr-rgb101010-draw-blt: SUCCESS (7.468s)
[668.362681] [133/133] (399s left) gem_exec_capture (capture-invisible)
[668.427028] Starting subtest: capture-invisible
[668.427967] Starting dynamic subtest: smem0
[668.429722] Dynamic subtest smem0: SKIP (0.000s)
[668.431581] Subtest capture-invisible: SKIP (0.001s)
[668.508332] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_selftest
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_async_flips
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sysfs_timeslice_duration
results: parsing output: 10/ for test: kms_plane_multiple
results: parsing output: 11/ for test: kms_lease
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: i915_drm_fdinfo
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: gem_exec_alignment
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: i915_drm_fdinfo
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_fence_pin_leak
results: parsing output: 30/ for test: gem_create
results: parsing output: 31/ for test: gen9_exec_parse
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_chamelium_edid
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_plane_alpha_blend
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_exercise_blt
results: parsing output: 45/ for test: core_getclient
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: gem_spin_batch
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: gem_pread
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_query
results: parsing output: 53/ for test: syncobj_eventfd
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_chamelium_color
results: parsing output: 58/ for test: dmabuf_sync_file
results: parsing output: 59/ for test: kms_fbcon_fbt
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_dsc
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: prime_busy
results: parsing output: 70/ for test: gem_mmap_offset
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_atomic_interruptible
results: parsing output: 73/ for test: gem_vm_create
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_pm_dc
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: gem_exec_capture
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_vrr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr_stress_test
results: parsing output: 90/ for test: kms_flip_scaled_crc
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: gem_close_race
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: gem_userptr_blits
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: i915_pm_rps
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gem_busy
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: gem_render_copy
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_capture
Done.