[58.585544] Initializing watchdogs
[58.585659]   /dev/watchdog0
[58.600639] [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.605342] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.607503] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.611213] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[58.727602] Starting subtest: primary-yf-tiled-reflect-x-0
[58.806071] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.080s)
[58.905931] [002/133] (960s left) perf (gen12-group-concurrent-oa-buffer-read)
[59.038116] Starting subtest: gen12-group-concurrent-oa-buffer-read
[69.066045] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.001s)
[69.110867] [003/133] (950s left) fbdev (info)
[69.148656] Starting subtest: info
[69.150668] Subtest info: SUCCESS (0.000s)
[69.211520] [004/133] (950s left) gem_ctx_shared (q-out-order)
[69.282698] Starting subtest: Q-out-order
[69.285192] Starting dynamic subtest: rcs0
[69.460085] Dynamic subtest rcs0: SUCCESS (0.175s)
[69.475199] Starting dynamic subtest: vcs0
[69.569529] Dynamic subtest vcs0: SUCCESS (0.110s)
[69.586601] Starting dynamic subtest: vcs1
[69.683969] Dynamic subtest vcs1: SUCCESS (0.114s)
[69.699428] Starting dynamic subtest: vecs0
[69.787617] Dynamic subtest vecs0: SUCCESS (0.102s)
[69.802321] Starting dynamic subtest: ccs0
[69.905507] Dynamic subtest ccs0: SUCCESS (0.117s)
[69.908427] Subtest Q-out-order: SUCCESS (0.620s)
[71.028772] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[71.033755] [005/133] (948s left) gem_exec_balancer (busy)
[71.096097] Starting subtest: busy
[72.914701] Subtest busy: SUCCESS (1.815s)
[73.227061] [006/133] (946s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[73.326507] Starting subtest: fbcpsr-shrfb-scaledprimary
[79.107655] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.782s)
[79.254278] [007/133] (940s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[79.372984] Starting subtest: pixel-format-linear-modifier-source-clamping
[79.399975] Starting dynamic subtest: pipe-A-plane-0
[82.966484] Dynamic subtest pipe-A-plane-0: SUCCESS (3.567s)
[82.973506] Starting dynamic subtest: pipe-A-plane-3
[84.622756] Dynamic subtest pipe-A-plane-3: SUCCESS (1.655s)
[85.756347] Starting dynamic subtest: pipe-B-plane-0
[89.373825] Dynamic subtest pipe-B-plane-0: SUCCESS (3.622s)
[89.381757] Starting dynamic subtest: pipe-B-plane-3
[91.018953] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[91.348203] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (11.971s)
[92.150888] [008/133] (927s left) gem_exec_balancer (parallel-keep-submit-fence)
[92.411060] Starting subtest: parallel-keep-submit-fence
[93.519056] Subtest parallel-keep-submit-fence: SUCCESS (1.108s)
[93.605977] [009/133] (925s left) i915_drm_fdinfo (memory-info-resident)
[93.645348] Starting subtest: memory-info-resident
[93.647657] Starting dynamic subtest: smem0
[96.240024] Dynamic subtest smem0: SUCCESS (2.595s)
[96.242722] Subtest memory-info-resident: SUCCESS (2.595s)
[96.311322] [010/133] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[96.406747] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[96.410352] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[96.523763] [011/133] (922s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[96.632679] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[96.636147] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[96.698501] [012/133] (922s left) i915_pm_freq_api (freq-reset-multiple)
[96.757093] Starting subtest: freq-reset-multiple
[96.759165] Starting dynamic subtest: gt0
[106.369662] Dynamic subtest gt0: SUCCESS (9.609s)
[106.385838] Starting dynamic subtest: gt1
[115.109858] Dynamic subtest gt1: SUCCESS (8.738s)
[115.112874] Subtest freq-reset-multiple: SUCCESS (18.348s)
[115.183494] [013/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[115.276256] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[122.526079] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.253s)
[122.673234] [014/133] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[122.773881] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[129.428777] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.656s)
[129.566164] [015/133] (890s left) kms_invalid_mode (bad-vtotal)
[129.664399] Starting subtest: bad-vtotal
[129.666723] Starting dynamic subtest: pipe-A-eDP-1
[129.952519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[129.961707] Starting dynamic subtest: pipe-B-eDP-1
[129.963633] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[129.971080] Starting dynamic subtest: pipe-C-eDP-1
[129.973487] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[129.981155] Starting dynamic subtest: pipe-D-eDP-1
[129.983479] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[129.985814] Subtest bad-vtotal: SUCCESS (0.291s)
[130.828374] [016/133] (888s left) kms_pm_rpm (pm-caching)
[133.083024] Starting subtest: pm-caching
[133.088247] Subtest pm-caching: SKIP (0.000s)
[133.455813] [017/133] (886s left) sw_sync (sync_busy)
[133.495359] Starting subtest: sync_busy
[133.497552] Subtest sync_busy: SUCCESS (0.002s)
[133.551042] [018/133] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[133.651314] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[133.655612] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.740275] [019/133] (886s left) gem_exec_reloc (basic-gtt-cpu-active)
[133.798684] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[133.870952] [020/133] (885s left) syncobj_timeline (etime-single-wait-all-submitted)
[133.924836] Starting subtest: etime-single-wait-all-submitted
[134.033258] Subtest etime-single-wait-all-submitted: SUCCESS (0.106s)
[134.109729] [021/133] (885s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[134.208523] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[134.212879] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[134.299594] [022/133] (885s left) syncobj_timeline (single-wait-all-available-submitted)
[134.362696] Starting subtest: single-wait-all-available-submitted
[134.365050] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[134.474585] [023/133] (885s left) gem_exec_params (invalid-fence-in-submit)
[134.527178] Starting subtest: invalid-fence-in-submit
[134.532304] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[134.637598] [024/133] (885s left) kms_async_flips (crc-atomic)
[134.720945] Starting subtest: crc-atomic
[135.099981] Starting dynamic subtest: pipe-A-eDP-1
[137.971867] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.870s)
[138.363091] Starting dynamic subtest: pipe-B-eDP-1
[141.226926] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.872s)
[141.612973] Starting dynamic subtest: pipe-C-eDP-1
[144.542124] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s)
[144.913536] Starting dynamic subtest: pipe-D-eDP-1
[147.755909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.853s)
[147.758262] Subtest crc-atomic: SUCCESS (13.036s)
[148.914068] [025/133] (871s left) gem_userptr_blits (create-destroy-sync)
[148.983733] Starting subtest: create-destroy-sync
[154.003912] Subtest create-destroy-sync: SUCCESS (5.014s)
[154.122262] [026/133] (865s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[154.222373] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[163.492750] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.272s)
[163.605727] [027/133] (856s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[163.709097] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[163.711298] Starting dynamic subtest: pipe-A-eDP-1
[163.733670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.742646] Starting dynamic subtest: pipe-B-eDP-1
[163.764171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.772468] Starting dynamic subtest: pipe-C-eDP-1
[163.794287] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.803215] Starting dynamic subtest: pipe-D-eDP-1
[163.825253] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.829214] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[165.901690] [028/133] (854s left) kms_selftest (drm_damage_helper)
[165.937961] Starting subtest: drm_damage_helper
[165.979779] Starting dynamic subtest: drm_test_damage_iter_no_damage
[166.056762] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.080s)
[166.065700] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[166.153728] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.097s)
[166.166247] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[166.242990] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.088s)
[166.252594] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[166.340853] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.097s)
[166.349956] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[166.429803] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.088s)
[166.437078] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[166.524233] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.095s)
[166.533674] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[166.621620] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.096s)
[166.629215] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[166.710509] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.089s)
[166.719903] Starting dynamic subtest: drm_test_damage_iter_single_damage
[166.795578] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.084s)
[166.803106] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[166.885163] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.090s)
[166.892281] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[166.977554] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.090s)
[166.984828] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[167.077125] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.100s)
[167.084024] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[167.176500] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.098s)
[167.183799] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[167.262212] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.086s)
[167.269815] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[167.367624] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.105s)
[167.374920] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[167.450137] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.082s)
[167.458060] Starting dynamic subtest: drm_test_damage_iter_damage
[167.534360] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.084s)
[167.541582] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[167.624125] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.088s)
[167.631277] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[167.713315] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.090s)
[167.721732] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[167.803835] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.089s)
[167.810828] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[167.908668] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.104s)
[167.910357] Subtest drm_damage_helper: SUCCESS (1.969s)
[168.056238] [029/133] (852s left) gem_create (create-ext-placement-all)
[168.216508] Starting subtest: create-ext-placement-all
[168.218579] Subtest create-ext-placement-all: SUCCESS (0.000s)
[168.316136] [030/133] (851s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[168.447046] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[169.479635] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.031s)
[169.601476] [031/133] (850s left) syncobj_wait (invalid-signal-zero-handles)
[169.656127] Starting subtest: invalid-signal-zero-handles
[169.658259] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[169.775622] [032/133] (850s left) kms_atomic_transition (plane-all-transition)
[169.860305] Starting subtest: plane-all-transition
[169.862068] Starting dynamic subtest: pipe-A-eDP-1
[172.353918] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[172.663471] Starting dynamic subtest: pipe-B-eDP-1
[175.930198] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.276s)
[176.228649] Subtest plane-all-transition: SUCCESS (6.368s)
[177.063938] [033/133] (843s left) gem_softpin (safe-alignment)
[177.135242] Starting subtest: safe-alignment
[177.161210] Subtest safe-alignment: SUCCESS (0.026s)
[178.939811] [034/133] (841s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[179.042126] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[179.046315] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.134476] [035/133] (841s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[179.244059] Starting subtest: 4-tiled-64bpp-rotate-90
[179.263941] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[179.388313] [036/133] (841s left) kms_chamelium_edid (dp-mode-timings)
[179.792336] Subtest dp-mode-timings: SKIP (0.000s)
[180.577975] [037/133] (839s left) kms_cursor_crc (cursor-random-32x10)
[180.746847] Starting subtest: cursor-random-32x10
[180.789875] Subtest cursor-random-32x10: SKIP (0.041s)
[181.060427] [038/133] (839s left) kms_cursor_legacy (forked-bo)
[181.185922] Starting subtest: forked-bo
[181.188222] Starting dynamic subtest: pipe-A
[186.667961] Dynamic subtest pipe-A: SUCCESS (5.477s)
[186.680567] Starting dynamic subtest: pipe-B
[192.144803] Dynamic subtest pipe-B: SUCCESS (5.475s)
[192.160103] Starting dynamic subtest: pipe-C
[197.618574] Dynamic subtest pipe-C: SUCCESS (5.471s)
[197.631915] Starting dynamic subtest: pipe-D
[203.086379] Dynamic subtest pipe-D: SUCCESS (5.466s)
[203.097157] Starting dynamic subtest: all-pipes
[208.587993] Dynamic subtest all-pipes: SUCCESS (5.499s)
[208.590511] Subtest forked-bo: SUCCESS (27.398s)
[208.743317] [039/133] (811s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[208.842646] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[216.060859] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.220s)
[216.159894] [040/133] (804s left) gem_ctx_exec (basic-norecovery)
[216.219206] Starting subtest: basic-norecovery
[216.579635] Subtest basic-norecovery: SUCCESS (0.361s)
[216.691695] [041/133] (803s left) kms_cursor_crc (cursor-onscreen-max-size)
[217.016300] Starting subtest: cursor-onscreen-max-size
[217.021517] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[217.144436] [042/133] (803s left) prime_mmap (test_reprime)
[217.193613] Starting subtest: test_reprime
[217.195497] Starting dynamic subtest: test_reprime-smem
[217.223200] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[217.225473] Subtest test_reprime: SUCCESS (0.031s)
[217.337711] [043/133] (803s left) gem_lmem_swapping (verify)
[217.376733] Subtest verify: SKIP (0.000s)
[217.422809] [044/133] (803s left) kms_plane_lowres (tiling-y)
[217.525490] Starting subtest: tiling-y
[217.529096] Subtest tiling-y: SKIP (0.000s)
[217.595950] [045/133] (803s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[217.683936] Starting subtest: y-tiled-32bpp-rotate-270
[217.687376] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[217.778549] [046/133] (803s left) kms_flip (flip-vs-suspend-interruptible)
[217.864244] Starting subtest: flip-vs-suspend-interruptible
[217.866338] Starting dynamic subtest: A-eDP1
[251.294748] Dynamic subtest A-eDP1: SUCCESS (4.293s)
[251.306333] Starting dynamic subtest: B-eDP1
[300.287963] Dynamic subtest B-eDP1: SUCCESS (4.448s)
[300.297479] Starting dynamic subtest: C-eDP1
[349.305145] Dynamic subtest C-eDP1: SUCCESS (4.459s)
[349.315129] Starting dynamic subtest: D-eDP1
[398.298806] Dynamic subtest D-eDP1: SUCCESS (4.487s)
[398.303818] Subtest flip-vs-suspend-interruptible: SUCCESS (17.698s)
[399.491304] [047/133] (621s left) sysfs_heartbeat_interval (idempotent)
[399.552077] Starting subtest: idempotent
[399.554306] Starting dynamic subtest: vecs0
[399.556646] Dynamic subtest vecs0: SUCCESS (0.001s)
[399.566647] Starting dynamic subtest: ccs0
[399.568563] Dynamic subtest ccs0: SUCCESS (0.001s)
[399.577447] Starting dynamic subtest: vcs0
[399.579668] Dynamic subtest vcs0: SUCCESS (0.000s)
[399.587927] Starting dynamic subtest: bcs0
[399.589837] Dynamic subtest bcs0: SUCCESS (0.001s)
[399.597654] Starting dynamic subtest: rcs0
[399.599564] Dynamic subtest rcs0: SUCCESS (0.001s)
[399.607444] Starting dynamic subtest: vcs1
[399.609301] Dynamic subtest vcs1: SUCCESS (0.000s)
[399.611173] Subtest idempotent: SUCCESS (0.008s)
[399.650756] [048/133] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[399.759061] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[399.763424] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[399.856335] [049/133] (621s left) gem_mmap_wc (coherency)
[399.907954] Subtest coherency: SKIP (0.000s)
[399.966090] [050/133] (621s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[400.071568] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[401.195234] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.103s)
[401.319576] [051/133] (619s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[401.421629] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[401.425067] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[401.541019] [052/133] (619s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[401.599250] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[401.602656] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[401.807897] [053/133] (619s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[401.911865] Starting subtest: x-tiled-32bpp-rotate-90
[401.934433] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[402.046286] [054/133] (619s left) core_getclient (basic)
[402.097688] Starting subtest: basic
[402.099844] Subtest basic: SUCCESS (0.000s)
[402.209379] [055/133] (619s left) kms_psr (psr2-cursor-plane-move)
[402.305694] Starting subtest: psr2-cursor-plane-move
[402.308078] Starting dynamic subtest: eDP-1
[404.025033] Dynamic subtest eDP-1: SUCCESS (1.696s)
[404.027356] Subtest psr2-cursor-plane-move: SUCCESS (1.697s)
[404.827568] [056/133] (616s left) gem_exec_schedule (preempt-self)
[404.903178] Starting subtest: preempt-self
[404.905690] Starting dynamic subtest: rcs0
[404.917150] Dynamic subtest rcs0: SUCCESS (0.023s)
[404.930607] Starting dynamic subtest: bcs0
[404.938675] Dynamic subtest bcs0: SUCCESS (0.020s)
[404.947702] Starting dynamic subtest: vcs0
[404.957984] Dynamic subtest vcs0: SUCCESS (0.019s)
[404.968545] Starting dynamic subtest: vcs1
[404.981125] Dynamic subtest vcs1: SUCCESS (0.022s)
[404.990184] Starting dynamic subtest: vecs0
[405.001530] Dynamic subtest vecs0: SUCCESS (0.019s)
[405.012338] Starting dynamic subtest: ccs0
[405.022289] Dynamic subtest ccs0: SUCCESS (0.019s)
[405.024655] Subtest preempt-self: SUCCESS (0.128s)
[406.499972] [057/133] (614s left) gem_userptr_blits (sd-probe)
[406.570990] Starting subtest: sd-probe
[406.572965] Subtest sd-probe: SUCCESS (0.000s)
[406.717593] [058/133] (614s left) gem_lmem_swapping (heavy-multi)
[406.764109] Subtest heavy-multi: SKIP (0.000s)
[406.810528] [059/133] (614s left) gem_mmap_offset (close-race)
[406.877995] Starting subtest: close-race
[426.989998] Subtest close-race: SUCCESS (20.049s)
[427.110619] [060/133] (594s left) i915_pm_rc6_residency (rc6-accuracy)
[427.173410] Starting subtest: rc6-accuracy
[427.175585] Starting dynamic subtest: gt0
[430.347545] Dynamic subtest gt0: SUCCESS (3.168s)
[430.357758] Starting dynamic subtest: gt1
[433.518050] Dynamic subtest gt1: SUCCESS (3.168s)
[433.520459] Subtest rc6-accuracy: SUCCESS (6.342s)
[433.591327] [061/133] (587s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[433.689183] Starting subtest: crc-primary-suspend-y-tiled-ccs
[433.691516] Starting dynamic subtest: pipe-A-eDP-1
[433.700570] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.710155] Starting dynamic subtest: pipe-B-eDP-1
[433.719143] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.727526] Starting dynamic subtest: pipe-C-eDP-1
[433.735974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.744111] Starting dynamic subtest: pipe-D-eDP-1
[433.752524] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[433.756629] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[435.883900] [062/133] (585s left) kms_flip (flip-vs-fences-interruptible)
[435.970381] Starting subtest: flip-vs-fences-interruptible
[435.974628] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[436.080997] [063/133] (585s left) kms_psr (fbc-pr-primary-mmap-cpu)
[436.166602] Starting subtest: fbc-pr-primary-mmap-cpu
[436.170454] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[436.250914] [064/133] (585s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[436.306781] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[436.415221] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[436.491515] [065/133] (585s left) api_intel_allocator (fork-simple-once)
[436.544696] Starting subtest: fork-simple-once
[436.561076] Subtest fork-simple-once: SUCCESS (0.019s)
[436.689275] [066/133] (584s left) kms_flip (modeset-vs-vblank-race-interruptible)
[436.792684] Starting subtest: modeset-vs-vblank-race-interruptible
[436.795064] Starting dynamic subtest: A-eDP1
[441.494086] Dynamic subtest A-eDP1: SUCCESS (4.701s)
[441.504831] Starting dynamic subtest: B-eDP1
[446.140248] Dynamic subtest B-eDP1: SUCCESS (4.643s)
[446.152294] Starting dynamic subtest: C-eDP1
[450.724010] Dynamic subtest C-eDP1: SUCCESS (4.580s)
[450.734774] Starting dynamic subtest: D-eDP1
[455.246584] Dynamic subtest D-eDP1: SUCCESS (4.521s)
[455.251708] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.458s)
[456.417560] [067/133] (565s left) kms_flip (2x-plain-flip-fb-recreate)
[456.524387] Starting subtest: 2x-plain-flip-fb-recreate
[456.534414] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[456.627281] [068/133] (565s left) kms_getfb (getfb-repeated-different-handles)
[456.712575] Starting subtest: getfb-repeated-different-handles
[456.714826] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[456.804679] [069/133] (565s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[456.899664] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[456.903627] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[456.973394] [070/133] (564s left) sw_sync (sync_multi_producer_single_consumer)
[457.012476] Starting subtest: sync_multi_producer_single_consumer
[458.088050] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[458.149338] [071/133] (563s left) gem_exec_parallel (basic)
[458.214827] Starting subtest: basic
[458.217296] Starting dynamic subtest: rcs0
[459.731345] Dynamic subtest rcs0: SUCCESS (1.515s)
[459.747915] Starting dynamic subtest: bcs0
[461.202218] Dynamic subtest bcs0: SUCCESS (1.467s)
[461.211560] Starting dynamic subtest: vcs0
[464.404934] Dynamic subtest vcs0: SUCCESS (3.198s)
[464.414947] Starting dynamic subtest: vcs1
[466.386962] Dynamic subtest vcs1: SUCCESS (1.979s)
[466.398707] Starting dynamic subtest: vecs0
[468.434748] Dynamic subtest vecs0: SUCCESS (2.044s)
[468.446268] Starting dynamic subtest: ccs0
[469.913208] Dynamic subtest ccs0: SUCCESS (1.476s)
[469.916409] Subtest basic: SUCCESS (11.695s)
[470.104553] [072/133] (551s left) gen3_render_mixed_blits
[470.231564] [073/133] (551s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[470.320117] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[470.322644] Starting dynamic subtest: pipe-A-eDP-1
[470.344407] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[470.360112] Starting dynamic subtest: pipe-B-eDP-1
[470.379877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[470.388615] Starting dynamic subtest: pipe-C-eDP-1
[470.408210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[470.416895] Starting dynamic subtest: pipe-D-eDP-1
[470.436193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[470.438426] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[472.792978] [074/133] (549s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[472.893900] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[472.898477] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[472.992749] [075/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[473.090406] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[473.094558] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[473.196053] [076/133] (548s left) gem_mmap_wc (write-read-distinct)
[473.256396] Subtest write-read-distinct: SKIP (0.000s)
[473.322135] [077/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[473.415092] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[473.419614] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[473.522501] [078/133] (548s left) kms_lease (invalid-create-leases)
[473.619187] Starting subtest: invalid-create-leases
[473.624361] Subtest invalid-create-leases: SUCCESS (0.006s)
[473.726327] [079/133] (548s left) gem_userptr_blits (coherency-sync)
[473.804734] Starting subtest: coherency-sync
[474.240604] Subtest coherency-sync: SKIP (0.402s)
[474.366931] [080/133] (547s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[474.506850] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[474.510836] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[474.613257] [081/133] (547s left) gem_mmap_gtt (basic-read-write)
[474.665536] Subtest basic-read-write: SKIP (0.000s)
[474.723690] [082/133] (547s left) kms_cursor_edge_walk (256x256-top-bottom)
[474.817547] Starting subtest: 256x256-top-bottom
[474.819805] Starting dynamic subtest: pipe-A-eDP-1
[478.258986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[478.268167] Starting dynamic subtest: pipe-D-eDP-1
[481.388543] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[481.391052] Subtest 256x256-top-bottom: SUCCESS (6.570s)
[482.191223] [083/133] (540s left) perf_pmu (event-wait)
[482.232790] Starting subtest: event-wait
[482.235031] Starting dynamic subtest: rcs0
[482.239485] Dynamic subtest rcs0: SKIP (0.000s)
[482.243699] Subtest event-wait: SKIP (0.001s)
[482.350974] [084/133] (540s left) gem_exec_reloc (basic-cpu)
[482.408002] Subtest basic-cpu: SKIP (0.000s)
[482.486693] [085/133] (539s left) kms_color (invalid-degamma-lut-sizes)
[482.577651] Starting subtest: invalid-degamma-lut-sizes
[482.579802] Starting dynamic subtest: pipe-A
[482.862801] Dynamic subtest pipe-A: SUCCESS (0.285s)
[482.871848] Starting dynamic subtest: pipe-B
[482.874222] Dynamic subtest pipe-B: SUCCESS (0.000s)
[482.882914] Starting dynamic subtest: pipe-C
[482.885309] Dynamic subtest pipe-C: SUCCESS (0.000s)
[482.900347] Starting dynamic subtest: pipe-D
[482.902451] Dynamic subtest pipe-D: SUCCESS (0.000s)
[482.904306] Subtest invalid-degamma-lut-sizes: SUCCESS (0.289s)
[483.723527] [086/133] (538s left) kms_chamelium_color (ctm-blue-to-red)
[483.840849] Subtest ctm-blue-to-red: SKIP (0.000s)
[483.886927] [087/133] (538s left) gem_exec_fence (syncobj-import)
[484.337925] Starting subtest: syncobj-import
[484.340614] Subtest syncobj-import: SUCCESS (0.006s)
[485.484197] [088/133] (537s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[485.544913] Subtest no-spare-fences-busy: SKIP (0.000s)
[485.619670] [089/133] (537s left) kms_psr (fbc-psr-primary-page-flip)
[485.710838] Starting subtest: fbc-psr-primary-page-flip
[485.713107] Starting dynamic subtest: eDP-1
[485.717166] Dynamic subtest eDP-1: SKIP (0.000s)
[485.721555] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[485.782578] [090/133] (536s left) i915_query (engine-info-invalid)
[485.848062] Starting subtest: engine-info-invalid
[485.850484] Subtest engine-info-invalid: SUCCESS (0.000s)
[485.936780] [091/133] (536s left) syncobj_timeline (reset-during-wait-for-submit)
[485.991797] Starting subtest: reset-during-wait-for-submit
[486.094185] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[486.170503] [092/133] (536s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[486.254684] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[486.259017] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[486.339816] [093/133] (536s left) kms_content_protection (dp-mst-type-0)
[486.475492] Starting subtest: dp-mst-type-0
[486.480068] Subtest dp-mst-type-0: SKIP (0.000s)
[486.584568] [094/133] (536s left) kms_pm_rpm (basic-pci-d3-state)
[488.528061] Starting subtest: basic-pci-d3-state
[490.011990] Subtest basic-pci-d3-state: SUCCESS (1.486s)
[490.114440] [095/133] (532s left) gem_fence_thrash (bo-copy)
[490.151742] Starting subtest: bo-copy
[490.164934] Subtest bo-copy: SKIP (0.010s)
[490.221487] [096/133] (532s left) gem_pxp (reject-modify-context-protection-off-3)
[490.340305] Starting subtest: reject-modify-context-protection-off-3
[490.342650] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[490.453921] [097/133] (532s left) prime_vgem (wait)
[490.524078] Starting subtest: wait
[490.526425] Starting dynamic subtest: rcs0
[490.562208] Dynamic subtest rcs0: SUCCESS (0.038s)
[490.571657] Starting dynamic subtest: bcs0
[490.615280] Dynamic subtest bcs0: SUCCESS (0.051s)
[490.624233] Starting dynamic subtest: vcs0
[490.660584] Dynamic subtest vcs0: SUCCESS (0.044s)
[490.669591] Starting dynamic subtest: vcs1
[490.707424] Dynamic subtest vcs1: SUCCESS (0.046s)
[490.716869] Starting dynamic subtest: vecs0
[490.751727] Dynamic subtest vecs0: SUCCESS (0.043s)
[490.761060] Starting dynamic subtest: ccs0
[490.798064] Dynamic subtest ccs0: SUCCESS (0.045s)
[490.800272] Subtest wait: SUCCESS (0.275s)
[490.934926] [098/133] (532s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[491.030347] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[491.034115] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[491.130174] [099/133] (531s left) kms_dsc (dsc-basic)
[491.217828] Starting subtest: dsc-basic
[491.228610] Subtest dsc-basic: SKIP (0.000s)
[491.295261] [100/133] (531s left) gem_mmap_wc (bad-size)
[491.355177] Subtest bad-size: SKIP (0.000s)
[491.411343] [101/133] (531s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[491.452926] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[491.557897] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[491.650417] [102/133] (531s left) kms_psr (pr-cursor-mmap-cpu)
[491.737396] Starting subtest: pr-cursor-mmap-cpu
[491.741010] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[491.820537] [103/133] (531s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[491.912320] Starting subtest: fbc-rgb565-draw-mmap-gtt
[491.916123] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[492.013760] [104/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[492.122595] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[498.671050] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.554s)
[498.812161] [105/133] (524s left) kms_setmode (invalid-clone-exclusive-crtc)
[498.872782] Starting subtest: invalid-clone-exclusive-crtc
[498.878619] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[498.968180] [106/133] (524s left) gem_readwrite (write-bad-handle)
[499.024978] Subtest write-bad-handle: SKIP (0.000s)
[499.079427] [107/133] (524s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[499.465500] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[500.300623] [108/133] (523s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[500.398147] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[500.402524] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[500.496196] [109/133] (522s left) kms_vblank (query-forked-hang)
[500.594423] Starting subtest: query-forked-hang
[500.596690] Starting dynamic subtest: pipe-A-eDP-1
[527.186614] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.594s)
[527.202511] Starting dynamic subtest: pipe-D-eDP-1
[551.197447] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.003s)
[551.199848] Subtest query-forked-hang: SUCCESS (50.606s)
[552.073917] [110/133] (471s left) gem_exec_schedule (preempt-other)
[552.148279] Starting subtest: preempt-other
[552.150694] Starting dynamic subtest: rcs0
[552.216163] Dynamic subtest rcs0: SUCCESS (0.076s)
[552.229104] Starting dynamic subtest: bcs0
[552.292392] Dynamic subtest bcs0: SUCCESS (0.076s)
[552.305611] Starting dynamic subtest: vcs0
[552.358566] Dynamic subtest vcs0: SUCCESS (0.065s)
[552.368290] Starting dynamic subtest: vcs1
[552.423303] Dynamic subtest vcs1: SUCCESS (0.064s)
[552.439841] Starting dynamic subtest: vecs0
[552.486636] Dynamic subtest vecs0: SUCCESS (0.062s)
[552.499257] Starting dynamic subtest: ccs0
[552.552656] Dynamic subtest ccs0: SUCCESS (0.065s)
[552.555317] Subtest preempt-other: SUCCESS (0.413s)
[553.502787] [111/133] (470s left) gem_exec_whisper (basic-contexts-forked)
[553.568133] Starting subtest: basic-contexts-forked
[577.147093] Subtest basic-contexts-forked: SUCCESS (23.572s)
[577.329590] [112/133] (446s left) intel_hwmon (hwmon-write)
[577.401464] Subtest hwmon-write: SKIP (0.000s)
[577.462066] [113/133] (446s left) perf (invalid-open-flags)
[577.569731] Starting subtest: invalid-open-flags
[577.571996] Subtest invalid-open-flags: SUCCESS (0.000s)
[577.617307] [114/133] (446s left) kms_plane_alpha_blend (constant-alpha-min)
[577.710387] Starting subtest: constant-alpha-min
[578.007939] Starting dynamic subtest: pipe-A-eDP-1
[578.722721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[578.733912] Starting dynamic subtest: pipe-D-eDP-1
[580.156066] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.430s)
[580.158420] Subtest constant-alpha-min: SUCCESS (2.444s)
[580.951977] [115/133] (442s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[581.055695] Starting subtest: plane-upscale-20x20-with-pixel-format
[581.057907] Starting dynamic subtest: pipe-A
[582.102726] Dynamic subtest pipe-A: SUCCESS (1.050s)
[582.112792] Starting dynamic subtest: pipe-B
[584.252853] Dynamic subtest pipe-B: SUCCESS (2.149s)
[584.263113] Starting dynamic subtest: pipe-C
[585.451943] Dynamic subtest pipe-C: SUCCESS (1.197s)
[585.462916] Starting dynamic subtest: pipe-D
[586.602602] Dynamic subtest pipe-D: SUCCESS (1.149s)
[586.604875] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.549s)
[587.790028] [116/133] (435s left) core_setmaster (master-drop-set-shared-fd)
[587.899293] Starting subtest: master-drop-set-shared-fd
[587.917398] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[587.962341] [117/133] (435s left) prime_self_import (basic-llseek-size)
[587.999012] Starting subtest: basic-llseek-size
[588.019823] Subtest basic-llseek-size: SUCCESS (0.022s)
[588.116534] [118/133] (435s left) kms_psr (psr-primary-blt)
[588.204441] Starting subtest: psr-primary-blt
[588.206733] Starting dynamic subtest: eDP-1
[589.898757] Dynamic subtest eDP-1: SUCCESS (1.692s)
[589.900936] Subtest psr-primary-blt: SUCCESS (1.693s)
[590.760141] [119/133] (433s left) kms_psr (fbc-psr2-primary-blt)
[590.847545] Starting subtest: fbc-psr2-primary-blt
[590.849806] Starting dynamic subtest: eDP-1
[590.853887] Dynamic subtest eDP-1: SKIP (0.000s)
[590.857991] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[590.927723] [120/133] (432s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[591.033960] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[591.038005] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[591.116591] [121/133] (432s left) kms_addfb_basic (invalid-set-prop)
[591.169964] Starting subtest: invalid-set-prop
[591.171935] Subtest invalid-set-prop: SUCCESS (0.000s)
[591.297395] [122/133] (432s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[591.387168] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[591.389432] Starting dynamic subtest: pipe-A-eDP-1
[591.411655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[591.422944] Starting dynamic subtest: pipe-B-eDP-1
[591.442858] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[591.454045] Starting dynamic subtest: pipe-C-eDP-1
[591.474507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[591.483983] Starting dynamic subtest: pipe-D-eDP-1
[591.505108] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[591.509383] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[593.641804] [123/133] (430s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[593.741562] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[593.745474] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[593.865896] [124/133] (430s left) gem_tiling_max_stride
[593.995562] [125/133] (430s left) gem_exec_flush (basic-uc-ro-default)
[594.049758] Starting subtest: basic-uc-ro-default
[599.511213] Subtest basic-uc-ro-default: SUCCESS (5.461s)
[599.713495] [126/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[599.816560] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[599.820453] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[599.916601] [127/133] (424s left) perf (blocking)
[599.996704] Starting subtest: blocking
[599.999000] Starting dynamic subtest: 0-rcs0
[610.020408] Dynamic subtest 0-rcs0: SUCCESS (10.019s)
[610.032151] Starting dynamic subtest: 1-vecs0
[620.045137] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[620.047763] Subtest blocking: SUCCESS (20.041s)
[620.098027] [128/133] (404s left) gen9_exec_parse (batch-invalid-length)
[620.156091] Subtest batch-invalid-length: SKIP (0.000s)
[620.229675] [129/133] (404s left) syncobj_wait (multi-wait-all-submitted-signaled)
[620.278017] Starting subtest: multi-wait-all-submitted-signaled
[620.383879] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[620.481244] [130/133] (403s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[620.553511] Starting subtest: invalid-multi-wait-unsubmitted
[620.555972] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[620.668698] [131/133] (403s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[620.782606] Starting subtest: yf-tiled-addfb-size-overflow
[620.787175] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[620.896688] [132/133] (403s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[620.991343] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[620.993626] Starting dynamic subtest: pipe-A
[622.151412] Dynamic subtest pipe-A: SUCCESS (1.163s)
[622.163956] Starting dynamic subtest: pipe-B
[624.329995] Dynamic subtest pipe-B: SUCCESS (2.178s)
[624.347166] Starting dynamic subtest: pipe-C
[625.537696] Dynamic subtest pipe-C: SUCCESS (1.207s)
[625.548361] Starting dynamic subtest: pipe-D
[626.681364] Dynamic subtest pipe-D: SUCCESS (1.143s)
[626.683770] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.694s)
[627.877875] [133/133] (396s left) gem_ctx_persistence (heartbeat-hang)
[627.939284] Starting subtest: heartbeat-hang
[627.943756] Subtest heartbeat-hang: SKIP (0.000s)
[628.037920] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: fbdev
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_plane
results: parsing output: 7/ for test: gem_exec_balancer
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: i915_pm_freq_api
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_invalid_mode
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: sw_sync
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: kms_selftest
results: parsing output: 28/ for test: gem_create
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_atomic_transition
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_chamelium_edid
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_cursor_legacy
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_ctx_exec
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_plane_lowres
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: sysfs_heartbeat_interval
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: core_getclient
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: gem_mmap_offset
results: parsing output: 59/ for test: i915_pm_rc6_residency
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: gem_exec_parallel
results: parsing output: 71/ for test: gen3_render_mixed_blits
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_cursor_edge_walk
results: parsing output: 82/ for test: perf_pmu
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_color
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_fenced_exec_thrash
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_pm_rpm
results: parsing output: 94/ for test: gem_fence_thrash
results: parsing output: 95/ for test: gem_pxp
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_dsc
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_setmode
results: parsing output: 105/ for test: gem_readwrite
results: parsing output: 106/ for test: kms_chamelium_hpd
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: intel_hwmon
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_plane_alpha_blend
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: core_setmaster
results: parsing output: 116/ for test: prime_self_import
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_tiling_max_stride
results: parsing output: 124/ for test: gem_exec_flush
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: gem_ctx_persistence
Done.