[58.685881] Initializing watchdogs
[58.685961]   /dev/watchdog0
[58.700552] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.704754] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.707185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.710518] [001/156] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[58.791928] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[58.794402] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[58.925788] [002/156] (960s left) gem_mmap_gtt (cpuset-big-copy)
[58.981967] Subtest cpuset-big-copy: SKIP (0.000s)
[59.038329] [003/156] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[59.132059] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[59.134431] Starting dynamic subtest: pipe-A-eDP-1
[59.157708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.171298] Starting dynamic subtest: pipe-B-eDP-1
[59.193027] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.200853] Starting dynamic subtest: pipe-C-eDP-1
[59.222384] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.230062] Starting dynamic subtest: pipe-D-eDP-1
[59.252519] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.256688] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[61.644955] [004/156] (957s left) kms_prop_blob (blob-prop-lifetime)
[61.707852] Starting subtest: blob-prop-lifetime
[61.710167] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[61.810202] [005/156] (957s left) gem_exec_fence (basic-wait-all)
[61.875727] Starting subtest: basic-wait-all
[61.978220] Subtest basic-wait-all: SUCCESS (0.102s)
[64.416232] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[64.418921] [006/156] (954s left) gem_ctx_persistence (engines-hostile-preempt)
[64.482234] Starting subtest: engines-hostile-preempt
[64.485020] Starting dynamic subtest: rcs0
[64.572723] Dynamic subtest rcs0: SUCCESS (0.090s)
[64.581984] Starting dynamic subtest: bcs0
[64.633944] Dynamic subtest bcs0: SUCCESS (0.060s)
[64.643666] Starting dynamic subtest: vcs0
[66.296070] Dynamic subtest vcs0: SUCCESS (1.653s)
[66.306739] Starting dynamic subtest: vcs1
[68.277529] Dynamic subtest vcs1: SUCCESS (1.974s)
[68.286503] Starting dynamic subtest: vecs0
[70.253496] Dynamic subtest vecs0: SUCCESS (1.970s)
[70.263771] Starting dynamic subtest: ccs0
[70.305761] Dynamic subtest ccs0: SUCCESS (0.053s)
[70.308251] Subtest engines-hostile-preempt: SUCCESS (5.805s)
[70.397151] [007/156] (949s left) gem_ctx_bad_destroy (invalid-pad)
[70.451035] Starting subtest: invalid-pad
[70.453286] Subtest invalid-pad: SUCCESS (0.000s)
[70.528733] [008/156] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[70.629817] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[70.632080] Starting dynamic subtest: pipe-A
[70.970501] Dynamic subtest pipe-A: SUCCESS (0.342s)
[70.979766] Starting dynamic subtest: pipe-B
[72.345952] Dynamic subtest pipe-B: SUCCESS (1.373s)
[72.353648] Starting dynamic subtest: pipe-C
[73.778343] Dynamic subtest pipe-C: SUCCESS (1.430s)
[73.788261] Starting dynamic subtest: pipe-D
[75.209092] Dynamic subtest pipe-D: SUCCESS (1.429s)
[75.211407] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.575s)
[76.369462] [009/156] (943s left) gem_userptr_blits (dmabuf-sync)
[76.427591] Starting subtest: dmabuf-sync
[76.432405] Subtest dmabuf-sync: SKIP (0.004s)
[76.579886] [010/156] (942s left) vgem_slow (nohang)
[76.623817] Starting subtest: nohang
[87.001159] Subtest nohang: SUCCESS (10.372s)
[87.081813] [011/156] (932s left) kms_pm_dc (dc3co-vpb-simulation)
[88.193788] Starting subtest: dc3co-vpb-simulation
[88.196193] Starting dynamic subtest: psr2
[88.200723] Dynamic subtest psr2: SKIP (0.000s)
[88.209390] Starting dynamic subtest: pr
[88.213485] Dynamic subtest pr: SKIP (0.000s)
[88.217695] Subtest dc3co-vpb-simulation: SKIP (0.001s)
[88.265239] [012/156] (931s left) gem_exec_fence (syncobj-channel)
[88.686643] Starting subtest: syncobj-channel
[89.710237] Subtest syncobj-channel: SUCCESS (1.020s)
[90.374027] [013/156] (929s left) perf (gen12-oa-tlb-invalidate)
[90.501669] Starting subtest: gen12-oa-tlb-invalidate
[90.503661] Starting dynamic subtest: 0-rcs0
[100.559346] Dynamic subtest 0-rcs0: SUCCESS (10.055s)
[100.568230] Starting dynamic subtest: 1-vcs1
[110.610092] Dynamic subtest 1-vcs1: SUCCESS (10.049s)
[110.612807] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.105s)
[110.662903] [014/156] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[110.769855] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[110.774503] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[110.857750] [015/156] (908s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[110.921221] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[110.923639] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[111.024578] [016/156] (908s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[111.396426] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[112.190641] [017/156] (907s left) kms_flip (basic-flip-vs-dpms)
[112.291818] Starting subtest: basic-flip-vs-dpms
[112.294293] Starting dynamic subtest: A-eDP1
[114.935220] Dynamic subtest A-eDP1: SUCCESS (2.644s)
[114.944197] Starting dynamic subtest: B-eDP1
[117.185990] Dynamic subtest B-eDP1: SUCCESS (2.250s)
[117.195583] Starting dynamic subtest: C-eDP1
[119.431970] Dynamic subtest C-eDP1: SUCCESS (2.244s)
[119.441748] Starting dynamic subtest: D-eDP1
[121.609692] Dynamic subtest D-eDP1: SUCCESS (2.178s)
[121.615454] Subtest basic-flip-vs-dpms: SUCCESS (9.324s)
[122.491750] [018/156] (897s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[122.592723] Starting subtest: hdr-rgb101010-draw-mmap-wc
[122.597255] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[122.702221] [019/156] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[122.802760] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[122.807254] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.912989] [020/156] (897s left) gem_mmap_offset (clear)
[122.959281] Starting subtest: clear
[122.962956] Starting dynamic subtest: smem0
[147.990779] Dynamic subtest smem0: SUCCESS (25.025s)
[147.993061] Subtest clear: SUCCESS (25.026s)
[148.116765] [021/156] (871s left) gem_exec_suspend (basic)
[148.206793] Starting subtest: basic
[148.209094] Starting dynamic subtest: smem
[150.268078] Dynamic subtest smem: SUCCESS (2.058s)
[150.271055] Subtest basic: SUCCESS (2.060s)
[150.452314] [022/156] (869s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[150.556519] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[150.560642] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[150.660023] [023/156] (869s left) kms_dsc (dsc-fractional-bpp)
[150.744719] Starting subtest: dsc-fractional-bpp
[150.757900] Subtest dsc-fractional-bpp: SKIP (0.000s)
[150.818409] [024/156] (869s left) i915_suspend (basic-s3-without-i915)
[150.852920] Starting subtest: basic-s3-without-i915
[154.293185] Subtest basic-s3-without-i915: SKIP (3.434s)
[155.908084] [025/156] (864s left) perf_pmu (all-busy-idle-check-all)
[155.957104] Starting subtest: all-busy-idle-check-all
[157.311530] Subtest all-busy-idle-check-all: SUCCESS (1.352s)
[157.424267] [026/156] (862s left) kms_psr (psr-cursor-blt)
[157.524133] Starting subtest: psr-cursor-blt
[157.526279] Starting dynamic subtest: eDP-1
[159.288262] Dynamic subtest eDP-1: SUCCESS (1.765s)
[159.290481] Subtest psr-cursor-blt: SUCCESS (1.766s)
[160.146841] [027/156] (860s left) kms_dp_linktrain_fallback (dsc-fallback)
[160.245551] Starting subtest: dsc-fallback
[160.251938] Subtest dsc-fallback: SKIP (0.000s)
[160.314605] [028/156] (859s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[160.416066] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[160.420616] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[160.538833] [029/156] (859s left) kms_cursor_crc (cursor-onscreen-64x21)
[160.713815] Starting subtest: cursor-onscreen-64x21
[160.764055] Subtest cursor-onscreen-64x21: SKIP (0.044s)
[161.004378] [030/156] (859s left) gem_spin_batch (user-each)
[161.064840] Starting subtest: user-each
[164.337676] Subtest user-each: SUCCESS (3.265s)
[165.406499] [031/156] (855s left) kms_invalid_mode (bad-htotal)
[165.510749] Starting subtest: bad-htotal
[165.513175] Starting dynamic subtest: pipe-A-eDP-1
[165.801185] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[165.813228] Starting dynamic subtest: pipe-B-eDP-1
[165.815167] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[165.824096] Starting dynamic subtest: pipe-C-eDP-1
[165.826321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[165.835333] Starting dynamic subtest: pipe-D-eDP-1
[165.837664] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[165.840044] Subtest bad-htotal: SUCCESS (0.295s)
[166.679288] [032/156] (853s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[166.780164] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[166.784157] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[166.885871] [033/156] (853s left) gem_vm_create (isolation)
[166.953578] Starting subtest: isolation
[166.961645] Subtest isolation: SUCCESS (0.010s)
[167.095189] [034/156] (853s left) kms_plane_multiple (tiling-none)
[167.188996] Starting subtest: tiling-none
[167.190883] Starting dynamic subtest: pipe-A-eDP-1
[171.024600] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.835s)
[171.034933] Starting dynamic subtest: pipe-B-eDP-1
[175.483174] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.458s)
[175.493237] Starting dynamic subtest: pipe-C-eDP-1
[179.920825] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.438s)
[179.930878] Starting dynamic subtest: pipe-D-eDP-1
[184.256263] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.334s)
[184.258750] Subtest tiling-none: SUCCESS (17.069s)
[185.066453] [035/156] (835s left) kms_frontbuffer_tracking (fbchdr-1p-shrfb-fliptrack-mmap-gtt)
[185.165582] Starting subtest: fbchdr-1p-shrfb-fliptrack-mmap-gtt
[185.169828] Subtest fbchdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[185.249235] [036/156] (835s left) kms_vblank (ts-continuation-suspend)
[185.346271] Starting subtest: ts-continuation-suspend
[185.348455] Starting dynamic subtest: pipe-A-eDP-1
[201.356629] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.391s)
[201.373878] Starting dynamic subtest: pipe-D-eDP-1
[218.331089] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.199s)
[218.333606] Subtest ts-continuation-suspend: SUCCESS (4.593s)
[219.160716] [037/156] (801s left) gem_pxp (create-regular-context-2)
[219.291205] Starting subtest: create-regular-context-2
[219.293924] Subtest create-regular-context-2: SUCCESS (0.002s)
[219.397828] [038/156] (801s left) prime_vgem (fence-flip-hang)
[219.481407] Subtest fence-flip-hang: SKIP (0.000s)
[219.593538] [039/156] (801s left) syncobj_wait (invalid-reset-one-illegal-handle)
[219.639605] Starting subtest: invalid-reset-one-illegal-handle
[219.641920] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[219.732891] [040/156] (801s left) kms_rotation_crc (primary-rotation-270)
[219.819123] Starting subtest: primary-rotation-270
[219.823448] Subtest primary-rotation-270: SKIP (0.000s)
[219.895326] [041/156] (800s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[219.995794] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[223.754631] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.713s)
[224.952985] [042/156] (795s left) gem_exec_balancer (parallel-keep-submit-fence)
[225.217044] Starting subtest: parallel-keep-submit-fence
[226.395362] Subtest parallel-keep-submit-fence: SUCCESS (1.169s)
[226.498490] [043/156] (794s left) gem_mmap_gtt (big-bo-tiledx)
[226.553485] Subtest big-bo-tiledX: SKIP (0.000s)
[226.621149] [044/156] (794s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[226.704437] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[226.706611] Starting dynamic subtest: pipe-A
[226.767611] Dynamic subtest pipe-A: SUCCESS (0.065s)
[226.778206] Starting dynamic subtest: pipe-B
[227.885479] Dynamic subtest pipe-B: SUCCESS (1.109s)
[227.897041] Starting dynamic subtest: pipe-C
[229.004172] Dynamic subtest pipe-C: SUCCESS (1.110s)
[229.014157] Starting dynamic subtest: pipe-D
[230.135588] Dynamic subtest pipe-D: SUCCESS (1.125s)
[230.137888] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.413s)
[231.309114] [045/156] (789s left) kms_psr (pr-cursor-blt)
[231.411400] Starting subtest: pr-cursor-blt
[231.415560] Subtest pr-cursor-blt: SKIP (0.000s)
[231.482878] [046/156] (789s left) prime_mmap_coherency (ioctl-errors)
[231.547073] Starting subtest: ioctl-errors
[245.423683] Subtest ioctl-errors: SUCCESS (13.847s)
[245.636439] [047/156] (775s left) kms_addfb_basic (too-high)
[245.791072] Starting subtest: too-high
[245.793224] Subtest too-high: SUCCESS (0.000s)
[245.891759] [048/156] (775s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[245.989145] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[245.993475] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[246.089992] [049/156] (775s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[246.154796] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[246.157113] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[246.266957] [050/156] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[246.365531] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[246.370030] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[246.462183] [051/156] (774s left) kms_psr (fbc-psr2-cursor-render)
[246.564213] Starting subtest: fbc-psr2-cursor-render
[246.566165] Starting dynamic subtest: eDP-1
[246.570386] Dynamic subtest eDP-1: SKIP (0.000s)
[246.574588] Subtest fbc-psr2-cursor-render: SKIP (0.001s)
[246.639194] [052/156] (774s left) kms_atomic_transition (plane-all-transition-nonblocking)
[246.733945] Starting subtest: plane-all-transition-nonblocking
[246.735920] Starting dynamic subtest: pipe-A-eDP-1
[249.230469] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[249.538975] Starting dynamic subtest: pipe-B-eDP-1
[252.776867] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.250s)
[253.078018] Subtest plane-all-transition-nonblocking: SUCCESS (6.343s)
[253.915894] [053/156] (767s left) gem_exec_whisper (basic-normal-all)
[253.981881] Starting subtest: basic-normal-all
[256.252154] Subtest basic-normal-all: SUCCESS (2.268s)
[256.435381] [054/156] (764s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[256.522086] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[256.524479] Starting dynamic subtest: pipe-A-eDP-1
[257.335122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[257.346284] Starting dynamic subtest: pipe-B-eDP-1
[258.908395] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.572s)
[258.919610] Starting dynamic subtest: pipe-C-eDP-1
[260.424596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.515s)
[260.436183] Starting dynamic subtest: pipe-D-eDP-1
[261.949200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[261.951507] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.419s)
[263.109561] [055/156] (758s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[263.208323] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[270.086681] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.881s)
[270.225081] [056/156] (751s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[270.337278] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[270.341425] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[270.443652] [057/156] (751s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[270.538653] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[270.543110] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[270.638451] [058/156] (750s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[270.737897] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[270.742132] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[270.839980] [059/156] (750s left) sw_sync (sync_busy)
[270.875452] Starting subtest: sync_busy
[270.877839] Subtest sync_busy: SUCCESS (0.002s)
[270.938277] [060/156] (750s left) gem_softpin (evict-active)
[271.010303] Starting subtest: evict-active
[271.012797] Subtest evict-active: SUCCESS (0.008s)
[271.136436] [061/156] (750s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[271.229277] Starting subtest: psr-rgb565-draw-mmap-wc
[278.101351] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.875s)
[278.219475] [062/156] (743s left) i915_hangman (detector)
[278.294246] Starting subtest: detector
[278.296544] Starting dynamic subtest: rcs0
[289.624210] Dynamic subtest rcs0: SUCCESS (11.325s)
[289.639565] Starting dynamic subtest: bcs0
[301.593161] Dynamic subtest bcs0: SUCCESS (11.962s)
[301.606042] Starting dynamic subtest: vcs0
[313.560124] Dynamic subtest vcs0: SUCCESS (11.960s)
[313.574217] Starting dynamic subtest: vcs1
[324.568801] Dynamic subtest vcs1: SUCCESS (11.009s)
[324.585036] Starting dynamic subtest: vecs0
[336.536678] Dynamic subtest vecs0: SUCCESS (11.966s)
[336.550224] Starting dynamic subtest: ccs0
[347.607860] Dynamic subtest ccs0: SUCCESS (11.068s)
[347.610988] Subtest detector: SUCCESS (69.308s)
[347.727970] [063/156] (674s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[347.823268] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[347.825591] Starting dynamic subtest: pipe-A-eDP-1
[347.885522] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[347.896081] Starting dynamic subtest: pipe-B-eDP-1
[347.954119] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[347.965858] Starting dynamic subtest: pipe-C-eDP-1
[348.023209] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[348.034671] Starting dynamic subtest: pipe-D-eDP-1
[348.091821] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[348.096378] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[350.150637] [064/156] (671s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[350.204375] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[350.309286] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[350.400737] [065/156] (671s left) gem_set_tiling_vs_gtt
[350.521620] [066/156] (671s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[350.570957] Starting subtest: protected-encrypted-src-copy-not-readible
[350.683541] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.110s)
[350.797033] [067/156] (671s left) kms_flip_event_leak (basic)
[350.894718] Starting subtest: basic
[350.896980] Starting dynamic subtest: pipe-A-eDP-1
[351.320573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[351.331613] Starting dynamic subtest: pipe-B-eDP-1
[352.463981] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s)
[352.475960] Starting dynamic subtest: pipe-C-eDP-1
[353.586018] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[353.597989] Starting dynamic subtest: pipe-D-eDP-1
[354.698614] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.109s)
[354.700528] Subtest basic: SUCCESS (3.804s)
[355.566130] [068/156] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[355.675160] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[362.387141] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.717s)
[362.522706] [069/156] (659s left) gem_tiled_blits (basic)
[362.581509] Subtest basic: SKIP (0.000s)
[362.643436] [070/156] (659s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[362.700925] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[362.702936] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[362.822920] [071/156] (659s left) kms_fbcon_fbt (fbc)
[362.871922] Starting subtest: fbc
[369.319753] Subtest fbc: SUCCESS (6.445s)
[370.494311] [072/156] (651s left) gem_ctx_shared (create-shared-gtt)
[370.566763] Starting subtest: create-shared-gtt
[372.719965] Subtest create-shared-gtt: SUCCESS (2.151s)
[373.352828] [073/156] (648s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-move)
[373.450633] Starting subtest: psrhdr-1p-primscrn-cur-indfb-move
[373.454579] Subtest psrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[373.552088] [074/156] (648s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[373.644791] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-pwrite
[373.648783] Subtest psrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[373.750507] [075/156] (648s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[373.863836] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[375.032100] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.168s)
[375.143307] [076/156] (647s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[375.246037] Starting subtest: 4-tiled-16bpp-rotate-180
[376.614797] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.368s)
[376.747759] [077/156] (645s left) gem_exec_reloc (basic-gtt-noreloc)
[376.808388] Subtest basic-gtt-noreloc: SKIP (0.000s)
[376.894250] [078/156] (645s left) kms_flip (plain-flip-fb-recreate)
[376.990652] Starting subtest: plain-flip-fb-recreate
[376.992366] Starting dynamic subtest: A-eDP1
[385.897082] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[385.908716] Starting dynamic subtest: B-eDP1
[394.748103] Dynamic subtest B-eDP1: SUCCESS (8.848s)
[394.761273] Starting dynamic subtest: C-eDP1
[403.576397] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[403.592567] Starting dynamic subtest: D-eDP1
[412.411634] Dynamic subtest D-eDP1: SUCCESS (8.830s)
[412.415888] Subtest plain-flip-fb-recreate: SUCCESS (35.418s)
[413.626467] [079/156] (608s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[413.723088] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[413.727650] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.804077] [080/156] (608s left) gen3_render_linear_blits
[413.915729] [081/156] (608s left) kms_hdr (invalid-hdr)
[414.004235] Starting subtest: invalid-hdr
[414.006703] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[419.104411] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.097s)
[419.125727] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[423.195480] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.072s)
[423.204411] Subtest invalid-hdr: SUCCESS (9.201s)
[423.324164] [082/156] (599s left) sysfs_heartbeat_interval (invalid)
[423.391518] Starting subtest: invalid
[423.393995] Starting dynamic subtest: vecs0
[423.396430] Dynamic subtest vecs0: SUCCESS (0.000s)
[423.409700] Starting dynamic subtest: ccs0
[423.411891] Dynamic subtest ccs0: SUCCESS (0.000s)
[423.422474] Starting dynamic subtest: vcs0
[423.424608] Dynamic subtest vcs0: SUCCESS (0.000s)
[423.434972] Starting dynamic subtest: bcs0
[423.437129] Dynamic subtest bcs0: SUCCESS (0.000s)
[423.447388] Starting dynamic subtest: rcs0
[423.449149] Dynamic subtest rcs0: SUCCESS (0.000s)
[423.459942] Starting dynamic subtest: vcs1
[423.462125] Dynamic subtest vcs1: SUCCESS (0.000s)
[423.464276] Subtest invalid: SUCCESS (0.006s)
[423.515590] [083/156] (599s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[423.616411] Starting subtest: y-tiled-16bpp-rotate-90
[423.620898] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[423.718001] [084/156] (598s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[423.784049] Starting subtest: yf-tiled-to-vebox-y-tiled
[423.788586] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[423.981909] [085/156] (598s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[424.037434] Starting subtest: wait-all-for-submit-delayed-submit
[424.140677] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[424.230521] [086/156] (598s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[424.328690] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[424.333153] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[424.424195] [087/156] (598s left) kms_cursor_edge_walk (64x64-top-edge)
[424.510111] Starting subtest: 64x64-top-edge
[424.512243] Starting dynamic subtest: pipe-A-eDP-1
[427.995203] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[428.007077] Starting dynamic subtest: pipe-D-eDP-1
[431.215247] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.220s)
[431.217683] Subtest 64x64-top-edge: SUCCESS (6.703s)
[432.052723] [088/156] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[432.159702] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[439.490393] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.335s)
[439.637608] [089/156] (583s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[439.733465] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[439.737661] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[439.858805] [090/156] (583s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[439.962944] Starting subtest: fbcpsrhdr-tiling-linear
[439.966830] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[440.064611] [091/156] (582s left) gem_exec_params (invalid-flag)
[440.127298] Starting subtest: invalid-flag
[440.129612] Subtest invalid-flag: SUCCESS (0.000s)
[440.274976] [092/156] (582s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[440.372357] Starting subtest: x-tiled-64bpp-rotate-180
[441.973392] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[442.152032] [093/156] (580s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[442.247479] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[442.259757] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[442.336114] [094/156] (580s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[442.426299] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[442.429929] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[442.525412] [095/156] (580s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[442.623473] Starting subtest: yf-tiled-64bpp-rotate-90
[442.627242] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[442.724607] [096/156] (580s left) gem_exec_balancer (bonded-chain)
[442.780548] Starting subtest: bonded-chain
[449.777015] Subtest bonded-chain: SUCCESS (6.998s)
[450.115267] [097/156] (573s left) prime_vgem (basic-blt)
[450.193036] Starting subtest: basic-blt
[450.233700] Subtest basic-blt: SUCCESS (0.041s)
[450.403577] [098/156] (572s left) gem_fence_thrash (bo-write-verify-y)
[450.438093] Starting subtest: bo-write-verify-y
[450.459684] Subtest bo-write-verify-y: SKIP (0.019s)
[450.521545] [099/156] (572s left) core_debugfs (read-all-entries)
[450.575001] Starting subtest: read-all-entries
[450.672391] Subtest read-all-entries: SUCCESS (0.097s)
[450.741740] [100/156] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[450.847962] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[450.852241] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[450.929109] [101/156] (572s left) kms_content_protection (legacy-hdcp14)
[451.068813] Starting subtest: legacy-hdcp14
[451.072182] Subtest legacy-hdcp14: SKIP (0.000s)
[451.186211] [102/156] (572s left) kms_chamelium_audio (dp-audio)
[451.567919] Subtest dp-audio: SKIP (0.000s)
[452.354973] [103/156] (571s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt)
[452.463960] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt
[452.468276] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[452.587866] [104/156] (570s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[452.683187] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[452.685401] Starting dynamic subtest: pipe-A-eDP-1
[452.707082] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[452.723096] Starting dynamic subtest: pipe-B-eDP-1
[452.744436] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[452.755949] Starting dynamic subtest: pipe-C-eDP-1
[452.777931] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[452.791649] Starting dynamic subtest: pipe-D-eDP-1
[452.815171] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.819356] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[454.951544] [105/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-render)
[455.054045] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-render
[455.058196] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[455.143598] [106/156] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[455.242575] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[455.246808] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[455.335725] [107/156] (568s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[455.431709] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[456.077926] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[456.231894] [108/156] (567s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[456.321363] Starting subtest: fbc-pr-cursor-mmap-gtt
[456.325771] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[456.396039] [109/156] (567s left) i915_pm_rpm (gem-pread)
[457.936098] Starting subtest: gem-pread
[460.364549] Subtest gem-pread: SUCCESS (2.432s)
[460.464182] [110/156] (563s left) kms_chamelium_hpd (common-hpd-after-suspend)
[460.838068] Subtest common-hpd-after-suspend: SKIP (0.000s)
[461.629829] [111/156] (562s left) perf_pmu (init-wait)
[461.672686] Starting subtest: init-wait
[461.675044] Starting dynamic subtest: rcs0
[461.677384] Dynamic subtest rcs0: SUCCESS (0.002s)
[461.689025] Starting dynamic subtest: bcs0
[461.691401] Dynamic subtest bcs0: SUCCESS (0.001s)
[461.701978] Starting dynamic subtest: vcs0
[461.704269] Dynamic subtest vcs0: SUCCESS (0.002s)
[461.715223] Starting dynamic subtest: vcs1
[461.717524] Dynamic subtest vcs1: SUCCESS (0.001s)
[461.728353] Starting dynamic subtest: vecs0
[461.730653] Dynamic subtest vecs0: SUCCESS (0.001s)
[461.744295] Starting dynamic subtest: ccs0
[461.746702] Dynamic subtest ccs0: SUCCESS (0.000s)
[461.748962] Subtest init-wait: SUCCESS (0.010s)
[461.816026] [112/156] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[461.911183] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[469.406861] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.502s)
[469.534542] [113/156] (554s left) kms_plane_alpha_blend (coverage-7efc)
[469.626703] Starting subtest: coverage-7efc
[469.914293] Starting dynamic subtest: pipe-A-eDP-1
[470.508556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.588s)
[470.534385] Starting dynamic subtest: pipe-D-eDP-1
[471.813724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[471.816126] Subtest coverage-7efc: SUCCESS (2.189s)
[472.644576] [114/156] (551s left) gen9_exec_parse (bb-start-out)
[472.702596] Subtest bb-start-out: SKIP (0.000s)
[472.772208] [115/156] (551s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[472.877653] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc
[472.882010] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[472.976727] [116/156] (551s left) gem_ccs (suspend-resume)
[473.033706] Starting subtest: suspend-resume
[473.038395] Subtest suspend-resume: SKIP (0.000s)
[473.143077] [117/156] (550s left) gem_exec_balancer (invalid-balancer)
[473.191803] Starting subtest: invalid-balancer
[474.089065] Subtest invalid-balancer: SUCCESS (0.895s)
[474.403204] [118/156] (549s left) gem_lmem_swapping (parallel-random-engines)
[474.445564] Subtest parallel-random-engines: SKIP (0.000s)
[474.487189] [119/156] (549s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[474.598988] Starting subtest: fbchdr-rgb101010-draw-render
[474.603183] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[474.713724] [120/156] (549s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[474.816662] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[475.772629] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s)
[475.885583] [121/156] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[475.979560] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[475.984053] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[476.089691] [122/156] (548s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[476.181364] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[476.184930] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[476.253907] [123/156] (548s left) syncobj_timeline (wait-all-for-submit-complex)
[476.300414] Starting subtest: wait-all-for-submit-complex
[476.516826] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[476.599890] [124/156] (547s left) gem_ccs (ctrl-surf-copy-new-ctx)
[476.651679] Starting subtest: ctrl-surf-copy-new-ctx
[476.656131] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[476.756649] [125/156] (547s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[476.846615] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[476.850540] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[476.947026] [126/156] (547s left) kms_async_flips (async-flip-dpms)
[477.034700] Starting subtest: async-flip-dpms
[477.402042] Starting dynamic subtest: pipe-A-eDP-1
[481.359796] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.956s)
[481.743161] Starting dynamic subtest: pipe-B-eDP-1
[484.539294] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.804s)
[484.920209] Starting dynamic subtest: pipe-C-eDP-1
[487.710013] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.801s)
[488.095188] Starting dynamic subtest: pipe-D-eDP-1
[490.889460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.805s)
[490.891911] Subtest async-flip-dpms: SUCCESS (13.857s)
[492.089860] [127/156] (532s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[492.198362] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[492.202730] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[492.296743] [128/156] (532s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[492.343632] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[492.445180] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[492.531103] [129/156] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[492.628117] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[492.632120] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[492.722867] [130/156] (531s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[492.826137] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[492.830504] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[492.912024] [131/156] (531s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[493.119921] Starting subtest: cursor-rapid-movement-128x128
[493.124947] Starting dynamic subtest: pipe-A-eDP-1
[493.679963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[493.709153] Starting dynamic subtest: pipe-D-eDP-1
[494.890717] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.191s)
[494.893049] Subtest cursor-rapid-movement-128x128: SUCCESS (1.771s)
[495.764104] [132/156] (528s left) dmabuf_sync_file (import-basic)
[495.799967] Starting subtest: import-basic
[495.802348] Subtest import-basic: SUCCESS (0.004s)
[495.868466] [133/156] (528s left) kms_psr (fbc-psr-sprite-plane-move)
[495.969273] Starting subtest: fbc-psr-sprite-plane-move
[495.971448] Starting dynamic subtest: eDP-1
[495.975454] Dynamic subtest eDP-1: SKIP (0.000s)
[495.979798] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[496.056969] [134/156] (528s left) kms_addfb_basic (unused-pitches)
[496.106556] Starting subtest: unused-pitches
[496.109128] Subtest unused-pitches: SUCCESS (0.000s)
[496.241128] [135/156] (528s left) kms_flip (absolute-wf_vblank)
[496.332640] Starting subtest: absolute-wf_vblank
[496.334945] Starting dynamic subtest: A-eDP1
[505.088671] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[505.101244] Starting dynamic subtest: B-eDP1
[513.822581] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[513.833986] Starting dynamic subtest: C-eDP1
[522.549625] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[522.562130] Starting dynamic subtest: D-eDP1
[531.273931] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[531.279876] Subtest absolute-wf_vblank: SUCCESS (34.946s)
[532.491049] [136/156] (492s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[532.553608] Starting subtest: invalid-bsd2-flag-on-vebox
[532.555447] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[532.658631] [137/156] (492s left) gem_exec_gttfill (multigpu-basic)
[532.841494] Starting subtest: multigpu-basic
[544.831545] Subtest multigpu-basic: SUCCESS (11.992s)
[544.892485] [138/156] (480s left) gem_exec_schedule (semaphore-user)
[545.012845] Starting subtest: semaphore-user
[545.071341] Subtest semaphore-user: SUCCESS (0.061s)
[546.658866] [139/156] (478s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[546.779716] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[546.782000] Starting dynamic subtest: pipe-A-eDP-1
[546.911952] Dynamic subtest pipe-A-eDP-1: SKIP (0.136s)
[546.925454] Starting dynamic subtest: pipe-B-eDP-1
[548.068258] Dynamic subtest pipe-B-eDP-1: SKIP (1.152s)
[548.073021] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.292s)
[549.264225] [140/156] (475s left) kms_addfb_basic (bo-too-small)
[549.362879] Starting subtest: bo-too-small
[549.364821] Subtest bo-too-small: SUCCESS (0.000s)
[549.464740] [141/156] (475s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[549.560085] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[549.564153] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[549.671037] [142/156] (475s left) kms_psr (psr-sprite-blt)
[549.768761] Starting subtest: psr-sprite-blt
[549.771005] Starting dynamic subtest: eDP-1
[551.560005] Dynamic subtest eDP-1: SUCCESS (1.790s)
[551.562139] Subtest psr-sprite-blt: SUCCESS (1.791s)
[552.413921] [143/156] (472s left) syncobj_wait (multi-wait-all-submitted)
[552.461160] Starting subtest: multi-wait-all-submitted
[552.565977] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[552.645207] [144/156] (472s left) gem_partial_pwrite_pread (write-display)
[552.709595] Subtest write-display: SKIP (0.000s)
[552.787131] [145/156] (472s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[552.879813] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[552.884205] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[552.974326] [146/156] (472s left) gem_exec_schedule (noreorder-priority)
[553.151351] Starting subtest: noreorder-priority
[553.153965] Starting dynamic subtest: rcs0
[554.284382] Dynamic subtest rcs0: SUCCESS (1.133s)
[554.298716] Starting dynamic subtest: vcs0
[555.636749] Dynamic subtest vcs0: SUCCESS (1.349s)
[555.650647] Starting dynamic subtest: vcs1
[557.633671] Dynamic subtest vcs1: SUCCESS (1.993s)
[557.648141] Starting dynamic subtest: vecs0
[559.603882] Dynamic subtest vecs0: SUCCESS (1.968s)
[559.618113] Starting dynamic subtest: ccs0
[560.747042] Dynamic subtest ccs0: SUCCESS (1.142s)
[560.749473] Subtest noreorder-priority: SUCCESS (7.595s)
[560.936404] [147/156] (464s left) i915_drm_fdinfo (virtual-busy)
[560.973397] Starting subtest: virtual-busy
[560.977991] Subtest virtual-busy: SKIP (0.000s)
[561.059292] [148/156] (464s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[561.155351] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[561.157632] Starting dynamic subtest: pipe-A-default-mode
[562.284162] Dynamic subtest pipe-A-default-mode: SKIP (1.126s)
[562.288280] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.127s)
[562.444239] [149/156] (463s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[562.537436] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[562.541529] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[562.612765] [150/156] (462s left) kms_vblank (invalid)
[562.709591] Starting subtest: invalid
[562.711532] Starting dynamic subtest: pipe-A-eDP-1
[563.110798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.402s)
[563.113351] Subtest invalid: SUCCESS (0.404s)
[563.990481] [151/156] (461s left) gem_exec_reloc (basic-gtt)
[564.035038] Subtest basic-gtt: SKIP (0.000s)
[564.104826] [152/156] (461s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[564.202146] Starting subtest: fbcpsr-stridechange
[570.392740] Subtest fbcpsr-stridechange: SUCCESS (6.194s)
[570.560201] [153/156] (455s left) api_intel_allocator (open-vm)
[570.614508] Starting subtest: open-vm
[570.616793] Subtest open-vm: SUCCESS (0.003s)
[570.748919] [154/156] (454s left) kms_mmap_write_crc (main)
[570.844941] Starting subtest: main
[570.847364] Starting dynamic subtest: pipe-A-eDP-1
[574.232452] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.386s)
[574.234785] Subtest main: SUCCESS (3.387s)
[575.071187] [155/156] (450s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[575.170406] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[575.174387] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[575.268779] [156/156] (450s left) kms_color (ctm-0-50)
[575.377216] Starting subtest: ctm-0-50
[575.379405] Starting dynamic subtest: pipe-A-eDP-1
[578.974719] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.598s)
[578.985988] Starting dynamic subtest: pipe-B-eDP-1
[583.300847] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.325s)
[583.312998] Starting dynamic subtest: pipe-C-eDP-1
[587.333529] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.030s)
[587.344997] Starting dynamic subtest: pipe-D-eDP-1
[591.325097] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.992s)
[591.327630] Subtest ctm-0-50: SUCCESS (15.949s)
[592.160481] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_prop_blob
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: gem_ctx_bad_destroy
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: vgem_slow
results: parsing output: 10/ for test: kms_pm_dc
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_chamelium_edid
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_exec_suspend
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_dsc
results: parsing output: 23/ for test: i915_suspend
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_dp_linktrain_fallback
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_invalid_mode
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_vm_create
results: parsing output: 33/ for test: kms_plane_multiple
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: gem_pxp
results: parsing output: 37/ for test: prime_vgem
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_rotation_crc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: prime_mmap_coherency
results: parsing output: 46/ for test: kms_addfb_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_atomic_transition
results: parsing output: 52/ for test: gem_exec_whisper
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: i915_hangman
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_set_tiling_vs_gtt
results: parsing output: 65/ for test: gem_pxp
results: parsing output: 66/ for test: kms_flip_event_leak
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_tiled_blits
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_fbcon_fbt
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gen3_render_linear_blits
results: parsing output: 80/ for test: kms_hdr
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: core_debugfs
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_chamelium_audio
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: kms_chamelium_hpd
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_alpha_blend
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: gem_lmem_swapping
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: dmabuf_sync_file
results: parsing output: 132/ for test: kms_psr
results: parsing output: 133/ for test: kms_addfb_basic
results: parsing output: 134/ for test: kms_flip
results: parsing output: 135/ for test: gem_exec_params
results: parsing output: 136/ for test: gem_exec_gttfill
results: parsing output: 137/ for test: gem_exec_schedule
results: parsing output: 138/ for test: kms_psr2_sf
results: parsing output: 139/ for test: kms_addfb_basic
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: gem_partial_pwrite_pread
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: gem_exec_schedule
results: parsing output: 146/ for test: i915_drm_fdinfo
results: parsing output: 147/ for test: kms_flip_scaled_crc
results: parsing output: 148/ for test: kms_psr2_sf
results: parsing output: 149/ for test: kms_vblank
results: parsing output: 150/ for test: gem_exec_reloc
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: api_intel_allocator
results: parsing output: 153/ for test: kms_mmap_write_crc
results: parsing output: 154/ for test: kms_flip_scaled_crc
results: parsing output: 155/ for test: kms_color
Done.