[56.529177] Initializing watchdogs
[56.529317]   /dev/watchdog0
[56.545253] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.549986] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.552082] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.554163] [001/134] (960s left) syncobj_timeline (invalid-wait-bad-flags)
[56.616092] Starting subtest: invalid-wait-bad-flags
[56.617409] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[56.734737] [002/134] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[56.837080] Starting subtest: fbcpsr-rgb101010-draw-render
[63.636216] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.724s)
[63.775224] [003/134] (953s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[64.163531] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[64.994718] [004/134] (952s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[65.085065] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[65.086932] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[65.187691] [005/134] (951s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[65.268840] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[65.269783] Starting dynamic subtest: pipe-A-eDP-1
[66.090614] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[66.096839] Starting dynamic subtest: pipe-B-eDP-1
[67.632082] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s)
[67.638715] Starting dynamic subtest: pipe-C-eDP-1
[69.151567] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[69.157765] Starting dynamic subtest: pipe-D-eDP-1
[70.698001] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[70.698861] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.405s)
[71.911710] [006/134] (945s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[72.073678] Starting subtest: yf-tiled-16bpp-rotate-270
[72.075984] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[72.271195] [007/134] (944s left) kms_async_flips (alternate-sync-async-flip-atomic)
[72.363088] Starting subtest: alternate-sync-async-flip-atomic
[72.743789] Starting dynamic subtest: pipe-A-eDP-1
[75.499508] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[75.878200] Starting dynamic subtest: pipe-B-eDP-1
[78.637980] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[79.002513] Starting dynamic subtest: pipe-C-eDP-1
[81.775124] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[82.144403] Starting dynamic subtest: pipe-D-eDP-1
[84.909026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[84.910126] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.533s)
[86.077019] [008/134] (931s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[91.046858] Starting subtest: pr-primary-plane-update-sf-dmg-area
[91.051503] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[91.918453] [009/134] (925s left) gem_exec_reloc (basic-write-cpu)
[91.989033] Subtest basic-write-cpu: SKIP (0.000s)
[92.038777] [010/134] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[92.144523] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[99.413400] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.267s)
[99.573591] [011/134] (917s left) gem_exec_flush (basic-wb-rw-before-default)
[99.637283] Starting subtest: basic-wb-rw-before-default
[105.088422] Subtest basic-wb-rw-before-default: SUCCESS (5.449s)
[105.276323] [012/134] (912s left) kms_colorop (plane-xr30-xr30-pq_125_eotf-pq_125_inv_eotf)
[105.403870] Subtest plane-XR30-XR30-pq_125_eotf-pq_125_inv_eotf: SKIP (0.000s)
[105.476593] [013/134] (911s left) syncobj_timeline (invalid-signal-bad-pad)
[105.524280] Starting subtest: invalid-signal-bad-pad
[105.525206] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[105.633484] [014/134] (911s left) kms_getfb (getfb-addfb-different-handles)
[105.726204] Starting subtest: getfb-addfb-different-handles
[105.727031] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[105.847719] [015/134] (911s left) perf_pmu (module-unload)
[105.958750] Starting subtest: module-unload
[114.215966] Subtest module-unload: FAIL (8.218s)
[114.233139] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[114.234737] [016/134] (903s left) kms_atomic_transition (modeset-transition)
[115.654355] Starting subtest: modeset-transition
[115.655488] Starting dynamic subtest: 1x-outputs
[126.575519] Dynamic subtest 1x-outputs: SUCCESS (10.919s)
[126.576942] Subtest modeset-transition: SUCCESS (10.920s)
[127.459072] [FACT kms_atomic_transition (modeset-transition)] new: kernel.kmod_is_loaded.i915: true
[127.461363] [017/134] (890s left) kms_cursor_crc (cursor-random-max-size)
[127.740742] Starting subtest: cursor-random-max-size
[127.743425] Subtest cursor-random-max-size: SKIP (0.000s)
[127.899243] [018/134] (889s left) gem_pxp (hw-rejects-pxp-context)
[128.024360] Starting subtest: hw-rejects-pxp-context
[128.026689] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[128.146839] [019/134] (889s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[128.230350] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[128.242080] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[128.319785] [020/134] (889s left) gem_exec_params (no-blt)
[128.376792] Starting subtest: no-blt
[128.379457] Subtest no-blt: SUCCESS (0.002s)
[128.511109] [021/134] (889s left) tools_test (tools_test)
[128.544874] Starting subtest: tools_test
[128.600095] Subtest tools_test: SUCCESS (0.063s)
[128.662898] [022/134] (889s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[128.746854] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[128.747715] Starting dynamic subtest: pipe-A-eDP-1
[128.755849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[128.762546] Starting dynamic subtest: pipe-B-eDP-1
[128.770857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[128.776793] Starting dynamic subtest: pipe-C-eDP-1
[128.784972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[128.790838] Starting dynamic subtest: pipe-D-eDP-1
[128.799248] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[128.800880] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[130.888445] [023/134] (886s left) gem_lmem_swapping (heavy-random)
[130.928731] Subtest heavy-random: SKIP (0.000s)
[130.965713] [024/134] (886s left) gem_softpin (evict-prime)
[131.016216] Starting subtest: evict-prime
[131.017072] Starting dynamic subtest: rcs0
[132.211824] Dynamic subtest rcs0: SUCCESS (1.196s)
[132.221727] Starting dynamic subtest: bcs0
[133.368597] Dynamic subtest bcs0: SUCCESS (1.154s)
[133.377986] Starting dynamic subtest: vcs0
[134.968250] Dynamic subtest vcs0: SUCCESS (1.595s)
[134.978618] Starting dynamic subtest: vcs1
[136.923447] Dynamic subtest vcs1: SUCCESS (1.953s)
[136.933307] Starting dynamic subtest: vecs0
[138.919448] Dynamic subtest vecs0: SUCCESS (1.994s)
[138.929875] Starting dynamic subtest: ccs0
[140.066588] Dynamic subtest ccs0: SUCCESS (1.148s)
[140.076944] Starting dynamic subtest: all
[141.938609] Dynamic subtest all: SUCCESS (1.867s)
[141.939875] Subtest evict-prime: SUCCESS (10.921s)
[142.023954] [025/134] (875s left) prime_mmap (test_userptr)
[142.073252] Starting subtest: test_userptr
[142.074159] Starting dynamic subtest: test_userptr-smem
[142.075129] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[142.076065] Subtest test_userptr: SUCCESS (0.001s)
[142.227047] [026/134] (875s left) gem_exec_whisper (basic-fds)
[142.286887] Starting subtest: basic-fds
[149.881226] Subtest basic-fds: SUCCESS (7.591s)
[150.078086] [027/134] (867s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[150.203229] Starting subtest: 2x-flip-vs-cursor-legacy
[150.205970] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[150.365020] [028/134] (867s left) gem_exec_schedule (preempt-hang)
[150.538394] Starting subtest: preempt-hang
[150.539530] Starting dynamic subtest: rcs0
[150.782495] Dynamic subtest rcs0: SUCCESS (0.246s)
[150.791309] Starting dynamic subtest: bcs0
[151.017745] Dynamic subtest bcs0: SUCCESS (0.233s)
[151.026303] Starting dynamic subtest: vcs0
[151.250726] Dynamic subtest vcs0: SUCCESS (0.232s)
[151.260222] Starting dynamic subtest: vcs1
[151.479914] Dynamic subtest vcs1: SUCCESS (0.228s)
[151.488502] Starting dynamic subtest: vecs0
[151.709980] Dynamic subtest vecs0: SUCCESS (0.228s)
[151.716650] Starting dynamic subtest: ccs0
[151.941772] Dynamic subtest ccs0: SUCCESS (0.230s)
[151.942845] Subtest preempt-hang: SUCCESS (1.405s)
[153.041782] [029/134] (864s left) gem_ctx_param (vm)
[153.089940] Starting subtest: vm
[153.155897] Subtest vm: SUCCESS (0.065s)
[153.300763] [030/134] (864s left) kms_psr (fbc-psr-sprite-blt)
[153.393541] Starting subtest: fbc-psr-sprite-blt
[153.394551] Starting dynamic subtest: eDP-1
[153.396424] Dynamic subtest eDP-1: SKIP (0.000s)
[153.398239] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[153.472269] [031/134] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[153.571940] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[160.148983] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.578s)
[160.314032] [032/134] (857s left) gem_exec_capture (capture-invisible)
[160.374463] Starting subtest: capture-invisible
[160.375552] Starting dynamic subtest: smem0
[160.377562] Dynamic subtest smem0: SKIP (0.000s)
[160.379462] Subtest capture-invisible: SKIP (0.001s)
[160.478167] [033/134] (857s left) vgem_slow (nohang)
[160.581078] Starting subtest: nohang
[170.612796] Subtest nohang: SUCCESS (10.029s)
[170.690695] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[170.692360] [034/134] (847s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[170.793447] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[170.795219] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[170.926330] [035/134] (847s left) kms_chamelium_color (ctm-negative)
[171.002984] Subtest ctm-negative: SKIP (0.000s)
[171.043917] [036/134] (847s left) gem_exec_reloc (basic-write-read)
[171.101129] Subtest basic-write-read: SKIP (0.000s)
[171.162294] [037/134] (846s left) gem_eio (context-create)
[171.390468] Starting subtest: context-create
[171.722772] Subtest context-create: SUCCESS (0.333s)
[171.879332] [038/134] (846s left) perf (gen12-invalid-class-instance)
[171.991585] Starting subtest: gen12-invalid-class-instance
[172.000274] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[172.031665] [039/134] (846s left) dmabuf_sync_file (export-multiwait)
[172.070564] Starting subtest: export-multiwait
[172.071597] Subtest export-multiwait: SUCCESS (0.001s)
[172.134400] [040/134] (846s left) kms_psr (fbc-psr-no-drrs)
[172.228779] Starting subtest: fbc-psr-no-drrs
[172.229751] Starting dynamic subtest: eDP-1
[172.231713] Dynamic subtest eDP-1: SKIP (0.000s)
[172.233429] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[172.312539] [041/134] (845s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[172.397276] Starting subtest: multiplane-rotation-cropping-bottom
[179.656551] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.260s)
[179.802388] [042/134] (838s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[179.892317] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[179.894154] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[180.016888] [043/134] (838s left) gem_exec_balancer (bonded-dual)
[180.071333] Starting subtest: bonded-dual
[180.073170] Subtest bonded-dual: SKIP (0.000s)
[180.383246] [044/134] (837s left) kms_hdr (invalid-metadata-sizes)
[180.460410] Starting subtest: invalid-metadata-sizes
[180.463120] Subtest invalid-metadata-sizes: SKIP (0.000s)
[180.538525] [045/134] (837s left) gem_userptr_blits (process-exit)
[180.604497] Starting subtest: process-exit
[180.615360] Subtest process-exit: SUCCESS (0.011s)
[180.747103] [046/134] (837s left) kms_cursor_crc (cursor-offscreen-256x85)
[180.998630] Starting subtest: cursor-offscreen-256x85
[181.041649] Subtest cursor-offscreen-256x85: SKIP (0.038s)
[181.245873] [047/134] (837s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[181.341440] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[181.342334] Starting dynamic subtest: pipe-A-eDP-1
[181.349765] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[181.359343] Starting dynamic subtest: pipe-B-eDP-1
[181.366581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[181.375883] Starting dynamic subtest: pipe-C-eDP-1
[181.383818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.390683] Starting dynamic subtest: pipe-D-eDP-1
[181.398163] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[181.398996] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[183.507854] [048/134] (834s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[183.561789] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[183.622314] [049/134] (834s left) i915_drm_fdinfo (memory-info-shared)
[183.653141] Starting subtest: memory-info-shared
[183.654090] Starting dynamic subtest: smem0
[183.739171] Dynamic subtest smem0: SUCCESS (0.085s)
[183.741069] Subtest memory-info-shared: SUCCESS (0.086s)
[183.820447] [050/134] (834s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[183.900147] Starting subtest: plane-scaler-unity-scaling-with-rotation
[183.901053] Starting dynamic subtest: pipe-A
[184.128025] Dynamic subtest pipe-A: SUCCESS (0.228s)
[184.135860] Starting dynamic subtest: pipe-B
[185.378798] Dynamic subtest pipe-B: SUCCESS (1.250s)
[185.386116] Starting dynamic subtest: pipe-C
[186.702941] Dynamic subtest pipe-C: SUCCESS (1.323s)
[186.710846] Starting dynamic subtest: pipe-D
[188.055818] Dynamic subtest pipe-D: SUCCESS (1.352s)
[188.057048] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.157s)
[189.234671] [051/134] (829s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[189.321995] Starting subtest: 4-tiled-64bpp-rotate-0
[190.566305] Subtest 4-tiled-64bpp-rotate-0: FAIL (1.027s)
[190.595582] [052/134] (828s left) gem_mmap_gtt (big-bo)
[190.655853] Subtest big-bo: SKIP (0.000s)
[190.721985] [053/134] (827s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[190.768044] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[190.795630] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[190.869961] [054/134] (827s left) kms_addfb_basic (addfb25-modifier-no-flag)
[190.946727] Starting subtest: addfb25-modifier-no-flag
[190.947629] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[191.045417] [055/134] (827s left) kms_chamelium_edid (dp-edid-resolution-list)
[191.411314] Subtest dp-edid-resolution-list: SKIP (0.000s)
[192.226513] [056/134] (826s left) gem_madvise (dontneed-before-mmap)
[192.255817] Starting subtest: dontneed-before-mmap
[192.286214] Subtest dontneed-before-mmap: SUCCESS (0.030s)
[192.398380] [057/134] (826s left) kms_hdmi_inject (inject-audio)
[192.748036] Starting subtest: inject-audio
[193.015059] Subtest inject-audio: SUCCESS (0.281s)
[193.639382] [058/134] (825s left) core_auth (basic-auth)
[193.694462] Starting subtest: basic-auth
[193.695468] Subtest basic-auth: SUCCESS (0.001s)
[193.811845] [059/134] (825s left) gem_userptr_blits (map-fixed-invalidate-busy)
[193.875324] Starting subtest: map-fixed-invalidate-busy
[193.877343] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[194.039988] [060/134] (824s left) gem_exec_reloc (basic-concurrent16)
[194.095218] Subtest basic-concurrent16: SKIP (0.000s)
[194.179790] [061/134] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[194.286160] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[194.287882] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[194.396811] [062/134] (824s left) kms_dp_link_training (non-uhbr-mst)
[194.475419] Starting subtest: non-uhbr-mst
[194.479168] Subtest non-uhbr-mst: SKIP (0.000s)
[194.552729] [063/134] (824s left) kms_scaling_modes (scaling-mode-none)
[194.636356] Starting subtest: scaling-mode-none
[194.637313] Starting dynamic subtest: pipe-A-eDP-1
[194.728860] Dynamic subtest pipe-A-eDP-1: SKIP (0.092s)
[194.738041] Starting dynamic subtest: pipe-B-eDP-1
[194.760160] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s)
[194.768831] Starting dynamic subtest: pipe-C-eDP-1
[194.789401] Dynamic subtest pipe-C-eDP-1: SKIP (0.028s)
[194.797109] Starting dynamic subtest: pipe-D-eDP-1
[194.822681] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[194.824621] Subtest scaling-mode-none: SKIP (0.188s)
[194.983268] [064/134] (824s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[195.074144] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[195.075905] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.209294] [065/134] (823s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[200.279535] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[200.282885] Starting dynamic subtest: pipe-A-eDP-1
[201.034515] Dynamic subtest pipe-A-eDP-1: SKIP (0.752s)
[201.043387] Starting dynamic subtest: pipe-B-eDP-1
[202.232071] Dynamic subtest pipe-B-eDP-1: SKIP (1.196s)
[202.234034] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.952s)
[203.508702] [066/134] (815s left) syncobj_timeline (single-wait-for-submit-signaled)
[203.556047] Starting subtest: single-wait-for-submit-signaled
[203.557271] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[203.682150] [067/134] (815s left) vgem_basic (dmabuf-export)
[203.715749] Starting subtest: dmabuf-export
[203.767133] Subtest dmabuf-export: SUCCESS (0.052s)
[203.881840] [068/134] (815s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[203.992316] Starting subtest: basic-busy-flip-before-cursor-legacy
[203.994164] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[204.153976] [069/134] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[204.250187] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[204.251876] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[204.380861] [070/134] (814s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[209.357898] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[209.361019] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[210.205132] [071/134] (809s left) kms_rotation_crc (sprite-rotation-90)
[210.299777] Starting subtest: sprite-rotation-90
[210.301736] Subtest sprite-rotation-90: SKIP (0.001s)
[210.393419] [072/134] (808s left) kms_vblank (ts-continuation-modeset-rpm)
[210.482162] Starting subtest: ts-continuation-modeset-rpm
[210.483097] Starting dynamic subtest: pipe-A-eDP-1
[212.945309] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.462s)
[212.957986] Starting dynamic subtest: pipe-D-eDP-1
[215.140562] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.193s)
[215.141343] Subtest ts-continuation-modeset-rpm: SUCCESS (4.659s)
[215.986792] [073/134] (803s left) gem_exec_schedule (semaphore-user)
[216.045151] Starting subtest: semaphore-user
[216.102980] Subtest semaphore-user: SUCCESS (0.057s)
[218.003724] [074/134] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[218.097134] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[222.306933] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.210s)
[223.495727] [075/134] (795s left) kms_flip (dpms-off-confusion)
[223.589571] Starting subtest: dpms-off-confusion
[223.591811] Starting dynamic subtest: A-eDP1
[232.255843] Dynamic subtest A-eDP1: SUCCESS (8.663s)
[232.264582] Starting dynamic subtest: B-eDP1
[240.959895] Dynamic subtest B-eDP1: SUCCESS (8.702s)
[240.971429] Starting dynamic subtest: C-eDP1
[249.646418] Dynamic subtest C-eDP1: SUCCESS (8.684s)
[249.656649] Starting dynamic subtest: D-eDP1
[258.355205] Dynamic subtest D-eDP1: SUCCESS (8.705s)
[258.358731] Subtest dpms-off-confusion: SUCCESS (34.767s)
[259.591336] [076/134] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[259.679026] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[259.680744] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[259.811993] [077/134] (759s left) kms_lease (lease-unleased-crtc)
[259.894460] Starting subtest: lease-unleased-crtc
[259.895285] Starting dynamic subtest: pipe-A-eDP-1
[260.202503] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.307s)
[260.214169] Starting dynamic subtest: pipe-B-eDP-1
[260.921040] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.717s)
[260.929894] Starting dynamic subtest: pipe-C-eDP-1
[260.930761] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[260.938456] Starting dynamic subtest: pipe-D-eDP-1
[260.939257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[260.940061] Subtest lease-unleased-crtc: SUCCESS (1.042s)
[261.307000] [078/134] (758s left) kms_cursor_edge_walk (128x128-right-edge)
[261.397449] Starting subtest: 128x128-right-edge
[261.398444] Starting dynamic subtest: pipe-A-eDP-1
[264.812064] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[264.819874] Starting dynamic subtest: pipe-D-eDP-1
[268.013075] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s)
[268.013996] Subtest 128x128-right-edge: SUCCESS (6.616s)
[268.899101] [079/134] (750s left) gen9_exec_parse (bb-start-out)
[268.953319] Subtest bb-start-out: SKIP (0.000s)
[269.009411] [080/134] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[269.088702] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[269.090418] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[269.197428] [081/134] (750s left) i915_pm_rpm (gem-pread)
[271.108444] Starting subtest: gem-pread
[273.139334] Subtest gem-pread: SUCCESS (2.033s)
[273.234823] [082/134] (746s left) kms_plane_alpha_blend (constant-alpha-min)
[273.321379] Starting subtest: constant-alpha-min
[273.610455] Starting dynamic subtest: pipe-A-eDP-1
[274.332167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[274.339761] Starting dynamic subtest: pipe-D-eDP-1
[275.807413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.473s)
[275.808292] Subtest constant-alpha-min: SUCCESS (2.486s)
[276.694656] [083/134] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[276.787238] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[276.788874] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[276.914009] [084/134] (742s left) gem_mmap_gtt (cpuset-big-copy-odd)
[276.962208] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[277.017321] [085/134] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[277.117161] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[285.661948] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.546s)
[285.791377] [086/134] (733s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[285.897634] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[289.968607] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.073s)
[291.099781] [087/134] (728s left) kms_flip (2x-flip-vs-dpms-on-nop)
[291.178412] Starting subtest: 2x-flip-vs-dpms-on-nop
[291.189846] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[291.321683] [088/134] (728s left) gem_basic (bad-close)
[291.367263] Starting subtest: bad-close
[291.369099] Subtest bad-close: SUCCESS (0.000s)
[291.473266] [089/134] (728s left) kms_psr (psr2-cursor-render)
[291.555162] Starting subtest: psr2-cursor-render
[291.555999] Starting dynamic subtest: eDP-1
[293.213057] Dynamic subtest eDP-1: SUCCESS (1.658s)
[293.214090] Subtest psr2-cursor-render: SUCCESS (1.659s)
[294.077189] [090/134] (725s left) api_intel_bb (render-ccs)
[294.122806] Starting subtest: render-ccs
[294.486567] Subtest render-ccs: SUCCESS (0.362s)
[294.597277] [091/134] (725s left) kms_cursor_crc (cursor-offscreen-64x21)
[294.790299] Starting subtest: cursor-offscreen-64x21
[294.832031] Subtest cursor-offscreen-64x21: SKIP (0.040s)
[295.120427] [092/134] (724s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[295.233649] Starting subtest: basic-busy-flip-before-cursor-atomic
[295.235398] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[295.395434] [093/134] (724s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[295.449149] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[295.555828] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[295.647710] [094/134] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[295.739753] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[295.741551] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[295.868887] [095/134] (724s left) gem_flink_basic (bad-open)
[295.926992] Starting subtest: bad-open
[295.928109] Subtest bad-open: SUCCESS (0.000s)
[296.033049] [096/134] (724s left) kms_flip (2x-blocking-wf_vblank)
[296.120477] Starting subtest: 2x-blocking-wf_vblank
[296.132617] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[296.262059] [097/134] (723s left) kms_big_fb (linear-8bpp-rotate-0)
[296.358208] Starting subtest: linear-8bpp-rotate-0
[297.570861] Subtest linear-8bpp-rotate-0: SUCCESS (1.213s)
[297.715171] [098/134] (722s left) api_intel_allocator (fork-simple-once)
[297.774319] Starting subtest: fork-simple-once
[297.787252] Subtest fork-simple-once: SUCCESS (0.015s)
[297.932837] [099/134] (722s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[298.025772] Starting subtest: y-tiled-32bpp-rotate-180
[298.027831] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[298.122935] [100/134] (722s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[298.172783] Starting subtest: wait-all-for-submit-delayed-submit
[298.277315] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[298.356994] [101/134] (721s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[298.453374] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[298.454298] Starting dynamic subtest: pipe-A
[298.794557] Dynamic subtest pipe-A: SUCCESS (0.342s)
[298.802094] Starting dynamic subtest: pipe-B
[300.244315] Dynamic subtest pipe-B: SUCCESS (1.449s)
[300.253339] Starting dynamic subtest: pipe-C
[301.639826] Dynamic subtest pipe-C: SUCCESS (1.394s)
[301.647430] Starting dynamic subtest: pipe-D
[303.043817] Dynamic subtest pipe-D: SUCCESS (1.403s)
[303.044605] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.592s)
[304.287283] [102/134] (715s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[304.374249] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[304.375128] Starting dynamic subtest: pipe-A-eDP-1
[305.248068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.870s)
[305.255891] Starting dynamic subtest: pipe-B-eDP-1
[306.740866] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s)
[306.748595] Starting dynamic subtest: pipe-C-eDP-1
[308.231892] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.490s)
[308.239594] Starting dynamic subtest: pipe-D-eDP-1
[309.731850] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s)
[309.732774] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.355s)
[310.907106] [103/134] (709s left) kms_big_fb (yf-tiled-addfb)
[311.003037] Starting subtest: yf-tiled-addfb
[311.004696] Subtest yf-tiled-addfb: SKIP (0.000s)
[311.129524] [104/134] (709s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[311.222287] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[320.524361] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.300s)
[320.648767] [105/134] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[320.746775] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[327.292082] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.543s)
[327.445701] [106/134] (692s left) gem_exec_reloc (basic-wc-gtt-active)
[327.503458] Subtest basic-wc-gtt-active: SKIP (0.000s)
[327.569234] [107/134] (692s left) perf (global-sseu-config-invalid)
[327.662476] Starting subtest: global-sseu-config-invalid
[327.664174] Subtest global-sseu-config-invalid: SKIP (0.000s)
[327.705748] [108/134] (692s left) kms_pm_rpm (fences-dpms)
[329.218544] Starting subtest: fences-dpms
[329.221702] Subtest fences-dpms: SKIP (0.000s)
[329.996809] [109/134] (690s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[330.085190] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[330.086057] Starting dynamic subtest: pipe-A-default-mode
[331.208030] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[331.209783] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.123s)
[331.397486] [110/134] (689s left) kms_pm_rpm (cursor-dpms)
[333.020661] Starting subtest: cursor-dpms
[333.023290] Subtest cursor-dpms: SKIP (0.000s)
[333.700555] [111/134] (686s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[333.751897] Starting subtest: invalid-multi-wait-all-unsubmitted
[333.752858] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[333.881377] [112/134] (686s left) kms_psr (fbc-pr-sprite-render)
[333.966659] Starting subtest: fbc-pr-sprite-render
[333.968596] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[334.046238] [113/134] (686s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[334.141647] Starting subtest: x-tiled-16bpp-rotate-270
[334.161491] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[334.286308] [114/134] (686s left) perf (invalid-remove-userspace-config)
[334.375022] Starting subtest: invalid-remove-userspace-config
[334.385282] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[334.423495] [115/134] (686s left) gem_watchdog (default-virtual)
[334.483569] Starting subtest: default-virtual
[340.774602] Subtest default-virtual: SUCCESS (6.288s)
[340.873317] [116/134] (679s left) sw_sync (sync_merge_same)
[340.900315] Starting subtest: sync_merge_same
[340.901218] Subtest sync_merge_same: SUCCESS (0.000s)
[340.981903] [117/134] (679s left) gem_ringfill (basic-all)
[346.904746] Starting subtest: basic-all
[348.063521] Subtest basic-all: SUCCESS (1.157s)
[348.216030] [118/134] (672s left) gem_ccs (suspend-resume)
[348.281997] Starting subtest: suspend-resume
[348.283986] Subtest suspend-resume: SKIP (0.000s)
[348.420827] [119/134] (672s left) gem_workarounds (basic-read)
[348.485301] Starting subtest: basic-read
[348.504823] Subtest basic-read: SUCCESS (0.020s)
[348.638089] [120/134] (672s left) gem_softpin (noreloc-s3)
[348.695965] Starting subtest: noreloc-S3
[368.300422] Subtest noreloc-S3: SUCCESS (5.409s)
[368.421038] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[368.438426] [FACT gem_softpin (noreloc-s3)] new: kernel.is_tainted.taint_warn: true
[368.439276] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_async_flips
results: parsing output: 7/ for test: kms_psr2_sf
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_flush
results: parsing output: 11/ for test: kms_colorop
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_atomic_transition
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: tools_test
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: prime_mmap
results: parsing output: 25/ for test: gem_exec_whisper
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: vgem_slow
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_chamelium_color
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: dmabuf_sync_file
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_rotation_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_balancer
results: parsing output: 43/ for test: kms_hdr
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_pipe_b_c_ivb
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: sriov_basic
results: parsing output: 53/ for test: kms_addfb_basic
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: gem_madvise
results: parsing output: 56/ for test: kms_hdmi_inject
results: parsing output: 57/ for test: core_auth
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_dp_link_training
results: parsing output: 62/ for test: kms_scaling_modes
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_lease
results: parsing output: 77/ for test: kms_cursor_edge_walk
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: kms_plane_alpha_blend
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_flink_basic
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: gem_watchdog
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: gem_ringfill
results: parsing output: 117/ for test: gem_ccs
results: parsing output: 118/ for test: gem_workarounds
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 121/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 122/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 123/ for test: kms_force_connector_basic
results: no output, setting notrun
results: parsing output: 124/ for test: i915_pm_rps
results: no output, setting notrun
results: parsing output: 125/ for test: fbdev
results: no output, setting notrun
results: parsing output: 126/ for test: kms_colorop
results: no output, setting notrun
results: parsing output: 127/ for test: gem_ctx_persistence
results: no output, setting notrun
results: parsing output: 128/ for test: prime_mmap
results: no output, setting notrun
results: parsing output: 129/ for test: gem_pxp
results: no output, setting notrun
results: parsing output: 130/ for test: kms_colorop
results: no output, setting notrun
results: parsing output: 131/ for test: gem_partial_pwrite_pread
results: no output, setting notrun
results: parsing output: 132/ for test: kms_joiner
results: no output, setting notrun
results: parsing output: 133/ for test: gem_exec_fence
results: no output, setting notrun
Done.