[61.711809] Initializing watchdogs
[61.711857]   /dev/watchdog0
[61.726781] [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]
[61.731027] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.733379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.736845] [001/133] (960s left) perf (global-sseu-config-invalid)
[61.894712] Starting subtest: global-sseu-config-invalid
[61.899087] Subtest global-sseu-config-invalid: SKIP (0.000s)
[61.933985] [002/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[62.037059] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[70.064731] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (8.018s)
[70.198797] [003/133] (952s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[70.291177] Starting subtest: fb-8bpc-vs-panel-8bpc
[70.293440] Starting dynamic subtest: pipe-A-eDP-1
[71.693144] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.399s)
[71.695464] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.400s)
[72.524906] [004/133] (949s left) kms_vblank (query-busy)
[72.627294] Starting subtest: query-busy
[72.629664] Starting dynamic subtest: pipe-A-eDP-1
[74.516304] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[74.529403] Starting dynamic subtest: pipe-D-eDP-1
[77.059936] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s)
[77.062149] Subtest query-busy: SUCCESS (4.429s)
[77.876225] [005/133] (944s left) gem_exec_fence (syncobj-timeline-export)
[78.445818] Starting subtest: syncobj-timeline-export
[78.451883] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[80.004324] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[80.007350] [006/133] (942s left) kms_vblank (wait-forked-hang)
[80.108739] Starting subtest: wait-forked-hang
[80.110615] Starting dynamic subtest: pipe-A-eDP-1
[106.709521] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.591s)
[106.723268] Starting dynamic subtest: pipe-D-eDP-1
[131.741226] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[131.743663] Subtest wait-forked-hang: SUCCESS (51.619s)
[132.562135] [007/133] (889s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[132.627449] Starting subtest: invalid-bsd1-flag-on-blt
[132.629340] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[132.756065] [008/133] (889s left) gem_media_vme
[132.907094] [009/133] (889s left) kms_cursor_crc (cursor-random-64x64)
[133.087224] Starting subtest: cursor-random-64x64
[133.089558] Starting dynamic subtest: pipe-A-eDP-1
[136.444513] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.353s)
[136.468627] Starting dynamic subtest: pipe-D-eDP-1
[140.430803] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[140.433087] Subtest cursor-random-64x64: SUCCESS (7.342s)
[141.327661] [010/133] (881s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[141.422483] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[141.426915] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[141.507898] [011/133] (881s left) kms_psr (psr2-cursor-render)
[141.612263] Starting subtest: psr2-cursor-render
[141.614600] Starting dynamic subtest: eDP-1
[143.295643] Dynamic subtest eDP-1: SUCCESS (1.684s)
[143.298014] Subtest psr2-cursor-render: SUCCESS (1.685s)
[144.110901] [012/133] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[144.214474] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[144.218677] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[144.328713] [013/133] (878s left) gem_set_tiling_vs_pwrite
[144.458476] [014/133] (878s left) gem_exec_balancer (parallel-keep-in-fence)
[144.706289] Starting subtest: parallel-keep-in-fence
[145.871018] Subtest parallel-keep-in-fence: SUCCESS (1.165s)
[145.988471] [015/133] (876s left) gem_userptr_blits (create-destroy-sync)
[146.050476] Starting subtest: create-destroy-sync
[151.108449] Subtest create-destroy-sync: SUCCESS (5.007s)
[151.200744] [016/133] (871s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[151.272316] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[151.377197] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[151.475971] [017/133] (871s left) gem_mmap_gtt (basic-small-copy-xy)
[151.549959] Subtest basic-small-copy-XY: SKIP (0.000s)
[151.617200] [018/133] (871s left) gem_caching (read-writes)
[151.693444] Subtest read-writes: SKIP (0.000s)
[151.778880] [019/133] (871s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[151.836742] Starting subtest: multi-wait-all-for-submit-available-signaled
[151.839057] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[151.948506] [020/133] (871s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[152.040825] Starting subtest: plane-lut1d-pre-ctm3x4
[152.053611] Starting dynamic subtest: pipe-A-eDP-1
[152.708861] Dynamic subtest pipe-A-eDP-1: FAIL (0.322s)
[153.470980] Starting dynamic subtest: pipe-B-eDP-1
[154.280807] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[154.802128] Starting dynamic subtest: pipe-C-eDP-1
[155.622572] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[156.125868] Starting dynamic subtest: pipe-D-eDP-1
[156.980681] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s)
[156.983189] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.627s)
[157.526739] [021/133] (865s left) sysfs_heartbeat_interval (idempotent)
[157.577117] Starting subtest: idempotent
[157.579419] Starting dynamic subtest: vecs0
[157.581713] Dynamic subtest vecs0: SUCCESS (0.001s)
[157.590062] Starting dynamic subtest: ccs0
[157.592216] Dynamic subtest ccs0: SUCCESS (0.001s)
[157.599592] Starting dynamic subtest: vcs0
[157.601847] Dynamic subtest vcs0: SUCCESS (0.000s)
[157.609260] Starting dynamic subtest: bcs0
[157.611135] Dynamic subtest bcs0: SUCCESS (0.001s)
[157.618071] Starting dynamic subtest: rcs0
[157.619930] Dynamic subtest rcs0: SUCCESS (0.000s)
[157.626797] Starting dynamic subtest: vcs1
[157.628654] Dynamic subtest vcs1: SUCCESS (0.000s)
[157.630571] Subtest idempotent: SUCCESS (0.006s)
[157.701265] [022/133] (865s left) kms_atomic (atomic-invalid-params)
[157.794342] Starting subtest: atomic-invalid-params
[157.796677] Starting dynamic subtest: pipe-A-eDP-1
[158.204949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[158.207281] Subtest atomic-invalid-params: SUCCESS (0.410s)
[159.047731] [023/133] (864s left) gem_pxp (hw-rejects-pxp-buffer)
[159.175650] Starting subtest: hw-rejects-pxp-buffer
[159.180367] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[159.294889] [024/133] (863s left) perf (non-system-wide-paranoid)
[159.407603] Starting subtest: non-system-wide-paranoid
[159.435817] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[159.490559] [025/133] (863s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[159.587323] Starting subtest: psr-rgb565-draw-mmap-gtt
[159.591646] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[159.709672] [026/133] (863s left) i915_query (hwconfig_table)
[159.767955] Starting subtest: hwconfig_table
[160.050199] Subtest hwconfig_table: SUCCESS (0.001s)
[160.086426] [027/133] (863s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[160.184671] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[167.234587] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.050s)
[168.358230] [028/133] (855s left) gem_ctx_param (invalid-set-ringsize)
[168.406514] Starting subtest: invalid-set-ringsize
[168.408712] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[168.490411] [029/133] (854s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[168.603480] Starting subtest: 4-tiled-addfb-size-offset-overflow
[168.605306] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[168.732219] [030/133] (854s left) kms_dsc (dsc-fractional-bpp)
[168.825040] Starting subtest: dsc-fractional-bpp
[168.838147] Subtest dsc-fractional-bpp: SKIP (0.000s)
[168.906008] [031/133] (854s left) drm_buddy (drm_buddy)
[168.947020] Starting subtest: drm_buddy
[168.951519] Subtest drm_buddy: SKIP (0.001s)
[169.016453] [032/133] (854s left) kms_chamelium_hpd (common-hpd-after-suspend)
[169.394716] Subtest common-hpd-after-suspend: SKIP (0.000s)
[170.245203] [033/133] (853s left) gem_exec_schedule (u-submit-golden-slice)
[170.316078] Starting subtest: u-submit-golden-slice
[170.317931] Starting dynamic subtest: rcs0
[170.343686] Dynamic subtest rcs0: SUCCESS (0.035s)
[170.352637] Starting dynamic subtest: bcs0
[170.369740] Dynamic subtest bcs0: SUCCESS (0.026s)
[170.377334] Starting dynamic subtest: vcs0
[170.402795] Dynamic subtest vcs0: SUCCESS (0.033s)
[170.412497] Starting dynamic subtest: vcs1
[170.431354] Dynamic subtest vcs1: SUCCESS (0.028s)
[170.438906] Starting dynamic subtest: vecs0
[170.463411] Dynamic subtest vecs0: SUCCESS (0.032s)
[170.471283] Starting dynamic subtest: ccs0
[170.491430] Dynamic subtest ccs0: SUCCESS (0.028s)
[170.493694] Subtest u-submit-golden-slice: SUCCESS (0.184s)
[172.056611] [034/133] (851s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[172.144337] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[172.148659] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[172.230684] [035/133] (851s left) syncobj_wait (single-wait-signaled)
[172.283841] Starting subtest: single-wait-signaled
[172.286097] Subtest single-wait-signaled: SUCCESS (0.000s)
[172.418215] [036/133] (851s left) kms_pm_backlight (fade-with-dpms)
[172.513931] Starting subtest: fade-with-dpms
[174.648888] Starting dynamic subtest: eDP-1
[177.333530] Dynamic subtest eDP-1: SUCCESS (2.685s)
[177.335803] Subtest fade-with-dpms: SUCCESS (4.820s)
[178.141977] [037/133] (845s left) kms_rmfb (close-fd)
[178.238980] Starting subtest: close-fd
[178.240969] Starting dynamic subtest: pipe-A-eDP-1
[178.342948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[178.352785] Starting dynamic subtest: pipe-B-eDP-1
[179.488135] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[179.497937] Starting dynamic subtest: pipe-C-eDP-1
[180.627162] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.138s)
[180.636166] Starting dynamic subtest: pipe-D-eDP-1
[181.752188] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[181.754385] Subtest close-fd: SUCCESS (3.516s)
[182.978046] [038/133] (840s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[183.073444] Starting subtest: read-crc-frame-sequence
[183.075820] Starting dynamic subtest: pipe-A-eDP-1
[183.787458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[183.796819] Starting dynamic subtest: pipe-B-eDP-1
[185.162333] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[185.171694] Starting dynamic subtest: pipe-C-eDP-1
[186.550719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[186.559705] Starting dynamic subtest: pipe-D-eDP-1
[187.868193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[187.870615] Subtest read-crc-frame-sequence: SUCCESS (4.795s)
[188.724869] [039/133] (835s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[188.829342] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[188.833731] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[188.918372] [040/133] (834s left) syncobj_wait (wait-all-interrupted)
[188.977040] Starting subtest: wait-all-interrupted
[189.082511] Subtest wait-all-interrupted: SUCCESS (0.103s)
[189.168974] [041/133] (834s left) kms_fbcon_fbt (psr-suspend)
[189.226823] Starting subtest: psr-suspend
[239.504387] Subtest psr-suspend: SUCCESS (20.476s)
[244.610939] [042/133] (784s left) gem_render_copy (y-tiled)
[244.681473] Starting subtest: y-tiled
[244.686441] Subtest y-tiled: SKIP (0.000s)
[244.877696] [043/133] (784s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[245.003333] Starting subtest: cursorA-vs-flipA-legacy
[256.164498] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.113s)
[257.004951] [044/133] (772s left) syncobj_wait (single-wait-for-submit-signaled)
[257.066272] Starting subtest: single-wait-for-submit-signaled
[257.068425] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[257.187287] [045/133] (771s left) kms_psr (fbc-pr-sprite-plane-move)
[257.293650] Starting subtest: fbc-pr-sprite-plane-move
[257.298979] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[257.377214] [046/133] (771s left) gem_mmap_offset (partial-mmap)
[257.442233] Starting subtest: partial-mmap
[257.444415] Starting dynamic subtest: smem0
[257.449624] Dynamic subtest smem0: SUCCESS (0.007s)
[257.452393] Subtest partial-mmap: SUCCESS (0.008s)
[257.564699] [047/133] (771s left) gem_spin_batch (resubmit)
[257.632851] Starting subtest: resubmit
[257.635460] Starting dynamic subtest: rcs0
[257.640629] Dynamic subtest rcs0: SUCCESS (0.007s)
[257.650207] Starting dynamic subtest: bcs0
[257.652689] Dynamic subtest bcs0: SUCCESS (0.003s)
[257.661483] Starting dynamic subtest: vcs0
[257.664236] Dynamic subtest vcs0: SUCCESS (0.003s)
[257.672667] Starting dynamic subtest: vcs1
[257.675357] Dynamic subtest vcs1: SUCCESS (0.004s)
[257.684188] Starting dynamic subtest: vecs0
[257.686530] Dynamic subtest vecs0: SUCCESS (0.003s)
[257.695172] Starting dynamic subtest: ccs0
[257.697641] Dynamic subtest ccs0: SUCCESS (0.003s)
[257.700406] Subtest resubmit: SUCCESS (0.027s)
[257.919346] [048/133] (771s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[258.029304] Starting subtest: fbcpsr-rgb565-draw-render
[264.998608] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.961s)
[265.181919] [049/133] (764s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[265.286035] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[265.291315] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[265.409643] [050/133] (763s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[265.513872] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[265.515862] Starting dynamic subtest: pipe-A-eDP-1
[265.536890] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[265.546478] Starting dynamic subtest: pipe-B-eDP-1
[265.568507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[265.577335] Starting dynamic subtest: pipe-C-eDP-1
[265.598231] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[265.608957] Starting dynamic subtest: pipe-D-eDP-1
[265.632452] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[265.635231] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.086s)
[267.817530] [051/133] (761s left) kms_setmode (invalid-clone-single-crtc-stealing)
[267.876593] Starting subtest: invalid-clone-single-crtc-stealing
[267.884431] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[267.991925] [052/133] (761s left) kms_invalid_mode (bad-vtotal)
[268.090148] Starting subtest: bad-vtotal
[268.092642] Starting dynamic subtest: pipe-A-eDP-1
[268.372714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[268.387207] Starting dynamic subtest: pipe-B-eDP-1
[268.389502] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[268.398260] Starting dynamic subtest: pipe-C-eDP-1
[268.401044] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[268.409753] Starting dynamic subtest: pipe-D-eDP-1
[268.412474] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[268.415299] Subtest bad-vtotal: SUCCESS (0.289s)
[269.242820] [053/133] (760s left) gem_mmap (short-mmap)
[269.318614] Subtest short-mmap: SKIP (0.000s)
[269.384574] [054/133] (760s left) gem_close (many-handles-one-vma)
[269.439391] Starting subtest: many-handles-one-vma
[269.461151] Subtest many-handles-one-vma: SUCCESS (0.024s)
[269.592622] [055/133] (759s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[269.656449] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[269.658962] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[269.784920] [056/133] (759s left) gem_exec_fence (syncobj-timeline-wait)
[270.349246] Starting subtest: syncobj-timeline-wait
[271.543334] Subtest syncobj-timeline-wait: SUCCESS (1.194s)
[271.802958] [057/133] (757s left) api_intel_allocator (default-alignment)
[271.872546] Starting subtest: default-alignment
[271.878246] Subtest default-alignment: SUCCESS (0.006s)
[272.021282] [058/133] (757s left) kms_psr (fbc-pr-basic)
[272.127342] Starting subtest: fbc-pr-basic
[272.132442] Subtest fbc-pr-basic: SKIP (0.000s)
[272.210987] [059/133] (757s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[272.320442] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[272.323401] Starting dynamic subtest: pipe-A-eDP-1
[272.350006] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.360407] Starting dynamic subtest: pipe-B-eDP-1
[272.386464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.395208] Starting dynamic subtest: pipe-C-eDP-1
[272.421186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.429885] Starting dynamic subtest: pipe-D-eDP-1
[272.455436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.460382] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[274.607919] [060/133] (755s left) kms_content_protection (dp-mst-lic-type-0)
[274.755600] Starting subtest: dp-mst-lic-type-0
[274.761148] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[274.883264] [061/133] (754s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[275.009356] Starting subtest: cursorA-vs-flipB-legacy
[275.014543] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[275.165177] [062/133] (754s left) gem_eio (suspend)
[275.397623] Starting subtest: suspend
[287.631662] Subtest suspend: SUCCESS (12.226s)
[298.852662] [063/133] (742s left) gem_exec_schedule (implicit-write-read)
[298.938373] Starting subtest: implicit-write-read
[298.941277] Starting dynamic subtest: rcs0
[299.107116] Dynamic subtest rcs0: SUCCESS (0.181s)
[299.117597] Starting dynamic subtest: vcs0
[299.226968] Dynamic subtest vcs0: SUCCESS (0.120s)
[299.240906] Starting dynamic subtest: vcs1
[299.385339] Dynamic subtest vcs1: SUCCESS (0.157s)
[299.397583] Starting dynamic subtest: vecs0
[299.494624] Dynamic subtest vecs0: SUCCESS (0.109s)
[299.506588] Starting dynamic subtest: ccs0
[299.647623] Dynamic subtest ccs0: SUCCESS (0.152s)
[299.650525] Subtest implicit-write-read: SUCCESS (0.722s)
[300.678210] [064/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[300.793971] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[300.798831] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[300.911809] [065/133] (740s left) api_intel_bb (reset-flags)
[300.972141] Starting subtest: reset-flags
[300.978467] Subtest reset-flags: SUCCESS (0.010s)
[301.140079] [066/133] (739s left) i915_drm_fdinfo (virtual-idle)
[301.187267] Starting subtest: virtual-idle
[304.271288] Subtest virtual-idle: SUCCESS (3.083s)
[304.359631] [067/133] (736s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[304.414508] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[304.417439] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[304.527379] [068/133] (736s left) gem_exec_reloc (basic-write-cpu)
[304.587926] Subtest basic-write-cpu: SKIP (0.000s)
[304.679248] [069/133] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[304.786745] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[308.792213] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (4.010s)
[309.935526] [070/133] (731s left) gem_busy (busy)
[310.017609] Starting subtest: busy
[310.020582] Starting dynamic subtest: all-engines
[310.090114] Dynamic subtest all-engines: SUCCESS (0.072s)
[310.099624] Starting dynamic subtest: rcs0
[311.558871] Dynamic subtest rcs0: SUCCESS (1.467s)
[311.569479] Starting dynamic subtest: bcs0
[311.621730] Dynamic subtest bcs0: SUCCESS (0.060s)
[311.630906] Starting dynamic subtest: vcs0
[311.662648] Dynamic subtest vcs0: SUCCESS (0.039s)
[311.672186] Starting dynamic subtest: vcs1
[313.541589] Dynamic subtest vcs1: SUCCESS (1.875s)
[313.552455] Starting dynamic subtest: vecs0
[315.581043] Dynamic subtest vecs0: SUCCESS (1.984s)
[315.593421] Starting dynamic subtest: ccs0
[317.509641] Dynamic subtest ccs0: SUCCESS (1.981s)
[317.512556] Subtest busy: SUCCESS (7.490s)
[317.906986] [071/133] (723s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[318.037863] Starting subtest: cursor-vs-flip-toggle
[348.838954] Subtest cursor-vs-flip-toggle: SUCCESS (30.792s)
[349.670832] [072/133] (691s left) gen7_exec_parse (oacontrol-tracking)
[349.757196] Subtest oacontrol-tracking: SKIP (0.000s)
[349.828373] [073/133] (691s left) kms_chamelium_frames (hdmi-crc-multiple)
[350.218392] Subtest hdmi-crc-multiple: SKIP (0.000s)
[351.071072] [074/133] (690s left) i915_pm_rps (min-max-config-idle)
[351.134034] Starting subtest: min-max-config-idle
[351.139398] Subtest min-max-config-idle: SKIP (0.001s)
[351.270954] [075/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[351.385470] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[351.390331] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[351.525140] [076/133] (689s left) kms_big_fb (linear-32bpp-rotate-270)
[351.635454] Starting subtest: linear-32bpp-rotate-270
[351.655133] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[351.804383] [077/133] (689s left) gem_mmap_wc (pf-nonblock)
[351.871440] Subtest pf-nonblock: SKIP (0.000s)
[351.949266] [078/133] (689s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[352.038351] Starting subtest: crc-primary-suspend-y-tiled-ccs
[352.040453] Starting dynamic subtest: pipe-A-eDP-1
[352.049381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.059125] Starting dynamic subtest: pipe-B-eDP-1
[352.068265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.078264] Starting dynamic subtest: pipe-C-eDP-1
[352.090482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.098862] Starting dynamic subtest: pipe-D-eDP-1
[352.106884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.110883] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[354.285858] [079/133] (687s left) gem_exec_schedule (u-submit-early-slice)
[354.371420] Starting subtest: u-submit-early-slice
[354.374194] Starting dynamic subtest: rcs0
[354.406597] Dynamic subtest rcs0: SUCCESS (0.047s)
[354.418146] Starting dynamic subtest: bcs0
[354.446218] Dynamic subtest bcs0: SUCCESS (0.039s)
[354.455370] Starting dynamic subtest: vcs0
[354.486952] Dynamic subtest vcs0: SUCCESS (0.040s)
[354.496421] Starting dynamic subtest: vcs1
[354.529334] Dynamic subtest vcs1: SUCCESS (0.041s)
[354.539397] Starting dynamic subtest: vecs0
[354.573230] Dynamic subtest vecs0: SUCCESS (0.043s)
[354.583458] Starting dynamic subtest: ccs0
[354.616149] Dynamic subtest ccs0: SUCCESS (0.042s)
[354.618592] Subtest u-submit-early-slice: SUCCESS (0.257s)
[355.621002] [080/133] (686s left) kms_lease (implicit-plane-lease)
[355.724360] Starting subtest: implicit-plane-lease
[355.727057] Subtest implicit-plane-lease: SUCCESS (0.003s)
[355.848979] [081/133] (685s left) perf_pmu (multi-client)
[355.896193] Starting subtest: multi-client
[355.898310] Starting dynamic subtest: rcs0
[356.970035] Dynamic subtest rcs0: SUCCESS (1.073s)
[356.982936] Starting dynamic subtest: bcs0
[358.030904] Dynamic subtest bcs0: SUCCESS (1.058s)
[358.043742] Starting dynamic subtest: vcs0
[359.084998] Dynamic subtest vcs0: SUCCESS (1.050s)
[359.096331] Starting dynamic subtest: vcs1
[360.568341] Dynamic subtest vcs1: SUCCESS (1.481s)
[360.579687] Starting dynamic subtest: vecs0
[362.549318] Dynamic subtest vecs0: SUCCESS (1.978s)
[362.560097] Starting dynamic subtest: ccs0
[364.535606] Dynamic subtest ccs0: SUCCESS (1.983s)
[364.538632] Subtest multi-client: SUCCESS (8.639s)
[364.683444] [082/133] (677s left) gem_wait (wait)
[364.754371] Starting subtest: wait
[364.757170] Starting dynamic subtest: all-engines
[366.464443] Dynamic subtest all-engines: SUCCESS (1.708s)
[366.476632] Starting dynamic subtest: rcs0
[367.516899] Dynamic subtest rcs0: SUCCESS (1.050s)
[367.529252] Starting dynamic subtest: bcs0
[368.570791] Dynamic subtest bcs0: SUCCESS (1.051s)
[368.583041] Starting dynamic subtest: vcs0
[369.620313] Dynamic subtest vcs0: SUCCESS (1.047s)
[369.632953] Starting dynamic subtest: vcs1
[370.668762] Dynamic subtest vcs1: SUCCESS (1.046s)
[370.681357] Starting dynamic subtest: vecs0
[371.718092] Dynamic subtest vecs0: SUCCESS (1.047s)
[371.729487] Starting dynamic subtest: ccs0
[372.772761] Dynamic subtest ccs0: SUCCESS (1.052s)
[372.775437] Subtest wait: SUCCESS (8.017s)
[372.989863] [083/133] (668s left) kms_busy (extended-pageflip-hang-newfb)
[373.102592] Starting subtest: extended-pageflip-hang-newfb
[373.105332] Starting dynamic subtest: pipe-A
[399.330293] Dynamic subtest pipe-A: SUCCESS (26.217s)
[399.341189] Starting dynamic subtest: pipe-D
[423.328120] Dynamic subtest pipe-D: SUCCESS (23.988s)
[423.330554] Subtest extended-pageflip-hang-newfb: SUCCESS (50.210s)
[424.190750] [084/133] (617s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[424.308770] Starting subtest: yf-tiled-8bpp-rotate-90
[424.314368] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[424.433700] [085/133] (617s left) kms_prime (basic-modeset-hybrid)
[424.522356] Subtest basic-modeset-hybrid: SKIP (0.000s)
[424.629050] [086/133] (617s left) gem_exec_balancer (bonded-dual)
[424.683658] Starting subtest: bonded-dual
[424.689365] Subtest bonded-dual: SKIP (0.000s)
[424.990899] [087/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[425.099513] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[425.104595] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[425.219031] [088/133] (616s left) prime_mmap (test_correct_cpu_write)
[425.272640] Starting subtest: test_correct_cpu_write
[425.275391] Starting dynamic subtest: test_correct_cpu_write-smem
[425.277886] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[425.280231] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[425.407640] [089/133] (616s left) gem_ctx_persistence (smoketest)
[425.476184] Starting subtest: smoketest
[466.463010] Subtest smoketest: SUCCESS (40.970s)
[466.557751] [090/133] (575s left) syncobj_wait (multi-wait-submitted)
[466.608588] Starting subtest: multi-wait-submitted
[466.707634] Subtest multi-wait-submitted: SUCCESS (0.101s)
[466.800770] [091/133] (575s left) syncobj_timeline (wait-all-complex)
[466.859428] Starting subtest: wait-all-complex
[467.073626] Subtest wait-all-complex: SUCCESS (0.215s)
[467.165340] [092/133] (575s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[467.287740] Starting subtest: y-tiled-16bpp-rotate-0
[467.292599] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[467.414522] [093/133] (574s left) sw_sync (sync_busy)
[467.454648] Starting subtest: sync_busy
[467.457343] Subtest sync_busy: SUCCESS (0.002s)
[467.522094] [094/133] (574s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[467.622173] Starting subtest: psr-rgb565-draw-pwrite
[474.533484] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.912s)
[474.663111] [095/133] (567s left) kms_flip (basic-flip-vs-dpms)
[474.777325] Starting subtest: basic-flip-vs-dpms
[474.779954] Starting dynamic subtest: A-eDP1
[477.312585] Dynamic subtest A-eDP1: SUCCESS (2.536s)
[477.323578] Starting dynamic subtest: B-eDP1
[479.484434] Dynamic subtest B-eDP1: SUCCESS (2.170s)
[479.495876] Starting dynamic subtest: C-eDP1
[481.537857] Dynamic subtest C-eDP1: SUCCESS (2.052s)
[481.548956] Starting dynamic subtest: D-eDP1
[483.608775] Dynamic subtest D-eDP1: SUCCESS (2.067s)
[483.611332] Subtest basic-flip-vs-dpms: SUCCESS (8.835s)
[484.419523] [096/133] (557s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[484.528900] Starting subtest: pr-overlay-plane-update-continuous-sf
[484.533789] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[484.608110] [097/133] (557s left) gem_create (busy-create)
[484.660096] Starting subtest: busy-create
[484.662339] Starting dynamic subtest: smem0
[518.533452] Dynamic subtest smem0: SUCCESS (33.857s)
[518.536506] Subtest busy-create: SUCCESS (33.858s)
[518.732733] [098/133] (523s left) kms_plane_cursor (viewport)
[518.832073] Starting subtest: viewport
[518.837303] Starting dynamic subtest: pipe-A-eDP-1-size-64
[521.420691] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.588s)
[521.478616] Starting dynamic subtest: pipe-A-eDP-1-size-128
[524.011350] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.541s)
[524.070661] Starting dynamic subtest: pipe-A-eDP-1-size-256
[526.523858] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.460s)
[526.874438] Starting dynamic subtest: pipe-B-eDP-1-size-64
[530.048397] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.184s)
[530.106120] Starting dynamic subtest: pipe-B-eDP-1-size-128
[532.628331] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.528s)
[532.687490] Starting dynamic subtest: pipe-B-eDP-1-size-256
[535.174326] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.494s)
[535.525625] Starting dynamic subtest: pipe-C-eDP-1-size-64
[538.355127] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.842s)
[538.393288] Starting dynamic subtest: pipe-C-eDP-1-size-128
[540.456439] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[540.495450] Starting dynamic subtest: pipe-C-eDP-1-size-256
[542.590428] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.103s)
[542.920483] Starting dynamic subtest: pipe-D-eDP-1-size-64
[545.726269] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.815s)
[545.762844] Starting dynamic subtest: pipe-D-eDP-1-size-128
[547.904292] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s)
[547.943147] Starting dynamic subtest: pipe-D-eDP-1-size-256
[550.049188] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[550.368995] Subtest viewport: SUCCESS (31.523s)
[551.174314] [099/133] (491s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[551.299258] Starting subtest: short-flip-after-cursor-toggle
[552.222445] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s)
[553.108042] [100/133] (489s left) gem_tiled_blits (normal)
[553.176696] Subtest normal: SKIP (0.000s)
[553.254962] [101/133] (489s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[553.353479] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[553.356511] Starting dynamic subtest: pipe-A-eDP-1
[553.386371] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[553.398181] Starting dynamic subtest: pipe-B-eDP-1
[553.426004] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[553.436024] Starting dynamic subtest: pipe-C-eDP-1
[553.463639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[553.473171] Starting dynamic subtest: pipe-D-eDP-1
[553.501553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[553.506494] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[555.680114] [102/133] (486s left) kms_psr (psr-no-drrs)
[555.782276] Starting subtest: psr-no-drrs
[555.784817] Starting dynamic subtest: eDP-1
[557.343531] Dynamic subtest eDP-1: SUCCESS (1.563s)
[557.346483] Subtest psr-no-drrs: SUCCESS (1.564s)
[558.239269] [103/133] (484s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[558.336628] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[558.339021] Starting dynamic subtest: pipe-A
[558.357498] Dynamic subtest pipe-A: SKIP (0.017s)
[558.372304] Starting dynamic subtest: pipe-B
[558.387117] Dynamic subtest pipe-B: SKIP (0.029s)
[558.402626] Starting dynamic subtest: pipe-C
[558.418481] Dynamic subtest pipe-C: SKIP (0.029s)
[558.429121] Starting dynamic subtest: pipe-D
[558.446727] Dynamic subtest pipe-D: SKIP (0.029s)
[558.451892] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.107s)
[558.577219] [104/133] (484s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[558.679633] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[558.682329] Starting dynamic subtest: pipe-A-eDP-1
[558.708293] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[558.724170] Starting dynamic subtest: pipe-B-eDP-1
[558.749371] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.759062] Starting dynamic subtest: pipe-C-eDP-1
[558.785048] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.794505] Starting dynamic subtest: pipe-D-eDP-1
[558.820915] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.825597] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[561.005927] [105/133] (481s left) i915_drm_fdinfo (busy)
[561.063429] Starting subtest: busy
[561.066504] Starting dynamic subtest: rcs0
[561.111204] Dynamic subtest rcs0: SKIP (0.045s)
[561.127916] Starting dynamic subtest: bcs0
[561.133392] Dynamic subtest bcs0: SKIP (0.001s)
[561.143244] Starting dynamic subtest: vcs0
[561.148756] Dynamic subtest vcs0: SKIP (0.000s)
[561.161234] Starting dynamic subtest: vcs1
[561.166304] Dynamic subtest vcs1: SKIP (0.000s)
[561.175987] Starting dynamic subtest: vecs0
[561.181051] Dynamic subtest vecs0: SKIP (0.000s)
[561.191026] Starting dynamic subtest: ccs0
[561.196524] Dynamic subtest ccs0: SKIP (0.000s)
[561.202139] Subtest busy: SKIP (0.054s)
[561.242681] [106/133] (481s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[561.346482] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[561.352383] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[561.465552] [107/133] (481s left) kms_cursor_crc (cursor-offscreen-64x21)
[561.675535] Starting subtest: cursor-offscreen-64x21
[561.721556] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[562.045360] [108/133] (480s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[562.148418] Starting subtest: async-flip-with-page-flip-events-linear
[562.524354] Starting dynamic subtest: pipe-A-eDP-1
[565.323051] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.744s)
[565.632607] Starting dynamic subtest: pipe-B-eDP-1
[568.452070] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[568.775148] Starting dynamic subtest: pipe-C-eDP-1
[571.590026] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[571.902584] Starting dynamic subtest: pipe-D-eDP-1
[574.713499] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[574.716434] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.509s)
[575.870917] [109/133] (467s left) gem_readwrite (beyond-eob)
[575.931489] Subtest beyond-EOB: SKIP (0.000s)
[576.003227] [110/133] (466s left) gem_exec_whisper (basic-queues-all)
[576.073406] Starting subtest: basic-queues-all
[586.343025] Subtest basic-queues-all: SUCCESS (10.265s)
[586.544991] [111/133] (456s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[586.682674] Starting subtest: cursorB-vs-flipB-varying-size
[586.687603] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[586.840407] [112/133] (456s left) prime_self_import (basic-with_one_bo)
[586.883711] Starting subtest: basic-with_one_bo
[586.899425] Subtest basic-with_one_bo: SUCCESS (0.017s)
[587.021276] [113/133] (456s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[587.125475] Starting subtest: 2x-plain-flip-ts-check-interruptible
[587.137415] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[587.225844] [114/133] (455s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[587.282197] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[587.287897] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[587.482551] [115/133] (455s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[587.583631] Starting subtest: x-tiled-32bpp-rotate-270
[587.604596] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[587.752970] [116/133] (455s left) gem_ctx_sseu (engines)
[587.822376] Subtest engines: SKIP (0.000s)
[587.913205] [117/133] (455s left) kms_cursor_edge_walk (64x64-top-bottom)
[588.003871] Starting subtest: 64x64-top-bottom
[588.006493] Starting dynamic subtest: pipe-A-eDP-1
[591.432071] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[591.442473] Starting dynamic subtest: pipe-D-eDP-1
[594.554341] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[594.556845] Subtest 64x64-top-bottom: SUCCESS (6.551s)
[595.377848] [118/133] (447s left) kms_psr (pr-primary-page-flip)
[595.480499] Starting subtest: pr-primary-page-flip
[595.485312] Subtest pr-primary-page-flip: SKIP (0.000s)
[595.565947] [119/133] (447s left) i915_query (query-topology-matches-eu-total)
[595.622112] Starting subtest: query-topology-matches-eu-total
[595.624918] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[595.753936] [120/133] (447s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[595.824956] Subtest tiled-to-untiled: SKIP (0.000s)
[595.912421] [121/133] (447s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[595.984876] Starting subtest: etime-multi-wait-all-submitted-signaled
[596.092297] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[596.183351] [122/133] (447s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[596.281581] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[596.286632] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[596.410114] [123/133] (447s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[596.515489] Starting subtest: fbc-rgb565-draw-mmap-gtt
[596.520458] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[596.644099] [124/133] (446s left) prime_busy (hang)
[596.703051] Starting subtest: hang
[596.705492] Starting dynamic subtest: rcs0
[623.078612] Dynamic subtest rcs0: SUCCESS (26.359s)
[623.088644] Starting dynamic subtest: bcs0
[630.168124] Dynamic subtest bcs0: SUCCESS (7.078s)
[630.178424] Starting dynamic subtest: vcs0
[637.196160] Dynamic subtest vcs0: SUCCESS (7.033s)
[637.211092] Starting dynamic subtest: vcs1
[644.182779] Dynamic subtest vcs1: SUCCESS (6.970s)
[644.195439] Starting dynamic subtest: vecs0
[651.146467] Dynamic subtest vecs0: SUCCESS (6.972s)
[651.156598] Starting dynamic subtest: ccs0
[665.054665] Dynamic subtest ccs0: SUCCESS (13.898s)
[665.057494] Subtest hang: SUCCESS (68.318s)
[665.213345] [125/133] (378s left) kms_setmode (invalid-clone-single-crtc)
[665.283443] Starting subtest: invalid-clone-single-crtc
[665.291859] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[665.402220] [126/133] (378s left) kms_properties (colorop-properties-atomic)
[665.505515] Starting subtest: colorop-properties-atomic
[665.508338] Starting dynamic subtest: pipe-A-eDP-1
[665.839598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.335s)
[665.851069] Starting dynamic subtest: pipe-B-eDP-1
[666.946994] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.105s)
[666.957323] Starting dynamic subtest: pipe-C-eDP-1
[667.983154] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.035s)
[667.994648] Starting dynamic subtest: pipe-D-eDP-1
[669.008960] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[669.011657] Subtest colorop-properties-atomic: SUCCESS (3.503s)
[669.821814] [127/133] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[669.931200] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[669.936390] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[670.052452] [128/133] (373s left) kms_plane_scaling (invalid-num-scalers)
[670.154596] Starting subtest: invalid-num-scalers
[670.156867] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[670.174069] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[670.183595] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[670.203554] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[670.213051] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[670.240034] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[670.250215] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[670.269061] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[670.271497] Subtest invalid-num-scalers: SUCCESS (0.115s)
[670.399906] [129/133] (373s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[670.500532] Starting subtest: yf-tiled-16bpp-rotate-0
[670.505379] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[670.621081] [130/133] (373s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[670.718281] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[670.723421] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[670.843826] [131/133] (373s left) kms_psr (fbc-psr-primary-page-flip)
[670.938367] Starting subtest: fbc-psr-primary-page-flip
[670.940640] Starting dynamic subtest: eDP-1
[670.945155] Dynamic subtest eDP-1: SKIP (0.000s)
[670.949224] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[671.022496] [132/133] (372s left) gem_render_copy_redux (normal)
[671.073260] Starting subtest: normal
[671.378775] Subtest normal: SUCCESS (0.305s)
[671.531944] [133/133] (372s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[671.630077] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[671.634392] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[671.737354] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_dither
results: parsing output: 3/ for test: kms_vblank
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_media_vme
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 13/ for test: gem_exec_balancer
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_mmap_gtt
results: parsing output: 17/ for test: gem_caching
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: sysfs_heartbeat_interval
results: parsing output: 21/ for test: kms_atomic
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: i915_query
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_ctx_param
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: drm_buddy
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_pm_backlight
results: parsing output: 36/ for test: kms_rmfb
results: parsing output: 37/ for test: kms_pipe_crc_basic
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_fbcon_fbt
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: gem_mmap_offset
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_setmode
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_close
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: api_intel_allocator
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_content_protection
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_eio
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: syncobj_wait
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_busy
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gen7_exec_parse
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_mmap_wc
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_big_fb
results: parsing output: 84/ for test: kms_prime
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: prime_mmap
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: gem_create
results: parsing output: 97/ for test: kms_plane_cursor
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: gem_tiled_blits
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: gem_readwrite
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_sseu
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: gem_set_tiling_vs_blt
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_busy
results: parsing output: 124/ for test: kms_setmode
results: parsing output: 125/ for test: kms_properties
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: gem_render_copy_redux
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.