[57.592812] Initializing watchdogs
[57.592866]   /dev/watchdog0
[57.607710] [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.614691] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.617140] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.620350] [001/131] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[57.686666] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[57.794273] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[57.888496] [002/131] (960s left) kms_feature_discovery (display-2x)
[57.994972] Starting subtest: display-2x
[57.999693] Subtest display-2x: SKIP (0.000s)
[58.076457] [003/131] (960s left) gem_eio (in-flight-contexts-10ms)
[58.214798] Starting subtest: in-flight-contexts-10ms
[69.921304] Subtest in-flight-contexts-10ms: SUCCESS (11.708s)
[70.114856] [004/131] (948s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[70.211580] Starting subtest: y-tiled-8bpp-rotate-90
[70.215799] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[70.313933] [005/131] (947s left) gem_exec_params (invalid-ring2)
[70.374905] Starting subtest: invalid-ring2
[70.377213] Subtest invalid-ring2: SUCCESS (0.000s)
[70.480873] [006/131] (947s left) kms_cursor_crc (cursor-onscreen-512x170)
[70.775564] Starting subtest: cursor-onscreen-512x170
[70.779795] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[71.050174] [007/131] (947s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[71.272836] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[75.337419] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.069s)
[76.523501] [008/131] (941s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[76.623948] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[76.626329] Starting dynamic subtest: pipe-A
[76.963776] Dynamic subtest pipe-A: SUCCESS (0.341s)
[76.973294] Starting dynamic subtest: pipe-B
[78.397584] Dynamic subtest pipe-B: SUCCESS (1.433s)
[78.407376] Starting dynamic subtest: pipe-C
[79.837305] Dynamic subtest pipe-C: SUCCESS (1.440s)
[79.848039] Starting dynamic subtest: pipe-D
[81.248210] Dynamic subtest pipe-D: SUCCESS (1.411s)
[81.250572] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.626s)
[82.421078] [009/131] (936s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[87.381731] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[87.386477] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[88.252629] [010/131] (930s left) gem_exec_flush (basic-wb-rw-default)
[88.320524] Starting subtest: basic-wb-rw-default
[93.769856] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[93.967311] [011/131] (924s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[94.066784] Starting subtest: fbc-psr-sprite-mmap-gtt
[94.069147] Starting dynamic subtest: eDP-1
[94.073590] Dynamic subtest eDP-1: SKIP (0.000s)
[94.077900] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[94.187591] [012/131] (924s left) gem_exec_fence (parallel)
[94.369369] Starting subtest: parallel
[94.371933] Starting dynamic subtest: rcs0
[96.518503] Dynamic subtest rcs0: SUCCESS (2.150s)
[96.527901] Starting dynamic subtest: bcs0
[98.667711] Dynamic subtest bcs0: SUCCESS (2.149s)
[98.676806] Starting dynamic subtest: vcs0
[100.817588] Dynamic subtest vcs0: SUCCESS (2.150s)
[100.827928] Starting dynamic subtest: vcs1
[102.965839] Dynamic subtest vcs1: SUCCESS (2.148s)
[102.974553] Starting dynamic subtest: vecs0
[105.114869] Dynamic subtest vecs0: SUCCESS (2.148s)
[105.125618] Starting dynamic subtest: ccs0
[107.268891] Dynamic subtest ccs0: SUCCESS (2.154s)
[107.270993] Subtest parallel: SUCCESS (12.901s)
[107.954056] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[107.956835] [013/131] (910s left) gem_ctx_sseu (mmap-args)
[108.028077] Subtest mmap-args: SKIP (0.000s)
[108.100974] [014/131] (910s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[108.158955] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[108.161301] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[108.295468] [015/131] (910s left) perf (low-oa-exponent-permissions)
[108.420341] Starting subtest: low-oa-exponent-permissions
[108.457140] Subtest low-oa-exponent-permissions: SUCCESS (0.038s)
[108.506212] [016/131] (910s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[108.604352] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[108.608818] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[108.716990] [017/131] (910s left) gem_ctx_persistence (legacy-engines-mixed)
[108.782865] Starting subtest: legacy-engines-mixed
[108.785193] Starting dynamic subtest: render
[108.892840] Dynamic subtest render: SUCCESS (0.109s)
[108.905268] Starting dynamic subtest: bsd1
[108.955392] Dynamic subtest bsd1: SUCCESS (0.061s)
[108.965622] Starting dynamic subtest: bsd2
[109.026473] Dynamic subtest bsd2: SUCCESS (0.069s)
[109.037291] Starting dynamic subtest: blt
[109.091575] Dynamic subtest blt: SUCCESS (0.063s)
[109.102514] Starting dynamic subtest: vebox
[109.164258] Dynamic subtest vebox: SUCCESS (0.071s)
[109.166388] Subtest legacy-engines-mixed: SUCCESS (0.382s)
[109.255598] [018/131] (909s left) syncobj_wait (wait-all-snapshot)
[109.314481] Starting subtest: wait-all-snapshot
[109.395192] Subtest wait-all-snapshot: SUCCESS (0.081s)
[109.495110] [019/131] (909s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[109.599975] Starting subtest: 4-tiled-16bpp-rotate-90
[109.622363] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[109.777768] [020/131] (909s left) gem_caching (writes)
[109.838551] Subtest writes: SKIP (0.000s)
[109.903159] [021/131] (909s left) gem_basic (multigpu-create-close)
[109.962084] Starting subtest: multigpu-create-close
[109.966052] Subtest multigpu-create-close: SKIP (0.000s)
[110.092970] [022/131] (908s left) i915_query (hwconfig_table)
[110.153277] Starting subtest: hwconfig_table
[110.404492] Subtest hwconfig_table: SUCCESS (0.001s)
[110.440917] [023/131] (908s left) kms_chamelium_frames (dp-crc-single)
[110.827170] Subtest dp-crc-single: SKIP (0.000s)
[111.652922] [024/131] (907s left) gen7_exec_parse (basic-rejected)
[111.714434] Subtest basic-rejected: SKIP (0.000s)
[111.771922] [025/131] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[111.870427] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[111.874795] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[111.992282] [026/131] (907s left) kms_psr (pr-no-drrs)
[112.098630] Starting subtest: pr-no-drrs
[112.103107] Subtest pr-no-drrs: SKIP (0.000s)
[112.196265] [027/131] (907s left) gem_create (create-ext-cpu-access-big)
[112.371369] Starting subtest: create-ext-cpu-access-big
[112.375885] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[112.456343] [028/131] (906s left) kms_chamelium_color (ctm-red-to-blue)
[112.552395] Subtest ctm-red-to-blue: SKIP (0.000s)
[112.600416] [029/131] (906s left) kms_prop_blob (invalid-get-prop)
[112.659124] Starting subtest: invalid-get-prop
[112.660942] Subtest invalid-get-prop: SUCCESS (0.000s)
[112.793174] [030/131] (906s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[112.888734] Starting subtest: 2x-plain-flip-ts-check-interruptible
[112.901096] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[113.046692] [031/131] (906s left) i915_module_load (reload-no-display)
[113.080960] Starting subtest: reload-no-display
[119.442287] Subtest reload-no-display: SUCCESS (6.361s)
[119.470565] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[119.471324] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[119.474425] [032/131] (899s left) vgem_basic (mmap)
[119.530299] Starting subtest: mmap
[119.535027] Subtest mmap: SUCCESS (0.006s)
[119.569072] [033/131] (899s left) api_intel_allocator (reopen-fork)
[121.070381] Starting subtest: reopen-fork
[124.666256] Subtest reopen-fork: SUCCESS (3.597s)
[124.703035] [FACT api_intel_allocator (reopen-fork)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[124.704363] [FACT api_intel_allocator (reopen-fork)] new: kernel.kmod_is_loaded.i915: true
[124.707871] [034/131] (894s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[124.817870] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[124.822296] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[124.925720] [035/131] (894s left) core_sysfs (read-all-entries)
[124.982905] Starting subtest: read-all-entries
[124.985291] Subtest read-all-entries: SUCCESS (0.003s)
[125.106315] [036/131] (894s left) gem_unref_active_buffers
[125.324680] [037/131] (894s left) kms_pm_rpm (i2c)
[127.073878] Starting subtest: i2c
[132.650952] Subtest i2c: SUCCESS (5.578s)
[132.771487] [038/131] (886s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[132.872993] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[132.875282] Starting dynamic subtest: pipe-A-default-mode
[133.989066] Dynamic subtest pipe-A-default-mode: SKIP (1.113s)
[133.993680] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.115s)
[134.167298] [039/131] (885s left) gem_exec_whisper (basic-normal-all)
[134.235112] Starting subtest: basic-normal-all
[136.497295] Subtest basic-normal-all: SUCCESS (2.259s)
[136.704210] [040/131] (883s left) gem_exec_schedule (manyslice)
[136.773999] Starting subtest: manyslice
[136.776736] Starting dynamic subtest: rcs0
[143.454777] Dynamic subtest rcs0: SUCCESS (6.688s)
[143.466393] Starting dynamic subtest: bcs0
[150.089673] Dynamic subtest bcs0: SUCCESS (6.631s)
[150.100881] Starting dynamic subtest: vcs0
[155.158236] Dynamic subtest vcs0: SUCCESS (5.069s)
[155.172494] Starting dynamic subtest: vcs1
[161.235773] Dynamic subtest vcs1: SUCCESS (6.077s)
[161.248623] Starting dynamic subtest: vecs0
[167.308595] Dynamic subtest vecs0: SUCCESS (6.071s)
[167.322603] Starting dynamic subtest: ccs0
[172.959563] Dynamic subtest ccs0: SUCCESS (5.648s)
[172.961937] Subtest manyslice: SUCCESS (36.189s)
[173.271224] [041/131] (846s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[173.324447] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[173.327085] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[173.443855] [042/131] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[173.544792] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[173.548975] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[173.684628] [043/131] (846s left) sysfs_heartbeat_interval (nopreempt)
[173.741544] Starting subtest: nopreempt
[173.743832] Starting dynamic subtest: vecs0
[182.950397] Dynamic subtest vecs0: SUCCESS (9.207s)
[182.962517] Starting dynamic subtest: ccs0
[186.988671] Dynamic subtest ccs0: SUCCESS (4.036s)
[186.999187] Starting dynamic subtest: vcs0
[196.918389] Dynamic subtest vcs0: SUCCESS (9.925s)
[196.929825] Starting dynamic subtest: bcs0
[200.933884] Dynamic subtest bcs0: SUCCESS (4.016s)
[200.944850] Starting dynamic subtest: rcs0
[205.032711] Dynamic subtest rcs0: SUCCESS (4.097s)
[205.042405] Starting dynamic subtest: vcs1
[214.949254] Dynamic subtest vcs1: SUCCESS (9.916s)
[214.951690] Subtest nopreempt: SUCCESS (41.207s)
[215.054829] [044/131] (804s left) kms_psr (psr-suspend)
[215.151847] Starting subtest: psr-suspend
[215.154096] Starting dynamic subtest: eDP-1
[232.619738] Dynamic subtest eDP-1: SUCCESS (3.033s)
[232.621662] Subtest psr-suspend: SUCCESS (3.034s)
[233.500945] [045/131] (786s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[233.634787] Starting subtest: cursorB-vs-flipA-legacy
[233.639545] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[233.806506] [046/131] (786s left) gem_mmap_gtt (medium-copy-odd)
[233.867359] Subtest medium-copy-odd: SKIP (0.000s)
[233.935249] [047/131] (786s left) gem_eio (in-flight-1us)
[234.133982] Starting subtest: in-flight-1us
[241.984703] Subtest in-flight-1us: SUCCESS (7.843s)
[242.161342] [048/131] (777s left) kms_frontbuffer_tracking (basic)
[242.262212] Starting subtest: basic
[245.610477] Subtest basic: SUCCESS (3.352s)
[245.776950] [049/131] (774s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[246.165007] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[246.993025] [050/131] (773s left) i915_pm_rpm (debugfs-read)
[248.514310] Starting subtest: debugfs-read
[249.670012] Subtest debugfs-read: SUCCESS (1.152s)
[250.072419] [051/131] (770s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[255.123727] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[255.126182] Starting dynamic subtest: pipe-A-eDP-1
[255.911432] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s)
[255.921576] Starting dynamic subtest: pipe-B-eDP-1
[257.044739] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[257.049425] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.917s)
[258.253917] [052/131] (761s left) gem_eio (in-flight-internal-10ms)
[258.475054] Starting subtest: in-flight-internal-10ms
[260.405502] Subtest in-flight-internal-10ms: SUCCESS (1.932s)
[260.560729] [053/131] (759s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[260.651939] Starting subtest: fbcpsr-tiling-4
[267.817951] Subtest fbcpsr-tiling-4: SUCCESS (7.166s)
[267.954640] [054/131] (752s left) gem_gpgpu_fill (basic)
[268.012691] Starting subtest: basic
[268.015119] Starting dynamic subtest: smem
[268.020664] Dynamic subtest smem: SUCCESS (0.008s)
[268.022955] Subtest basic: SUCCESS (0.009s)
[268.179290] [055/131] (752s left) kms_async_flips (test-cursor-atomic)
[268.279018] Starting subtest: test-cursor-atomic
[268.283419] Subtest test-cursor-atomic: SKIP (0.000s)
[269.511820] [056/131] (750s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[269.564795] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[269.567146] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[269.660899] [057/131] (750s left) gem_exec_schedule (deep)
[269.830391] Starting subtest: deep
[269.833307] Starting dynamic subtest: rcs0
[275.368762] Dynamic subtest rcs0: SKIP (5.535s)
[275.382730] Starting dynamic subtest: vcs0
[286.320764] Dynamic subtest vcs0: SUCCESS (10.951s)
[286.331160] Starting dynamic subtest: vcs1
[298.485498] Dynamic subtest vcs1: SUCCESS (12.161s)
[298.499218] Starting dynamic subtest: vecs0
[310.533498] Dynamic subtest vecs0: SUCCESS (12.045s)
[310.547130] Starting dynamic subtest: ccs0
[323.203471] Dynamic subtest ccs0: SUCCESS (12.667s)
[323.206868] Subtest deep: SUCCESS (53.364s)
[324.112457] [058/131] (696s left) syncobj_eventfd (binary-wait)
[324.168876] Starting subtest: binary-wait
[324.177132] Subtest binary-wait: SUCCESS (0.010s)
[324.299276] [059/131] (696s left) kms_vblank (crtc-id)
[324.401951] Starting subtest: crtc-id
[324.403930] Starting dynamic subtest: pipe-A-eDP-1
[324.862727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[324.879444] Starting dynamic subtest: pipe-D-eDP-1
[326.030412] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.167s)
[326.033125] Subtest crtc-id: SUCCESS (1.631s)
[326.889769] [060/131] (693s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[326.954873] Starting subtest: y-tiled-ccs-to-yf-tiled
[326.959329] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[327.149392] [061/131] (693s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[327.250839] Starting subtest: x-tiled-16bpp-rotate-0
[328.653999] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.404s)
[328.797155] [062/131] (691s left) kms_plane_lowres (tiling-yf)
[328.895380] Starting subtest: tiling-yf
[328.899071] Subtest tiling-yf: SKIP (0.000s)
[328.982777] [063/131] (691s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[329.047380] Starting subtest: yf-tiled-ccs-to-yf-tiled
[329.051259] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[329.257327] [064/131] (691s left) gem_mmap_wc (write-gtt-read-wc)
[329.318410] Subtest write-gtt-read-wc: SKIP (0.000s)
[329.381416] [065/131] (691s left) kms_hdr (invalid-hdr)
[329.473404] Starting subtest: invalid-hdr
[331.586604] Starting dynamic subtest: pipe-A-eDP-1
[334.562831] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.977s)
[334.565040] Subtest invalid-hdr: SUCCESS (5.091s)
[334.705070] [066/131] (686s left) kms_cursor_edge_walk (128x128-top-edge)
[334.796465] Starting subtest: 128x128-top-edge
[334.798757] Starting dynamic subtest: pipe-A-eDP-1
[338.279828] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[338.290462] Starting dynamic subtest: pipe-D-eDP-1
[341.391382] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[341.394131] Subtest 128x128-top-edge: SUCCESS (6.597s)
[342.234366] [067/131] (678s left) kms_getfb (getfb-repeated-different-handles)
[342.330699] Starting subtest: getfb-repeated-different-handles
[342.332568] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[342.454495] [068/131] (678s left) gem_userptr_blits (sync-unmap)
[342.521183] Starting subtest: sync-unmap
[342.534439] Subtest sync-unmap: SUCCESS (0.015s)
[342.664795] [069/131] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[342.761080] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[342.765209] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[342.901012] [070/131] (678s left) drm_read (empty-nonblock)
[343.047928] Starting subtest: empty-nonblock
[343.050294] Subtest empty-nonblock: SUCCESS (0.000s)
[343.200350] [071/131] (677s left) kms_psr (fbc-psr2-primary-page-flip)
[343.299464] Starting subtest: fbc-psr2-primary-page-flip
[343.301297] Starting dynamic subtest: eDP-1
[343.304875] Dynamic subtest eDP-1: SKIP (0.000s)
[343.308268] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[343.386579] [072/131] (677s left) gem_exec_balancer (individual)
[343.451520] Starting subtest: individual
[345.341868] Subtest individual: SUCCESS (1.888s)
[345.693476] [073/131] (675s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[345.795907] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[345.798019] Starting dynamic subtest: pipe-A-eDP-1
[345.818123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[345.831014] Starting dynamic subtest: pipe-B-eDP-1
[345.850319] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[345.861003] Starting dynamic subtest: pipe-C-eDP-1
[345.881272] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[345.892400] Starting dynamic subtest: pipe-D-eDP-1
[345.911992] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[345.913990] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[348.012384] [074/131] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[348.113308] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[351.735341] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.628s)
[352.920899] [075/131] (668s left) kms_psr (psr2-primary-mmap-cpu)
[353.024071] Starting subtest: psr2-primary-mmap-cpu
[353.026373] Starting dynamic subtest: eDP-1
[354.765843] Dynamic subtest eDP-1: SUCCESS (1.741s)
[354.768214] Subtest psr2-primary-mmap-cpu: SUCCESS (1.742s)
[355.668480] [076/131] (665s left) kms_setmode (basic)
[355.714389] Starting subtest: basic
[356.033468] Starting dynamic subtest: pipe-A-eDP-1
[358.161995] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.124s)
[358.505986] Starting dynamic subtest: pipe-B-eDP-1
[360.590385] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[360.901462] Subtest basic: SUCCESS (5.185s)
[361.754408] [077/131] (659s left) gem_mmap_offset (bad-object)
[361.813087] Starting subtest: bad-object
[361.815110] Subtest bad-object: SUCCESS (0.001s)
[361.924852] [078/131] (659s left) kms_addfb_basic (too-wide)
[362.023395] Starting subtest: too-wide
[362.025606] Subtest too-wide: SUCCESS (0.000s)
[362.143771] [079/131] (659s left) perf_pmu (semaphore-busy)
[362.179880] Starting subtest: semaphore-busy
[362.182226] Starting dynamic subtest: rcs0
[363.849803] Dynamic subtest rcs0: SUCCESS (1.666s)
[363.862514] Starting dynamic subtest: bcs0
[365.481953] Dynamic subtest bcs0: SUCCESS (1.628s)
[365.493440] Starting dynamic subtest: vcs0
[369.843258] Dynamic subtest vcs0: SUCCESS (4.359s)
[369.856476] Starting dynamic subtest: vcs1
[375.859136] Dynamic subtest vcs1: SUCCESS (6.012s)
[375.871402] Starting dynamic subtest: vecs0
[381.875412] Dynamic subtest vecs0: SUCCESS (6.012s)
[381.887399] Starting dynamic subtest: ccs0
[384.947404] Dynamic subtest ccs0: SUCCESS (3.068s)
[384.950617] Subtest semaphore-busy: SUCCESS (22.763s)
[385.088166] [080/131] (636s left) kms_atomic_interruptible (atomic-setmode)
[385.200051] Starting subtest: atomic-setmode
[385.202175] Starting dynamic subtest: pipe-A-eDP-1
[392.111825] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.909s)
[392.114091] Subtest atomic-setmode: SUCCESS (6.910s)
[392.993293] [081/131] (628s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[393.082464] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[393.084742] Starting dynamic subtest: pipe-A-eDP-1
[393.093835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.104779] Starting dynamic subtest: pipe-B-eDP-1
[393.113647] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.123865] Starting dynamic subtest: pipe-C-eDP-1
[393.132528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.142337] Starting dynamic subtest: pipe-D-eDP-1
[393.150982] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.155386] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[395.326761] [082/131] (626s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[395.385430] Starting subtest: invalid-signal-one-illegal-handle
[395.387595] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[395.496597] [083/131] (626s left) gem_exec_schedule (promotion)
[395.568711] Starting subtest: promotion
[395.571043] Starting dynamic subtest: rcs0
[395.660096] Dynamic subtest rcs0: SUCCESS (0.100s)
[395.671659] Starting dynamic subtest: vcs0
[395.741378] Dynamic subtest vcs0: SUCCESS (0.080s)
[395.752363] Starting dynamic subtest: vcs1
[395.828623] Dynamic subtest vcs1: SUCCESS (0.087s)
[395.841810] Starting dynamic subtest: vecs0
[395.909030] Dynamic subtest vecs0: SUCCESS (0.079s)
[395.921533] Starting dynamic subtest: ccs0
[396.012392] Dynamic subtest ccs0: SUCCESS (0.101s)
[396.015285] Subtest promotion: SUCCESS (0.453s)
[397.517212] [084/131] (624s left) kms_getfb (getfb-handle-protection)
[397.610468] Starting subtest: getfb-handle-protection
[397.640064] Subtest getfb-handle-protection: SUCCESS (0.031s)
[397.791654] [085/131] (623s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[397.890699] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[397.894968] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[398.045766] [086/131] (623s left) gem_exec_basic (basic)
[398.103510] Starting subtest: basic
[398.105824] Starting dynamic subtest: rcs0-smem
[398.108162] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[398.119870] Starting dynamic subtest: bcs0-smem
[398.121795] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[398.131456] Starting dynamic subtest: vcs0-smem
[398.133335] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[398.143193] Starting dynamic subtest: vcs1-smem
[398.145149] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[398.154790] Starting dynamic subtest: vecs0-smem
[398.156678] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[398.165929] Starting dynamic subtest: ccs0-smem
[398.167826] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[398.169715] Subtest basic: SUCCESS (0.014s)
[399.403561] [087/131] (622s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[399.492412] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[399.494973] Starting dynamic subtest: pipe-A-eDP-1
[399.517444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[399.528785] Starting dynamic subtest: pipe-B-eDP-1
[399.549478] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[399.559473] Starting dynamic subtest: pipe-C-eDP-1
[399.580793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[399.590579] Starting dynamic subtest: pipe-D-eDP-1
[399.612455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[399.616758] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[401.691008] [088/131] (620s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[401.785727] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[401.788058] Starting dynamic subtest: pipe-A
[401.835602] Dynamic subtest pipe-A: SKIP (0.019s)
[401.846078] Starting dynamic subtest: pipe-B
[401.854720] Dynamic subtest pipe-B: SKIP (0.034s)
[401.865580] Starting dynamic subtest: pipe-C
[401.878259] Dynamic subtest pipe-C: SKIP (0.034s)
[401.888535] Starting dynamic subtest: pipe-D
[401.913118] Dynamic subtest pipe-D: SKIP (0.034s)
[401.916707] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.125s)
[402.040618] [089/131] (619s left) kms_vblank (query-forked-busy-hang)
[402.132772] Starting subtest: query-forked-busy-hang
[402.135082] Starting dynamic subtest: pipe-A-eDP-1
[428.100845] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.961s)
[428.117183] Starting dynamic subtest: pipe-D-eDP-1
[453.112439] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.007s)
[453.114794] Subtest query-forked-busy-hang: SUCCESS (50.972s)
[453.962025] [090/131] (567s left) gem_mmap_wc (write-prefaulted)
[454.021303] Subtest write-prefaulted: SKIP (0.000s)
[454.084762] [091/131] (567s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[454.203152] Starting subtest: 2x-flip-vs-cursor-atomic
[454.207688] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[454.374012] [092/131] (567s left) perf (invalid-remove-userspace-config)
[454.514551] Starting subtest: invalid-remove-userspace-config
[454.522691] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[454.567777] [093/131] (567s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[454.668861] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[455.681013] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.013s)
[455.831701] [094/131] (566s left) gem_mmap_gtt (cpuset-big-copy)
[455.888610] Subtest cpuset-big-copy: SKIP (0.000s)
[455.950552] [095/131] (566s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[456.054974] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[456.058528] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[456.169725] [096/131] (565s left) gem_spin_batch (resubmit-new-all)
[456.218439] Starting subtest: resubmit-new-all
[456.220411] Starting dynamic subtest: rcs0
[456.231586] Dynamic subtest rcs0: SUCCESS (0.013s)
[456.244207] Starting dynamic subtest: bcs0
[456.246064] Dynamic subtest bcs0: SUCCESS (0.010s)
[456.256000] Starting dynamic subtest: vcs0
[456.257553] Dynamic subtest vcs0: SUCCESS (0.008s)
[456.267294] Starting dynamic subtest: vcs1
[456.269012] Dynamic subtest vcs1: SUCCESS (0.009s)
[456.278688] Starting dynamic subtest: vecs0
[456.280227] Dynamic subtest vecs0: SUCCESS (0.009s)
[456.290206] Starting dynamic subtest: ccs0
[456.292048] Dynamic subtest ccs0: SUCCESS (0.011s)
[456.293815] Subtest resubmit-new-all: SUCCESS (0.065s)
[457.400566] [097/131] (564s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[457.460274] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[457.560621] [098/131] (564s left) gem_ctx_persistence (engines-hang)
[457.622476] Starting subtest: engines-hang
[457.624676] Starting dynamic subtest: rcs0
[457.715991] Dynamic subtest rcs0: SUCCESS (0.091s)
[457.726105] Starting dynamic subtest: bcs0
[457.821204] Dynamic subtest bcs0: SUCCESS (0.106s)
[457.834086] Starting dynamic subtest: vcs0
[457.941272] Dynamic subtest vcs0: SUCCESS (0.117s)
[457.954431] Starting dynamic subtest: vcs1
[458.060816] Dynamic subtest vcs1: SUCCESS (0.117s)
[458.074060] Starting dynamic subtest: vecs0
[458.179245] Dynamic subtest vecs0: SUCCESS (0.116s)
[458.193205] Starting dynamic subtest: ccs0
[458.300397] Dynamic subtest ccs0: SUCCESS (0.119s)
[458.303177] Subtest engines-hang: SUCCESS (0.680s)
[458.407236] [099/131] (563s left) gem_partial_pwrite_pread (reads)
[458.462119] Subtest reads: SKIP (0.000s)
[458.527891] [100/131] (563s left) kms_joiner (invalid-modeset-ultra-joiner)
[458.630231] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[458.702092] [101/131] (563s left) api_intel_bb (offset-control)
[458.755186] Starting subtest: offset-control
[458.759845] Subtest offset-control: SUCCESS (0.007s)
[458.923303] [102/131] (563s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[459.018808] Starting subtest: fbcpsr-modesetfrombusy
[465.339217] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.322s)
[465.491470] [103/131] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[465.597803] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[473.022015] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.423s)
[473.161576] [104/131] (549s left) kms_draw_crc (draw-method-mmap-gtt)
[473.259166] Starting subtest: draw-method-mmap-gtt
[473.263325] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[473.374651] [105/131] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[473.469308] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[473.473491] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[473.573820] [106/131] (548s left) kms_big_fb (linear-64bpp-rotate-270)
[473.670326] Starting subtest: linear-64bpp-rotate-270
[473.689708] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[473.833058] [107/131] (548s left) kms_async_flips (async-flip-suspend-resume)
[473.924899] Starting subtest: async-flip-suspend-resume
[474.298776] Starting dynamic subtest: pipe-A-eDP-1
[475.584381] Dynamic subtest pipe-A-eDP-1: FAIL (0.824s)
[475.595280] Starting dynamic subtest: pipe-B-eDP-1
[476.488488] Dynamic subtest pipe-B-eDP-1: FAIL (0.741s)
[476.632841] Starting dynamic subtest: pipe-C-eDP-1
[494.171012] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.878s)
[494.535005] Starting dynamic subtest: pipe-D-eDP-1
[512.141300] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s)
[512.143566] Subtest async-flip-suspend-resume: FAIL (8.798s)
[513.274231] Aborting: Kernel badly tainted (0x4244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[513.291606] [FACT kms_async_flips (async-flip-suspend-resume)] new: kernel.is_tainted.taint_warn: true
[513.292570] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_feature_discovery
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_params
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: gem_exec_flush
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_ctx_sseu
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_caching
results: parsing output: 20/ for test: gem_basic
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: gen7_exec_parse
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_create
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_prop_blob
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: i915_module_load
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: core_sysfs
results: parsing output: 35/ for test: gem_unref_active_buffers
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_exec_whisper
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: sysfs_heartbeat_interval
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: i915_pm_rpm
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_eio
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_gpgpu_fill
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_exec_schedule
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_plane_lowres
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_getfb
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: drm_read
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_setmode
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_atomic_interruptible
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: kms_getfb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_basic
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_vblank
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_spin_batch
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: kms_joiner
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_draw_crc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 109/ for test: gem_madvise
results: no output, setting notrun
results: parsing output: 110/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 111/ for test: kms_writeback
results: no output, setting notrun
results: parsing output: 112/ for test: kms_content_protection
results: no output, setting notrun
results: parsing output: 113/ for test: kms_panel_fitting
results: no output, setting notrun
results: parsing output: 114/ for test: kms_cursor_crc
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: kms_sharpness_filter
results: no output, setting notrun
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 118/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 120/ for test: gem_vm_create
results: no output, setting notrun
results: parsing output: 121/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 122/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 124/ for test: kms_pipe_crc_basic
results: no output, setting notrun
results: parsing output: 125/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 126/ for test: i915_query
results: no output, setting notrun
results: parsing output: 127/ for test: gem_set_tiling_vs_pwrite
results: no output, setting notrun
results: parsing output: 128/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 129/ for test: kms_psr2_su
results: no output, setting notrun
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: no output, setting notrun
Done.