[58.542654] Initializing watchdogs
[58.542714]   /dev/watchdog0
[58.557003] [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]
[58.561647] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.563926] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.567608] [001/132] (960s left) kms_addfb_basic (invalid-get-prop-any)
[58.644273] Starting subtest: invalid-get-prop-any
[58.646610] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[58.773365] [002/132] (960s left) perf_pmu (most-busy-check-all)
[58.816194] Starting subtest: most-busy-check-all
[58.818622] Starting dynamic subtest: rcs0
[59.928203] Dynamic subtest rcs0: SUCCESS (1.105s)
[59.938651] Starting dynamic subtest: bcs0
[61.912920] Dynamic subtest bcs0: SUCCESS (1.977s)
[61.923059] Starting dynamic subtest: vcs0
[63.895267] Dynamic subtest vcs0: SUCCESS (1.976s)
[63.904535] Starting dynamic subtest: vcs1
[65.880056] Dynamic subtest vcs1: SUCCESS (1.980s)
[65.889863] Starting dynamic subtest: vecs0
[67.927228] Dynamic subtest vecs0: SUCCESS (2.043s)
[67.938085] Starting dynamic subtest: ccs0
[69.910339] Dynamic subtest ccs0: SUCCESS (1.980s)
[69.913038] Subtest most-busy-check-all: SUCCESS (11.069s)
[70.014283] [003/132] (949s left) kms_cursor_crc (cursor-random-128x128)
[70.231432] Starting subtest: cursor-random-128x128
[70.249718] Starting dynamic subtest: pipe-A-eDP-1
[73.690594] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[73.723836] Starting dynamic subtest: pipe-D-eDP-1
[77.659297] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.940s)
[77.661640] Subtest cursor-random-128x128: SUCCESS (7.423s)
[78.525813] [004/132] (940s left) gem_ctx_shared (q-out-order)
[78.595770] Starting subtest: Q-out-order
[78.598025] Starting dynamic subtest: rcs0
[78.741459] Dynamic subtest rcs0: SUCCESS (0.147s)
[78.757249] Starting dynamic subtest: vcs0
[78.815874] Dynamic subtest vcs0: SUCCESS (0.074s)
[78.829318] Starting dynamic subtest: vcs1
[78.892499] Dynamic subtest vcs1: SUCCESS (0.076s)
[78.907399] Starting dynamic subtest: vecs0
[78.978845] Dynamic subtest vecs0: SUCCESS (0.087s)
[78.994555] Starting dynamic subtest: ccs0
[79.074244] Dynamic subtest ccs0: SUCCESS (0.095s)
[79.076935] Subtest Q-out-order: SUCCESS (0.480s)
[79.979804] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[79.984175] [005/132] (939s left) gem_huc_copy (huc-copy)
[80.044909] Starting subtest: huc-copy
[80.049949] Subtest huc-copy: SUCCESS (0.003s)
[80.162102] [006/132] (939s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[80.288057] Starting subtest: cursor-vs-flip-legacy
[109.710713] Subtest cursor-vs-flip-legacy: SUCCESS (29.420s)
[110.555303] [007/132] (908s left) gem_ctx_persistence (idempotent)
[110.629385] Starting subtest: idempotent
[110.631691] Subtest idempotent: SUCCESS (0.000s)
[110.734896] [008/132] (908s left) kms_joiner (invalid-modeset-force-big-joiner)
[110.832401] Starting subtest: invalid-modeset-force-big-joiner
[110.836994] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[110.898200] [009/132] (908s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[110.988236] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[110.990590] Starting dynamic subtest: pipe-A-eDP-1
[111.049063] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[111.060726] Starting dynamic subtest: pipe-B-eDP-1
[111.121020] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[111.130336] Starting dynamic subtest: pipe-C-eDP-1
[111.187104] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[111.196388] Starting dynamic subtest: pipe-D-eDP-1
[111.254253] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[111.258803] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[113.154071] [010/132] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[113.280413] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[113.285100] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[113.382654] [011/132] (906s left) gem_exec_balancer (parallel-keep-in-fence)
[113.632978] Starting subtest: parallel-keep-in-fence
[114.712474] Subtest parallel-keep-in-fence: SUCCESS (1.079s)
[114.823955] [012/132] (904s left) gem_close (many-handles-one-vma)
[114.889523] Starting subtest: many-handles-one-vma
[114.914244] Subtest many-handles-one-vma: SUCCESS (0.025s)
[115.002464] [013/132] (904s left) sysfs_timeslice_duration (idempotent)
[115.067632] Starting subtest: idempotent
[115.069923] Starting dynamic subtest: vecs0
[115.072144] Dynamic subtest vecs0: SUCCESS (0.000s)
[115.079502] Starting dynamic subtest: ccs0
[115.081432] Dynamic subtest ccs0: SUCCESS (0.000s)
[115.088468] Starting dynamic subtest: vcs0
[115.090335] Dynamic subtest vcs0: SUCCESS (0.000s)
[115.097344] Starting dynamic subtest: bcs0
[115.099186] Dynamic subtest bcs0: SUCCESS (0.000s)
[115.106829] Starting dynamic subtest: rcs0
[115.109038] Dynamic subtest rcs0: SUCCESS (0.000s)
[115.116185] Starting dynamic subtest: vcs1
[115.118399] Dynamic subtest vcs1: SUCCESS (0.000s)
[115.120311] Subtest idempotent: SUCCESS (0.004s)
[115.160634] [014/132] (904s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[115.261232] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[119.211040] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.953s)
[120.362472] [015/132] (899s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[120.459814] Starting subtest: pr-cursor-plane-move-continuous-sf
[120.464240] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[120.526222] [016/132] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[120.623206] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[120.627672] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[120.715724] [017/132] (898s left) kms_chamelium_frames (hdmi-crc-multiple)
[121.102068] Subtest hdmi-crc-multiple: SKIP (0.000s)
[121.947116] [018/132] (897s left) gem_userptr_blits (unsync-unmap-after-close)
[122.016628] Subtest unsync-unmap-after-close: SKIP (0.000s)
[122.134519] [019/132] (897s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[122.657509] Starting subtest: syncobj-timeline-multiple-ext-nodes
[122.660529] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[123.986042] [020/132] (895s left) sriov_basic (enable-vfs-bind-unbind-each)
[124.043056] Starting subtest: enable-vfs-bind-unbind-each
[124.045426] Starting dynamic subtest: numvfs-1
[124.119571] Dynamic subtest numvfs-1: FAIL (0.018s)
[124.128615] Starting dynamic subtest: numvfs-2
[124.201997] Dynamic subtest numvfs-2: FAIL (0.004s)
[124.212788] Starting dynamic subtest: numvfs-3
[124.285784] Dynamic subtest numvfs-3: FAIL (0.004s)
[124.295144] Starting dynamic subtest: numvfs-4
[124.367241] Dynamic subtest numvfs-4: FAIL (0.004s)
[124.376468] Starting dynamic subtest: numvfs-5
[124.449255] Dynamic subtest numvfs-5: FAIL (0.004s)
[124.458666] Starting dynamic subtest: numvfs-6
[124.533736] Dynamic subtest numvfs-6: FAIL (0.004s)
[124.542763] Starting dynamic subtest: numvfs-7
[124.616085] Dynamic subtest numvfs-7: FAIL (0.004s)
[124.625372] Starting dynamic subtest: numvfs-random
[124.697491] Dynamic subtest numvfs-random: FAIL (0.004s)
[124.699604] Subtest enable-vfs-bind-unbind-each: FAIL (0.047s)
[124.736242] [021/132] (895s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[124.833712] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[124.835918] Starting dynamic subtest: pipe-A-eDP-1
[124.845404] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.855861] Starting dynamic subtest: pipe-B-eDP-1
[124.864523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.872297] Starting dynamic subtest: pipe-C-eDP-1
[124.880689] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.888079] Starting dynamic subtest: pipe-D-eDP-1
[124.896300] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.900322] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[127.047014] [022/132] (892s left) gem_mmap_wc (close)
[127.103781] Subtest close: SKIP (0.000s)
[127.162876] [023/132] (892s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[127.257012] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[127.880862] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[128.031209] [024/132] (891s left) kms_big_fb (linear-8bpp-rotate-180)
[128.123478] Starting subtest: linear-8bpp-rotate-180
[129.351343] Subtest linear-8bpp-rotate-180: SUCCESS (1.229s)
[129.509705] [025/132] (890s left) kms_plane_multiple (2x-tiling-none)
[129.595065] Starting subtest: 2x-tiling-none
[129.598553] Subtest 2x-tiling-none: SKIP (0.000s)
[129.668932] [026/132] (890s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[129.773702] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[129.777316] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[129.866936] [027/132] (890s left) kms_draw_crc (draw-method-mmap-cpu)
[129.961501] Starting subtest: draw-method-mmap-cpu
[129.963312] Starting dynamic subtest: xrgb8888-untiled
[130.237539] Dynamic subtest xrgb8888-untiled: SUCCESS (0.279s)
[130.246716] Starting dynamic subtest: rgb565-untiled
[130.437605] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[130.446532] Starting dynamic subtest: xrgb2101010-untiled
[130.659912] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[130.668638] Starting dynamic subtest: xbgr16161616f-untiled
[130.871158] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[130.879163] Starting dynamic subtest: xrgb8888-xtiled
[130.995371] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[131.002982] Starting dynamic subtest: rgb565-xtiled
[131.115503] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[131.124560] Starting dynamic subtest: xrgb2101010-xtiled
[131.237834] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[131.250303] Starting dynamic subtest: xbgr16161616f-xtiled
[131.361882] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[131.369394] Starting dynamic subtest: xrgb8888-4tiled
[131.504311] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[131.512339] Starting dynamic subtest: rgb565-4tiled
[131.637758] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[131.648738] Starting dynamic subtest: xrgb2101010-4tiled
[131.771097] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[131.780389] Starting dynamic subtest: xbgr16161616f-4tiled
[131.904761] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[131.906839] Subtest draw-method-mmap-cpu: SUCCESS (1.946s)
[132.019284] [028/132] (888s left) prime_vgem (fence-write-hang)
[132.094454] Subtest fence-write-hang: SKIP (0.000s)
[132.200634] [029/132] (887s left) gem_mmap_wc (coherency)
[132.254753] Subtest coherency: SKIP (0.000s)
[132.310248] [030/132] (887s left) core_debugfs (read-all-entries)
[132.372963] Starting subtest: read-all-entries
[132.455116] Subtest read-all-entries: SUCCESS (0.083s)
[132.519445] [031/132] (887s left) perf (invalid-create-userspace-config)
[132.638845] Starting subtest: invalid-create-userspace-config
[132.640694] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[132.685794] [032/132] (887s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[132.778756] Starting subtest: fbc-tiling-linear
[136.457054] Subtest fbc-tiling-linear: SUCCESS (3.682s)
[137.641985] [033/132] (882s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[137.746481] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[137.750914] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[137.817687] [034/132] (882s left) perf_pmu (busy)
[137.864629] Starting subtest: busy
[137.866913] Starting dynamic subtest: rcs0
[138.452308] Dynamic subtest rcs0: SUCCESS (0.587s)
[138.467899] Starting dynamic subtest: bcs0
[139.019377] Dynamic subtest bcs0: SUCCESS (0.566s)
[139.029812] Starting dynamic subtest: vcs0
[140.886382] Dynamic subtest vcs0: SUCCESS (1.865s)
[140.897611] Starting dynamic subtest: vcs1
[142.934883] Dynamic subtest vcs1: SUCCESS (2.047s)
[142.946673] Starting dynamic subtest: vecs0
[144.918045] Dynamic subtest vecs0: SUCCESS (1.982s)
[144.930172] Starting dynamic subtest: ccs0
[145.486754] Dynamic subtest ccs0: SUCCESS (0.569s)
[145.489735] Subtest busy: SUCCESS (7.621s)
[145.595623] [035/132] (874s left) kms_color (deep-color)
[145.693493] Starting subtest: deep-color
[146.805073] Starting dynamic subtest: pipe-A-eDP-1-gamma
[147.517836] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.713s)
[147.527357] Starting dynamic subtest: pipe-A-eDP-1-degamma
[149.033961] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.513s)
[149.043659] Starting dynamic subtest: pipe-A-eDP-1-ctm
[150.424710] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.391s)
[151.224542] Starting dynamic subtest: pipe-B-eDP-1-gamma
[151.951672] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.736s)
[151.961071] Starting dynamic subtest: pipe-B-eDP-1-degamma
[153.377424] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.425s)
[153.386430] Starting dynamic subtest: pipe-B-eDP-1-ctm
[154.819966] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.441s)
[155.616608] Starting dynamic subtest: pipe-C-eDP-1-gamma
[156.279239] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.674s)
[156.290725] Starting dynamic subtest: pipe-C-eDP-1-degamma
[157.680593] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.401s)
[157.690844] Starting dynamic subtest: pipe-C-eDP-1-ctm
[159.082557] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.403s)
[159.908198] Starting dynamic subtest: pipe-D-eDP-1-gamma
[160.588152] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.694s)
[160.601039] Starting dynamic subtest: pipe-D-eDP-1-degamma
[161.941185] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.351s)
[161.949470] Starting dynamic subtest: pipe-D-eDP-1-ctm
[163.349879] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.409s)
[163.352197] Subtest deep-color: SUCCESS (17.656s)
[164.214012] [036/132] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[164.319925] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[167.994215] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.677s)
[169.119806] [037/132] (851s left) kms_getfb (getfb2-handle-zero)
[169.237931] Starting subtest: getfb2-handle-zero
[169.240387] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[169.341472] [038/132] (851s left) gem_exec_reloc (basic-wc-cpu)
[169.413226] Subtest basic-wc-cpu: SKIP (0.000s)
[169.493977] [039/132] (851s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[169.542882] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[169.545188] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[169.633319] [040/132] (850s left) gem_mmap_gtt (cpuset-big-copy-xy)
[169.702703] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[169.767571] [041/132] (850s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[169.867633] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[169.872120] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[169.967168] [042/132] (850s left) gem_spin_batch (engines)
[170.033639] Starting subtest: engines
[170.036072] Starting dynamic subtest: rcs0
[173.274989] Dynamic subtest rcs0: SUCCESS (3.235s)
[173.286923] Starting dynamic subtest: bcs0
[176.565877] Dynamic subtest bcs0: SUCCESS (3.235s)
[176.577887] Starting dynamic subtest: vcs0
[179.800361] Dynamic subtest vcs0: SUCCESS (3.234s)
[179.814294] Starting dynamic subtest: vcs1
[183.035711] Dynamic subtest vcs1: SUCCESS (3.233s)
[183.049606] Starting dynamic subtest: vecs0
[186.275859] Dynamic subtest vecs0: SUCCESS (3.237s)
[186.287463] Starting dynamic subtest: ccs0
[189.512847] Dynamic subtest ccs0: SUCCESS (3.236s)
[189.515772] Subtest engines: SUCCESS (19.422s)
[189.680731] [043/132] (831s left) kms_content_protection (lic-type-1)
[189.829273] Starting subtest: lic-type-1
[189.833722] Subtest lic-type-1: SKIP (0.000s)
[189.954154] [044/132] (830s left) gem_exec_fence (syncobj-wait)
[190.387335] Starting subtest: syncobj-wait
[191.890635] Subtest syncobj-wait: SUCCESS (1.502s)
[192.239049] [045/132] (828s left) kms_chamelium_color (ctm-blue-to-red)
[192.332173] Subtest ctm-blue-to-red: SKIP (0.000s)
[192.376592] [046/132] (828s left) gem_exec_whisper (basic-contexts-all)
[192.445243] Starting subtest: basic-contexts-all
[203.829085] Subtest basic-contexts-all: SUCCESS (11.384s)
[204.029909] [047/132] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[204.133738] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[204.137749] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[204.230251] [048/132] (816s left) i915_pm_rpm (gem-mmap-type)
[206.055388] Starting subtest: gem-mmap-type
[206.058099] Starting dynamic subtest: wb-smem0
[209.561218] Dynamic subtest wb-smem0: SUCCESS (3.508s)
[209.569628] Starting dynamic subtest: wc-smem0
[212.731364] Dynamic subtest wc-smem0: SUCCESS (3.168s)
[212.740486] Starting dynamic subtest: uc-smem0
[215.931789] Dynamic subtest uc-smem0: SUCCESS (3.198s)
[215.934093] Subtest gem-mmap-type: SUCCESS (9.879s)
[216.053744] [049/132] (804s left) i915_pm_rps (thresholds)
[216.111115] Starting subtest: thresholds
[216.115906] Subtest thresholds: SKIP (0.000s)
[216.204988] [050/132] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[216.309833] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[223.114151] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.806s)
[223.249814] [051/132] (797s left) syncobj_eventfd (invalid-bad-pad)
[223.303744] Starting subtest: invalid-bad-pad
[223.306064] Subtest invalid-bad-pad: SUCCESS (0.000s)
[223.386916] [052/132] (797s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[223.478615] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[223.490666] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[223.569724] [053/132] (797s left) gem_request_retire (retire-vma-not-inactive)
[223.634084] Starting subtest: retire-vma-not-inactive
[223.694176] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[223.821176] [054/132] (797s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[223.924895] Starting subtest: psr-rgb101010-draw-render
[231.156516] Subtest psr-rgb101010-draw-render: SUCCESS (7.234s)
[231.283396] [055/132] (789s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[231.405644] Starting subtest: cursorB-vs-flipB-toggle
[231.410056] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[231.551603] [056/132] (789s left) kms_flip (2x-flip-vs-dpms-on-nop)
[231.653157] Starting subtest: 2x-flip-vs-dpms-on-nop
[231.662015] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[231.738614] [057/132] (789s left) syncobj_wait (wait-for-submit-delayed-submit)
[231.793140] Starting subtest: wait-for-submit-delayed-submit
[231.897018] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[231.984853] [058/132] (789s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[232.033845] Starting subtest: multi-wait-all-for-submit-submitted
[232.139227] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[232.212972] [059/132] (789s left) gem_mmap_offset (pf-nonblock)
[232.265045] Starting subtest: pf-nonblock
[232.269757] Subtest pf-nonblock: SUCCESS (0.005s)
[232.357445] [060/132] (789s left) kms_addfb_basic (bad-pitch-65536)
[232.416427] Starting subtest: bad-pitch-65536
[232.418706] Subtest bad-pitch-65536: SUCCESS (0.000s)
[232.564567] [061/132] (788s left) vgem_basic (dmabuf-mmap)
[232.614397] Starting subtest: dmabuf-mmap
[232.645619] Subtest dmabuf-mmap: SUCCESS (0.033s)
[232.706581] [062/132] (788s left) syncobj_timeline (single-wait-for-submit-signaled)
[232.763490] Starting subtest: single-wait-for-submit-signaled
[232.765701] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[232.875412] [063/132] (788s left) fbdev (unaligned-write)
[232.928105] Starting subtest: unaligned-write
[233.024351] Subtest unaligned-write: SUCCESS (0.098s)
[233.112266] [064/132] (788s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[233.202308] Starting subtest: fbc-psr-cursor-mmap-gtt
[233.204264] Starting dynamic subtest: eDP-1
[233.207908] Dynamic subtest eDP-1: SKIP (0.000s)
[233.211323] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.002s)
[233.282190] [065/132] (788s left) kms_addfb_basic (invalid-set-prop-any)
[233.342662] Starting subtest: invalid-set-prop-any
[233.345255] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[233.468106] [066/132] (788s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[233.594207] Starting subtest: 2x-long-flip-vs-cursor-legacy
[233.597875] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[233.739313] [067/132] (788s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[233.822029] Starting subtest: primary-4-tiled-reflect-x-0
[240.781984] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.961s)
[241.957661] [068/132] (779s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[242.063285] Starting subtest: x-tiled-8bpp-rotate-180
[243.277227] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.216s)
[243.399117] [069/132] (778s left) gem_ctx_persistence (engines-hang)
[243.463689] Starting subtest: engines-hang
[243.465648] Starting dynamic subtest: rcs0
[243.604624] Dynamic subtest rcs0: SUCCESS (0.140s)
[243.615492] Starting dynamic subtest: bcs0
[243.707499] Dynamic subtest bcs0: SUCCESS (0.101s)
[243.718381] Starting dynamic subtest: vcs0
[243.816092] Dynamic subtest vcs0: SUCCESS (0.106s)
[243.827239] Starting dynamic subtest: vcs1
[243.903261] Dynamic subtest vcs1: SUCCESS (0.086s)
[243.913964] Starting dynamic subtest: vecs0
[243.992501] Dynamic subtest vecs0: SUCCESS (0.087s)
[244.000573] Starting dynamic subtest: ccs0
[244.085338] Dynamic subtest ccs0: SUCCESS (0.091s)
[244.087599] Subtest engines-hang: SUCCESS (0.623s)
[244.167336] [070/132] (777s left) i915_query (query-topology-coherent-slice-mask)
[244.223888] Starting subtest: query-topology-coherent-slice-mask
[244.227405] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[244.307866] [071/132] (777s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[244.397063] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[244.398910] Starting dynamic subtest: pipe-A-eDP-1
[244.415979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[244.425259] Starting dynamic subtest: pipe-B-eDP-1
[244.441837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[244.449714] Starting dynamic subtest: pipe-C-eDP-1
[244.465699] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[244.473538] Starting dynamic subtest: pipe-D-eDP-1
[244.489223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[244.491085] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[246.559239] [072/132] (775s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[246.658735] Starting subtest: bad-pixel-format-yf-tiled-ccs
[246.661118] Starting dynamic subtest: pipe-A-eDP-1
[246.683713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.693789] Starting dynamic subtest: pipe-B-eDP-1
[246.716115] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.725047] Starting dynamic subtest: pipe-C-eDP-1
[246.746599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.754776] Starting dynamic subtest: pipe-D-eDP-1
[246.776365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.780424] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[248.920395] [073/132] (773s left) gem_eio (in-flight-suspend)
[249.161588] Starting subtest: in-flight-suspend
[293.714668] Subtest in-flight-suspend: SUCCESS (15.121s)
[293.894766] [074/132] (728s left) kms_psr (fbc-psr-sprite-render)
[293.994764] Starting subtest: fbc-psr-sprite-render
[293.997038] Starting dynamic subtest: eDP-1
[294.001062] Dynamic subtest eDP-1: SKIP (0.000s)
[294.005237] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[294.077122] [075/132] (728s left) gem_exec_schedule (implicit-write-read)
[294.139567] Starting subtest: implicit-write-read
[294.141490] Starting dynamic subtest: rcs0
[294.262522] Dynamic subtest rcs0: SUCCESS (0.129s)
[294.274037] Starting dynamic subtest: vcs0
[294.364281] Dynamic subtest vcs0: SUCCESS (0.101s)
[294.377659] Starting dynamic subtest: vcs1
[294.446684] Dynamic subtest vcs1: SUCCESS (0.083s)
[294.459105] Starting dynamic subtest: vecs0
[294.539844] Dynamic subtest vecs0: SUCCESS (0.091s)
[294.550686] Starting dynamic subtest: ccs0
[294.644746] Dynamic subtest ccs0: SUCCESS (0.101s)
[294.647184] Subtest implicit-write-read: SUCCESS (0.509s)
[295.398664] [076/132] (726s left) kms_plane (planar-pixel-format-settings)
[295.515014] Starting subtest: planar-pixel-format-settings
[295.580344] Subtest planar-pixel-format-settings: SUCCESS (0.064s)
[295.678923] [077/132] (726s left) kms_rotation_crc (primary-rotation-270)
[295.766628] Starting subtest: primary-rotation-270
[295.771172] Subtest primary-rotation-270: SKIP (0.001s)
[295.857357] [078/132] (726s left) syncobj_timeline (invalid-query-one-illegal-handle)
[295.911277] Starting subtest: invalid-query-one-illegal-handle
[295.913260] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[296.016638] [079/132] (726s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[296.148211] Starting subtest: cursorA-vs-flipB-toggle
[296.152674] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[296.310014] [080/132] (726s left) kms_plane (pixel-format-yf-tiled-modifier)
[296.394917] Starting subtest: pixel-format-yf-tiled-modifier
[296.398589] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[296.482938] [081/132] (725s left) device_reset (unbind-cold-reset-rebind)
[296.530950] Starting subtest: unbind-cold-reset-rebind
[296.534666] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[296.591656] [082/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[296.680019] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[296.683420] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[296.780268] [083/132] (725s left) gen9_exec_parse (unaligned-jump)
[296.839384] Subtest unaligned-jump: SKIP (0.000s)
[296.918121] [084/132] (725s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[297.302777] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[298.125231] [085/132] (724s left) kms_cursor_crc (cursor-onscreen-512x512)
[298.416933] Starting subtest: cursor-onscreen-512x512
[298.421528] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[298.585765] [086/132] (723s left) kms_psr (fbc-pr-primary-mmap-gtt)
[298.681443] Starting subtest: fbc-pr-primary-mmap-gtt
[298.685958] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[298.772790] [087/132] (723s left) gem_exec_flush (basic-wb-rw-before-default)
[298.835136] Starting subtest: basic-wb-rw-before-default
[304.372909] Subtest basic-wb-rw-before-default: SUCCESS (5.463s)
[304.544173] [088/132] (718s left) i915_drm_fdinfo (virtual-busy-hang-all)
[304.585368] Starting subtest: virtual-busy-hang-all
[304.589902] Subtest virtual-busy-hang-all: SKIP (0.000s)
[304.658449] [089/132] (718s left) syncobj_wait (reset-unsignaled)
[304.703366] Starting subtest: reset-unsignaled
[304.705691] Subtest reset-unsignaled: SUCCESS (0.000s)
[304.800158] [090/132] (717s left) kms_psr (psr-cursor-plane-onoff)
[304.881729] Starting subtest: psr-cursor-plane-onoff
[304.884079] Starting dynamic subtest: eDP-1
[306.603859] Dynamic subtest eDP-1: SUCCESS (1.711s)
[306.606186] Subtest psr-cursor-plane-onoff: SUCCESS (1.713s)
[307.481297] [091/132] (715s left) gem_softpin (softpin)
[307.542833] Starting subtest: softpin
[339.952881] Subtest softpin: SUCCESS (32.365s)
[340.088218] [092/132] (682s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[340.184178] Starting subtest: fbcpsr-stridechange
[346.428764] Subtest fbcpsr-stridechange: SUCCESS (6.245s)
[346.564852] [093/132] (676s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[346.625369] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[346.627633] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[346.734232] [094/132] (676s left) gem_exec_balancer (bonded-dual)
[346.797212] Starting subtest: bonded-dual
[346.801810] Subtest bonded-dual: SKIP (0.000s)
[347.096614] [095/132] (675s left) gem_exec_flush (basic-batch-kernel-default-wb)
[347.160590] Starting subtest: basic-batch-kernel-default-wb
[352.902028] Subtest basic-batch-kernel-default-wb: SUCCESS (5.738s)
[353.102886] [096/132] (669s left) kms_prop_blob (invalid-set-prop)
[353.161882] Starting subtest: invalid-set-prop
[353.164126] Subtest invalid-set-prop: SUCCESS (0.000s)
[353.289168] [097/132] (669s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[353.396729] Starting subtest: y-tiled-32bpp-rotate-270
[353.401058] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[353.484631] [098/132] (669s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[353.550233] Starting subtest: yf-tiled-to-vebox-yf-tiled
[353.554598] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[353.749680] [099/132] (669s left) gem_unfence_active_buffers
[353.909436] [100/132] (669s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[354.012580] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[354.014937] Starting dynamic subtest: pipe-A-eDP-1
[359.914105] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.903s)
[359.924792] Starting dynamic subtest: pipe-B-eDP-1
[366.567936] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.648s)
[366.569799] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.554s)
[367.443359] [101/132] (655s left) gen7_exec_parse (oacontrol-tracking)
[367.504974] Subtest oacontrol-tracking: SKIP (0.000s)
[367.577342] [102/132] (655s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[367.694194] Starting subtest: short-flip-after-cursor-toggle
[368.639491] Subtest short-flip-after-cursor-toggle: SUCCESS (0.944s)
[369.486365] [103/132] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[369.593094] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[376.726647] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.133s)
[376.843878] [104/132] (646s left) gem_create (create-invalid-size)
[376.904246] Starting subtest: create-invalid-size
[376.906229] Subtest create-invalid-size: SUCCESS (0.000s)
[377.099980] [105/132] (646s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[377.196567] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[377.200675] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[377.298616] [106/132] (646s left) syncobj_wait (wait-all-for-submit-snapshot)
[377.365596] Starting subtest: wait-all-for-submit-snapshot
[377.445289] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[377.522245] [107/132] (645s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[377.630766] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[377.634985] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[377.727142] [108/132] (645s left) kms_async_flips (crc-atomic)
[377.840751] Starting subtest: crc-atomic
[378.218880] Starting dynamic subtest: pipe-A-eDP-1
[381.146202] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.905s)
[381.505832] Starting dynamic subtest: pipe-B-eDP-1
[384.477192] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.950s)
[384.828478] Starting dynamic subtest: pipe-C-eDP-1
[387.747524] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.926s)
[388.114402] Starting dynamic subtest: pipe-D-eDP-1
[391.019736] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[391.022376] Subtest crc-atomic: SUCCESS (13.142s)
[392.161504] [109/132] (631s left) kms_pipe_crc_basic (read-crc)
[392.259613] Starting subtest: read-crc
[392.261920] Starting dynamic subtest: pipe-A-eDP-1
[392.963586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[392.974111] Starting dynamic subtest: pipe-B-eDP-1
[394.329973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.364s)
[394.341983] Starting dynamic subtest: pipe-C-eDP-1
[395.632579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[395.642814] Starting dynamic subtest: pipe-D-eDP-1
[396.973859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[396.976158] Subtest read-crc: SUCCESS (4.715s)
[397.793692] [110/132] (625s left) syncobj_wait (single-wait-all-for-submit-submitted)
[397.857147] Starting subtest: single-wait-all-for-submit-submitted
[397.964210] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[398.041471] [111/132] (625s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[398.140552] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[398.142880] Starting dynamic subtest: pipe-A
[398.203396] Dynamic subtest pipe-A: SUCCESS (0.065s)
[398.214322] Starting dynamic subtest: pipe-B
[399.326616] Dynamic subtest pipe-B: SUCCESS (1.121s)
[399.339067] Starting dynamic subtest: pipe-C
[400.436070] Dynamic subtest pipe-C: SUCCESS (1.108s)
[400.447794] Starting dynamic subtest: pipe-D
[401.579681] Dynamic subtest pipe-D: SUCCESS (1.143s)
[401.582003] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.443s)
[402.718992] [112/132] (620s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[402.823148] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[403.524327] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.703s)
[403.674786] [113/132] (620s left) gem_render_copy (linear-to-vebox-y-tiled)
[403.749581] Starting subtest: linear-to-vebox-y-tiled
[403.753524] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[403.934787] [114/132] (619s left) gem_ctx_param (set-priority-range)
[403.980790] Starting subtest: set-priority-range
[403.994686] Subtest set-priority-range: SUCCESS (0.014s)
[404.101564] [115/132] (619s left) kms_vblank (wait-idle)
[404.201806] Starting subtest: wait-idle
[404.204031] Starting dynamic subtest: pipe-A-eDP-1
[405.955736] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[405.970570] Starting dynamic subtest: pipe-D-eDP-1
[408.376846] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[408.379259] Subtest wait-idle: SUCCESS (4.174s)
[409.187131] [116/132] (614s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[409.299054] Starting subtest: flip-vs-cursor-legacy
[416.448265] Subtest flip-vs-cursor-legacy: SUCCESS (7.147s)
[417.318522] [117/132] (606s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[417.384888] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[417.513307] [118/132] (606s left) gem_close_race (multigpu-basic-process)
[417.583751] Starting subtest: multigpu-basic-process
[417.588036] Subtest multigpu-basic-process: SKIP (0.000s)
[417.808734] [119/132] (606s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[417.932024] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[417.936398] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[418.078716] [120/132] (605s left) kms_sequence (get-idle)
[418.165196] Starting subtest: get-idle
[418.167123] Starting dynamic subtest: pipe-A-eDP-1
[419.987778] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[419.998033] Starting dynamic subtest: pipe-B-eDP-1
[422.494165] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.508s)
[422.505131] Starting dynamic subtest: pipe-C-eDP-1
[424.920556] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[424.932930] Starting dynamic subtest: pipe-D-eDP-1
[427.345014] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[427.347405] Subtest get-idle: SUCCESS (9.181s)
[428.153660] [121/132] (595s left) gem_exec_schedule (promotion)
[428.223937] Starting subtest: promotion
[428.225913] Starting dynamic subtest: rcs0
[428.321569] Dynamic subtest rcs0: SUCCESS (0.106s)
[428.333788] Starting dynamic subtest: vcs0
[428.412985] Dynamic subtest vcs0: SUCCESS (0.088s)
[428.426480] Starting dynamic subtest: vcs1
[428.512882] Dynamic subtest vcs1: SUCCESS (0.099s)
[428.525799] Starting dynamic subtest: vecs0
[428.604039] Dynamic subtest vecs0: SUCCESS (0.091s)
[428.615643] Starting dynamic subtest: ccs0
[428.715764] Dynamic subtest ccs0: SUCCESS (0.110s)
[428.718416] Subtest promotion: SUCCESS (0.501s)
[430.453356] [122/132] (593s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[430.563334] Starting subtest: primary-x-tiled-reflect-x-180
[437.710246] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.148s)
[438.927249] [123/132] (585s left) kms_lease (lease-unleased-crtc)
[439.025985] Starting subtest: lease-unleased-crtc
[439.028320] Starting dynamic subtest: pipe-A-eDP-1
[439.317154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[439.327814] Starting dynamic subtest: pipe-B-eDP-1
[440.083162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[440.096306] Starting dynamic subtest: pipe-C-eDP-1
[440.098391] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[440.107459] Starting dynamic subtest: pipe-D-eDP-1
[440.109438] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[440.111427] Subtest lease-unleased-crtc: SUCCESS (1.069s)
[440.462174] [124/132] (583s left) sw_sync (alloc_merge_fence)
[440.502173] Starting subtest: alloc_merge_fence
[440.504158] Subtest alloc_merge_fence: SUCCESS (0.000s)
[440.556608] [125/132] (583s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[440.618355] Starting subtest: invalid-bsd1-flag-on-blt
[440.620307] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[440.726950] [126/132] (583s left) gem_mmap_offset (open-flood)
[440.785513] Starting subtest: open-flood
[462.279127] Subtest open-flood: SUCCESS (21.490s)
[462.384371] [127/132] (561s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[462.487942] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[462.491585] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[462.582921] [128/132] (561s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[462.675190] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[462.678977] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[462.764219] [129/132] (561s left) kms_pm_rpm (dpms-lpsp)
[464.488553] Starting subtest: dpms-lpsp
[464.935311] Subtest dpms-lpsp: SUCCESS (0.450s)
[465.040289] [130/132] (559s left) kms_cursor_edge_walk (64x64-left-edge)
[465.136777] Starting subtest: 64x64-left-edge
[465.139081] Starting dynamic subtest: pipe-A-eDP-1
[468.556574] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[468.566398] Starting dynamic subtest: pipe-D-eDP-1
[471.684874] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[471.687085] Subtest 64x64-left-edge: SUCCESS (6.547s)
[472.494926] [131/132] (551s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[472.603634] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[472.607731] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[472.705005] [132/132] (551s left) kms_async_flips (async-flip-dpms)
[472.799434] Starting subtest: async-flip-dpms
[473.182763] Starting dynamic subtest: pipe-A-eDP-1
[476.997045] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.813s)
[477.379476] Starting dynamic subtest: pipe-B-eDP-1
[480.182865] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[480.552402] Starting dynamic subtest: pipe-C-eDP-1
[483.352122] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.807s)
[483.737780] Starting dynamic subtest: pipe-D-eDP-1
[486.522793] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.792s)
[486.525055] Subtest async-flip-dpms: SUCCESS (13.721s)
[487.706070] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: perf_pmu
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gem_huc_copy
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_ctx_persistence
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_close
results: parsing output: 12/ for test: sysfs_timeslice_duration
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_chamelium_frames
results: parsing output: 17/ for test: gem_userptr_blits
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: sriov_basic
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_plane_multiple
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: prime_vgem
results: parsing output: 28/ for test: gem_mmap_wc
results: parsing output: 29/ for test: core_debugfs
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_getfb
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_spin_batch
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_chamelium_color
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: fbdev
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_rotation_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: i915_query
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_rotation_crc
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: device_reset
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: gem_exec_flush
results: parsing output: 95/ for test: kms_prop_blob
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: gem_unfence_active_buffers
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: gen7_exec_parse
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_create
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_pipe_crc_basic
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_plane_scaling
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_close_race
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: sw_sync
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: gem_mmap_offset
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_pm_rpm
results: parsing output: 129/ for test: kms_cursor_edge_walk
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_async_flips
Done.