[55.196522] Initializing watchdogs
[55.196581]   /dev/watchdog0
[55.211495] [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]
[55.215935] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.218379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.221583] [001/132] (960s left) kms_pm_rpm (system-suspend-idle)
[57.511869] Starting subtest: system-suspend-idle
[77.376086] Subtest system-suspend-idle: SUCCESS (4.830s)
[86.780771] [002/132] (937s left) syncobj_timeline (invalid-signal-illegal-handle)
[86.855732] Starting subtest: invalid-signal-illegal-handle
[86.858151] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[86.948574] [003/132] (937s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[87.046206] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[87.050455] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.160014] [004/132] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[87.266667] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[87.270798] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[87.432775] [005/132] (937s left) gem_mmap_gtt (close-race)
[87.627796] Subtest close-race: SKIP (0.000s)
[87.781656] [006/132] (937s left) kms_chamelium_frames (hdmi-crc-single)
[88.253382] Subtest hdmi-crc-single: SKIP (0.000s)
[89.050674] [007/132] (935s left) kms_addfb_basic (unused-modifier)
[89.099406] Starting subtest: unused-modifier
[89.101655] Subtest unused-modifier: SUCCESS (0.000s)
[89.232440] [008/132] (935s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[89.327771] Starting subtest: extended-pageflip-modeset-hang-oldfb
[89.330062] Starting dynamic subtest: pipe-A
[97.238488] Dynamic subtest pipe-A: SUCCESS (7.908s)
[97.250395] Starting dynamic subtest: pipe-D
[105.886476] Dynamic subtest pipe-D: SUCCESS (8.647s)
[105.889533] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.558s)
[106.737492] [009/132] (918s left) gem_softpin (full)
[106.802250] Starting subtest: full
[106.814919] Subtest full: SUCCESS (0.013s)
[106.945377] [010/132] (918s left) kms_feature_discovery (display-3x)
[107.046621] Starting subtest: display-3x
[107.050772] Subtest display-3x: SKIP (0.000s)
[107.116635] [011/132] (918s left) gem_bad_reloc (negative-reloc)
[107.177706] Subtest negative-reloc: SKIP (0.000s)
[107.252426] [012/132] (917s left) gem_exec_flush (basic-wb-pro-default)
[107.329815] Starting subtest: basic-wb-pro-default
[112.814082] Subtest basic-wb-pro-default: SUCCESS (5.487s)
[113.008805] [013/132] (912s left) kms_vblank (accuracy-idle)
[113.099788] Starting subtest: accuracy-idle
[113.102212] Starting dynamic subtest: pipe-A-eDP-1
[114.868974] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[114.885429] Starting dynamic subtest: pipe-D-eDP-1
[117.278815] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.410s)
[117.281124] Subtest accuracy-idle: SUCCESS (4.178s)
[118.101719] [014/132] (907s left) i915_hangman (gt-error-state-capture)
[118.163558] Starting subtest: gt-error-state-capture
[118.165760] Starting dynamic subtest: rcs0
[129.339021] Dynamic subtest rcs0: SUCCESS (11.171s)
[129.351014] Starting dynamic subtest: bcs0
[141.306101] Dynamic subtest bcs0: SUCCESS (11.964s)
[141.318048] Starting dynamic subtest: vcs0
[153.276136] Dynamic subtest vcs0: SUCCESS (11.967s)
[153.288458] Starting dynamic subtest: vcs1
[164.283681] Dynamic subtest vcs1: SUCCESS (11.006s)
[164.295697] Starting dynamic subtest: vecs0
[176.317048] Dynamic subtest vecs0: SUCCESS (12.032s)
[176.328520] Starting dynamic subtest: ccs0
[188.283436] Dynamic subtest ccs0: SUCCESS (11.964s)
[188.286280] Subtest gt-error-state-capture: SUCCESS (70.111s)
[188.442977] [015/132] (836s left) kms_content_protection (type1)
[188.588191] Starting subtest: type1
[188.592742] Subtest type1: SKIP (0.000s)
[188.710401] [016/132] (836s left) i915_suspend (debugfs-reader)
[188.764599] Starting subtest: debugfs-reader
[207.129819] Subtest debugfs-reader: SUCCESS (4.274s)
[217.336448] [017/132] (818s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[217.446893] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[218.227823] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.781s)
[218.387605] [018/132] (817s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[218.491968] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[218.494321] Starting dynamic subtest: pipe-A
[218.511393] Dynamic subtest pipe-A: SKIP (0.016s)
[218.520764] Starting dynamic subtest: pipe-B
[218.546516] Dynamic subtest pipe-B: SKIP (0.034s)
[218.555321] Starting dynamic subtest: pipe-C
[218.579669] Dynamic subtest pipe-C: SKIP (0.034s)
[218.588371] Starting dynamic subtest: pipe-D
[218.607715] Dynamic subtest pipe-D: SKIP (0.029s)
[218.611449] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.114s)
[218.704324] [019/132] (816s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[218.815046] Starting subtest: x-tiled-64bpp-rotate-270
[218.844092] Subtest x-tiled-64bpp-rotate-270: SKIP (0.025s)
[218.964710] [020/132] (816s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[219.077347] Starting subtest: disable-crc-after-crtc
[219.079670] Starting dynamic subtest: pipe-A-eDP-1
[220.760598] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.681s)
[220.771272] Starting dynamic subtest: pipe-B-eDP-1
[223.016176] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.253s)
[223.027263] Starting dynamic subtest: pipe-C-eDP-1
[225.282185] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.262s)
[225.292596] Starting dynamic subtest: pipe-D-eDP-1
[227.552088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.270s)
[227.554647] Subtest disable-crc-after-crtc: SUCCESS (8.471s)
[228.374544] [021/132] (807s left) gem_exec_reloc (basic-wc-read-noreloc)
[228.440874] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[228.502805] [022/132] (807s left) gem_userptr_blits (sync-unmap-cycles)
[228.578312] Starting subtest: sync-unmap-cycles
[233.955007] Subtest sync-unmap-cycles: SUCCESS (5.377s)
[234.071099] [023/132] (801s left) gem_exec_balancer (parallel-ordering)
[234.337229] Starting subtest: parallel-ordering
[235.310491] Subtest parallel-ordering: SUCCESS (0.976s)
[235.433340] [024/132] (800s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[235.496105] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[235.498439] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[235.605874] [025/132] (800s left) gem_exec_fence (syncobj-wait)
[236.094937] Starting subtest: syncobj-wait
[237.510818] Subtest syncobj-wait: SUCCESS (1.414s)
[237.858208] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[237.861472] [026/132] (798s left) vgem_basic (dmabuf-fence)
[237.911328] Starting subtest: dmabuf-fence
[237.913501] Subtest dmabuf-fence: SUCCESS (0.000s)
[237.970197] [027/132] (798s left) gem_mmap_offset (clear-via-pagefault)
[238.022040] Starting subtest: clear-via-pagefault
[238.024005] Starting dynamic subtest: smem0
[271.891968] Dynamic subtest smem0: SUCCESS (33.864s)
[271.894030] Subtest clear-via-pagefault: SUCCESS (33.865s)
[271.994600] [028/132] (764s left) gem_render_copy (linear-to-vebox-yf-tiled)
[272.055162] Starting subtest: linear-to-vebox-yf-tiled
[272.059732] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[272.241829] [029/132] (763s left) kms_plane_multiple (tiling-yf)
[272.348909] Starting subtest: tiling-yf
[272.352933] Subtest tiling-yf: SKIP (0.000s)
[272.420515] [030/132] (763s left) gem_exec_schedule (pi-common)
[272.593075] Starting subtest: pi-common
[272.600043] Starting dynamic subtest: rcs0
[272.616756] Dynamic subtest rcs0: SUCCESS (0.027s)
[272.631843] Starting dynamic subtest: bcs0
[272.643249] Dynamic subtest bcs0: SUCCESS (0.026s)
[272.657942] Starting dynamic subtest: vcs0
[272.670119] Dynamic subtest vcs0: SUCCESS (0.027s)
[272.683995] Starting dynamic subtest: vcs1
[272.695962] Dynamic subtest vcs1: SUCCESS (0.025s)
[272.709532] Starting dynamic subtest: vecs0
[272.721953] Dynamic subtest vecs0: SUCCESS (0.026s)
[272.735828] Starting dynamic subtest: ccs0
[272.747804] Dynamic subtest ccs0: SUCCESS (0.025s)
[272.750053] Subtest pi-common: SUCCESS (0.159s)
[272.967941] [031/132] (763s left) kms_cursor_crc (cursor-onscreen-32x32)
[273.119028] Starting subtest: cursor-onscreen-32x32
[273.166133] Subtest cursor-onscreen-32x32: SKIP (0.042s)
[273.457210] [032/132] (762s left) syncobj_eventfd (invalid-bad-pad)
[273.509831] Starting subtest: invalid-bad-pad
[273.511672] Subtest invalid-bad-pad: SUCCESS (0.000s)
[273.611818] [033/132] (762s left) kms_fbcon_fbt (psr)
[273.679898] Starting subtest: psr
[281.046803] Subtest psr: SUCCESS (7.363s)
[281.130438] [034/132] (755s left) gem_exec_reloc (basic-gtt-cpu-active)
[281.196659] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[281.281206] [035/132] (755s left) gem_exec_reloc (basic-write-cpu)
[281.358062] Subtest basic-write-cpu: SKIP (0.000s)
[281.441871] [036/132] (754s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[281.498092] Starting subtest: multi-wait-all-for-submit-unsubmitted
[281.606637] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[281.696538] [037/132] (754s left) kms_flip (absolute-wf_vblank-interruptible)
[281.801479] Starting subtest: absolute-wf_vblank-interruptible
[281.803804] Starting dynamic subtest: A-eDP1
[290.495809] Dynamic subtest A-eDP1: SUCCESS (8.690s)
[290.505755] Starting dynamic subtest: B-eDP1
[299.225195] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[299.240137] Starting dynamic subtest: C-eDP1
[307.951704] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[307.961552] Starting dynamic subtest: D-eDP1
[316.692411] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[316.697161] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.894s)
[317.901415] [038/132] (718s left) gem_partial_pwrite_pread (reads-display)
[317.964525] Subtest reads-display: SKIP (0.000s)
[318.034258] [039/132] (718s left) perf_pmu (busy-no-semaphores)
[318.073071] Starting subtest: busy-no-semaphores
[318.075393] Starting dynamic subtest: rcs0
[318.620554] Dynamic subtest rcs0: SUCCESS (0.546s)
[318.633206] Starting dynamic subtest: bcs0
[319.171498] Dynamic subtest bcs0: SUCCESS (0.548s)
[319.182792] Starting dynamic subtest: vcs0
[319.721926] Dynamic subtest vcs0: SUCCESS (0.548s)
[319.734639] Starting dynamic subtest: vcs1
[321.004651] Dynamic subtest vcs1: SUCCESS (1.280s)
[321.016065] Starting dynamic subtest: vecs0
[322.989643] Dynamic subtest vecs0: SUCCESS (1.982s)
[323.000813] Starting dynamic subtest: ccs0
[324.973207] Dynamic subtest ccs0: SUCCESS (1.982s)
[324.976557] Subtest busy-no-semaphores: SUCCESS (6.901s)
[325.092278] [040/132] (711s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[325.194108] Starting subtest: sprite-rotation-90-pos-100-0
[325.198263] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[325.285044] [041/132] (711s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[325.383962] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[325.386255] Starting dynamic subtest: pipe-A-eDP-1
[325.527353] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[325.539576] Starting dynamic subtest: pipe-B-eDP-1
[325.558445] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[325.567651] Starting dynamic subtest: pipe-C-eDP-1
[325.586159] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[325.595150] Starting dynamic subtest: pipe-D-eDP-1
[325.613355] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[325.615205] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[327.757982] [042/132] (708s left) kms_lease (lease-get)
[327.859355] Starting subtest: lease-get
[327.861633] Starting dynamic subtest: pipe-A-eDP-1
[327.864100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[327.874269] Starting dynamic subtest: pipe-B-eDP-1
[327.876376] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[327.886265] Starting dynamic subtest: pipe-C-eDP-1
[327.888436] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[327.897886] Starting dynamic subtest: pipe-D-eDP-1
[327.900102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[327.902340] Subtest lease-get: SUCCESS (0.008s)
[327.979670] [043/132] (708s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[328.081471] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[328.085740] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[328.178938] [044/132] (708s left) gen9_exec_parse (bb-start-far)
[328.239825] Subtest bb-start-far: SKIP (0.000s)
[328.308674] [045/132] (708s left) kms_big_fb (linear-16bpp-rotate-0)
[328.422141] Starting subtest: linear-16bpp-rotate-0
[329.734832] Subtest linear-16bpp-rotate-0: SUCCESS (1.313s)
[329.846514] [046/132] (706s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[329.947600] Starting subtest: yf-tiled-64bpp-rotate-270
[329.951413] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[330.050917] [047/132] (706s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[330.137294] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[330.139178] Starting dynamic subtest: pipe-A-eDP-1
[364.442587] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.740s)
[364.452400] Starting dynamic subtest: pipe-B-eDP-1
[399.339414] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.584s)
[399.349730] Starting dynamic subtest: pipe-C-eDP-1
[434.322823] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.461s)
[434.334382] Starting dynamic subtest: pipe-D-eDP-1
[469.317263] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.515s)
[469.319622] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.306s)
[480.572506] [048/132] (566s left) kms_prop_blob (blob-prop-core)
[480.633147] Starting subtest: blob-prop-core
[480.635463] Subtest blob-prop-core: SUCCESS (0.000s)
[480.739529] [049/132] (566s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[480.835855] Starting subtest: primary-y-tiled-reflect-x-270
[480.840284] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[480.910803] [050/132] (566s left) kms_getfb (getfb-handle-zero)
[480.996781] Starting subtest: getfb-handle-zero
[480.999011] Subtest getfb-handle-zero: SUCCESS (0.000s)
[481.130765] [051/132] (565s left) syncobj_timeline (single-wait-for-submit-signaled)
[481.199426] Starting subtest: single-wait-for-submit-signaled
[481.201842] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[481.318431] [052/132] (565s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[481.380132] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[481.384216] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[481.563337] [053/132] (565s left) kms_hdr (static-toggle)
[481.654597] Starting subtest: static-toggle
[481.661042] Subtest static-toggle: SKIP (0.000s)
[481.729747] [054/132] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[481.832961] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[481.837336] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[481.924425] [055/132] (565s left) gem_exec_suspend (basic-s3)
[482.001446] Starting subtest: basic-S3
[482.003930] Starting dynamic subtest: smem
[501.679707] Dynamic subtest smem: SUCCESS (6.309s)
[501.682291] Subtest basic-S3: SUCCESS (6.312s)
[509.885506] [056/132] (545s left) gem_render_linear_blits (basic)
[509.948573] Starting subtest: basic
[509.968331] Subtest basic: SUCCESS (0.019s)
[510.053279] [057/132] (545s left) kms_plane (pixel-format-x-tiled-modifier)
[510.147721] Starting subtest: pixel-format-x-tiled-modifier
[510.171687] Starting dynamic subtest: pipe-A-plane-0
[510.804816] Dynamic subtest pipe-A-plane-0: SUCCESS (0.633s)
[510.816532] Starting dynamic subtest: pipe-A-plane-3
[511.204386] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[511.214338] Starting dynamic subtest: pipe-A-plane-5
[511.217927] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[512.283334] Starting dynamic subtest: pipe-B-plane-0
[512.974682] Dynamic subtest pipe-B-plane-0: SUCCESS (0.699s)
[512.987923] Starting dynamic subtest: pipe-B-plane-3
[513.374344] Dynamic subtest pipe-B-plane-3: SUCCESS (0.397s)
[513.385732] Starting dynamic subtest: pipe-B-plane-5
[513.389405] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[513.682476] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.537s)
[514.554983] [058/132] (540s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[514.669486] Starting subtest: 2x-cursor-vs-flip-legacy
[514.674005] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[514.829265] [059/132] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[514.918346] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[514.922378] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[515.016824] [060/132] (540s left) kms_hdr (invalid-metadata-sizes)
[515.118118] Starting subtest: invalid-metadata-sizes
[515.124671] Subtest invalid-metadata-sizes: SKIP (0.000s)
[515.204921] [061/132] (540s left) syncobj_timeline (reset-during-wait-for-submit)
[515.254527] Starting subtest: reset-during-wait-for-submit
[515.356566] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[515.437614] [062/132] (540s left) gem_exec_whisper (basic-queues-all)
[515.504494] Starting subtest: basic-queues-all
[526.607696] Subtest basic-queues-all: SUCCESS (11.095s)
[526.794294] [063/132] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[526.912193] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[526.916417] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[527.006307] [064/132] (528s left) gem_fenced_exec_thrash (too-many-fences)
[527.063469] Subtest too-many-fences: SKIP (0.000s)
[527.134443] [065/132] (528s left) sysfs_heartbeat_interval (idempotent)
[527.194631] Starting subtest: idempotent
[527.196848] Starting dynamic subtest: vecs0
[527.204134] Dynamic subtest vecs0: SUCCESS (0.001s)
[527.215495] Starting dynamic subtest: ccs0
[527.217634] Dynamic subtest ccs0: SUCCESS (0.001s)
[527.227477] Starting dynamic subtest: vcs0
[527.229610] Dynamic subtest vcs0: SUCCESS (0.000s)
[527.239449] Starting dynamic subtest: bcs0
[527.241569] Dynamic subtest bcs0: SUCCESS (0.001s)
[527.251222] Starting dynamic subtest: rcs0
[527.253302] Dynamic subtest rcs0: SUCCESS (0.001s)
[527.263145] Starting dynamic subtest: vcs1
[527.265266] Dynamic subtest vcs1: SUCCESS (0.000s)
[527.267337] Subtest idempotent: SUCCESS (0.008s)
[527.306636] [066/132] (528s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[527.426999] Starting subtest: y-tiled-64bpp-rotate-180
[527.431408] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[527.524691] [067/132] (528s left) kms_psr (psr2-cursor-plane-move)
[527.631629] Starting subtest: psr2-cursor-plane-move
[527.633712] Starting dynamic subtest: eDP-1
[529.335227] Dynamic subtest eDP-1: SUCCESS (1.703s)
[529.337526] Subtest psr2-cursor-plane-move: SUCCESS (1.704s)
[530.146069] [068/132] (525s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[530.243839] Starting subtest: pr-cursor-plane-update-sf
[530.248045] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[530.317587] [069/132] (525s left) i915_drm_fdinfo (all-busy-idle-check-all)
[530.361297] Starting subtest: all-busy-idle-check-all
[530.365706] Subtest all-busy-idle-check-all: SKIP (0.003s)
[530.446060] [070/132] (525s left) gem_mmap_gtt (basic-write-gtt)
[530.495116] Subtest basic-write-gtt: SKIP (0.000s)
[530.566509] [071/132] (525s left) gem_ctx_persistence (heartbeat-hang)
[530.624418] Starting subtest: heartbeat-hang
[530.628967] Subtest heartbeat-hang: SKIP (0.000s)
[530.727913] [072/132] (525s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[530.832840] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[531.856555] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s)
[531.997533] [073/132] (524s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[532.096028] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[532.485072] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[535.229672] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.742s)
[535.243542] Starting dynamic subtest: pipe-A-eDP-1-4
[537.403483] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.172s)
[537.416563] Starting dynamic subtest: pipe-A-eDP-1-4
[539.413971] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[539.424566] Starting dynamic subtest: pipe-A-eDP-1-x
[541.604502] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s)
[541.969423] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[544.767813] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[544.780609] Starting dynamic subtest: pipe-B-eDP-1-4
[546.952629] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[546.963525] Starting dynamic subtest: pipe-B-eDP-1-4
[548.963026] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[548.973894] Starting dynamic subtest: pipe-B-eDP-1-x
[551.153466] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[551.531532] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[554.299791] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.774s)
[554.313142] Starting dynamic subtest: pipe-C-eDP-1-4
[556.485325] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s)
[556.495843] Starting dynamic subtest: pipe-C-eDP-1-4
[558.495687] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[558.508908] Starting dynamic subtest: pipe-C-eDP-1-x
[560.675310] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[561.037823] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[563.832619] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[563.849857] Starting dynamic subtest: pipe-D-eDP-1-4
[566.007084] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[566.020112] Starting dynamic subtest: pipe-D-eDP-1-4
[568.017154] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[568.031732] Starting dynamic subtest: pipe-D-eDP-1-x
[570.207654] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[570.210418] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.108s)
[571.418439] [074/132] (484s left) gem_exec_balancer (bonded-dual)
[571.485114] Starting subtest: bonded-dual
[571.489416] Subtest bonded-dual: SKIP (0.000s)
[571.785477] [075/132] (484s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[571.882933] Starting subtest: fbcpsr-rgb565-draw-render
[579.031370] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.153s)
[579.170447] [076/132] (476s left) gem_mmap_gtt (basic-small-bo-tiledx)
[579.242021] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[579.312252] [077/132] (476s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[579.410104] Starting subtest: fbcpsr-tiling-4
[586.555006] Subtest fbcpsr-tiling-4: SUCCESS (7.145s)
[586.693109] [078/132] (469s left) kms_psr (fbc-psr2-sprite-plane-move)
[586.789878] Starting subtest: fbc-psr2-sprite-plane-move
[586.792169] Starting dynamic subtest: eDP-1
[586.796230] Dynamic subtest eDP-1: SKIP (0.000s)
[586.800300] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[586.867989] [079/132] (469s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[586.990071] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[587.141630] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.154s)
[587.254883] [080/132] (469s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[587.355213] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[587.357516] Starting dynamic subtest: pipe-A-eDP-1
[587.380155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[587.392097] Starting dynamic subtest: pipe-B-eDP-1
[587.413523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[587.423698] Starting dynamic subtest: pipe-C-eDP-1
[587.445022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[587.454772] Starting dynamic subtest: pipe-D-eDP-1
[587.476503] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[587.480473] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[589.650665] [081/132] (466s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[589.746079] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[596.604354] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.861s)
[596.742104] [082/132] (459s left) perf_pmu (frequency)
[596.784660] Starting subtest: frequency
[596.786636] Starting dynamic subtest: gt0
[598.929635] Dynamic subtest gt0: SUCCESS (2.138s)
[598.941911] Starting dynamic subtest: idle-gt0
[599.435769] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[599.448916] Starting dynamic subtest: gt1
[603.695809] Dynamic subtest gt1: SUCCESS (4.255s)
[603.708078] Starting dynamic subtest: idle-gt1
[604.200342] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[604.203538] Subtest frequency: SUCCESS (7.419s)
[604.307407] [083/132] (452s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[604.409128] Starting subtest: fbcpsr-suspend
[644.775205] Subtest fbcpsr-suspend: SUCCESS (10.844s)
[651.957627] [084/132] (411s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[652.074957] Starting subtest: fbc-pr-cursor-mmap-gtt
[652.078975] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[652.151887] [085/132] (411s left) kms_flip (wf_vblank-ts-check)
[652.253972] Starting subtest: wf_vblank-ts-check
[652.256274] Starting dynamic subtest: A-eDP1
[661.153341] Dynamic subtest A-eDP1: SUCCESS (8.890s)
[661.168047] Starting dynamic subtest: B-eDP1
[670.092479] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[670.105278] Starting dynamic subtest: C-eDP1
[679.017793] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[679.028436] Starting dynamic subtest: D-eDP1
[687.949962] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[687.951890] Subtest wf_vblank-ts-check: SUCCESS (35.680s)
[689.200393] [086/132] (374s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[689.300519] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[696.055563] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.757s)
[696.208415] [087/132] (367s left) kms_cursor_legacy (single-move)
[696.331658] Starting subtest: single-move
[696.333905] Starting dynamic subtest: pipe-A
[701.716441] Dynamic subtest pipe-A: SUCCESS (5.379s)
[701.729764] Starting dynamic subtest: pipe-B
[707.100046] Dynamic subtest pipe-B: SUCCESS (5.380s)
[707.113185] Starting dynamic subtest: pipe-C
[712.484242] Dynamic subtest pipe-C: SUCCESS (5.380s)
[712.497019] Starting dynamic subtest: pipe-D
[717.868610] Dynamic subtest pipe-D: SUCCESS (5.380s)
[717.882151] Starting dynamic subtest: all-pipes
[723.260747] Dynamic subtest all-pipes: SUCCESS (5.388s)
[723.263237] Subtest single-move: SUCCESS (26.920s)
[723.406221] [088/132] (340s left) gem_ctx_param (set-priority-invalid-size)
[723.461145] Starting subtest: set-priority-invalid-size
[723.463550] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[723.537807] [089/132] (340s left) gem_exec_schedule (semaphore-power)
[723.726256] Subtest semaphore-power: SKIP (0.000s)
[723.899827] [090/132] (339s left) core_getversion (basic)
[723.949083] Starting subtest: basic
[723.953057] Subtest basic: SUCCESS (0.000s)
[724.012497] [091/132] (339s left) kms_properties (get_properties-sanity-non-atomic)
[724.097453] Starting subtest: get_properties-sanity-non-atomic
[724.099668] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[724.173353] [092/132] (339s left) tools_test (sysfs_l3_parity)
[724.233706] Starting subtest: sysfs_l3_parity
[724.292369] Subtest sysfs_l3_parity: SKIP (0.072s)
[724.352535] [093/132] (339s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[724.450572] Starting subtest: primary-4-tiled-reflect-x-0
[731.430565] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.979s)
[732.584036] [094/132] (331s left) kms_psr (fbc-psr-suspend)
[732.678502] Starting subtest: fbc-psr-suspend
[732.680781] Starting dynamic subtest: eDP-1
[732.684979] Dynamic subtest eDP-1: SKIP (0.000s)
[732.689279] Subtest fbc-psr-suspend: SKIP (0.001s)
[732.753833] [095/132] (331s left) gem_mmap_gtt (basic-small-copy-xy)
[732.799070] Subtest basic-small-copy-XY: SKIP (0.000s)
[732.857042] [096/132] (331s left) kms_pm_rpm (cursor)
[734.383460] Starting subtest: cursor
[734.388615] Subtest cursor: SKIP (0.000s)
[735.137887] [097/132] (329s left) kms_color (invalid-gamma-lut-sizes)
[735.221225] Starting subtest: invalid-gamma-lut-sizes
[735.223361] Starting dynamic subtest: pipe-A
[735.505275] Dynamic subtest pipe-A: SUCCESS (0.286s)
[735.515718] Starting dynamic subtest: pipe-B
[735.517944] Dynamic subtest pipe-B: SUCCESS (0.000s)
[735.528085] Starting dynamic subtest: pipe-C
[735.530638] Dynamic subtest pipe-C: SUCCESS (0.000s)
[735.540840] Starting dynamic subtest: pipe-D
[735.542705] Dynamic subtest pipe-D: SUCCESS (0.000s)
[735.544643] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s)
[736.348042] [098/132] (327s left) gem_exec_fence (parallel)
[736.535327] Starting subtest: parallel
[736.537628] Starting dynamic subtest: rcs0
[738.686300] Dynamic subtest rcs0: SUCCESS (2.154s)
[738.698094] Starting dynamic subtest: bcs0
[740.838721] Dynamic subtest bcs0: SUCCESS (2.150s)
[740.853298] Starting dynamic subtest: vcs0
[742.989239] Dynamic subtest vcs0: SUCCESS (2.149s)
[743.010995] Starting dynamic subtest: vcs1
[745.142948] Dynamic subtest vcs1: SUCCESS (2.151s)
[745.153185] Starting dynamic subtest: vecs0
[747.296918] Dynamic subtest vecs0: SUCCESS (2.153s)
[747.309067] Starting dynamic subtest: ccs0
[749.445306] Dynamic subtest ccs0: SUCCESS (2.148s)
[749.447261] Subtest parallel: SUCCESS (12.913s)
[750.295545] [099/132] (313s left) gem_ctx_exec (basic-invalid-context)
[750.364757] Starting subtest: basic-invalid-context
[750.373172] Subtest basic-invalid-context: SUCCESS (0.010s)
[750.495793] [100/132] (313s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[750.593712] Starting subtest: psr-rgb101010-draw-mmap-wc
[757.616546] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.027s)
[757.733478] [101/132] (306s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[757.826613] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[757.828956] Starting dynamic subtest: pipe-A-eDP-1
[757.889341] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[757.901821] Starting dynamic subtest: pipe-B-eDP-1
[757.961260] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[757.973323] Starting dynamic subtest: pipe-C-eDP-1
[758.030842] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[758.042055] Starting dynamic subtest: pipe-D-eDP-1
[758.099793] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[758.104460] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[760.135970] [102/132] (304s left) gem_basic (bad-close)
[760.189707] Starting subtest: bad-close
[760.194114] Subtest bad-close: SUCCESS (0.000s)
[760.273929] [103/132] (304s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[760.363765] Starting subtest: fbc-psr2-cursor-mmap-cpu
[760.365929] Starting dynamic subtest: eDP-1
[760.369951] Dynamic subtest eDP-1: SKIP (0.000s)
[760.373974] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[760.439396] [104/132] (304s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[760.536559] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[764.554975] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.021s)
[765.767194] [105/132] (298s left) syncobj_basic (bad-flags-handle-to-fd)
[765.824895] Starting subtest: bad-flags-handle-to-fd
[765.827188] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[765.920056] [106/132] (298s left) gem_partial_pwrite_pread (writes-after-reads-display)
[765.978387] Subtest writes-after-reads-display: SKIP (0.000s)
[766.045958] [107/132] (298s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[766.138719] Starting subtest: fbc-rgb565-draw-mmap-cpu
[770.203250] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.068s)
[771.342921] [108/132] (293s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[771.440875] Starting subtest: flip-vs-dpms-on-nop-interruptible
[771.442709] Starting dynamic subtest: A-eDP1
[773.319269] Dynamic subtest A-eDP1: SUCCESS (1.876s)
[773.335045] Starting dynamic subtest: B-eDP1
[775.151991] Dynamic subtest B-eDP1: SUCCESS (1.830s)
[775.165417] Starting dynamic subtest: C-eDP1
[776.975778] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[776.987826] Starting dynamic subtest: D-eDP1
[778.814797] Dynamic subtest D-eDP1: SUCCESS (1.839s)
[778.820508] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.378s)
[779.997874] [109/132] (284s left) gem_ctx_param (invalid-ctx-set)
[780.049793] Starting subtest: invalid-ctx-set
[780.052156] Subtest invalid-ctx-set: SUCCESS (0.001s)
[780.156505] [110/132] (284s left) api_intel_bb (reset-bb)
[780.223428] Starting subtest: reset-bb
[780.230182] Subtest reset-bb: SUCCESS (0.009s)
[780.350508] [111/132] (284s left) kms_cursor_crc (cursor-sliding-256x85)
[780.629556] Starting subtest: cursor-sliding-256x85
[780.678695] Subtest cursor-sliding-256x85: SKIP (0.043s)
[780.834206] [112/132] (283s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[780.959418] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[780.963095] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[781.106255] [113/132] (283s left) prime_mmap (test_aperture_limit)
[781.161853] Starting subtest: test_aperture_limit
[781.163634] Starting dynamic subtest: test_aperture_limit-smem
[781.171052] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[781.174665] Subtest test_aperture_limit: SKIP (0.009s)
[781.260884] [114/132] (283s left) api_intel_allocator (fork-simple-stress-signal)
[781.320833] Starting subtest: fork-simple-stress-signal
[786.725488] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[786.867458] [115/132] (278s left) gem_wait (busy)
[786.945319] Starting subtest: busy
[786.947687] Starting dynamic subtest: all-engines
[788.226098] Dynamic subtest all-engines: SUCCESS (1.279s)
[788.241974] Starting dynamic subtest: rcs0
[788.771254] Dynamic subtest rcs0: SUCCESS (0.543s)
[788.784862] Starting dynamic subtest: bcs0
[789.311666] Dynamic subtest bcs0: SUCCESS (0.540s)
[789.325711] Starting dynamic subtest: vcs0
[791.233845] Dynamic subtest vcs0: SUCCESS (1.919s)
[791.246051] Starting dynamic subtest: vcs1
[793.219841] Dynamic subtest vcs1: SUCCESS (1.984s)
[793.233560] Starting dynamic subtest: vecs0
[795.202661] Dynamic subtest vecs0: SUCCESS (1.980s)
[795.216264] Starting dynamic subtest: ccs0
[795.744294] Dynamic subtest ccs0: SUCCESS (0.540s)
[795.746760] Subtest busy: SUCCESS (8.799s)
[795.949007] [116/132] (269s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[796.062774] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[796.067283] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[796.163624] [117/132] (268s left) gem_exec_params (batch-first)
[796.227257] Starting subtest: batch-first
[796.233785] Subtest batch-first: SUCCESS (0.007s)
[796.350557] [118/132] (268s left) gem_ctx_isolation (dirty-create)
[796.404631] Starting subtest: dirty-create
[796.406912] Starting dynamic subtest: rcs0
[796.591918] Dynamic subtest rcs0: SUCCESS (0.187s)
[796.602824] Starting dynamic subtest: bcs0
[796.795156] Dynamic subtest bcs0: SUCCESS (0.202s)
[796.806000] Starting dynamic subtest: vcs0
[797.033603] Dynamic subtest vcs0: SUCCESS (0.238s)
[797.044917] Starting dynamic subtest: vcs1
[798.383343] Dynamic subtest vcs1: SUCCESS (1.348s)
[798.397922] Starting dynamic subtest: vecs0
[800.397271] Dynamic subtest vecs0: SUCCESS (2.012s)
[800.408288] Starting dynamic subtest: ccs0
[802.490650] Dynamic subtest ccs0: SUCCESS (2.092s)
[802.493074] Subtest dirty-create: SUCCESS (6.085s)
[802.731521] [119/132] (262s left) kms_chamelium_color (ctm-limited-range)
[802.823594] Subtest ctm-limited-range: SKIP (0.000s)
[802.878369] [120/132] (262s left) gem_eio (unwedge-stress)
[803.091929] Starting subtest: unwedge-stress
[803.093823] Starting dynamic subtest: render
[807.576718] Dynamic subtest render: SUCCESS (4.483s)
[807.594537] Starting dynamic subtest: bsd1
[825.653356] Dynamic subtest bsd1: SUCCESS (18.073s)
[825.671680] Starting dynamic subtest: bsd2
[843.676081] Dynamic subtest bsd2: SUCCESS (18.017s)
[843.694289] Starting dynamic subtest: blt
[843.699051] Dynamic subtest blt: SKIP (0.000s)
[843.708693] Starting dynamic subtest: vebox
[861.661640] Dynamic subtest vebox: SUCCESS (17.980s)
[861.664071] Subtest unwedge-stress: SUCCESS (58.558s)
[863.276292] [121/132] (201s left) i915_pm_rpm (gem-execbuf)
[865.417510] Starting subtest: gem-execbuf
[865.420116] Starting dynamic subtest: smem0
[867.650389] Dynamic subtest smem0: SUCCESS (2.231s)
[867.652565] Subtest gem-execbuf: SUCCESS (2.233s)
[867.736046] [122/132] (197s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[867.834240] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[867.838579] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[867.920673] [123/132] (197s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[868.012825] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[868.015104] Starting dynamic subtest: pipe-A
[868.035350] Dynamic subtest pipe-A: SKIP (0.019s)
[868.046611] Starting dynamic subtest: pipe-B
[868.066881] Dynamic subtest pipe-B: SKIP (0.032s)
[868.078055] Starting dynamic subtest: pipe-C
[868.098982] Dynamic subtest pipe-C: SKIP (0.032s)
[868.109892] Starting dynamic subtest: pipe-D
[868.132907] Dynamic subtest pipe-D: SKIP (0.032s)
[868.136698] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.117s)
[868.241771] [124/132] (197s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[868.399916] Starting subtest: cursor-rapid-movement-32x32
[868.446167] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[868.734339] [125/132] (196s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[868.825559] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[868.829245] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[868.900614] [126/132] (196s left) prime_vgem (sync)
[868.970086] Starting subtest: sync
[868.972106] Starting dynamic subtest: rcs0
[869.013687] Dynamic subtest rcs0: SUCCESS (0.043s)
[869.023906] Starting dynamic subtest: bcs0
[869.071752] Dynamic subtest bcs0: SUCCESS (0.057s)
[869.082330] Starting dynamic subtest: vcs0
[869.121422] Dynamic subtest vcs0: SUCCESS (0.049s)
[869.132077] Starting dynamic subtest: vcs1
[869.166529] Dynamic subtest vcs1: SUCCESS (0.044s)
[869.177321] Starting dynamic subtest: vecs0
[869.212742] Dynamic subtest vecs0: SUCCESS (0.045s)
[869.222801] Starting dynamic subtest: ccs0
[869.257045] Dynamic subtest ccs0: SUCCESS (0.044s)
[869.259064] Subtest sync: SUCCESS (0.288s)
[869.368468] [127/132] (196s left) kms_vblank (wait-forked-busy)
[869.465459] Starting subtest: wait-forked-busy
[869.466991] Starting dynamic subtest: pipe-A-eDP-1
[871.356311] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[871.373485] Starting dynamic subtest: pipe-D-eDP-1
[873.958492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[873.960879] Subtest wait-forked-busy: SUCCESS (4.493s)
[874.768187] [128/132] (190s left) perf_pmu (busy-check-all)
[874.812696] Starting subtest: busy-check-all
[874.814826] Starting dynamic subtest: rcs0
[875.372854] Dynamic subtest rcs0: SUCCESS (0.560s)
[875.385915] Starting dynamic subtest: bcs0
[875.922897] Dynamic subtest bcs0: SUCCESS (0.548s)
[875.936407] Starting dynamic subtest: vcs0
[877.186118] Dynamic subtest vcs0: SUCCESS (1.260s)
[877.200070] Starting dynamic subtest: vcs1
[879.234735] Dynamic subtest vcs1: SUCCESS (2.046s)
[879.248060] Starting dynamic subtest: vecs0
[881.218996] Dynamic subtest vecs0: SUCCESS (1.982s)
[881.233231] Starting dynamic subtest: ccs0
[881.787295] Dynamic subtest ccs0: SUCCESS (0.566s)
[881.789697] Subtest busy-check-all: SUCCESS (6.978s)
[881.888659] [129/132] (183s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[881.993947] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[882.006514] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[882.084380] [130/132] (183s left) kms_atomic (plane-immutable-zpos)
[882.191202] Starting subtest: plane-immutable-zpos
[882.193504] Starting dynamic subtest: pipe-A-eDP-1
[882.826968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[882.829036] Subtest plane-immutable-zpos: SUCCESS (0.636s)
[883.730926] [131/132] (181s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[884.137012] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[884.929463] [132/132] (180s left) gem_exec_whisper (basic-contexts-forked)
[884.996971] Starting subtest: basic-contexts-forked
[909.723060] Subtest basic-contexts-forked: SUCCESS (24.725s)
[909.909614] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_chamelium_frames
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_busy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: kms_feature_discovery
results: parsing output: 10/ for test: gem_bad_reloc
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: kms_content_protection
results: parsing output: 15/ for test: i915_suspend
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_pipe_crc_basic
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: vgem_basic
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: syncobj_eventfd
results: parsing output: 32/ for test: kms_fbcon_fbt
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_partial_pwrite_pread
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_rotation_crc
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: kms_rotation_crc
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: kms_hdr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_suspend
results: parsing output: 55/ for test: gem_render_linear_blits
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_hdr
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_fenced_exec_thrash
results: parsing output: 64/ for test: sysfs_heartbeat_interval
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_exec_balancer
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_pxp
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: perf_pmu
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: core_getversion
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: tools_test
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: kms_color
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_ctx_exec
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_basic
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_basic
results: parsing output: 105/ for test: gem_partial_pwrite_pread
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: api_intel_allocator
results: parsing output: 114/ for test: gem_wait
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: gem_eio
results: parsing output: 120/ for test: i915_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_atomic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: gem_exec_whisper
Done.