[56.958805] Initializing watchdogs
[56.958895]   /dev/watchdog0
[56.977411] [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]
[56.981540] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.983805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.987137] [001/133] (960s left) gem_exec_balancer (full-late)
[57.073039] Starting subtest: full-late
[62.158958] Subtest full-late: SUCCESS (5.086s)
[62.468066] [002/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[62.569095] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[62.573204] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[62.648385] [003/133] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[62.755142] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[62.759659] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[62.861166] [004/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[62.959484] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[70.190946] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.235s)
[70.323186] [005/133] (947s left) prime_busy (hang)
[70.383691] Starting subtest: hang
[70.386053] Starting dynamic subtest: rcs0
[96.792859] Dynamic subtest rcs0: SUCCESS (26.409s)
[96.802837] Starting dynamic subtest: bcs0
[103.951335] Dynamic subtest bcs0: SUCCESS (7.158s)
[103.961428] Starting dynamic subtest: vcs0
[110.924497] Dynamic subtest vcs0: SUCCESS (6.974s)
[110.933388] Starting dynamic subtest: vcs1
[117.963533] Dynamic subtest vcs1: SUCCESS (7.036s)
[117.973636] Starting dynamic subtest: vecs0
[124.939381] Dynamic subtest vecs0: SUCCESS (6.978s)
[124.949935] Starting dynamic subtest: ccs0
[138.840039] Dynamic subtest ccs0: SUCCESS (13.898s)
[138.842479] Subtest hang: SUCCESS (68.456s)
[139.005516] [006/133] (878s left) kms_tiled_display (basic-test-pattern)
[139.116760] Subtest basic-test-pattern: SKIP (0.000s)
[139.162897] [007/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[139.256845] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[139.261098] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[139.351408] [008/133] (878s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[139.440080] Starting subtest: flip-primary-invalidate-overlay
[151.091273] Subtest flip-primary-invalidate-overlay: SUCCESS (11.652s)
[151.224411] [009/133] (866s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[151.320434] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[151.323905] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[151.392227] [010/133] (866s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[151.503899] Starting subtest: flip-vs-cursor-atomic
[158.953590] Subtest flip-vs-cursor-atomic: SUCCESS (7.447s)
[159.833030] [011/133] (858s left) kms_psr (fbc-pr-sprite-blt)
[159.924025] Starting subtest: fbc-pr-sprite-blt
[159.928130] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[159.992407] [012/133] (857s left) kms_plane (plane-position-hole-dpms)
[160.076056] Starting subtest: plane-position-hole-dpms
[160.597769] Starting dynamic subtest: pipe-A-plane-1
[162.999552] Dynamic subtest pipe-A-plane-1: SUCCESS (2.402s)
[163.009491] Starting dynamic subtest: pipe-A-plane-2
[165.397894] Dynamic subtest pipe-A-plane-2: SUCCESS (2.395s)
[165.406229] Starting dynamic subtest: pipe-A-plane-3
[167.839362] Dynamic subtest pipe-A-plane-3: SUCCESS (2.442s)
[167.848856] Starting dynamic subtest: pipe-A-plane-4
[170.192490] Dynamic subtest pipe-A-plane-4: SUCCESS (2.353s)
[170.202363] Starting dynamic subtest: pipe-A-plane-5
[170.217721] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[171.380067] Starting dynamic subtest: pipe-B-plane-1
[173.807779] Dynamic subtest pipe-B-plane-1: SUCCESS (2.436s)
[173.816119] Starting dynamic subtest: pipe-B-plane-2
[176.175561] Dynamic subtest pipe-B-plane-2: SUCCESS (2.367s)
[176.184323] Starting dynamic subtest: pipe-B-plane-3
[178.520402] Dynamic subtest pipe-B-plane-3: SUCCESS (2.346s)
[178.530358] Starting dynamic subtest: pipe-B-plane-4
[180.910250] Dynamic subtest pipe-B-plane-4: SUCCESS (2.387s)
[180.918666] Starting dynamic subtest: pipe-B-plane-5
[180.937478] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[180.939624] Subtest plane-position-hole-dpms: SUCCESS (20.860s)
[181.710369] [013/133] (836s left) api_intel_bb (full-batch)
[181.776625] Starting subtest: full-batch
[181.781657] Subtest full-batch: SUCCESS (0.006s)
[181.896770] [014/133] (836s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[181.989171] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[186.467712] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.482s)
[187.627285] [015/133] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[187.718799] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[187.723377] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.825999] [016/133] (830s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[187.910247] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[187.912615] Starting dynamic subtest: pipe-A-eDP-1
[187.933086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[187.943764] Starting dynamic subtest: pipe-B-eDP-1
[187.963482] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[187.972425] Starting dynamic subtest: pipe-C-eDP-1
[187.992163] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[188.000575] Starting dynamic subtest: pipe-D-eDP-1
[188.020371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[188.022590] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[190.180847] [017/133] (827s left) gem_exec_gttfill (all-engines)
[190.236178] Starting subtest: all-engines
[213.229969] Subtest all-engines: SUCCESS (22.994s)
[213.418372] [018/133] (804s left) kms_chamelium_edid (hdmi-edid-read)
[213.856801] Subtest hdmi-edid-read: SKIP (0.000s)
[214.678507] [019/133] (803s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[214.776094] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[214.780254] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[214.864603] [020/133] (803s left) kms_setmode (invalid-clone-single-crtc-stealing)
[214.910716] Starting subtest: invalid-clone-single-crtc-stealing
[214.917054] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[215.016876] [021/133] (803s left) gem_ctx_persistence (legacy-engines-queued)
[215.081785] Starting subtest: legacy-engines-queued
[215.084091] Starting dynamic subtest: render
[215.147077] Dynamic subtest render: SUCCESS (0.064s)
[215.161057] Starting dynamic subtest: bsd1
[216.288270] Dynamic subtest bsd1: SUCCESS (1.137s)
[216.301109] Starting dynamic subtest: bsd2
[218.270921] Dynamic subtest bsd2: SUCCESS (1.979s)
[218.285956] Starting dynamic subtest: blt
[218.332180] Dynamic subtest blt: SUCCESS (0.060s)
[218.343410] Starting dynamic subtest: vebox
[220.254629] Dynamic subtest vebox: SUCCESS (1.919s)
[220.257714] Subtest legacy-engines-queued: SUCCESS (5.172s)
[220.336263] [022/133] (797s left) gem_eio (context-create)
[220.572981] Starting subtest: context-create
[220.920914] Subtest context-create: SUCCESS (0.347s)
[221.048825] [023/133] (797s left) i915_pm_rps (fence-order)
[221.112886] Starting subtest: fence-order
[223.993882] Subtest fence-order: SUCCESS (2.877s)
[224.078891] [024/133] (794s left) gem_userptr_blits (set-cache-level)
[224.133514] Starting subtest: set-cache-level
[224.138068] Subtest set-cache-level: SKIP (0.000s)
[224.274193] [025/133] (794s left) kms_cursor_crc (cursor-random-128x128)
[224.496803] Starting subtest: cursor-random-128x128
[224.501665] Starting dynamic subtest: pipe-A-eDP-1
[227.852265] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s)
[227.881064] Starting dynamic subtest: pipe-D-eDP-1
[231.799088] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.926s)
[231.801779] Subtest cursor-random-128x128: SUCCESS (7.301s)
[232.672480] [026/133] (785s left) syncobj_timeline (wait-all-for-submit-complex)
[232.729642] Starting subtest: wait-all-for-submit-complex
[232.942357] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[233.015950] [027/133] (785s left) gem_exec_schedule (preempt-contexts)
[233.092480] Starting subtest: preempt-contexts
[233.094798] Starting dynamic subtest: rcs0
[233.135880] Dynamic subtest rcs0: SUCCESS (0.051s)
[233.145311] Starting dynamic subtest: bcs0
[233.191654] Dynamic subtest bcs0: SUCCESS (0.055s)
[233.203566] Starting dynamic subtest: vcs0
[233.240380] Dynamic subtest vcs0: SUCCESS (0.047s)
[233.249519] Starting dynamic subtest: vcs1
[233.289065] Dynamic subtest vcs1: SUCCESS (0.048s)
[233.300088] Starting dynamic subtest: vecs0
[233.332993] Dynamic subtest vecs0: SUCCESS (0.043s)
[233.344685] Starting dynamic subtest: ccs0
[233.385711] Dynamic subtest ccs0: SUCCESS (0.053s)
[233.387942] Subtest preempt-contexts: SUCCESS (0.301s)
[235.361592] [028/133] (783s left) kms_big_fb (linear-64bpp-rotate-90)
[235.463982] Starting subtest: linear-64bpp-rotate-90
[235.485705] Subtest linear-64bpp-rotate-90: SKIP (0.021s)
[235.587866] [029/133] (782s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[235.634071] Starting subtest: invalid-single-wait-all-unsubmitted
[235.636311] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[235.711293] [030/133] (782s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[235.815918] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[235.820312] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[235.928974] [031/133] (782s left) kms_psr (psr2-sprite-mmap-gtt)
[236.026257] Starting subtest: psr2-sprite-mmap-gtt
[236.028519] Starting dynamic subtest: eDP-1
[237.471483] Dynamic subtest eDP-1: SKIP (1.442s)
[237.476541] Subtest psr2-sprite-mmap-gtt: SKIP (1.444s)
[237.614422] [032/133] (781s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[237.705093] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[237.709505] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[237.786545] [033/133] (780s left) kms_color (ctm-0-25)
[237.890599] Starting subtest: ctm-0-25
[237.892794] Starting dynamic subtest: pipe-A-eDP-1
[241.344045] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.453s)
[241.358629] Starting dynamic subtest: pipe-B-eDP-1
[245.624778] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.282s)
[245.633727] Starting dynamic subtest: pipe-C-eDP-1
[249.673055] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.044s)
[249.683527] Starting dynamic subtest: pipe-D-eDP-1
[253.671446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[253.673761] Subtest ctm-0-25: SUCCESS (15.782s)
[254.504575] [034/133] (764s left) kms_vblank (ts-continuation-suspend)
[254.614136] Starting subtest: ts-continuation-suspend
[254.616230] Starting dynamic subtest: pipe-A-eDP-1
[270.787524] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s)
[270.803705] Starting dynamic subtest: pipe-D-eDP-1
[287.785156] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.167s)
[287.787709] Subtest ts-continuation-suspend: SUCCESS (4.594s)
[288.589427] [035/133] (730s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[288.684040] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[288.686268] Starting dynamic subtest: pipe-A-eDP-1
[288.709936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.720823] Starting dynamic subtest: pipe-B-eDP-1
[288.741704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.750887] Starting dynamic subtest: pipe-C-eDP-1
[288.771141] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.780320] Starting dynamic subtest: pipe-D-eDP-1
[288.802538] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.807009] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[290.867243] [036/133] (728s left) kms_addfb_basic (tile-pitch-mismatch)
[290.917594] Starting subtest: tile-pitch-mismatch
[290.921830] Subtest tile-pitch-mismatch: SKIP (0.000s)
[291.049944] [037/133] (727s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[291.164495] Starting subtest: short-busy-flip-before-cursor-toggle
[291.169127] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[291.321857] [038/133] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[291.411357] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[291.415798] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[291.512003] [039/133] (727s left) perf_pmu (pmu-read)
[291.555106] Starting subtest: pmu-read
[291.557354] Subtest pmu-read: SUCCESS (0.002s)
[291.677285] [040/133] (727s left) kms_addfb_basic (bad-pitch-0)
[291.726479] Starting subtest: bad-pitch-0
[291.728872] Subtest bad-pitch-0: SUCCESS (0.000s)
[291.868012] [041/133] (727s left) kms_rmfb (close-fd)
[291.948324] Starting subtest: close-fd
[291.950281] Starting dynamic subtest: pipe-A-eDP-1
[292.056551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[292.068430] Starting dynamic subtest: pipe-B-eDP-1
[293.235672] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[293.246793] Starting dynamic subtest: pipe-C-eDP-1
[294.378819] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[294.389350] Starting dynamic subtest: pipe-D-eDP-1
[295.502250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[295.504567] Subtest close-fd: SUCCESS (3.551s)
[296.708395] [042/133] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[296.821925] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[303.609762] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.791s)
[303.760140] [043/133] (715s left) i915_hangman (gt-error-state-capture)
[303.830285] Starting subtest: gt-error-state-capture
[303.832575] Starting dynamic subtest: rcs0
[315.838338] Dynamic subtest rcs0: SUCCESS (12.004s)
[315.849851] Starting dynamic subtest: bcs0
[326.845476] Dynamic subtest bcs0: SUCCESS (11.005s)
[326.862764] Starting dynamic subtest: vcs0
[338.812574] Dynamic subtest vcs0: SUCCESS (11.965s)
[338.826624] Starting dynamic subtest: vcs1
[350.781350] Dynamic subtest vcs1: SUCCESS (11.965s)
[350.795012] Starting dynamic subtest: vecs0
[361.790656] Dynamic subtest vecs0: SUCCESS (11.005s)
[361.803625] Starting dynamic subtest: ccs0
[373.821695] Dynamic subtest ccs0: SUCCESS (12.027s)
[373.824677] Subtest gt-error-state-capture: SUCCESS (69.988s)
[373.900300] [044/133] (645s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[374.002592] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[377.729585] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.730s)
[378.946440] [045/133] (640s left) syncobj_wait (multi-wait-for-submit-signaled)
[379.014360] Starting subtest: multi-wait-for-submit-signaled
[379.016316] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[379.118265] [046/133] (640s left) kms_content_protection (atomic-dpms)
[379.261296] Starting subtest: atomic-dpms
[379.266411] Subtest atomic-dpms: SKIP (0.000s)
[379.393246] [047/133] (639s left) kms_pm_backlight (brightness-with-dpms)
[379.486995] Starting subtest: brightness-with-dpms
[379.537863] Starting dynamic subtest: eDP-1
[381.930457] Dynamic subtest eDP-1: SUCCESS (2.391s)
[381.932904] Subtest brightness-with-dpms: SUCCESS (2.443s)
[382.789161] [048/133] (636s left) kms_plane_multiple (tiling-y)
[382.896013] Starting subtest: tiling-y
[382.900085] Subtest tiling-y: SKIP (0.000s)
[382.982521] [049/133] (636s left) syncobj_basic (bad-handle-to-fd)
[383.027921] Starting subtest: bad-handle-to-fd
[383.030083] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[383.121106] [050/133] (636s left) vgem_slow (nohang)
[383.233335] Starting subtest: nohang
[393.596471] Subtest nohang: SUCCESS (10.365s)
[393.659675] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[393.662807] [051/133] (625s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[393.763991] Starting subtest: pr-overlay-plane-move-continuous-sf
[393.767954] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[393.833527] [052/133] (625s left) kms_pipe_crc_basic (read-crc)
[393.924626] Starting subtest: read-crc
[393.928101] Starting dynamic subtest: pipe-A-eDP-1
[394.631148] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[394.641804] Starting dynamic subtest: pipe-B-eDP-1
[395.987008] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[395.997951] Starting dynamic subtest: pipe-C-eDP-1
[397.368735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[397.380546] Starting dynamic subtest: pipe-D-eDP-1
[398.703796] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[398.706106] Subtest read-crc: SUCCESS (4.784s)
[399.534722] [053/133] (620s left) kms_flip (absolute-wf_vblank)
[399.638872] Starting subtest: absolute-wf_vblank
[399.641139] Starting dynamic subtest: A-eDP1
[408.395362] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[408.408592] Starting dynamic subtest: B-eDP1
[417.126104] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[417.139384] Starting dynamic subtest: C-eDP1
[425.847887] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[425.857944] Starting dynamic subtest: D-eDP1
[434.582261] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[434.584575] Subtest absolute-wf_vblank: SUCCESS (34.948s)
[435.793203] [054/133] (583s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[435.900161] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[435.904152] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[436.004639] [055/133] (583s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[436.094668] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[436.099048] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[436.166969] [056/133] (583s left) perf_pmu (busy-accuracy-2)
[436.203613] Starting subtest: busy-accuracy-2
[436.205925] Starting dynamic subtest: rcs0
[439.244909] Dynamic subtest rcs0: SUCCESS (3.039s)
[439.257183] Starting dynamic subtest: bcs0
[442.302569] Dynamic subtest bcs0: SUCCESS (3.054s)
[442.315231] Starting dynamic subtest: vcs0
[445.344012] Dynamic subtest vcs0: SUCCESS (3.041s)
[445.356346] Starting dynamic subtest: vcs1
[448.386925] Dynamic subtest vcs1: SUCCESS (3.041s)
[448.397785] Starting dynamic subtest: vecs0
[451.432408] Dynamic subtest vecs0: SUCCESS (3.044s)
[451.445481] Starting dynamic subtest: ccs0
[454.487985] Dynamic subtest ccs0: SUCCESS (3.053s)
[454.490618] Subtest busy-accuracy-2: SUCCESS (18.283s)
[454.605918] [057/133] (565s left) kms_pm_rpm (i2c)
[456.146335] Starting subtest: i2c
[461.481207] Subtest i2c: SUCCESS (5.338s)
[461.583066] [058/133] (558s left) kms_joiner (basic-force-big-joiner)
[461.684601] Starting subtest: basic-force-big-joiner
[461.688666] Subtest basic-force-big-joiner: SKIP (0.000s)
[461.751865] [059/133] (558s left) syncobj_timeline (multi-wait-submitted-signaled)
[461.807281] Starting subtest: multi-wait-submitted-signaled
[461.809629] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[461.904301] [060/133] (557s left) gem_workarounds (basic-read)
[461.971305] Starting subtest: basic-read
[461.980365] Subtest basic-read: SUCCESS (0.009s)
[462.100632] [061/133] (557s left) syncobj_timeline (wait-zero-handles)
[462.144976] Starting subtest: wait-zero-handles
[462.147330] Subtest wait-zero-handles: SUCCESS (0.000s)
[462.244748] [062/133] (557s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[462.342479] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[469.079427] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.739s)
[469.202979] [063/133] (550s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[469.311409] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[469.313572] Starting dynamic subtest: pipe-A
[469.374009] Dynamic subtest pipe-A: SUCCESS (0.065s)
[469.386869] Starting dynamic subtest: pipe-B
[470.503444] Dynamic subtest pipe-B: SUCCESS (1.127s)
[470.517438] Starting dynamic subtest: pipe-C
[471.623377] Dynamic subtest pipe-C: SUCCESS (1.118s)
[471.633761] Starting dynamic subtest: pipe-D
[472.753500] Dynamic subtest pipe-D: SUCCESS (1.129s)
[472.755599] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.445s)
[473.899206] [064/133] (546s left) dmabuf_sync_file (import-basic)
[473.941672] Starting subtest: import-basic
[473.943598] Subtest import-basic: SUCCESS (0.002s)
[474.009290] [065/133] (546s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[474.107066] Starting subtest: x-tiled-32bpp-rotate-180
[475.497857] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.390s)
[475.633389] [066/133] (544s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[475.730759] Starting subtest: yf-tiled-32bpp-rotate-270
[475.734484] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[475.840354] [067/133] (544s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[475.947573] Starting subtest: 2x-flip-vs-cursor-atomic
[475.951609] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[476.106201] [068/133] (544s left) gem_lmem_swapping (massive-random)
[476.149375] Subtest massive-random: SKIP (0.000s)
[476.185731] [069/133] (544s left) gen9_exec_parse (unaligned-access)
[476.251382] Subtest unaligned-access: SKIP (0.000s)
[476.322940] [070/133] (543s left) gem_exec_params (invalid-bsd2-flag-on-render)
[476.372119] Starting subtest: invalid-bsd2-flag-on-render
[476.373960] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[476.490172] [071/133] (543s left) kms_busy (basic-hang)
[476.583032] Starting subtest: basic-hang
[476.584996] Starting dynamic subtest: flip-pipe-A
[477.229549] Dynamic subtest flip-pipe-A: SUCCESS (0.646s)
[477.240717] Starting dynamic subtest: modeset-pipe-A
[480.867247] Dynamic subtest modeset-pipe-A: SUCCESS (3.634s)
[480.878619] Starting dynamic subtest: flip-pipe-D
[482.065198] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[482.076118] Starting dynamic subtest: modeset-pipe-D
[485.486623] Dynamic subtest modeset-pipe-D: SUCCESS (3.420s)
[485.489034] Subtest basic-hang: SUCCESS (8.904s)
[486.293296] [072/133] (534s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[486.391855] Starting subtest: basic-modeset-with-all-modifiers-formats
[486.775780] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[487.581944] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.807s)
[487.592428] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[487.603345] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s)
[487.613494] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[487.625657] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[487.638045] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[487.781178] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[487.794742] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[487.804470] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[487.815183] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[487.825933] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[487.837679] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[487.850099] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[487.862454] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[487.870203] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[487.880335] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[487.892385] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[487.902468] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[487.915001] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[487.927958] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[487.936913] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[487.946921] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[487.959272] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[487.973106] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[488.114677] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[488.127427] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[488.136905] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[488.149508] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[488.159073] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[488.170078] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[488.181424] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[488.192466] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[488.203575] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[488.217183] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[488.225959] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[488.235984] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[488.247997] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[488.257840] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[488.270133] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[488.279957] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[488.292452] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[488.304874] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[488.459592] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[488.472415] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[488.481706] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[488.491925] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[488.503946] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[488.516274] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[488.526149] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[488.535973] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[488.548330] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[488.558251] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[488.570616] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[488.582729] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[488.592470] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[488.601941] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[488.614914] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[488.629715] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[488.636885] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[489.024792] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.634s)
[489.876878] [073/133] (530s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[489.933878] Starting subtest: x-tiled-to-vebox-yf-tiled
[489.938375] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[490.125016] [074/133] (530s left) kms_cursor_crc (cursor-random-128x42)
[490.363619] Starting subtest: cursor-random-128x42
[490.416192] Subtest cursor-random-128x42: SKIP (0.047s)
[490.613007] [075/133] (529s left) gem_spin_batch (resubmit-all)
[490.660694] Starting subtest: resubmit-all
[490.663100] Starting dynamic subtest: rcs0
[490.673094] Dynamic subtest rcs0: SUCCESS (0.012s)
[490.684665] Starting dynamic subtest: bcs0
[490.687076] Dynamic subtest bcs0: SUCCESS (0.002s)
[490.697034] Starting dynamic subtest: vcs0
[490.698921] Dynamic subtest vcs0: SUCCESS (0.002s)
[490.708217] Starting dynamic subtest: vcs1
[490.710152] Dynamic subtest vcs1: SUCCESS (0.002s)
[490.719633] Starting dynamic subtest: vecs0
[490.721572] Dynamic subtest vecs0: SUCCESS (0.002s)
[490.730970] Starting dynamic subtest: ccs0
[490.732885] Dynamic subtest ccs0: SUCCESS (0.002s)
[490.734785] Subtest resubmit-all: SUCCESS (0.027s)
[491.910842] [076/133] (528s left) gem_exec_schedule (u-semaphore-resolve)
[491.978487] Starting subtest: u-semaphore-resolve
[492.011943] Subtest u-semaphore-resolve: SUCCESS (0.041s)
[492.358741] [077/133] (528s left) gem_ctx_persistence (engines-queued)
[492.425702] Starting subtest: engines-queued
[492.427913] Starting dynamic subtest: rcs0
[492.508778] Dynamic subtest rcs0: SUCCESS (0.085s)
[492.521124] Starting dynamic subtest: bcs0
[492.564916] Dynamic subtest bcs0: SUCCESS (0.054s)
[492.576748] Starting dynamic subtest: vcs0
[493.821742] Dynamic subtest vcs0: SUCCESS (1.253s)
[493.833188] Starting dynamic subtest: vcs1
[495.867341] Dynamic subtest vcs1: SUCCESS (2.043s)
[495.880608] Starting dynamic subtest: vecs0
[497.853128] Dynamic subtest vecs0: SUCCESS (1.982s)
[497.866904] Starting dynamic subtest: ccs0
[498.041506] Dynamic subtest ccs0: SUCCESS (0.187s)
[498.044083] Subtest engines-queued: SUCCESS (5.618s)
[498.161514] [078/133] (522s left) kms_flip (dpms-vs-vblank-race)
[498.253981] Starting subtest: dpms-vs-vblank-race
[498.256273] Starting dynamic subtest: A-eDP1
[503.254126] Dynamic subtest A-eDP1: SUCCESS (4.996s)
[503.265021] Starting dynamic subtest: B-eDP1
[507.876383] Dynamic subtest B-eDP1: SUCCESS (4.622s)
[507.887870] Starting dynamic subtest: C-eDP1
[512.513946] Dynamic subtest C-eDP1: SUCCESS (4.635s)
[512.525738] Starting dynamic subtest: D-eDP1
[517.148328] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[517.150727] Subtest dpms-vs-vblank-race: SUCCESS (18.894s)
[518.029704] [079/133] (502s left) kms_flip (2x-flip-vs-wf_vblank)
[518.125239] Starting subtest: 2x-flip-vs-wf_vblank
[518.134560] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[518.227618] [080/133] (502s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[518.279275] Starting subtest: etime-single-wait-all-for-submit-submitted
[518.387814] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[518.466331] [081/133] (502s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[518.567976] Starting subtest: psr-modesetfrombusy
[524.694539] Subtest psr-modesetfrombusy: SUCCESS (6.132s)
[524.832707] [082/133] (495s left) gem_exec_fence (syncobj-export)
[525.293910] Starting subtest: syncobj-export
[525.299279] Subtest syncobj-export: SUCCESS (0.005s)
[526.964474] [083/133] (493s left) kms_flip (2x-blocking-wf_vblank)
[527.051184] Starting subtest: 2x-blocking-wf_vblank
[527.061872] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[527.186404] [084/133] (493s left) gem_exec_reloc (basic-write-wc-noreloc)
[527.240269] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[527.303162] [085/133] (493s left) gem_create (busy-create)
[527.358823] Starting subtest: busy-create
[527.360987] Starting dynamic subtest: smem0
[560.858035] Dynamic subtest smem0: SUCCESS (33.497s)
[560.860709] Subtest busy-create: SUCCESS (33.499s)
[561.049357] [086/133] (459s left) gem_pread (snoop)
[561.101950] Subtest snoop: SKIP (0.000s)
[561.165039] [087/133] (459s left) kms_atomic_interruptible (universal-setplane-primary)
[561.259797] Starting subtest: universal-setplane-primary
[561.262138] Starting dynamic subtest: pipe-A-eDP-1
[568.698630] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s)
[568.700544] Subtest universal-setplane-primary: SUCCESS (7.437s)
[569.557974] [088/133] (451s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[569.648170] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[569.650493] Starting dynamic subtest: pipe-A-eDP-1
[570.496879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.841s)
[570.508740] Starting dynamic subtest: pipe-B-eDP-1
[572.141570] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.641s)
[572.153377] Starting dynamic subtest: pipe-C-eDP-1
[573.660118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.519s)
[573.672011] Starting dynamic subtest: pipe-D-eDP-1
[575.181276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.520s)
[575.183248] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.526s)
[576.378951] [089/133] (444s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[576.488879] Starting subtest: y-tiled-32bpp-rotate-270
[576.493441] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[576.600323] [090/133] (444s left) gem_userptr_blits (sync-unmap)
[576.672589] Starting subtest: sync-unmap
[576.685113] Subtest sync-unmap: SUCCESS (0.013s)
[576.826852] [091/133] (444s left) gen3_render_tiledy_blits
[576.955139] [092/133] (444s left) prime_self_import (reimport-vs-gem_close-race)
[576.991118] Starting subtest: reimport-vs-gem_close-race
[582.070933] Subtest reimport-vs-gem_close-race: SUCCESS (5.081s)
[582.151049] [093/133] (439s left) kms_frontbuffer_tracking (fbc-tiling-4)
[582.253422] Starting subtest: fbc-tiling-4
[586.470622] Subtest fbc-tiling-4: SUCCESS (4.220s)
[587.657867] [094/133] (433s left) syncobj_eventfd (binary-wait-signaled)
[587.733547] Starting subtest: binary-wait-signaled
[587.735550] Subtest binary-wait-signaled: SUCCESS (0.000s)
[587.834298] [095/133] (433s left) api_intel_bb (blit-reloc-purge-cache)
[587.891879] Starting subtest: blit-reloc-purge-cache
[587.895915] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[588.001593] [096/133] (433s left) gem_exec_reloc (basic-wc)
[588.060124] Subtest basic-wc: SKIP (0.000s)
[588.122304] [097/133] (433s left) gen9_exec_parse (bb-start-far)
[588.185118] Subtest bb-start-far: SKIP (0.000s)
[588.255920] [098/133] (433s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[588.357548] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[595.270139] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.915s)
[595.397684] [099/133] (426s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[595.498595] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[595.501036] Starting dynamic subtest: pipe-A-eDP-1
[595.572381] Dynamic subtest pipe-A-eDP-1: SKIP (0.080s)
[595.583151] Starting dynamic subtest: pipe-B-eDP-1
[596.670418] Dynamic subtest pipe-B-eDP-1: SKIP (1.096s)
[596.674369] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.178s)
[597.856616] [100/133] (423s left) kms_rotation_crc (primary-rotation-270)
[597.961890] Starting subtest: primary-rotation-270
[597.966322] Subtest primary-rotation-270: SKIP (0.001s)
[598.041272] [101/133] (423s left) kms_flip (flip-vs-panning-vs-hang)
[598.125906] Starting subtest: flip-vs-panning-vs-hang
[598.128286] Starting dynamic subtest: A-eDP1
[649.354466] Dynamic subtest A-eDP1: SUCCESS (51.226s)
[649.368115] Starting dynamic subtest: D-eDP1
[689.419073] Dynamic subtest D-eDP1: SUCCESS (40.060s)
[689.421420] Subtest flip-vs-panning-vs-hang: SUCCESS (91.292s)
[690.646486] [102/133] (330s left) kms_cursor_crc (cursor-sliding-256x85)
[690.927477] Starting subtest: cursor-sliding-256x85
[690.976156] Subtest cursor-sliding-256x85: SKIP (0.044s)
[691.146339] [103/133] (330s left) gem_render_copy_redux (interruptible)
[691.207632] Starting subtest: interruptible
[691.515143] Subtest interruptible: SUCCESS (0.307s)
[691.640917] [104/133] (330s left) syncobj_basic (bad-flags-handle-to-fd)
[691.688927] Starting subtest: bad-flags-handle-to-fd
[691.690911] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[691.795586] [105/133] (329s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[691.850791] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[691.917646] [106/133] (329s left) kms_psr (fbc-psr-sprite-blt)
[692.008866] Starting subtest: fbc-psr-sprite-blt
[692.010736] Starting dynamic subtest: eDP-1
[692.014299] Dynamic subtest eDP-1: SKIP (0.000s)
[692.017741] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[692.117562] [107/133] (329s left) gem_exec_flush (basic-wb-ro-default)
[692.176109] Starting subtest: basic-wb-ro-default
[697.632282] Subtest basic-wb-ro-default: SUCCESS (5.455s)
[697.822276] [108/133] (324s left) kms_psr (pr-cursor-plane-move)
[697.920953] Starting subtest: pr-cursor-plane-move
[697.925436] Subtest pr-cursor-plane-move: SKIP (0.000s)
[697.996744] [109/133] (323s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[698.056817] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[698.061452] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[698.246606] [110/133] (323s left) perf (invalid-oa-format-id)
[698.381036] Starting subtest: invalid-oa-format-id
[698.394077] Subtest invalid-oa-format-id: SUCCESS (0.013s)
[698.443996] [111/133] (323s left) gem_exec_reloc (basic-cpu-gtt-active)
[698.494526] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[698.591191] [112/133] (323s left) kms_atomic_transition (modeset-transition-fencing)
[698.674848] Starting subtest: modeset-transition-fencing
[698.677094] Starting dynamic subtest: 1x-outputs
[709.582110] Dynamic subtest 1x-outputs: SUCCESS (10.907s)
[709.584674] Subtest modeset-transition-fencing: SUCCESS (10.908s)
[710.444150] [113/133] (311s left) gem_exec_whisper (basic-contexts-priority)
[710.505412] Starting subtest: basic-contexts-priority
[735.217416] Subtest basic-contexts-priority: SUCCESS (24.706s)
[735.400918] [114/133] (286s left) kms_chamelium_audio (dp-audio)
[735.803699] Subtest dp-audio: SKIP (0.000s)
[736.669122] [115/133] (285s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[736.759213] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[736.763087] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[736.863630] [116/133] (285s left) kms_lease (implicit-plane-lease)
[736.958170] Starting subtest: implicit-plane-lease
[736.960451] Subtest implicit-plane-lease: SUCCESS (0.003s)
[737.065716] [117/133] (285s left) gem_mmap (pf-nonblock)
[737.119280] Subtest pf-nonblock: SKIP (0.000s)
[737.177818] [118/133] (285s left) gem_render_tiled_blits (basic)
[737.236542] Subtest basic: SKIP (0.000s)
[737.305720] [119/133] (285s left) i915_suspend (basic-s3-without-i915)
[737.351144] Starting subtest: basic-s3-without-i915
[742.087379] Subtest basic-s3-without-i915: SKIP (4.730s)
[743.657647] [120/133] (278s left) kms_psr (fbc-pr-basic)
[743.756791] Starting subtest: fbc-pr-basic
[743.761325] Subtest fbc-pr-basic: SKIP (0.000s)
[743.832722] [121/133] (278s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[743.934570] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[743.938609] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[744.033227] [122/133] (278s left) kms_color (ctm-negative)
[744.134775] Starting subtest: ctm-negative
[744.137108] Starting dynamic subtest: pipe-A-eDP-1
[744.881604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[744.894445] Starting dynamic subtest: pipe-B-eDP-1
[746.275621] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[746.286418] Starting dynamic subtest: pipe-C-eDP-1
[747.659798] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[747.670514] Starting dynamic subtest: pipe-D-eDP-1
[748.986819] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[748.988732] Subtest ctm-negative: SUCCESS (4.851s)
[749.793446] [123/133] (272s left) gem_exec_capture (capture-recoverable)
[749.866132] Starting subtest: capture-recoverable
[749.872081] Subtest capture-recoverable: SUCCESS (0.003s)
[750.001907] [124/133] (272s left) kms_feature_discovery (psr1)
[750.104029] Starting subtest: psr1
[750.105944] Subtest psr1: SUCCESS (0.000s)
[750.174632] [125/133] (272s left) fbdev (write)
[750.216304] Starting subtest: write
[750.575860] Subtest write: SUCCESS (0.357s)
[750.650854] [126/133] (272s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[750.745108] Starting subtest: 4-tiled-8bpp-rotate-90
[750.766164] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[750.885355] [127/133] (271s left) gem_lmem_swapping (random-engines)
[750.923288] Subtest random-engines: SKIP (0.000s)
[750.969886] [128/133] (271s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[751.051243] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[751.053479] Starting dynamic subtest: pipe-A-eDP-1
[751.076183] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[751.088569] Starting dynamic subtest: pipe-B-eDP-1
[751.110253] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[751.119518] Starting dynamic subtest: pipe-C-eDP-1
[751.141099] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[751.150422] Starting dynamic subtest: pipe-D-eDP-1
[751.172670] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[751.177174] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[753.282986] [129/133] (269s left) gem_render_linear_blits (basic)
[753.353591] Starting subtest: basic
[753.374643] Subtest basic: SUCCESS (0.023s)
[753.460774] [130/133] (269s left) gem_mmap_offset (partial-remap)
[753.511162] Starting subtest: partial-remap
[753.513018] Starting dynamic subtest: smem0
[753.521596] Dynamic subtest smem0: SUCCESS (0.005s)
[753.523465] Subtest partial-remap: SUCCESS (0.005s)
[753.599617] [131/133] (269s left) gem_ctx_param (basic)
[753.645533] Starting subtest: basic
[753.647654] Subtest basic: SUCCESS (0.001s)
[753.753221] [132/133] (269s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[753.802971] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[753.864786] [133/133] (269s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[753.964873] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[758.118553] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.157s)
[759.283185] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: prime_busy
results: parsing output: 5/ for test: kms_tiled_display
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr_stress_test
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: api_intel_bb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_exec_gttfill
results: parsing output: 17/ for test: kms_chamelium_edid
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_setmode
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: gem_userptr_blits
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_color
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_addfb_basic
results: parsing output: 40/ for test: kms_rmfb
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: kms_pm_backlight
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: syncobj_basic
results: parsing output: 49/ for test: vgem_slow
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_joiner
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: gem_workarounds
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: dmabuf_sync_file
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: gem_render_copy
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_spin_batch
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: gem_create
results: parsing output: 85/ for test: gem_pread
results: parsing output: 86/ for test: kms_atomic_interruptible
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: gen3_render_tiledy_blits
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: api_intel_bb
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: gem_render_copy_redux
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: kms_pipe_b_c_ivb
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: gem_exec_whisper
results: parsing output: 113/ for test: kms_chamelium_audio
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: gem_mmap
results: parsing output: 117/ for test: gem_render_tiled_blits
results: parsing output: 118/ for test: i915_suspend
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: fbdev
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_lmem_swapping
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gem_render_linear_blits
results: parsing output: 129/ for test: gem_mmap_offset
results: parsing output: 130/ for test: gem_ctx_param
results: parsing output: 131/ for test: gem_fenced_exec_thrash
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.