[57.902077] Initializing watchdogs
[57.902123]   /dev/watchdog0
[57.915931] [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]
[57.920238] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.922841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.926787] [001/133] (960s left) kms_chamelium_hpd (common-hpd-after-suspend)
[58.346553] Subtest common-hpd-after-suspend: SKIP (0.000s)
[59.152209] [002/133] (959s left) kms_chamelium_color (ctm-red-to-blue)
[59.248828] Subtest ctm-red-to-blue: SKIP (0.000s)
[59.287294] [003/133] (959s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[59.337740] Starting subtest: etime-multi-wait-available-unsubmitted
[59.441444] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[59.536368] [004/133] (959s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[59.626076] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[59.630267] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[59.689714] [005/133] (958s left) syncobj_wait (invalid-reset-bad-pad)
[59.746817] Starting subtest: invalid-reset-bad-pad
[59.749207] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[59.856304] [006/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[59.951653] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[59.956076] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[60.041562] [007/133] (958s left) kms_draw_crc (draw-method-mmap-cpu)
[60.123460] Starting subtest: draw-method-mmap-cpu
[60.125519] Starting dynamic subtest: xrgb8888-untiled
[60.364367] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[60.370750] Starting dynamic subtest: rgb565-untiled
[60.573568] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[60.580931] Starting dynamic subtest: xrgb2101010-untiled
[60.794347] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[60.800701] Starting dynamic subtest: xbgr16161616f-untiled
[61.003704] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[61.010944] Starting dynamic subtest: xrgb8888-xtiled
[61.125348] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[61.132969] Starting dynamic subtest: rgb565-xtiled
[61.258026] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[61.266541] Starting dynamic subtest: xrgb2101010-xtiled
[61.368148] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[61.376897] Starting dynamic subtest: xbgr16161616f-xtiled
[61.478623] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[61.485975] Starting dynamic subtest: xrgb8888-4tiled
[61.621742] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[61.628265] Starting dynamic subtest: rgb565-4tiled
[61.776879] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[61.784067] Starting dynamic subtest: xrgb2101010-4tiled
[61.909105] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[61.915533] Starting dynamic subtest: xbgr16161616f-4tiled
[62.041910] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[62.043924] Subtest draw-method-mmap-cpu: SUCCESS (1.934s)
[62.128751] [008/133] (956s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[62.221457] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[62.224922] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[62.288320] [009/133] (956s left) gem_mmap_wc (write-read)
[62.344800] Subtest write-read: SKIP (0.000s)
[62.408872] [010/133] (956s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[62.501948] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[62.503959] Starting dynamic subtest: pipe-A-eDP-1
[62.524562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.532816] Starting dynamic subtest: pipe-B-eDP-1
[62.550838] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.557090] Starting dynamic subtest: pipe-C-eDP-1
[62.573966] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.581337] Starting dynamic subtest: pipe-D-eDP-1
[62.599579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.603045] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[64.800100] [011/133] (953s left) kms_atomic (plane-primary-legacy)
[64.899045] Starting subtest: plane-primary-legacy
[64.901264] Starting dynamic subtest: pipe-A-eDP-1
[65.391151] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.494s)
[65.393505] Subtest plane-primary-legacy: SUCCESS (0.495s)
[66.227228] [012/133] (952s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[66.359668] Starting subtest: 2x-flip-vs-cursor-legacy
[66.364144] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[66.499857] [013/133] (952s left) gem_exec_reloc (basic-write-cpu-active)
[66.571177] Subtest basic-write-cpu-active: SKIP (0.000s)
[66.645883] [014/133] (952s left) gem_mmap_gtt (basic-small-bo-tiledy)
[66.752350] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[66.839824] [015/133] (952s left) sriov_basic (enable-vfs-bind-unbind-each)
[66.924741] Starting subtest: enable-vfs-bind-unbind-each
[66.926704] Starting dynamic subtest: numvfs-1
[67.005332] Dynamic subtest numvfs-1: FAIL (0.022s)
[67.014622] Starting dynamic subtest: numvfs-2
[67.092953] Dynamic subtest numvfs-2: FAIL (0.005s)
[67.101637] Starting dynamic subtest: numvfs-3
[67.174351] Dynamic subtest numvfs-3: FAIL (0.005s)
[67.182482] Starting dynamic subtest: numvfs-4
[67.245293] Dynamic subtest numvfs-4: FAIL (0.004s)
[67.253512] Starting dynamic subtest: numvfs-5
[67.315768] Dynamic subtest numvfs-5: FAIL (0.004s)
[67.324123] Starting dynamic subtest: numvfs-6
[67.386571] Dynamic subtest numvfs-6: FAIL (0.004s)
[67.395809] Starting dynamic subtest: numvfs-7
[67.460157] Dynamic subtest numvfs-7: FAIL (0.004s)
[67.468101] Starting dynamic subtest: numvfs-random
[67.531484] Dynamic subtest numvfs-random: FAIL (0.004s)
[67.533225] Subtest enable-vfs-bind-unbind-each: FAIL (0.056s)
[67.594175] [016/133] (951s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[67.766390] Starting subtest: verify-pxp-key-change-after-suspend-resume
[75.025358] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.273s)
[75.148645] [017/133] (943s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[75.251348] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[75.253740] Starting dynamic subtest: pipe-A-eDP-1
[75.312918] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[75.319915] Starting dynamic subtest: pipe-B-eDP-1
[75.377492] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[75.386991] Starting dynamic subtest: pipe-C-eDP-1
[75.444324] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[75.453508] Starting dynamic subtest: pipe-D-eDP-1
[75.512737] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[75.516839] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[77.525964] [018/133] (941s left) gem_mmap_offset (bad-object)
[77.583807] Starting subtest: bad-object
[77.585825] Subtest bad-object: SUCCESS (0.001s)
[77.683287] [019/133] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[77.784073] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[77.788287] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[77.886614] [020/133] (941s left) vgem_basic (bad-handle)
[77.952707] Starting subtest: bad-handle
[77.954585] Subtest bad-handle: SUCCESS (0.000s)
[78.017855] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[78.021370] [021/133] (941s left) gem_ctx_shared (q-smoketest)
[78.087388] Starting subtest: Q-smoketest
[78.089721] Starting dynamic subtest: rcs0
[83.703819] Dynamic subtest rcs0: SUCCESS (5.511s)
[83.712304] Starting dynamic subtest: bcs0
[89.212125] Dynamic subtest bcs0: SUCCESS (5.494s)
[89.226643] Starting dynamic subtest: vcs0
[94.674553] Dynamic subtest vcs0: SUCCESS (5.478s)
[94.685049] Starting dynamic subtest: vcs1
[100.190419] Dynamic subtest vcs1: SUCCESS (5.507s)
[100.200787] Starting dynamic subtest: vecs0
[105.683205] Dynamic subtest vecs0: SUCCESS (5.497s)
[105.693231] Starting dynamic subtest: ccs0
[111.117642] Dynamic subtest ccs0: SUCCESS (5.485s)
[111.120160] Subtest Q-smoketest: SUCCESS (32.976s)
[111.306859] [022/133] (907s left) kms_hdr (static-toggle)
[111.412754] Starting subtest: static-toggle
[111.419244] Subtest static-toggle: SKIP (0.000s)
[111.481628] [023/133] (907s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[111.536612] Starting subtest: multi-wait-for-submit-submitted-signaled
[111.538546] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[111.636171] [024/133] (907s left) gem_exec_balancer (hang)
[111.888229] Starting subtest: hang
[113.856199] Subtest hang: SUCCESS (1.968s)
[113.988275] [025/133] (905s left) gem_cs_tlb (engines)
[114.049150] Starting subtest: engines
[114.051247] Starting dynamic subtest: rcs0
[116.258438] Dynamic subtest rcs0: SUCCESS (2.152s)
[116.269237] Starting dynamic subtest: bcs0
[118.409623] Dynamic subtest bcs0: SUCCESS (2.153s)
[118.417118] Starting dynamic subtest: vcs0
[120.563379] Dynamic subtest vcs0: SUCCESS (2.151s)
[120.571641] Starting dynamic subtest: vcs1
[122.715933] Dynamic subtest vcs1: SUCCESS (2.153s)
[122.725542] Starting dynamic subtest: vecs0
[124.867515] Dynamic subtest vecs0: SUCCESS (2.151s)
[124.878754] Starting dynamic subtest: ccs0
[127.020815] Dynamic subtest ccs0: SUCCESS (2.153s)
[127.023443] Subtest engines: SUCCESS (12.916s)
[127.078256] [026/133] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[127.180899] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[134.518984] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.340s)
[134.618163] [027/133] (884s left) gem_pread (self)
[134.677451] Subtest self: SKIP (0.000s)
[134.731426] [028/133] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[134.819668] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[134.823838] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[134.912998] [029/133] (884s left) prime_mmap (test_errors)
[134.960773] Starting subtest: test_errors
[134.962708] Starting dynamic subtest: test_errors-smem
[135.053515] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[135.056430] Subtest test_errors: SUCCESS (0.094s)
[135.140976] [030/133] (884s left) gen9_exec_parse (bb-start-far)
[135.200415] Subtest bb-start-far: SKIP (0.000s)
[135.262643] [031/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[135.366958] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[135.371256] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[135.490159] [032/133] (884s left) perf (gen12-group-concurrent-oa-buffer-read)
[135.619496] Starting subtest: gen12-group-concurrent-oa-buffer-read
[145.698934] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.024s)
[145.735824] [033/133] (873s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[145.858849] Starting subtest: 4-tiled-32bpp-rotate-0
[147.294925] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.437s)
[147.420381] [034/133] (872s left) kms_cursor_crc (cursor-random-max-size)
[147.728718] Starting subtest: cursor-random-max-size
[147.734544] Subtest cursor-random-max-size: SKIP (0.000s)
[147.847829] [035/133] (871s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[147.904070] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[147.905748] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[147.986352] [036/133] (871s left) gem_exec_reloc (basic-softpin)
[148.044943] Subtest basic-softpin: SKIP (0.000s)
[148.112898] [037/133] (871s left) kms_psr (fbc-pr-cursor-blt)
[148.198553] Starting subtest: fbc-pr-cursor-blt
[148.202169] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[148.271215] [038/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[148.358073] Starting subtest: legacy-setmode
[148.360101] Starting dynamic subtest: pipe-A-eDP-1
[155.228018] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.868s)
[155.230187] Subtest legacy-setmode: SUCCESS (6.869s)
[156.015296] [039/133] (863s left) perf_pmu (enable-race)
[156.061154] Starting subtest: enable-race
[156.063094] Starting dynamic subtest: rcs0
[168.834320] Dynamic subtest rcs0: SUCCESS (12.755s)
[168.844130] Starting dynamic subtest: bcs0
[181.575472] Dynamic subtest bcs0: SUCCESS (12.740s)
[181.585697] Starting dynamic subtest: vcs0
[196.885694] Dynamic subtest vcs0: SUCCESS (15.326s)
[196.895660] Starting dynamic subtest: vcs1
[212.887720] Dynamic subtest vcs1: SUCCESS (16.000s)
[212.897065] Starting dynamic subtest: vecs0
[228.886202] Dynamic subtest vecs0: SUCCESS (15.996s)
[228.895602] Starting dynamic subtest: ccs0
[241.634151] Dynamic subtest ccs0: SUCCESS (12.748s)
[241.636612] Subtest enable-race: SUCCESS (85.574s)
[241.727430] [040/133] (778s left) syncobj_timeline (invalid-transfer-illegal-handle)
[241.787257] Starting subtest: invalid-transfer-illegal-handle
[241.789544] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[241.882096] [041/133] (778s left) syncobj_eventfd (timeline-wait)
[241.939051] Starting subtest: timeline-wait
[241.949472] Subtest timeline-wait: SUCCESS (0.010s)
[242.024292] [042/133] (778s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[242.092063] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[242.154426] [043/133] (777s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[242.252549] Starting subtest: y-tiled-8bpp-rotate-180
[242.256622] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[242.335826] [044/133] (777s left) gem_exec_fence (syncobj-timeline-chain-engines)
[242.897537] Starting subtest: syncobj-timeline-chain-engines
[243.017869] Subtest syncobj-timeline-chain-engines: SUCCESS (0.121s)
[244.046560] [045/133] (776s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[244.155630] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[244.159666] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[244.236233] [046/133] (775s left) kms_pm_backlight (bad-brightness)
[244.327126] Starting subtest: bad-brightness
[244.380604] Starting dynamic subtest: eDP-1
[244.686469] Dynamic subtest eDP-1: SUCCESS (0.305s)
[244.688648] Subtest bad-brightness: SUCCESS (0.359s)
[245.541133] [047/133] (774s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[245.631174] Starting subtest: 2x-flip-vs-rmfb-interruptible
[245.641760] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.010s)
[245.731161] [048/133] (774s left) prime_mmap (test_userptr)
[245.792988] Starting subtest: test_userptr
[245.795462] Starting dynamic subtest: test_userptr-smem
[245.797948] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[245.800288] Subtest test_userptr: SUCCESS (0.001s)
[245.887999] [049/133] (774s left) perf (disabled-read-error)
[245.989036] Starting subtest: disabled-read-error
[245.999333] Subtest disabled-read-error: SUCCESS (0.013s)
[246.040816] [050/133] (774s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[246.149017] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[246.151273] Starting dynamic subtest: pipe-A-eDP-1
[246.246428] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[246.256592] Starting dynamic subtest: pipe-B-eDP-1
[247.416936] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s)
[247.421567] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.274s)
[248.598953] [051/133] (771s left) prime_self_import (basic-with_two_bos)
[248.640591] Starting subtest: basic-with_two_bos
[248.661463] Subtest basic-with_two_bos: SUCCESS (0.021s)
[248.767127] [052/133] (771s left) gem_exec_schedule (semaphore-power)
[248.951199] Subtest semaphore-power: SKIP (0.000s)
[249.131257] [053/133] (771s left) gem_mmap_gtt (medium-copy)
[249.189080] Subtest medium-copy: SKIP (0.000s)
[249.252199] [054/133] (771s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[249.360151] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[249.362396] Starting dynamic subtest: pipe-A-default-mode
[250.552981] Dynamic subtest pipe-A-default-mode: SKIP (1.191s)
[250.557366] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.192s)
[250.674412] [055/133] (769s left) gem_lmem_evict (dontneed-evict-race)
[250.723188] Subtest dontneed-evict-race: SKIP (0.000s)
[250.765700] [056/133] (769s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[250.856747] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[250.859055] Starting dynamic subtest: pipe-A-eDP-1
[267.438965] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.420s)
[267.448695] Starting dynamic subtest: pipe-B-eDP-1
[284.379929] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.445s)
[284.389695] Starting dynamic subtest: pipe-C-eDP-1
[301.395116] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.379s)
[301.404300] Starting dynamic subtest: pipe-D-eDP-1
[318.372368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.388s)
[318.375082] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.637s)
[319.571808] [057/133] (701s left) kms_pm_rpm (system-suspend-modeset)
[321.219387] Starting subtest: system-suspend-modeset
[340.452283] Subtest system-suspend-modeset: SUCCESS (4.432s)
[340.840888] [058/133] (679s left) gem_mmap_wc (close)
[340.905641] Subtest close: SKIP (0.000s)
[340.958427] [059/133] (679s left) gem_exec_reloc (basic-write-gtt-noreloc)
[341.010813] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[341.067020] [060/133] (679s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[341.165497] Starting subtest: yf-tiled-32bpp-rotate-90
[341.170197] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[341.244002] [061/133] (679s left) sw_sync (sync_random_merge)
[341.278689] Starting subtest: sync_random_merge
[341.317763] Subtest sync_random_merge: SUCCESS (0.042s)
[341.379430] [062/133] (679s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[341.433068] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[341.534323] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[341.610341] [063/133] (679s left) gem_ctx_persistence (engines-hang)
[341.671280] Starting subtest: engines-hang
[341.673694] Starting dynamic subtest: rcs0
[341.728648] Dynamic subtest rcs0: SUCCESS (0.059s)
[341.739305] Starting dynamic subtest: bcs0
[341.809644] Dynamic subtest bcs0: SUCCESS (0.082s)
[341.820523] Starting dynamic subtest: vcs0
[341.899094] Dynamic subtest vcs0: SUCCESS (0.089s)
[341.909934] Starting dynamic subtest: vcs1
[341.984142] Dynamic subtest vcs1: SUCCESS (0.086s)
[341.994856] Starting dynamic subtest: vecs0
[342.072807] Dynamic subtest vecs0: SUCCESS (0.090s)
[342.084428] Starting dynamic subtest: ccs0
[342.164078] Dynamic subtest ccs0: SUCCESS (0.092s)
[342.166748] Subtest engines-hang: SUCCESS (0.508s)
[342.243211] [064/133] (678s left) gem_vm_create (execbuf)
[342.294643] Starting subtest: execbuf
[342.300808] Subtest execbuf: SUCCESS (0.009s)
[342.415199] [065/133] (678s left) gem_mmap_gtt (close-race)
[342.460657] Subtest close-race: SKIP (0.000s)
[342.517286] [066/133] (678s left) gem_exec_whisper (basic-fds)
[342.579547] Starting subtest: basic-fds
[347.956110] Subtest basic-fds: SUCCESS (5.480s)
[348.152048] [067/133] (672s left) drm_read (short-buffer-wakeup)
[348.310523] Starting subtest: short-buffer-wakeup
[380.437831] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[380.573315] [068/133] (640s left) kms_psr (psr2-sprite-mmap-cpu)
[380.677713] Starting subtest: psr2-sprite-mmap-cpu
[380.680651] Starting dynamic subtest: eDP-1
[382.436847] Dynamic subtest eDP-1: SUCCESS (1.759s)
[382.439811] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.760s)
[383.302500] [069/133] (637s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[383.402022] Starting subtest: bad-aux-stride-yf-tiled-ccs
[383.404387] Starting dynamic subtest: pipe-A-eDP-1
[383.427318] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[383.437672] Starting dynamic subtest: pipe-B-eDP-1
[383.460767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[383.469569] Starting dynamic subtest: pipe-C-eDP-1
[383.492460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[383.501226] Starting dynamic subtest: pipe-D-eDP-1
[383.523564] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[383.527861] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.007s)
[385.671483] [070/133] (635s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[385.781688] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[385.787399] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[385.878095] [071/133] (635s left) kms_lease (invalid-create-leases)
[385.978092] Starting subtest: invalid-create-leases
[385.983577] Subtest invalid-create-leases: SUCCESS (0.007s)
[386.100405] [072/133] (635s left) i915_pm_rpm (gem-mmap-type)
[388.229618] Starting subtest: gem-mmap-type
[388.232559] Starting dynamic subtest: wb-smem0
[391.720618] Dynamic subtest wb-smem0: SUCCESS (3.492s)
[391.730662] Starting dynamic subtest: wc-smem0
[394.893870] Dynamic subtest wc-smem0: SUCCESS (3.171s)
[394.903901] Starting dynamic subtest: uc-smem0
[397.783326] Dynamic subtest uc-smem0: SUCCESS (2.890s)
[397.785553] Subtest gem-mmap-type: SUCCESS (9.556s)
[397.894898] [073/133] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[398.000153] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[398.005424] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[398.084099] [074/133] (623s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[398.140369] Starting subtest: yf-tiled-to-vebox-y-tiled
[398.145035] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[398.338423] [075/133] (623s left) kms_cursor_edge_walk (64x64-top-bottom)
[398.437569] Starting subtest: 64x64-top-bottom
[398.440331] Starting dynamic subtest: pipe-A-eDP-1
[401.904620] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.468s)
[401.914843] Starting dynamic subtest: pipe-D-eDP-1
[405.029989] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[405.032897] Subtest 64x64-top-bottom: SUCCESS (6.596s)
[405.833583] [076/133] (615s left) gem_ctx_persistence (legacy-engines-hang)
[405.899356] Starting subtest: legacy-engines-hang
[405.901767] Starting dynamic subtest: render
[406.043863] Dynamic subtest render: SUCCESS (0.144s)
[406.056656] Starting dynamic subtest: bsd1
[406.149117] Dynamic subtest bsd1: SUCCESS (0.102s)
[406.160976] Starting dynamic subtest: bsd2
[406.254539] Dynamic subtest bsd2: SUCCESS (0.102s)
[406.267622] Starting dynamic subtest: blt
[406.350487] Dynamic subtest blt: SUCCESS (0.092s)
[406.365482] Starting dynamic subtest: vebox
[406.444343] Dynamic subtest vebox: SUCCESS (0.091s)
[406.447141] Subtest legacy-engines-hang: SUCCESS (0.546s)
[406.536956] [077/133] (614s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[406.642808] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[407.444294] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[407.595992] [078/133] (613s left) gem_fence_thrash (bo-copy)
[407.642257] Starting subtest: bo-copy
[407.654496] Subtest bo-copy: SKIP (0.014s)
[407.715351] [079/133] (613s left) kms_async_flips (async-flip-suspend-resume)
[407.799245] Starting subtest: async-flip-suspend-resume
[408.171270] Starting dynamic subtest: pipe-A-eDP-1
[426.241954] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.859s)
[426.616381] Starting dynamic subtest: pipe-B-eDP-1
[444.283440] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.023s)
[444.660713] Starting dynamic subtest: pipe-C-eDP-1
[462.202960] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.912s)
[462.586761] Starting dynamic subtest: pipe-D-eDP-1
[480.244777] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.968s)
[480.250957] Subtest async-flip-suspend-resume: SUCCESS (13.280s)
[481.371534] [080/133] (540s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[481.469172] Starting subtest: compare-crc-sanitycheck-xr24
[481.471444] Starting dynamic subtest: pipe-A-eDP-1
[482.082097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s)
[482.091414] Starting dynamic subtest: pipe-B-eDP-1
[483.344630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s)
[483.355056] Starting dynamic subtest: pipe-C-eDP-1
[484.573364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s)
[484.583906] Starting dynamic subtest: pipe-D-eDP-1
[485.796708] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[485.799751] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.467s)
[486.776998] [081/133] (534s left) gem_exec_flush (basic-batch-kernel-default-wb)
[486.842546] Starting subtest: basic-batch-kernel-default-wb
[494.265040] Subtest basic-batch-kernel-default-wb: SUCCESS (7.521s)
[494.473039] [082/133] (527s left) api_intel_bb (offset-control)
[494.521259] Starting subtest: offset-control
[494.533431] Subtest offset-control: SUCCESS (0.014s)
[494.655015] [083/133] (527s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[494.751982] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[501.362103] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.645s)
[501.487968] [084/133] (520s left) kms_psr (pr-cursor-blt)
[501.575586] Starting subtest: pr-cursor-blt
[501.580223] Subtest pr-cursor-blt: SKIP (0.000s)
[501.648311] [085/133] (520s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[501.734946] Starting subtest: blocking-absolute-wf_vblank-interruptible
[501.737544] Starting dynamic subtest: A-eDP1
[510.445970] Dynamic subtest A-eDP1: SUCCESS (8.696s)
[510.457441] Starting dynamic subtest: B-eDP1
[519.185595] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[519.196296] Starting dynamic subtest: C-eDP1
[527.928641] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[527.940158] Starting dynamic subtest: D-eDP1
[536.612188] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[536.614881] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.883s)
[537.841004] [086/133] (484s left) gem_exec_balancer (waits)
[537.910641] Starting subtest: waits
[544.448295] Subtest waits: SUCCESS (6.480s)
[544.699868] [087/133] (477s left) syncobj_wait (wait-any-complex)
[544.765630] Starting subtest: wait-any-complex
[544.825769] Subtest wait-any-complex: SUCCESS (0.063s)
[544.916983] [088/133] (477s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[544.987483] Starting subtest: wait-all-for-submit-delayed-submit
[545.088802] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[545.192189] [089/133] (476s left) kms_psr (psr-primary-page-flip)
[545.312311] Starting subtest: psr-primary-page-flip
[545.314869] Starting dynamic subtest: eDP-1
[547.025286] Dynamic subtest eDP-1: SUCCESS (1.712s)
[547.028273] Subtest psr-primary-page-flip: SUCCESS (1.714s)
[547.880511] [090/133] (474s left) gem_mmap_gtt (hang)
[547.954523] Subtest hang: SKIP (0.000s)
[548.020012] [091/133] (474s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[548.112511] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[548.117594] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[548.193935] [092/133] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[548.284521] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[551.851114] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.573s)
[553.002360] [093/133] (469s left) gem_spin_batch (resubmit-all)
[553.070452] Starting subtest: resubmit-all
[553.073627] Starting dynamic subtest: rcs0
[553.085744] Dynamic subtest rcs0: SUCCESS (0.015s)
[553.102187] Starting dynamic subtest: bcs0
[553.104567] Dynamic subtest bcs0: SUCCESS (0.004s)
[553.117289] Starting dynamic subtest: vcs0
[553.119605] Dynamic subtest vcs0: SUCCESS (0.002s)
[553.128310] Starting dynamic subtest: vcs1
[553.130524] Dynamic subtest vcs1: SUCCESS (0.002s)
[553.139388] Starting dynamic subtest: vecs0
[553.141612] Dynamic subtest vecs0: SUCCESS (0.002s)
[553.150511] Starting dynamic subtest: ccs0
[553.152993] Dynamic subtest ccs0: SUCCESS (0.003s)
[553.155419] Subtest resubmit-all: SUCCESS (0.037s)
[554.561620] [094/133] (467s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[554.666739] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[563.342217] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.681s)
[563.461780] [095/133] (458s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[563.558545] Starting subtest: fbc-rgb565-draw-render
[567.724605] Subtest fbc-rgb565-draw-render: SUCCESS (4.171s)
[568.867427] [096/133] (453s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[568.968888] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[568.974365] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[569.092788] [097/133] (453s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[569.202350] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[570.271009] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.069s)
[570.398612] [098/133] (452s left) kms_selftest (drm_framebuffer)
[570.440600] Starting subtest: drm_framebuffer
[570.471337] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[570.580274] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.109s)
[570.590089] Starting dynamic subtest: drm_test_framebuffer_cleanup
[570.685020] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.101s)
[570.694208] Starting dynamic subtest: drm_test_framebuffer_create
[570.910009] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.225s)
[570.919794] Starting dynamic subtest: drm_test_framebuffer_free
[571.110218] Dynamic subtest drm_test_framebuffer_free: FAIL (0.137s)
[571.115318] Subtest drm_framebuffer: FAIL (0.610s)
[571.218892] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[571.235856] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[571.236672] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: kms_chamelium_color
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_draw_crc
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_mmap_wc
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_mmap_offset
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: gem_ctx_shared
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: syncobj_wait
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_cs_tlb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_pread
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: gen9_exec_parse
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_atomic_interruptible
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: syncobj_eventfd
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_pm_backlight
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: prime_self_import
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_lmem_evict
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_mmap_wc
results: parsing output: 58/ for test: gem_exec_reloc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: drm_read
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_lease
results: parsing output: 71/ for test: i915_pm_rpm
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_cursor_edge_walk
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: gem_fence_thrash
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_selftest
results: parsing output: 98/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 99/ for test: kms_atomic_transition
results: no output, setting notrun
results: parsing output: 100/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 101/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 102/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 103/ for test: gem_softpin
results: no output, setting notrun
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 105/ for test: kms_vblank
results: no output, setting notrun
results: parsing output: 106/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 107/ for test: kms_color_pipeline
results: no output, setting notrun
results: parsing output: 108/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 109/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 110/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 112/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 113/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 114/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 116/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 117/ for test: kms_cursor_crc
results: no output, setting notrun
results: parsing output: 118/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 119/ for test: prime_vgem
results: no output, setting notrun
results: parsing output: 120/ for test: i915_suspend
results: no output, setting notrun
results: parsing output: 121/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 122/ for test: kms_plane
results: no output, setting notrun
results: parsing output: 123/ for test: kms_fence_pin_leak
results: no output, setting notrun
results: parsing output: 124/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 125/ for test: gem_exec_flush
results: no output, setting notrun
results: parsing output: 126/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 128/ for test: gem_busy
results: no output, setting notrun
results: parsing output: 129/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 130/ for test: i915_hangman
results: no output, setting notrun
results: parsing output: 131/ for test: kms_pm_dc
results: no output, setting notrun
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
Done.