[57.221154] Initializing watchdogs
[57.221199]   /dev/watchdog0
[57.235353] [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.239683] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.242097] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.245512] [001/132] (960s left) kms_pm_dc (dc5-psr)
[58.378703] Starting subtest: dc5-psr
[61.274879] Subtest dc5-psr: SUCCESS (2.897s)
[62.086655] [002/132] (955s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[62.197872] Starting subtest: cursorA-vs-flipA-toggle
[73.351116] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.152s)
[74.195858] [003/132] (943s left) gem_exec_reloc (basic-gtt-read-noreloc)
[74.267963] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[74.352560] [004/132] (943s left) gem_exec_params (secure-non-root)
[74.413019] Starting subtest: secure-non-root
[74.417394] Subtest secure-non-root: SKIP (0.000s)
[74.519059] [005/132] (943s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[74.621928] Starting subtest: fbcpsr-slowdraw
[99.793637] Subtest fbcpsr-slowdraw: SUCCESS (25.176s)
[99.957639] [006/132] (917s left) gem_ccs (block-copy-uncompressed)
[100.030324] Starting subtest: block-copy-uncompressed
[100.032611] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[100.052017] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[100.061759] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[100.069867] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[100.077081] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[100.086949] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[100.094171] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[100.104025] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[100.106362] Subtest block-copy-uncompressed: SUCCESS (0.074s)
[100.218331] [007/132] (917s left) kms_flip (2x-flip-vs-fences)
[100.307990] Starting subtest: 2x-flip-vs-fences
[100.312336] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[100.393083] [008/132] (917s left) syncobj_timeline (etime-single-wait-all-submitted)
[100.435907] Starting subtest: etime-single-wait-all-submitted
[100.539402] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[100.610437] [009/132] (917s left) kms_psr (pr-cursor-mmap-cpu)
[100.695504] Starting subtest: pr-cursor-mmap-cpu
[100.700039] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[100.765598] [010/132] (917s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[100.853059] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[100.855301] Starting dynamic subtest: pipe-A
[100.872442] Dynamic subtest pipe-A: SKIP (0.017s)
[100.880838] Starting dynamic subtest: pipe-B
[100.916487] Dynamic subtest pipe-B: SKIP (0.041s)
[100.924102] Starting dynamic subtest: pipe-C
[100.950276] Dynamic subtest pipe-C: SKIP (0.034s)
[100.957256] Starting dynamic subtest: pipe-D
[100.991515] Dynamic subtest pipe-D: SKIP (0.042s)
[100.995706] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.136s)
[101.110522] [011/132] (917s left) gem_ctx_isolation (clean)
[101.169482] Starting subtest: clean
[101.171753] Starting dynamic subtest: rcs0
[101.218865] Dynamic subtest rcs0: SUCCESS (0.049s)
[101.226453] Starting dynamic subtest: bcs0
[101.286661] Dynamic subtest bcs0: SUCCESS (0.067s)
[101.293749] Starting dynamic subtest: vcs0
[101.351069] Dynamic subtest vcs0: SUCCESS (0.064s)
[101.360818] Starting dynamic subtest: vcs1
[102.933648] Dynamic subtest vcs1: SUCCESS (1.582s)
[102.943371] Starting dynamic subtest: vecs0
[104.916830] Dynamic subtest vecs0: SUCCESS (1.983s)
[104.925916] Starting dynamic subtest: ccs0
[106.904137] Dynamic subtest ccs0: SUCCESS (1.987s)
[106.906664] Subtest clean: SUCCESS (5.735s)
[107.122811] [012/132] (911s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[107.222647] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[107.224885] Starting dynamic subtest: pipe-A-eDP-1
[107.249463] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.258192] Starting dynamic subtest: pipe-B-eDP-1
[107.281252] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.288070] Starting dynamic subtest: pipe-C-eDP-1
[107.310689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.320283] Starting dynamic subtest: pipe-D-eDP-1
[107.343818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.348181] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[109.406407] [013/132] (908s left) kms_color (ctm-0-50)
[109.502541] Starting subtest: ctm-0-50
[109.504429] Starting dynamic subtest: pipe-A-eDP-1
[113.029280] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.527s)
[113.037534] Starting dynamic subtest: pipe-B-eDP-1
[117.318688] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.289s)
[117.327241] Starting dynamic subtest: pipe-C-eDP-1
[121.347774] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.025s)
[121.356096] Starting dynamic subtest: pipe-D-eDP-1
[125.345630] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[125.348057] Subtest ctm-0-50: SUCCESS (15.842s)
[126.151603] [014/132] (892s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[126.250745] Starting subtest: fbcpsr-modesetfrombusy
[132.515222] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.269s)
[132.663382] [015/132] (885s left) gem_eio (create)
[132.875751] Starting subtest: create
[133.171252] Subtest create: SUCCESS (0.295s)
[133.331480] [016/132] (885s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[133.423149] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[133.426794] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[133.491866] [017/132] (884s left) gem_exec_balancer (smoke)
[133.549891] Starting subtest: smoke
[156.079645] Subtest smoke: SUCCESS (22.522s)
[157.179020] [018/132] (861s left) kms_lease (page-flip-implicit-plane)
[157.277848] Starting subtest: page-flip-implicit-plane
[157.280225] Starting dynamic subtest: pipe-A-eDP-1
[157.754845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[157.764731] Starting dynamic subtest: pipe-B-eDP-1
[158.916608] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[158.925441] Starting dynamic subtest: pipe-C-eDP-1
[160.038027] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[160.047601] Starting dynamic subtest: pipe-D-eDP-1
[161.160737] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[161.162920] Subtest page-flip-implicit-plane: SUCCESS (3.883s)
[161.996667] [019/132] (856s left) gem_exec_params (rsvd2-dirt)
[162.062575] Starting subtest: rsvd2-dirt
[162.067219] Subtest rsvd2-dirt: SKIP (0.000s)
[162.153814] [020/132] (856s left) gem_exec_reloc (basic-write-wc-active)
[162.216710] Subtest basic-write-wc-active: SKIP (0.000s)
[162.293740] [021/132] (856s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[162.682869] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[163.504186] [022/132] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[163.614129] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[163.618676] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[163.713884] [023/132] (854s left) kms_plane_scaling (intel-max-src-size)
[163.805912] Starting subtest: intel-max-src-size
[163.812435] Subtest intel-max-src-size: SKIP (0.000s)
[163.903059] [024/132] (854s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[163.956741] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[164.016379] [025/132] (854s left) gem_ctx_exec (basic-close-race)
[164.082634] Starting subtest: basic-close-race
[169.768590] Subtest basic-close-race: SUCCESS (5.684s)
[169.905816] [026/132] (848s left) kms_properties (invalid-properties-atomic)
[170.005721] Starting subtest: invalid-properties-atomic
[170.314152] Subtest invalid-properties-atomic: SUCCESS (0.308s)
[170.386768] [027/132] (848s left) drm_read (short-buffer-nonblock)
[170.532017] Starting subtest: short-buffer-nonblock
[170.534546] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[170.679428] [028/132] (848s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[170.744601] Subtest untiled-to-tiled: SKIP (0.000s)
[170.809587] [029/132] (848s left) kms_cursor_crc (cursor-offscreen-256x85)
[171.079566] Starting subtest: cursor-offscreen-256x85
[171.126566] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[171.320384] [030/132] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[171.418723] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[178.751417] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.334s)
[178.872298] [031/132] (840s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[178.984228] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[178.986626] Starting dynamic subtest: pipe-A-eDP-1
[179.009670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.019239] Starting dynamic subtest: pipe-B-eDP-1
[179.040631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.047858] Starting dynamic subtest: pipe-C-eDP-1
[179.068979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.076637] Starting dynamic subtest: pipe-D-eDP-1
[179.098142] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.102572] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[181.248507] [032/132] (837s left) kms_psr (fbc-psr-primary-blt)
[181.354981] Starting subtest: fbc-psr-primary-blt
[181.357238] Starting dynamic subtest: eDP-1
[181.361301] Dynamic subtest eDP-1: SKIP (0.000s)
[181.365294] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[181.457375] [033/132] (837s left) gem_spin_batch (legacy-resubmit-new)
[181.519914] Starting subtest: legacy-resubmit-new
[181.522251] Starting dynamic subtest: default
[181.527042] Dynamic subtest default: SUCCESS (0.006s)
[181.536490] Starting dynamic subtest: render
[181.538586] Dynamic subtest render: SUCCESS (0.003s)
[181.546132] Starting dynamic subtest: bsd
[181.548367] Dynamic subtest bsd: SUCCESS (0.004s)
[181.555652] Starting dynamic subtest: bsd1
[181.557502] Dynamic subtest bsd1: SUCCESS (0.003s)
[181.564454] Starting dynamic subtest: bsd2
[181.566324] Dynamic subtest bsd2: SUCCESS (0.005s)
[181.573326] Starting dynamic subtest: blt
[181.575166] Dynamic subtest blt: SUCCESS (0.004s)
[181.582116] Starting dynamic subtest: vebox
[181.583963] Dynamic subtest vebox: SUCCESS (0.004s)
[181.585894] Subtest legacy-resubmit-new: SUCCESS (0.035s)
[182.983872] [034/132] (836s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[183.046479] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[183.048914] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[183.142439] [035/132] (835s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[183.749161] Starting subtest: syncobj-timeline-invalid-wait
[183.752192] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[184.971688] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[184.975207] [036/132] (834s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[185.035403] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[185.095517] [037/132] (834s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[185.206221] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[185.208834] Starting dynamic subtest: pipe-A-eDP-1
[185.322751] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[185.331804] Starting dynamic subtest: pipe-B-eDP-1
[186.501234] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[186.505740] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.299s)
[187.674244] [038/132] (831s left) prime_vgem (wait)
[187.747309] Starting subtest: wait
[187.749313] Starting dynamic subtest: rcs0
[187.782506] Dynamic subtest rcs0: SUCCESS (0.038s)
[187.790522] Starting dynamic subtest: bcs0
[187.841066] Dynamic subtest bcs0: SUCCESS (0.058s)
[187.849681] Starting dynamic subtest: vcs0
[187.886230] Dynamic subtest vcs0: SUCCESS (0.044s)
[187.894300] Starting dynamic subtest: vcs1
[187.932350] Dynamic subtest vcs1: SUCCESS (0.045s)
[187.940560] Starting dynamic subtest: vecs0
[187.980383] Dynamic subtest vecs0: SUCCESS (0.047s)
[187.988510] Starting dynamic subtest: ccs0
[188.026524] Dynamic subtest ccs0: SUCCESS (0.045s)
[188.028717] Subtest wait: SUCCESS (0.283s)
[188.137441] [039/132] (831s left) kms_atomic_transition (plane-toggle-modeset-transition)
[188.228053] Starting subtest: plane-toggle-modeset-transition
[188.229988] Starting dynamic subtest: pipe-A-eDP-1
[200.885448] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.655s)
[200.895844] Starting dynamic subtest: pipe-B-eDP-1
[213.325071] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.433s)
[213.327893] Subtest plane-toggle-modeset-transition: SUCCESS (25.096s)
[214.140470] [040/132] (805s left) kms_getfb (getfb2-into-addfb2)
[214.230364] Starting subtest: getfb2-into-addfb2
[214.232343] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[214.322522] [041/132] (805s left) kms_dsc (dsc-with-output-formats-with-bpc)
[214.418340] Starting subtest: dsc-with-output-formats-with-bpc
[214.477401] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[214.516272] [042/132] (804s left) kms_dirtyfb (default-dirtyfb-ioctl)
[214.613401] Starting subtest: default-dirtyfb-ioctl
[214.615664] Starting dynamic subtest: A-eDP-1
[216.207464] Dynamic subtest A-eDP-1: SUCCESS (1.595s)
[216.209956] Subtest default-dirtyfb-ioctl: SUCCESS (1.596s)
[217.076969] [043/132] (802s left) gem_mmap_offset (partial-remap)
[217.131220] Starting subtest: partial-remap
[217.133169] Starting dynamic subtest: smem0
[217.142025] Dynamic subtest smem0: SUCCESS (0.006s)
[217.144016] Subtest partial-remap: SUCCESS (0.006s)
[217.253538] [044/132] (802s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[217.339189] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[217.341428] Starting dynamic subtest: pipe-A-eDP-1
[217.366793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[217.377423] Starting dynamic subtest: pipe-B-eDP-1
[217.401704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[217.411506] Starting dynamic subtest: pipe-C-eDP-1
[217.435248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[217.442858] Starting dynamic subtest: pipe-D-eDP-1
[217.466204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[217.470548] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[219.629836] [045/132] (799s left) kms_cursor_crc (cursor-random-512x512)
[219.933838] Starting subtest: cursor-random-512x512
[219.938488] Subtest cursor-random-512x512: SKIP (0.002s)
[220.081138] [046/132] (799s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[220.176567] Starting subtest: coverage-vs-premult-vs-constant
[220.467812] Starting dynamic subtest: pipe-A-eDP-1
[221.064321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.593s)
[221.075680] Starting dynamic subtest: pipe-D-eDP-1
[222.341187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[222.343659] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.168s)
[223.182303] [047/132] (796s left) kms_concurrent (multi-plane-atomic-lowres)
[223.272448] Starting subtest: multi-plane-atomic-lowres
[223.274617] Starting dynamic subtest: pipe-A-eDP-1
[223.834132] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[223.842961] Starting dynamic subtest: pipe-B-eDP-1
[225.050959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.215s)
[225.060290] Starting dynamic subtest: pipe-C-eDP-1
[226.278110] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.228s)
[226.286683] Starting dynamic subtest: pipe-D-eDP-1
[227.510252] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[227.512590] Subtest multi-plane-atomic-lowres: SUCCESS (4.237s)
[228.330785] [048/132] (791s left) gem_mmap_gtt (big-bo-tiledy)
[228.397341] Subtest big-bo-tiledY: SKIP (0.000s)
[228.459898] [049/132] (791s left) syncobj_eventfd (invalid-bad-pad)
[228.509631] Starting subtest: invalid-bad-pad
[228.511888] Subtest invalid-bad-pad: SUCCESS (0.000s)
[228.615417] [050/132] (791s left) gem_exec_schedule (implicit-read-write)
[228.681917] Starting subtest: implicit-read-write
[228.684015] Starting dynamic subtest: rcs0
[228.853500] Dynamic subtest rcs0: SUCCESS (0.181s)
[228.865234] Starting dynamic subtest: vcs0
[228.934599] Dynamic subtest vcs0: SUCCESS (0.081s)
[228.946169] Starting dynamic subtest: vcs1
[229.013087] Dynamic subtest vcs1: SUCCESS (0.078s)
[229.024685] Starting dynamic subtest: vecs0
[229.091197] Dynamic subtest vecs0: SUCCESS (0.077s)
[229.100965] Starting dynamic subtest: ccs0
[229.184625] Dynamic subtest ccs0: SUCCESS (0.092s)
[229.187213] Subtest implicit-read-write: SUCCESS (0.514s)
[231.031103] [051/132] (788s left) i915_drm_fdinfo (virtual-busy)
[231.070512] Starting subtest: virtual-busy
[231.074827] Subtest virtual-busy: SKIP (0.000s)
[231.149450] [052/132] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[231.248834] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[231.251084] Starting dynamic subtest: pipe-A-default-mode
[232.398766] Dynamic subtest pipe-A-default-mode: SKIP (1.148s)
[232.403150] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.149s)
[232.545525] [053/132] (787s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[232.680972] Starting subtest: basic-busy-flip-before-cursor-varying-size
[232.685633] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[232.847318] [054/132] (787s left) kms_rotation_crc (primary-rotation-180)
[232.935482] Starting subtest: primary-rotation-180
[239.842723] Subtest primary-rotation-180: SUCCESS (6.910s)
[241.035866] [055/132] (778s left) gem_pxp (create-regular-context-2)
[241.168117] Starting subtest: create-regular-context-2
[241.170554] Subtest create-regular-context-2: SUCCESS (0.001s)
[241.273647] [056/132] (778s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[241.376750] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[245.484853] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.112s)
[246.649754] [057/132] (773s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[246.751684] Starting subtest: yf-tiled-64bpp-rotate-180
[246.756032] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[246.856494] [058/132] (773s left) perf_pmu (busy-start)
[246.895684] Starting subtest: busy-start
[246.898105] Starting dynamic subtest: rcs0
[249.444725] Dynamic subtest rcs0: SUCCESS (2.549s)
[249.455957] Starting dynamic subtest: bcs0
[251.994207] Dynamic subtest bcs0: SUCCESS (2.547s)
[252.005668] Starting dynamic subtest: vcs0
[255.894662] Dynamic subtest vcs0: SUCCESS (3.896s)
[255.906716] Starting dynamic subtest: vcs1
[259.926537] Dynamic subtest vcs1: SUCCESS (4.029s)
[259.945869] Starting dynamic subtest: vecs0
[263.893933] Dynamic subtest vecs0: SUCCESS (3.965s)
[263.905565] Starting dynamic subtest: ccs0
[266.443223] Dynamic subtest ccs0: SUCCESS (2.548s)
[266.445972] Subtest busy-start: SUCCESS (19.548s)
[266.540598] [059/132] (753s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[266.637162] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[266.641657] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[266.745506] [060/132] (753s left) kms_sequence (get-forked-busy)
[266.837111] Starting subtest: get-forked-busy
[266.839353] Starting dynamic subtest: pipe-A-eDP-1
[268.764263] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[268.774834] Starting dynamic subtest: pipe-B-eDP-1
[271.328867] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.562s)
[271.338270] Starting dynamic subtest: pipe-C-eDP-1
[273.940185] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.611s)
[273.949560] Starting dynamic subtest: pipe-D-eDP-1
[276.560769] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[276.563092] Subtest get-forked-busy: SUCCESS (9.720s)
[277.362681] [061/132] (742s left) syncobj_wait (invalid-reset-bad-pad)
[277.419101] Starting subtest: invalid-reset-bad-pad
[277.421030] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[277.521897] [062/132] (742s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[277.619052] Starting subtest: extended-pageflip-modeset-hang-oldfb
[277.621334] Starting dynamic subtest: pipe-A
[285.509649] Dynamic subtest pipe-A: SUCCESS (7.890s)
[285.520867] Starting dynamic subtest: pipe-D
[294.155158] Dynamic subtest pipe-D: SUCCESS (8.644s)
[294.157533] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.538s)
[295.022124] [063/132] (725s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[295.110308] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[295.112593] Starting dynamic subtest: pipe-A-eDP-1
[295.331962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.212s)
[295.342746] Starting dynamic subtest: pipe-B-eDP-1
[295.362274] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[295.370805] Starting dynamic subtest: pipe-C-eDP-1
[295.389463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[295.397420] Starting dynamic subtest: pipe-D-eDP-1
[295.416338] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[295.418191] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.221s)
[297.558727] [064/132] (722s left) i915_pm_rpm (system-suspend)
[299.087677] Starting subtest: system-suspend
[317.038864] Subtest system-suspend: SUCCESS (3.134s)
[317.428744] [065/132] (702s left) gem_ctx_persistence (legacy-engines-mixed)
[317.499362] Starting subtest: legacy-engines-mixed
[317.501455] Starting dynamic subtest: render
[317.566413] Dynamic subtest render: SUCCESS (0.067s)
[317.578462] Starting dynamic subtest: bsd1
[317.619303] Dynamic subtest bsd1: SUCCESS (0.052s)
[317.630146] Starting dynamic subtest: bsd2
[317.668196] Dynamic subtest bsd2: SUCCESS (0.047s)
[317.678393] Starting dynamic subtest: blt
[317.727170] Dynamic subtest blt: SUCCESS (0.057s)
[317.740915] Starting dynamic subtest: vebox
[317.769317] Dynamic subtest vebox: SUCCESS (0.040s)
[317.771630] Subtest legacy-engines-mixed: SUCCESS (0.275s)
[317.847376] [066/132] (702s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[317.908033] Starting subtest: basic-batch-kernel-default-cmd
[317.912157] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[318.089509] [067/132] (702s left) gem_flink_basic (basic)
[318.132903] Starting subtest: basic
[318.135204] Subtest basic: SUCCESS (0.000s)
[318.223556] [068/132] (702s left) kms_vblank (ts-continuation-idle)
[318.313041] Starting subtest: ts-continuation-idle
[318.314931] Starting dynamic subtest: pipe-A-eDP-1
[318.707829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[318.722712] Starting dynamic subtest: pipe-D-eDP-1
[319.755241] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.058s)
[319.757314] Subtest ts-continuation-idle: SUCCESS (1.462s)
[320.615102] [069/132] (699s left) kms_addfb_basic (unused-modifier)
[320.666598] Starting subtest: unused-modifier
[320.669060] Subtest unused-modifier: SUCCESS (0.000s)
[320.811937] [070/132] (699s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[320.906440] Starting subtest: fbc-psr2-primary-mmap-gtt
[320.908699] Starting dynamic subtest: eDP-1
[320.917571] Dynamic subtest eDP-1: SKIP (0.000s)
[320.921971] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[320.991819] [071/132] (699s left) vgem_basic (bad-pad)
[321.042962] Starting subtest: bad-pad
[321.045122] Subtest bad-pad: SUCCESS (0.000s)
[321.108870] [072/132] (699s left) i915_pm_freq_api (freq-basic-api)
[321.167522] Starting subtest: freq-basic-api
[321.169910] Starting dynamic subtest: gt0
[321.172222] Dynamic subtest gt0: SUCCESS (0.003s)
[321.183420] Starting dynamic subtest: gt1
[321.185297] Dynamic subtest gt1: SUCCESS (0.003s)
[321.187196] Subtest freq-basic-api: SUCCESS (0.007s)
[321.260415] [073/132] (699s left) gem_exec_params (invalid-bsd2-flag-on-render)
[321.313261] Starting subtest: invalid-bsd2-flag-on-render
[321.315659] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[321.418068] [074/132] (699s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[321.521157] Starting subtest: 4-tiled-64bpp-rotate-180
[323.095985] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.590s)
[323.250734] [075/132] (697s left) kms_plane_cursor (viewport)
[323.346754] Starting subtest: viewport
[323.350626] Starting dynamic subtest: pipe-A-eDP-1-size-64
[325.760028] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.432s)
[325.820635] Starting dynamic subtest: pipe-A-eDP-1-size-128
[328.246310] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.449s)
[328.305914] Starting dynamic subtest: pipe-A-eDP-1-size-256
[330.671154] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.383s)
[331.021521] Starting dynamic subtest: pipe-B-eDP-1-size-64
[334.171166] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.170s)
[334.231049] Starting dynamic subtest: pipe-B-eDP-1-size-128
[336.767650] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[336.827840] Starting dynamic subtest: pipe-B-eDP-1-size-256
[339.262833] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.449s)
[339.625752] Starting dynamic subtest: pipe-C-eDP-1-size-64
[342.531120] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.921s)
[342.569640] Starting dynamic subtest: pipe-C-eDP-1-size-128
[344.706513] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[344.744868] Starting dynamic subtest: pipe-C-eDP-1-size-256
[346.838887] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.102s)
[347.173704] Starting dynamic subtest: pipe-D-eDP-1-size-64
[349.983584] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.819s)
[350.021848] Starting dynamic subtest: pipe-D-eDP-1-size-128
[352.117604] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.103s)
[352.155675] Starting dynamic subtest: pipe-D-eDP-1-size-256
[354.373205] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.225s)
[354.692147] Subtest viewport: SUCCESS (31.412s)
[355.593536] [076/132] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[355.707293] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[360.318119] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.617s)
[361.469533] [077/132] (659s left) prime_vgem (basic-write)
[361.547161] Starting subtest: basic-write
[361.563986] Subtest basic-write: SKIP (0.015s)
[361.667000] [078/132] (659s left) gem_exec_flush (basic-batch-kernel-default-uc)
[361.736964] Starting subtest: basic-batch-kernel-default-uc
[367.763604] Subtest basic-batch-kernel-default-uc: SUCCESS (6.028s)
[367.969310] [079/132] (652s left) gem_exec_schedule (fifo)
[368.037816] Starting subtest: fifo
[368.039765] Starting dynamic subtest: rcs0
[368.182999] Dynamic subtest rcs0: SUCCESS (0.153s)
[368.195972] Starting dynamic subtest: vcs0
[368.290468] Dynamic subtest vcs0: SUCCESS (0.107s)
[368.308816] Starting dynamic subtest: vcs1
[368.390883] Dynamic subtest vcs1: SUCCESS (0.099s)
[368.403160] Starting dynamic subtest: vecs0
[368.492236] Dynamic subtest vecs0: SUCCESS (0.101s)
[368.504470] Starting dynamic subtest: ccs0
[368.608659] Dynamic subtest ccs0: SUCCESS (0.115s)
[368.611630] Subtest fifo: SUCCESS (0.580s)
[369.818758] [080/132] (651s left) perf (global-sseu-config-invalid)
[369.941940] Starting subtest: global-sseu-config-invalid
[369.946556] Subtest global-sseu-config-invalid: SKIP (0.000s)
[369.985764] [081/132] (651s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[370.093981] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[370.098248] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[370.194716] [082/132] (650s left) kms_flip (2x-modeset-vs-vblank-race)
[370.285988] Starting subtest: 2x-modeset-vs-vblank-race
[370.294467] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[370.394211] [083/132] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[370.483936] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[370.487930] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[370.580899] [084/132] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[370.670314] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[370.674627] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[370.768710] [085/132] (650s left) kms_big_fb (linear-32bpp-rotate-90)
[370.865613] Starting subtest: linear-32bpp-rotate-90
[370.886289] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[371.024556] [086/132] (650s left) gem_exec_flush (basic-wb-ro-default)
[371.090411] Starting subtest: basic-wb-ro-default
[376.556720] Subtest basic-wb-ro-default: SUCCESS (5.469s)
[376.747564] [087/132] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[376.861656] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[376.866123] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[376.959853] [088/132] (644s left) kms_frontbuffer_tracking (fbc-tiling-y)
[377.055925] Starting subtest: fbc-tiling-y
[377.060093] Subtest fbc-tiling-y: SKIP (0.000s)
[377.156806] [089/132] (644s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[377.269097] Starting subtest: fbc-rgb565-draw-mmap-gtt
[377.273193] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[377.366315] [090/132] (644s left) api_intel_allocator (simple-allocator)
[377.423004] Starting subtest: simple-allocator
[377.425192] Starting dynamic subtest: basic
[377.427338] Dynamic subtest basic: SUCCESS (0.004s)
[377.439958] Starting dynamic subtest: parallel-one
[377.619388] Dynamic subtest parallel-one: SUCCESS (0.192s)
[377.630402] Starting dynamic subtest: print
[377.632256] Dynamic subtest print: SUCCESS (0.000s)
[377.642254] Starting dynamic subtest: reuse
[377.644372] Dynamic subtest reuse: SUCCESS (0.000s)
[377.654281] Starting dynamic subtest: reserve
[377.656760] Dynamic subtest reserve: SUCCESS (0.000s)
[377.666802] Starting dynamic subtest: fork-reopen-allocator
[377.668970] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[377.671191] Subtest simple-allocator: SUCCESS (0.215s)
[377.772806] [091/132] (643s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[377.860813] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[378.246763] Starting dynamic subtest: pipe-A-eDP-1
[381.042078] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[381.406960] Starting dynamic subtest: pipe-B-eDP-1
[384.159376] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[384.532366] Starting dynamic subtest: pipe-C-eDP-1
[387.293000] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[387.662241] Starting dynamic subtest: pipe-D-eDP-1
[390.417015] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[390.419886] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.561s)
[391.598805] [092/132] (629s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[391.707799] Starting subtest: basic-flip-after-cursor-legacy
[392.627903] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.919s)
[393.427380] [093/132] (628s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[393.489463] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[393.494178] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[393.673440] [094/132] (627s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[393.776730] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[393.780810] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[393.844702] [095/132] (627s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[393.945363] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[393.949748] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[394.046788] [096/132] (627s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[394.100308] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[394.182092] [097/132] (627s left) gen9_exec_parse (allowed-single)
[394.244433] Subtest allowed-single: SKIP (0.000s)
[394.319751] [098/132] (627s left) gem_exec_schedule (u-submit-late-slice)
[394.410327] Starting subtest: u-submit-late-slice
[394.412210] Starting dynamic subtest: rcs0
[394.441777] Dynamic subtest rcs0: SUCCESS (0.038s)
[394.453568] Starting dynamic subtest: bcs0
[394.470644] Dynamic subtest bcs0: SUCCESS (0.028s)
[394.479978] Starting dynamic subtest: vcs0
[394.501005] Dynamic subtest vcs0: SUCCESS (0.029s)
[394.514241] Starting dynamic subtest: vcs1
[394.525961] Dynamic subtest vcs1: SUCCESS (0.025s)
[394.535461] Starting dynamic subtest: vecs0
[394.552769] Dynamic subtest vecs0: SUCCESS (0.026s)
[394.561961] Starting dynamic subtest: ccs0
[394.590826] Dynamic subtest ccs0: SUCCESS (0.037s)
[394.592983] Subtest u-submit-late-slice: SUCCESS (0.188s)
[395.794031] [099/132] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[395.887177] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[395.891585] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[395.981435] [100/132] (625s left) i915_pm_rps (thresholds)
[396.050196] Starting subtest: thresholds
[396.054743] Subtest thresholds: SKIP (0.000s)
[396.143535] [101/132] (625s left) kms_addfb_basic (unused-pitches)
[396.201966] Starting subtest: unused-pitches
[396.204012] Subtest unused-pitches: SUCCESS (0.000s)
[396.349367] [102/132] (625s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[396.446013] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[396.448347] Starting dynamic subtest: pipe-A-eDP-1
[396.457706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[396.469244] Starting dynamic subtest: pipe-B-eDP-1
[396.478217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[396.487421] Starting dynamic subtest: pipe-C-eDP-1
[396.496504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[396.505658] Starting dynamic subtest: pipe-D-eDP-1
[396.514087] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[396.518394] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[398.701075] [103/132] (623s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[398.792159] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[403.241247] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.454s)
[404.392448] [104/132] (617s left) gem_exec_schedule (semaphore-user)
[404.468182] Starting subtest: semaphore-user
[404.518650] Subtest semaphore-user: SUCCESS (0.060s)
[405.803754] [105/132] (616s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[405.853668] Starting subtest: multi-wait-available-submitted-signaled
[405.855859] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[405.952227] [106/132] (616s left) syncobj_wait (wait-all-delayed-signal)
[406.015883] Starting subtest: wait-all-delayed-signal
[406.119462] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[406.194478] [107/132] (615s left) perf_pmu (interrupts-sync)
[406.238686] Starting subtest: interrupts-sync
[407.320905] Subtest interrupts-sync: SUCCESS (1.084s)
[407.432399] [108/132] (614s left) kms_flip (2x-flip-vs-suspend-interruptible)
[407.532791] Starting subtest: 2x-flip-vs-suspend-interruptible
[407.544679] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[407.619428] [109/132] (614s left) dmabuf_sync_file (export-wait-after-attach)
[407.662465] Starting subtest: export-wait-after-attach
[407.664626] Subtest export-wait-after-attach: SUCCESS (0.001s)
[407.716795] [110/132] (614s left) gem_partial_pwrite_pread (write-snoop)
[407.776937] Subtest write-snoop: SKIP (0.000s)
[407.852546] [111/132] (614s left) kms_async_flips (test-cursor)
[407.959651] Starting subtest: test-cursor
[408.339915] Starting dynamic subtest: pipe-A-eDP-1
[409.079697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[409.460075] Starting dynamic subtest: pipe-B-eDP-1
[410.206031] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[410.585854] Starting dynamic subtest: pipe-C-eDP-1
[411.345868] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[411.711399] Starting dynamic subtest: pipe-D-eDP-1
[412.483001] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s)
[412.485332] Subtest test-cursor: SUCCESS (4.527s)
[413.665094] [112/132] (608s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[414.050164] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[414.864182] [113/132] (607s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[414.976133] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[416.023939] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.047s)
[416.140160] [114/132] (606s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[416.193439] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[416.250517] [115/132] (606s left) gem_exec_reloc (basic-gtt-wc)
[416.304281] Subtest basic-gtt-wc: SKIP (0.000s)
[416.363438] [116/132] (606s left) api_intel_bb (simple-bb-ctx)
[416.404481] Starting subtest: simple-bb-ctx
[416.410903] Subtest simple-bb-ctx: SUCCESS (0.008s)
[416.495252] [117/132] (606s left) kms_psr2_su (frontbuffer-xrgb8888)
[416.551619] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[416.613002] [118/132] (605s left) kms_psr (psr-sprite-plane-onoff)
[416.698231] Starting subtest: psr-sprite-plane-onoff
[416.700116] Starting dynamic subtest: eDP-1
[418.421828] Dynamic subtest eDP-1: SUCCESS (1.723s)
[418.424181] Subtest psr-sprite-plane-onoff: SUCCESS (1.724s)
[419.259906] [119/132] (603s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[419.358191] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[426.212614] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.855s)
[426.361633] [120/132] (596s left) kms_psr (psr-cursor-plane-onoff)
[426.456680] Starting subtest: psr-cursor-plane-onoff
[426.458977] Starting dynamic subtest: eDP-1
[428.160299] Dynamic subtest eDP-1: SUCCESS (1.702s)
[428.167628] Subtest psr-cursor-plane-onoff: SUCCESS (1.703s)
[429.042176] [121/132] (593s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[429.204392] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[430.197760] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.994s)
[431.058004] [122/132] (591s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[431.170178] Starting subtest: invalid-modeset-force-ultra-joiner
[431.174537] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[431.238356] [123/132] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[431.332052] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[431.336103] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[431.438406] [124/132] (591s left) syncobj_timeline (signal-array)
[431.498226] Starting subtest: signal-array
[431.500257] Subtest signal-array: SUCCESS (0.000s)
[431.594242] [125/132] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[431.698082] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[431.702184] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[431.802639] [126/132] (591s left) gem_lmem_swapping (massive)
[431.846301] Subtest massive: SKIP (0.000s)
[431.885766] [127/132] (591s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[431.950358] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[431.953115] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[432.059629] [128/132] (590s left) gen7_exec_parse (basic-allocation)
[432.124087] Subtest basic-allocation: SKIP (0.000s)
[432.206537] [129/132] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[432.316061] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[439.778680] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.464s)
[439.908151] [130/132] (583s left) gem_exec_balancer (hang)
[440.172805] Starting subtest: hang
[441.866206] Subtest hang: SUCCESS (1.695s)
[441.993028] [131/132] (581s left) kms_pm_rpm (system-suspend-idle)
[443.919311] Starting subtest: system-suspend-idle
[463.246476] Subtest system-suspend-idle: SUCCESS (4.247s)
[463.612312] [132/132] (559s left) gem_pxp (hw-rejects-pxp-context)
[463.720099] Starting subtest: hw-rejects-pxp-context
[463.725599] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[463.841402] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ccs
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: gem_ctx_isolation
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_color
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: gem_ctx_exec
results: parsing output: 25/ for test: kms_properties
results: parsing output: 26/ for test: drm_read
results: parsing output: 27/ for test: gem_set_tiling_vs_blt
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_spin_batch
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_pipe_b_c_ivb
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: kms_atomic_transition
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_dirtyfb
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_plane_alpha_blend
results: parsing output: 46/ for test: kms_concurrent
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_rotation_crc
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: gem_flink_basic
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: vgem_basic
results: parsing output: 71/ for test: i915_pm_freq_api
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_plane_cursor
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: gem_exec_flush
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: i915_pm_rps
results: parsing output: 100/ for test: kms_addfb_basic
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: dmabuf_sync_file
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_async_flips
results: parsing output: 111/ for test: kms_chamelium_frames
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: gem_fenced_exec_thrash
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_psr2_su
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_joiner
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_lmem_swapping
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: gen7_exec_parse
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_exec_balancer
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: gem_pxp
Done.